builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-053 starttime: 1476421937.97 results: success (0) buildid: 20161013183004 builduid: 3ece2ea886dd465a8bec2f1829d17c4c revision: a15521c1e84ffabb1cbedb6a93e494eb13c99054 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 22:12:17.966445) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 22:12:17.966977) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 22:12:17.967285) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 22:12:17.987624) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 22:12:17.988197) ========= 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=920470bf432669ad7e3a5387000001ca-1476421937.461482-800442252 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-13 22:12:18-- 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% 70.2M=0s 2016-10-13 22:12:18 (70.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.112542 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 22:12:18.120412) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 22:12:18.120795) ========= 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=920470bf432669ad7e3a5387000001ca-1476421937.461482-800442252 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021731 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 22:12:18.170771) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-13 22:12:18.171163) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev a15521c1e84ffabb1cbedb6a93e494eb13c99054 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev a15521c1e84ffabb1cbedb6a93e494eb13c99054 --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=920470bf432669ad7e3a5387000001ca-1476421937.461482-800442252 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-13 22:12:18,679 truncating revision to first 12 chars 2016-10-13 22:12:18,680 Setting DEBUG logging. 2016-10-13 22:12:18,680 attempt 1/10 2016-10-13 22:12:18,680 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/a15521c1e84f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-13 22:12:19,928 unpacking tar archive at: mozilla-inbound-a15521c1e84f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.617446 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-13 22:12:19.808883) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 22:12:19.809275) ========= script_repo_revision: a15521c1e84ffabb1cbedb6a93e494eb13c99054 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 22:12:19.809742) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 22:12:19.810039) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 22:12:19.820593) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-10-13 22:12:19.821031) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=920470bf432669ad7e3a5387000001ca-1476421937.461482-800442252 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:12:20 INFO - MultiFileLogger online at 20161013 22:12:20 in /builds/slave/test 22:12:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 22:12:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:12:20 INFO - {'append_to_log': False, 22:12:20 INFO - 'base_work_dir': '/builds/slave/test', 22:12:20 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 22:12:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:12:20 INFO - 'branch': 'Mozilla-Inbound', 22:12:20 INFO - 'buildbot_json_path': 'buildprops.json', 22:12:20 INFO - 'config_files': ('talos/linux_config.py',), 22:12:20 INFO - 'default_actions': ('clobber', 22:12:20 INFO - 'read-buildbot-config', 22:12:20 INFO - 'download-and-extract', 22:12:20 INFO - 'populate-webroot', 22:12:20 INFO - 'create-virtualenv', 22:12:20 INFO - 'install', 22:12:20 INFO - 'run-tests'), 22:12:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:12:20 INFO - 'download_minidump_stackwalk': True, 22:12:20 INFO - 'download_symbols': 'ondemand', 22:12:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:12:20 INFO - 'tooltool.py': '/tools/tooltool.py', 22:12:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:12:20 INFO - '/tools/misc-python/virtualenv.py')}, 22:12:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:12:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:12:20 INFO - 'installer_path': 'installer.exe', 22:12:20 INFO - 'log_level': 'info', 22:12:20 INFO - 'log_name': 'talos', 22:12:20 INFO - 'log_to_console': True, 22:12:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:12:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:12:20 INFO - 'opt_config_files': (), 22:12:20 INFO - 'pip_index': False, 22:12:20 INFO - 'sps_profile': False, 22:12:20 INFO - 'sps_profile_interval': 0, 22:12:20 INFO - 'suite': 'dromaeojs-e10s', 22:12:20 INFO - 'system_bits': '32', 22:12:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:12:20 INFO - 'title': 'talos-linux64-ix-053', 22:12:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:12:20 INFO - 'use_talos_json': True, 22:12:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:12:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:12:20 INFO - 'work_dir': 'build'} 22:12:20 INFO - [mozharness: 2016-10-14 05:12:20.423162Z] Running clobber step. 22:12:20 INFO - Running pre-action listener: _resource_record_pre_action 22:12:20 INFO - Running main action method: clobber 22:12:20 INFO - rmtree: /builds/slave/test/build 22:12:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:12:21 INFO - Running post-action listener: _resource_record_post_action 22:12:21 INFO - [mozharness: 2016-10-14 05:12:21.407713Z] Finished clobber step (success) 22:12:21 INFO - [mozharness: 2016-10-14 05:12:21.407813Z] Running read-buildbot-config step. 22:12:21 INFO - Running pre-action listener: _resource_record_pre_action 22:12:21 INFO - Running main action method: read_buildbot_config 22:12:21 INFO - Using buildbot properties: 22:12:21 INFO - { 22:12:21 INFO - "project": "", 22:12:21 INFO - "product": "firefox", 22:12:21 INFO - "script_repo_revision": "production", 22:12:21 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 22:12:21 INFO - "repository": "", 22:12:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 22:12:21 INFO - "buildid": "20161013183004", 22:12:21 INFO - "pgo_build": "True", 22:12:21 INFO - "basedir": "/builds/slave/test", 22:12:21 INFO - "buildnumber": 1773, 22:12:21 INFO - "slavename": "talos-linux64-ix-053", 22:12:21 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:12:21 INFO - "platform": "ubuntu64_hw", 22:12:21 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 22:12:21 INFO - "branch": "mozilla-inbound", 22:12:21 INFO - "repo_path": "integration/mozilla-inbound", 22:12:21 INFO - "revision": "a15521c1e84ffabb1cbedb6a93e494eb13c99054", 22:12:21 INFO - "stage_platform": "linux64-pgo", 22:12:21 INFO - "builduid": "3ece2ea886dd465a8bec2f1829d17c4c", 22:12:21 INFO - "slavebuilddir": "test" 22:12:21 INFO - } 22:12:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/DT0E5O3hTouYnwfMieI2wA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 22:12:21 INFO - Running post-action listener: _resource_record_post_action 22:12:21 INFO - [mozharness: 2016-10-14 05:12:21.410236Z] Finished read-buildbot-config step (success) 22:12:21 INFO - [mozharness: 2016-10-14 05:12:21.410324Z] Running download-and-extract step. 22:12:21 INFO - Running pre-action listener: _resource_record_pre_action 22:12:21 INFO - Running main action method: download_and_extract 22:12:21 INFO - mkdir: /builds/slave/test/build/tests 22:12:21 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')]} 22:12:21 INFO - trying https://queue.taskcluster.net/v1/task/DT0E5O3hTouYnwfMieI2wA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 22:12:21 INFO - Downloading https://queue.taskcluster.net/v1/task/DT0E5O3hTouYnwfMieI2wA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 22:12:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DT0E5O3hTouYnwfMieI2wA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:12:22 INFO - Downloaded 1361 bytes. 22:12:22 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 22:12:22 INFO - Using the following test package requirements: 22:12:22 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 22:12:22 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:12:22 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:12:22 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:12:22 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:12:22 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:12:22 INFO - u'jsshell-linux-x86_64.zip'], 22:12:22 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:12:22 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:12:22 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 22:12:22 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:12:22 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:12:22 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:12:22 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:12:22 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:12:22 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:12:22 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:12:22 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:12:22 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:12:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DT0E5O3hTouYnwfMieI2wA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 22:12:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DT0E5O3hTouYnwfMieI2wA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:12:22 INFO - Fetch https://queue.taskcluster.net/v1/task/DT0E5O3hTouYnwfMieI2wA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:12:22 INFO - Http code: 200 22:12:22 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 22:12:22 INFO - x-amz-cf-id: ggA1lzRx0_VtRcZuf0bRoM00-oiBCmLzEKe06fte3xCIAYS5-GeUPA== 22:12:22 INFO - x-amz-version-id: 897.OPj6zEYl73Vd3k9HKkjIIlG.kM_p 22:12:23 INFO - Expected file size: 22122168 22:12:23 INFO - Obtained file size: 22122168 22:12:27 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:12:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DT0E5O3hTouYnwfMieI2wA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 22:12:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DT0E5O3hTouYnwfMieI2wA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:12:27 INFO - Fetch https://queue.taskcluster.net/v1/task/DT0E5O3hTouYnwfMieI2wA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:12:27 INFO - Http code: 200 22:12:27 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 22:12:27 INFO - x-amz-cf-id: X0UbJDh6gB-uAgwEXz2sUe-IxvvFscw6YgCTlXFerzger6VbvTIT_w== 22:12:27 INFO - x-amz-version-id: 897.OPj6zEYl73Vd3k9HKkjIIlG.kM_p 22:12:28 INFO - Expected file size: 22122168 22:12:28 INFO - Obtained file size: 22122168 22:12:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DT0E5O3hTouYnwfMieI2wA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 22:12:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DT0E5O3hTouYnwfMieI2wA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:12:32 INFO - Fetch https://queue.taskcluster.net/v1/task/DT0E5O3hTouYnwfMieI2wA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 22:12:33 INFO - Http code: 200 22:12:33 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 22:12:33 INFO - x-amz-cf-id: gOV6ApFA7anTjWLv8UWUx7h8vldvopqu67bJYwPgvhXAGqGm0_IHwQ== 22:12:33 INFO - x-amz-version-id: Zocu9ahlGc9hxufhEQG2zZYqbc5Xnw.d 22:12:33 INFO - Expected file size: 14409006 22:12:33 INFO - Obtained file size: 14409006 22:12:33 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')]} 22:12:33 INFO - trying https://queue.taskcluster.net/v1/task/DT0E5O3hTouYnwfMieI2wA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:12:33 INFO - Downloading https://queue.taskcluster.net/v1/task/DT0E5O3hTouYnwfMieI2wA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:12:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DT0E5O3hTouYnwfMieI2wA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:12:34 INFO - Downloaded 59682981 bytes. 22:12:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DT0E5O3hTouYnwfMieI2wA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:12:34 INFO - mkdir: /builds/slave/test/properties 22:12:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:12:34 INFO - Writing to file /builds/slave/test/properties/build_url 22:12:34 INFO - Contents: 22:12:34 INFO - build_url:https://queue.taskcluster.net/v1/task/DT0E5O3hTouYnwfMieI2wA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:12:35 INFO - Running post-action listener: _resource_record_post_action 22:12:35 INFO - Running post-action listener: set_extra_try_arguments 22:12:35 INFO - [mozharness: 2016-10-14 05:12:35.373850Z] Finished download-and-extract step (success) 22:12:35 INFO - [mozharness: 2016-10-14 05:12:35.374076Z] Running populate-webroot step. 22:12:35 INFO - Running pre-action listener: _resource_record_pre_action 22:12:35 INFO - Running main action method: populate_webroot 22:12:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:12:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:12:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:12:35 INFO - '--tppagecycles', 22:12:35 INFO - '7'], 22:12:35 INFO - 'tests': ['tsvgm']}}, 22:12:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:12:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:12:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:12:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:12:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:12:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:12:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:12:35 INFO - 'talos_options': ['--disable-e10s'], 22:12:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:12:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:12:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:12:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:12:35 INFO - 'talos_options': ['--disable-e10s'], 22:12:35 INFO - 'tests': ['damp', 'tps']}, 22:12:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:12:35 INFO - 'tests': ['damp', 'tps']}, 22:12:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:12:35 INFO - 'tests': ['dromaeo_dom']}, 22:12:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:12:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:12:35 INFO - 'tests': ['basic_compositor_video']}, 22:12:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:12:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:12:35 INFO - 'tests': ['a11yr', 22:12:35 INFO - 'ts_paint', 22:12:35 INFO - 'tpaint', 22:12:35 INFO - 'sessionrestore', 22:12:35 INFO - 'sessionrestore_no_auto_restore', 22:12:35 INFO - 'tabpaint']}, 22:12:35 INFO - 'other-e10s': {'tests': ['a11yr', 22:12:35 INFO - 'ts_paint', 22:12:35 INFO - 'tpaint', 22:12:35 INFO - 'sessionrestore', 22:12:35 INFO - 'sessionrestore_no_auto_restore', 22:12:35 INFO - 'tabpaint']}, 22:12:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:12:35 INFO - 'ts_paint', 22:12:35 INFO - 'tpaint', 22:12:35 INFO - 'sessionrestore', 22:12:35 INFO - 'sessionrestore_no_auto_restore', 22:12:35 INFO - 'tabpaint']}, 22:12:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:12:35 INFO - 'ts_paint', 22:12:35 INFO - 'tpaint', 22:12:35 INFO - 'sessionrestore', 22:12:35 INFO - 'sessionrestore_no_auto_restore', 22:12:35 INFO - 'tabpaint']}, 22:12:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:12:35 INFO - 'tests': ['a11yr', 22:12:35 INFO - 'ts_paint', 22:12:35 INFO - 'tpaint', 22:12:35 INFO - 'sessionrestore', 22:12:35 INFO - 'sessionrestore_no_auto_restore', 22:12:35 INFO - 'tabpaint']}, 22:12:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:12:35 INFO - 'tests': ['a11yr', 22:12:35 INFO - 'ts_paint', 22:12:35 INFO - 'tpaint', 22:12:35 INFO - 'sessionrestore', 22:12:35 INFO - 'sessionrestore_no_auto_restore', 22:12:35 INFO - 'tabpaint']}, 22:12:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:12:35 INFO - 'tests': ['tsvgx', 22:12:35 INFO - 'tsvgr_opacity', 22:12:35 INFO - 'tart', 22:12:35 INFO - 'tscrollx', 22:12:35 INFO - 'cart']}, 22:12:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:12:35 INFO - 'tsvgr_opacity', 22:12:35 INFO - 'tart', 22:12:35 INFO - 'tscrollx', 22:12:35 INFO - 'cart']}, 22:12:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:12:35 INFO - 'talos_options': ['--disable-e10s'], 22:12:35 INFO - 'tests': ['tp5o']}, 22:12:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:12:35 INFO - 'tests': ['tp5o']}, 22:12:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:12:35 INFO - 'talos_options': ['--disable-e10s', 22:12:35 INFO - '--xperf_path', 22:12:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:12:35 INFO - 'tests': ['tp5n']}, 22:12:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:12:35 INFO - 'talos_options': ['--xperf_path', 22:12:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:12:35 INFO - 'tests': ['tp5n']}}, 22:12:35 INFO - 'talos.zip': {'path': '', 22:12:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:12:35 INFO - Running post-action listener: _resource_record_post_action 22:12:35 INFO - [mozharness: 2016-10-14 05:12:35.391822Z] Finished populate-webroot step (success) 22:12:35 INFO - [mozharness: 2016-10-14 05:12:35.391910Z] Running create-virtualenv step. 22:12:35 INFO - Running pre-action listener: _resource_record_pre_action 22:12:35 INFO - Running main action method: create_virtualenv 22:12:35 INFO - Creating virtualenv /builds/slave/test/build/venv 22:12:35 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 22:12:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:12:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:12:35 INFO - Using real prefix '/usr' 22:12:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:12:35 INFO - Installing distribute.............................................................................................................................................................................................done. 22:12:37 INFO - Installing pip.................done. 22:12:37 INFO - Return code: 0 22:12:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:12:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:12:38 INFO - Reading from file tmpfile_stdout 22:12:38 INFO - Output received: 22:12:38 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) 22:12:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:12: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')]} 22:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12: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')]} 22:12:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedd2222f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13feca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fbf60>, '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 0x13fcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fd1d0>, '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': '920470bf432669ad7e3a5387000001ca-1476421937.461482-800442252', '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 22:12: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', 'pip>=1.5'] in /builds/slave/test/build 22:12: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 pip>=1.5 22:12:38 INFO - Using env: {'DISPLAY': ':0', 22:12:38 INFO - 'HOME': '/home/cltbld', 22:12:38 INFO - 'LANG': 'en_US.UTF-8', 22:12:38 INFO - 'LANGUAGE': 'en_US:en', 22:12:38 INFO - 'LOGNAME': 'cltbld', 22:12:38 INFO - 'MAIL': '/var/mail/cltbld', 22:12:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:38 INFO - 'MOZ_NO_REMOTE': '1', 22:12:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:38 INFO - 'NO_EM_RESTART': '1', 22:12:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:12:38 INFO - 'PWD': '/builds/slave/test', 22:12:38 INFO - 'SHELL': '/bin/bash', 22:12:38 INFO - 'SHLVL': '1', 22:12:38 INFO - 'TERM': 'linux', 22:12:38 INFO - 'TMOUT': '86400', 22:12:38 INFO - 'USER': 'cltbld', 22:12:38 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1476421937.461482-800442252', 22:12:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:38 INFO - '_': '/tools/buildbot/bin/python'} 22:12:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:38 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 22:12:38 INFO - Cleaning up... 22:12:38 INFO - Return code: 0 22:12:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:12: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')]} 22:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12: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')]} 22:12:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12: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', '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 0x7fedd2222f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13feca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fbf60>, '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 0x13fcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fd1d0>, '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': '920470bf432669ad7e3a5387000001ca-1476421937.461482-800442252', '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 22:12: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', 'psutil>=3.1.1'] in /builds/slave/test/build 22:12: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 psutil>=3.1.1 22:12:38 INFO - Using env: {'DISPLAY': ':0', 22:12:38 INFO - 'HOME': '/home/cltbld', 22:12:38 INFO - 'LANG': 'en_US.UTF-8', 22:12:38 INFO - 'LANGUAGE': 'en_US:en', 22:12:38 INFO - 'LOGNAME': 'cltbld', 22:12:38 INFO - 'MAIL': '/var/mail/cltbld', 22:12:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:38 INFO - 'MOZ_NO_REMOTE': '1', 22:12:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:38 INFO - 'NO_EM_RESTART': '1', 22:12:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:12:38 INFO - 'PWD': '/builds/slave/test', 22:12:38 INFO - 'SHELL': '/bin/bash', 22:12:38 INFO - 'SHLVL': '1', 22:12:38 INFO - 'TERM': 'linux', 22:12:38 INFO - 'TMOUT': '86400', 22:12:38 INFO - 'USER': 'cltbld', 22:12:38 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1476421937.461482-800442252', 22:12:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:38 INFO - '_': '/tools/buildbot/bin/python'} 22:12:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:38 INFO - Downloading/unpacking psutil>=3.1.1 22:12: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 22:12: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 22:12: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 22:12: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 22:12: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 22:12: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 22:12:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:12:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:12:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:12:40 INFO - Installing collected packages: psutil 22:12:40 INFO - Running setup.py install for psutil 22:12:40 INFO - building 'psutil._psutil_linux' extension 22:12:40 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 22:12:40 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 22:12:40 INFO - building 'psutil._psutil_posix' extension 22:12:40 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 22:12:41 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 22:12:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:12:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:12:41 INFO - Successfully installed psutil 22:12:41 INFO - Cleaning up... 22:12:41 INFO - Return code: 0 22:12:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:12: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')]} 22:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12: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')]} 22:12:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:41 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 0x7fedd2222f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13feca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fbf60>, '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 0x13fcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fd1d0>, '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': '920470bf432669ad7e3a5387000001ca-1476421937.461482-800442252', '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 22:12:41 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 22:12:41 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 22:12:41 INFO - Using env: {'DISPLAY': ':0', 22:12:41 INFO - 'HOME': '/home/cltbld', 22:12:41 INFO - 'LANG': 'en_US.UTF-8', 22:12:41 INFO - 'LANGUAGE': 'en_US:en', 22:12:41 INFO - 'LOGNAME': 'cltbld', 22:12:41 INFO - 'MAIL': '/var/mail/cltbld', 22:12:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:41 INFO - 'MOZ_NO_REMOTE': '1', 22:12:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:41 INFO - 'NO_EM_RESTART': '1', 22:12:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:12:41 INFO - 'PWD': '/builds/slave/test', 22:12:41 INFO - 'SHELL': '/bin/bash', 22:12:41 INFO - 'SHLVL': '1', 22:12:41 INFO - 'TERM': 'linux', 22:12:41 INFO - 'TMOUT': '86400', 22:12:41 INFO - 'USER': 'cltbld', 22:12:41 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1476421937.461482-800442252', 22:12:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:41 INFO - '_': '/tools/buildbot/bin/python'} 22:12:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:12:41 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 22:12:41 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 22:12:41 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 22:12:41 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 22:12:41 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 22:12:41 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 22:12:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:12:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:12:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:12:43 INFO - Installing collected packages: mozsystemmonitor 22:12:43 INFO - Running setup.py install for mozsystemmonitor 22:12:43 INFO - Successfully installed mozsystemmonitor 22:12:43 INFO - Cleaning up... 22:12:43 INFO - Return code: 0 22:12:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:12:43 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')]} 22:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:43 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')]} 22:12:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:43 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 0x7fedd2222f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13feca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fbf60>, '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 0x13fcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fd1d0>, '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': '920470bf432669ad7e3a5387000001ca-1476421937.461482-800442252', '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 22:12:43 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 22:12:43 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 22:12:43 INFO - Using env: {'DISPLAY': ':0', 22:12:43 INFO - 'HOME': '/home/cltbld', 22:12:43 INFO - 'LANG': 'en_US.UTF-8', 22:12:43 INFO - 'LANGUAGE': 'en_US:en', 22:12:43 INFO - 'LOGNAME': 'cltbld', 22:12:43 INFO - 'MAIL': '/var/mail/cltbld', 22:12:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:43 INFO - 'MOZ_NO_REMOTE': '1', 22:12:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:43 INFO - 'NO_EM_RESTART': '1', 22:12:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:12:43 INFO - 'PWD': '/builds/slave/test', 22:12:43 INFO - 'SHELL': '/bin/bash', 22:12:43 INFO - 'SHLVL': '1', 22:12:43 INFO - 'TERM': 'linux', 22:12:43 INFO - 'TMOUT': '86400', 22:12:43 INFO - 'USER': 'cltbld', 22:12:43 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1476421937.461482-800442252', 22:12:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:43 INFO - '_': '/tools/buildbot/bin/python'} 22:12:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:43 INFO - Downloading/unpacking jsonschema==2.5.1 22:12:43 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 22:12:43 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 22:12:43 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 22:12:43 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 22:12:43 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 22:12:43 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 22:12:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:12:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:12:45 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 22:12:45 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 22:12:45 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 22:12:45 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 22:12:45 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 22:12:45 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 22:12:45 INFO - Downloading functools32-3.2.3-2.tar.gz 22:12:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:12:45 INFO - warning: no files found matching '*.txt' 22:12:45 INFO - no previously-included directories found matching 'build' 22:12:45 INFO - no previously-included directories found matching 'dist' 22:12:45 INFO - no previously-included directories found matching '.git*' 22:12:45 INFO - Installing collected packages: jsonschema, functools32 22:12:46 INFO - Running setup.py install for functools32 22:12:46 INFO - warning: no files found matching '*.txt' 22:12:46 INFO - no previously-included directories found matching 'build' 22:12:46 INFO - no previously-included directories found matching 'dist' 22:12:46 INFO - no previously-included directories found matching '.git*' 22:12:46 INFO - Successfully installed jsonschema functools32 22:12:46 INFO - Cleaning up... 22:12:46 INFO - Return code: 0 22:12:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:12:46 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')]} 22:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:46 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')]} 22:12:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:46 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 0x7fedd2222f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13feca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fbf60>, '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 0x13fcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fd1d0>, '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': '920470bf432669ad7e3a5387000001ca-1476421937.461482-800442252', '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 22:12:46 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 22:12:46 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 22:12:46 INFO - Using env: {'DISPLAY': ':0', 22:12:46 INFO - 'HOME': '/home/cltbld', 22:12:46 INFO - 'LANG': 'en_US.UTF-8', 22:12:46 INFO - 'LANGUAGE': 'en_US:en', 22:12:46 INFO - 'LOGNAME': 'cltbld', 22:12:46 INFO - 'MAIL': '/var/mail/cltbld', 22:12:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:46 INFO - 'MOZ_NO_REMOTE': '1', 22:12:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:46 INFO - 'NO_EM_RESTART': '1', 22:12:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:12:46 INFO - 'PWD': '/builds/slave/test', 22:12:46 INFO - 'SHELL': '/bin/bash', 22:12:46 INFO - 'SHLVL': '1', 22:12:46 INFO - 'TERM': 'linux', 22:12:46 INFO - 'TMOUT': '86400', 22:12:46 INFO - 'USER': 'cltbld', 22:12:46 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1476421937.461482-800442252', 22:12:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:46 INFO - '_': '/tools/buildbot/bin/python'} 22:12:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:12:46 INFO - Cleaning up... 22:12:46 INFO - Return code: 0 22:12:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:12:46 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')]} 22:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:46 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')]} 22:12:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:46 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 0x7fedd2222f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13feca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fbf60>, '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 0x13fcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fd1d0>, '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': '920470bf432669ad7e3a5387000001ca-1476421937.461482-800442252', '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 22:12:46 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 22:12:46 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 22:12:46 INFO - Using env: {'DISPLAY': ':0', 22:12:46 INFO - 'HOME': '/home/cltbld', 22:12:46 INFO - 'LANG': 'en_US.UTF-8', 22:12:46 INFO - 'LANGUAGE': 'en_US:en', 22:12:46 INFO - 'LOGNAME': 'cltbld', 22:12:46 INFO - 'MAIL': '/var/mail/cltbld', 22:12:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:46 INFO - 'MOZ_NO_REMOTE': '1', 22:12:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:46 INFO - 'NO_EM_RESTART': '1', 22:12:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:12:46 INFO - 'PWD': '/builds/slave/test', 22:12:46 INFO - 'SHELL': '/bin/bash', 22:12:46 INFO - 'SHLVL': '1', 22:12:46 INFO - 'TERM': 'linux', 22:12:46 INFO - 'TMOUT': '86400', 22:12:46 INFO - 'USER': 'cltbld', 22:12:46 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1476421937.461482-800442252', 22:12:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:46 INFO - '_': '/tools/buildbot/bin/python'} 22:12:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:46 INFO - Downloading/unpacking blobuploader==1.2.4 22:12: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 22:12: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 22:12: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 22:12: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 22:12: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 22:12: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 22:12:48 INFO - Downloading blobuploader-1.2.4.tar.gz 22:12:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:12:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:12:48 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 22:12:48 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 22:12:48 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 22:12:48 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 22:12:48 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 22:12:48 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 22:12:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:12:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:12:49 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 22:12:49 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 22:12:49 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 22:12:49 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 22:12:49 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 22:12:49 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 22:12:49 INFO - Downloading docopt-0.6.1.tar.gz 22:12:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:12:49 INFO - Installing collected packages: blobuploader, requests, docopt 22:12:49 INFO - Running setup.py install for blobuploader 22:12:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:12:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:12:49 INFO - Running setup.py install for requests 22:12:49 INFO - Running setup.py install for docopt 22:12:49 INFO - Successfully installed blobuploader requests docopt 22:12:49 INFO - Cleaning up... 22:12:49 INFO - Return code: 0 22:12:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:12: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')]} 22:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12: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')]} 22:12:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:49 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 0x7fedd2222f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13feca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fbf60>, '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 0x13fcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fd1d0>, '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': '920470bf432669ad7e3a5387000001ca-1476421937.461482-800442252', '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 22:12:49 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 22:12:49 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 22:12:49 INFO - Using env: {'DISPLAY': ':0', 22:12:49 INFO - 'HOME': '/home/cltbld', 22:12:49 INFO - 'LANG': 'en_US.UTF-8', 22:12:49 INFO - 'LANGUAGE': 'en_US:en', 22:12:49 INFO - 'LOGNAME': 'cltbld', 22:12:49 INFO - 'MAIL': '/var/mail/cltbld', 22:12:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:49 INFO - 'MOZ_NO_REMOTE': '1', 22:12:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:49 INFO - 'NO_EM_RESTART': '1', 22:12:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:12:49 INFO - 'PWD': '/builds/slave/test', 22:12:49 INFO - 'SHELL': '/bin/bash', 22:12:49 INFO - 'SHLVL': '1', 22:12:49 INFO - 'TERM': 'linux', 22:12:49 INFO - 'TMOUT': '86400', 22:12:49 INFO - 'USER': 'cltbld', 22:12:49 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1476421937.461482-800442252', 22:12:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:49 INFO - '_': '/tools/buildbot/bin/python'} 22:12:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:12:50 INFO - Running setup.py (path:/tmp/pip-0vxkKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:12:50 INFO - Running setup.py (path:/tmp/pip-gUuPqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:12:50 INFO - Running setup.py (path:/tmp/pip-7B_SrV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:12:50 INFO - Running setup.py (path:/tmp/pip-C6vlYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:12:50 INFO - Running setup.py (path:/tmp/pip-JbHsKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:12:50 INFO - Running setup.py (path:/tmp/pip-i9rUl0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:12:50 INFO - Running setup.py (path:/tmp/pip-sDo2Lw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:12:50 INFO - Running setup.py (path:/tmp/pip-h1Jw3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:12:50 INFO - Running setup.py (path:/tmp/pip-yqcmnD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:12:50 INFO - Running setup.py (path:/tmp/pip-ShRnzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:12:50 INFO - Running setup.py (path:/tmp/pip-fnSK4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:12:50 INFO - Running setup.py (path:/tmp/pip-z1RIlM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:12:51 INFO - Running setup.py (path:/tmp/pip-cJJH72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:12:51 INFO - Running setup.py (path:/tmp/pip-THcVPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:12:51 INFO - Running setup.py (path:/tmp/pip-m0HBuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:12:51 INFO - Running setup.py (path:/tmp/pip-ButOP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:12:51 INFO - Running setup.py (path:/tmp/pip-h2Z2UX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:12:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:12:51 INFO - Running setup.py install for manifestparser 22:12:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:12:51 INFO - Running setup.py install for mozcrash 22:12:51 INFO - Running setup.py install for mozdebug 22:12:51 INFO - Running setup.py install for mozdevice 22:12:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:12:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:12:51 INFO - Running setup.py install for mozfile 22:12:51 INFO - Running setup.py install for mozhttpd 22:12:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:12:51 INFO - Running setup.py install for mozinfo 22:12:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:12:52 INFO - Running setup.py install for mozInstall 22:12:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:12:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:12:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:12:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:12:52 INFO - Running setup.py install for mozleak 22:12:52 INFO - Running setup.py install for mozlog 22:12:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:12:52 INFO - Running setup.py install for moznetwork 22:12:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:12:52 INFO - Running setup.py install for mozprocess 22:12:52 INFO - Running setup.py install for mozprofile 22:12:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:12:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:12:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:12:52 INFO - Running setup.py install for mozrunner 22:12:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:12:52 INFO - Running setup.py install for mozscreenshot 22:12:52 INFO - Running setup.py install for moztest 22:12:53 INFO - Running setup.py install for mozversion 22:12:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:12:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:12:53 INFO - Cleaning up... 22:12:53 INFO - Return code: 0 22:12:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:12:53 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')]} 22:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:53 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')]} 22:12:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:53 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 0x7fedd2222f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13feca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fbf60>, '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 0x13fcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fd1d0>, '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': '920470bf432669ad7e3a5387000001ca-1476421937.461482-800442252', '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 22:12:53 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 22:12:53 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 22:12:53 INFO - Using env: {'DISPLAY': ':0', 22:12:53 INFO - 'HOME': '/home/cltbld', 22:12:53 INFO - 'LANG': 'en_US.UTF-8', 22:12:53 INFO - 'LANGUAGE': 'en_US:en', 22:12:53 INFO - 'LOGNAME': 'cltbld', 22:12:53 INFO - 'MAIL': '/var/mail/cltbld', 22:12:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:53 INFO - 'MOZ_NO_REMOTE': '1', 22:12:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:53 INFO - 'NO_EM_RESTART': '1', 22:12:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:12:53 INFO - 'PWD': '/builds/slave/test', 22:12:53 INFO - 'SHELL': '/bin/bash', 22:12:53 INFO - 'SHLVL': '1', 22:12:53 INFO - 'TERM': 'linux', 22:12:53 INFO - 'TMOUT': '86400', 22:12:53 INFO - 'USER': 'cltbld', 22:12:53 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1476421937.461482-800442252', 22:12:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:53 INFO - '_': '/tools/buildbot/bin/python'} 22:12:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:12:53 INFO - Running setup.py (path:/tmp/pip-QTgFSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:12:53 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)) 22:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:12:53 INFO - Running setup.py (path:/tmp/pip-MRiIRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:12:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 22:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:12:53 INFO - Running setup.py (path:/tmp/pip-b61Emz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:12:53 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)) 22:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:12:53 INFO - Running setup.py (path:/tmp/pip-Gm4WFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:12:53 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)) 22:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:12:53 INFO - Running setup.py (path:/tmp/pip-1mXxea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:12:53 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)) 22:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:12:53 INFO - Running setup.py (path:/tmp/pip-HuAt7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:12:53 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)) 22:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:12:53 INFO - Running setup.py (path:/tmp/pip-JQc3dV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:12:53 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)) 22:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:12:53 INFO - Running setup.py (path:/tmp/pip-AuXmtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:12:54 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)) 22:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:12:54 INFO - Running setup.py (path:/tmp/pip-rbl00k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:12:54 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)) 22:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:12:54 INFO - Running setup.py (path:/tmp/pip-zpDaBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:12:54 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)) 22:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:12:54 INFO - Running setup.py (path:/tmp/pip-j5e3rp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:12:54 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)) 22:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:12:54 INFO - Running setup.py (path:/tmp/pip-Rra0mM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:12:54 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)) 22:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:12:54 INFO - Running setup.py (path:/tmp/pip-OR8Hj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:12:54 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)) 22:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:12:54 INFO - Running setup.py (path:/tmp/pip-E_0Zr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:12:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 22:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:12:54 INFO - Running setup.py (path:/tmp/pip-MWt9VU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:12:54 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)) 22:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:12:54 INFO - Running setup.py (path:/tmp/pip-BLAIP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:12:54 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)) 22:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:12:54 INFO - Running setup.py (path:/tmp/pip-Z5qfHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:12:54 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)) 22:12:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:12:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:12:54 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)) 22:12:54 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)) 22:12:54 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)) 22:12:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:12:54 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 22:12:54 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 22:12:54 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 22:12:54 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 22:12:54 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 22:12:54 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 22:12:56 INFO - Downloading blessings-1.6.tar.gz 22:12:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:12:56 INFO - Installing collected packages: blessings 22:12:56 INFO - Running setup.py install for blessings 22:12:56 INFO - Successfully installed blessings 22:12:56 INFO - Cleaning up... 22:12:56 INFO - Return code: 0 22:12:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:12:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:12:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:12:57 INFO - Reading from file tmpfile_stdout 22:12:57 INFO - Current package versions: 22:12:57 INFO - argparse == 1.2.1 22:12:57 INFO - blessings == 1.6 22:12:57 INFO - blobuploader == 1.2.4 22:12:57 INFO - docopt == 0.6.1 22:12:57 INFO - functools32 == 3.2.3-2 22:12:57 INFO - jsonschema == 2.5.1 22:12:57 INFO - manifestparser == 1.1 22:12:57 INFO - mozInstall == 1.12 22:12:57 INFO - mozcrash == 0.17 22:12:57 INFO - mozdebug == 0.1 22:12:57 INFO - mozdevice == 0.48 22:12:57 INFO - mozfile == 1.2 22:12:57 INFO - mozhttpd == 0.7 22:12:57 INFO - mozinfo == 0.9 22:12:57 INFO - mozleak == 0.1 22:12:57 INFO - mozlog == 3.4 22:12:57 INFO - moznetwork == 0.27 22:12:57 INFO - mozprocess == 0.23 22:12:57 INFO - mozprofile == 0.28 22:12:57 INFO - mozrunner == 6.12 22:12:57 INFO - mozscreenshot == 0.1 22:12:57 INFO - mozsystemmonitor == 0.3 22:12:57 INFO - moztest == 0.7 22:12:57 INFO - mozversion == 1.4 22:12:57 INFO - psutil == 3.1.1 22:12:57 INFO - requests == 1.2.3 22:12:57 INFO - wsgiref == 0.1.2 22:12:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:12:57 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')]} 22:12:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:57 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')]} 22:12:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:57 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 0x7fedd2222f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13feca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fbf60>, '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 0x13fcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fd1d0>, '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': '920470bf432669ad7e3a5387000001ca-1476421937.461482-800442252', '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 22:12:57 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 22:12:57 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 22:12:57 INFO - Using env: {'DISPLAY': ':0', 22:12:57 INFO - 'HOME': '/home/cltbld', 22:12:57 INFO - 'LANG': 'en_US.UTF-8', 22:12:57 INFO - 'LANGUAGE': 'en_US:en', 22:12:57 INFO - 'LOGNAME': 'cltbld', 22:12:57 INFO - 'MAIL': '/var/mail/cltbld', 22:12:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:57 INFO - 'MOZ_NO_REMOTE': '1', 22:12:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:57 INFO - 'NO_EM_RESTART': '1', 22:12:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:12:57 INFO - 'PWD': '/builds/slave/test', 22:12:57 INFO - 'SHELL': '/bin/bash', 22:12:57 INFO - 'SHLVL': '1', 22:12:57 INFO - 'TERM': 'linux', 22:12:57 INFO - 'TMOUT': '86400', 22:12:57 INFO - 'USER': 'cltbld', 22:12:57 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1476421937.461482-800442252', 22:12:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:57 INFO - '_': '/tools/buildbot/bin/python'} 22:12:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:57 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)) 22:12:57 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)) 22:12:57 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)) 22:12:57 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)) 22:12:57 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)) 22:12:57 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)) 22:12:57 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)) 22:12:57 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)) 22:12:57 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)) 22:12:57 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)) 22:12:57 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)) 22:12:57 INFO - Cleaning up... 22:12:57 INFO - Return code: 0 22:12:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:12:57 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')]} 22:12:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:57 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')]} 22:12:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:57 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 0x7fedd2222f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13feca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fbf60>, '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 0x13fcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fd1d0>, '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': '920470bf432669ad7e3a5387000001ca-1476421937.461482-800442252', '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 22:12:57 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 22:12:57 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 22:12:57 INFO - Using env: {'DISPLAY': ':0', 22:12:57 INFO - 'HOME': '/home/cltbld', 22:12:57 INFO - 'LANG': 'en_US.UTF-8', 22:12:57 INFO - 'LANGUAGE': 'en_US:en', 22:12:57 INFO - 'LOGNAME': 'cltbld', 22:12:57 INFO - 'MAIL': '/var/mail/cltbld', 22:12:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:57 INFO - 'MOZ_NO_REMOTE': '1', 22:12:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:57 INFO - 'NO_EM_RESTART': '1', 22:12:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:12:57 INFO - 'PWD': '/builds/slave/test', 22:12:57 INFO - 'SHELL': '/bin/bash', 22:12:57 INFO - 'SHLVL': '1', 22:12:57 INFO - 'TERM': 'linux', 22:12:57 INFO - 'TMOUT': '86400', 22:12:57 INFO - 'USER': 'cltbld', 22:12:57 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1476421937.461482-800442252', 22:12:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:57 INFO - '_': '/tools/buildbot/bin/python'} 22:12:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:12:57 INFO - Cleaning up... 22:12:57 INFO - Return code: 0 22:12:57 INFO - Running post-action listener: _resource_record_post_action 22:12:57 INFO - Running post-action listener: _start_resource_monitoring 22:12:57 INFO - Starting resource monitoring. 22:12:57 INFO - [mozharness: 2016-10-14 05:12:57.536091Z] Finished create-virtualenv step (success) 22:12:57 INFO - [mozharness: 2016-10-14 05:12:57.536605Z] Running install step. 22:12:57 INFO - Running pre-action listener: _resource_record_pre_action 22:12:57 INFO - Running main action method: install 22:12:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:12:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:12:57 INFO - Reading from file tmpfile_stdout 22:12:57 INFO - Detecting whether we're running mozinstall >=1.0... 22:12:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:12:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:12:57 INFO - Reading from file tmpfile_stdout 22:12:57 INFO - Output received: 22:12:57 INFO - Usage: mozinstall [options] installer 22:12:57 INFO - Options: 22:12:57 INFO - -h, --help show this help message and exit 22:12:57 INFO - -d DEST, --destination=DEST 22:12:57 INFO - Directory to install application into. [default: 22:12:57 INFO - "/builds/slave/test"] 22:12:57 INFO - --app=APP Application being installed. [default: firefox] 22:12:57 INFO - mkdir: /builds/slave/test/build/application 22:12:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:12:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:13:15 INFO - Reading from file tmpfile_stdout 22:13:15 INFO - Output received: 22:13:15 INFO - /builds/slave/test/build/application/firefox/firefox 22:13:15 INFO - Running post-action listener: _resource_record_post_action 22:13:15 INFO - [mozharness: 2016-10-14 05:13:15.466810Z] Finished install step (success) 22:13:15 INFO - [mozharness: 2016-10-14 05:13:15.467054Z] Running run-tests step. 22:13:15 INFO - Running pre-action listener: _resource_record_pre_action 22:13:15 INFO - Running main action method: run_tests 22:13:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:13:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:13:15 INFO - Python 2.7.3 22:13:15 INFO - Return code: 0 22:13:15 INFO - grabbing minidump binary from tooltool 22:13:15 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')]} 22:13:15 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 0x13fbf60>, '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 0x13fcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fd1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:13:15 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 22:13:15 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 22:13:15 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 22:13:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:13:15 INFO - Return code: 0 22:13:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:13:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:13:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:13:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:13:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:13:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DT0E5O3hTouYnwfMieI2wA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 22:13:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DT0E5O3hTouYnwfMieI2wA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --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 22:13:15 INFO - Using env: {'DISPLAY': ':0', 22:13:15 INFO - 'HOME': '/home/cltbld', 22:13:15 INFO - 'LANG': 'en_US.UTF-8', 22:13:15 INFO - 'LANGUAGE': 'en_US:en', 22:13:15 INFO - 'LOGNAME': 'cltbld', 22:13:15 INFO - 'MAIL': '/var/mail/cltbld', 22:13:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:13:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:13:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:15 INFO - 'MOZ_NO_REMOTE': '1', 22:13:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:13:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:15 INFO - 'NO_EM_RESTART': '1', 22:13:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:15 INFO - 'PWD': '/builds/slave/test', 22:13:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:13:15 INFO - 'SHELL': '/bin/bash', 22:13:15 INFO - 'SHLVL': '1', 22:13:15 INFO - 'TERM': 'linux', 22:13:15 INFO - 'TMOUT': '86400', 22:13:15 INFO - 'USER': 'cltbld', 22:13:15 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1476421937.461482-800442252', 22:13:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:15 INFO - '_': '/tools/buildbot/bin/python'} 22:13:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DT0E5O3hTouYnwfMieI2wA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 22:13:15 INFO - mozversion application_buildid: 20161013183004 22:13:15 INFO - mozversion application_changeset: a15521c1e84ffabb1cbedb6a93e494eb13c99054 22:13:15 INFO - mozversion application_display_name: Nightly 22:13:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:13:15 INFO - mozversion application_name: Firefox 22:13:15 INFO - mozversion application_remotingname: firefox 22:13:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:13:15 INFO - mozversion application_vendor: Mozilla 22:13:15 INFO - mozversion application_version: 52.0a1 22:13:15 INFO - mozversion platform_buildid: 20161013183004 22:13:15 INFO - mozversion platform_changeset: a15521c1e84ffabb1cbedb6a93e494eb13c99054 22:13:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:13:15 INFO - mozversion platform_version: 52.0a1 22:13:15 INFO - using testdate: 1476421995 22:13:15 INFO - actual date: 1476421995 22:13:15 INFO - starting webserver on 'localhost:33023' 22:13:15 INFO - SUITE-START | Running 2 tests 22:13:15 INFO - TEST-START | dromaeo_css 22:13:15 INFO - operating with platform_type : linux_ 22:13:15 INFO - Initialising browser for dromaeo_css test... 22:13:15 INFO - TEST-INFO | started process 4419 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnb9N3Y/profile http://localhost:33023/getInfo.html) 22:13:20 INFO - PROCESS | 4419 | __metrics Screen width/height:1600/1200 22:13:20 INFO - PROCESS | 4419 | colorDepth:24 22:13:20 INFO - PROCESS | 4419 | Browser inner width/height: 1024/697 22:13:20 INFO - PROCESS | 4419 | __metrics 22:13:20 ERROR - PROCESS | 4419 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 22:13:21 INFO - TEST-INFO | 4419: exit 0 22:13:21 INFO - Browser initialized. 22:13:21 INFO - Running cycle 1/1 for dromaeo_css test... 22:13:21 INFO - TEST-INFO | started process 4545 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnb9N3Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:13:34 INFO - PROCESS | 4545 | RSS: Main: 182747136 22:13:34 INFO - PROCESS | 4545 | 22:14:23 INFO - PROCESS | 4545 | 1476422063706 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] 22:16:35 INFO - PROCESS | 4545 | Cycle 1(1): loaded http://localhost:33023/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33023/tests/dromaeo/cssquery-ext.html) 22:16:37 INFO - PROCESS | 4545 | RSS: Main: 196730880 22:16:37 INFO - PROCESS | 4545 | 22:19:39 INFO - PROCESS | 4545 | Cycle 1(1): loaded http://localhost:33023/tests/dromaeo/cssquery-ext.html (next: http://localhost:33023/tests/dromaeo/cssquery-jquery.html) 22:19:39 INFO - PROCESS | 4545 | RSS: Main: 194707456 22:19:39 INFO - PROCESS | 4545 | 22:22:41 INFO - PROCESS | 4545 | Cycle 1(1): loaded http://localhost:33023/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33023/tests/dromaeo/cssquery-mootools.html) 22:22:42 INFO - PROCESS | 4545 | RSS: Main: 196763648 22:22:42 INFO - PROCESS | 4545 | 22:25:44 INFO - PROCESS | 4545 | Cycle 1(1): loaded http://localhost:33023/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33023/tests/dromaeo/cssquery-prototype.html) 22:25:44 INFO - PROCESS | 4545 | RSS: Main: 193781760 22:25:44 INFO - PROCESS | 4545 | 22:28:47 INFO - PROCESS | 4545 | Cycle 1(1): loaded http://localhost:33023/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33023/tests/dromaeo/cssquery-yui.html) 22:28:48 INFO - PROCESS | 4545 | RSS: Main: 196931584 22:28:48 INFO - PROCESS | 4545 | 22:31:50 INFO - PROCESS | 4545 | Cycle 1(1): loaded http://localhost:33023/tests/dromaeo/cssquery-yui.html (next: http://localhost:33023/tests/dromaeo/cssquery-dojo.html) 22:31:51 INFO - PROCESS | 4545 | RSS: Main: 196673536 22:31:51 INFO - PROCESS | 4545 | 22:31:51 INFO - PROCESS | 4545 | __start_tp_report 22:31:51 INFO - PROCESS | 4545 | _x_x_mozilla_page_load 22:31:51 INFO - PROCESS | 4545 | _x_x_mozilla_page_load_details 22:31:51 INFO - PROCESS | 4545 | |i|pagename|runs| 22:31:51 INFO - PROCESS | 4545 | |0;dojo.html;3006.503926852068;3015.59289495918;3016.924576885578;3047.8933237336696;3061.3112049788797;5243.711595862226;5265.157574788034;5265.289185959899;5399.19012148178;5408.621396502246;5272.288241087452;5301.787928482856;5315.229291752694;5345.278387417698;5348.117560602505;4890.608751299887;4911.950880491203;4961.107000739866;5004.174311238641;5018.899622007558;4893.657443978923;4908.190148625473;4972.505147495048;4978.054169707744;5016.172331565305;4948.505149485059;4959.132151873444;5005.399352077756;5017.698938063728;5049.798008079672;4786.569208771192;4812.1578723723205;4815.3017812417;4816.325714399987;4848.612111031144;4848.612111031144;4856.077345304381;4881.585065269456;4888.2178851383605;4944.283078953567;5292.603054770908;5335.599830012726;5338.733063346817;5356.1697936819855;5367.2485851980755;5620.353659329188;5654.067078931971;5707.200991861143;5713.457221563945;5726.255586773693;5736;5753.424657534213;5759.424057594249;5771.826845194651;5785.82642520725;5163.638545301868;5224;5364.624476286662;5401.594880383908;5420.485053919911;5751.482366587027;5774.538036957033;5792.594518383757;5817.389174136655;5894.823155305347;5575.0522411190195;5586.078297081018;5598.692071936082;5599.524040456526;5606.495415412633;5489.533389661923;5674.546036317085;5675.687837168995;5702.258706368146;5704.515116215168;5497.917531237034;5632.831015069554;5664.943350566524;5674.97162514193;5685.289338832646;5680.971595141998;5683.8010669626365;5689.288838895138;5700.743466544015;5710.800121995793;4253.404523366731;4347.087111706577;4406.4051353066925;4412.205802955499;4467.508574056917;3837.4819399381286;3860.768353898775;3875;3899.941500877489;3953.604639536081;5306.124489459273;5348.91976620351;5368.812091576776;5373.919391209135;5383.488568585978;5651.6043876928225;5668.234788303609;5677.063284558001;5698.1737648041635;5733.569982251348;5246.4753524647995;5312.654677446031;5339.946600534023;5356.91964620531;5361.946380536223;4876.8780780480065;4883.4628190898975;4893.314935908976;4933.58064564516;4937.654364194544;5885.911711324334;5901.940980590139;5905.025670764362;5909.645421274738;5945.464908158114;5513.476219759116;5517.613767036269;5594.888102237851;5689.630174038674;5690.687012214368;5807.186993820784;5824.126381042708;5826.300843898759;5837.270341207349;5857.092150716646;5517.2275881377445;5547.306586676666;5552.916706249491;5563.082091454865;5567.805126820542;5657.688827114548;5670.404607516151;5670.829875103588;5717.171010203414;5733.770649174153;5519.779208831602;5522.751476183501;5536.169574563848;5561.138023606348;5568.944310557004;5398.757055932571;5399.379071406838;5527.585431092603;5546.168074788814;5577.051901176891;5532.087205611029;5548.528375088002;5573.136163894603;5585.162225666182;5620.578456615852;5677.205191273142;5719.170720245625;5722;5732.71336433185;5738.741756621045;5301.416844147064;5340.332458442695;5508.20131080983;5514.448555144453;5554.944450555605 22:31:51 INFO - PROCESS | 4545 | |1;ext.html;538.8572351272173;582.0628787651877;582.6649676436049;582.7144699097444;597.5637784417376;42859.35710964338;44456.77771611141;44613.77693111534;47323.763381183046;47675.523244767544;44037.77981110098;44863;44871.77564112183;44907.550924490744;45003.324950125694;8603.913960860405;8908.287337013024;8921.95539022304;8941.284697224206;8943.150400711922;8786.956065219665;8867.911320886806;8878.778030549223;8914.331425143107;8920;8841.690540831072;8919.464832110094;8942.061083586228;8981.101889811032;8992.77518062047;8870.600822962982;8875.378723489359;8890.688825891095;8940.418872773249;8955.820883582292;8710;8774.341924355698;8784.472931624123;8842.46945183291;8876.334274929406;41648;41927.161456771;42088.57911420877;42217.36673949893;42344.1531169378;3482.495038219444;3576.338377400189;3617.457381392786;3728.105254738843;4018.176273863851;31208.843955780078;31351.686483135105;31455.37089258202;31527.211819704462;33022.17444563881;4292.678049146327;4411.647068234533;4504.48198457175;4545.431821022372;4616.8153273869;321535;323298;323538;323740.9999999977;324109;56355.436445635016;56418;56637.433625663216;56696.71651641715;56943.715281424156;59003.409965899795;59256.51895696754;59476.10785838216;59508.10737838936;59646.403535964084;15692.68614627701;15949.920250398674;15983.760243596354;16003.359865605245;16075.115868627337;11892.167548271711;11985;11998.520059197534;12001.819972700416;12019.098567607465;15096.471623493126;15986.60033499172;16126.11306378137;16269.837301626832;16425.26086326118;3142.591463109781;6073.908891366633;6188.4739797116845;6232.750689972441;6250.4374606285655;898.7708134425679;1021.6832781837654;1025.3079171559168;1041.7343577387717;1083.2958576924905;32170.517442238386;32224.83887580547;32262.032139035866;32285;32682;1048.5753269925692;1068.8509851909228;1129.249049382168;1158.1082566423806;1205.2647884790272;15880.285387157606;16564.420245291356;16597.253123609466;16686;16757.49727508177;484699;489723;490565;491390;491777;56873.715631421575;57223;57225.71387143121;57289;57429.71285143548;1301.3493253373313;1318.1300341774383;1342.5099838558856;1342.8438981352697;1345.5290648273026;29581.40837183201;31230.21924451907;31293.374132517678;31667.36665266728;32087.679123209404;50286;50728.49271507385;50751.746241268556;50786.49213507966;50917.49082509128;411366;413765;415430;417061;418413;26191.476170476864;27276.72723272742;27449.451010979268;27509.724902750717;27798.722012779614;43216.56783432126;43529;44036;45394.31908521309;47169.292460613804;38693.806530967166;39554.802225988686;39619.80190099031;40064.3990340151;41355.1728965425;38974;39743.403848942864;40341.1931761369;40377.39433908435;41168.1766364677;39340.803295983336;40052.599474004885;40703.1859362817;40876.79561602292;41150;33966.66033339734;36247.63752362443;36301.273974519834;36775.632243677224;36818.263634726616;27547.31131721723;27789.583156253077;27791.86104069467;28042.43915121727;28057 22:31:51 INFO - PROCESS | 4545 | |2;jquery.html;367.86389036056664;371.20191588085623;374.23469005882976;379.2471943192764;384.64036126221987;18017.909910450446;19240.51898702533;19366.709499357505;19463.90268048658;19477.318293859717;18865;18873.15070821813;18925.716114258295;19328.806711932877;19421.223151073977;5504.669719816804;5514.503694667479;5778.682172480512;5788.102844059156;5789.884202315972;5508.6970216638065;5627.437256274381;5632.577556683244;5637.887242255152;5658.292713410824;5502.9174562381395;5563.916541251884;5571.9721401392935;5574.080276754331;5586.13414920686;5411.18832175173;5610.018246806833;5617.38208797032;5621.7751289948355;5647.632903861277;4925.507449255046;4970.801167953277;4971.925421118686;4984.601231901475;5203.063448579254;13269.601911942656;13631.863681363158;18516.16677249527;21765.891170544204;22180.778192218033;2088.7389076365453;2109.8945052747454;2196.187410658051;2340.719113706349;2682;9676.500142477857;9688.806223875483;10041;10044.648437304731;10584.153267738562;1874.8593855460758;1880.6238752249606;1930.8262256396852;1951.1122439290089;1952.1410579345043;77502.22497775007;81835.5908220461;83226.58386708028;84415;84744;10965.177611679155;10988.505517251742;11155.27490713101;11426.771464570662;11522.53909843597;15254.847451525564;15262.771058434133;15268.694626107415;15312.923435382974;15368.693661038713;7839.451238413257;8004.999375078115;8005.078781092496;8231.835363292701;8290.378221633402;7650.579218143055;7735.61321933901;7879.724209652634;7911.287984081345;7930.246626570467;4517.457905051415;4658.604018658452;4705.505921878222;4720.976395118002;4781.306710527024;1884.3781552087778;1945.9416217513497;1972.3885595465451;2004.3385682724665;2008.256944930385;874.6151693254948;972.7373609125497;1007.189212683782;1010.8584798128268;1032.912202462799;19200.13599388031;19203.711944320847;19373.32193373225;19412.611747764964;19671.311504097288;986.5313975861409;1043.9321444106108;1050.495762034228;1053.203744059508;1061.368485750977;10343;10834.512446939907;10956.12351011917;10969.780604387868;10970.286931349438;420453;421225.983531564;422367;424894;429459;52202.47797522052;64662.35337646658;70886;77224;82081;961.7211008807508;1002.2332915319786;1038;1040.5629635553087;1053.9367637941596;17440.47678569645;17659;18131.184096715417;18224.908875455538;18225.81774182241;40466.39300410437;41518.58481415147;41655.16689666129;42809.35785963275;42813.143737125705;54048;55575.444245557024;56187.15719264132;56581.434185659265;56678.7166064167;5451.809186678606;7938.126806051445;8112.918870811216;8116.45787300411;8298;10914.890851091704;12478.18891772032;12643.557475488315;12881.742365152457;12946.287954162235;11547.4803633835;11658.358790266277;11815.704607384883;11878.792725964115;11880.881191187977;11328.546858125583;11562.47968841421;11730.824037639271;11828.290302581872;11931;11796.404790945979;12154.778536236403;12313.50745970187;12328;12423.62729118128;8045.517268963881;8185.345172386075;8284.851756332555;8367.916320836957;8450.535220562928;9452.291078169028;11503.309801411942;11556.017738491986;11852.940735296268;12001.099917506397 22:31:51 INFO - PROCESS | 4545 | |3;mootools.html;1446.1612264886367;1472.0063956829138;1613.1450331324395;1750.7899052113748;1755.8507526860224;7632.809179770495;7872.3308518775975;8139.348852091825;8723.738287851367;8726.30189584834;8335.58322083895;8669.133086691329;8670;8854.645814167441;8862.379633425662;2312.8727919964394;2329.7670232976734;2340.3447034830274;2340.5318936212825;2341.1454818991115;2282.3837563857746;2300.769923007703;2343.921795973854;2348.3776799148154;2351.071326825903;2270.886455677218;2301.9079236830507;2324.3259454758186;2325.279163459333;2336.684547586071;2236.0385034435185;2236.944076398087;2241.5180736141647;2246.9887650561723;2250.7749225077523;2229.6544035674497;2238.8880555972137;2244.842860999731;2251.9978609518607;2254.718160229971;8702.173293537167;8708.433951793177;8712.564371781385;8742.781430464225;8751.562421878943;5139.12634852076;5177.741112944375;5212.218167274901;5212.348456442945;5226.608004399685;3260.4620237660756;3420.640832712554;3517.384457719889;3555.5022296878456;3556.715462762973;1141.178351586856;1159.2696601141226;2157.4498502881665;2185.8579192352604;2201.6627244328647;11879.881201187964;12020.338881361522;12079.93960030203;12131.332776697367;12148;4212.726172798758;4417.469903611523;4485.618722408566;4517.81928722854;4527.977360113245;9365.719028429157;9413.48225847585;9424.104710052534;9460.90539094614;9483.952580237192;5108.897822043538;5112.130937740593;5127.282180494733;5152.948470515247;5159.638825282194;4672.602828759594;4768.3085952536685;4824.49342819006;4868.099401610642;4909.459959404463;3556.2176321209295;3725.0873535983314;3741.7193710471824;3769;3798.639129282714;1132.184826924613;1135.4890299365318;1136.2330426961769;1143.3368646185359;1148.17905197784;785.3717026378874;898.2364989758653;914.5610107148606;923.2291036984193;940.9978373032699;5695.82912512617;5695.886082278331;5866.970665146647;5890.702625975873;6049.395060494004;426.0945490831982;427.8716385084462;429.84310726584573;434.30511182109007;447.0254844439154;3911.2764138634443;3957.08986933007;3961.3067713150085;4005.7796821175116;4006.799660017046;10417.322874013165;10613.257072004886;10737.141028717684;10738.248322617343;10753.462326883624;10306.48467576633;10453.163746900229;10653.094486968539;10665.84001239982;10672.519736611872;8015.7595272141925;8028.237317454832;8034.839303213903;8055.436119471698;8064.919350806535;5595.888082238251;5725.828225153252;5800.796972105956;5807.274090738658;5977.073553599199;9674.854877176707;9704.660336888175;9707.757306067404;9724.562394692115;9729.756756081155;9737.805243895224;9876.604935802487;10131.696049118538;10135.442550659785;10190.541425635716;6597.340265973365;6783.457323414016;7137.928620713727;7400.111986561647;7496.550206987598;8289.668413263402;8445.619947102272;8459.238668519863;8461.915380846112;8489.53307568065;7354.70581176747;7631.809204769926;7634.656440460081;7649.732259370895;7678.577678227751;7385.446091543048;7486.550806951383;7546.886796698163;7561.4706970513735;7607.505512141693;6958.165020197609;7011.193712722898;7049.9647501762165;7055.61194134307;7074.787756367317;5072.771725272445;5084.466131056334;5121.8975620486635;5143.819966301162;5365.061114305059;5059.569936555434;5117.795288188431;5137.717425541631;5170.844874653766;5261.500157485033 22:31:51 INFO - PROCESS | 4545 | |4;prototype.html;301.35510008581633;309.3843251928662;321.37492576937865;326.4157158685951;327.9721223695986;5507.265211458388;5556.361018482876;5580.553555715544;5591.692456914868;5627.352854421738;5406.459354064592;5466.070767969445;5481.780728770845;5487.314085739283;5524.1989911462815;4080.5108883581065;4165.33354663254;4184.769837658928;4251.9370157460635;4266.658667306608;4249.851255206068;4256.510501292345;4260.936085958713;4261.190373828978;4274.166537525184;4224.598663126998;4246.617804397603;4263.701540892139;4268.253055715253;4293.978530107345;3974.801259937006;4169.770662613555;4211.168141858301;4217.768022758747;4288.592583704543;3675.9264814703824;3680.5399325084363;3691.6492933171307;3692.1877187018813;3701.5373078365205;5361.195820626898;5369.355677318707;5380.973095134538;5403.13549832025;5422.91865622016;4586.7477288749105;4787.257975013878;4809.711417314972;4850.151223535902;4881.414230292387;5723.799667011676;5748.741306641211;5756.7985120521;5778;5806.680632565207;4027.8791636250958;4032.919341613151;4045.8179381927885;4053.6757059435176;4058.6403554809176;5887.381824908366;5908.168467775004;5920.5263578913155;5963.582549221556;6011.669358185298;4072.3077076897;4082.387641853686;4091.4681091458515;4096.91806163881;4106.7125301228625;4138;4147.149834283965;4150.605692459211;4153.356229784388;4166.979165104155;4705.623550115983;4782.545658162469;4807.855764327076;4809.230523116355;4825.6139508839915;5767.68277744728;5780.884382312414;5791.420857914259;5805.448482394166;5812.593118481665;1438.8345340285791;1455.2360010994312;1456.6285597172653;1458.8176477940258;1467.2810322941682;867.6182479708908;907.0929070929071;925.717656114878;925.8750068740634;949.4493193947494;5406.2696739249795;5465.836024919259;5480.314960629921;5539.861503462365;5544.7227638618715;5796.971015144982;5818.218158197121;5818.330891947396;5835.562332825055;5860.443257890493;5308.946910530845;5523.6685798852195;5540.894460105214;5566.4990150886615;5571.303587051619;3150.952735708966;3154.668759780236;3157.9684203157676;3169.5245713143213;3182.3635272945503;5744.597878148489;6124.724387402489;6159.384061593894;6169.784057557964;6170.969145154335;6002.219711437485;6100.786472473442;6108;6113.266408030976;6142.692865356715;6160.168377269011;6176.8764624707255;6239.7520495901;6240.719167637377;6241.96879015602;5600;5887.499562537061;5923.555733319932;5955.464008239279;6040.818775436744;5804.622699524517;5904.232449781673;5930.377310382521;5996.280446346466;5999.250093738283;5846.532277417711;6098.237720284965;6114.144019837316;6124.846878828065;6166.1983942087245;4135.152293779708;4199.874003779892;4211.7472951623;4256.3828244904935;4263.914721705486;5885;5988.760449582142;6008.188894499187;6010.248718910137;6015.879682406415;5548.833534993957;5700;5706.343770466449;5734.856628584319;5778.335491418541;5676.829695109153;5726.312842458931;5775.978407557322;5780.653160810365;5790.768369265351;5397.27136836522;5610.877824435048;5674.829755107354;5727.6849773262875;5735.881503107021;5779.162021506942;5779.566532509994;5815.883682326415;5819.301683797971;5835.869907483822;5677.801276955287;5688.829335119953;5695.316562012585;5716.942830571641;5726.284214473191 22:31:51 INFO - PROCESS | 4545 | |5;yui.html;725.713343229424;741.8330875552999;797.2107613462674;816.3346872299074;820.8276261984983;15228.314725837336;16863;16868.40960566379;16889.408870689527;16954.576135596602;13562.660933476667;13590.25253611051;13603.931980340109;13646.522371716992;13659.521916732916;785.5169071021323;791.6833266693311;792.6274650914061;792.9207079292054;794.8092457810142;793.0404210904783;800.087899794235;800.3597122302164;805.1746959366667;808.3452403553111;846.1538461538462;851.4380508864151;852.6035393542002;853.5476197615274;853.6542700206427;845.4124383553433;845.7209120990059;846.3313981954249;846.356768855668;846.5386364431369;623.5011990407655;624.1947887225474;626.6365508005346;626.7430353555067;627.8461776864698;13800.378982945791;13886.93056534721;13890.166590004632;13902.513412030632;13922.303884805719;12871.806922896165;12954.417051232716;12980.675483112998;13327.666808329772;13706.65733356674;11116.221864469491;11283.266587671775;11368.37473938933;11661.300321980623;11679.532818687243;4169.10364271683;4208.768517731523;4315.956840431587;4320.135972805451;4320.762358070305;69196;70290;71798.64100679515;72363.27636723618;72446;11163.218574699693;11212.934771196724;11221.863354037267;11278.210525263154;11283.717907052389;19707.802921970884;19816;19916.203351866054;19968.800311996984;20125.295614653416;7820.960895195602;7957.721479748181;7966.681332746741;7978.760637180894;8242.381821363422;4579.198640237945;4608.354830323758;4615.815367385334;4737.502562230985;4871.439784424837;3348.2801197742115;3453.499242609858;3456.412409890325;3474.878379256764;3500.299940011957;619.3496828330325;623.8970569856014;628.5066223014911;639.8272466434037;648.7923864363453;524.9343832020998;609.1319869186392;638.2755572425237;639.3510586754448;644.5230529408204;8907.242884354902;9263.583138758771;9270;9764.749255188763;9960.900390996143;652.9934700653027;670.3062330487921;671.6306031682652;680.9897851532231;681.4241965539112;4387.5393083726385;4388.166248412791;4426.535213802569;4433.2648972713705;4565.246734288805;67427;67676.323236767;68413.3158668407;68587.3141268581;83429.58285208535;65937.67031164814;67874.66062669754;77462;85545;106407;74340;75539.24460755433;78400;80809.59595202105;80848.19488905666;9477.857832132662;9690.740203773465;9958.15355694774;10022.148117410103;10038.498075096362;45742;45874.311885322415;46327;47033.059338812345;47540;62534.06198906929;71029;72990;73622.7913162606;73629;12639.241645501299;12678.366081696062;12680.429380678077;12720.363981800689;13375.39810708501;14519.854801452273;14758.55724328272;14906.403743850124;15558.377664893278;15660.295286711897;13554.45908247019;13581;13692.45230190821;13785.448582056606;13993.650158745706;12612.873871261538;12724.300163491096;12850.742985140432;12856.935715321364;13329.733405331644;13215.801762973371;13389.866101338863;13678.384472698952;14213.573592792232;14255.643608909446;10421.68734937953;10480.266381353233;10826.621068262573;11194.328340299608;11498.425078746197;11319.434028298718;11483.311001339946;11542.884571154182;11633.476493557979;11648 22:31:51 INFO - PROCESS | 4545 | __end_tp_report 22:31:51 INFO - PROCESS | 4545 | __start_cc_report 22:31:51 INFO - PROCESS | 4545 | _x_x_mozilla_cycle_collect,315 22:31:51 INFO - PROCESS | 4545 | __end_cc_report 22:31:51 INFO - PROCESS | 4545 | __startTimestamp1476423111098__endTimestamp 22:31:51 INFO - PROCESS | 4545 | 22:31:51 INFO - PROCESS | 4545 | ------- Summary: start ------- 22:31:51 INFO - PROCESS | 4545 | Number of tests: 6 22:31:51 INFO - PROCESS | 4545 | 22:31:51 INFO - PROCESS | 4545 | [#0] dojo.html Cycles:165 Average:5291.52 Median:5513.48 stddev:593.19 (10.8%) stddev-sans-first:567.28 22:31:51 INFO - PROCESS | 4545 | Values: 3006.5 3015.6 3016.9 3047.9 3061.3 5243.7 5265.2 5265.3 5399.2 5408.6 5272.3 5301.8 5315.2 5345.3 5348.1 4890.6 4912.0 4961.1 5004.2 5018.9 4893.7 4908.2 4972.5 4978.1 5016.2 4948.5 4959.1 5005.4 5017.7 5049.8 4786.6 4812.2 4815.3 4816.3 4848.6 4848.6 4856.1 4881.6 4888.2 4944.3 5292.6 5335.6 5338.7 5356.2 5367.2 5620.4 5654.1 5707.2 5713.5 5726.3 5736.0 5753.4 5759.4 5771.8 5785.8 5163.6 5224.0 5364.6 5401.6 5420.5 5751.5 5774.5 5792.6 5817.4 5894.8 5575.1 5586.1 5598.7 5599.5 5606.5 5489.5 5674.5 5675.7 5702.3 5704.5 5497.9 5632.8 5664.9 5675.0 5685.3 5681.0 5683.8 5689.3 5700.7 5710.8 4253.4 4347.1 4406.4 4412.2 4467.5 3837.5 3860.8 3875.0 3899.9 3953.6 5306.1 5348.9 5368.8 5373.9 5383.5 5651.6 5668.2 5677.1 5698.2 5733.6 5246.5 5312.7 5339.9 5356.9 5361.9 4876.9 4883.5 4893.3 4933.6 4937.7 5885.9 5901.9 5905.0 5909.6 5945.5 5513.5 5517.6 5594.9 5689.6 5690.7 5807.2 5824.1 5826.3 5837.3 5857.1 5517.2 5547.3 5552.9 5563.1 5567.8 5657.7 5670.4 5670.8 5717.2 5733.8 5519.8 5522.8 5536.2 5561.1 5568.9 5398.8 5399.4 5527.6 5546.2 5577.1 5532.1 5548.5 5573.1 5585.2 5620.6 5677.2 5719.2 5722.0 5732.7 5738.7 5301.4 5340.3 5508.2 5514.4 5554.9 22:31:51 INFO - PROCESS | 4545 | 22:31:51 INFO - PROCESS | 4545 | [#1] ext.html Cycles:180 Average:57169.15 Median:227560.09 stddev:109779.37 (48.2%) stddev-sans-first:110004.99 22:31:51 INFO - PROCESS | 4545 | Values: 538.9 582.1 582.7 582.7 597.6 42859.4 44456.8 44613.8 47323.8 47675.5 44037.8 44863.0 44871.8 44907.6 45003.3 8603.9 8908.3 8922.0 8941.3 8943.2 8787.0 8867.9 8878.8 8914.3 8920.0 8841.7 8919.5 8942.1 8981.1 8992.8 8870.6 8875.4 8890.7 8940.4 8955.8 8710.0 8774.3 8784.5 8842.5 8876.3 41648.0 41927.2 42088.6 42217.4 42344.2 3482.5 3576.3 3617.5 3728.1 4018.2 31208.8 31351.7 31455.4 31527.2 33022.2 4292.7 4411.6 4504.5 4545.4 4616.8 321535.0 323298.0 323538.0 323741.0 324109.0 56355.4 56418.0 56637.4 56696.7 56943.7 59003.4 59256.5 59476.1 59508.1 59646.4 15692.7 15949.9 15983.8 16003.4 16075.1 11892.2 11985.0 11998.5 12001.8 12019.1 15096.5 15986.6 16126.1 16269.8 16425.3 3142.6 6073.9 6188.5 6232.8 6250.4 898.8 1021.7 1025.3 1041.7 1083.3 32170.5 32224.8 32262.0 32285.0 32682.0 1048.6 1068.9 1129.2 1158.1 1205.3 15880.3 16564.4 16597.3 16686.0 16757.5 484699.0 489723.0 490565.0 491390.0 491777.0 56873.7 57223.0 57225.7 57289.0 57429.7 1301.3 1318.1 1342.5 1342.8 1345.5 29581.4 31230.2 31293.4 31667.4 32087.7 50286.0 50728.5 50751.7 50786.5 50917.5 411366.0 413765.0 415430.0 417061.0 418413.0 26191.5 27276.7 27449.5 27509.7 27798.7 43216.6 43529.0 44036.0 45394.3 47169.3 38693.8 39554.8 39619.8 40064.4 41355.2 38974.0 39743.4 40341.2 40377.4 41168.2 39340.8 40052.6 40703.2 40876.8 41150.0 33966.7 36247.6 36301.3 36775.6 36818.3 27547.3 27789.6 27791.9 28042.4 28057.0 22:31:51 INFO - PROCESS | 4545 | 22:31:51 INFO - PROCESS | 4545 | [#2] jquery.html Cycles:180 Average:26292.50 Median:12260.75 stddev:69855.49 (569.7%) stddev-sans-first:70024.33 22:31:51 INFO - PROCESS | 4545 | Values: 367.9 371.2 374.2 379.2 384.6 18017.9 19240.5 19366.7 19463.9 19477.3 18865.0 18873.2 18925.7 19328.8 19421.2 5504.7 5514.5 5778.7 5788.1 5789.9 5508.7 5627.4 5632.6 5637.9 5658.3 5502.9 5563.9 5572.0 5574.1 5586.1 5411.2 5610.0 5617.4 5621.8 5647.6 4925.5 4970.8 4971.9 4984.6 5203.1 13269.6 13631.9 18516.2 21765.9 22180.8 2088.7 2109.9 2196.2 2340.7 2682.0 9676.5 9688.8 10041.0 10044.6 10584.2 1874.9 1880.6 1930.8 1951.1 1952.1 77502.2 81835.6 83226.6 84415.0 84744.0 10965.2 10988.5 11155.3 11426.8 11522.5 15254.8 15262.8 15268.7 15312.9 15368.7 7839.5 8005.0 8005.1 8231.8 8290.4 7650.6 7735.6 7879.7 7911.3 7930.2 4517.5 4658.6 4705.5 4721.0 4781.3 1884.4 1945.9 1972.4 2004.3 2008.3 874.6 972.7 1007.2 1010.9 1032.9 19200.1 19203.7 19373.3 19412.6 19671.3 986.5 1043.9 1050.5 1053.2 1061.4 10343.0 10834.5 10956.1 10969.8 10970.3 420453.0 421226.0 422367.0 424894.0 429459.0 52202.5 64662.4 70886.0 77224.0 82081.0 961.7 1002.2 1038.0 1040.6 1053.9 17440.5 17659.0 18131.2 18224.9 18225.8 40466.4 41518.6 41655.2 42809.4 42813.1 54048.0 55575.4 56187.2 56581.4 56678.7 5451.8 7938.1 8112.9 8116.5 8298.0 10914.9 12478.2 12643.6 12881.7 12946.3 11547.5 11658.4 11815.7 11878.8 11880.9 11328.5 11562.5 11730.8 11828.3 11931.0 11796.4 12154.8 12313.5 12328.0 12423.6 8045.5 8185.3 8284.9 8367.9 8450.5 9452.3 11503.3 11556.0 11852.9 12001.1 22:31:51 INFO - PROCESS | 4545 | 22:31:51 INFO - PROCESS | 4545 | [#3] mootools.html Cycles:180 Average:5657.17 Median:5096.68 stddev:3184.64 (62.5%) stddev-sans-first:3177.85 22:31:51 INFO - PROCESS | 4545 | Values: 1446.2 1472.0 1613.1 1750.8 1755.9 7632.8 7872.3 8139.3 8723.7 8726.3 8335.6 8669.1 8670.0 8854.6 8862.4 2312.9 2329.8 2340.3 2340.5 2341.1 2282.4 2300.8 2343.9 2348.4 2351.1 2270.9 2301.9 2324.3 2325.3 2336.7 2236.0 2236.9 2241.5 2247.0 2250.8 2229.7 2238.9 2244.8 2252.0 2254.7 8702.2 8708.4 8712.6 8742.8 8751.6 5139.1 5177.7 5212.2 5212.3 5226.6 3260.5 3420.6 3517.4 3555.5 3556.7 1141.2 1159.3 2157.4 2185.9 2201.7 11879.9 12020.3 12079.9 12131.3 12148.0 4212.7 4417.5 4485.6 4517.8 4528.0 9365.7 9413.5 9424.1 9460.9 9484.0 5108.9 5112.1 5127.3 5152.9 5159.6 4672.6 4768.3 4824.5 4868.1 4909.5 3556.2 3725.1 3741.7 3769.0 3798.6 1132.2 1135.5 1136.2 1143.3 1148.2 785.4 898.2 914.6 923.2 941.0 5695.8 5695.9 5867.0 5890.7 6049.4 426.1 427.9 429.8 434.3 447.0 3911.3 3957.1 3961.3 4005.8 4006.8 10417.3 10613.3 10737.1 10738.2 10753.5 10306.5 10453.2 10653.1 10665.8 10672.5 8015.8 8028.2 8034.8 8055.4 8064.9 5595.9 5725.8 5800.8 5807.3 5977.1 9674.9 9704.7 9707.8 9724.6 9729.8 9737.8 9876.6 10131.7 10135.4 10190.5 6597.3 6783.5 7137.9 7400.1 7496.6 8289.7 8445.6 8459.2 8461.9 8489.5 7354.7 7631.8 7634.7 7649.7 7678.6 7385.4 7486.6 7546.9 7561.5 7607.5 6958.2 7011.2 7050.0 7055.6 7074.8 5072.8 5084.5 5121.9 5143.8 5365.1 5059.6 5117.8 5137.7 5170.8 5261.5 22:31:51 INFO - PROCESS | 4545 | 22:31:51 INFO - PROCESS | 4545 | [#4] prototype.html Cycles:180 Average:4834.72 Median:5552.60 stddev:1448.90 (26.1%) stddev-sans-first:1412.45 22:31:51 INFO - PROCESS | 4545 | Values: 301.4 309.4 321.4 326.4 328.0 5507.3 5556.4 5580.6 5591.7 5627.4 5406.5 5466.1 5481.8 5487.3 5524.2 4080.5 4165.3 4184.8 4251.9 4266.7 4249.9 4256.5 4260.9 4261.2 4274.2 4224.6 4246.6 4263.7 4268.3 4294.0 3974.8 4169.8 4211.2 4217.8 4288.6 3675.9 3680.5 3691.6 3692.2 3701.5 5361.2 5369.4 5381.0 5403.1 5422.9 4586.7 4787.3 4809.7 4850.2 4881.4 5723.8 5748.7 5756.8 5778.0 5806.7 4027.9 4032.9 4045.8 4053.7 4058.6 5887.4 5908.2 5920.5 5963.6 6011.7 4072.3 4082.4 4091.5 4096.9 4106.7 4138.0 4147.1 4150.6 4153.4 4167.0 4705.6 4782.5 4807.9 4809.2 4825.6 5767.7 5780.9 5791.4 5805.4 5812.6 1438.8 1455.2 1456.6 1458.8 1467.3 867.6 907.1 925.7 925.9 949.4 5406.3 5465.8 5480.3 5539.9 5544.7 5797.0 5818.2 5818.3 5835.6 5860.4 5308.9 5523.7 5540.9 5566.5 5571.3 3151.0 3154.7 3158.0 3169.5 3182.4 5744.6 6124.7 6159.4 6169.8 6171.0 6002.2 6100.8 6108.0 6113.3 6142.7 6160.2 6176.9 6239.8 6240.7 6242.0 5600.0 5887.5 5923.6 5955.5 6040.8 5804.6 5904.2 5930.4 5996.3 5999.3 5846.5 6098.2 6114.1 6124.8 6166.2 4135.2 4199.9 4211.7 4256.4 4263.9 5885.0 5988.8 6008.2 6010.2 6015.9 5548.8 5700.0 5706.3 5734.9 5778.3 5676.8 5726.3 5776.0 5780.7 5790.8 5397.3 5610.9 5674.8 5727.7 5735.9 5779.2 5779.6 5815.9 5819.3 5835.9 5677.8 5688.8 5695.3 5716.9 5726.3 22:31:51 INFO - PROCESS | 4545 | 22:31:51 INFO - PROCESS | 4545 | [#5] yui.html Cycles:180 Average:18315.91 Median:25241.33 stddev:24265.67 (96.1%) stddev-sans-first:24297.80 22:31:51 INFO - PROCESS | 4545 | Values: 725.7 741.8 797.2 816.3 820.8 15228.3 16863.0 16868.4 16889.4 16954.6 13562.7 13590.3 13603.9 13646.5 13659.5 785.5 791.7 792.6 792.9 794.8 793.0 800.1 800.4 805.2 808.3 846.2 851.4 852.6 853.5 853.7 845.4 845.7 846.3 846.4 846.5 623.5 624.2 626.6 626.7 627.8 13800.4 13886.9 13890.2 13902.5 13922.3 12871.8 12954.4 12980.7 13327.7 13706.7 11116.2 11283.3 11368.4 11661.3 11679.5 4169.1 4208.8 4316.0 4320.1 4320.8 69196.0 70290.0 71798.6 72363.3 72446.0 11163.2 11212.9 11221.9 11278.2 11283.7 19707.8 19816.0 19916.2 19968.8 20125.3 7821.0 7957.7 7966.7 7978.8 8242.4 4579.2 4608.4 4615.8 4737.5 4871.4 3348.3 3453.5 3456.4 3474.9 3500.3 619.3 623.9 628.5 639.8 648.8 524.9 609.1 638.3 639.4 644.5 8907.2 9263.6 9270.0 9764.7 9960.9 653.0 670.3 671.6 681.0 681.4 4387.5 4388.2 4426.5 4433.3 4565.2 67427.0 67676.3 68413.3 68587.3 83429.6 65937.7 67874.7 77462.0 85545.0 106407.0 74340.0 75539.2 78400.0 80809.6 80848.2 9477.9 9690.7 9958.2 10022.1 10038.5 45742.0 45874.3 46327.0 47033.1 47540.0 62534.1 71029.0 72990.0 73622.8 73629.0 12639.2 12678.4 12680.4 12720.4 13375.4 14519.9 14758.6 14906.4 15558.4 15660.3 13554.5 13581.0 13692.5 13785.4 13993.7 12612.9 12724.3 12850.7 12856.9 13329.7 13215.8 13389.9 13678.4 14213.6 14255.6 10421.7 10480.3 10826.6 11194.3 11498.4 11319.4 11483.3 11542.9 11633.5 11648.0 22:31:51 INFO - PROCESS | 4545 | -------- Summary: end -------- 22:31:51 INFO - PROCESS | 4545 | 22:31:52 INFO - TEST-INFO | 4545: exit 0 22:31:52 INFO - TEST-OK | dromaeo_css | took 1116412ms 22:31:52 INFO - TEST-START | kraken 22:31:52 INFO - operating with platform_type : linux_ 22:31:52 INFO - Initialising browser for kraken test... 22:31:52 INFO - TEST-INFO | started process 4910 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiwm3MB/profile http://localhost:33023/getInfo.html) 22:31:56 INFO - PROCESS | 4910 | __metrics Screen width/height:1600/1200 22:31:56 INFO - PROCESS | 4910 | colorDepth:24 22:31:56 INFO - PROCESS | 4910 | Browser inner width/height: 1024/697 22:31:56 INFO - PROCESS | 4910 | __metrics 22:31:57 ERROR - PROCESS | 4910 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 22:31:58 INFO - TEST-INFO | 4910: exit 0 22:31:58 INFO - Browser initialized. 22:31:58 INFO - Running cycle 1/1 for kraken test... 22:31:58 INFO - TEST-INFO | started process 5030 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiwm3MB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:32:10 INFO - PROCESS | 5030 | RSS: Main: 182751232 22:32:10 INFO - PROCESS | 5030 | 22:32:13 INFO - PROCESS | 5030 | Cycle 1(1): loaded http://localhost:33023/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33023/tests/kraken/driver.html?testName=audio-beat-detection) 22:32:14 INFO - PROCESS | 5030 | RSS: Main: 196960256 22:32:14 INFO - PROCESS | 5030 | 22:32:16 INFO - PROCESS | 5030 | Cycle 1(1): loaded http://localhost:33023/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33023/tests/kraken/driver.html?testName=audio-dft) 22:32:17 INFO - PROCESS | 5030 | RSS: Main: 195190784 22:32:17 INFO - PROCESS | 5030 | 22:32:20 INFO - PROCESS | 5030 | Cycle 1(1): loaded http://localhost:33023/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33023/tests/kraken/driver.html?testName=audio-fft) 22:32:20 INFO - PROCESS | 5030 | RSS: Main: 191262720 22:32:20 INFO - PROCESS | 5030 | 22:32:23 INFO - PROCESS | 5030 | Cycle 1(1): loaded http://localhost:33023/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33023/tests/kraken/driver.html?testName=audio-oscillator) 22:32:23 INFO - PROCESS | 5030 | RSS: Main: 191647744 22:32:23 INFO - PROCESS | 5030 | 22:32:25 INFO - PROCESS | 5030 | Cycle 1(1): loaded http://localhost:33023/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33023/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:32:26 INFO - PROCESS | 5030 | RSS: Main: 192307200 22:32:26 INFO - PROCESS | 5030 | 22:32:29 INFO - PROCESS | 5030 | Cycle 1(1): loaded http://localhost:33023/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33023/tests/kraken/driver.html?testName=imaging-darkroom) 22:32:30 INFO - PROCESS | 5030 | RSS: Main: 192651264 22:32:30 INFO - PROCESS | 5030 | 22:32:33 INFO - PROCESS | 5030 | Cycle 1(1): loaded http://localhost:33023/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33023/tests/kraken/driver.html?testName=imaging-desaturate) 22:32:34 INFO - PROCESS | 5030 | RSS: Main: 192696320 22:32:34 INFO - PROCESS | 5030 | 22:32:36 INFO - PROCESS | 5030 | Cycle 1(1): loaded http://localhost:33023/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33023/tests/kraken/driver.html?testName=json-parse-financial) 22:32:37 INFO - PROCESS | 5030 | RSS: Main: 192192512 22:32:37 INFO - PROCESS | 5030 | 22:32:39 INFO - PROCESS | 5030 | Cycle 1(1): loaded http://localhost:33023/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33023/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:32:39 INFO - PROCESS | 5030 | RSS: Main: 192004096 22:32:39 INFO - PROCESS | 5030 | 22:32:41 INFO - PROCESS | 5030 | Cycle 1(1): loaded http://localhost:33023/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33023/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:32:42 INFO - PROCESS | 5030 | RSS: Main: 192159744 22:32:42 INFO - PROCESS | 5030 | 22:32:44 INFO - PROCESS | 5030 | Cycle 1(1): loaded http://localhost:33023/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33023/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:32:44 INFO - PROCESS | 5030 | RSS: Main: 192712704 22:32:44 INFO - PROCESS | 5030 | 22:32:47 INFO - PROCESS | 5030 | Cycle 1(1): loaded http://localhost:33023/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33023/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:32:48 INFO - PROCESS | 5030 | RSS: Main: 192389120 22:32:48 INFO - PROCESS | 5030 | 22:32:51 INFO - PROCESS | 5030 | Cycle 1(1): loaded http://localhost:33023/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33023/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:32:51 INFO - PROCESS | 5030 | RSS: Main: 192954368 22:32:51 INFO - PROCESS | 5030 | 22:32:53 INFO - PROCESS | 5030 | Cycle 1(1): loaded http://localhost:33023/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33023/tests/kraken/driver.html?testName=ai-astar) 22:32:53 INFO - PROCESS | 5030 | RSS: Main: 194822144 22:32:53 INFO - PROCESS | 5030 | 22:32:53 INFO - PROCESS | 5030 | __start_tp_report 22:32:53 INFO - PROCESS | 5030 | _x_x_mozilla_page_load 22:32:53 INFO - PROCESS | 5030 | _x_x_mozilla_page_load_details 22:32:53 INFO - PROCESS | 5030 | |i|pagename|runs| 22:32:53 INFO - PROCESS | 5030 | |0;ai-astar;105;111;113;113;113;113;112;112;114;114 22:32:53 INFO - PROCESS | 5030 | |1;audio-beat-detection;158;125;128;175;128;126;129;125;150;126 22:32:53 INFO - PROCESS | 5030 | |2;audio-dft;164;164;165;172;165;163;165;163;164;161 22:32:53 INFO - PROCESS | 5030 | |3;audio-fft;75;76;75;111;79;77;78;77;120;75 22:32:53 INFO - PROCESS | 5030 | |4;audio-oscillator;84;83;110;85;85;83;99;83;84;110 22:32:53 INFO - PROCESS | 5030 | |5;imaging-gaussian-blur;118;118;117;117;117;118;117;118;118;119 22:32:53 INFO - PROCESS | 5030 | |6;imaging-darkroom;147;148;148;146;147;148;148;146;148;147 22:32:53 INFO - PROCESS | 5030 | |7;imaging-desaturate;87;86;85;85;85;86;87;85;85;87 22:32:53 INFO - PROCESS | 5030 | |8;json-parse-financial;56;53;54;55;58;54;57;58;58;54 22:32:53 INFO - PROCESS | 5030 | |9;json-stringify-tinderbox;61;60;58;58;59;59;59;60;59;59 22:32:53 INFO - PROCESS | 5030 | |10;stanford-crypto-aes;81;80;80;81;79;83;81;80;80;80 22:32:53 INFO - PROCESS | 5030 | |11;stanford-crypto-ccm;148;129;141;130;131;141;131;147;170;132 22:32:53 INFO - PROCESS | 5030 | |12;stanford-crypto-pbkdf2;168;165;165;169;168;167;165;168;166;176 22:32:53 INFO - PROCESS | 5030 | |13;stanford-crypto-sha256-iterative;66;74;66;67;66;72;71;66;66;65 22:32:53 INFO - PROCESS | 5030 | __end_tp_report 22:32:53 INFO - PROCESS | 5030 | __start_cc_report 22:32:53 INFO - PROCESS | 5030 | _x_x_mozilla_cycle_collect,803 22:32:53 INFO - PROCESS | 5030 | __end_cc_report 22:32:53 INFO - PROCESS | 5030 | __startTimestamp1476423173715__endTimestamp 22:32:53 INFO - PROCESS | 5030 | 22:32:53 INFO - PROCESS | 5030 | ------- Summary: start ------- 22:32:53 INFO - PROCESS | 5030 | Number of tests: 14 22:32:53 INFO - PROCESS | 5030 | 22:32:53 INFO - PROCESS | 5030 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:2.62 (2.3%) stddev-sans-first:0.97 22:32:53 INFO - PROCESS | 5030 | Values: 105.0 111.0 113.0 113.0 113.0 113.0 112.0 112.0 114.0 114.0 22:32:53 INFO - PROCESS | 5030 | 22:32:53 INFO - PROCESS | 5030 | [#1] audio-beat-detection Cycles:10 Average:137.00 Median:128.50 stddev:17.67 (13.8%) stddev-sans-first:17.03 22:32:53 INFO - PROCESS | 5030 | Values: 158.0 125.0 128.0 175.0 128.0 126.0 129.0 125.0 150.0 126.0 22:32:53 INFO - PROCESS | 5030 | 22:32:53 INFO - PROCESS | 5030 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.50 stddev:2.88 (1.7%) stddev-sans-first:3.04 22:32:53 INFO - PROCESS | 5030 | Values: 164.0 164.0 165.0 172.0 165.0 163.0 165.0 163.0 164.0 161.0 22:32:53 INFO - PROCESS | 5030 | 22:32:53 INFO - PROCESS | 5030 | [#3] audio-fft Cycles:10 Average:84.30 Median:76.50 stddev:16.63 (21.7%) stddev-sans-first:17.30 22:32:53 INFO - PROCESS | 5030 | Values: 75.0 76.0 75.0 111.0 79.0 77.0 78.0 77.0 120.0 75.0 22:32:53 INFO - PROCESS | 5030 | 22:32:53 INFO - PROCESS | 5030 | [#4] audio-oscillator Cycles:10 Average:90.60 Median:84.00 stddev:11.29 (13.4%) stddev-sans-first:11.72 22:32:53 INFO - PROCESS | 5030 | Values: 84.0 83.0 110.0 85.0 85.0 83.0 99.0 83.0 84.0 110.0 22:32:53 INFO - PROCESS | 5030 | 22:32:53 INFO - PROCESS | 5030 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 22:32:53 INFO - PROCESS | 5030 | Values: 118.0 118.0 117.0 117.0 117.0 118.0 117.0 118.0 118.0 119.0 22:32:53 INFO - PROCESS | 5030 | 22:32:53 INFO - PROCESS | 5030 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 22:32:53 INFO - PROCESS | 5030 | Values: 147.0 148.0 148.0 146.0 147.0 148.0 148.0 146.0 148.0 147.0 22:32:53 INFO - PROCESS | 5030 | 22:32:53 INFO - PROCESS | 5030 | [#7] imaging-desaturate Cycles:10 Average:85.80 Median:86.00 stddev:0.92 (1.1%) stddev-sans-first:0.87 22:32:53 INFO - PROCESS | 5030 | Values: 87.0 86.0 85.0 85.0 85.0 86.0 87.0 85.0 85.0 87.0 22:32:53 INFO - PROCESS | 5030 | 22:32:53 INFO - PROCESS | 5030 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:56.50 stddev:1.95 (3.4%) stddev-sans-first:2.06 22:32:53 INFO - PROCESS | 5030 | Values: 56.0 53.0 54.0 55.0 58.0 54.0 57.0 58.0 58.0 54.0 22:32:53 INFO - PROCESS | 5030 | 22:32:53 INFO - PROCESS | 5030 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:59.00 stddev:0.92 (1.6%) stddev-sans-first:0.71 22:32:53 INFO - PROCESS | 5030 | Values: 61.0 60.0 58.0 58.0 59.0 59.0 59.0 60.0 59.0 59.0 22:32:53 INFO - PROCESS | 5030 | 22:32:53 INFO - PROCESS | 5030 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:80.50 stddev:1.08 (1.3%) stddev-sans-first:1.13 22:32:53 INFO - PROCESS | 5030 | Values: 81.0 80.0 80.0 81.0 79.0 83.0 81.0 80.0 80.0 80.0 22:32:53 INFO - PROCESS | 5030 | 22:32:53 INFO - PROCESS | 5030 | [#11] stanford-crypto-ccm Cycles:10 Average:140.00 Median:141.00 stddev:12.75 (9.0%) stddev-sans-first:13.19 22:32:53 INFO - PROCESS | 5030 | Values: 148.0 129.0 141.0 130.0 131.0 141.0 131.0 147.0 170.0 132.0 22:32:53 INFO - PROCESS | 5030 | 22:32:53 INFO - PROCESS | 5030 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.70 Median:168.00 stddev:3.27 (1.9%) stddev-sans-first:3.46 22:32:53 INFO - PROCESS | 5030 | Values: 168.0 165.0 165.0 169.0 168.0 167.0 165.0 168.0 166.0 176.0 22:32:53 INFO - PROCESS | 5030 | 22:32:53 INFO - PROCESS | 5030 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:66.50 stddev:3.18 (4.8%) stddev-sans-first:3.30 22:32:53 INFO - PROCESS | 5030 | Values: 66.0 74.0 66.0 67.0 66.0 72.0 71.0 66.0 66.0 65.0 22:32:53 INFO - PROCESS | 5030 | -------- Summary: end -------- 22:32:53 INFO - PROCESS | 5030 | 22:32:54 INFO - TEST-INFO | 5030: exit 0 22:32:54 INFO - TEST-OK | kraken | took 62756ms 22:32:54 INFO - SUITE-END | took 1179s 22:32:55 INFO - Completed test suite (00:19:39) 22:32:55 INFO - javascript benchmark 22:32:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7117.385206527652, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3006.503926852068, 3015.59289495918, 3016.924576885578, 3047.8933237336696, 3061.3112049788797, 5243.711595862226, 5265.157574788034, 5265.289185959899, 5399.19012148178, 5408.621396502246, 5272.288241087452, 5301.787928482856, 5315.229291752694, 5345.278387417698, 5348.117560602505, 4890.608751299887, 4911.950880491203, 4961.107000739866, 5004.174311238641, 5018.899622007558, 4893.657443978923, 4908.190148625473, 4972.505147495048, 4978.054169707744, 5016.172331565305, 4948.505149485059, 4959.132151873444, 5005.399352077756, 5017.698938063728, 5049.798008079672, 4786.569208771192, 4812.1578723723205, 4815.3017812417, 4816.325714399987, 4848.612111031144, 4848.612111031144, 4856.077345304381, 4881.585065269456, 4888.2178851383605, 4944.283078953567, 5292.603054770908, 5335.599830012726, 5338.733063346817, 5356.1697936819855, 5367.2485851980755, 5620.353659329188, 5654.067078931971, 5707.200991861143, 5713.457221563945, 5726.255586773693, 5736.0, 5753.424657534213, 5759.424057594249, 5771.826845194651, 5785.82642520725, 5163.638545301868, 5224.0, 5364.624476286662, 5401.594880383908, 5420.485053919911, 5751.482366587027, 5774.538036957033, 5792.594518383757, 5817.389174136655, 5894.823155305347, 5575.0522411190195, 5586.078297081018, 5598.692071936082, 5599.524040456526, 5606.495415412633, 5489.533389661923, 5674.546036317085, 5675.687837168995, 5702.258706368146, 5704.515116215168, 5497.917531237034, 5632.831015069554, 5664.943350566524, 5674.97162514193, 5685.289338832646, 5680.971595141998, 5683.8010669626365, 5689.288838895138, 5700.743466544015, 5710.800121995793, 4253.404523366731, 4347.087111706577, 4406.4051353066925, 4412.205802955499, 4467.508574056917, 3837.4819399381286, 3860.768353898775, 3875.0, 3899.941500877489, 3953.604639536081, 5306.124489459273, 5348.91976620351, 5368.812091576776, 5373.919391209135, 5383.488568585978, 5651.6043876928225, 5668.234788303609, 5677.063284558001, 5698.1737648041635, 5733.569982251348, 5246.4753524647995, 5312.654677446031, 5339.946600534023, 5356.91964620531, 5361.946380536223, 4876.8780780480065, 4883.4628190898975, 4893.314935908976, 4933.58064564516, 4937.654364194544, 5885.911711324334, 5901.940980590139, 5905.025670764362, 5909.645421274738, 5945.464908158114, 5513.476219759116, 5517.613767036269, 5594.888102237851, 5689.630174038674, 5690.687012214368, 5807.186993820784, 5824.126381042708, 5826.300843898759, 5837.270341207349, 5857.092150716646, 5517.2275881377445, 5547.306586676666, 5552.916706249491, 5563.082091454865, 5567.805126820542, 5657.688827114548, 5670.404607516151, 5670.829875103588, 5717.171010203414, 5733.770649174153, 5519.779208831602, 5522.751476183501, 5536.169574563848, 5561.138023606348, 5568.944310557004, 5398.757055932571, 5399.379071406838, 5527.585431092603, 5546.168074788814, 5577.051901176891, 5532.087205611029, 5548.528375088002, 5573.136163894603, 5585.162225666182, 5620.578456615852, 5677.205191273142, 5719.170720245625, 5722.0, 5732.71336433185, 5738.741756621045, 5301.416844147064, 5340.332458442695, 5508.20131080983, 5514.448555144453, 5554.944450555605], "value": 5251.322223584187, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.8572351272173, 582.0628787651877, 582.6649676436049, 582.7144699097444, 597.5637784417376, 42859.35710964338, 44456.77771611141, 44613.77693111534, 47323.763381183046, 47675.523244767544, 44037.77981110098, 44863.0, 44871.77564112183, 44907.550924490744, 45003.324950125694, 8603.913960860405, 8908.287337013024, 8921.95539022304, 8941.284697224206, 8943.150400711922, 8786.956065219665, 8867.911320886806, 8878.778030549223, 8914.331425143107, 8920.0, 8841.690540831072, 8919.464832110094, 8942.061083586228, 8981.101889811032, 8992.77518062047, 8870.600822962982, 8875.378723489359, 8890.688825891095, 8940.418872773249, 8955.820883582292, 8710.0, 8774.341924355698, 8784.472931624123, 8842.46945183291, 8876.334274929406, 41648.0, 41927.161456771, 42088.57911420877, 42217.36673949893, 42344.1531169378, 3482.495038219444, 3576.338377400189, 3617.457381392786, 3728.105254738843, 4018.176273863851, 31208.843955780078, 31351.686483135105, 31455.37089258202, 31527.211819704462, 33022.17444563881, 4292.678049146327, 4411.647068234533, 4504.48198457175, 4545.431821022372, 4616.8153273869, 321535.0, 323298.0, 323538.0, 323740.9999999977, 324109.0, 56355.436445635016, 56418.0, 56637.433625663216, 56696.71651641715, 56943.715281424156, 59003.409965899795, 59256.51895696754, 59476.10785838216, 59508.10737838936, 59646.403535964084, 15692.68614627701, 15949.920250398674, 15983.760243596354, 16003.359865605245, 16075.115868627337, 11892.167548271711, 11985.0, 11998.520059197534, 12001.819972700416, 12019.098567607465, 15096.471623493126, 15986.60033499172, 16126.11306378137, 16269.837301626832, 16425.26086326118, 3142.591463109781, 6073.908891366633, 6188.4739797116845, 6232.750689972441, 6250.4374606285655, 898.7708134425679, 1021.6832781837654, 1025.3079171559168, 1041.7343577387717, 1083.2958576924905, 32170.517442238386, 32224.83887580547, 32262.032139035866, 32285.0, 32682.0, 1048.5753269925692, 1068.8509851909228, 1129.249049382168, 1158.1082566423806, 1205.2647884790272, 15880.285387157606, 16564.420245291356, 16597.253123609466, 16686.0, 16757.49727508177, 484699.0, 489723.0, 490565.0, 491390.0, 491777.0, 56873.715631421575, 57223.0, 57225.71387143121, 57289.0, 57429.71285143548, 1301.3493253373313, 1318.1300341774383, 1342.5099838558856, 1342.8438981352697, 1345.5290648273026, 29581.40837183201, 31230.21924451907, 31293.374132517678, 31667.36665266728, 32087.679123209404, 50286.0, 50728.49271507385, 50751.746241268556, 50786.49213507966, 50917.49082509128, 411366.0, 413765.0, 415430.0, 417061.0, 418413.0, 26191.476170476864, 27276.72723272742, 27449.451010979268, 27509.724902750717, 27798.722012779614, 43216.56783432126, 43529.0, 44036.0, 45394.31908521309, 47169.292460613804, 38693.806530967166, 39554.802225988686, 39619.80190099031, 40064.3990340151, 41355.1728965425, 38974.0, 39743.403848942864, 40341.1931761369, 40377.39433908435, 41168.1766364677, 39340.803295983336, 40052.599474004885, 40703.1859362817, 40876.79561602292, 41150.0, 33966.66033339734, 36247.63752362443, 36301.273974519834, 36775.632243677224, 36818.263634726616, 27547.31131721723, 27789.583156253077, 27791.86104069467, 28042.43915121727, 28057.0], "value": 19559.54277217257, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.86389036056664, 371.20191588085623, 374.23469005882976, 379.2471943192764, 384.64036126221987, 18017.909910450446, 19240.51898702533, 19366.709499357505, 19463.90268048658, 19477.318293859717, 18865.0, 18873.15070821813, 18925.716114258295, 19328.806711932877, 19421.223151073977, 5504.669719816804, 5514.503694667479, 5778.682172480512, 5788.102844059156, 5789.884202315972, 5508.6970216638065, 5627.437256274381, 5632.577556683244, 5637.887242255152, 5658.292713410824, 5502.9174562381395, 5563.916541251884, 5571.9721401392935, 5574.080276754331, 5586.13414920686, 5411.18832175173, 5610.018246806833, 5617.38208797032, 5621.7751289948355, 5647.632903861277, 4925.507449255046, 4970.801167953277, 4971.925421118686, 4984.601231901475, 5203.063448579254, 13269.601911942656, 13631.863681363158, 18516.16677249527, 21765.891170544204, 22180.778192218033, 2088.7389076365453, 2109.8945052747454, 2196.187410658051, 2340.719113706349, 2682.0, 9676.500142477857, 9688.806223875483, 10041.0, 10044.648437304731, 10584.153267738562, 1874.8593855460758, 1880.6238752249606, 1930.8262256396852, 1951.1122439290089, 1952.1410579345043, 77502.22497775007, 81835.5908220461, 83226.58386708028, 84415.0, 84744.0, 10965.177611679155, 10988.505517251742, 11155.27490713101, 11426.771464570662, 11522.53909843597, 15254.847451525564, 15262.771058434133, 15268.694626107415, 15312.923435382974, 15368.693661038713, 7839.451238413257, 8004.999375078115, 8005.078781092496, 8231.835363292701, 8290.378221633402, 7650.579218143055, 7735.61321933901, 7879.724209652634, 7911.287984081345, 7930.246626570467, 4517.457905051415, 4658.604018658452, 4705.505921878222, 4720.976395118002, 4781.306710527024, 1884.3781552087778, 1945.9416217513497, 1972.3885595465451, 2004.3385682724665, 2008.256944930385, 874.6151693254948, 972.7373609125497, 1007.189212683782, 1010.8584798128268, 1032.912202462799, 19200.13599388031, 19203.711944320847, 19373.32193373225, 19412.611747764964, 19671.311504097288, 986.5313975861409, 1043.9321444106108, 1050.495762034228, 1053.203744059508, 1061.368485750977, 10343.0, 10834.512446939907, 10956.12351011917, 10969.780604387868, 10970.286931349438, 420453.0, 421225.983531564, 422367.0, 424894.0, 429459.0, 52202.47797522052, 64662.35337646658, 70886.0, 77224.0, 82081.0, 961.7211008807508, 1002.2332915319786, 1038.0, 1040.5629635553087, 1053.9367637941596, 17440.47678569645, 17659.0, 18131.184096715417, 18224.908875455538, 18225.81774182241, 40466.39300410437, 41518.58481415147, 41655.16689666129, 42809.35785963275, 42813.143737125705, 54048.0, 55575.444245557024, 56187.15719264132, 56581.434185659265, 56678.7166064167, 5451.809186678606, 7938.126806051445, 8112.918870811216, 8116.45787300411, 8298.0, 10914.890851091704, 12478.18891772032, 12643.557475488315, 12881.742365152457, 12946.287954162235, 11547.4803633835, 11658.358790266277, 11815.704607384883, 11878.792725964115, 11880.881191187977, 11328.546858125583, 11562.47968841421, 11730.824037639271, 11828.290302581872, 11931.0, 11796.404790945979, 12154.778536236403, 12313.50745970187, 12328.0, 12423.62729118128, 8045.517268963881, 8185.345172386075, 8284.851756332555, 8367.916320836957, 8450.535220562928, 9452.291078169028, 11503.309801411942, 11556.017738491986, 11852.940735296268, 12001.099917506397], "value": 8932.284565775924, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1446.1612264886367, 1472.0063956829138, 1613.1450331324395, 1750.7899052113748, 1755.8507526860224, 7632.809179770495, 7872.3308518775975, 8139.348852091825, 8723.738287851367, 8726.30189584834, 8335.58322083895, 8669.133086691329, 8670.0, 8854.645814167441, 8862.379633425662, 2312.8727919964394, 2329.7670232976734, 2340.3447034830274, 2340.5318936212825, 2341.1454818991115, 2282.3837563857746, 2300.769923007703, 2343.921795973854, 2348.3776799148154, 2351.071326825903, 2270.886455677218, 2301.9079236830507, 2324.3259454758186, 2325.279163459333, 2336.684547586071, 2236.0385034435185, 2236.944076398087, 2241.5180736141647, 2246.9887650561723, 2250.7749225077523, 2229.6544035674497, 2238.8880555972137, 2244.842860999731, 2251.9978609518607, 2254.718160229971, 8702.173293537167, 8708.433951793177, 8712.564371781385, 8742.781430464225, 8751.562421878943, 5139.12634852076, 5177.741112944375, 5212.218167274901, 5212.348456442945, 5226.608004399685, 3260.4620237660756, 3420.640832712554, 3517.384457719889, 3555.5022296878456, 3556.715462762973, 1141.178351586856, 1159.2696601141226, 2157.4498502881665, 2185.8579192352604, 2201.6627244328647, 11879.881201187964, 12020.338881361522, 12079.93960030203, 12131.332776697367, 12148.0, 4212.726172798758, 4417.469903611523, 4485.618722408566, 4517.81928722854, 4527.977360113245, 9365.719028429157, 9413.48225847585, 9424.104710052534, 9460.90539094614, 9483.952580237192, 5108.897822043538, 5112.130937740593, 5127.282180494733, 5152.948470515247, 5159.638825282194, 4672.602828759594, 4768.3085952536685, 4824.49342819006, 4868.099401610642, 4909.459959404463, 3556.2176321209295, 3725.0873535983314, 3741.7193710471824, 3769.0, 3798.639129282714, 1132.184826924613, 1135.4890299365318, 1136.2330426961769, 1143.3368646185359, 1148.17905197784, 785.3717026378874, 898.2364989758653, 914.5610107148606, 923.2291036984193, 940.9978373032699, 5695.82912512617, 5695.886082278331, 5866.970665146647, 5890.702625975873, 6049.395060494004, 426.0945490831982, 427.8716385084462, 429.84310726584573, 434.30511182109007, 447.0254844439154, 3911.2764138634443, 3957.08986933007, 3961.3067713150085, 4005.7796821175116, 4006.799660017046, 10417.322874013165, 10613.257072004886, 10737.141028717684, 10738.248322617343, 10753.462326883624, 10306.48467576633, 10453.163746900229, 10653.094486968539, 10665.84001239982, 10672.519736611872, 8015.7595272141925, 8028.237317454832, 8034.839303213903, 8055.436119471698, 8064.919350806535, 5595.888082238251, 5725.828225153252, 5800.796972105956, 5807.274090738658, 5977.073553599199, 9674.854877176707, 9704.660336888175, 9707.757306067404, 9724.562394692115, 9729.756756081155, 9737.805243895224, 9876.604935802487, 10131.696049118538, 10135.442550659785, 10190.541425635716, 6597.340265973365, 6783.457323414016, 7137.928620713727, 7400.111986561647, 7496.550206987598, 8289.668413263402, 8445.619947102272, 8459.238668519863, 8461.915380846112, 8489.53307568065, 7354.70581176747, 7631.809204769926, 7634.656440460081, 7649.732259370895, 7678.577678227751, 7385.446091543048, 7486.550806951383, 7546.886796698163, 7561.4706970513735, 7607.505512141693, 6958.165020197609, 7011.193712722898, 7049.9647501762165, 7055.61194134307, 7074.787756367317, 5072.771725272445, 5084.466131056334, 5121.8975620486635, 5143.819966301162, 5365.061114305059, 5059.569936555434, 5117.795288188431, 5137.717425541631, 5170.844874653766, 5261.500157485033], "value": 4491.797306249233, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.35510008581633, 309.3843251928662, 321.37492576937865, 326.4157158685951, 327.9721223695986, 5507.265211458388, 5556.361018482876, 5580.553555715544, 5591.692456914868, 5627.352854421738, 5406.459354064592, 5466.070767969445, 5481.780728770845, 5487.314085739283, 5524.1989911462815, 4080.5108883581065, 4165.33354663254, 4184.769837658928, 4251.9370157460635, 4266.658667306608, 4249.851255206068, 4256.510501292345, 4260.936085958713, 4261.190373828978, 4274.166537525184, 4224.598663126998, 4246.617804397603, 4263.701540892139, 4268.253055715253, 4293.978530107345, 3974.801259937006, 4169.770662613555, 4211.168141858301, 4217.768022758747, 4288.592583704543, 3675.9264814703824, 3680.5399325084363, 3691.6492933171307, 3692.1877187018813, 3701.5373078365205, 5361.195820626898, 5369.355677318707, 5380.973095134538, 5403.13549832025, 5422.91865622016, 4586.7477288749105, 4787.257975013878, 4809.711417314972, 4850.151223535902, 4881.414230292387, 5723.799667011676, 5748.741306641211, 5756.7985120521, 5778.0, 5806.680632565207, 4027.8791636250958, 4032.919341613151, 4045.8179381927885, 4053.6757059435176, 4058.6403554809176, 5887.381824908366, 5908.168467775004, 5920.5263578913155, 5963.582549221556, 6011.669358185298, 4072.3077076897, 4082.387641853686, 4091.4681091458515, 4096.91806163881, 4106.7125301228625, 4138.0, 4147.149834283965, 4150.605692459211, 4153.356229784388, 4166.979165104155, 4705.623550115983, 4782.545658162469, 4807.855764327076, 4809.230523116355, 4825.6139508839915, 5767.68277744728, 5780.884382312414, 5791.420857914259, 5805.448482394166, 5812.593118481665, 1438.8345340285791, 1455.2360010994312, 1456.6285597172653, 1458.8176477940258, 1467.2810322941682, 867.6182479708908, 907.0929070929071, 925.717656114878, 925.8750068740634, 949.4493193947494, 5406.2696739249795, 5465.836024919259, 5480.314960629921, 5539.861503462365, 5544.7227638618715, 5796.971015144982, 5818.218158197121, 5818.330891947396, 5835.562332825055, 5860.443257890493, 5308.946910530845, 5523.6685798852195, 5540.894460105214, 5566.4990150886615, 5571.303587051619, 3150.952735708966, 3154.668759780236, 3157.9684203157676, 3169.5245713143213, 3182.3635272945503, 5744.597878148489, 6124.724387402489, 6159.384061593894, 6169.784057557964, 6170.969145154335, 6002.219711437485, 6100.786472473442, 6108.0, 6113.266408030976, 6142.692865356715, 6160.168377269011, 6176.8764624707255, 6239.7520495901, 6240.719167637377, 6241.96879015602, 5600.0, 5887.499562537061, 5923.555733319932, 5955.464008239279, 6040.818775436744, 5804.622699524517, 5904.232449781673, 5930.377310382521, 5996.280446346466, 5999.250093738283, 5846.532277417711, 6098.237720284965, 6114.144019837316, 6124.846878828065, 6166.1983942087245, 4135.152293779708, 4199.874003779892, 4211.7472951623, 4256.3828244904935, 4263.914721705486, 5885.0, 5988.760449582142, 6008.188894499187, 6010.248718910137, 6015.879682406415, 5548.833534993957, 5700.0, 5706.343770466449, 5734.856628584319, 5778.335491418541, 5676.829695109153, 5726.312842458931, 5775.978407557322, 5780.653160810365, 5790.768369265351, 5397.27136836522, 5610.877824435048, 5674.829755107354, 5727.6849773262875, 5735.881503107021, 5779.162021506942, 5779.566532509994, 5815.883682326415, 5819.301683797971, 5835.869907483822, 5677.801276955287, 5688.829335119953, 5695.316562012585, 5716.942830571641, 5726.284214473191], "value": 4360.685348891684, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.713343229424, 741.8330875552999, 797.2107613462674, 816.3346872299074, 820.8276261984983, 15228.314725837336, 16863.0, 16868.40960566379, 16889.408870689527, 16954.576135596602, 13562.660933476667, 13590.25253611051, 13603.931980340109, 13646.522371716992, 13659.521916732916, 785.5169071021323, 791.6833266693311, 792.6274650914061, 792.9207079292054, 794.8092457810142, 793.0404210904783, 800.087899794235, 800.3597122302164, 805.1746959366667, 808.3452403553111, 846.1538461538462, 851.4380508864151, 852.6035393542002, 853.5476197615274, 853.6542700206427, 845.4124383553433, 845.7209120990059, 846.3313981954249, 846.356768855668, 846.5386364431369, 623.5011990407655, 624.1947887225474, 626.6365508005346, 626.7430353555067, 627.8461776864698, 13800.378982945791, 13886.93056534721, 13890.166590004632, 13902.513412030632, 13922.303884805719, 12871.806922896165, 12954.417051232716, 12980.675483112998, 13327.666808329772, 13706.65733356674, 11116.221864469491, 11283.266587671775, 11368.37473938933, 11661.300321980623, 11679.532818687243, 4169.10364271683, 4208.768517731523, 4315.956840431587, 4320.135972805451, 4320.762358070305, 69196.0, 70290.0, 71798.64100679515, 72363.27636723618, 72446.0, 11163.218574699693, 11212.934771196724, 11221.863354037267, 11278.210525263154, 11283.717907052389, 19707.802921970884, 19816.0, 19916.203351866054, 19968.800311996984, 20125.295614653416, 7820.960895195602, 7957.721479748181, 7966.681332746741, 7978.760637180894, 8242.381821363422, 4579.198640237945, 4608.354830323758, 4615.815367385334, 4737.502562230985, 4871.439784424837, 3348.2801197742115, 3453.499242609858, 3456.412409890325, 3474.878379256764, 3500.299940011957, 619.3496828330325, 623.8970569856014, 628.5066223014911, 639.8272466434037, 648.7923864363453, 524.9343832020998, 609.1319869186392, 638.2755572425237, 639.3510586754448, 644.5230529408204, 8907.242884354902, 9263.583138758771, 9270.0, 9764.749255188763, 9960.900390996143, 652.9934700653027, 670.3062330487921, 671.6306031682652, 680.9897851532231, 681.4241965539112, 4387.5393083726385, 4388.166248412791, 4426.535213802569, 4433.2648972713705, 4565.246734288805, 67427.0, 67676.323236767, 68413.3158668407, 68587.3141268581, 83429.58285208535, 65937.67031164814, 67874.66062669754, 77462.0, 85545.0, 106407.0, 74340.0, 75539.24460755433, 78400.0, 80809.59595202105, 80848.19488905666, 9477.857832132662, 9690.740203773465, 9958.15355694774, 10022.148117410103, 10038.498075096362, 45742.0, 45874.311885322415, 46327.0, 47033.059338812345, 47540.0, 62534.06198906929, 71029.0, 72990.0, 73622.7913162606, 73629.0, 12639.241645501299, 12678.366081696062, 12680.429380678077, 12720.363981800689, 13375.39810708501, 14519.854801452273, 14758.55724328272, 14906.403743850124, 15558.377664893278, 15660.295286711897, 13554.45908247019, 13581.0, 13692.45230190821, 13785.448582056606, 13993.650158745706, 12612.873871261538, 12724.300163491096, 12850.742985140432, 12856.935715321364, 13329.733405331644, 13215.801762973371, 13389.866101338863, 13678.384472698952, 14213.573592792232, 14255.643608909446, 10421.68734937953, 10480.266381353233, 10826.621068262573, 11194.328340299608, 11498.425078746197, 11319.434028298718, 11483.311001339946, 11542.884571154182, 11633.476493557979, 11648.0], "value": 7232.930387896889, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1510.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 111.0, 113.0, 113.0, 113.0, 113.0, 112.0, 112.0, 114.0, 114.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 125.0, 128.0, 175.0, 128.0, 126.0, 129.0, 125.0, 150.0, 126.0], "value": 137.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 165.0, 172.0, 165.0, 163.0, 165.0, 163.0, 164.0, 161.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 111.0, 79.0, 77.0, 78.0, 77.0, 120.0, 75.0], "value": 84.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 110.0, 85.0, 85.0, 83.0, 99.0, 83.0, 84.0, 110.0], "value": 90.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 119.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 146.0, 147.0, 148.0, 148.0, 146.0, 148.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 85.0, 85.0, 85.0, 86.0, 87.0, 85.0, 85.0, 87.0], "value": 85.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 54.0, 55.0, 58.0, 54.0, 57.0, 58.0, 58.0, 54.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 58.0, 58.0, 59.0, 59.0, 59.0, 60.0, 59.0, 59.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 80.0, 81.0, 79.0, 83.0, 81.0, 80.0, 80.0, 80.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 129.0, 141.0, 130.0, 131.0, 141.0, 131.0, 147.0, 170.0, 132.0], "value": 140.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 165.0, 165.0, 169.0, 168.0, 167.0, 165.0, 168.0, 166.0, 176.0], "value": 167.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 74.0, 66.0, 67.0, 66.0, 72.0, 71.0, 66.0, 66.0, 65.0], "value": 67.9, "unit": "score"}]}]} 22:32:55 INFO - Return code: 0 22:32:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:32:55 ERROR - # TBPL SUCCESS # 22:32:55 INFO - Running post-action listener: _resource_record_post_action 22:32:55 INFO - [mozharness: 2016-10-14 05:32:55.548584Z] Finished run-tests step (success) 22:32:55 INFO - Running post-run listener: _resource_record_post_run 22:32:55 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 397111296; Read time: 12; Write time: 461704 22:32:55 INFO - TinderboxPrint: CPU usage
13.4% 22:32:55 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 22:32:55 INFO - TinderboxPrint: I/O write bytes / time
397,111,296 / 461,704 22:32:55 INFO - TinderboxPrint: CPU idle
8,265.9 (86.6%) 22:32:55 INFO - TinderboxPrint: CPU user
1,215.1 (12.7%) 22:32:55 INFO - TinderboxPrint: Swap in / out
0 / 0 22:32:55 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107937792; Read time: 0; Write time: 120744 22:32:55 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289173504; Read time: 12; Write time: 340960 22:32:56 INFO - Running post-run listener: _upload_blobber_files 22:32:56 INFO - Blob upload gear active. 22:32:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:32:56 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 22:32:56 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:32:56 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:32:56 INFO - (blobuploader) - INFO - Open directory for files ... 22:32:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:32:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:32:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:32:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:32:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:32:57 INFO - (blobuploader) - INFO - Done attempting. 22:32:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:32:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:32:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:32:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:32:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:32:58 INFO - (blobuploader) - INFO - Done attempting. 22:32:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:32:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:32:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:33:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:33:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:33:01 INFO - (blobuploader) - INFO - Done attempting. 22:33:01 INFO - (blobuploader) - INFO - Iteration through files over. 22:33:01 INFO - Return code: 0 22:33:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:33:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:33:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/15a0ea828e1132446c418a45c39e3d6cd3f80f0e9e3deac9d43b597d9b52581634e8a1ec809c4f12f796cfc4d6ca38723369d5e54c1d72ffcb3fb67d0bde4012", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5d868f64aadf61c280264b974798a1b4f3ba3d372fc92581ba7edcda968b44174853cd20bd9ec9a6322089567be685c1954ed8486ae7cdb92caa3fd994f63280", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ad68e62f40c3560b359e0ad635e2edea792a5eee5fd6e3dd0f342d09f2a565d2a8ebecabd84075e97f6b5e8377020077c69b07dc9c5edf1def2d86b5eeb34dc9"} 22:33:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:33:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:33:01 INFO - Contents: 22:33:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/15a0ea828e1132446c418a45c39e3d6cd3f80f0e9e3deac9d43b597d9b52581634e8a1ec809c4f12f796cfc4d6ca38723369d5e54c1d72ffcb3fb67d0bde4012", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5d868f64aadf61c280264b974798a1b4f3ba3d372fc92581ba7edcda968b44174853cd20bd9ec9a6322089567be685c1954ed8486ae7cdb92caa3fd994f63280", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ad68e62f40c3560b359e0ad635e2edea792a5eee5fd6e3dd0f342d09f2a565d2a8ebecabd84075e97f6b5e8377020077c69b07dc9c5edf1def2d86b5eeb34dc9"} 22:33:01 INFO - Running post-run listener: copy_logs_to_upload_dir 22:33:01 INFO - Copying logs to upload dir... 22:33:01 INFO - mkdir: /builds/slave/test/build/upload/logs 22:33:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.120199 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-10-13 22:33:00.950695) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 22:33:00.954158) ========= 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=920470bf432669ad7e3a5387000001ca-1476421937.461482-800442252 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/Mozilla-Inbound/sha512/15a0ea828e1132446c418a45c39e3d6cd3f80f0e9e3deac9d43b597d9b52581634e8a1ec809c4f12f796cfc4d6ca38723369d5e54c1d72ffcb3fb67d0bde4012", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5d868f64aadf61c280264b974798a1b4f3ba3d372fc92581ba7edcda968b44174853cd20bd9ec9a6322089567be685c1954ed8486ae7cdb92caa3fd994f63280", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ad68e62f40c3560b359e0ad635e2edea792a5eee5fd6e3dd0f342d09f2a565d2a8ebecabd84075e97f6b5e8377020077c69b07dc9c5edf1def2d86b5eeb34dc9"} build_url:https://queue.taskcluster.net/v1/task/DT0E5O3hTouYnwfMieI2wA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011501 build_url: 'https://queue.taskcluster.net/v1/task/DT0E5O3hTouYnwfMieI2wA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/15a0ea828e1132446c418a45c39e3d6cd3f80f0e9e3deac9d43b597d9b52581634e8a1ec809c4f12f796cfc4d6ca38723369d5e54c1d72ffcb3fb67d0bde4012", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5d868f64aadf61c280264b974798a1b4f3ba3d372fc92581ba7edcda968b44174853cd20bd9ec9a6322089567be685c1954ed8486ae7cdb92caa3fd994f63280", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ad68e62f40c3560b359e0ad635e2edea792a5eee5fd6e3dd0f342d09f2a565d2a8ebecabd84075e97f6b5e8377020077c69b07dc9c5edf1def2d86b5eeb34dc9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 22:33:00.983505) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 22:33:00.984255) ========= 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=920470bf432669ad7e3a5387000001ca-1476421937.461482-800442252 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004462 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 22:33:01.066901) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 22:33:01.067312) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 22:33:01.067771) ========= ========= Total master_lag: 0.17 =========