builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-047 starttime: 1479165850.87 results: success (0) buildid: 20161114123421 builduid: fea17106966448509ba4f02f52bed788 revision: 71fd23fa0803a548b6e571aa25d0533a06cd0421 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 15:24:10.873922) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 15:24:10.874437) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 15:24:10.874752) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 15:24:10.886412) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 15:24:10.886763) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1479165850.240185-1080477398 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-14 15:24:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-11-14 15:24:11 (46.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118094 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 15:24:11.016115) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 15:24:11.016440) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1479165850.240185-1080477398 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020668 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 15:24:11.066702) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 15:24:11.067059) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 71fd23fa0803a548b6e571aa25d0533a06cd0421 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 71fd23fa0803a548b6e571aa25d0533a06cd0421 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1479165850.240185-1080477398 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-14 15:24:11,220 truncating revision to first 12 chars 2016-11-14 15:24:11,220 Setting DEBUG logging. 2016-11-14 15:24:11,220 attempt 1/10 2016-11-14 15:24:11,220 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/71fd23fa0803?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-14 15:24:11,560 unpacking tar archive at: mozilla-central-71fd23fa0803/testing/mozharness/ program finished with exit code 0 elapsedTime=0.633940 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 15:24:11.714492) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 15:24:11.714906) ========= script_repo_revision: 71fd23fa0803a548b6e571aa25d0533a06cd0421 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 15:24:11.715391) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 15:24:11.715837) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 15:24:11.725019) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-11-14 15:24:11.725461) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1479165850.240185-1080477398 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:24:11 INFO - MultiFileLogger online at 20161114 15:24:11 in /builds/slave/test 15:24:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 15:24:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:24:11 INFO - {'append_to_log': False, 15:24:11 INFO - 'base_work_dir': '/builds/slave/test', 15:24:11 INFO - 'blob_upload_branch': 'Firefox', 15:24:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:24:11 INFO - 'branch': 'Firefox', 15:24:11 INFO - 'buildbot_json_path': 'buildprops.json', 15:24:11 INFO - 'config_files': ('talos/linux_config.py',), 15:24:11 INFO - 'default_actions': ('clobber', 15:24:11 INFO - 'read-buildbot-config', 15:24:11 INFO - 'download-and-extract', 15:24:11 INFO - 'populate-webroot', 15:24:11 INFO - 'create-virtualenv', 15:24:11 INFO - 'install', 15:24:11 INFO - 'run-tests'), 15:24:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:24:11 INFO - 'download_minidump_stackwalk': True, 15:24:11 INFO - 'download_symbols': 'ondemand', 15:24:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:24:11 INFO - 'tooltool.py': '/tools/tooltool.py', 15:24:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:24:11 INFO - '/tools/misc-python/virtualenv.py')}, 15:24:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:24:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:24:11 INFO - 'installer_path': 'installer.exe', 15:24:11 INFO - 'log_level': 'info', 15:24:11 INFO - 'log_name': 'talos', 15:24:11 INFO - 'log_to_console': True, 15:24:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:24:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:24:11 INFO - 'opt_config_files': (), 15:24:11 INFO - 'pip_index': False, 15:24:11 INFO - 'sps_profile': False, 15:24:11 INFO - 'sps_profile_interval': 0, 15:24:11 INFO - 'suite': 'dromaeojs-e10s', 15:24:11 INFO - 'system_bits': '32', 15:24:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:24:11 INFO - 'title': 'talos-linux64-ix-047', 15:24:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:24:11 INFO - 'use_talos_json': True, 15:24:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:24:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:24:11 INFO - 'work_dir': 'build'} 15:24:11 INFO - [mozharness: 2016-11-14 23:24:11.980504Z] Running clobber step. 15:24:11 INFO - Running pre-action listener: _resource_record_pre_action 15:24:11 INFO - Running main action method: clobber 15:24:11 INFO - rmtree: /builds/slave/test/build 15:24:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:24:13 INFO - Running post-action listener: _resource_record_post_action 15:24:13 INFO - [mozharness: 2016-11-14 23:24:13.007806Z] Finished clobber step (success) 15:24:13 INFO - [mozharness: 2016-11-14 23:24:13.007905Z] Running read-buildbot-config step. 15:24:13 INFO - Running pre-action listener: _resource_record_pre_action 15:24:13 INFO - Running main action method: read_buildbot_config 15:24:13 INFO - Using buildbot properties: 15:24:13 INFO - { 15:24:13 INFO - "project": "", 15:24:13 INFO - "product": "firefox", 15:24:13 INFO - "script_repo_revision": "production", 15:24:13 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 15:24:13 INFO - "repository": "", 15:24:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 15:24:13 INFO - "buildid": "20161114123421", 15:24:13 INFO - "pgo_build": "True", 15:24:13 INFO - "basedir": "/builds/slave/test", 15:24:13 INFO - "buildnumber": 189, 15:24:13 INFO - "slavename": "talos-linux64-ix-047", 15:24:13 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:24:13 INFO - "platform": "ubuntu64_hw", 15:24:13 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 15:24:13 INFO - "branch": "mozilla-central", 15:24:13 INFO - "repo_path": "mozilla-central", 15:24:13 INFO - "revision": "71fd23fa0803a548b6e571aa25d0533a06cd0421", 15:24:13 INFO - "stage_platform": "linux64-pgo", 15:24:13 INFO - "builduid": "fea17106966448509ba4f02f52bed788", 15:24:13 INFO - "slavebuilddir": "test" 15:24:13 INFO - } 15:24:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/bxcL35UDSF-iatl5HrQ20g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 15:24:13 INFO - Running post-action listener: _resource_record_post_action 15:24:13 INFO - [mozharness: 2016-11-14 23:24:13.010366Z] Finished read-buildbot-config step (success) 15:24:13 INFO - [mozharness: 2016-11-14 23:24:13.010453Z] Running download-and-extract step. 15:24:13 INFO - Running pre-action listener: _resource_record_pre_action 15:24:13 INFO - Running main action method: download_and_extract 15:24:13 INFO - mkdir: /builds/slave/test/build/tests 15:24:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:13 INFO - trying https://queue.taskcluster.net/v1/task/bxcL35UDSF-iatl5HrQ20g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 15:24:13 INFO - Downloading https://queue.taskcluster.net/v1/task/bxcL35UDSF-iatl5HrQ20g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 15:24:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bxcL35UDSF-iatl5HrQ20g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:24:13 INFO - Downloaded 1361 bytes. 15:24:13 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 15:24:13 INFO - Using the following test package requirements: 15:24:13 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 15:24:13 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:24:13 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:24:13 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:24:13 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:24:13 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:24:13 INFO - u'jsshell-linux-x86_64.zip'], 15:24:13 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:24:13 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:24:13 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 15:24:13 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:24:13 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:24:13 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:24:13 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:24:13 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:24:13 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:24:13 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:24:13 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:24:13 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:24:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bxcL35UDSF-iatl5HrQ20g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 15:24:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bxcL35UDSF-iatl5HrQ20g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:24:13 INFO - Fetch https://queue.taskcluster.net/v1/task/bxcL35UDSF-iatl5HrQ20g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:24:14 INFO - Http code: 200 15:24:14 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 15:24:14 INFO - x-amz-cf-id: t9Xm4k6k_YhV-uvYE3-02MOZscd93parNqPbJs1B7p7VCh8LMrO6Vw== 15:24:14 INFO - x-amz-version-id: O9ScqkmLIEU6L2E9nhy6yuSoXCvpo09e 15:24:14 INFO - Expected file size: 21969216 15:24:14 INFO - Obtained file size: 21969216 15:24:18 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:24:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bxcL35UDSF-iatl5HrQ20g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 15:24:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bxcL35UDSF-iatl5HrQ20g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:24:18 INFO - Fetch https://queue.taskcluster.net/v1/task/bxcL35UDSF-iatl5HrQ20g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:24:19 INFO - Http code: 200 15:24:19 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 15:24:19 INFO - x-amz-cf-id: SRyLN1gzF_40tinLL1dQJzN0IykD01aDrwTfNsmhFKjnIBPgUcJTXQ== 15:24:19 INFO - x-amz-version-id: O9ScqkmLIEU6L2E9nhy6yuSoXCvpo09e 15:24:19 INFO - Expected file size: 21969216 15:24:19 INFO - Obtained file size: 21969216 15:24:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bxcL35UDSF-iatl5HrQ20g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 15:24:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bxcL35UDSF-iatl5HrQ20g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:24:24 INFO - Fetch https://queue.taskcluster.net/v1/task/bxcL35UDSF-iatl5HrQ20g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 15:24:24 INFO - Http code: 200 15:24:24 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 15:24:24 INFO - x-amz-cf-id: ABFDZ1DHElkwjONqgV1ioCQN-4XrtUB_jI7zUJn4cD9AFIH7XU7R1Q== 15:24:24 INFO - x-amz-version-id: UBgQ4QSivYzXHt8wBazysqJyAUl_KiHN 15:24:24 INFO - Expected file size: 14409038 15:24:24 INFO - Obtained file size: 14409038 15:24:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:25 INFO - trying https://queue.taskcluster.net/v1/task/bxcL35UDSF-iatl5HrQ20g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 15:24:25 INFO - Downloading https://queue.taskcluster.net/v1/task/bxcL35UDSF-iatl5HrQ20g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 15:24:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bxcL35UDSF-iatl5HrQ20g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:24:26 INFO - Downloaded 59519395 bytes. 15:24:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bxcL35UDSF-iatl5HrQ20g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 15:24:26 INFO - mkdir: /builds/slave/test/properties 15:24:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:24:26 INFO - Writing to file /builds/slave/test/properties/build_url 15:24:26 INFO - Contents: 15:24:26 INFO - build_url:https://queue.taskcluster.net/v1/task/bxcL35UDSF-iatl5HrQ20g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 15:24:26 INFO - Running post-action listener: _resource_record_post_action 15:24:26 INFO - Running post-action listener: set_extra_try_arguments 15:24:26 INFO - [mozharness: 2016-11-14 23:24:26.987002Z] Finished download-and-extract step (success) 15:24:26 INFO - [mozharness: 2016-11-14 23:24:26.987227Z] Running populate-webroot step. 15:24:26 INFO - Running pre-action listener: _resource_record_pre_action 15:24:26 INFO - Running main action method: populate_webroot 15:24:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:24:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:24:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:24:27 INFO - '--tppagecycles', 15:24:27 INFO - '7'], 15:24:27 INFO - 'tests': ['tsvgm']}}, 15:24:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:24:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:24:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:24:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:24:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:24:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:24:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:24:27 INFO - 'talos_options': ['--disable-e10s'], 15:24:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:24:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:24:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:24:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:24:27 INFO - 'talos_options': ['--disable-e10s'], 15:24:27 INFO - 'tests': ['damp', 'tps']}, 15:24:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:24:27 INFO - 'tests': ['damp', 'tps']}, 15:24:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:24:27 INFO - 'tests': ['dromaeo_dom']}, 15:24:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:24:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:24:27 INFO - 'tests': ['basic_compositor_video']}, 15:24:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:24:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:24:27 INFO - 'tests': ['a11yr', 15:24:27 INFO - 'ts_paint', 15:24:27 INFO - 'tpaint', 15:24:27 INFO - 'sessionrestore', 15:24:27 INFO - 'sessionrestore_no_auto_restore', 15:24:27 INFO - 'tabpaint']}, 15:24:27 INFO - 'other-e10s': {'tests': ['a11yr', 15:24:27 INFO - 'ts_paint', 15:24:27 INFO - 'tpaint', 15:24:27 INFO - 'sessionrestore', 15:24:27 INFO - 'sessionrestore_no_auto_restore', 15:24:27 INFO - 'tabpaint']}, 15:24:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:24:27 INFO - 'ts_paint', 15:24:27 INFO - 'tpaint', 15:24:27 INFO - 'sessionrestore', 15:24:27 INFO - 'sessionrestore_no_auto_restore', 15:24:27 INFO - 'tabpaint']}, 15:24:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:24:27 INFO - 'ts_paint', 15:24:27 INFO - 'tpaint', 15:24:27 INFO - 'sessionrestore', 15:24:27 INFO - 'sessionrestore_no_auto_restore', 15:24:27 INFO - 'tabpaint']}, 15:24:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:24:27 INFO - 'tests': ['a11yr', 15:24:27 INFO - 'ts_paint', 15:24:27 INFO - 'tpaint', 15:24:27 INFO - 'sessionrestore', 15:24:27 INFO - 'sessionrestore_no_auto_restore', 15:24:27 INFO - 'tabpaint']}, 15:24:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:24:27 INFO - 'tests': ['a11yr', 15:24:27 INFO - 'ts_paint', 15:24:27 INFO - 'tpaint', 15:24:27 INFO - 'sessionrestore', 15:24:27 INFO - 'sessionrestore_no_auto_restore', 15:24:27 INFO - 'tabpaint']}, 15:24:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:24:27 INFO - 'tests': ['tsvgx', 15:24:27 INFO - 'tsvgr_opacity', 15:24:27 INFO - 'tart', 15:24:27 INFO - 'tscrollx', 15:24:27 INFO - 'cart']}, 15:24:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:24:27 INFO - 'tsvgr_opacity', 15:24:27 INFO - 'tart', 15:24:27 INFO - 'tscrollx', 15:24:27 INFO - 'cart']}, 15:24:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:24:27 INFO - 'talos_options': ['--disable-e10s'], 15:24:27 INFO - 'tests': ['tp5o']}, 15:24:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:24:27 INFO - 'tests': ['tp5o']}, 15:24:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:24:27 INFO - 'talos_options': ['--disable-e10s', 15:24:27 INFO - '--xperf_path', 15:24:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:24:27 INFO - 'tests': ['tp5n']}, 15:24:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:24:27 INFO - 'talos_options': ['--xperf_path', 15:24:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:24:27 INFO - 'tests': ['tp5n']}}, 15:24:27 INFO - 'talos.zip': {'path': '', 15:24:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:24:27 INFO - Running post-action listener: _resource_record_post_action 15:24:27 INFO - [mozharness: 2016-11-14 23:24:27.009481Z] Finished populate-webroot step (success) 15:24:27 INFO - [mozharness: 2016-11-14 23:24:27.009569Z] Running create-virtualenv step. 15:24:27 INFO - Running pre-action listener: _resource_record_pre_action 15:24:27 INFO - Running main action method: create_virtualenv 15:24:27 INFO - Creating virtualenv /builds/slave/test/build/venv 15:24:27 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:24:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:24:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:24:27 INFO - Using real prefix '/usr' 15:24:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:24:27 INFO - Installing distribute.............................................................................................................................................................................................done. 15:24:29 INFO - Installing pip.................done. 15:24:29 INFO - Return code: 0 15:24:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:24:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:24:29 INFO - Reading from file tmpfile_stdout 15:24:29 INFO - Output received: 15:24:29 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 15:24:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:24:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f25ea244f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117c790>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117db20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479165850.240185-1080477398', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:24:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:24:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:24:29 INFO - Using env: {'DISPLAY': ':0', 15:24:29 INFO - 'HOME': '/home/cltbld', 15:24:29 INFO - 'LANG': 'en_US.UTF-8', 15:24:29 INFO - 'LANGUAGE': 'en_US:en', 15:24:29 INFO - 'LOGNAME': 'cltbld', 15:24:29 INFO - 'MAIL': '/var/mail/cltbld', 15:24:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:29 INFO - 'MOZ_NO_REMOTE': '1', 15:24:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:29 INFO - 'NO_EM_RESTART': '1', 15:24:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:29 INFO - 'PWD': '/builds/slave/test', 15:24:29 INFO - 'SHELL': '/bin/bash', 15:24:29 INFO - 'SHLVL': '1', 15:24:29 INFO - 'TERM': 'linux', 15:24:29 INFO - 'TMOUT': '86400', 15:24:29 INFO - 'USER': 'cltbld', 15:24:29 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479165850.240185-1080477398', 15:24:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:29 INFO - '_': '/tools/buildbot/bin/python'} 15:24:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:24:30 INFO - Cleaning up... 15:24:30 INFO - Return code: 0 15:24:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:24:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f25ea244f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117c790>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117db20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479165850.240185-1080477398', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:24:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:24:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:24:30 INFO - Using env: {'DISPLAY': ':0', 15:24:30 INFO - 'HOME': '/home/cltbld', 15:24:30 INFO - 'LANG': 'en_US.UTF-8', 15:24:30 INFO - 'LANGUAGE': 'en_US:en', 15:24:30 INFO - 'LOGNAME': 'cltbld', 15:24:30 INFO - 'MAIL': '/var/mail/cltbld', 15:24:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:30 INFO - 'MOZ_NO_REMOTE': '1', 15:24:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:30 INFO - 'NO_EM_RESTART': '1', 15:24:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:30 INFO - 'PWD': '/builds/slave/test', 15:24:30 INFO - 'SHELL': '/bin/bash', 15:24:30 INFO - 'SHLVL': '1', 15:24:30 INFO - 'TERM': 'linux', 15:24:30 INFO - 'TMOUT': '86400', 15:24:30 INFO - 'USER': 'cltbld', 15:24:30 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479165850.240185-1080477398', 15:24:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:30 INFO - '_': '/tools/buildbot/bin/python'} 15:24:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:30 INFO - Downloading/unpacking psutil>=3.1.1 15:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:24:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:24:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:24:32 INFO - Installing collected packages: psutil 15:24:32 INFO - Running setup.py install for psutil 15:24:32 INFO - building 'psutil._psutil_linux' extension 15:24:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:24:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:24:32 INFO - building 'psutil._psutil_posix' extension 15:24:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:24:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:24:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:24:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:24:32 INFO - Successfully installed psutil 15:24:32 INFO - Cleaning up... 15:24:32 INFO - Return code: 0 15:24:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:24:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f25ea244f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117c790>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117db20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479165850.240185-1080477398', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:24:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:24:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:24:32 INFO - Using env: {'DISPLAY': ':0', 15:24:32 INFO - 'HOME': '/home/cltbld', 15:24:32 INFO - 'LANG': 'en_US.UTF-8', 15:24:32 INFO - 'LANGUAGE': 'en_US:en', 15:24:32 INFO - 'LOGNAME': 'cltbld', 15:24:32 INFO - 'MAIL': '/var/mail/cltbld', 15:24:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:32 INFO - 'MOZ_NO_REMOTE': '1', 15:24:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:32 INFO - 'NO_EM_RESTART': '1', 15:24:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:32 INFO - 'PWD': '/builds/slave/test', 15:24:32 INFO - 'SHELL': '/bin/bash', 15:24:32 INFO - 'SHLVL': '1', 15:24:32 INFO - 'TERM': 'linux', 15:24:32 INFO - 'TMOUT': '86400', 15:24:32 INFO - 'USER': 'cltbld', 15:24:32 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479165850.240185-1080477398', 15:24:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:32 INFO - '_': '/tools/buildbot/bin/python'} 15:24:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:24:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:24:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:24:35 INFO - Installing collected packages: mozsystemmonitor 15:24:35 INFO - Running setup.py install for mozsystemmonitor 15:24:35 INFO - Successfully installed mozsystemmonitor 15:24:35 INFO - Cleaning up... 15:24:35 INFO - Return code: 0 15:24:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:24:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f25ea244f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117c790>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117db20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479165850.240185-1080477398', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:24:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:24:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:24:35 INFO - Using env: {'DISPLAY': ':0', 15:24:35 INFO - 'HOME': '/home/cltbld', 15:24:35 INFO - 'LANG': 'en_US.UTF-8', 15:24:35 INFO - 'LANGUAGE': 'en_US:en', 15:24:35 INFO - 'LOGNAME': 'cltbld', 15:24:35 INFO - 'MAIL': '/var/mail/cltbld', 15:24:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:35 INFO - 'MOZ_NO_REMOTE': '1', 15:24:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:35 INFO - 'NO_EM_RESTART': '1', 15:24:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:35 INFO - 'PWD': '/builds/slave/test', 15:24:35 INFO - 'SHELL': '/bin/bash', 15:24:35 INFO - 'SHLVL': '1', 15:24:35 INFO - 'TERM': 'linux', 15:24:35 INFO - 'TMOUT': '86400', 15:24:35 INFO - 'USER': 'cltbld', 15:24:35 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479165850.240185-1080477398', 15:24:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:35 INFO - '_': '/tools/buildbot/bin/python'} 15:24:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:35 INFO - Downloading/unpacking jsonschema==2.5.1 15:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:24:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:37 INFO - Downloading functools32-3.2.3-2.tar.gz 15:24:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:24:37 INFO - warning: no files found matching '*.txt' 15:24:37 INFO - no previously-included directories found matching 'build' 15:24:37 INFO - no previously-included directories found matching 'dist' 15:24:37 INFO - no previously-included directories found matching '.git*' 15:24:37 INFO - Installing collected packages: jsonschema, functools32 15:24:37 INFO - Running setup.py install for functools32 15:24:37 INFO - warning: no files found matching '*.txt' 15:24:37 INFO - no previously-included directories found matching 'build' 15:24:37 INFO - no previously-included directories found matching 'dist' 15:24:37 INFO - no previously-included directories found matching '.git*' 15:24:37 INFO - Successfully installed jsonschema functools32 15:24:37 INFO - Cleaning up... 15:24:37 INFO - Return code: 0 15:24:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:24:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f25ea244f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117c790>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117db20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479165850.240185-1080477398', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:24:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:24:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:24:37 INFO - Using env: {'DISPLAY': ':0', 15:24:37 INFO - 'HOME': '/home/cltbld', 15:24:37 INFO - 'LANG': 'en_US.UTF-8', 15:24:37 INFO - 'LANGUAGE': 'en_US:en', 15:24:37 INFO - 'LOGNAME': 'cltbld', 15:24:37 INFO - 'MAIL': '/var/mail/cltbld', 15:24:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:37 INFO - 'MOZ_NO_REMOTE': '1', 15:24:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:37 INFO - 'NO_EM_RESTART': '1', 15:24:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:37 INFO - 'PWD': '/builds/slave/test', 15:24:37 INFO - 'SHELL': '/bin/bash', 15:24:37 INFO - 'SHLVL': '1', 15:24:37 INFO - 'TERM': 'linux', 15:24:37 INFO - 'TMOUT': '86400', 15:24:37 INFO - 'USER': 'cltbld', 15:24:37 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479165850.240185-1080477398', 15:24:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:37 INFO - '_': '/tools/buildbot/bin/python'} 15:24:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:24:38 INFO - Cleaning up... 15:24:38 INFO - Return code: 0 15:24:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:24:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f25ea244f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117c790>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117db20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479165850.240185-1080477398', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:24:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:24:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:24:38 INFO - Using env: {'DISPLAY': ':0', 15:24:38 INFO - 'HOME': '/home/cltbld', 15:24:38 INFO - 'LANG': 'en_US.UTF-8', 15:24:38 INFO - 'LANGUAGE': 'en_US:en', 15:24:38 INFO - 'LOGNAME': 'cltbld', 15:24:38 INFO - 'MAIL': '/var/mail/cltbld', 15:24:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:38 INFO - 'MOZ_NO_REMOTE': '1', 15:24:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:38 INFO - 'NO_EM_RESTART': '1', 15:24:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:38 INFO - 'PWD': '/builds/slave/test', 15:24:38 INFO - 'SHELL': '/bin/bash', 15:24:38 INFO - 'SHLVL': '1', 15:24:38 INFO - 'TERM': 'linux', 15:24:38 INFO - 'TMOUT': '86400', 15:24:38 INFO - 'USER': 'cltbld', 15:24:38 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479165850.240185-1080477398', 15:24:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:38 INFO - '_': '/tools/buildbot/bin/python'} 15:24:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:38 INFO - Downloading/unpacking blobuploader==1.2.4 15:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:40 INFO - Downloading blobuploader-1.2.4.tar.gz 15:24:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:24:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:24:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:41 INFO - Downloading docopt-0.6.1.tar.gz 15:24:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:24:41 INFO - Installing collected packages: blobuploader, requests, docopt 15:24:41 INFO - Running setup.py install for blobuploader 15:24:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:24:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:24:41 INFO - Running setup.py install for requests 15:24:41 INFO - Running setup.py install for docopt 15:24:41 INFO - Successfully installed blobuploader requests docopt 15:24:41 INFO - Cleaning up... 15:24:41 INFO - Return code: 0 15:24:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f25ea244f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117c790>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117db20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479165850.240185-1080477398', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:24:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:24:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:24:41 INFO - Using env: {'DISPLAY': ':0', 15:24:41 INFO - 'HOME': '/home/cltbld', 15:24:41 INFO - 'LANG': 'en_US.UTF-8', 15:24:41 INFO - 'LANGUAGE': 'en_US:en', 15:24:41 INFO - 'LOGNAME': 'cltbld', 15:24:41 INFO - 'MAIL': '/var/mail/cltbld', 15:24:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:41 INFO - 'MOZ_NO_REMOTE': '1', 15:24:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:41 INFO - 'NO_EM_RESTART': '1', 15:24:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:41 INFO - 'PWD': '/builds/slave/test', 15:24:41 INFO - 'SHELL': '/bin/bash', 15:24:41 INFO - 'SHLVL': '1', 15:24:41 INFO - 'TERM': 'linux', 15:24:41 INFO - 'TMOUT': '86400', 15:24:41 INFO - 'USER': 'cltbld', 15:24:41 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479165850.240185-1080477398', 15:24:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:41 INFO - '_': '/tools/buildbot/bin/python'} 15:24:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:24:41 INFO - Running setup.py (path:/tmp/pip-VFMVfg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:24:42 INFO - Running setup.py (path:/tmp/pip-Hd1zC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:24:42 INFO - Running setup.py (path:/tmp/pip-e8XoNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:24:42 INFO - Running setup.py (path:/tmp/pip-nRoJW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:24:42 INFO - Running setup.py (path:/tmp/pip-bWt88t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:24:42 INFO - Running setup.py (path:/tmp/pip-bOxkAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:24:42 INFO - Running setup.py (path:/tmp/pip-i9ZJDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:24:42 INFO - Running setup.py (path:/tmp/pip-Mju5U6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:24:42 INFO - Running setup.py (path:/tmp/pip-cTFmM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:24:42 INFO - Running setup.py (path:/tmp/pip-95k11R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:24:42 INFO - Running setup.py (path:/tmp/pip-ZkHipw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:24:42 INFO - Running setup.py (path:/tmp/pip-Dy0zPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:24:42 INFO - Running setup.py (path:/tmp/pip-8giVEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:24:42 INFO - Running setup.py (path:/tmp/pip-9Sj1Tf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:24:42 INFO - Running setup.py (path:/tmp/pip-HiHa1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:24:43 INFO - Running setup.py (path:/tmp/pip-unuNvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:24:43 INFO - Running setup.py (path:/tmp/pip-jqrSHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:24:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:24:43 INFO - Running setup.py install for manifestparser 15:24:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:24:43 INFO - Running setup.py install for mozcrash 15:24:43 INFO - Running setup.py install for mozdebug 15:24:43 INFO - Running setup.py install for mozdevice 15:24:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:24:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:24:43 INFO - Running setup.py install for mozfile 15:24:43 INFO - Running setup.py install for mozhttpd 15:24:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:24:43 INFO - Running setup.py install for mozinfo 15:24:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:24:43 INFO - Running setup.py install for mozInstall 15:24:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:24:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:24:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:24:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:24:44 INFO - Running setup.py install for mozleak 15:24:44 INFO - Running setup.py install for mozlog 15:24:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:24:44 INFO - Running setup.py install for moznetwork 15:24:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:24:44 INFO - Running setup.py install for mozprocess 15:24:44 INFO - Running setup.py install for mozprofile 15:24:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:24:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:24:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:24:44 INFO - Running setup.py install for mozrunner 15:24:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:24:44 INFO - Running setup.py install for mozscreenshot 15:24:44 INFO - Running setup.py install for moztest 15:24:44 INFO - Running setup.py install for mozversion 15:24:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:24:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:24:44 INFO - Cleaning up... 15:24:45 INFO - Return code: 0 15:24:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:24:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f25ea244f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117c790>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117db20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479165850.240185-1080477398', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:24:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:24:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:24:45 INFO - Using env: {'DISPLAY': ':0', 15:24:45 INFO - 'HOME': '/home/cltbld', 15:24:45 INFO - 'LANG': 'en_US.UTF-8', 15:24:45 INFO - 'LANGUAGE': 'en_US:en', 15:24:45 INFO - 'LOGNAME': 'cltbld', 15:24:45 INFO - 'MAIL': '/var/mail/cltbld', 15:24:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:45 INFO - 'MOZ_NO_REMOTE': '1', 15:24:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:45 INFO - 'NO_EM_RESTART': '1', 15:24:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:45 INFO - 'PWD': '/builds/slave/test', 15:24:45 INFO - 'SHELL': '/bin/bash', 15:24:45 INFO - 'SHLVL': '1', 15:24:45 INFO - 'TERM': 'linux', 15:24:45 INFO - 'TMOUT': '86400', 15:24:45 INFO - 'USER': 'cltbld', 15:24:45 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479165850.240185-1080477398', 15:24:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:45 INFO - '_': '/tools/buildbot/bin/python'} 15:24:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:24:45 INFO - Running setup.py (path:/tmp/pip-axVflT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:24:45 INFO - Running setup.py (path:/tmp/pip-cEM9Iy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:24:45 INFO - Running setup.py (path:/tmp/pip-IvGsnD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:24:45 INFO - Running setup.py (path:/tmp/pip-l6MJ79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:24:45 INFO - Running setup.py (path:/tmp/pip-DR5_Qn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:24:45 INFO - Running setup.py (path:/tmp/pip-22trzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:24:45 INFO - Running setup.py (path:/tmp/pip-LVuXiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:24:45 INFO - Running setup.py (path:/tmp/pip-tXyCV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:24:45 INFO - Running setup.py (path:/tmp/pip-ywgE5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:24:45 INFO - Running setup.py (path:/tmp/pip-iotPuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:24:45 INFO - Running setup.py (path:/tmp/pip-9_UD1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:24:46 INFO - Running setup.py (path:/tmp/pip-8ldMMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:24:46 INFO - Running setup.py (path:/tmp/pip-pmUieq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:24:46 INFO - Running setup.py (path:/tmp/pip-oaexp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:24:46 INFO - Running setup.py (path:/tmp/pip-rxELsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:24:46 INFO - Running setup.py (path:/tmp/pip-rlEnDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:24:46 INFO - Running setup.py (path:/tmp/pip-jr3tGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:24:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:24:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:48 INFO - Downloading blessings-1.6.tar.gz 15:24:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:24:48 INFO - Installing collected packages: blessings 15:24:48 INFO - Running setup.py install for blessings 15:24:48 INFO - Successfully installed blessings 15:24:48 INFO - Cleaning up... 15:24:48 INFO - Return code: 0 15:24:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:24:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:24:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:24:48 INFO - Reading from file tmpfile_stdout 15:24:48 INFO - Current package versions: 15:24:48 INFO - argparse == 1.2.1 15:24:48 INFO - blessings == 1.6 15:24:48 INFO - blobuploader == 1.2.4 15:24:48 INFO - docopt == 0.6.1 15:24:48 INFO - functools32 == 3.2.3-2 15:24:48 INFO - jsonschema == 2.5.1 15:24:48 INFO - manifestparser == 1.1 15:24:48 INFO - mozInstall == 1.12 15:24:48 INFO - mozcrash == 1.0 15:24:48 INFO - mozdebug == 0.1 15:24:48 INFO - mozdevice == 0.48 15:24:48 INFO - mozfile == 1.2 15:24:48 INFO - mozhttpd == 0.7 15:24:48 INFO - mozinfo == 0.9 15:24:48 INFO - mozleak == 0.1 15:24:48 INFO - mozlog == 3.4 15:24:48 INFO - moznetwork == 0.27 15:24:48 INFO - mozprocess == 0.23 15:24:48 INFO - mozprofile == 0.28 15:24:48 INFO - mozrunner == 6.13 15:24:48 INFO - mozscreenshot == 0.1 15:24:48 INFO - mozsystemmonitor == 0.3 15:24:48 INFO - moztest == 0.7 15:24:48 INFO - mozversion == 1.4 15:24:48 INFO - psutil == 3.1.1 15:24:48 INFO - requests == 1.2.3 15:24:48 INFO - wsgiref == 0.1.2 15:24:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f25ea244f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117c790>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117db20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479165850.240185-1080477398', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:24:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:24:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:24:48 INFO - Using env: {'DISPLAY': ':0', 15:24:48 INFO - 'HOME': '/home/cltbld', 15:24:48 INFO - 'LANG': 'en_US.UTF-8', 15:24:48 INFO - 'LANGUAGE': 'en_US:en', 15:24:48 INFO - 'LOGNAME': 'cltbld', 15:24:48 INFO - 'MAIL': '/var/mail/cltbld', 15:24:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:48 INFO - 'MOZ_NO_REMOTE': '1', 15:24:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:48 INFO - 'NO_EM_RESTART': '1', 15:24:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:48 INFO - 'PWD': '/builds/slave/test', 15:24:48 INFO - 'SHELL': '/bin/bash', 15:24:48 INFO - 'SHLVL': '1', 15:24:48 INFO - 'TERM': 'linux', 15:24:48 INFO - 'TMOUT': '86400', 15:24:48 INFO - 'USER': 'cltbld', 15:24:48 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479165850.240185-1080477398', 15:24:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:48 INFO - '_': '/tools/buildbot/bin/python'} 15:24:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:24:49 INFO - Cleaning up... 15:24:49 INFO - Return code: 0 15:24:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:24:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f25ea244f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117c790>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117db20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479165850.240185-1080477398', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:24:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:24:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:24:49 INFO - Using env: {'DISPLAY': ':0', 15:24:49 INFO - 'HOME': '/home/cltbld', 15:24:49 INFO - 'LANG': 'en_US.UTF-8', 15:24:49 INFO - 'LANGUAGE': 'en_US:en', 15:24:49 INFO - 'LOGNAME': 'cltbld', 15:24:49 INFO - 'MAIL': '/var/mail/cltbld', 15:24:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:49 INFO - 'MOZ_NO_REMOTE': '1', 15:24:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:49 INFO - 'NO_EM_RESTART': '1', 15:24:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:49 INFO - 'PWD': '/builds/slave/test', 15:24:49 INFO - 'SHELL': '/bin/bash', 15:24:49 INFO - 'SHLVL': '1', 15:24:49 INFO - 'TERM': 'linux', 15:24:49 INFO - 'TMOUT': '86400', 15:24:49 INFO - 'USER': 'cltbld', 15:24:49 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479165850.240185-1080477398', 15:24:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:49 INFO - '_': '/tools/buildbot/bin/python'} 15:24:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:24:49 INFO - Cleaning up... 15:24:49 INFO - Return code: 0 15:24:49 INFO - Running post-action listener: _resource_record_post_action 15:24:49 INFO - Running post-action listener: _start_resource_monitoring 15:24:49 INFO - Starting resource monitoring. 15:24:49 INFO - [mozharness: 2016-11-14 23:24:49.362174Z] Finished create-virtualenv step (success) 15:24:49 INFO - [mozharness: 2016-11-14 23:24:49.362630Z] Running install step. 15:24:49 INFO - Running pre-action listener: _resource_record_pre_action 15:24:49 INFO - Running main action method: install 15:24:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:24:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:24:49 INFO - Reading from file tmpfile_stdout 15:24:49 INFO - Detecting whether we're running mozinstall >=1.0... 15:24:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:24:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:24:49 INFO - Reading from file tmpfile_stdout 15:24:49 INFO - Output received: 15:24:49 INFO - Usage: mozinstall [options] installer 15:24:49 INFO - Options: 15:24:49 INFO - -h, --help show this help message and exit 15:24:49 INFO - -d DEST, --destination=DEST 15:24:49 INFO - Directory to install application into. [default: 15:24:49 INFO - "/builds/slave/test"] 15:24:49 INFO - --app=APP Application being installed. [default: firefox] 15:24:49 INFO - mkdir: /builds/slave/test/build/application 15:24:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:24:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:25:06 INFO - Reading from file tmpfile_stdout 15:25:06 INFO - Output received: 15:25:06 INFO - /builds/slave/test/build/application/firefox/firefox 15:25:06 INFO - Running post-action listener: _resource_record_post_action 15:25:06 INFO - [mozharness: 2016-11-14 23:25:06.558037Z] Finished install step (success) 15:25:06 INFO - [mozharness: 2016-11-14 23:25:06.558281Z] Running run-tests step. 15:25:06 INFO - Running pre-action listener: _resource_record_pre_action 15:25:06 INFO - Running main action method: run_tests 15:25:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:25:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:25:06 INFO - Python 2.7.3 15:25:06 INFO - Return code: 0 15:25:06 INFO - grabbing minidump binary from tooltool 15:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:06 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117c790>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:25:06 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:25:06 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:25:06 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:25:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:25:06 INFO - Return code: 0 15:25:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:25:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:25:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:25:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:25:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:25:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bxcL35UDSF-iatl5HrQ20g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:25:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bxcL35UDSF-iatl5HrQ20g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:25:06 INFO - Using env: {'DISPLAY': ':0', 15:25:06 INFO - 'HOME': '/home/cltbld', 15:25:06 INFO - 'LANG': 'en_US.UTF-8', 15:25:06 INFO - 'LANGUAGE': 'en_US:en', 15:25:06 INFO - 'LOGNAME': 'cltbld', 15:25:06 INFO - 'MAIL': '/var/mail/cltbld', 15:25:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:25:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:25:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:06 INFO - 'MOZ_NO_REMOTE': '1', 15:25:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:25:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:06 INFO - 'NO_EM_RESTART': '1', 15:25:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:06 INFO - 'PWD': '/builds/slave/test', 15:25:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:25:06 INFO - 'SHELL': '/bin/bash', 15:25:06 INFO - 'SHLVL': '1', 15:25:06 INFO - 'TERM': 'linux', 15:25:06 INFO - 'TMOUT': '86400', 15:25:06 INFO - 'USER': 'cltbld', 15:25:06 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479165850.240185-1080477398', 15:25:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:06 INFO - '_': '/tools/buildbot/bin/python'} 15:25:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bxcL35UDSF-iatl5HrQ20g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:25:06 INFO - mozversion application_buildid: 20161114123421 15:25:06 INFO - mozversion application_changeset: 71fd23fa0803a548b6e571aa25d0533a06cd0421 15:25:06 INFO - mozversion application_display_name: Nightly 15:25:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:25:06 INFO - mozversion application_name: Firefox 15:25:06 INFO - mozversion application_remotingname: firefox 15:25:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:25:06 INFO - mozversion application_vendor: Mozilla 15:25:06 INFO - mozversion application_version: 53.0a1 15:25:06 INFO - mozversion platform_buildid: 20161114123421 15:25:06 INFO - mozversion platform_changeset: 71fd23fa0803a548b6e571aa25d0533a06cd0421 15:25:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:25:06 INFO - mozversion platform_version: 53.0a1 15:25:06 INFO - using testdate: 1479165906 15:25:06 INFO - actual date: 1479165906 15:25:06 INFO - starting webserver on 'localhost:41027' 15:25:06 INFO - SUITE-START | Running 2 tests 15:25:06 INFO - TEST-START | dromaeo_css 15:25:06 INFO - operating with platform_type : linux_ 15:25:06 INFO - Initialising browser for dromaeo_css test... 15:25:06 INFO - TEST-INFO | started process 9400 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_zKn8k/profile http://localhost:41027/getInfo.html) 15:25:11 INFO - PROCESS | 9400 | __metrics Screen width/height:1600/1200 15:25:11 INFO - PROCESS | 9400 | colorDepth:24 15:25:11 INFO - PROCESS | 9400 | Browser inner width/height: 1024/697 15:25:11 INFO - PROCESS | 9400 | __metrics 15:25:11 ERROR - PROCESS | 9400 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3178: TypeError: this.tabs is undefined 15:25:12 INFO - TEST-INFO | 9400: exit 0 15:25:12 INFO - Browser initialized. 15:25:12 INFO - Running cycle 1/1 for dromaeo_css test... 15:25:12 INFO - TEST-INFO | started process 9524 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_zKn8k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:25:25 INFO - PROCESS | 9524 | RSS: Main: 185712640 15:25:25 INFO - PROCESS | 9524 | 15:26:14 INFO - PROCESS | 9524 | 1479165974819 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:28:26 INFO - PROCESS | 9524 | Cycle 1(1): loaded http://localhost:41027/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41027/tests/dromaeo/cssquery-ext.html) 15:28:27 INFO - PROCESS | 9524 | RSS: Main: 197963776 15:28:27 INFO - PROCESS | 9524 | 15:31:29 INFO - PROCESS | 9524 | Cycle 1(1): loaded http://localhost:41027/tests/dromaeo/cssquery-ext.html (next: http://localhost:41027/tests/dromaeo/cssquery-jquery.html) 15:31:30 INFO - PROCESS | 9524 | RSS: Main: 196554752 15:31:30 INFO - PROCESS | 9524 | 15:34:32 INFO - PROCESS | 9524 | Cycle 1(1): loaded http://localhost:41027/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41027/tests/dromaeo/cssquery-mootools.html) 15:34:33 INFO - PROCESS | 9524 | RSS: Main: 198991872 15:34:33 INFO - PROCESS | 9524 | 15:37:35 INFO - PROCESS | 9524 | Cycle 1(1): loaded http://localhost:41027/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41027/tests/dromaeo/cssquery-prototype.html) 15:37:35 INFO - PROCESS | 9524 | RSS: Main: 195641344 15:37:35 INFO - PROCESS | 9524 | 15:40:38 INFO - PROCESS | 9524 | Cycle 1(1): loaded http://localhost:41027/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41027/tests/dromaeo/cssquery-yui.html) 15:40:39 INFO - PROCESS | 9524 | RSS: Main: 198828032 15:40:39 INFO - PROCESS | 9524 | 15:43:42 INFO - PROCESS | 9524 | Cycle 1(1): loaded http://localhost:41027/tests/dromaeo/cssquery-yui.html (next: http://localhost:41027/tests/dromaeo/cssquery-dojo.html) 15:43:42 INFO - PROCESS | 9524 | RSS: Main: 198639616 15:43:42 INFO - PROCESS | 9524 | 15:43:42 INFO - PROCESS | 9524 | __start_tp_report 15:43:42 INFO - PROCESS | 9524 | _x_x_mozilla_page_load 15:43:42 INFO - PROCESS | 9524 | _x_x_mozilla_page_load_details 15:43:42 INFO - PROCESS | 9524 | |i|pagename|runs| 15:43:42 INFO - PROCESS | 9524 | |0;dojo.html;3120.26673731673;3126.1871913302534;3127.3588914272577;3159.747220222384;3164.968350316496;5382.2464854920345;5391.083515802318;5422.783088676449;5433.755481003354;5444.210589464526;5453.3728621208575;5464.562834973202;5493.478119578644;5510.090835012218;5567.053600887849;4935.605151587883;4951.331570238017;4990.301357809892;5018.698878067309;5121.052605268037;4986.75066246688;5039.949600503985;5146.150885103972;5152.072626927152;5194.454582268864;4842.370491836039;5029.170186919154;5077.644564880423;5086.974565127188;5127.435982041991;4823.155947709137;4868.878278043077;4869.4156701195725;4878.24387219978;4949.08441938239;4785.186518291899;4831.830885918976;4857.149998750205;4872.123017856784;4881.609471242327;5328.6269961102735;5329.040772660919;5334.813281535166;5343.064963631349;5388.299521062276;5675.2054712340305;5735.483806457397;5762.683052432115;5814.186013958049;5825.854353641151;5920.082387229986;5921.792737254175;5926.4073592640825;5937.821865344046;5991.550633702446;5520.972395137998;5540.889182216373;5541.667499950016;5545.417731138213;5559.749811258503;5752.741126649227;5793.391693872083;5953.613015154087;5976.133460648181;6023.397660233942;5794.88410231793;5796;5799.2750906136735;5833.88332233353;5859.882802343929;5784.884302314014;5847.210626565445;5899.557533184942;5903.203067585821;5907.113932910098;5612.07400778875;5654.434556544395;5655.293088363955;5752.482276595043;5777.740001699934;5804.970975145097;5884.146798714248;5891.116332550152;5941.37615550361;5952.375000624958;4495.100979803987;4497.8425755098415;4508.278675411918;4521.982553925341;4563.292689633112;3973.1854969731135;3975.224831157954;4004.7797371144284;4030.375291829771;4039.5758445363404;5587.189857470644;5626.2685850839125;5633.070543360382;5710.628809127394;5726.513246374022;5916.645001299936;5961;5969.31352894414;5969.522438204933;5975.103734439869;5548.889022219533;5625.634333768292;5669.6314739541795;5673.773049078073;5684.829455116271;4931.556159945622;4979.228219625964;4986.55121039101;5040.647154699136;5045.217991211368;6001.939980600226;6016.368281330485;6018.729157187937;6021.2473440819895;6028.125921741323;5788.392218817132;5805.419458054161;5827.854303642443;5839.649621022752;5844.415558444121;5909.645421274738;5937.7921772737745;5971.134185542985;6017.037274036308;6059.424354686298;5735.827925162252;5745.253117094918;5754.194412782297;5754.482096611325;5762.596618236683;5866.5893387462465;5880.235569375954;5881.735321910439;5886.087656413263;5888.381719919346;5785.132230165509;5826.446487583673;5829.038208695518;5846.503047241032;5881.2942446906645;5741.3971532988435;5755.309362876482;5785.739641716217;5787.102999035156;5815.360310365941;5483.616146869681;5499.5325397340075;5606.719664016864;5651.660900345993;5736.512396446349;5752.108423194411;5849.473547380756;5854.707264636836;5871.735771890189;5900.793472228452;5663.943360566506;5725.370209277059;5731.7420716067045;5736.512396446349;5747.770089196552 15:43:42 INFO - PROCESS | 9524 | |1;ext.html;548.4868777703373;572.3789688188316;576.5157267894967;585.5052480653851;592.2448877680957;40861.59138408615;42352.36471452931;42363.78818105909;45188.32217516732;45313.320300195526;42277;43679.78160109203;43712.34431483522;43729.344059839124;43769.562304376945;8249.298809601176;8461.53461559614;8462.942132233471;8463.365247606424;8466.32269418448;8492.235698787108;8539.06070332263;8571.657133714674;8592.355573331994;8685.218330350268;8639.740807775777;8648.1784230498;8681.34889883258;8708.17272359125;8745;8570.057293697688;8576.09950955147;8634.266087382548;8635.266002389804;8678.349123815738;8445.957770211171;8542.74371768848;8554.93063367079;8582.957085214597;8633.69782057625;41113;41675;41744;41792.164156716695;41806.581934180875;3478.9130271743156;3527.4532447470683;3565.94651080234;3985.60143985602;4146.792660366969;30658.69341306603;30737.846310768527;30746.692533074605;30845.383092338026;32648.6735132648;4060.309747342959;4124.463819703449;4125.958740412588;4180.16396720654;4277.786110694453;230133;230628.9999999983;232383;232520;234265;55180.724096379265;55631;55635.44364556303;55660.443395565526;55663;59178;59390;59412.70293648504;59438;59551.40448595458;16575.6684866302;16962.067086310126;16963.74554381685;16965.575860603338;16973;12867.613971580868;12872.420741066675;12918.870811291954;12934.41795119222;12941.158824676366;15014;16755.66488670244;16842.57893552671;17020.148992550323;17117;3233.708966193054;3338.9499157512655;5903.439173278532;5921.73352199152;6071.210742603434;911.6080085563138;940.4451373689556;1009.7627057641448;1088.4448931045224;1131.1878967878304;27799.58300625492;30133.397332053235;30193.396132077236;30504.08487745371;30698.69301307003;1083.1064371893062;1100.829371447411;1116.6147679050714;1129.271619805221;1176.8528933883265;15398.769018464733;15927;16055.357785688675;16094.275757590936;16128.11295378742;468048;471917;475047;475105;476054;55901;56640.150397744066;56678.43321566814;56923.71538142283;56930.43069569334;1306.1183701001785;1314.4216544720293;1361.795730640392;1368.2406264523086;1374.1686279800576;28268;29230.853845731486;29708.405831883672;30286;30301.242468938453;47602.285965711235;47907;47923.52076479191;47964.28053579269;48218;424717;425459;425751;427950;429386;26796.59805102964;27513.44973100487;28312;28455;29653.920946205544;44957.100857982005;45123.774381127885;45421;46741.06517869556;46928.765356173004;38391.808040959615;38738.22523549457;38880.444154278775;39733.2053358937;39983.2003359937;38667.80666096652;38878;39214.2157156861;39953;40792.1841563173;38949.61050389573;39374;39583;39604;39729.40405893972;33243;35205.647943520235;35482;35937.101572460895;35965.62380258124;26653.733462665125;26924.326891827077;27268.863655681595;27379.726202738515;29370.706292936797 15:43:42 INFO - PROCESS | 9524 | |2;jquery.html;388.8736160747758;391.65338675272375;401.60642570281124;405.7747949887812;417.6533477213913;13950.302484875767;18439.354622588213;18555.628887422245;19199.232030718773;19211.807881921195;18463.446096617125;18529.629407411845;18575.349862754807;18819.05904704766;18904.10958904109;5247.947520524803;5356.598255130881;5390.51485366317;5393.9190912136155;5409.6213265071465;5299.178627312773;5390.326209223847;5390.865228369283;5396.730163491829;5397.919031214535;5146.253793199984;5277.815276465324;5308.389535203462;5322.414534401213;5374.973125134388;5226.372835259775;5256.474352564751;5261.76322065508;5265.315508983846;5270.947290527103;4776.47458779534;4831.130396528623;5074.314967479417;5132.1275383184575;5186.247994040843;13391.799123013163;13511.459541618324;14272.286385680778;20940.685889711665;21401.67897481539;2237.1498830444325;2272.216085450517;2349.859008459498;2350.471143992605;2615.6076588511874;10105.949470252675;10576.36541807494;11468.827967580493;12477.188982716094;14069.155850648995;1796.7574377459136;1803.0984507746127;1839.5217243516781;1845.5201647571594;1915.4253723882919;64798.352016480174;74199;75733.24266757317;77306.22693773046;78016.60991695062;10657.680269591925;10747.140228781678;10885.673429797118;10959.780804383867;11017.283876548;12273.202241854251;15141.545753627408;15147.621309467351;15186.164760938034;15245;7612.657430415645;7721.92278077212;7987.600619969095;8018.79953001168;8042.396820238506;7814.257645523666;7891.644875980594;7913;8130.878036829452;8156.1028286888395;3996.540397854284;4022.4368588397647;4042.7776472293717;4088.9795551022053;4141.254574176617;1922.520815675342;1971.9802801972085;1972.280117757037;1974.5261137326938;1986.1558837494008;883.8188171424842;956.4691596164196;995.4574756757585;1010.939343639384;1017.7099526634873;17083.829161708225;17898.642027159385;18981.62036759257;19111.713324300148;19699.40901772949;913.1005959130251;932.3753085432776;935.3686261773275;980.8038392321564;1019.4647809899714;9412.247020238501;10282.588696452207;10444.529996150191;10558.155347572176;10627.309224900357;411312;412214;415781;416171;428731;52855;65369.34630653728;90577.54711226534;90606.54696726475;91636.54181729181;1020.7805321855985;1040.3705758016442;1041.4272150317295;1043.2280112716535;1044.6709286574705;14931.0418733086;15507.30217140254;16217.270222839765;16249.837501624832;16494.587635309214;37847.43228851625;39513;40832.079348494895;42347.15305693931;42938.71183864489;53909.19136213038;55169;55401.44598553963;55664.72167639136;56250.1562476555;8205.425620206528;8303.95848020756;8306.377021723516;8409.705660301861;8670;11660.358680272666;12371.13402061847;12537.498500059895;12757.48970041225;12829.422675979416;10424.530896109845;10722.03501684852;11078.335299882034;11186.496607652838;11535.192536522363;10968.341899486057;11016.283941543774;11124.555017799521;11177.16171287173;11394.48724807369;11157.72105697364;11197.160212983896;11281.661550153509;11301.71745706331;11509.366984815915;7954.8067789831985;8178.223068808454;8487.321014318963;8529.530875801891;8536.231739143259;10453.26827122094;10813.134949204203;11026.558937642405;11090.223684342342;11672.591459299223 15:43:42 INFO - PROCESS | 9524 | |3;mootools.html;1426.308240503356;1446.7540518111923;1503.5188739603325;1651.556504687726;1655.081429806457;7285.890711639329;7524.360429363497;7950.483218590794;8277.710280140196;8390.328773698106;7998.440109192359;8296.709615163456;8311.75064748057;8513.27637150843;8540.316774658027;2313.3406979010942;2335.789778919897;2341.1805867946255;2341.777531134548;2343.16817529777;2294.3575798776287;2331.0442718485424;2331.80179684727;2380.3811009137576;2381.95236095278;2193.1885202475028;2201.152556265833;2212.9668054979106;2217.1020736601704;2239.6304609739373;2233.4304752288226;2269.7730226977337;2301.493671392291;2306.308107567723;2310.1106074161485;2278.0773786616446;2281.2015794471968;2289.9427514312274;2295.3114065780364;2308.9422764430856;8294.875576866352;8339.957505311835;8397.748067557983;8429.70496032642;8434.915650843473;5170.319646115027;5314.7608357624;5315.388730296027;5318.282031925718;5321.8935621287355;3168.461361568539;3207.957413840511;3437.2609888873762;3466.4973578830927;3470.16715988161;1014.8426993815971;1030.0574973898874;1035.6685860524635;1041.599049278719;1084.2735367303846;11656.825147622792;11668.883311166865;11690.123240756891;11723.648290551211;11878.049756019498;4431.468223813163;4464.419625448671;4533.662569541993;4542.068875880503;4710.905781884411;9807.754806129904;9814.754631134136;9815.754606134904;9851.556679949419;9890.456024918554;5210.062188806051;5275.235090911796;5278.9208161877605;5292.550133238641;5300.814471493479;4680.063987202573;4813.133635945564;4814.542618451242;4827.155247831615;4900.142475066849;3608.62109478501;3665.3402387570495;3732.122951106488;3757.5678796938155;3793.468914351993;1170.9648710538697;1187.424099311833;1193.7135087578918;1193.8985186259092;1202.506972141418;695.8121307247015;908.954552272397;916.7433118726767;921.6221349246911;926.8146370725747;5377.3816011159215;5436.53789427903;5536.916946245809;5619.775208991595;5619.8595035124445;453.80259587079723;464.97907594158346;465.36710074298924;471.6651875193195;472.2679846238317;3709.2581483703366;3801.125741079512;3822.904427389282;3826.521684789401;3916.373380259145;10202.183825293958;10521.21090918169;10526.31578947366;10546;10557.524911379007;10228.386296822215;10331.793364132674;10486.37081775096;10505.842412363821;10522.210834187466;7826.530408175528;7923.286904178536;7967;8019.198080192051;8024.317932975646;5484.451554844483;5495.53287970527;5525.640833345819;5535.474129957647;5728.112142617901;9321.673741419017;9324.533773311443;9326.114019168168;9339.673111441067;9372.062793720574;9389.765255868659;9840.55717492729;9964.9536798638;9970.451625160686;9985.45080020606;6157.230346206724;6253.249610046823;6668.199816022108;7019.719211231493;7174.784756457315;7713.2286771322415;7843.882341764764;7846.058472983279;7849.882251766342;7898.447108702336;6999.160100787938;7069.82325441868;7110.146782386147;7132.750353737594;7251.383632391306;6909;6929.480288978448;6933.479989000946;7158.2841715828;7174.461915356474;6779.762708305186;6781.660916954232;6838.179418469616;6843.555168914005;6884.965575172092;4945.085159245551;5062.367204099488;5073.644844860972;5080.949190508048;5109.795608175631;5018.749062546785;5132.897342053213;5185.948140518697;5193.558547523503;5235.842924712265 15:43:42 INFO - PROCESS | 9524 | |4;prototype.html;324.2613912449425;338.23221287676967;345.23358144918274;345.91179249291434;346.64815212559273;5352.545033672142;5496.065668836298;5644.491995720385;5659.4340565943385;5665.575081868861;5352.554810201253;5452.372977107624;5452.83641490755;5481.75332110055;5488.121900495921;4279.74321540707;4283.37891005804;4289.16361309544;4302.48370195577;4321.956780432187;4215.367694845767;4248.9575104249025;4279.0316454430995;4291.399204111427;4324.156789426063;4234.555371685975;4246.150769846027;4248.915021699564;4250.2137104635585;4263.765492897889;4246.386373178203;4278.122984788127;4285.35719642053;4315.158544083905;4316.417283666696;3648.8175591220333;3837.270918525471;3839.0978120141745;3840.558335791392;3846;5306.336707911511;5316.787328506855;5328.49379308965;5414.242006119146;5444.836654900319;4864.1974074277705;4888.511148885119;4896.143174944406;4897.51024897511;4907.631927605444;5521.503064724154;5716.571257155689;5734.989130706413;5763.567732420043;5770.19217309577;4142.544320124784;4148.709590328678;4162.854300099512;4180.143070670505;4191.161767646483;5998.520118390562;6007.909881351783;6015.27816661999;6044.005478192186;6057.878842423171;4178.247915375201;4254.744715317091;4277.657787377002;4318.35224716295;4330.913381732347;4274.508431530352;4278.219157547557;4291.635211007037;4302.290122129876;4304.418903448057;4893.363862697897;4924.3105965164905;4936.950630493721;4965.3048573199785;4996.050750357421;5529.225908372831;5696.344920334214;5850.9414905851245;5859.648421094748;5922.555808314393;1395.8953078519153;1411.4424802203073;1412.4632639596887;1415.2994267837487;1424.2166808255417;932.7061975477839;956.6412595276771;959.9009134541051;974.7173319737338;983.5524836199512;5294.788208471695;5391.78432862689;5405.270288511001;5433.483819037185;5460.235567020621;5681.375048744635;5690.77236910519;5709.286339207599;5723.513501352349;5829.300483941955;5181.844544663666;5352.839414817562;5413.267754318659;5423.891522169613;5468.644538105011;3090.258337998864;3092.922676933095;3111.6577176510564;3111.9533207001914;3116.844157792101;5739.713014349266;5813.360530341659;5862.882742345215;5897.439743224387;5901.321348044944;5576.637518561281;5748.885022299531;5760.423957604206;5805.158252053513;5814.592978491465;5882.411728845401;5898.646081235054;5906.320773111147;5934.821955341346;5950.738719286644;5449.6730196188355;5620.4660557247;5679.046895614175;5736.96337800075;5745.253117094751;5600.927656767022;5642.689652069175;5667.40492248308;5668.631538949955;5673.432656734293;5856.560757943256;5864.592497800582;5898.852528686817;5901.940980590311;5967.492763115184;3977.244323578511;4216.30430978885;4226.915461690687;4241.109367032957;4245.278302688489;5875.796576283894;5943.58394912352;6013.428724271187;6014.939850601613;6019.578629495893;5843.386444423444;5848.561357898089;5876.001079816356;5892.5285977122585;5940.257467816523;5842.737076831638;5851.590388672752;5860.560457965755;5863.912041319469;5864.266966629171;5617;5767.7404516796005;5776.364599893925;5805.6226345289115;5818.912716309174;5875.559333049953;5910.7931222407005;5940.3663992402435;5989.850253743692;6001.519878409804;5659.717014149359;5731.8853622928145;5763.596548241583;5802.564807639359;5850.736716847837 15:43:42 INFO - PROCESS | 9524 | |5;yui.html;721.5057685485443;724.3480867219502;748.6294284329258;816.0778320497836;829.2371018662832;14424.783628245572;15051.096934183943;15082.095074295536;15086.3211155498;15181.316840742165;12453.439595218215;12636.494540218404;12716.36418179092;12734.93632531836;12740.80888786669;759.8366351234483;760.1941941541969;769.3306823063942;785.2971590426565;792.029763539665;796.358931060496;802.7350974178536;802.8474589827914;806.3388021822108;807.2815194476921;831.5343407691712;834.3533761334953;834.7954751085992;836.188896770135;839.3201506779498;829.1749709039544;830.5099991005305;830.6552780596045;830.7258604660448;834.6661335465801;603.523216658839;604.5073265288776;607.398675311443;608.3034925010837;611.6574718157846;14479.276036198147;14507.202103884281;14573.271336433136;14575.854241457662;14610.780838287434;12740.362981850963;13244.86755132446;13541.661458463519;13553.322333883267;13564.796528052088;10821.790586681109;10947.50736216872;10987.505562249718;11045.171612129123;11205.719857003558;3409.573803274591;3422.212891035051;3534.575850897909;3559.6440355964455;3569.7501174917766;55318.72340638271;63608;63698.36301637017;65614.67192664054;66491.335086649;10044.748881278027;10062.094411502854;10142.543585538668;10206.846897296546;10529.526171322308;19699.803001970082;19703;19715;19765.110570024382;19838.70241946372;7668.578228197391;7680.923190768132;7708.190639982833;7801.570913599693;7952.165022672536;4299;4358.782060897006;4414.293713005904;4472.262076757299;4486.416765820488;3283.310504793972;3340.682635149657;3374.274530975852;3379.645137260552;3382.1037425082372;575.5596968319239;575.671867035794;589.0839744197727;593.1902952469848;596.3023262782555;641.6759536434164;666.7628662841929;702.6908160409404;711.6833009310807;724.7898109548278;8694.434861733967;9125.543722813965;9140.268778497704;9157.49633770149;9616.23070154386;641.6246495800009;718.3750137380513;722.5086940880146;723;725.677073702208;4184.581541845791;4380.759058251827;4544.88637784058;4551.271796512542;4562.908741825145;48684.7565762176;48895.511044889805;48918.75540622274;59914;78468;70996.64501677458;71123.2887671127;72599.2740072603;72671;72671;63743.68128159329;64247;65005.999999999054;65763.67118164379;66060.66969665121;8418.200270974248;8618.396712230335;8628.39601227908;8696;8804.867926980973;42343.5765642352;42801.28794848171;44162;44300;44505.33242001308;39030;55882.1617675727;56509;56788;57731.7113414447;10938.234323597271;11191.104711623213;11193;11267.718307042389;11921.642350729491;12221.327826969602;12469.376531173586;12582.281644383356;12739.363031848185;12783.80824287655;11420.94289528547;11491.482883270106;11886.739836264793;12072.637820865388;12422.627321180378;11715.589954351557;12135.211211271238;12564.497420103093;12565.93717031409;12578.182418142791;11052.778944420907;11730.413479326171;11743.17797754149;11811.291322520676;12134.514619415124;9484.715458536255;9700.223982081276;9736.95131524338;9919.851202231828;10349.120324772479;8586.742397728078;8624.22794372777;9832.262580306362;9881.901180988098;9952.950235248778 15:43:42 INFO - PROCESS | 9524 | __end_tp_report 15:43:42 INFO - PROCESS | 9524 | __start_cc_report 15:43:42 INFO - PROCESS | 9524 | _x_x_mozilla_cycle_collect,325 15:43:42 INFO - PROCESS | 9524 | __end_cc_report 15:43:42 INFO - PROCESS | 9524 | __startTimestamp1479167022511__endTimestamp 15:43:42 INFO - PROCESS | 9524 | 15:43:42 INFO - PROCESS | 9524 | ------- Summary: start ------- 15:43:42 INFO - PROCESS | 9524 | Number of tests: 6 15:43:42 INFO - PROCESS | 9524 | 15:43:42 INFO - PROCESS | 9524 | [#0] dojo.html Cycles:165 Average:5444.55 Median:5710.63 stddev:623.50 (10.9%) stddev-sans-first:598.15 15:43:42 INFO - PROCESS | 9524 | Values: 3120.3 3126.2 3127.4 3159.7 3165.0 5382.2 5391.1 5422.8 5433.8 5444.2 5453.4 5464.6 5493.5 5510.1 5567.1 4935.6 4951.3 4990.3 5018.7 5121.1 4986.8 5039.9 5146.2 5152.1 5194.5 4842.4 5029.2 5077.6 5087.0 5127.4 4823.2 4868.9 4869.4 4878.2 4949.1 4785.2 4831.8 4857.1 4872.1 4881.6 5328.6 5329.0 5334.8 5343.1 5388.3 5675.2 5735.5 5762.7 5814.2 5825.9 5920.1 5921.8 5926.4 5937.8 5991.6 5521.0 5540.9 5541.7 5545.4 5559.7 5752.7 5793.4 5953.6 5976.1 6023.4 5794.9 5796.0 5799.3 5833.9 5859.9 5784.9 5847.2 5899.6 5903.2 5907.1 5612.1 5654.4 5655.3 5752.5 5777.7 5805.0 5884.1 5891.1 5941.4 5952.4 4495.1 4497.8 4508.3 4522.0 4563.3 3973.2 3975.2 4004.8 4030.4 4039.6 5587.2 5626.3 5633.1 5710.6 5726.5 5916.6 5961.0 5969.3 5969.5 5975.1 5548.9 5625.6 5669.6 5673.8 5684.8 4931.6 4979.2 4986.6 5040.6 5045.2 6001.9 6016.4 6018.7 6021.2 6028.1 5788.4 5805.4 5827.9 5839.6 5844.4 5909.6 5937.8 5971.1 6017.0 6059.4 5735.8 5745.3 5754.2 5754.5 5762.6 5866.6 5880.2 5881.7 5886.1 5888.4 5785.1 5826.4 5829.0 5846.5 5881.3 5741.4 5755.3 5785.7 5787.1 5815.4 5483.6 5499.5 5606.7 5651.7 5736.5 5752.1 5849.5 5854.7 5871.7 5900.8 5663.9 5725.4 5731.7 5736.5 5747.8 15:43:42 INFO - PROCESS | 9524 | 15:43:42 INFO - PROCESS | 9524 | [#1] ext.html Cycles:180 Average:54080.87 Median:40987.30 stddev:103812.25 (253.3%) stddev-sans-first:104025.66 15:43:42 INFO - PROCESS | 9524 | Values: 548.5 572.4 576.5 585.5 592.2 40861.6 42352.4 42363.8 45188.3 45313.3 42277.0 43679.8 43712.3 43729.3 43769.6 8249.3 8461.5 8462.9 8463.4 8466.3 8492.2 8539.1 8571.7 8592.4 8685.2 8639.7 8648.2 8681.3 8708.2 8745.0 8570.1 8576.1 8634.3 8635.3 8678.3 8446.0 8542.7 8554.9 8583.0 8633.7 41113.0 41675.0 41744.0 41792.2 41806.6 3478.9 3527.5 3565.9 3985.6 4146.8 30658.7 30737.8 30746.7 30845.4 32648.7 4060.3 4124.5 4126.0 4180.2 4277.8 230133.0 230629.0 232383.0 232520.0 234265.0 55180.7 55631.0 55635.4 55660.4 55663.0 59178.0 59390.0 59412.7 59438.0 59551.4 16575.7 16962.1 16963.7 16965.6 16973.0 12867.6 12872.4 12918.9 12934.4 12941.2 15014.0 16755.7 16842.6 17020.1 17117.0 3233.7 3338.9 5903.4 5921.7 6071.2 911.6 940.4 1009.8 1088.4 1131.2 27799.6 30133.4 30193.4 30504.1 30698.7 1083.1 1100.8 1116.6 1129.3 1176.9 15398.8 15927.0 16055.4 16094.3 16128.1 468048.0 471917.0 475047.0 475105.0 476054.0 55901.0 56640.2 56678.4 56923.7 56930.4 1306.1 1314.4 1361.8 1368.2 1374.2 28268.0 29230.9 29708.4 30286.0 30301.2 47602.3 47907.0 47923.5 47964.3 48218.0 424717.0 425459.0 425751.0 427950.0 429386.0 26796.6 27513.4 28312.0 28455.0 29653.9 44957.1 45123.8 45421.0 46741.1 46928.8 38391.8 38738.2 38880.4 39733.2 39983.2 38667.8 38878.0 39214.2 39953.0 40792.2 38949.6 39374.0 39583.0 39604.0 39729.4 33243.0 35205.6 35482.0 35937.1 35965.6 26653.7 26924.3 27268.9 27379.7 29370.7 15:43:42 INFO - PROCESS | 9524 | 15:43:42 INFO - PROCESS | 9524 | [#2] jquery.html Cycles:180 Average:25818.52 Median:2483.04 stddev:68831.98 (2772.1%) stddev-sans-first:68998.59 15:43:42 INFO - PROCESS | 9524 | Values: 388.9 391.7 401.6 405.8 417.7 13950.3 18439.4 18555.6 19199.2 19211.8 18463.4 18529.6 18575.3 18819.1 18904.1 5247.9 5356.6 5390.5 5393.9 5409.6 5299.2 5390.3 5390.9 5396.7 5397.9 5146.3 5277.8 5308.4 5322.4 5375.0 5226.4 5256.5 5261.8 5265.3 5270.9 4776.5 4831.1 5074.3 5132.1 5186.2 13391.8 13511.5 14272.3 20940.7 21401.7 2237.1 2272.2 2349.9 2350.5 2615.6 10105.9 10576.4 11468.8 12477.2 14069.2 1796.8 1803.1 1839.5 1845.5 1915.4 64798.4 74199.0 75733.2 77306.2 78016.6 10657.7 10747.1 10885.7 10959.8 11017.3 12273.2 15141.5 15147.6 15186.2 15245.0 7612.7 7721.9 7987.6 8018.8 8042.4 7814.3 7891.6 7913.0 8130.9 8156.1 3996.5 4022.4 4042.8 4089.0 4141.3 1922.5 1972.0 1972.3 1974.5 1986.2 883.8 956.5 995.5 1010.9 1017.7 17083.8 17898.6 18981.6 19111.7 19699.4 913.1 932.4 935.4 980.8 1019.5 9412.2 10282.6 10444.5 10558.2 10627.3 411312.0 412214.0 415781.0 416171.0 428731.0 52855.0 65369.3 90577.5 90606.5 91636.5 1020.8 1040.4 1041.4 1043.2 1044.7 14931.0 15507.3 16217.3 16249.8 16494.6 37847.4 39513.0 40832.1 42347.2 42938.7 53909.2 55169.0 55401.4 55664.7 56250.2 8205.4 8304.0 8306.4 8409.7 8670.0 11660.4 12371.1 12537.5 12757.5 12829.4 10424.5 10722.0 11078.3 11186.5 11535.2 10968.3 11016.3 11124.6 11177.2 11394.5 11157.7 11197.2 11281.7 11301.7 11509.4 7954.8 8178.2 8487.3 8529.5 8536.2 10453.3 10813.1 11026.6 11090.2 11672.6 15:43:42 INFO - PROCESS | 9524 | 15:43:42 INFO - PROCESS | 9524 | [#3] mootools.html Cycles:180 Average:5506.64 Median:5121.35 stddev:3112.15 (60.8%) stddev-sans-first:3105.78 15:43:42 INFO - PROCESS | 9524 | Values: 1426.3 1446.8 1503.5 1651.6 1655.1 7285.9 7524.4 7950.5 8277.7 8390.3 7998.4 8296.7 8311.8 8513.3 8540.3 2313.3 2335.8 2341.2 2341.8 2343.2 2294.4 2331.0 2331.8 2380.4 2382.0 2193.2 2201.2 2213.0 2217.1 2239.6 2233.4 2269.8 2301.5 2306.3 2310.1 2278.1 2281.2 2289.9 2295.3 2308.9 8294.9 8340.0 8397.7 8429.7 8434.9 5170.3 5314.8 5315.4 5318.3 5321.9 3168.5 3208.0 3437.3 3466.5 3470.2 1014.8 1030.1 1035.7 1041.6 1084.3 11656.8 11668.9 11690.1 11723.6 11878.0 4431.5 4464.4 4533.7 4542.1 4710.9 9807.8 9814.8 9815.8 9851.6 9890.5 5210.1 5275.2 5278.9 5292.6 5300.8 4680.1 4813.1 4814.5 4827.2 4900.1 3608.6 3665.3 3732.1 3757.6 3793.5 1171.0 1187.4 1193.7 1193.9 1202.5 695.8 909.0 916.7 921.6 926.8 5377.4 5436.5 5536.9 5619.8 5619.9 453.8 465.0 465.4 471.7 472.3 3709.3 3801.1 3822.9 3826.5 3916.4 10202.2 10521.2 10526.3 10546.0 10557.5 10228.4 10331.8 10486.4 10505.8 10522.2 7826.5 7923.3 7967.0 8019.2 8024.3 5484.5 5495.5 5525.6 5535.5 5728.1 9321.7 9324.5 9326.1 9339.7 9372.1 9389.8 9840.6 9965.0 9970.5 9985.5 6157.2 6253.2 6668.2 7019.7 7174.8 7713.2 7843.9 7846.1 7849.9 7898.4 6999.2 7069.8 7110.1 7132.8 7251.4 6909.0 6929.5 6933.5 7158.3 7174.5 6779.8 6781.7 6838.2 6843.6 6885.0 4945.1 5062.4 5073.6 5080.9 5109.8 5018.7 5132.9 5185.9 5193.6 5235.8 15:43:42 INFO - PROCESS | 9524 | 15:43:42 INFO - PROCESS | 9524 | [#4] prototype.html Cycles:180 Average:4824.85 Median:5484.94 stddev:1411.42 (25.7%) stddev-sans-first:1374.36 15:43:42 INFO - PROCESS | 9524 | Values: 324.3 338.2 345.2 345.9 346.6 5352.5 5496.1 5644.5 5659.4 5665.6 5352.6 5452.4 5452.8 5481.8 5488.1 4279.7 4283.4 4289.2 4302.5 4322.0 4215.4 4249.0 4279.0 4291.4 4324.2 4234.6 4246.2 4248.9 4250.2 4263.8 4246.4 4278.1 4285.4 4315.2 4316.4 3648.8 3837.3 3839.1 3840.6 3846.0 5306.3 5316.8 5328.5 5414.2 5444.8 4864.2 4888.5 4896.1 4897.5 4907.6 5521.5 5716.6 5735.0 5763.6 5770.2 4142.5 4148.7 4162.9 4180.1 4191.2 5998.5 6007.9 6015.3 6044.0 6057.9 4178.2 4254.7 4277.7 4318.4 4330.9 4274.5 4278.2 4291.6 4302.3 4304.4 4893.4 4924.3 4937.0 4965.3 4996.1 5529.2 5696.3 5850.9 5859.6 5922.6 1395.9 1411.4 1412.5 1415.3 1424.2 932.7 956.6 959.9 974.7 983.6 5294.8 5391.8 5405.3 5433.5 5460.2 5681.4 5690.8 5709.3 5723.5 5829.3 5181.8 5352.8 5413.3 5423.9 5468.6 3090.3 3092.9 3111.7 3112.0 3116.8 5739.7 5813.4 5862.9 5897.4 5901.3 5576.6 5748.9 5760.4 5805.2 5814.6 5882.4 5898.6 5906.3 5934.8 5950.7 5449.7 5620.5 5679.0 5737.0 5745.3 5600.9 5642.7 5667.4 5668.6 5673.4 5856.6 5864.6 5898.9 5901.9 5967.5 3977.2 4216.3 4226.9 4241.1 4245.3 5875.8 5943.6 6013.4 6014.9 6019.6 5843.4 5848.6 5876.0 5892.5 5940.3 5842.7 5851.6 5860.6 5863.9 5864.3 5617.0 5767.7 5776.4 5805.6 5818.9 5875.6 5910.8 5940.4 5989.9 6001.5 5659.7 5731.9 5763.6 5802.6 5850.7 15:43:42 INFO - PROCESS | 9524 | 15:43:42 INFO - PROCESS | 9524 | [#5] yui.html Cycles:180 Average:16026.03 Median:55600.44 stddev:20385.73 (36.7%) stddev-sans-first:20410.52 15:43:42 INFO - PROCESS | 9524 | Values: 721.5 724.3 748.6 816.1 829.2 14424.8 15051.1 15082.1 15086.3 15181.3 12453.4 12636.5 12716.4 12734.9 12740.8 759.8 760.2 769.3 785.3 792.0 796.4 802.7 802.8 806.3 807.3 831.5 834.4 834.8 836.2 839.3 829.2 830.5 830.7 830.7 834.7 603.5 604.5 607.4 608.3 611.7 14479.3 14507.2 14573.3 14575.9 14610.8 12740.4 13244.9 13541.7 13553.3 13564.8 10821.8 10947.5 10987.5 11045.2 11205.7 3409.6 3422.2 3534.6 3559.6 3569.8 55318.7 63608.0 63698.4 65614.7 66491.3 10044.7 10062.1 10142.5 10206.8 10529.5 19699.8 19703.0 19715.0 19765.1 19838.7 7668.6 7680.9 7708.2 7801.6 7952.2 4299.0 4358.8 4414.3 4472.3 4486.4 3283.3 3340.7 3374.3 3379.6 3382.1 575.6 575.7 589.1 593.2 596.3 641.7 666.8 702.7 711.7 724.8 8694.4 9125.5 9140.3 9157.5 9616.2 641.6 718.4 722.5 723.0 725.7 4184.6 4380.8 4544.9 4551.3 4562.9 48684.8 48895.5 48918.8 59914.0 78468.0 70996.6 71123.3 72599.3 72671.0 72671.0 63743.7 64247.0 65006.0 65763.7 66060.7 8418.2 8618.4 8628.4 8696.0 8804.9 42343.6 42801.3 44162.0 44300.0 44505.3 39030.0 55882.2 56509.0 56788.0 57731.7 10938.2 11191.1 11193.0 11267.7 11921.6 12221.3 12469.4 12582.3 12739.4 12783.8 11420.9 11491.5 11886.7 12072.6 12422.6 11715.6 12135.2 12564.5 12565.9 12578.2 11052.8 11730.4 11743.2 11811.3 12134.5 9484.7 9700.2 9737.0 9919.9 10349.1 8586.7 8624.2 9832.3 9881.9 9953.0 15:43:42 INFO - PROCESS | 9524 | -------- Summary: end -------- 15:43:42 INFO - PROCESS | 9524 | 15:43:43 INFO - TEST-INFO | 9524: exit 0 15:43:43 INFO - TEST-OK | dromaeo_css | took 1116641ms 15:43:43 INFO - TEST-START | kraken 15:43:43 INFO - operating with platform_type : linux_ 15:43:43 INFO - Initialising browser for kraken test... 15:43:43 INFO - TEST-INFO | started process 9887 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW0bJ0c/profile http://localhost:41027/getInfo.html) 15:43:48 INFO - PROCESS | 9887 | __metrics Screen width/height:1600/1200 15:43:48 INFO - PROCESS | 9887 | colorDepth:24 15:43:48 INFO - PROCESS | 9887 | Browser inner width/height: 1024/697 15:43:48 INFO - PROCESS | 9887 | __metrics 15:43:48 ERROR - PROCESS | 9887 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3178: TypeError: this.tabs is undefined 15:43:49 INFO - TEST-INFO | 9887: exit 0 15:43:49 INFO - Browser initialized. 15:43:49 INFO - Running cycle 1/1 for kraken test... 15:43:49 INFO - TEST-INFO | started process 10010 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW0bJ0c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:44:01 INFO - PROCESS | 10010 | RSS: Main: 186138624 15:44:01 INFO - PROCESS | 10010 | 15:44:04 INFO - PROCESS | 10010 | Cycle 1(1): loaded http://localhost:41027/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41027/tests/kraken/driver.html?testName=audio-beat-detection) 15:44:05 INFO - PROCESS | 10010 | RSS: Main: 198557696 15:44:05 INFO - PROCESS | 10010 | 15:44:08 INFO - PROCESS | 10010 | Cycle 1(1): loaded http://localhost:41027/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41027/tests/kraken/driver.html?testName=audio-dft) 15:44:08 INFO - PROCESS | 10010 | RSS: Main: 197177344 15:44:08 INFO - PROCESS | 10010 | 15:44:11 INFO - PROCESS | 10010 | Cycle 1(1): loaded http://localhost:41027/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41027/tests/kraken/driver.html?testName=audio-fft) 15:44:12 INFO - PROCESS | 10010 | RSS: Main: 193830912 15:44:12 INFO - PROCESS | 10010 | 15:44:14 INFO - PROCESS | 10010 | Cycle 1(1): loaded http://localhost:41027/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41027/tests/kraken/driver.html?testName=audio-oscillator) 15:44:14 INFO - PROCESS | 10010 | RSS: Main: 194080768 15:44:14 INFO - PROCESS | 10010 | 15:44:17 INFO - PROCESS | 10010 | Cycle 1(1): loaded http://localhost:41027/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41027/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:44:17 INFO - PROCESS | 10010 | RSS: Main: 194281472 15:44:17 INFO - PROCESS | 10010 | 15:44:20 INFO - PROCESS | 10010 | Cycle 1(1): loaded http://localhost:41027/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41027/tests/kraken/driver.html?testName=imaging-darkroom) 15:44:21 INFO - PROCESS | 10010 | RSS: Main: 199577600 15:44:21 INFO - PROCESS | 10010 | 15:44:24 INFO - PROCESS | 10010 | Cycle 1(1): loaded http://localhost:41027/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41027/tests/kraken/driver.html?testName=imaging-desaturate) 15:44:25 INFO - PROCESS | 10010 | RSS: Main: 199933952 15:44:25 INFO - PROCESS | 10010 | 15:44:28 INFO - PROCESS | 10010 | Cycle 1(1): loaded http://localhost:41027/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41027/tests/kraken/driver.html?testName=json-parse-financial) 15:44:28 INFO - PROCESS | 10010 | RSS: Main: 199774208 15:44:28 INFO - PROCESS | 10010 | 15:44:30 INFO - PROCESS | 10010 | Cycle 1(1): loaded http://localhost:41027/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41027/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:44:31 INFO - PROCESS | 10010 | RSS: Main: 199217152 15:44:31 INFO - PROCESS | 10010 | 15:44:32 INFO - PROCESS | 10010 | Cycle 1(1): loaded http://localhost:41027/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41027/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:44:33 INFO - PROCESS | 10010 | RSS: Main: 199282688 15:44:33 INFO - PROCESS | 10010 | 15:44:35 INFO - PROCESS | 10010 | Cycle 1(1): loaded http://localhost:41027/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41027/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:44:36 INFO - PROCESS | 10010 | RSS: Main: 199634944 15:44:36 INFO - PROCESS | 10010 | 15:44:38 INFO - PROCESS | 10010 | Cycle 1(1): loaded http://localhost:41027/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41027/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:44:39 INFO - PROCESS | 10010 | RSS: Main: 199548928 15:44:39 INFO - PROCESS | 10010 | 15:44:42 INFO - PROCESS | 10010 | Cycle 1(1): loaded http://localhost:41027/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41027/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:44:43 INFO - PROCESS | 10010 | RSS: Main: 199749632 15:44:43 INFO - PROCESS | 10010 | 15:44:44 INFO - PROCESS | 10010 | Cycle 1(1): loaded http://localhost:41027/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41027/tests/kraken/driver.html?testName=ai-astar) 15:44:45 INFO - PROCESS | 10010 | RSS: Main: 201392128 15:44:45 INFO - PROCESS | 10010 | 15:44:45 INFO - PROCESS | 10010 | __start_tp_report 15:44:45 INFO - PROCESS | 10010 | _x_x_mozilla_page_load 15:44:45 INFO - PROCESS | 10010 | _x_x_mozilla_page_load_details 15:44:45 INFO - PROCESS | 10010 | |i|pagename|runs| 15:44:45 INFO - PROCESS | 10010 | |0;ai-astar;109;114;112;113;114;116;114;114;115;117 15:44:45 INFO - PROCESS | 10010 | |1;audio-beat-detection;154;126;125;166;127;129;125;122;160;126 15:44:45 INFO - PROCESS | 10010 | |2;audio-dft;164;166;166;166;166;163;163;164;162;163 15:44:45 INFO - PROCESS | 10010 | |3;audio-fft;78;75;75;113;76;75;75;76;113;75 15:44:45 INFO - PROCESS | 10010 | |4;audio-oscillator;84;82;107;83;83;82;99;82;82;116 15:44:45 INFO - PROCESS | 10010 | |5;imaging-gaussian-blur;118;119;118;119;118;118;117;117;119;119 15:44:45 INFO - PROCESS | 10010 | |6;imaging-darkroom;149;149;147;148;147;149;148;146;147;147 15:44:45 INFO - PROCESS | 10010 | |7;imaging-desaturate;85;85;85;85;85;86;85;86;86;86 15:44:45 INFO - PROCESS | 10010 | |8;json-parse-financial;61;55;62;54;54;55;55;56;54;56 15:44:45 INFO - PROCESS | 10010 | |9;json-stringify-tinderbox;64;63;62;63;64;62;63;65;63;64 15:44:45 INFO - PROCESS | 10010 | |10;stanford-crypto-aes;80;80;84;80;79;81;79;82;83;80 15:44:45 INFO - PROCESS | 10010 | |11;stanford-crypto-ccm;134;132;141;132;138;144;143;136;188;142 15:44:45 INFO - PROCESS | 10010 | |12;stanford-crypto-pbkdf2;164;165;164;164;164;163;166;164;166;165 15:44:45 INFO - PROCESS | 10010 | |13;stanford-crypto-sha256-iterative;65;73;65;66;65;64;63;68;62;66 15:44:45 INFO - PROCESS | 10010 | __end_tp_report 15:44:45 INFO - PROCESS | 10010 | __start_cc_report 15:44:45 INFO - PROCESS | 10010 | _x_x_mozilla_cycle_collect,807 15:44:45 INFO - PROCESS | 10010 | __end_cc_report 15:44:45 INFO - PROCESS | 10010 | __startTimestamp1479167085120__endTimestamp 15:44:45 INFO - PROCESS | 10010 | 15:44:45 INFO - PROCESS | 10010 | ------- Summary: start ------- 15:44:45 INFO - PROCESS | 10010 | Number of tests: 14 15:44:45 INFO - PROCESS | 10010 | 15:44:45 INFO - PROCESS | 10010 | [#0] ai-astar Cycles:10 Average:113.80 Median:114.00 stddev:2.20 (1.9%) stddev-sans-first:1.50 15:44:45 INFO - PROCESS | 10010 | Values: 109.0 114.0 112.0 113.0 114.0 116.0 114.0 114.0 115.0 117.0 15:44:45 INFO - PROCESS | 10010 | 15:44:45 INFO - PROCESS | 10010 | [#1] audio-beat-detection Cycles:10 Average:136.00 Median:128.00 stddev:16.89 (13.2%) stddev-sans-first:16.61 15:44:45 INFO - PROCESS | 10010 | Values: 154.0 126.0 125.0 166.0 127.0 129.0 125.0 122.0 160.0 126.0 15:44:45 INFO - PROCESS | 10010 | 15:44:45 INFO - PROCESS | 10010 | [#2] audio-dft Cycles:10 Average:164.30 Median:165.00 stddev:1.57 (0.9%) stddev-sans-first:1.66 15:44:45 INFO - PROCESS | 10010 | Values: 164.0 166.0 166.0 166.0 166.0 163.0 163.0 164.0 162.0 163.0 15:44:45 INFO - PROCESS | 10010 | 15:44:45 INFO - PROCESS | 10010 | [#3] audio-fft Cycles:10 Average:83.10 Median:75.00 stddev:15.79 (21.0%) stddev-sans-first:16.64 15:44:45 INFO - PROCESS | 10010 | Values: 78.0 75.0 75.0 113.0 76.0 75.0 75.0 76.0 113.0 75.0 15:44:45 INFO - PROCESS | 10010 | 15:44:45 INFO - PROCESS | 10010 | [#4] audio-oscillator Cycles:10 Average:90.00 Median:82.50 stddev:12.63 (15.3%) stddev-sans-first:13.21 15:44:45 INFO - PROCESS | 10010 | Values: 84.0 82.0 107.0 83.0 83.0 82.0 99.0 82.0 82.0 116.0 15:44:45 INFO - PROCESS | 10010 | 15:44:45 INFO - PROCESS | 10010 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.50 stddev:0.79 (0.7%) stddev-sans-first:0.83 15:44:45 INFO - PROCESS | 10010 | Values: 118.0 119.0 118.0 119.0 118.0 118.0 117.0 117.0 119.0 119.0 15:44:45 INFO - PROCESS | 10010 | 15:44:45 INFO - PROCESS | 10010 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:1.06 (0.7%) stddev-sans-first:1.01 15:44:45 INFO - PROCESS | 10010 | Values: 149.0 149.0 147.0 148.0 147.0 149.0 148.0 146.0 147.0 147.0 15:44:45 INFO - PROCESS | 10010 | 15:44:45 INFO - PROCESS | 10010 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:85.50 stddev:0.52 (0.6%) stddev-sans-first:0.53 15:44:45 INFO - PROCESS | 10010 | Values: 85.0 85.0 85.0 85.0 85.0 86.0 85.0 86.0 86.0 86.0 15:44:45 INFO - PROCESS | 10010 | 15:44:45 INFO - PROCESS | 10010 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:55.50 stddev:2.90 (5.2%) stddev-sans-first:2.50 15:44:45 INFO - PROCESS | 10010 | Values: 61.0 55.0 62.0 54.0 54.0 55.0 55.0 56.0 54.0 56.0 15:44:45 INFO - PROCESS | 10010 | 15:44:45 INFO - PROCESS | 10010 | [#9] json-stringify-tinderbox Cycles:10 Average:63.30 Median:63.50 stddev:0.95 (1.5%) stddev-sans-first:0.97 15:44:45 INFO - PROCESS | 10010 | Values: 64.0 63.0 62.0 63.0 64.0 62.0 63.0 65.0 63.0 64.0 15:44:45 INFO - PROCESS | 10010 | 15:44:45 INFO - PROCESS | 10010 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:80.50 stddev:1.69 (2.1%) stddev-sans-first:1.76 15:44:45 INFO - PROCESS | 10010 | Values: 80.0 80.0 84.0 80.0 79.0 81.0 79.0 82.0 83.0 80.0 15:44:45 INFO - PROCESS | 10010 | 15:44:45 INFO - PROCESS | 10010 | [#11] stanford-crypto-ccm Cycles:10 Average:143.00 Median:141.50 stddev:16.42 (11.6%) stddev-sans-first:17.10 15:44:45 INFO - PROCESS | 10010 | Values: 134.0 132.0 141.0 132.0 138.0 144.0 143.0 136.0 188.0 142.0 15:44:45 INFO - PROCESS | 10010 | 15:44:45 INFO - PROCESS | 10010 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.50 Median:164.50 stddev:0.97 (0.6%) stddev-sans-first:1.01 15:44:45 INFO - PROCESS | 10010 | Values: 164.0 165.0 164.0 164.0 164.0 163.0 166.0 164.0 166.0 165.0 15:44:45 INFO - PROCESS | 10010 | 15:44:45 INFO - PROCESS | 10010 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:65.50 stddev:3.06 (4.7%) stddev-sans-first:3.23 15:44:45 INFO - PROCESS | 10010 | Values: 65.0 73.0 65.0 66.0 65.0 64.0 63.0 68.0 62.0 66.0 15:44:45 INFO - PROCESS | 10010 | -------- Summary: end -------- 15:44:45 INFO - PROCESS | 10010 | 15:44:46 INFO - TEST-INFO | 10010: exit 0 15:44:46 INFO - TEST-OK | kraken | took 62791ms 15:44:46 INFO - SUITE-END | took 1179s 15:44:46 INFO - Completed test suite (00:19:39) 15:44:46 INFO - javascript benchmark 15:44:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6972.461370790299, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3120.26673731673, 3126.1871913302534, 3127.3588914272577, 3159.747220222384, 3164.968350316496, 5382.2464854920345, 5391.083515802318, 5422.783088676449, 5433.755481003354, 5444.210589464526, 5453.3728621208575, 5464.562834973202, 5493.478119578644, 5510.090835012218, 5567.053600887849, 4935.605151587883, 4951.331570238017, 4990.301357809892, 5018.698878067309, 5121.052605268037, 4986.75066246688, 5039.949600503985, 5146.150885103972, 5152.072626927152, 5194.454582268864, 4842.370491836039, 5029.170186919154, 5077.644564880423, 5086.974565127188, 5127.435982041991, 4823.155947709137, 4868.878278043077, 4869.4156701195725, 4878.24387219978, 4949.08441938239, 4785.186518291899, 4831.830885918976, 4857.149998750205, 4872.123017856784, 4881.609471242327, 5328.6269961102735, 5329.040772660919, 5334.813281535166, 5343.064963631349, 5388.299521062276, 5675.2054712340305, 5735.483806457397, 5762.683052432115, 5814.186013958049, 5825.854353641151, 5920.082387229986, 5921.792737254175, 5926.4073592640825, 5937.821865344046, 5991.550633702446, 5520.972395137998, 5540.889182216373, 5541.667499950016, 5545.417731138213, 5559.749811258503, 5752.741126649227, 5793.391693872083, 5953.613015154087, 5976.133460648181, 6023.397660233942, 5794.88410231793, 5796.0, 5799.2750906136735, 5833.88332233353, 5859.882802343929, 5784.884302314014, 5847.210626565445, 5899.557533184942, 5903.203067585821, 5907.113932910098, 5612.07400778875, 5654.434556544395, 5655.293088363955, 5752.482276595043, 5777.740001699934, 5804.970975145097, 5884.146798714248, 5891.116332550152, 5941.37615550361, 5952.375000624958, 4495.100979803987, 4497.8425755098415, 4508.278675411918, 4521.982553925341, 4563.292689633112, 3973.1854969731135, 3975.224831157954, 4004.7797371144284, 4030.375291829771, 4039.5758445363404, 5587.189857470644, 5626.2685850839125, 5633.070543360382, 5710.628809127394, 5726.513246374022, 5916.645001299936, 5961.0, 5969.31352894414, 5969.522438204933, 5975.103734439869, 5548.889022219533, 5625.634333768292, 5669.6314739541795, 5673.773049078073, 5684.829455116271, 4931.556159945622, 4979.228219625964, 4986.55121039101, 5040.647154699136, 5045.217991211368, 6001.939980600226, 6016.368281330485, 6018.729157187937, 6021.2473440819895, 6028.125921741323, 5788.392218817132, 5805.419458054161, 5827.854303642443, 5839.649621022752, 5844.415558444121, 5909.645421274738, 5937.7921772737745, 5971.134185542985, 6017.037274036308, 6059.424354686298, 5735.827925162252, 5745.253117094918, 5754.194412782297, 5754.482096611325, 5762.596618236683, 5866.5893387462465, 5880.235569375954, 5881.735321910439, 5886.087656413263, 5888.381719919346, 5785.132230165509, 5826.446487583673, 5829.038208695518, 5846.503047241032, 5881.2942446906645, 5741.3971532988435, 5755.309362876482, 5785.739641716217, 5787.102999035156, 5815.360310365941, 5483.616146869681, 5499.5325397340075, 5606.719664016864, 5651.660900345993, 5736.512396446349, 5752.108423194411, 5849.473547380756, 5854.707264636836, 5871.735771890189, 5900.793472228452, 5663.943360566506, 5725.370209277059, 5731.7420716067045, 5736.512396446349, 5747.770089196552], "value": 5401.858140077941, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.4868777703373, 572.3789688188316, 576.5157267894967, 585.5052480653851, 592.2448877680957, 40861.59138408615, 42352.36471452931, 42363.78818105909, 45188.32217516732, 45313.320300195526, 42277.0, 43679.78160109203, 43712.34431483522, 43729.344059839124, 43769.562304376945, 8249.298809601176, 8461.53461559614, 8462.942132233471, 8463.365247606424, 8466.32269418448, 8492.235698787108, 8539.06070332263, 8571.657133714674, 8592.355573331994, 8685.218330350268, 8639.740807775777, 8648.1784230498, 8681.34889883258, 8708.17272359125, 8745.0, 8570.057293697688, 8576.09950955147, 8634.266087382548, 8635.266002389804, 8678.349123815738, 8445.957770211171, 8542.74371768848, 8554.93063367079, 8582.957085214597, 8633.69782057625, 41113.0, 41675.0, 41744.0, 41792.164156716695, 41806.581934180875, 3478.9130271743156, 3527.4532447470683, 3565.94651080234, 3985.60143985602, 4146.792660366969, 30658.69341306603, 30737.846310768527, 30746.692533074605, 30845.383092338026, 32648.6735132648, 4060.309747342959, 4124.463819703449, 4125.958740412588, 4180.16396720654, 4277.786110694453, 230133.0, 230628.9999999983, 232383.0, 232520.0, 234265.0, 55180.724096379265, 55631.0, 55635.44364556303, 55660.443395565526, 55663.0, 59178.0, 59390.0, 59412.70293648504, 59438.0, 59551.40448595458, 16575.6684866302, 16962.067086310126, 16963.74554381685, 16965.575860603338, 16973.0, 12867.613971580868, 12872.420741066675, 12918.870811291954, 12934.41795119222, 12941.158824676366, 15014.0, 16755.66488670244, 16842.57893552671, 17020.148992550323, 17117.0, 3233.708966193054, 3338.9499157512655, 5903.439173278532, 5921.73352199152, 6071.210742603434, 911.6080085563138, 940.4451373689556, 1009.7627057641448, 1088.4448931045224, 1131.1878967878304, 27799.58300625492, 30133.397332053235, 30193.396132077236, 30504.08487745371, 30698.69301307003, 1083.1064371893062, 1100.829371447411, 1116.6147679050714, 1129.271619805221, 1176.8528933883265, 15398.769018464733, 15927.0, 16055.357785688675, 16094.275757590936, 16128.11295378742, 468048.0, 471917.0, 475047.0, 475105.0, 476054.0, 55901.0, 56640.150397744066, 56678.43321566814, 56923.71538142283, 56930.43069569334, 1306.1183701001785, 1314.4216544720293, 1361.795730640392, 1368.2406264523086, 1374.1686279800576, 28268.0, 29230.853845731486, 29708.405831883672, 30286.0, 30301.242468938453, 47602.285965711235, 47907.0, 47923.52076479191, 47964.28053579269, 48218.0, 424717.0, 425459.0, 425751.0, 427950.0, 429386.0, 26796.59805102964, 27513.44973100487, 28312.0, 28455.0, 29653.920946205544, 44957.100857982005, 45123.774381127885, 45421.0, 46741.06517869556, 46928.765356173004, 38391.808040959615, 38738.22523549457, 38880.444154278775, 39733.2053358937, 39983.2003359937, 38667.80666096652, 38878.0, 39214.2157156861, 39953.0, 40792.1841563173, 38949.61050389573, 39374.0, 39583.0, 39604.0, 39729.40405893972, 33243.0, 35205.647943520235, 35482.0, 35937.101572460895, 35965.62380258124, 26653.733462665125, 26924.326891827077, 27268.863655681595, 27379.726202738515, 29370.706292936797], "value": 19064.721106373527, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.8736160747758, 391.65338675272375, 401.60642570281124, 405.7747949887812, 417.6533477213913, 13950.302484875767, 18439.354622588213, 18555.628887422245, 19199.232030718773, 19211.807881921195, 18463.446096617125, 18529.629407411845, 18575.349862754807, 18819.05904704766, 18904.10958904109, 5247.947520524803, 5356.598255130881, 5390.51485366317, 5393.9190912136155, 5409.6213265071465, 5299.178627312773, 5390.326209223847, 5390.865228369283, 5396.730163491829, 5397.919031214535, 5146.253793199984, 5277.815276465324, 5308.389535203462, 5322.414534401213, 5374.973125134388, 5226.372835259775, 5256.474352564751, 5261.76322065508, 5265.315508983846, 5270.947290527103, 4776.47458779534, 4831.130396528623, 5074.314967479417, 5132.1275383184575, 5186.247994040843, 13391.799123013163, 13511.459541618324, 14272.286385680778, 20940.685889711665, 21401.67897481539, 2237.1498830444325, 2272.216085450517, 2349.859008459498, 2350.471143992605, 2615.6076588511874, 10105.949470252675, 10576.36541807494, 11468.827967580493, 12477.188982716094, 14069.155850648995, 1796.7574377459136, 1803.0984507746127, 1839.5217243516781, 1845.5201647571594, 1915.4253723882919, 64798.352016480174, 74199.0, 75733.24266757317, 77306.22693773046, 78016.60991695062, 10657.680269591925, 10747.140228781678, 10885.673429797118, 10959.780804383867, 11017.283876548, 12273.202241854251, 15141.545753627408, 15147.621309467351, 15186.164760938034, 15245.0, 7612.657430415645, 7721.92278077212, 7987.600619969095, 8018.79953001168, 8042.396820238506, 7814.257645523666, 7891.644875980594, 7913.0, 8130.878036829452, 8156.1028286888395, 3996.540397854284, 4022.4368588397647, 4042.7776472293717, 4088.9795551022053, 4141.254574176617, 1922.520815675342, 1971.9802801972085, 1972.280117757037, 1974.5261137326938, 1986.1558837494008, 883.8188171424842, 956.4691596164196, 995.4574756757585, 1010.939343639384, 1017.7099526634873, 17083.829161708225, 17898.642027159385, 18981.62036759257, 19111.713324300148, 19699.40901772949, 913.1005959130251, 932.3753085432776, 935.3686261773275, 980.8038392321564, 1019.4647809899714, 9412.247020238501, 10282.588696452207, 10444.529996150191, 10558.155347572176, 10627.309224900357, 411312.0, 412214.0, 415781.0, 416171.0, 428731.0, 52855.0, 65369.34630653728, 90577.54711226534, 90606.54696726475, 91636.54181729181, 1020.7805321855985, 1040.3705758016442, 1041.4272150317295, 1043.2280112716535, 1044.6709286574705, 14931.0418733086, 15507.30217140254, 16217.270222839765, 16249.837501624832, 16494.587635309214, 37847.43228851625, 39513.0, 40832.079348494895, 42347.15305693931, 42938.71183864489, 53909.19136213038, 55169.0, 55401.44598553963, 55664.72167639136, 56250.1562476555, 8205.425620206528, 8303.95848020756, 8306.377021723516, 8409.705660301861, 8670.0, 11660.358680272666, 12371.13402061847, 12537.498500059895, 12757.48970041225, 12829.422675979416, 10424.530896109845, 10722.03501684852, 11078.335299882034, 11186.496607652838, 11535.192536522363, 10968.341899486057, 11016.283941543774, 11124.555017799521, 11177.16171287173, 11394.48724807369, 11157.72105697364, 11197.160212983896, 11281.661550153509, 11301.71745706331, 11509.366984815915, 7954.8067789831985, 8178.223068808454, 8487.321014318963, 8529.530875801891, 8536.231739143259, 10453.26827122094, 10813.134949204203, 11026.558937642405, 11090.223684342342, 11672.591459299223], "value": 8733.857836635461, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1426.308240503356, 1446.7540518111923, 1503.5188739603325, 1651.556504687726, 1655.081429806457, 7285.890711639329, 7524.360429363497, 7950.483218590794, 8277.710280140196, 8390.328773698106, 7998.440109192359, 8296.709615163456, 8311.75064748057, 8513.27637150843, 8540.316774658027, 2313.3406979010942, 2335.789778919897, 2341.1805867946255, 2341.777531134548, 2343.16817529777, 2294.3575798776287, 2331.0442718485424, 2331.80179684727, 2380.3811009137576, 2381.95236095278, 2193.1885202475028, 2201.152556265833, 2212.9668054979106, 2217.1020736601704, 2239.6304609739373, 2233.4304752288226, 2269.7730226977337, 2301.493671392291, 2306.308107567723, 2310.1106074161485, 2278.0773786616446, 2281.2015794471968, 2289.9427514312274, 2295.3114065780364, 2308.9422764430856, 8294.875576866352, 8339.957505311835, 8397.748067557983, 8429.70496032642, 8434.915650843473, 5170.319646115027, 5314.7608357624, 5315.388730296027, 5318.282031925718, 5321.8935621287355, 3168.461361568539, 3207.957413840511, 3437.2609888873762, 3466.4973578830927, 3470.16715988161, 1014.8426993815971, 1030.0574973898874, 1035.6685860524635, 1041.599049278719, 1084.2735367303846, 11656.825147622792, 11668.883311166865, 11690.123240756891, 11723.648290551211, 11878.049756019498, 4431.468223813163, 4464.419625448671, 4533.662569541993, 4542.068875880503, 4710.905781884411, 9807.754806129904, 9814.754631134136, 9815.754606134904, 9851.556679949419, 9890.456024918554, 5210.062188806051, 5275.235090911796, 5278.9208161877605, 5292.550133238641, 5300.814471493479, 4680.063987202573, 4813.133635945564, 4814.542618451242, 4827.155247831615, 4900.142475066849, 3608.62109478501, 3665.3402387570495, 3732.122951106488, 3757.5678796938155, 3793.468914351993, 1170.9648710538697, 1187.424099311833, 1193.7135087578918, 1193.8985186259092, 1202.506972141418, 695.8121307247015, 908.954552272397, 916.7433118726767, 921.6221349246911, 926.8146370725747, 5377.3816011159215, 5436.53789427903, 5536.916946245809, 5619.775208991595, 5619.8595035124445, 453.80259587079723, 464.97907594158346, 465.36710074298924, 471.6651875193195, 472.2679846238317, 3709.2581483703366, 3801.125741079512, 3822.904427389282, 3826.521684789401, 3916.373380259145, 10202.183825293958, 10521.21090918169, 10526.31578947366, 10546.0, 10557.524911379007, 10228.386296822215, 10331.793364132674, 10486.37081775096, 10505.842412363821, 10522.210834187466, 7826.530408175528, 7923.286904178536, 7967.0, 8019.198080192051, 8024.317932975646, 5484.451554844483, 5495.53287970527, 5525.640833345819, 5535.474129957647, 5728.112142617901, 9321.673741419017, 9324.533773311443, 9326.114019168168, 9339.673111441067, 9372.062793720574, 9389.765255868659, 9840.55717492729, 9964.9536798638, 9970.451625160686, 9985.45080020606, 6157.230346206724, 6253.249610046823, 6668.199816022108, 7019.719211231493, 7174.784756457315, 7713.2286771322415, 7843.882341764764, 7846.058472983279, 7849.882251766342, 7898.447108702336, 6999.160100787938, 7069.82325441868, 7110.146782386147, 7132.750353737594, 7251.383632391306, 6909.0, 6929.480288978448, 6933.479989000946, 7158.2841715828, 7174.461915356474, 6779.762708305186, 6781.660916954232, 6838.179418469616, 6843.555168914005, 6884.965575172092, 4945.085159245551, 5062.367204099488, 5073.644844860972, 5080.949190508048, 5109.795608175631, 5018.749062546785, 5132.897342053213, 5185.948140518697, 5193.558547523503, 5235.842924712265], "value": 4356.176371612192, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.2613912449425, 338.23221287676967, 345.23358144918274, 345.91179249291434, 346.64815212559273, 5352.545033672142, 5496.065668836298, 5644.491995720385, 5659.4340565943385, 5665.575081868861, 5352.554810201253, 5452.372977107624, 5452.83641490755, 5481.75332110055, 5488.121900495921, 4279.74321540707, 4283.37891005804, 4289.16361309544, 4302.48370195577, 4321.956780432187, 4215.367694845767, 4248.9575104249025, 4279.0316454430995, 4291.399204111427, 4324.156789426063, 4234.555371685975, 4246.150769846027, 4248.915021699564, 4250.2137104635585, 4263.765492897889, 4246.386373178203, 4278.122984788127, 4285.35719642053, 4315.158544083905, 4316.417283666696, 3648.8175591220333, 3837.270918525471, 3839.0978120141745, 3840.558335791392, 3846.0, 5306.336707911511, 5316.787328506855, 5328.49379308965, 5414.242006119146, 5444.836654900319, 4864.1974074277705, 4888.511148885119, 4896.143174944406, 4897.51024897511, 4907.631927605444, 5521.503064724154, 5716.571257155689, 5734.989130706413, 5763.567732420043, 5770.19217309577, 4142.544320124784, 4148.709590328678, 4162.854300099512, 4180.143070670505, 4191.161767646483, 5998.520118390562, 6007.909881351783, 6015.27816661999, 6044.005478192186, 6057.878842423171, 4178.247915375201, 4254.744715317091, 4277.657787377002, 4318.35224716295, 4330.913381732347, 4274.508431530352, 4278.219157547557, 4291.635211007037, 4302.290122129876, 4304.418903448057, 4893.363862697897, 4924.3105965164905, 4936.950630493721, 4965.3048573199785, 4996.050750357421, 5529.225908372831, 5696.344920334214, 5850.9414905851245, 5859.648421094748, 5922.555808314393, 1395.8953078519153, 1411.4424802203073, 1412.4632639596887, 1415.2994267837487, 1424.2166808255417, 932.7061975477839, 956.6412595276771, 959.9009134541051, 974.7173319737338, 983.5524836199512, 5294.788208471695, 5391.78432862689, 5405.270288511001, 5433.483819037185, 5460.235567020621, 5681.375048744635, 5690.77236910519, 5709.286339207599, 5723.513501352349, 5829.300483941955, 5181.844544663666, 5352.839414817562, 5413.267754318659, 5423.891522169613, 5468.644538105011, 3090.258337998864, 3092.922676933095, 3111.6577176510564, 3111.9533207001914, 3116.844157792101, 5739.713014349266, 5813.360530341659, 5862.882742345215, 5897.439743224387, 5901.321348044944, 5576.637518561281, 5748.885022299531, 5760.423957604206, 5805.158252053513, 5814.592978491465, 5882.411728845401, 5898.646081235054, 5906.320773111147, 5934.821955341346, 5950.738719286644, 5449.6730196188355, 5620.4660557247, 5679.046895614175, 5736.96337800075, 5745.253117094751, 5600.927656767022, 5642.689652069175, 5667.40492248308, 5668.631538949955, 5673.432656734293, 5856.560757943256, 5864.592497800582, 5898.852528686817, 5901.940980590311, 5967.492763115184, 3977.244323578511, 4216.30430978885, 4226.915461690687, 4241.109367032957, 4245.278302688489, 5875.796576283894, 5943.58394912352, 6013.428724271187, 6014.939850601613, 6019.578629495893, 5843.386444423444, 5848.561357898089, 5876.001079816356, 5892.5285977122585, 5940.257467816523, 5842.737076831638, 5851.590388672752, 5860.560457965755, 5863.912041319469, 5864.266966629171, 5617.0, 5767.7404516796005, 5776.364599893925, 5805.6226345289115, 5818.912716309174, 5875.559333049953, 5910.7931222407005, 5940.3663992402435, 5989.850253743692, 6001.519878409804, 5659.717014149359, 5731.8853622928145, 5763.596548241583, 5802.564807639359, 5850.736716847837], "value": 4369.98895345354, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [721.5057685485443, 724.3480867219502, 748.6294284329258, 816.0778320497836, 829.2371018662832, 14424.783628245572, 15051.096934183943, 15082.095074295536, 15086.3211155498, 15181.316840742165, 12453.439595218215, 12636.494540218404, 12716.36418179092, 12734.93632531836, 12740.80888786669, 759.8366351234483, 760.1941941541969, 769.3306823063942, 785.2971590426565, 792.029763539665, 796.358931060496, 802.7350974178536, 802.8474589827914, 806.3388021822108, 807.2815194476921, 831.5343407691712, 834.3533761334953, 834.7954751085992, 836.188896770135, 839.3201506779498, 829.1749709039544, 830.5099991005305, 830.6552780596045, 830.7258604660448, 834.6661335465801, 603.523216658839, 604.5073265288776, 607.398675311443, 608.3034925010837, 611.6574718157846, 14479.276036198147, 14507.202103884281, 14573.271336433136, 14575.854241457662, 14610.780838287434, 12740.362981850963, 13244.86755132446, 13541.661458463519, 13553.322333883267, 13564.796528052088, 10821.790586681109, 10947.50736216872, 10987.505562249718, 11045.171612129123, 11205.719857003558, 3409.573803274591, 3422.212891035051, 3534.575850897909, 3559.6440355964455, 3569.7501174917766, 55318.72340638271, 63608.0, 63698.36301637017, 65614.67192664054, 66491.335086649, 10044.748881278027, 10062.094411502854, 10142.543585538668, 10206.846897296546, 10529.526171322308, 19699.803001970082, 19703.0, 19715.0, 19765.110570024382, 19838.70241946372, 7668.578228197391, 7680.923190768132, 7708.190639982833, 7801.570913599693, 7952.165022672536, 4299.0, 4358.782060897006, 4414.293713005904, 4472.262076757299, 4486.416765820488, 3283.310504793972, 3340.682635149657, 3374.274530975852, 3379.645137260552, 3382.1037425082372, 575.5596968319239, 575.671867035794, 589.0839744197727, 593.1902952469848, 596.3023262782555, 641.6759536434164, 666.7628662841929, 702.6908160409404, 711.6833009310807, 724.7898109548278, 8694.434861733967, 9125.543722813965, 9140.268778497704, 9157.49633770149, 9616.23070154386, 641.6246495800009, 718.3750137380513, 722.5086940880146, 723.0, 725.677073702208, 4184.581541845791, 4380.759058251827, 4544.88637784058, 4551.271796512542, 4562.908741825145, 48684.7565762176, 48895.511044889805, 48918.75540622274, 59914.0, 78468.0, 70996.64501677458, 71123.2887671127, 72599.2740072603, 72671.0, 72671.0, 63743.68128159329, 64247.0, 65005.999999999054, 65763.67118164379, 66060.66969665121, 8418.200270974248, 8618.396712230335, 8628.39601227908, 8696.0, 8804.867926980973, 42343.5765642352, 42801.28794848171, 44162.0, 44300.0, 44505.33242001308, 39030.0, 55882.1617675727, 56509.0, 56788.0, 57731.7113414447, 10938.234323597271, 11191.104711623213, 11193.0, 11267.718307042389, 11921.642350729491, 12221.327826969602, 12469.376531173586, 12582.281644383356, 12739.363031848185, 12783.80824287655, 11420.94289528547, 11491.482883270106, 11886.739836264793, 12072.637820865388, 12422.627321180378, 11715.589954351557, 12135.211211271238, 12564.497420103093, 12565.93717031409, 12578.182418142791, 11052.778944420907, 11730.413479326171, 11743.17797754149, 11811.291322520676, 12134.514619415124, 9484.715458536255, 9700.223982081276, 9736.95131524338, 9919.851202231828, 10349.120324772479, 8586.742397728078, 8624.22794372777, 9832.262580306362, 9881.901180988098, 9952.950235248778], "value": 6709.778532704908, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1512.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 114.0, 112.0, 113.0, 114.0, 116.0, 114.0, 114.0, 115.0, 117.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 126.0, 125.0, 166.0, 127.0, 129.0, 125.0, 122.0, 160.0, 126.0], "value": 136.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 166.0, 166.0, 166.0, 163.0, 163.0, 164.0, 162.0, 163.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 75.0, 113.0, 76.0, 75.0, 75.0, 76.0, 113.0, 75.0], "value": 83.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 107.0, 83.0, 83.0, 82.0, 99.0, 82.0, 82.0, 116.0], "value": 90.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 118.0, 119.0, 118.0, 118.0, 117.0, 117.0, 119.0, 119.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 147.0, 148.0, 147.0, 149.0, 148.0, 146.0, 147.0, 147.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 85.0, 86.0, 85.0, 86.0, 86.0, 86.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 55.0, 62.0, 54.0, 54.0, 55.0, 55.0, 56.0, 54.0, 56.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 62.0, 63.0, 64.0, 62.0, 63.0, 65.0, 63.0, 64.0], "value": 63.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 84.0, 80.0, 79.0, 81.0, 79.0, 82.0, 83.0, 80.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 132.0, 141.0, 132.0, 138.0, 144.0, 143.0, 136.0, 188.0, 142.0], "value": 143.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 164.0, 164.0, 164.0, 163.0, 166.0, 164.0, 166.0, 165.0], "value": 164.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 73.0, 65.0, 66.0, 65.0, 64.0, 63.0, 68.0, 62.0, 66.0], "value": 65.7, "unit": "score"}]}]} 15:44:46 INFO - Return code: 0 15:44:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:44:46 ERROR - # TBPL SUCCESS # 15:44:46 INFO - Running post-action listener: _resource_record_post_action 15:44:46 INFO - [mozharness: 2016-11-14 23:44:46.412523Z] Finished run-tests step (success) 15:44:46 INFO - Running post-run listener: _resource_record_post_run 15:44:46 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392642560; Read time: 16; Write time: 315508 15:44:46 INFO - TinderboxPrint: CPU usage
13.5% 15:44:46 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 15:44:46 INFO - TinderboxPrint: I/O write bytes / time
392,642,560 / 315,508 15:44:46 INFO - TinderboxPrint: CPU idle
8,251.0 (86.5%) 15:44:46 INFO - TinderboxPrint: CPU user
1,224.2 (12.8%) 15:44:46 INFO - TinderboxPrint: Swap in / out
0 / 0 15:44:46 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103497728; Read time: 0; Write time: 98212 15:44:46 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 288653312; Read time: 0; Write time: 217256 15:44:47 INFO - Running post-run listener: _upload_blobber_files 15:44:47 INFO - Blob upload gear active. 15:44:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:44:47 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:44:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:44:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:44:47 INFO - (blobuploader) - INFO - Open directory for files ... 15:44:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:44:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:44:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:44:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:44:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:44:50 INFO - (blobuploader) - INFO - Done attempting. 15:44:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:44:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:44:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:44:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:44:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:44:51 INFO - (blobuploader) - INFO - Done attempting. 15:44:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:44:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:44:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:44:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:44:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:44:52 INFO - (blobuploader) - INFO - Done attempting. 15:44:52 INFO - (blobuploader) - INFO - Iteration through files over. 15:44:52 INFO - Return code: 0 15:44:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:44:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:44:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f64a057c9c2462ef55fc05af45883b3060fce1817385a8d4271cb91965299297e8d0eb518a7e2c746d2363f7bc48041130303eb0746dd8b6b8826e3e10205e8d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b4fcae17c3b1464317d00aa57bd980625cd0e19b74cb074160172354e6677ac0d231eac62e786f04bcc17bd11769d3c539b38da009c6a7e043bdd1d4a4c2488", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c2aa7334948fdc0df0e3f49850d2665e3cd5a35a2f0ea6e8b0b0dd19caf12b0516d3915613d6bb0b51373ffc834de7f873a91d064a096200bc5777ced74e14e"} 15:44:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:44:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:44:52 INFO - Contents: 15:44:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f64a057c9c2462ef55fc05af45883b3060fce1817385a8d4271cb91965299297e8d0eb518a7e2c746d2363f7bc48041130303eb0746dd8b6b8826e3e10205e8d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b4fcae17c3b1464317d00aa57bd980625cd0e19b74cb074160172354e6677ac0d231eac62e786f04bcc17bd11769d3c539b38da009c6a7e043bdd1d4a4c2488", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c2aa7334948fdc0df0e3f49850d2665e3cd5a35a2f0ea6e8b0b0dd19caf12b0516d3915613d6bb0b51373ffc834de7f873a91d064a096200bc5777ced74e14e"} 15:44:52 INFO - Running post-run listener: copy_logs_to_upload_dir 15:44:52 INFO - Copying logs to upload dir... 15:44:52 INFO - mkdir: /builds/slave/test/build/upload/logs 15:44:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.461647 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-11-14 15:44:52.207730) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 15:44:52.211000) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1479165850.240185-1080477398 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f64a057c9c2462ef55fc05af45883b3060fce1817385a8d4271cb91965299297e8d0eb518a7e2c746d2363f7bc48041130303eb0746dd8b6b8826e3e10205e8d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b4fcae17c3b1464317d00aa57bd980625cd0e19b74cb074160172354e6677ac0d231eac62e786f04bcc17bd11769d3c539b38da009c6a7e043bdd1d4a4c2488", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c2aa7334948fdc0df0e3f49850d2665e3cd5a35a2f0ea6e8b0b0dd19caf12b0516d3915613d6bb0b51373ffc834de7f873a91d064a096200bc5777ced74e14e"} build_url:https://queue.taskcluster.net/v1/task/bxcL35UDSF-iatl5HrQ20g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.012014 build_url: 'https://queue.taskcluster.net/v1/task/bxcL35UDSF-iatl5HrQ20g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f64a057c9c2462ef55fc05af45883b3060fce1817385a8d4271cb91965299297e8d0eb518a7e2c746d2363f7bc48041130303eb0746dd8b6b8826e3e10205e8d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b4fcae17c3b1464317d00aa57bd980625cd0e19b74cb074160172354e6677ac0d231eac62e786f04bcc17bd11769d3c539b38da009c6a7e043bdd1d4a4c2488", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c2aa7334948fdc0df0e3f49850d2665e3cd5a35a2f0ea6e8b0b0dd19caf12b0516d3915613d6bb0b51373ffc834de7f873a91d064a096200bc5777ced74e14e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 15:44:52.236825) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 15:44:52.237144) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1479165850.240185-1080477398 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 15:44:52.321434) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 15:44:52.321756) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 15:44:52.322041) ========= ========= Total master_lag: 0.17 =========