builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-004 starttime: 1482834486.42 results: success (0) buildid: 20161227004018 builduid: 57787d9771274caaa560716bbbcc03b7 revision: 5434909ba45c6df65a4e769ba80fe67ead95b785 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-27 02:28:06.415890) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-27 02:28:06.416681) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-27 02:28:06.417173) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-27 02:28:06.456082) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-27 02:28:06.456659) ========= 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=c6927cf182745ad25b1d38b9000001fe-1482834337.259206-1719056383 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-27 02:28:06-- 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% 42.1M=0s 2016-12-27 02:28:06 (42.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.162512 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-27 02:28:06.648800) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-27 02:28:06.649116) ========= 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=c6927cf182745ad25b1d38b9000001fe-1482834337.259206-1719056383 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021400 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-27 02:28:06.729893) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-27 02:28:06.730284) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5434909ba45c6df65a4e769ba80fe67ead95b785 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5434909ba45c6df65a4e769ba80fe67ead95b785 --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=c6927cf182745ad25b1d38b9000001fe-1482834337.259206-1719056383 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-27 02:28:07,132 truncating revision to first 12 chars 2016-12-27 02:28:07,132 Setting DEBUG logging. 2016-12-27 02:28:07,132 attempt 1/10 2016-12-27 02:28:07,132 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/5434909ba45c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-27 02:28:07,454 unpacking tar archive at: mozilla-aurora-5434909ba45c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.613972 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-27 02:28:07.380205) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-27 02:28:07.380530) ========= script_repo_revision: 5434909ba45c6df65a4e769ba80fe67ead95b785 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-27 02:28:07.380918) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-27 02:28:07.381183) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-27 02:28:07.475542) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-12-27 02:28:07.475943) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=c6927cf182745ad25b1d38b9000001fe-1482834337.259206-1719056383 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:28:07 INFO - MultiFileLogger online at 20161227 02:28:07 in /builds/slave/test 02:28:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:28:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:28:07 INFO - {'append_to_log': False, 02:28:07 INFO - 'base_work_dir': '/builds/slave/test', 02:28:07 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:28:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:28:07 INFO - 'branch': 'Mozilla-Aurora', 02:28:07 INFO - 'buildbot_json_path': 'buildprops.json', 02:28:07 INFO - 'config_files': ('talos/linux_config.py',), 02:28:07 INFO - 'default_actions': ('clobber', 02:28:07 INFO - 'read-buildbot-config', 02:28:07 INFO - 'download-and-extract', 02:28:07 INFO - 'populate-webroot', 02:28:07 INFO - 'create-virtualenv', 02:28:07 INFO - 'install', 02:28:07 INFO - 'run-tests'), 02:28:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:28:07 INFO - 'download_minidump_stackwalk': True, 02:28:07 INFO - 'download_symbols': 'ondemand', 02:28:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:28:07 INFO - 'tooltool.py': '/tools/tooltool.py', 02:28:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:28:07 INFO - '/tools/misc-python/virtualenv.py')}, 02:28:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:28:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:28:07 INFO - 'installer_path': 'installer.exe', 02:28:07 INFO - 'log_level': 'info', 02:28:07 INFO - 'log_name': 'talos', 02:28:07 INFO - 'log_to_console': True, 02:28:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:28:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:28:07 INFO - 'opt_config_files': (), 02:28:07 INFO - 'pip_index': False, 02:28:07 INFO - 'sps_profile': False, 02:28:07 INFO - 'sps_profile_interval': 0, 02:28:07 INFO - 'suite': 'dromaeojs-e10s', 02:28:07 INFO - 'system_bits': '32', 02:28:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:28:07 INFO - 'title': 'talos-linux64-ix-004', 02:28:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:28:07 INFO - 'use_talos_json': True, 02:28:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:28:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:28:07 INFO - 'work_dir': 'build'} 02:28:07 INFO - [mozharness: 2016-12-27 10:28:07.962650Z] Running clobber step. 02:28:07 INFO - Running pre-action listener: _resource_record_pre_action 02:28:07 INFO - Running main action method: clobber 02:28:07 INFO - rmtree: /builds/slave/test/build 02:28:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:28:08 INFO - Running post-action listener: _resource_record_post_action 02:28:08 INFO - [mozharness: 2016-12-27 10:28:08.957879Z] Finished clobber step (success) 02:28:08 INFO - [mozharness: 2016-12-27 10:28:08.957977Z] Running read-buildbot-config step. 02:28:08 INFO - Running pre-action listener: _resource_record_pre_action 02:28:08 INFO - Running main action method: read_buildbot_config 02:28:08 INFO - Using buildbot properties: 02:28:08 INFO - { 02:28:08 INFO - "project": "", 02:28:08 INFO - "product": "firefox", 02:28:08 INFO - "script_repo_revision": "production", 02:28:08 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 02:28:08 INFO - "repository": "", 02:28:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 02:28:08 INFO - "buildid": "20161227004018", 02:28:08 INFO - "stage_platform": "linux64-pgo", 02:28:08 INFO - "basedir": "/builds/slave/test", 02:28:08 INFO - "nightly_build": "True", 02:28:08 INFO - "buildnumber": 780, 02:28:08 INFO - "slavename": "talos-linux64-ix-004", 02:28:08 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:28:08 INFO - "platform": "ubuntu64_hw", 02:28:08 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 02:28:08 INFO - "branch": "mozilla-aurora", 02:28:08 INFO - "repo_path": "releases/mozilla-aurora", 02:28:08 INFO - "revision": "5434909ba45c6df65a4e769ba80fe67ead95b785", 02:28:08 INFO - "pgo_build": "True", 02:28:08 INFO - "builduid": "57787d9771274caaa560716bbbcc03b7", 02:28:08 INFO - "slavebuilddir": "test" 02:28:08 INFO - } 02:28:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/WeLlevggTVuo2_3ktAhduw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 02:28:08 INFO - Running post-action listener: _resource_record_post_action 02:28:08 INFO - [mozharness: 2016-12-27 10:28:08.960471Z] Finished read-buildbot-config step (success) 02:28:08 INFO - [mozharness: 2016-12-27 10:28:08.960559Z] Running download-and-extract step. 02:28:08 INFO - Running pre-action listener: _resource_record_pre_action 02:28:08 INFO - Running main action method: download_and_extract 02:28:08 INFO - mkdir: /builds/slave/test/build/tests 02:28:08 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')]} 02:28:08 INFO - trying https://queue.taskcluster.net/v1/task/WeLlevggTVuo2_3ktAhduw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 02:28:08 INFO - Downloading https://queue.taskcluster.net/v1/task/WeLlevggTVuo2_3ktAhduw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 02:28:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WeLlevggTVuo2_3ktAhduw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:28:09 INFO - Downloaded 1361 bytes. 02:28:09 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 02:28:09 INFO - Using the following test package requirements: 02:28:09 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 02:28:09 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:28:09 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 02:28:09 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:28:09 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 02:28:09 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:28:09 INFO - u'jsshell-linux-x86_64.zip'], 02:28:09 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:28:09 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 02:28:09 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 02:28:09 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:28:09 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 02:28:09 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:28:09 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 02:28:09 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:28:09 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 02:28:09 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:28:09 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 02:28:09 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:28:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WeLlevggTVuo2_3ktAhduw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 02:28:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WeLlevggTVuo2_3ktAhduw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:28:09 INFO - Fetch https://queue.taskcluster.net/v1/task/WeLlevggTVuo2_3ktAhduw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 02:28:10 INFO - Http code: 200 02:28:10 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 02:28:10 INFO - x-amz-cf-id: Wdynivxm4ON_CXqPhJHpOd4FRPbdlCtOnleRx_8B5CvD0L8rbLJ_EA== 02:28:10 INFO - x-amz-version-id: ZTRQ1WcH.if6SwGyxnhzEvjuvAIoa0gQ 02:28:10 INFO - Expected file size: 21941578 02:28:10 INFO - Obtained file size: 21941578 02:28:14 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:28:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WeLlevggTVuo2_3ktAhduw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 02:28:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WeLlevggTVuo2_3ktAhduw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:28:14 INFO - Fetch https://queue.taskcluster.net/v1/task/WeLlevggTVuo2_3ktAhduw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 02:28:15 INFO - Http code: 200 02:28:15 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 02:28:15 INFO - x-amz-cf-id: yih4VefZxpyoW5rYveq9QBq9VMZKkLFXeHkMkFXx-ZlZj90DJL1hUQ== 02:28:15 INFO - x-amz-version-id: ZTRQ1WcH.if6SwGyxnhzEvjuvAIoa0gQ 02:28:15 INFO - Expected file size: 21941578 02:28:15 INFO - Obtained file size: 21941578 02:28:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WeLlevggTVuo2_3ktAhduw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 02:28:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WeLlevggTVuo2_3ktAhduw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:28:19 INFO - Fetch https://queue.taskcluster.net/v1/task/WeLlevggTVuo2_3ktAhduw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 02:28:20 INFO - Http code: 200 02:28:20 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 02:28:20 INFO - x-amz-cf-id: AEjFoP0AkkuZQfY0vvQjxU_UQZvDOVIf-4euTpG4AM_j1XhOFBA0ZQ== 02:28:20 INFO - x-amz-version-id: oX1cPGbi4JPQscucFlW2m5x08zlbg9x2 02:28:20 INFO - Expected file size: 14409038 02:28:20 INFO - Obtained file size: 14409038 02:28:20 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')]} 02:28:20 INFO - trying https://queue.taskcluster.net/v1/task/WeLlevggTVuo2_3ktAhduw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:28:20 INFO - Downloading https://queue.taskcluster.net/v1/task/WeLlevggTVuo2_3ktAhduw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:28:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WeLlevggTVuo2_3ktAhduw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:28:22 INFO - Downloaded 64011548 bytes. 02:28:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WeLlevggTVuo2_3ktAhduw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:28:22 INFO - mkdir: /builds/slave/test/properties 02:28:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:28:22 INFO - Writing to file /builds/slave/test/properties/build_url 02:28:22 INFO - Contents: 02:28:22 INFO - build_url:https://queue.taskcluster.net/v1/task/WeLlevggTVuo2_3ktAhduw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:28:22 INFO - Running post-action listener: _resource_record_post_action 02:28:22 INFO - Running post-action listener: set_extra_try_arguments 02:28:22 INFO - [mozharness: 2016-12-27 10:28:22.738293Z] Finished download-and-extract step (success) 02:28:22 INFO - [mozharness: 2016-12-27 10:28:22.738518Z] Running populate-webroot step. 02:28:22 INFO - Running pre-action listener: _resource_record_pre_action 02:28:22 INFO - Running main action method: populate_webroot 02:28:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:28:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:28:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:28:22 INFO - '--tppagecycles', 02:28:22 INFO - '7'], 02:28:22 INFO - 'tests': ['tsvgm']}}, 02:28:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:28:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:28:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:28:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:28:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:28:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:28:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:22 INFO - 'talos_options': ['--disable-e10s'], 02:28:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:28:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:28:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:22 INFO - 'talos_options': ['--disable-e10s'], 02:28:22 INFO - 'tests': ['damp', 'tps']}, 02:28:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:22 INFO - 'tests': ['damp', 'tps']}, 02:28:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:28:22 INFO - 'tests': ['dromaeo_dom']}, 02:28:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:28:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:28:22 INFO - 'tests': ['basic_compositor_video']}, 02:28:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:28:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:28:22 INFO - 'tests': ['a11yr', 02:28:22 INFO - 'ts_paint', 02:28:22 INFO - 'tpaint', 02:28:22 INFO - 'sessionrestore', 02:28:22 INFO - 'sessionrestore_no_auto_restore', 02:28:22 INFO - 'tabpaint']}, 02:28:22 INFO - 'other-e10s': {'tests': ['a11yr', 02:28:22 INFO - 'ts_paint', 02:28:22 INFO - 'tpaint', 02:28:22 INFO - 'sessionrestore', 02:28:22 INFO - 'sessionrestore_no_auto_restore', 02:28:22 INFO - 'tabpaint']}, 02:28:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:28:22 INFO - 'ts_paint', 02:28:22 INFO - 'tpaint', 02:28:22 INFO - 'sessionrestore', 02:28:22 INFO - 'sessionrestore_no_auto_restore', 02:28:22 INFO - 'tabpaint']}, 02:28:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:28:22 INFO - 'ts_paint', 02:28:22 INFO - 'tpaint', 02:28:22 INFO - 'sessionrestore', 02:28:22 INFO - 'sessionrestore_no_auto_restore', 02:28:22 INFO - 'tabpaint']}, 02:28:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:28:22 INFO - 'tests': ['a11yr', 02:28:22 INFO - 'ts_paint', 02:28:22 INFO - 'tpaint', 02:28:22 INFO - 'sessionrestore', 02:28:22 INFO - 'sessionrestore_no_auto_restore', 02:28:22 INFO - 'tabpaint']}, 02:28:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:28:22 INFO - 'tests': ['a11yr', 02:28:22 INFO - 'ts_paint', 02:28:22 INFO - 'tpaint', 02:28:22 INFO - 'sessionrestore', 02:28:22 INFO - 'sessionrestore_no_auto_restore', 02:28:22 INFO - 'tabpaint']}, 02:28:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:28:22 INFO - 'tests': ['tsvgx', 02:28:22 INFO - 'tsvgr_opacity', 02:28:22 INFO - 'tart', 02:28:22 INFO - 'tscrollx', 02:28:22 INFO - 'cart']}, 02:28:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:28:22 INFO - 'tsvgr_opacity', 02:28:22 INFO - 'tart', 02:28:22 INFO - 'tscrollx', 02:28:22 INFO - 'cart']}, 02:28:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:22 INFO - 'talos_options': ['--disable-e10s'], 02:28:22 INFO - 'tests': ['tp5o']}, 02:28:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:22 INFO - 'tests': ['tp5o']}, 02:28:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:22 INFO - 'talos_options': ['--disable-e10s', 02:28:22 INFO - '--xperf_path', 02:28:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:28:22 INFO - 'tests': ['tp5n']}, 02:28:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:22 INFO - 'talos_options': ['--xperf_path', 02:28:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:28:22 INFO - 'tests': ['tp5n']}}, 02:28:22 INFO - 'talos.zip': {'path': '', 02:28:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:28:22 INFO - Running post-action listener: _resource_record_post_action 02:28:22 INFO - [mozharness: 2016-12-27 10:28:22.760215Z] Finished populate-webroot step (success) 02:28:22 INFO - [mozharness: 2016-12-27 10:28:22.760303Z] Running create-virtualenv step. 02:28:22 INFO - Running pre-action listener: _resource_record_pre_action 02:28:22 INFO - Running main action method: create_virtualenv 02:28:22 INFO - Creating virtualenv /builds/slave/test/build/venv 02:28:22 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 02:28:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:28:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:28:22 INFO - Using real prefix '/usr' 02:28:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:28:23 INFO - Installing distribute.............................................................................................................................................................................................done. 02:28:25 INFO - Installing pip.................done. 02:28:25 INFO - Return code: 0 02:28:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:28:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:28:25 INFO - Reading from file tmpfile_stdout 02:28:25 INFO - Output received: 02:28:25 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) 02:28:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:28:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:28:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:25 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 0x7f4107d26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2602ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fff60>, '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 0x2600d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26011d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1482834337.259206-1719056383', '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 02:28:25 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 02:28:25 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 02:28:25 INFO - Using env: {'DISPLAY': ':0', 02:28:25 INFO - 'HOME': '/home/cltbld', 02:28:25 INFO - 'LANG': 'en_US.UTF-8', 02:28:25 INFO - 'LANGUAGE': 'en_US:en', 02:28:25 INFO - 'LOGNAME': 'cltbld', 02:28:25 INFO - 'MAIL': '/var/mail/cltbld', 02:28:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:25 INFO - 'MOZ_NO_REMOTE': '1', 02:28:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:25 INFO - 'NO_EM_RESTART': '1', 02:28:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:25 INFO - 'PWD': '/builds/slave/test', 02:28:25 INFO - 'SHELL': '/bin/bash', 02:28:25 INFO - 'SHLVL': '1', 02:28:25 INFO - 'TERM': 'linux', 02:28:25 INFO - 'TMOUT': '86400', 02:28:25 INFO - 'USER': 'cltbld', 02:28:25 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1482834337.259206-1719056383', 02:28:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:25 INFO - '_': '/tools/buildbot/bin/python'} 02:28:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:25 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 02:28:25 INFO - Cleaning up... 02:28:25 INFO - Return code: 0 02:28:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:28:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:28:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:25 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 0x7f4107d26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2602ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fff60>, '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 0x2600d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26011d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1482834337.259206-1719056383', '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 02:28:25 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 02:28:25 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 02:28:25 INFO - Using env: {'DISPLAY': ':0', 02:28:25 INFO - 'HOME': '/home/cltbld', 02:28:25 INFO - 'LANG': 'en_US.UTF-8', 02:28:25 INFO - 'LANGUAGE': 'en_US:en', 02:28:25 INFO - 'LOGNAME': 'cltbld', 02:28:25 INFO - 'MAIL': '/var/mail/cltbld', 02:28:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:25 INFO - 'MOZ_NO_REMOTE': '1', 02:28:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:25 INFO - 'NO_EM_RESTART': '1', 02:28:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:25 INFO - 'PWD': '/builds/slave/test', 02:28:25 INFO - 'SHELL': '/bin/bash', 02:28:25 INFO - 'SHLVL': '1', 02:28:25 INFO - 'TERM': 'linux', 02:28:25 INFO - 'TMOUT': '86400', 02:28:25 INFO - 'USER': 'cltbld', 02:28:25 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1482834337.259206-1719056383', 02:28:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:25 INFO - '_': '/tools/buildbot/bin/python'} 02:28:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:25 INFO - Downloading/unpacking psutil>=3.1.1 02:28:25 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 02:28:25 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 02:28:25 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 02:28:25 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 02:28:25 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 02:28:25 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 02:28:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:28:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:28:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:28:28 INFO - Installing collected packages: psutil 02:28:28 INFO - Running setup.py install for psutil 02:28:28 INFO - building 'psutil._psutil_linux' extension 02:28:28 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 02:28:28 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 02:28:28 INFO - building 'psutil._psutil_posix' extension 02:28:28 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 02:28:28 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 02:28:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:28:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:28:28 INFO - Successfully installed psutil 02:28:28 INFO - Cleaning up... 02:28:28 INFO - Return code: 0 02:28:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:28:28 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')]} 02:28:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:28 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')]} 02:28:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:28 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 0x7f4107d26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2602ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fff60>, '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 0x2600d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26011d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1482834337.259206-1719056383', '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 02:28:28 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 02:28:28 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 02:28:28 INFO - Using env: {'DISPLAY': ':0', 02:28:28 INFO - 'HOME': '/home/cltbld', 02:28:28 INFO - 'LANG': 'en_US.UTF-8', 02:28:28 INFO - 'LANGUAGE': 'en_US:en', 02:28:28 INFO - 'LOGNAME': 'cltbld', 02:28:28 INFO - 'MAIL': '/var/mail/cltbld', 02:28:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:28 INFO - 'MOZ_NO_REMOTE': '1', 02:28:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:28 INFO - 'NO_EM_RESTART': '1', 02:28:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:28 INFO - 'PWD': '/builds/slave/test', 02:28:28 INFO - 'SHELL': '/bin/bash', 02:28:28 INFO - 'SHLVL': '1', 02:28:28 INFO - 'TERM': 'linux', 02:28:28 INFO - 'TMOUT': '86400', 02:28:28 INFO - 'USER': 'cltbld', 02:28:28 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1482834337.259206-1719056383', 02:28:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:28 INFO - '_': '/tools/buildbot/bin/python'} 02:28:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:28:28 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 02:28:28 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 02:28:28 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 02:28:28 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 02:28:28 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 02:28:28 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 02:28:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:28:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:28:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:28:30 INFO - Installing collected packages: mozsystemmonitor 02:28:30 INFO - Running setup.py install for mozsystemmonitor 02:28:31 INFO - Successfully installed mozsystemmonitor 02:28:31 INFO - Cleaning up... 02:28:31 INFO - Return code: 0 02:28:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:28:31 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')]} 02:28:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:31 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')]} 02:28:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:31 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 0x7f4107d26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2602ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fff60>, '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 0x2600d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26011d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1482834337.259206-1719056383', '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 02:28:31 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 02:28:31 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 02:28:31 INFO - Using env: {'DISPLAY': ':0', 02:28:31 INFO - 'HOME': '/home/cltbld', 02:28:31 INFO - 'LANG': 'en_US.UTF-8', 02:28:31 INFO - 'LANGUAGE': 'en_US:en', 02:28:31 INFO - 'LOGNAME': 'cltbld', 02:28:31 INFO - 'MAIL': '/var/mail/cltbld', 02:28:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:31 INFO - 'MOZ_NO_REMOTE': '1', 02:28:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:31 INFO - 'NO_EM_RESTART': '1', 02:28:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:31 INFO - 'PWD': '/builds/slave/test', 02:28:31 INFO - 'SHELL': '/bin/bash', 02:28:31 INFO - 'SHLVL': '1', 02:28:31 INFO - 'TERM': 'linux', 02:28:31 INFO - 'TMOUT': '86400', 02:28:31 INFO - 'USER': 'cltbld', 02:28:31 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1482834337.259206-1719056383', 02:28:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:31 INFO - '_': '/tools/buildbot/bin/python'} 02:28:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:31 INFO - Downloading/unpacking jsonschema==2.5.1 02:28:31 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 02:28:31 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 02:28:31 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 02:28:31 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 02:28:31 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 02:28:31 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 02:28:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:28:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:33 INFO - Downloading functools32-3.2.3-2.tar.gz 02:28:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:28:33 INFO - warning: no files found matching '*.txt' 02:28:33 INFO - no previously-included directories found matching 'build' 02:28:33 INFO - no previously-included directories found matching 'dist' 02:28:33 INFO - no previously-included directories found matching '.git*' 02:28:33 INFO - Installing collected packages: jsonschema, functools32 02:28:33 INFO - Running setup.py install for functools32 02:28:33 INFO - warning: no files found matching '*.txt' 02:28:33 INFO - no previously-included directories found matching 'build' 02:28:33 INFO - no previously-included directories found matching 'dist' 02:28:33 INFO - no previously-included directories found matching '.git*' 02:28:33 INFO - Successfully installed jsonschema functools32 02:28:33 INFO - Cleaning up... 02:28:33 INFO - Return code: 0 02:28:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:28: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')]} 02:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28: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')]} 02:28:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:33 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 0x7f4107d26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2602ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fff60>, '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 0x2600d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26011d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1482834337.259206-1719056383', '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 02:28:33 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 02:28:33 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 02:28:33 INFO - Using env: {'DISPLAY': ':0', 02:28:33 INFO - 'HOME': '/home/cltbld', 02:28:33 INFO - 'LANG': 'en_US.UTF-8', 02:28:33 INFO - 'LANGUAGE': 'en_US:en', 02:28:33 INFO - 'LOGNAME': 'cltbld', 02:28:33 INFO - 'MAIL': '/var/mail/cltbld', 02:28:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:33 INFO - 'MOZ_NO_REMOTE': '1', 02:28:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:33 INFO - 'NO_EM_RESTART': '1', 02:28:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:33 INFO - 'PWD': '/builds/slave/test', 02:28:33 INFO - 'SHELL': '/bin/bash', 02:28:33 INFO - 'SHLVL': '1', 02:28:33 INFO - 'TERM': 'linux', 02:28:33 INFO - 'TMOUT': '86400', 02:28:33 INFO - 'USER': 'cltbld', 02:28:33 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1482834337.259206-1719056383', 02:28:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:33 INFO - '_': '/tools/buildbot/bin/python'} 02:28:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:28:33 INFO - Cleaning up... 02:28:33 INFO - Return code: 0 02:28:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:28: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')]} 02:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28: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')]} 02:28:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:34 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 0x7f4107d26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2602ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fff60>, '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 0x2600d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26011d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1482834337.259206-1719056383', '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 02:28:34 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 02:28:34 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 02:28:34 INFO - Using env: {'DISPLAY': ':0', 02:28:34 INFO - 'HOME': '/home/cltbld', 02:28:34 INFO - 'LANG': 'en_US.UTF-8', 02:28:34 INFO - 'LANGUAGE': 'en_US:en', 02:28:34 INFO - 'LOGNAME': 'cltbld', 02:28:34 INFO - 'MAIL': '/var/mail/cltbld', 02:28:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:34 INFO - 'MOZ_NO_REMOTE': '1', 02:28:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:34 INFO - 'NO_EM_RESTART': '1', 02:28:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:34 INFO - 'PWD': '/builds/slave/test', 02:28:34 INFO - 'SHELL': '/bin/bash', 02:28:34 INFO - 'SHLVL': '1', 02:28:34 INFO - 'TERM': 'linux', 02:28:34 INFO - 'TMOUT': '86400', 02:28:34 INFO - 'USER': 'cltbld', 02:28:34 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1482834337.259206-1719056383', 02:28:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:34 INFO - '_': '/tools/buildbot/bin/python'} 02:28:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:34 INFO - Downloading/unpacking blobuploader==1.2.4 02:28:34 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 02:28:34 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 02:28:34 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 02:28:34 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 02:28:34 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 02:28:34 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 02:28:36 INFO - Downloading blobuploader-1.2.4.tar.gz 02:28:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:28:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:28:36 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 02:28:36 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 02:28:36 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 02:28:36 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 02:28:36 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 02:28:36 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 02:28:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:28:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:28:36 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 02:28:36 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 02:28:36 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 02:28:36 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 02:28:36 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 02:28:36 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 02:28:36 INFO - Downloading docopt-0.6.1.tar.gz 02:28:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:28:36 INFO - Installing collected packages: blobuploader, requests, docopt 02:28:36 INFO - Running setup.py install for blobuploader 02:28:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:28:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:28:37 INFO - Running setup.py install for requests 02:28:37 INFO - Running setup.py install for docopt 02:28:37 INFO - Successfully installed blobuploader requests docopt 02:28:37 INFO - Cleaning up... 02:28:37 INFO - Return code: 0 02:28:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:28:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:28:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:28:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:37 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 0x7f4107d26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2602ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fff60>, '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 0x2600d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26011d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1482834337.259206-1719056383', '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 02:28:37 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 02:28:37 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 02:28:37 INFO - Using env: {'DISPLAY': ':0', 02:28:37 INFO - 'HOME': '/home/cltbld', 02:28:37 INFO - 'LANG': 'en_US.UTF-8', 02:28:37 INFO - 'LANGUAGE': 'en_US:en', 02:28:37 INFO - 'LOGNAME': 'cltbld', 02:28:37 INFO - 'MAIL': '/var/mail/cltbld', 02:28:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:37 INFO - 'MOZ_NO_REMOTE': '1', 02:28:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:37 INFO - 'NO_EM_RESTART': '1', 02:28:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:37 INFO - 'PWD': '/builds/slave/test', 02:28:37 INFO - 'SHELL': '/bin/bash', 02:28:37 INFO - 'SHLVL': '1', 02:28:37 INFO - 'TERM': 'linux', 02:28:37 INFO - 'TMOUT': '86400', 02:28:37 INFO - 'USER': 'cltbld', 02:28:37 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1482834337.259206-1719056383', 02:28:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:37 INFO - '_': '/tools/buildbot/bin/python'} 02:28:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:28:37 INFO - Running setup.py (path:/tmp/pip-34z3zw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:28:37 INFO - Running setup.py (path:/tmp/pip-F86l9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:28:37 INFO - Running setup.py (path:/tmp/pip-Yvrmre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:28:38 INFO - Running setup.py (path:/tmp/pip-fXMaZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:28:38 INFO - Running setup.py (path:/tmp/pip-ER4pze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:28:38 INFO - Running setup.py (path:/tmp/pip-20STou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:28:38 INFO - Running setup.py (path:/tmp/pip-Fqdhc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:28:38 INFO - Running setup.py (path:/tmp/pip-SVtnuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:28:38 INFO - Running setup.py (path:/tmp/pip-hd1YVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:28:38 INFO - Running setup.py (path:/tmp/pip-5sNuSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:28:38 INFO - Running setup.py (path:/tmp/pip-XPPeLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:28:38 INFO - Running setup.py (path:/tmp/pip-Tm5267-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:28:38 INFO - Running setup.py (path:/tmp/pip-4S8lA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:28:38 INFO - Running setup.py (path:/tmp/pip-lpiJYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:28:38 INFO - Running setup.py (path:/tmp/pip-EsAe6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:28:38 INFO - Running setup.py (path:/tmp/pip-ruwHYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:28:38 INFO - Running setup.py (path:/tmp/pip-hO88wN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:28:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:28:39 INFO - Running setup.py install for manifestparser 02:28:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:28:39 INFO - Running setup.py install for mozcrash 02:28:39 INFO - Running setup.py install for mozdebug 02:28:39 INFO - Running setup.py install for mozdevice 02:28:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:28:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:28:39 INFO - Running setup.py install for mozfile 02:28:39 INFO - Running setup.py install for mozhttpd 02:28:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:28:39 INFO - Running setup.py install for mozinfo 02:28:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:28:39 INFO - Running setup.py install for mozInstall 02:28:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:28:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:28:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:28:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:28:39 INFO - Running setup.py install for mozleak 02:28:39 INFO - Running setup.py install for mozlog 02:28:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:28:40 INFO - Running setup.py install for moznetwork 02:28:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:28:40 INFO - Running setup.py install for mozprocess 02:28:40 INFO - Running setup.py install for mozprofile 02:28:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:28:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:28:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:28:40 INFO - Running setup.py install for mozrunner 02:28:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:28:40 INFO - Running setup.py install for mozscreenshot 02:28:40 INFO - Running setup.py install for moztest 02:28:40 INFO - Running setup.py install for mozversion 02:28:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:28:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:28:40 INFO - Cleaning up... 02:28:40 INFO - Return code: 0 02:28:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:28:40 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')]} 02:28:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:40 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')]} 02:28:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:40 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 0x7f4107d26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2602ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fff60>, '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 0x2600d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26011d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1482834337.259206-1719056383', '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 02:28:40 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 02:28:40 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 02:28:40 INFO - Using env: {'DISPLAY': ':0', 02:28:40 INFO - 'HOME': '/home/cltbld', 02:28:40 INFO - 'LANG': 'en_US.UTF-8', 02:28:40 INFO - 'LANGUAGE': 'en_US:en', 02:28:40 INFO - 'LOGNAME': 'cltbld', 02:28:40 INFO - 'MAIL': '/var/mail/cltbld', 02:28:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:40 INFO - 'MOZ_NO_REMOTE': '1', 02:28:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:40 INFO - 'NO_EM_RESTART': '1', 02:28:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:40 INFO - 'PWD': '/builds/slave/test', 02:28:40 INFO - 'SHELL': '/bin/bash', 02:28:40 INFO - 'SHLVL': '1', 02:28:40 INFO - 'TERM': 'linux', 02:28:40 INFO - 'TMOUT': '86400', 02:28:40 INFO - 'USER': 'cltbld', 02:28:40 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1482834337.259206-1719056383', 02:28:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:40 INFO - '_': '/tools/buildbot/bin/python'} 02:28:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:28:41 INFO - Running setup.py (path:/tmp/pip-W6F70d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:28:41 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)) 02:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:28:41 INFO - Running setup.py (path:/tmp/pip-kbWElM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:28:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:28:41 INFO - Running setup.py (path:/tmp/pip-aV5eZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:28:41 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)) 02:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:28:41 INFO - Running setup.py (path:/tmp/pip-gT21cU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:28:41 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)) 02:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:28:41 INFO - Running setup.py (path:/tmp/pip-EhLLLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:28:41 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)) 02:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:28:41 INFO - Running setup.py (path:/tmp/pip-5YjP3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:28:41 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)) 02:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:28:41 INFO - Running setup.py (path:/tmp/pip-4sMRoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:28:41 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)) 02:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:28:41 INFO - Running setup.py (path:/tmp/pip-AXfmUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:28:41 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)) 02:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:28:41 INFO - Running setup.py (path:/tmp/pip-CWwv2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:28:41 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)) 02:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:28:41 INFO - Running setup.py (path:/tmp/pip-ynRdRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:28:41 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)) 02:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:28:41 INFO - Running setup.py (path:/tmp/pip-FnpBkJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:28:41 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)) 02:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:28:41 INFO - Running setup.py (path:/tmp/pip-MfMJQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:28:41 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)) 02:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:28:41 INFO - Running setup.py (path:/tmp/pip-KEXThG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:28:42 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)) 02:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:28:42 INFO - Running setup.py (path:/tmp/pip-VEWwX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:28:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:28:42 INFO - Running setup.py (path:/tmp/pip-1A6NCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:28:42 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)) 02:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:28:42 INFO - Running setup.py (path:/tmp/pip-shTQBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:28:42 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)) 02:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:28:42 INFO - Running setup.py (path:/tmp/pip-yhEcWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:28:42 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)) 02:28:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:28:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:28:42 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)) 02:28:42 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)) 02:28:42 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)) 02:28:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:28:42 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 02:28:42 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 02:28:42 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 02:28:42 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 02:28:42 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 02:28:42 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 02:28:44 INFO - Downloading blessings-1.6.tar.gz 02:28:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:28:44 INFO - Installing collected packages: blessings 02:28:44 INFO - Running setup.py install for blessings 02:28:44 INFO - Successfully installed blessings 02:28:44 INFO - Cleaning up... 02:28:44 INFO - Return code: 0 02:28:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:28:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:28:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:28:44 INFO - Reading from file tmpfile_stdout 02:28:44 INFO - Current package versions: 02:28:44 INFO - argparse == 1.2.1 02:28:44 INFO - blessings == 1.6 02:28:44 INFO - blobuploader == 1.2.4 02:28:44 INFO - docopt == 0.6.1 02:28:44 INFO - functools32 == 3.2.3-2 02:28:44 INFO - jsonschema == 2.5.1 02:28:44 INFO - manifestparser == 1.1 02:28:44 INFO - mozInstall == 1.12 02:28:44 INFO - mozcrash == 1.0 02:28:44 INFO - mozdebug == 0.1 02:28:44 INFO - mozdevice == 0.48 02:28:44 INFO - mozfile == 1.2 02:28:44 INFO - mozhttpd == 0.7 02:28:44 INFO - mozinfo == 0.9 02:28:44 INFO - mozleak == 0.1 02:28:44 INFO - mozlog == 3.4 02:28:44 INFO - moznetwork == 0.27 02:28:44 INFO - mozprocess == 0.23 02:28:44 INFO - mozprofile == 0.28 02:28:44 INFO - mozrunner == 6.13 02:28:44 INFO - mozscreenshot == 0.1 02:28:44 INFO - mozsystemmonitor == 0.3 02:28:44 INFO - moztest == 0.7 02:28:44 INFO - mozversion == 1.4 02:28:44 INFO - psutil == 3.1.1 02:28:44 INFO - requests == 1.2.3 02:28:44 INFO - wsgiref == 0.1.2 02:28:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:28:44 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')]} 02:28:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:44 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')]} 02:28:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:44 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 0x7f4107d26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2602ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fff60>, '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 0x2600d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26011d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1482834337.259206-1719056383', '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 02:28:44 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 02:28:44 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 02:28:44 INFO - Using env: {'DISPLAY': ':0', 02:28:44 INFO - 'HOME': '/home/cltbld', 02:28:44 INFO - 'LANG': 'en_US.UTF-8', 02:28:44 INFO - 'LANGUAGE': 'en_US:en', 02:28:44 INFO - 'LOGNAME': 'cltbld', 02:28:44 INFO - 'MAIL': '/var/mail/cltbld', 02:28:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:44 INFO - 'MOZ_NO_REMOTE': '1', 02:28:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:44 INFO - 'NO_EM_RESTART': '1', 02:28:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:44 INFO - 'PWD': '/builds/slave/test', 02:28:44 INFO - 'SHELL': '/bin/bash', 02:28:44 INFO - 'SHLVL': '1', 02:28:44 INFO - 'TERM': 'linux', 02:28:44 INFO - 'TMOUT': '86400', 02:28:44 INFO - 'USER': 'cltbld', 02:28:44 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1482834337.259206-1719056383', 02:28:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:44 INFO - '_': '/tools/buildbot/bin/python'} 02:28:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:45 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)) 02:28:45 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)) 02:28:45 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)) 02:28:45 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)) 02:28:45 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)) 02:28:45 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)) 02:28:45 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)) 02:28:45 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)) 02:28:45 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)) 02:28:45 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)) 02:28:45 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)) 02:28:45 INFO - Cleaning up... 02:28:45 INFO - Return code: 0 02:28:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:28:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:28:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:45 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 0x7f4107d26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2602ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fff60>, '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 0x2600d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26011d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1482834337.259206-1719056383', '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 02:28:45 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 02:28:45 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 02:28:45 INFO - Using env: {'DISPLAY': ':0', 02:28:45 INFO - 'HOME': '/home/cltbld', 02:28:45 INFO - 'LANG': 'en_US.UTF-8', 02:28:45 INFO - 'LANGUAGE': 'en_US:en', 02:28:45 INFO - 'LOGNAME': 'cltbld', 02:28:45 INFO - 'MAIL': '/var/mail/cltbld', 02:28:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:45 INFO - 'MOZ_NO_REMOTE': '1', 02:28:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:45 INFO - 'NO_EM_RESTART': '1', 02:28:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:45 INFO - 'PWD': '/builds/slave/test', 02:28:45 INFO - 'SHELL': '/bin/bash', 02:28:45 INFO - 'SHLVL': '1', 02:28:45 INFO - 'TERM': 'linux', 02:28:45 INFO - 'TMOUT': '86400', 02:28:45 INFO - 'USER': 'cltbld', 02:28:45 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1482834337.259206-1719056383', 02:28:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:45 INFO - '_': '/tools/buildbot/bin/python'} 02:28:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:28:45 INFO - Cleaning up... 02:28:45 INFO - Return code: 0 02:28:45 INFO - Running post-action listener: _resource_record_post_action 02:28:45 INFO - Running post-action listener: _start_resource_monitoring 02:28:45 INFO - Starting resource monitoring. 02:28:45 INFO - [mozharness: 2016-12-27 10:28:45.280030Z] Finished create-virtualenv step (success) 02:28:45 INFO - [mozharness: 2016-12-27 10:28:45.280531Z] Running install step. 02:28:45 INFO - Running pre-action listener: _resource_record_pre_action 02:28:45 INFO - Running main action method: install 02:28:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:28:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:28:45 INFO - Reading from file tmpfile_stdout 02:28:45 INFO - Detecting whether we're running mozinstall >=1.0... 02:28:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:28:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:28:45 INFO - Reading from file tmpfile_stdout 02:28:45 INFO - Output received: 02:28:45 INFO - Usage: mozinstall [options] installer 02:28:45 INFO - Options: 02:28:45 INFO - -h, --help show this help message and exit 02:28:45 INFO - -d DEST, --destination=DEST 02:28:45 INFO - Directory to install application into. [default: 02:28:45 INFO - "/builds/slave/test"] 02:28:45 INFO - --app=APP Application being installed. [default: firefox] 02:28:45 INFO - mkdir: /builds/slave/test/build/application 02:28:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:28:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:29:01 INFO - Reading from file tmpfile_stdout 02:29:01 INFO - Output received: 02:29:01 INFO - /builds/slave/test/build/application/firefox/firefox 02:29:01 INFO - Running post-action listener: _resource_record_post_action 02:29:01 INFO - [mozharness: 2016-12-27 10:29:01.497374Z] Finished install step (success) 02:29:01 INFO - [mozharness: 2016-12-27 10:29:01.497617Z] Running run-tests step. 02:29:01 INFO - Running pre-action listener: _resource_record_pre_action 02:29:01 INFO - Running main action method: run_tests 02:29:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:29:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:29:01 INFO - Python 2.7.3 02:29:01 INFO - Return code: 0 02:29:01 INFO - grabbing minidump binary from tooltool 02:29:01 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')]} 02:29:01 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 0x25fff60>, '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 0x2600d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26011d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:29:01 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 02:29:01 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 02:29:01 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 02:29:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:29:01 INFO - Return code: 0 02:29:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:29:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:29:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:29:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:29:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:29:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WeLlevggTVuo2_3ktAhduw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 02:29:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WeLlevggTVuo2_3ktAhduw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --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 02:29:01 INFO - Using env: {'DISPLAY': ':0', 02:29:01 INFO - 'HOME': '/home/cltbld', 02:29:01 INFO - 'LANG': 'en_US.UTF-8', 02:29:01 INFO - 'LANGUAGE': 'en_US:en', 02:29:01 INFO - 'LOGNAME': 'cltbld', 02:29:01 INFO - 'MAIL': '/var/mail/cltbld', 02:29:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:29:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:29:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:01 INFO - 'MOZ_NO_REMOTE': '1', 02:29:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:29:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:01 INFO - 'NO_EM_RESTART': '1', 02:29:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:01 INFO - 'PWD': '/builds/slave/test', 02:29:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:29:01 INFO - 'SHELL': '/bin/bash', 02:29:01 INFO - 'SHLVL': '1', 02:29:01 INFO - 'TERM': 'linux', 02:29:01 INFO - 'TMOUT': '86400', 02:29:01 INFO - 'USER': 'cltbld', 02:29:01 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1482834337.259206-1719056383', 02:29:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:01 INFO - '_': '/tools/buildbot/bin/python'} 02:29:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WeLlevggTVuo2_3ktAhduw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 02:29:01 INFO - mozversion application_buildid: 20161227004018 02:29:01 INFO - mozversion application_changeset: 5434909ba45c6df65a4e769ba80fe67ead95b785 02:29:01 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:29:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:29:01 INFO - mozversion application_name: Firefox 02:29:01 INFO - mozversion application_remotingname: firefox-dev 02:29:01 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:29:01 INFO - mozversion application_vendor: Mozilla 02:29:01 INFO - mozversion application_version: 52.0a2 02:29:01 INFO - mozversion platform_buildid: 20161227004018 02:29:01 INFO - mozversion platform_changeset: 5434909ba45c6df65a4e769ba80fe67ead95b785 02:29:01 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:29:01 INFO - mozversion platform_version: 52.0a2 02:29:01 INFO - using testdate: 1482834541 02:29:01 INFO - actual date: 1482834541 02:29:01 INFO - starting webserver on 'localhost:36934' 02:29:01 INFO - SUITE-START | Running 2 tests 02:29:01 INFO - TEST-START | dromaeo_css 02:29:01 INFO - operating with platform_type : linux_ 02:29:01 INFO - Initialising browser for dromaeo_css test... 02:29:01 INFO - TEST-INFO | started process 15882 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBTp9fU/profile http://localhost:36934/getInfo.html) 02:29:06 INFO - PROCESS | 15882 | __metrics Screen width/height:1600/1200 02:29:06 INFO - PROCESS | 15882 | colorDepth:24 02:29:06 INFO - PROCESS | 15882 | Browser inner width/height: 1024/697 02:29:06 INFO - PROCESS | 15882 | __metrics 02:29:06 ERROR - PROCESS | 15882 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 02:29:07 INFO - TEST-INFO | 15882: exit 0 02:29:07 INFO - Browser initialized. 02:29:07 INFO - Running cycle 1/1 for dromaeo_css test... 02:29:07 INFO - TEST-INFO | started process 16013 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBTp9fU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:29:19 INFO - PROCESS | 16013 | RSS: Main: 152010752 02:29:19 INFO - PROCESS | 16013 | 02:30:09 INFO - PROCESS | 16013 | 1482834609089 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] 02:32:19 INFO - PROCESS | 16013 | Cycle 1(1): loaded http://localhost:36934/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36934/tests/dromaeo/cssquery-ext.html) 02:32:21 INFO - PROCESS | 16013 | RSS: Main: 156835840 02:32:21 INFO - PROCESS | 16013 | 02:35:23 INFO - PROCESS | 16013 | Cycle 1(1): loaded http://localhost:36934/tests/dromaeo/cssquery-ext.html (next: http://localhost:36934/tests/dromaeo/cssquery-jquery.html) 02:35:23 INFO - PROCESS | 16013 | RSS: Main: 152850432 02:35:23 INFO - PROCESS | 16013 | 02:38:25 INFO - PROCESS | 16013 | Cycle 1(1): loaded http://localhost:36934/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36934/tests/dromaeo/cssquery-mootools.html) 02:38:26 INFO - PROCESS | 16013 | RSS: Main: 153157632 02:38:26 INFO - PROCESS | 16013 | 02:41:28 INFO - PROCESS | 16013 | Cycle 1(1): loaded http://localhost:36934/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36934/tests/dromaeo/cssquery-prototype.html) 02:41:28 INFO - PROCESS | 16013 | RSS: Main: 151990272 02:41:28 INFO - PROCESS | 16013 | 02:44:31 INFO - PROCESS | 16013 | Cycle 1(1): loaded http://localhost:36934/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36934/tests/dromaeo/cssquery-yui.html) 02:44:31 INFO - PROCESS | 16013 | RSS: Main: 154157056 02:44:31 INFO - PROCESS | 16013 | 02:47:34 INFO - PROCESS | 16013 | Cycle 1(1): loaded http://localhost:36934/tests/dromaeo/cssquery-yui.html (next: http://localhost:36934/tests/dromaeo/cssquery-dojo.html) 02:47:34 INFO - PROCESS | 16013 | RSS: Main: 155340800 02:47:34 INFO - PROCESS | 16013 | 02:47:34 INFO - PROCESS | 16013 | __start_tp_report 02:47:34 INFO - PROCESS | 16013 | _x_x_mozilla_page_load 02:47:34 INFO - PROCESS | 16013 | _x_x_mozilla_page_load_details 02:47:34 INFO - PROCESS | 16013 | |i|pagename|runs| 02:47:34 INFO - PROCESS | 16013 | |0;dojo.html;3299.8845040423585;3354.312365964976;3356.5300857879893;3372.966270337296;3374.6287908330096;5848.619839710421;5854.151148083531;5870.354261031289;5879.441453061963;5927.644341339523;5848.093545500455;5898.203742494762;5902.232709747737;5913.704314784254;5921.20063791388;5282.049231138403;5355.7857685692525;5380.650257733254;5387;5399.865003374927;5397.190421436796;5397.8380648580605;5402.108652072423;5404.675719456825;5456.072467680484;5248.448912864152;5274.182501712241;5388.003219404403;5397.055515284809;5413.26920865684;5285.656432331905;5327.440618735035;5335.1197052486295;5363.892722145574;5428;5260.316158899319;5348.572114230852;5357.973210133963;5382.300300960889;5401.027814993299;5837.503812175928;5870.941290587082;5878.29460464747;5887;5897.351291357947;6077.453029227391;6111.816645500642;6114.144019837227;6140.412224875342;6175.722092505848;6117.522930757287;6221.253449586034;6225.8132256032395;6228.875422491525;6248.718807653621;5743.224664670216;5752.539796816244;5804.245448091721;5804.709764511757;5807.332156801979;6240.31356550779;6334.1765570475545;6352.205974253218;6356.650384228912;6375.553711240169;6166.229221347332;6167;6240;6245.5628106033055;6246.937530624727;6263.342349053375;6295.527835412362;6311.116443697886;6323.241211054611;6340.841478963062;6078.54410919174;6132.814448934737;6143.815685529441;6153.077038444269;6196.411340922605;6230.314665386803;6238.625682459067;6284.528660350492;6291.937080629135;6305.243370795534;4767.165745994506;4794.976025119852;4803;4804.42346918372;4809.062232864558;4192.7065105442325;4200.285951388271;4207.095474473003;4208.473940757405;4303.074838909587;5990.400959903975;6001.36985616504;6003.309619393825;6005.969970150121;6035.909461358083;6286.371362863677;6365.904511432333;6367.586106903036;6387.648679322682;6396.1045453636525;5841.9415805842245;5883.14694369314;5923.259592550931;6049.758009679652;6057.515398768088;5432;5481.890362192814;5485.451454854483;5487.890242195133;5501.862453438696;6551.6069035857045;6569.244536878129;6584;6586.769463068769;6586.901196482057;6117.279373342116;6129.053167990599;6374.968125159345;6377.7767778127545;6388.1376014237485;6435.742570297136;6439.8068057958335;6449.193850768654;6550.574212676161;6560.114384558024;6184.196054512884;6211.09939058843;6215.129881816459;6217.285012223471;6217.409346112112;6112.235970503687;6225.688715564294;6292.465140463112;6299.716512756845;6310.432061114522;6032.426919442646;6116.487945662287;6132.049532322497;6144.402455361549;6233.625982441068;6204.100405441276;6210.192674952408;6222.595531290452;6234.719437625227;6234.812955611339;6061;6153;6174.25908890936;6182.752689892354;6197.25632924052;5995.970020149872;6054.878902422015;6121.148138557293;6164;6193.287771906108;6039.758409663565;6087.178230938766;6090.390960904051;6098.725557350019;6130.47890929276 02:47:34 INFO - PROCESS | 16013 | |1;ext.html;573.3922042634807;607.1681795939563;631.6557476175483;661.1834384535096;661.4014317043071;43546.78226608867;45118;45184.77407612966;48124.27813582799;48565.51434485654;45510.54489455104;45670.54329456705;45845.7707711461;45970.31044534335;46151.76924115375;8735.956320218405;8913.554322283891;8914.598843052077;8929.374943753939;8947.105289471066;8783.604737786814;8827;8882.822343553125;8895.199432051115;8938.776530586721;8929.241014513775;8961.05908879568;8979.595918183697;8985.415947963395;9013.36906416551;8829.33779966505;8838.779030524223;8850;8948.463092214488;8954.776130596721;8642.827143457158;8696.608652610585;8782.38523303369;8793.252573531257;8843.77890552735;42898.356524652154;42932.78533607343;43190.78404607957;43266;43326.35010474845;3420.7263418926673;3497.720182385403;3500.3174380995715;3872.7676339419445;3968.444417781513;31775.52336714951;31940;32056.839715801503;32059.198520036953;33535.16162095943;4196.328587426027;4326.740395576276;4334.1981733379425;4365.781710914442;4394.011347446831;338170;341381;341473;342813;345086;62143.6892815533;63064;63115.36884631187;63145;63236.367636323965;65399.673001634685;65472.67263663651;65565.34434655687;66249;66423.33576664267;18218.45344639663;18353.449396518125;18425.81574184241;18456.907715461337;18652.44042678722;14351.92824035894;14424.783628245585;14428.350724217435;14444.85555144435;14452.421903123968;19031.238750450102;19179.041047947827;19196.904015479835;19214.519637008907;19232.326868559812;6396.976483762575;6500.902486462707;6753.696083676246;6762.83092922671;6776.356246156607;1009.248110157937;1039.8336266197373;1090.798202332571;1175.1538891997918;1198.676357383519;32483.83758081242;32570.837145814592;32698.67301327004;32962;33264.16839578981;1093.2238110941162;1094.1684319916922;1095.1676725688376;1111;1174.3775798826637;16449.25978330978;16799.496015119566;16831.326746929986;17169.48491545256;17178.914105429394;492761;496172;498140;498261;498822;60930.39069609336;61146.38853611407;61522.69238653778;61527.38472615306;61597.38402616006;1347.9258640774851;1371.5268232459784;1377.538524594272;1388.3127851713466;1400.9929950350183;30995.380092398478;31181.220469488446;31892.84053579717;32279.35441291114;32995.175120621214;52436.47563524316;52554.47445525496;52643.473565263856;52880.73559632177;53229.201561975824;455287;456725;457917;458290;460362;42936.78531607322;43582.56417435785;43696.78151609222;43797.78101109474;44251.557484424746;52555.47444525506;52717.20924186217;52949.735251323495;53258.73370633122;54965;41753.30121032006;43014.56985430106;43075.353869692604;43214.13571728611;43426.782866085465;42597.148057038066;43602.44535198239;43869.78065109654;44102.55897440985;44419.77790111029;40994.38508422316;41741;42579.7871010643;42801.57198428101;44809.79596700881;35449.29101418009;37914.24171516499;38049.4292585617;38225.23549529049;39131;29327.560086599144;29348.266293342836;29669.5549566761;29796.255093622833;30006 02:47:34 INFO - PROCESS | 16013 | |2;jquery.html;425.9190753756784;431.38312213534647;432.67856614856936;438.13249765464377;445.5299658859901;19560.706589401154;19788.60422791543;20496.795032049675;20579.897100514496;20675.172993080258;17690.82309176911;17725.64548709025;19209.135588898498;19785.40643780689;19886.70169947452;5211.348581427312;5389.137737961927;5399.514043736063;5419.620626556142;5429.104197807357;5238.266642670029;5308.071087559681;5358.812441564546;5407.891842163154;5410.756515956772;5397.973010134944;5400.243965844785;5403.135498320269;5406.432324605918;5416.8104116355935;5342.091844386464;5374.844408452182;5380.99999999998;5444.8366549003595;5764.855878603026;5277.86805329866;5278.577713782888;5286.735663216824;5291.735413229323;5296.761645725952;14567.198804065772;23241.88379058111;23385.298441046794;23764.287071387713;23963;2090;2280.05377768226;2294;2494.8627825469594;2809.1712944681162;10615;10660.147188225;10916.945415272872;10939.28894621847;11032.779344413148;1838.6782313095155;1855.8608104392224;1860.3488778927403;1899.9145038473303;1923.4806602217463;77687;89758.55120724355;90322;91894.08105918922;92095;11763.353015584054;11838.881611183779;11969.341686207168;12179;12249.387530623433;17048;17104.91447542779;17118.572035699206;17133.485995420157;17140.97154170754;8185.631646575918;8415.410921235578;8497.980242370955;8770.429922055173;8788.16512431318;7718.498297610638;7746.341560967268;7747.109082455477;7955.960220198977;8295;5099.566536844335;5186.144286192812;5189.351331083614;5203.687778733212;5242.97378513105;1963.528753099246;2060.6084843879617;2101.4116047506723;2108.4518025313528;2136.818370438499;968.2931460034074;982.332014230316;1018.5263852308713;1053.3627155570923;1077.6874706335232;19819.60360792805;20334.898325508573;20375.8981205096;20408.081636326402;20554;1025.3591505309182;1025.6153942271649;1031.1029404418205;1041.5937784264142;1071.9892801072046;10564.947175264075;11128.109751219883;11149.38678372681;11173.273737207055;11237.775244495064;484636;488411;492893;502357;522630;87696;98266;99427.50286248523;107363;107558;1070.5129166229347;1122.848415463902;1166.9941650291694;1168.1881092640704;1171.0865524890598;18913.621727565645;19194;19266.133024014234;19385.903070484557;19410.126544305822;46158.76920615375;46160.30759538677;46709.532904670516;46858;46976.76511617557;64810;65007;65845.0123248142;67088.66455667885;67522.66238668775;9054.27565794748;9203.309751768778;9307.20888724466;9493.525323733924;9606.807863842823;13714.314284285547;14219;14276.428942842585;14401;14428.278586070865;12487.625371238877;12519.749605007666;12542;12626.684332891751;12628.621141365773;12132.150749447454;12317.137800354247;12362.814557781461;12467.750644986869;12569.93715031419;12505.249685018927;12887.548935787203;13023.283719395145;13036.47854085826;13105.541306054241;9082.863757043517;9096.27229821626;9202.064311234564;9218.769530761516;9395.718128456158;11530.423478826193;11766.352850593299;11868.762624747284;11969.700757481132;12388.62834114978 02:47:34 INFO - PROCESS | 16013 | |3;mootools.html;1526.1911187070853;1560.2588770334091;1697.9405720799775;1805.7020591602386;1811.4475085099057;8060.073091594469;8346.582670866463;8668.34987375947;9185.678501252458;9220;8333.66665333386;8556.529390883514;8585.356098292637;8837.072107428723;8838.381313308071;2467.321486591188;2492;2498.600223964166;2508.159766478223;2513.3716570857287;2436.4030812450974;2485.888135033928;2488.042103790036;2492.9002839886475;2507.661465702134;2436.914707985221;2446.9233537243554;2466.950660986779;2481.950360992788;2483.3295010347197;2416.033586565379;2424.75752424757;2435.111184417675;2435.890384932682;2449.473363226906;2377.2749311459997;2393.3418309964727;2422.8667423291713;2437.061731233488;2440.4264997725522;8893.777655558599;9060.728178154666;9133.406328588688;9163.862542061874;9166.404183728104;5567.109262518018;5674.290713660793;5727.599068065237;5742.511886489653;5745.109508026263;3499.475078738184;3536.257385948954;3557.6442355764475;3741.9625803741887;3771.358868992278;1161.9593314234046;1170.087331881134;1183.5088438298096;1195.8804119588058;1215.6960759810047;12602.558910438182;12697.365131743376;12728.872711272954;12730.872691273062;12763.617091487178;4751.09729151467;4994.700317980933;5044.672096313801;5087.389513258433;5100.744962751922;10653.84019239712;10752.19358548112;10771.407572583426;10785.676429707122;10848.566057357775;5622.0161471742285;5628.887422251532;5657.717114144276;5661.433856614388;5672.801451949162;4484.775761211927;4936;5071.594272458195;5227.738613069408;5266.947330526722;4259.914801704011;4293.763842988603;4315.805788739514;4347.739135651871;4375.234333991539;1375.7317323122095;1392.3455975691409;1398.3497673581833;1409.9295035248401;1410.0341266232663;768.6656304507445;857.4651374040523;882.955852207387;963.1764841060932;969.8022941667035;6121.632702037892;6158.661273629904;6165.136880836686;6190.978488549339;6280;501.09302163084203;505.7294347524057;513.4480433533965;515.4253007896243;516.2308160840321;4124.572428605489;4214.978925105416;4249.617534421917;4271.978640106841;4363.389125522366;11030.28303160292;11321.490532926038;11401.543938242377;11445.542178312775;11458;11096.55613775456;11244.212905096565;11300.378479183724;11373.147013973985;11500.252483588707;8336.916630833735;8509.70216042423;8547.059823419419;8566.52884091381;8573.785655358666;6101.908471373022;6103.6032657877095;6107.816765497042;6202.255729312511;6203.565750397429;10286.022827831344;10327.173826093744;10372.68881933513;10397.11624511925;10482.842757358494;10569.577216911237;10601.575936962436;10649.254552181274;10663.733406664585;10670.57317707283;7961.283484486193;8029.919700803151;8097.919020809716;8183.508989460652;8212.301954333949;8744.344174186834;8760.561971901252;8877.866831997655;8881.866771998555;8928.464292142493;7946.40401969843;8066.475679080841;8129.065157506726;8134.064582572843;8211.17888211174;7791;7829.7259595913865;7891.960540197262;7924.564148971862;8052.557109358807;7415.443841712001;7479.214682458263;7540.359069479156;7558.2441755823975;7563.357114645317;5283.1052045201395;5366.570674345965;5372.113601255905;5472.863178420572;5514.6691198528215;5381.246625472359;5392.946070539401;5456.890862182813;5459.481349271813;5470.671759694431 02:47:34 INFO - PROCESS | 16013 | |4;prototype.html;357.11613755954016;361.3062919195145;365.89206184175663;367.1189146049479;370.4591296706806;5756.424357564241;5756.769729210831;5761.683107429089;5776.768929242825;5781.248437703098;5419.8374048778505;5578.219049333096;5639.802606908759;5656.2929633795775;5711.857203569913;4390.143921935216;4453.599176074153;4466.464024317086;4476.149531589004;4483.30508771141;4467.816028752383;4467.88830279244;4472.172648060119;4490.932636010446;4492.258777301758;4476.709013914102;4479.723278865524;4493.348464472666;4494.955050449503;4503.819847206124;4221.282381995068;4329.199098166833;4392.450943632046;4398.922264045297;4409.162259170747;3863.208042351311;3883.611638836122;3887.9805600972095;3892.4161375793856;3921.568627450978;5474.68781387259;5518.33779946405;5523.392426833045;5526.834194974117;5528.281323427928;4991.9034005717685;5024.9748751256375;5077.2637967494875;5080.898382032376;5094.261332106861;5873.383294754032;5927.051671732502;5955.464008239279;5976.372480889488;5993.820185394402;4217.219814334328;4236.491621005468;4257.552956939508;4285.693056800794;4295.2912769393015;5971.761129554812;6066.605670631395;6175.197224360849;6180.351063138396;6181.258249010148;4338.891527711769;4360.978195109004;4361.672874534423;4362.76004819738;4426.136903303889;4431.736954967819;4466.57567531084;4467.15124126415;4482.484514280834;4490.124425737015;4952.182889823139;5033.382641026646;5129.384473863161;5137.9743101285;5157.252198431282;5960.225170727865;5969.850753731104;5987.491063259672;5991.850203744854;6085.878282434415;1464.8388677245493;1468.4566710317251;1469.6472846516758;1472.5655931500232;1482.303317440801;953.8855337359422;992.2409356842022;997.4015590645699;1012.3520946594185;1018.7147598672384;5569.721513924287;5576.302962129734;5591.602099475132;5614.326280846243;5655.660660360391;5944.227250457499;5977.462028417463;5996.880062398727;6010.3554436048;6020.447935717947;5435.755391007414;5534.695591742412;5538.086215774352;5578.219049333096;5599.8600034998635;3146.9685303147135;3152.7477801775804;3170.682931706857;3189.5056266278766;3189.9681003190135;6000.239889650809;6111.54163437744;6186.072089186658;6218.502519798405;6234.937650623527;5989.263113697066;6011.729472173763;6013.338532761392;6018.759249629966;6069.271687397452;6136.938630613637;6137.629574122643;6158.907616385758;6194.99999999991;6246.406591373812;5651.180578816131;5859.091840764689;5859.5019423349495;5874.651448674214;5937.762489500372;5872.354041055566;5873.970630146822;5910.349861515316;5936.495397891227;5968;6224.782132625336;6334.588251763621;6361.459275961595;6387.297397286387;6409.775657852139;4415.183191109655;4456.131054444352;4470.1059788041875;4473.642108631367;4487.1282379277945;6113.84715382119;6136.32500424944;6189.319174890668;6235.875282494416;6242.687865606792;5968.104784282219;5974.566104134889;5986.551008674454;6020.314311992649;6043.22011874525;5991.580589358703;6017.819465416044;6036.275646922398;6041.909371359521;6050.183225264709;5714.314282286152;5938.138969849261;5963.2844058713235;5978.372270911492;5983.820485385445;5994.160817485643;6040.818775436744;6072.878542429038;6097.359777223328;6129.77404519089;5626.324841019104;5872.768348027722;5893.44012318829;5994.790182343597;5998 02:47:34 INFO - PROCESS | 16013 | |5;yui.html;694.2883544367023;749.9025126733524;752.6725874244702;775.8448310337932;783.8667426537488;15414.84585154148;15617.453389131382;15630;15681.921590392047;15748.527544173665;14764.852351476482;14932.178730169837;14952.925235373808;14964.775528367083;14965.551033468986;693.7121094745687;708.8050786033831;826.8098337382405;838.7316058861136;850.3537311643134;847.2798121596655;849.413904405961;850.1795767084762;853.0829358439702;858.6222062292571;889.3685483306828;891.4339394484484;891.8974317953454;892.0633334998258;894.4767311123001;883.8188171424842;884.045231150356;884.0938038510546;884.4339622641514;885.4554449013874;648.6432462145801;650.7364517370426;654.1136759690598;654.2868273581819;656.7044829826549;14443.78334324986;14509.637259068502;14597.489087881979;14608.488702895347;15777.29002194904;11686.649400517997;14090.154590724589;14257.572272831832;14347.354369053417;14363.497277595234;10767.138628909668;10946.890531094667;11037.668869933916;11067.059299959514;11068.39123848188;3488.164801426151;3494.3011397720556;3552.6980206682465;3565.4295312749837;3643.9635603644156;62945.370546294405;64799;66515;66746.66626666836;66886.3311366885;10353;10409.27135100551;10458.424786636655;10511.52698128586;10612.469376531142;19062.046897655062;19832;20017.699734503993;20037.699434508493;20044.198232070845;7728.8454230916195;8032.4778889372;8045.9597702011115;8174.67301307941;8218;4467.5755803198645;4472.329150627432;4480.61914737251;4501.476627521958;4554.795034223468;3549.804760738184;3611.476335931328;3627.3108109459645;3644.4351125575577;3674.9816250918575;626.6396821827467;635.6313338263795;636.3858876184504;653.6796969484918;655.2170156662837;644.8130042287778;669.4778073102988;753.0361137743697;753.4838635534676;764.537380416918;9428.15146636806;9765.267604929517;9835.3115281931;9920.603175873028;10111.443870587189;612.2652816620074;627.679269753577;739.3826155160393;761.2311565318957;779.8011507065662;4319.157764235943;4321.719088259253;4402.911941761146;4612.0545288215835;4644.790984405642;54588.454115458335;58388;87832.68250976241;89019.55490222508;90997;78246;79506;80710.5964470174;81590;83364.58317708493;67958.98061529081;68235.31764682289;68827.3117268831;71168.64415677992;72386.27613723795;8871.866921996305;8886.244669202932;8910.331725120512;8962.417442866194;9363;48026.9999999986;48156.27765583449;48355.5164448351;49690;50394.244086338;64457.67771161114;65866;65890.34109659033;67763;67879.3212067873;11404.258723182966;11477.426128693698;11596.594119205787;11703.180777345504;12147.635570932885;13097.869021309665;13452.058355914993;13462.663433414244;13541.86458135406;13601.251931143883;12154.696132596755;12190.878091219329;12197.939010304892;12375.381230938237;12614;11183.776324473627;11580.942095289469;11591.362475063952;11677.88322116768;12153;12551.87448125507;12715.173513721578;12738.87261127377;12821.423035963218;12833.614991550268;9749.415035097916;9899.65351212704;10033.749156271151;10121.848172277274;10269.74325641865;9721.611135554498;10164.79670406573;10170.542325595217;10205.795884082128;10218.233632477743 02:47:34 INFO - PROCESS | 16013 | __end_tp_report 02:47:34 INFO - PROCESS | 16013 | __start_cc_report 02:47:34 INFO - PROCESS | 16013 | _x_x_mozilla_cycle_collect,327 02:47:34 INFO - PROCESS | 16013 | __end_cc_report 02:47:34 INFO - PROCESS | 16013 | __startTimestamp1482835654444__endTimestamp 02:47:34 INFO - PROCESS | 16013 | 02:47:34 INFO - PROCESS | 16013 | ------- Summary: start ------- 02:47:34 INFO - PROCESS | 16013 | Number of tests: 6 02:47:34 INFO - PROCESS | 16013 | 02:47:34 INFO - PROCESS | 16013 | [#0] dojo.html Cycles:165 Average:5833.50 Median:6087.18 stddev:666.52 (10.9%) stddev-sans-first:638.24 02:47:34 INFO - PROCESS | 16013 | Values: 3299.9 3354.3 3356.5 3373.0 3374.6 5848.6 5854.2 5870.4 5879.4 5927.6 5848.1 5898.2 5902.2 5913.7 5921.2 5282.0 5355.8 5380.7 5387.0 5399.9 5397.2 5397.8 5402.1 5404.7 5456.1 5248.4 5274.2 5388.0 5397.1 5413.3 5285.7 5327.4 5335.1 5363.9 5428.0 5260.3 5348.6 5358.0 5382.3 5401.0 5837.5 5870.9 5878.3 5887.0 5897.4 6077.5 6111.8 6114.1 6140.4 6175.7 6117.5 6221.3 6225.8 6228.9 6248.7 5743.2 5752.5 5804.2 5804.7 5807.3 6240.3 6334.2 6352.2 6356.7 6375.6 6166.2 6167.0 6240.0 6245.6 6246.9 6263.3 6295.5 6311.1 6323.2 6340.8 6078.5 6132.8 6143.8 6153.1 6196.4 6230.3 6238.6 6284.5 6291.9 6305.2 4767.2 4795.0 4803.0 4804.4 4809.1 4192.7 4200.3 4207.1 4208.5 4303.1 5990.4 6001.4 6003.3 6006.0 6035.9 6286.4 6365.9 6367.6 6387.6 6396.1 5841.9 5883.1 5923.3 6049.8 6057.5 5432.0 5481.9 5485.5 5487.9 5501.9 6551.6 6569.2 6584.0 6586.8 6586.9 6117.3 6129.1 6375.0 6377.8 6388.1 6435.7 6439.8 6449.2 6550.6 6560.1 6184.2 6211.1 6215.1 6217.3 6217.4 6112.2 6225.7 6292.5 6299.7 6310.4 6032.4 6116.5 6132.0 6144.4 6233.6 6204.1 6210.2 6222.6 6234.7 6234.8 6061.0 6153.0 6174.3 6182.8 6197.3 5996.0 6054.9 6121.1 6164.0 6193.3 6039.8 6087.2 6090.4 6098.7 6130.5 02:47:34 INFO - PROCESS | 16013 | 02:47:34 INFO - PROCESS | 16013 | [#1] ext.html Cycles:180 Average:61022.48 Median:43592.50 stddev:115487.42 (264.9%) stddev-sans-first:115722.21 02:47:34 INFO - PROCESS | 16013 | Values: 573.4 607.2 631.7 661.2 661.4 43546.8 45118.0 45184.8 48124.3 48565.5 45510.5 45670.5 45845.8 45970.3 46151.8 8736.0 8913.6 8914.6 8929.4 8947.1 8783.6 8827.0 8882.8 8895.2 8938.8 8929.2 8961.1 8979.6 8985.4 9013.4 8829.3 8838.8 8850.0 8948.5 8954.8 8642.8 8696.6 8782.4 8793.3 8843.8 42898.4 42932.8 43190.8 43266.0 43326.4 3420.7 3497.7 3500.3 3872.8 3968.4 31775.5 31940.0 32056.8 32059.2 33535.2 4196.3 4326.7 4334.2 4365.8 4394.0 338170.0 341381.0 341473.0 342813.0 345086.0 62143.7 63064.0 63115.4 63145.0 63236.4 65399.7 65472.7 65565.3 66249.0 66423.3 18218.5 18353.4 18425.8 18456.9 18652.4 14351.9 14424.8 14428.4 14444.9 14452.4 19031.2 19179.0 19196.9 19214.5 19232.3 6397.0 6500.9 6753.7 6762.8 6776.4 1009.2 1039.8 1090.8 1175.2 1198.7 32483.8 32570.8 32698.7 32962.0 33264.2 1093.2 1094.2 1095.2 1111.0 1174.4 16449.3 16799.5 16831.3 17169.5 17178.9 492761.0 496172.0 498140.0 498261.0 498822.0 60930.4 61146.4 61522.7 61527.4 61597.4 1347.9 1371.5 1377.5 1388.3 1401.0 30995.4 31181.2 31892.8 32279.4 32995.2 52436.5 52554.5 52643.5 52880.7 53229.2 455287.0 456725.0 457917.0 458290.0 460362.0 42936.8 43582.6 43696.8 43797.8 44251.6 52555.5 52717.2 52949.7 53258.7 54965.0 41753.3 43014.6 43075.4 43214.1 43426.8 42597.1 43602.4 43869.8 44102.6 44419.8 40994.4 41741.0 42579.8 42801.6 44809.8 35449.3 37914.2 38049.4 38225.2 39131.0 29327.6 29348.3 29669.6 29796.3 30006.0 02:47:34 INFO - PROCESS | 16013 | 02:47:34 INFO - PROCESS | 16013 | [#2] jquery.html Cycles:180 Average:30320.99 Median:2122.64 stddev:82512.73 (3887.3%) stddev-sans-first:82713.66 02:47:34 INFO - PROCESS | 16013 | Values: 425.9 431.4 432.7 438.1 445.5 19560.7 19788.6 20496.8 20579.9 20675.2 17690.8 17725.6 19209.1 19785.4 19886.7 5211.3 5389.1 5399.5 5419.6 5429.1 5238.3 5308.1 5358.8 5407.9 5410.8 5398.0 5400.2 5403.1 5406.4 5416.8 5342.1 5374.8 5381.0 5444.8 5764.9 5277.9 5278.6 5286.7 5291.7 5296.8 14567.2 23241.9 23385.3 23764.3 23963.0 2090.0 2280.1 2294.0 2494.9 2809.2 10615.0 10660.1 10916.9 10939.3 11032.8 1838.7 1855.9 1860.3 1899.9 1923.5 77687.0 89758.6 90322.0 91894.1 92095.0 11763.4 11838.9 11969.3 12179.0 12249.4 17048.0 17104.9 17118.6 17133.5 17141.0 8185.6 8415.4 8498.0 8770.4 8788.2 7718.5 7746.3 7747.1 7956.0 8295.0 5099.6 5186.1 5189.4 5203.7 5243.0 1963.5 2060.6 2101.4 2108.5 2136.8 968.3 982.3 1018.5 1053.4 1077.7 19819.6 20334.9 20375.9 20408.1 20554.0 1025.4 1025.6 1031.1 1041.6 1072.0 10564.9 11128.1 11149.4 11173.3 11237.8 484636.0 488411.0 492893.0 502357.0 522630.0 87696.0 98266.0 99427.5 107363.0 107558.0 1070.5 1122.8 1167.0 1168.2 1171.1 18913.6 19194.0 19266.1 19385.9 19410.1 46158.8 46160.3 46709.5 46858.0 46976.8 64810.0 65007.0 65845.0 67088.7 67522.7 9054.3 9203.3 9307.2 9493.5 9606.8 13714.3 14219.0 14276.4 14401.0 14428.3 12487.6 12519.7 12542.0 12626.7 12628.6 12132.2 12317.1 12362.8 12467.8 12569.9 12505.2 12887.5 13023.3 13036.5 13105.5 9082.9 9096.3 9202.1 9218.8 9395.7 11530.4 11766.4 11868.8 11969.7 12388.6 02:47:34 INFO - PROCESS | 16013 | 02:47:34 INFO - PROCESS | 16013 | [#3] mootools.html Cycles:180 Average:6030.36 Median:2775.20 stddev:3402.74 (122.6%) stddev-sans-first:3395.45 02:47:34 INFO - PROCESS | 16013 | Values: 1526.2 1560.3 1697.9 1805.7 1811.4 8060.1 8346.6 8668.3 9185.7 9220.0 8333.7 8556.5 8585.4 8837.1 8838.4 2467.3 2492.0 2498.6 2508.2 2513.4 2436.4 2485.9 2488.0 2492.9 2507.7 2436.9 2446.9 2467.0 2482.0 2483.3 2416.0 2424.8 2435.1 2435.9 2449.5 2377.3 2393.3 2422.9 2437.1 2440.4 8893.8 9060.7 9133.4 9163.9 9166.4 5567.1 5674.3 5727.6 5742.5 5745.1 3499.5 3536.3 3557.6 3742.0 3771.4 1162.0 1170.1 1183.5 1195.9 1215.7 12602.6 12697.4 12728.9 12730.9 12763.6 4751.1 4994.7 5044.7 5087.4 5100.7 10653.8 10752.2 10771.4 10785.7 10848.6 5622.0 5628.9 5657.7 5661.4 5672.8 4484.8 4936.0 5071.6 5227.7 5266.9 4259.9 4293.8 4315.8 4347.7 4375.2 1375.7 1392.3 1398.3 1409.9 1410.0 768.7 857.5 883.0 963.2 969.8 6121.6 6158.7 6165.1 6191.0 6280.0 501.1 505.7 513.4 515.4 516.2 4124.6 4215.0 4249.6 4272.0 4363.4 11030.3 11321.5 11401.5 11445.5 11458.0 11096.6 11244.2 11300.4 11373.1 11500.3 8336.9 8509.7 8547.1 8566.5 8573.8 6101.9 6103.6 6107.8 6202.3 6203.6 10286.0 10327.2 10372.7 10397.1 10482.8 10569.6 10601.6 10649.3 10663.7 10670.6 7961.3 8029.9 8097.9 8183.5 8212.3 8744.3 8760.6 8877.9 8881.9 8928.5 7946.4 8066.5 8129.1 8134.1 8211.2 7791.0 7829.7 7892.0 7924.6 8052.6 7415.4 7479.2 7540.4 7558.2 7563.4 5283.1 5366.6 5372.1 5472.9 5514.7 5381.2 5392.9 5456.9 5459.5 5470.7 02:47:34 INFO - PROCESS | 16013 | 02:47:34 INFO - PROCESS | 16013 | [#4] prototype.html Cycles:180 Average:4998.13 Median:5653.42 stddev:1463.80 (25.9%) stddev-sans-first:1425.86 02:47:34 INFO - PROCESS | 16013 | Values: 357.1 361.3 365.9 367.1 370.5 5756.4 5756.8 5761.7 5776.8 5781.2 5419.8 5578.2 5639.8 5656.3 5711.9 4390.1 4453.6 4466.5 4476.1 4483.3 4467.8 4467.9 4472.2 4490.9 4492.3 4476.7 4479.7 4493.3 4495.0 4503.8 4221.3 4329.2 4392.5 4398.9 4409.2 3863.2 3883.6 3888.0 3892.4 3921.6 5474.7 5518.3 5523.4 5526.8 5528.3 4991.9 5025.0 5077.3 5080.9 5094.3 5873.4 5927.1 5955.5 5976.4 5993.8 4217.2 4236.5 4257.6 4285.7 4295.3 5971.8 6066.6 6175.2 6180.4 6181.3 4338.9 4361.0 4361.7 4362.8 4426.1 4431.7 4466.6 4467.2 4482.5 4490.1 4952.2 5033.4 5129.4 5138.0 5157.3 5960.2 5969.9 5987.5 5991.9 6085.9 1464.8 1468.5 1469.6 1472.6 1482.3 953.9 992.2 997.4 1012.4 1018.7 5569.7 5576.3 5591.6 5614.3 5655.7 5944.2 5977.5 5996.9 6010.4 6020.4 5435.8 5534.7 5538.1 5578.2 5599.9 3147.0 3152.7 3170.7 3189.5 3190.0 6000.2 6111.5 6186.1 6218.5 6234.9 5989.3 6011.7 6013.3 6018.8 6069.3 6136.9 6137.6 6158.9 6195.0 6246.4 5651.2 5859.1 5859.5 5874.7 5937.8 5872.4 5874.0 5910.3 5936.5 5968.0 6224.8 6334.6 6361.5 6387.3 6409.8 4415.2 4456.1 4470.1 4473.6 4487.1 6113.8 6136.3 6189.3 6235.9 6242.7 5968.1 5974.6 5986.6 6020.3 6043.2 5991.6 6017.8 6036.3 6041.9 6050.2 5714.3 5938.1 5963.3 5978.4 5983.8 5994.2 6040.8 6072.9 6097.4 6129.8 5626.3 5872.8 5893.4 5994.8 5998.0 02:47:34 INFO - PROCESS | 16013 | 02:47:34 INFO - PROCESS | 16013 | [#5] yui.html Cycles:180 Average:17763.72 Median:49022.76 stddev:23613.02 (48.2%) stddev-sans-first:23644.48 02:47:34 INFO - PROCESS | 16013 | Values: 694.3 749.9 752.7 775.8 783.9 15414.8 15617.5 15630.0 15681.9 15748.5 14764.9 14932.2 14952.9 14964.8 14965.6 693.7 708.8 826.8 838.7 850.4 847.3 849.4 850.2 853.1 858.6 889.4 891.4 891.9 892.1 894.5 883.8 884.0 884.1 884.4 885.5 648.6 650.7 654.1 654.3 656.7 14443.8 14509.6 14597.5 14608.5 15777.3 11686.6 14090.2 14257.6 14347.4 14363.5 10767.1 10946.9 11037.7 11067.1 11068.4 3488.2 3494.3 3552.7 3565.4 3644.0 62945.4 64799.0 66515.0 66746.7 66886.3 10353.0 10409.3 10458.4 10511.5 10612.5 19062.0 19832.0 20017.7 20037.7 20044.2 7728.8 8032.5 8046.0 8174.7 8218.0 4467.6 4472.3 4480.6 4501.5 4554.8 3549.8 3611.5 3627.3 3644.4 3675.0 626.6 635.6 636.4 653.7 655.2 644.8 669.5 753.0 753.5 764.5 9428.2 9765.3 9835.3 9920.6 10111.4 612.3 627.7 739.4 761.2 779.8 4319.2 4321.7 4402.9 4612.1 4644.8 54588.5 58388.0 87832.7 89019.6 90997.0 78246.0 79506.0 80710.6 81590.0 83364.6 67959.0 68235.3 68827.3 71168.6 72386.3 8871.9 8886.2 8910.3 8962.4 9363.0 48027.0 48156.3 48355.5 49690.0 50394.2 64457.7 65866.0 65890.3 67763.0 67879.3 11404.3 11477.4 11596.6 11703.2 12147.6 13097.9 13452.1 13462.7 13541.9 13601.3 12154.7 12190.9 12197.9 12375.4 12614.0 11183.8 11580.9 11591.4 11677.9 12153.0 12551.9 12715.2 12738.9 12821.4 12833.6 9749.4 9899.7 10033.7 10121.8 10269.7 9721.6 10164.8 10170.5 10205.8 10218.2 02:47:34 INFO - PROCESS | 16013 | -------- Summary: end -------- 02:47:34 INFO - PROCESS | 16013 | 02:47:35 INFO - TEST-INFO | 16013: exit 0 02:47:35 INFO - TEST-OK | dromaeo_css | took 1113443ms 02:47:35 INFO - TEST-START | kraken 02:47:35 INFO - operating with platform_type : linux_ 02:47:35 INFO - Initialising browser for kraken test... 02:47:35 INFO - TEST-INFO | started process 16391 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFDsY9Z/profile http://localhost:36934/getInfo.html) 02:47:39 INFO - PROCESS | 16391 | __metrics Screen width/height:1600/1200 02:47:39 INFO - PROCESS | 16391 | colorDepth:24 02:47:39 INFO - PROCESS | 16391 | Browser inner width/height: 1024/697 02:47:39 INFO - PROCESS | 16391 | __metrics 02:47:40 ERROR - PROCESS | 16391 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 02:47:40 INFO - TEST-INFO | 16391: exit 0 02:47:40 INFO - Browser initialized. 02:47:40 INFO - Running cycle 1/1 for kraken test... 02:47:40 INFO - TEST-INFO | started process 16526 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFDsY9Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:47:52 INFO - PROCESS | 16526 | RSS: Main: 152383488 02:47:52 INFO - PROCESS | 16526 | 02:47:55 INFO - PROCESS | 16526 | Cycle 1(1): loaded http://localhost:36934/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36934/tests/kraken/driver.html?testName=audio-beat-detection) 02:47:56 INFO - PROCESS | 16526 | RSS: Main: 157114368 02:47:56 INFO - PROCESS | 16526 | 02:47:58 INFO - PROCESS | 16526 | Cycle 1(1): loaded http://localhost:36934/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36934/tests/kraken/driver.html?testName=audio-dft) 02:47:59 INFO - PROCESS | 16526 | RSS: Main: 155332608 02:47:59 INFO - PROCESS | 16526 | 02:48:02 INFO - PROCESS | 16526 | Cycle 1(1): loaded http://localhost:36934/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36934/tests/kraken/driver.html?testName=audio-fft) 02:48:02 INFO - PROCESS | 16526 | RSS: Main: 156135424 02:48:02 INFO - PROCESS | 16526 | 02:48:04 INFO - PROCESS | 16526 | Cycle 1(1): loaded http://localhost:36934/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36934/tests/kraken/driver.html?testName=audio-oscillator) 02:48:05 INFO - PROCESS | 16526 | RSS: Main: 155717632 02:48:05 INFO - PROCESS | 16526 | 02:48:07 INFO - PROCESS | 16526 | Cycle 1(1): loaded http://localhost:36934/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36934/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:48:08 INFO - PROCESS | 16526 | RSS: Main: 155365376 02:48:08 INFO - PROCESS | 16526 | 02:48:11 INFO - PROCESS | 16526 | Cycle 1(1): loaded http://localhost:36934/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36934/tests/kraken/driver.html?testName=imaging-darkroom) 02:48:11 INFO - PROCESS | 16526 | RSS: Main: 158507008 02:48:11 INFO - PROCESS | 16526 | 02:48:15 INFO - PROCESS | 16526 | Cycle 1(1): loaded http://localhost:36934/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36934/tests/kraken/driver.html?testName=imaging-desaturate) 02:48:15 INFO - PROCESS | 16526 | RSS: Main: 158384128 02:48:15 INFO - PROCESS | 16526 | 02:48:18 INFO - PROCESS | 16526 | Cycle 1(1): loaded http://localhost:36934/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36934/tests/kraken/driver.html?testName=json-parse-financial) 02:48:19 INFO - PROCESS | 16526 | RSS: Main: 158629888 02:48:19 INFO - PROCESS | 16526 | 02:48:20 INFO - PROCESS | 16526 | Cycle 1(1): loaded http://localhost:36934/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36934/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:48:21 INFO - PROCESS | 16526 | RSS: Main: 157446144 02:48:21 INFO - PROCESS | 16526 | 02:48:23 INFO - PROCESS | 16526 | Cycle 1(1): loaded http://localhost:36934/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36934/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:48:23 INFO - PROCESS | 16526 | RSS: Main: 158113792 02:48:23 INFO - PROCESS | 16526 | 02:48:25 INFO - PROCESS | 16526 | Cycle 1(1): loaded http://localhost:36934/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36934/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:48:26 INFO - PROCESS | 16526 | RSS: Main: 157798400 02:48:26 INFO - PROCESS | 16526 | 02:48:28 INFO - PROCESS | 16526 | Cycle 1(1): loaded http://localhost:36934/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36934/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:48:29 INFO - PROCESS | 16526 | RSS: Main: 157691904 02:48:29 INFO - PROCESS | 16526 | 02:48:32 INFO - PROCESS | 16526 | Cycle 1(1): loaded http://localhost:36934/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36934/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:48:32 INFO - PROCESS | 16526 | RSS: Main: 158101504 02:48:32 INFO - PROCESS | 16526 | 02:48:34 INFO - PROCESS | 16526 | Cycle 1(1): loaded http://localhost:36934/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36934/tests/kraken/driver.html?testName=ai-astar) 02:48:34 INFO - PROCESS | 16526 | RSS: Main: 159662080 02:48:34 INFO - PROCESS | 16526 | 02:48:34 INFO - PROCESS | 16526 | __start_tp_report 02:48:34 INFO - PROCESS | 16526 | _x_x_mozilla_page_load 02:48:34 INFO - PROCESS | 16526 | _x_x_mozilla_page_load_details 02:48:34 INFO - PROCESS | 16526 | |i|pagename|runs| 02:48:34 INFO - PROCESS | 16526 | |0;ai-astar;107;115;111;112;113;111;112;113;112;114 02:48:34 INFO - PROCESS | 16526 | |1;audio-beat-detection;146;122;128;160;124;118;117;123;154;121 02:48:34 INFO - PROCESS | 16526 | |2;audio-dft;164;162;164;163;161;163;164;164;164;164 02:48:34 INFO - PROCESS | 16526 | |3;audio-fft;75;74;75;103;76;77;75;76;95;77 02:48:34 INFO - PROCESS | 16526 | |4;audio-oscillator;82;80;116;81;83;81;96;82;81;111 02:48:34 INFO - PROCESS | 16526 | |5;imaging-gaussian-blur;118;120;118;119;118;118;118;118;117;117 02:48:34 INFO - PROCESS | 16526 | |6;imaging-darkroom;147;147;147;148;148;147;147;147;149;147 02:48:34 INFO - PROCESS | 16526 | |7;imaging-desaturate;86;86;86;86;85;84;85;85;86;85 02:48:34 INFO - PROCESS | 16526 | |8;json-parse-financial;52;52;57;52;52;52;55;52;52;52 02:48:34 INFO - PROCESS | 16526 | |9;json-stringify-tinderbox;59;60;59;59;59;58;59;59;59;59 02:48:34 INFO - PROCESS | 16526 | |10;stanford-crypto-aes;75;77;77;81;77;73;74;75;73;79 02:48:34 INFO - PROCESS | 16526 | |11;stanford-crypto-ccm;122;123;132;132;127;120;124;121;174;123 02:48:34 INFO - PROCESS | 16526 | |12;stanford-crypto-pbkdf2;165;156;157;161;158;153;155;155;155;154 02:48:34 INFO - PROCESS | 16526 | |13;stanford-crypto-sha256-iterative;62;63;65;67;63;62;63;62;61;70 02:48:34 INFO - PROCESS | 16526 | __end_tp_report 02:48:34 INFO - PROCESS | 16526 | __start_cc_report 02:48:34 INFO - PROCESS | 16526 | _x_x_mozilla_cycle_collect,826 02:48:34 INFO - PROCESS | 16526 | __end_cc_report 02:48:34 INFO - PROCESS | 16526 | __startTimestamp1482835714778__endTimestamp 02:48:34 INFO - PROCESS | 16526 | 02:48:34 INFO - PROCESS | 16526 | ------- Summary: start ------- 02:48:34 INFO - PROCESS | 16526 | Number of tests: 14 02:48:34 INFO - PROCESS | 16526 | 02:48:34 INFO - PROCESS | 16526 | [#0] ai-astar Cycles:10 Average:112.00 Median:112.50 stddev:2.16 (1.9%) stddev-sans-first:1.33 02:48:34 INFO - PROCESS | 16526 | Values: 107.0 115.0 111.0 112.0 113.0 111.0 112.0 113.0 112.0 114.0 02:48:34 INFO - PROCESS | 16526 | 02:48:34 INFO - PROCESS | 16526 | [#1] audio-beat-detection Cycles:10 Average:131.30 Median:126.00 stddev:15.85 (12.6%) stddev-sans-first:15.90 02:48:34 INFO - PROCESS | 16526 | Values: 146.0 122.0 128.0 160.0 124.0 118.0 117.0 123.0 154.0 121.0 02:48:34 INFO - PROCESS | 16526 | 02:48:34 INFO - PROCESS | 16526 | [#2] audio-dft Cycles:10 Average:163.30 Median:164.00 stddev:1.06 (0.6%) stddev-sans-first:1.09 02:48:34 INFO - PROCESS | 16526 | Values: 164.0 162.0 164.0 163.0 161.0 163.0 164.0 164.0 164.0 164.0 02:48:34 INFO - PROCESS | 16526 | 02:48:34 INFO - PROCESS | 16526 | [#3] audio-fft Cycles:10 Average:80.30 Median:76.00 stddev:10.08 (13.3%) stddev-sans-first:10.51 02:48:34 INFO - PROCESS | 16526 | Values: 75.0 74.0 75.0 103.0 76.0 77.0 75.0 76.0 95.0 77.0 02:48:34 INFO - PROCESS | 16526 | 02:48:34 INFO - PROCESS | 16526 | [#4] audio-oscillator Cycles:10 Average:89.30 Median:81.50 stddev:13.61 (16.7%) stddev-sans-first:14.18 02:48:34 INFO - PROCESS | 16526 | Values: 82.0 80.0 116.0 81.0 83.0 81.0 96.0 82.0 81.0 111.0 02:48:34 INFO - PROCESS | 16526 | 02:48:34 INFO - PROCESS | 16526 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.88 (0.7%) stddev-sans-first:0.93 02:48:34 INFO - PROCESS | 16526 | Values: 118.0 120.0 118.0 119.0 118.0 118.0 118.0 118.0 117.0 117.0 02:48:34 INFO - PROCESS | 16526 | 02:48:34 INFO - PROCESS | 16526 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 02:48:34 INFO - PROCESS | 16526 | Values: 147.0 147.0 147.0 148.0 148.0 147.0 147.0 147.0 149.0 147.0 02:48:34 INFO - PROCESS | 16526 | 02:48:34 INFO - PROCESS | 16526 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:86.00 stddev:0.70 (0.8%) stddev-sans-first:0.71 02:48:34 INFO - PROCESS | 16526 | Values: 86.0 86.0 86.0 86.0 85.0 84.0 85.0 85.0 86.0 85.0 02:48:34 INFO - PROCESS | 16526 | 02:48:34 INFO - PROCESS | 16526 | [#8] json-parse-financial Cycles:10 Average:52.80 Median:52.00 stddev:1.75 (3.4%) stddev-sans-first:1.83 02:48:34 INFO - PROCESS | 16526 | Values: 52.0 52.0 57.0 52.0 52.0 52.0 55.0 52.0 52.0 52.0 02:48:34 INFO - PROCESS | 16526 | 02:48:34 INFO - PROCESS | 16526 | [#9] json-stringify-tinderbox Cycles:10 Average:59.00 Median:59.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 02:48:34 INFO - PROCESS | 16526 | Values: 59.0 60.0 59.0 59.0 59.0 58.0 59.0 59.0 59.0 59.0 02:48:34 INFO - PROCESS | 16526 | 02:48:34 INFO - PROCESS | 16526 | [#10] stanford-crypto-aes Cycles:10 Average:76.10 Median:77.00 stddev:2.60 (3.4%) stddev-sans-first:2.73 02:48:34 INFO - PROCESS | 16526 | Values: 75.0 77.0 77.0 81.0 77.0 73.0 74.0 75.0 73.0 79.0 02:48:34 INFO - PROCESS | 16526 | 02:48:34 INFO - PROCESS | 16526 | [#11] stanford-crypto-ccm Cycles:10 Average:129.80 Median:125.50 stddev:16.10 (12.8%) stddev-sans-first:16.82 02:48:34 INFO - PROCESS | 16526 | Values: 122.0 123.0 132.0 132.0 127.0 120.0 124.0 121.0 174.0 123.0 02:48:34 INFO - PROCESS | 16526 | 02:48:34 INFO - PROCESS | 16526 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.90 Median:156.50 stddev:3.63 (2.3%) stddev-sans-first:2.40 02:48:34 INFO - PROCESS | 16526 | Values: 165.0 156.0 157.0 161.0 158.0 153.0 155.0 155.0 155.0 154.0 02:48:34 INFO - PROCESS | 16526 | 02:48:34 INFO - PROCESS | 16526 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:63.00 stddev:2.78 (4.4%) stddev-sans-first:2.87 02:48:34 INFO - PROCESS | 16526 | Values: 62.0 63.0 65.0 67.0 63.0 62.0 63.0 62.0 61.0 70.0 02:48:34 INFO - PROCESS | 16526 | -------- Summary: end -------- 02:48:34 INFO - PROCESS | 16526 | 02:48:35 INFO - TEST-INFO | 16526: exit 0 02:48:35 INFO - TEST-OK | kraken | took 60595ms 02:48:35 INFO - SUITE-END | took 1174s 02:48:35 INFO - Completed test suite (00:19:34) 02:48:35 INFO - javascript benchmark 02:48:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7503.5125016311395, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3299.8845040423585, 3354.312365964976, 3356.5300857879893, 3372.966270337296, 3374.6287908330096, 5848.619839710421, 5854.151148083531, 5870.354261031289, 5879.441453061963, 5927.644341339523, 5848.093545500455, 5898.203742494762, 5902.232709747737, 5913.704314784254, 5921.20063791388, 5282.049231138403, 5355.7857685692525, 5380.650257733254, 5387.0, 5399.865003374927, 5397.190421436796, 5397.8380648580605, 5402.108652072423, 5404.675719456825, 5456.072467680484, 5248.448912864152, 5274.182501712241, 5388.003219404403, 5397.055515284809, 5413.26920865684, 5285.656432331905, 5327.440618735035, 5335.1197052486295, 5363.892722145574, 5428.0, 5260.316158899319, 5348.572114230852, 5357.973210133963, 5382.300300960889, 5401.027814993299, 5837.503812175928, 5870.941290587082, 5878.29460464747, 5887.0, 5897.351291357947, 6077.453029227391, 6111.816645500642, 6114.144019837227, 6140.412224875342, 6175.722092505848, 6117.522930757287, 6221.253449586034, 6225.8132256032395, 6228.875422491525, 6248.718807653621, 5743.224664670216, 5752.539796816244, 5804.245448091721, 5804.709764511757, 5807.332156801979, 6240.31356550779, 6334.1765570475545, 6352.205974253218, 6356.650384228912, 6375.553711240169, 6166.229221347332, 6167.0, 6240.0, 6245.5628106033055, 6246.937530624727, 6263.342349053375, 6295.527835412362, 6311.116443697886, 6323.241211054611, 6340.841478963062, 6078.54410919174, 6132.814448934737, 6143.815685529441, 6153.077038444269, 6196.411340922605, 6230.314665386803, 6238.625682459067, 6284.528660350492, 6291.937080629135, 6305.243370795534, 4767.165745994506, 4794.976025119852, 4803.0, 4804.42346918372, 4809.062232864558, 4192.7065105442325, 4200.285951388271, 4207.095474473003, 4208.473940757405, 4303.074838909587, 5990.400959903975, 6001.36985616504, 6003.309619393825, 6005.969970150121, 6035.909461358083, 6286.371362863677, 6365.904511432333, 6367.586106903036, 6387.648679322682, 6396.1045453636525, 5841.9415805842245, 5883.14694369314, 5923.259592550931, 6049.758009679652, 6057.515398768088, 5432.0, 5481.890362192814, 5485.451454854483, 5487.890242195133, 5501.862453438696, 6551.6069035857045, 6569.244536878129, 6584.0, 6586.769463068769, 6586.901196482057, 6117.279373342116, 6129.053167990599, 6374.968125159345, 6377.7767778127545, 6388.1376014237485, 6435.742570297136, 6439.8068057958335, 6449.193850768654, 6550.574212676161, 6560.114384558024, 6184.196054512884, 6211.09939058843, 6215.129881816459, 6217.285012223471, 6217.409346112112, 6112.235970503687, 6225.688715564294, 6292.465140463112, 6299.716512756845, 6310.432061114522, 6032.426919442646, 6116.487945662287, 6132.049532322497, 6144.402455361549, 6233.625982441068, 6204.100405441276, 6210.192674952408, 6222.595531290452, 6234.719437625227, 6234.812955611339, 6061.0, 6153.0, 6174.25908890936, 6182.752689892354, 6197.25632924052, 5995.970020149872, 6054.878902422015, 6121.148138557293, 6164.0, 6193.287771906108, 6039.758409663565, 6087.178230938766, 6090.390960904051, 6098.725557350019, 6130.47890929276], "value": 5787.612246830181, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.3922042634807, 607.1681795939563, 631.6557476175483, 661.1834384535096, 661.4014317043071, 43546.78226608867, 45118.0, 45184.77407612966, 48124.27813582799, 48565.51434485654, 45510.54489455104, 45670.54329456705, 45845.7707711461, 45970.31044534335, 46151.76924115375, 8735.956320218405, 8913.554322283891, 8914.598843052077, 8929.374943753939, 8947.105289471066, 8783.604737786814, 8827.0, 8882.822343553125, 8895.199432051115, 8938.776530586721, 8929.241014513775, 8961.05908879568, 8979.595918183697, 8985.415947963395, 9013.36906416551, 8829.33779966505, 8838.779030524223, 8850.0, 8948.463092214488, 8954.776130596721, 8642.827143457158, 8696.608652610585, 8782.38523303369, 8793.252573531257, 8843.77890552735, 42898.356524652154, 42932.78533607343, 43190.78404607957, 43266.0, 43326.35010474845, 3420.7263418926673, 3497.720182385403, 3500.3174380995715, 3872.7676339419445, 3968.444417781513, 31775.52336714951, 31940.0, 32056.839715801503, 32059.198520036953, 33535.16162095943, 4196.328587426027, 4326.740395576276, 4334.1981733379425, 4365.781710914442, 4394.011347446831, 338170.0, 341381.0, 341473.0, 342813.0, 345086.0, 62143.6892815533, 63064.0, 63115.36884631187, 63145.0, 63236.367636323965, 65399.673001634685, 65472.67263663651, 65565.34434655687, 66249.0, 66423.33576664267, 18218.45344639663, 18353.449396518125, 18425.81574184241, 18456.907715461337, 18652.44042678722, 14351.92824035894, 14424.783628245585, 14428.350724217435, 14444.85555144435, 14452.421903123968, 19031.238750450102, 19179.041047947827, 19196.904015479835, 19214.519637008907, 19232.326868559812, 6396.976483762575, 6500.902486462707, 6753.696083676246, 6762.83092922671, 6776.356246156607, 1009.248110157937, 1039.8336266197373, 1090.798202332571, 1175.1538891997918, 1198.676357383519, 32483.83758081242, 32570.837145814592, 32698.67301327004, 32962.0, 33264.16839578981, 1093.2238110941162, 1094.1684319916922, 1095.1676725688376, 1111.0, 1174.3775798826637, 16449.25978330978, 16799.496015119566, 16831.326746929986, 17169.48491545256, 17178.914105429394, 492761.0, 496172.0, 498140.0, 498261.0, 498822.0, 60930.39069609336, 61146.38853611407, 61522.69238653778, 61527.38472615306, 61597.38402616006, 1347.9258640774851, 1371.5268232459784, 1377.538524594272, 1388.3127851713466, 1400.9929950350183, 30995.380092398478, 31181.220469488446, 31892.84053579717, 32279.35441291114, 32995.175120621214, 52436.47563524316, 52554.47445525496, 52643.473565263856, 52880.73559632177, 53229.201561975824, 455287.0, 456725.0, 457917.0, 458290.0, 460362.0, 42936.78531607322, 43582.56417435785, 43696.78151609222, 43797.78101109474, 44251.557484424746, 52555.47444525506, 52717.20924186217, 52949.735251323495, 53258.73370633122, 54965.0, 41753.30121032006, 43014.56985430106, 43075.353869692604, 43214.13571728611, 43426.782866085465, 42597.148057038066, 43602.44535198239, 43869.78065109654, 44102.55897440985, 44419.77790111029, 40994.38508422316, 41741.0, 42579.7871010643, 42801.57198428101, 44809.79596700881, 35449.29101418009, 37914.24171516499, 38049.4292585617, 38225.23549529049, 39131.0, 29327.560086599144, 29348.266293342836, 29669.5549566761, 29796.255093622833, 30006.0], "value": 20927.166301713558, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [425.9190753756784, 431.38312213534647, 432.67856614856936, 438.13249765464377, 445.5299658859901, 19560.706589401154, 19788.60422791543, 20496.795032049675, 20579.897100514496, 20675.172993080258, 17690.82309176911, 17725.64548709025, 19209.135588898498, 19785.40643780689, 19886.70169947452, 5211.348581427312, 5389.137737961927, 5399.514043736063, 5419.620626556142, 5429.104197807357, 5238.266642670029, 5308.071087559681, 5358.812441564546, 5407.891842163154, 5410.756515956772, 5397.973010134944, 5400.243965844785, 5403.135498320269, 5406.432324605918, 5416.8104116355935, 5342.091844386464, 5374.844408452182, 5380.99999999998, 5444.8366549003595, 5764.855878603026, 5277.86805329866, 5278.577713782888, 5286.735663216824, 5291.735413229323, 5296.761645725952, 14567.198804065772, 23241.88379058111, 23385.298441046794, 23764.287071387713, 23963.0, 2090.0, 2280.05377768226, 2294.0, 2494.8627825469594, 2809.1712944681162, 10615.0, 10660.147188225, 10916.945415272872, 10939.28894621847, 11032.779344413148, 1838.6782313095155, 1855.8608104392224, 1860.3488778927403, 1899.9145038473303, 1923.4806602217463, 77687.0, 89758.55120724355, 90322.0, 91894.08105918922, 92095.0, 11763.353015584054, 11838.881611183779, 11969.341686207168, 12179.0, 12249.387530623433, 17048.0, 17104.91447542779, 17118.572035699206, 17133.485995420157, 17140.97154170754, 8185.631646575918, 8415.410921235578, 8497.980242370955, 8770.429922055173, 8788.16512431318, 7718.498297610638, 7746.341560967268, 7747.109082455477, 7955.960220198977, 8295.0, 5099.566536844335, 5186.144286192812, 5189.351331083614, 5203.687778733212, 5242.97378513105, 1963.528753099246, 2060.6084843879617, 2101.4116047506723, 2108.4518025313528, 2136.818370438499, 968.2931460034074, 982.332014230316, 1018.5263852308713, 1053.3627155570923, 1077.6874706335232, 19819.60360792805, 20334.898325508573, 20375.8981205096, 20408.081636326402, 20554.0, 1025.3591505309182, 1025.6153942271649, 1031.1029404418205, 1041.5937784264142, 1071.9892801072046, 10564.947175264075, 11128.109751219883, 11149.38678372681, 11173.273737207055, 11237.775244495064, 484636.0, 488411.0, 492893.0, 502357.0, 522630.0, 87696.0, 98266.0, 99427.50286248523, 107363.0, 107558.0, 1070.5129166229347, 1122.848415463902, 1166.9941650291694, 1168.1881092640704, 1171.0865524890598, 18913.621727565645, 19194.0, 19266.133024014234, 19385.903070484557, 19410.126544305822, 46158.76920615375, 46160.30759538677, 46709.532904670516, 46858.0, 46976.76511617557, 64810.0, 65007.0, 65845.0123248142, 67088.66455667885, 67522.66238668775, 9054.27565794748, 9203.309751768778, 9307.20888724466, 9493.525323733924, 9606.807863842823, 13714.314284285547, 14219.0, 14276.428942842585, 14401.0, 14428.278586070865, 12487.625371238877, 12519.749605007666, 12542.0, 12626.684332891751, 12628.621141365773, 12132.150749447454, 12317.137800354247, 12362.814557781461, 12467.750644986869, 12569.93715031419, 12505.249685018927, 12887.548935787203, 13023.283719395145, 13036.47854085826, 13105.541306054241, 9082.863757043517, 9096.27229821626, 9202.064311234564, 9218.769530761516, 9395.718128456158, 11530.423478826193, 11766.352850593299, 11868.762624747284, 11969.700757481132, 12388.62834114978], "value": 9613.477252838273, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1526.1911187070853, 1560.2588770334091, 1697.9405720799775, 1805.7020591602386, 1811.4475085099057, 8060.073091594469, 8346.582670866463, 8668.34987375947, 9185.678501252458, 9220.0, 8333.66665333386, 8556.529390883514, 8585.356098292637, 8837.072107428723, 8838.381313308071, 2467.321486591188, 2492.0, 2498.600223964166, 2508.159766478223, 2513.3716570857287, 2436.4030812450974, 2485.888135033928, 2488.042103790036, 2492.9002839886475, 2507.661465702134, 2436.914707985221, 2446.9233537243554, 2466.950660986779, 2481.950360992788, 2483.3295010347197, 2416.033586565379, 2424.75752424757, 2435.111184417675, 2435.890384932682, 2449.473363226906, 2377.2749311459997, 2393.3418309964727, 2422.8667423291713, 2437.061731233488, 2440.4264997725522, 8893.777655558599, 9060.728178154666, 9133.406328588688, 9163.862542061874, 9166.404183728104, 5567.109262518018, 5674.290713660793, 5727.599068065237, 5742.511886489653, 5745.109508026263, 3499.475078738184, 3536.257385948954, 3557.6442355764475, 3741.9625803741887, 3771.358868992278, 1161.9593314234046, 1170.087331881134, 1183.5088438298096, 1195.8804119588058, 1215.6960759810047, 12602.558910438182, 12697.365131743376, 12728.872711272954, 12730.872691273062, 12763.617091487178, 4751.09729151467, 4994.700317980933, 5044.672096313801, 5087.389513258433, 5100.744962751922, 10653.84019239712, 10752.19358548112, 10771.407572583426, 10785.676429707122, 10848.566057357775, 5622.0161471742285, 5628.887422251532, 5657.717114144276, 5661.433856614388, 5672.801451949162, 4484.775761211927, 4936.0, 5071.594272458195, 5227.738613069408, 5266.947330526722, 4259.914801704011, 4293.763842988603, 4315.805788739514, 4347.739135651871, 4375.234333991539, 1375.7317323122095, 1392.3455975691409, 1398.3497673581833, 1409.9295035248401, 1410.0341266232663, 768.6656304507445, 857.4651374040523, 882.955852207387, 963.1764841060932, 969.8022941667035, 6121.632702037892, 6158.661273629904, 6165.136880836686, 6190.978488549339, 6280.0, 501.09302163084203, 505.7294347524057, 513.4480433533965, 515.4253007896243, 516.2308160840321, 4124.572428605489, 4214.978925105416, 4249.617534421917, 4271.978640106841, 4363.389125522366, 11030.28303160292, 11321.490532926038, 11401.543938242377, 11445.542178312775, 11458.0, 11096.55613775456, 11244.212905096565, 11300.378479183724, 11373.147013973985, 11500.252483588707, 8336.916630833735, 8509.70216042423, 8547.059823419419, 8566.52884091381, 8573.785655358666, 6101.908471373022, 6103.6032657877095, 6107.816765497042, 6202.255729312511, 6203.565750397429, 10286.022827831344, 10327.173826093744, 10372.68881933513, 10397.11624511925, 10482.842757358494, 10569.577216911237, 10601.575936962436, 10649.254552181274, 10663.733406664585, 10670.57317707283, 7961.283484486193, 8029.919700803151, 8097.919020809716, 8183.508989460652, 8212.301954333949, 8744.344174186834, 8760.561971901252, 8877.866831997655, 8881.866771998555, 8928.464292142493, 7946.40401969843, 8066.475679080841, 8129.065157506726, 8134.064582572843, 8211.17888211174, 7791.0, 7829.7259595913865, 7891.960540197262, 7924.564148971862, 8052.557109358807, 7415.443841712001, 7479.214682458263, 7540.359069479156, 7558.2441755823975, 7563.357114645317, 5283.1052045201395, 5366.570674345965, 5372.113601255905, 5472.863178420572, 5514.6691198528215, 5381.246625472359, 5392.946070539401, 5456.890862182813, 5459.481349271813, 5470.671759694431], "value": 4766.188564014601, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.11613755954016, 361.3062919195145, 365.89206184175663, 367.1189146049479, 370.4591296706806, 5756.424357564241, 5756.769729210831, 5761.683107429089, 5776.768929242825, 5781.248437703098, 5419.8374048778505, 5578.219049333096, 5639.802606908759, 5656.2929633795775, 5711.857203569913, 4390.143921935216, 4453.599176074153, 4466.464024317086, 4476.149531589004, 4483.30508771141, 4467.816028752383, 4467.88830279244, 4472.172648060119, 4490.932636010446, 4492.258777301758, 4476.709013914102, 4479.723278865524, 4493.348464472666, 4494.955050449503, 4503.819847206124, 4221.282381995068, 4329.199098166833, 4392.450943632046, 4398.922264045297, 4409.162259170747, 3863.208042351311, 3883.611638836122, 3887.9805600972095, 3892.4161375793856, 3921.568627450978, 5474.68781387259, 5518.33779946405, 5523.392426833045, 5526.834194974117, 5528.281323427928, 4991.9034005717685, 5024.9748751256375, 5077.2637967494875, 5080.898382032376, 5094.261332106861, 5873.383294754032, 5927.051671732502, 5955.464008239279, 5976.372480889488, 5993.820185394402, 4217.219814334328, 4236.491621005468, 4257.552956939508, 4285.693056800794, 4295.2912769393015, 5971.761129554812, 6066.605670631395, 6175.197224360849, 6180.351063138396, 6181.258249010148, 4338.891527711769, 4360.978195109004, 4361.672874534423, 4362.76004819738, 4426.136903303889, 4431.736954967819, 4466.57567531084, 4467.15124126415, 4482.484514280834, 4490.124425737015, 4952.182889823139, 5033.382641026646, 5129.384473863161, 5137.9743101285, 5157.252198431282, 5960.225170727865, 5969.850753731104, 5987.491063259672, 5991.850203744854, 6085.878282434415, 1464.8388677245493, 1468.4566710317251, 1469.6472846516758, 1472.5655931500232, 1482.303317440801, 953.8855337359422, 992.2409356842022, 997.4015590645699, 1012.3520946594185, 1018.7147598672384, 5569.721513924287, 5576.302962129734, 5591.602099475132, 5614.326280846243, 5655.660660360391, 5944.227250457499, 5977.462028417463, 5996.880062398727, 6010.3554436048, 6020.447935717947, 5435.755391007414, 5534.695591742412, 5538.086215774352, 5578.219049333096, 5599.8600034998635, 3146.9685303147135, 3152.7477801775804, 3170.682931706857, 3189.5056266278766, 3189.9681003190135, 6000.239889650809, 6111.54163437744, 6186.072089186658, 6218.502519798405, 6234.937650623527, 5989.263113697066, 6011.729472173763, 6013.338532761392, 6018.759249629966, 6069.271687397452, 6136.938630613637, 6137.629574122643, 6158.907616385758, 6194.99999999991, 6246.406591373812, 5651.180578816131, 5859.091840764689, 5859.5019423349495, 5874.651448674214, 5937.762489500372, 5872.354041055566, 5873.970630146822, 5910.349861515316, 5936.495397891227, 5968.0, 6224.782132625336, 6334.588251763621, 6361.459275961595, 6387.297397286387, 6409.775657852139, 4415.183191109655, 4456.131054444352, 4470.1059788041875, 4473.642108631367, 4487.1282379277945, 6113.84715382119, 6136.32500424944, 6189.319174890668, 6235.875282494416, 6242.687865606792, 5968.104784282219, 5974.566104134889, 5986.551008674454, 6020.314311992649, 6043.22011874525, 5991.580589358703, 6017.819465416044, 6036.275646922398, 6041.909371359521, 6050.183225264709, 5714.314282286152, 5938.138969849261, 5963.2844058713235, 5978.372270911492, 5983.820485385445, 5994.160817485643, 6040.818775436744, 6072.878542429038, 6097.359777223328, 6129.77404519089, 5626.324841019104, 5872.768348027722, 5893.44012318829, 5994.790182343597, 5998.0], "value": 4530.153631801464, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.2883544367023, 749.9025126733524, 752.6725874244702, 775.8448310337932, 783.8667426537488, 15414.84585154148, 15617.453389131382, 15630.0, 15681.921590392047, 15748.527544173665, 14764.852351476482, 14932.178730169837, 14952.925235373808, 14964.775528367083, 14965.551033468986, 693.7121094745687, 708.8050786033831, 826.8098337382405, 838.7316058861136, 850.3537311643134, 847.2798121596655, 849.413904405961, 850.1795767084762, 853.0829358439702, 858.6222062292571, 889.3685483306828, 891.4339394484484, 891.8974317953454, 892.0633334998258, 894.4767311123001, 883.8188171424842, 884.045231150356, 884.0938038510546, 884.4339622641514, 885.4554449013874, 648.6432462145801, 650.7364517370426, 654.1136759690598, 654.2868273581819, 656.7044829826549, 14443.78334324986, 14509.637259068502, 14597.489087881979, 14608.488702895347, 15777.29002194904, 11686.649400517997, 14090.154590724589, 14257.572272831832, 14347.354369053417, 14363.497277595234, 10767.138628909668, 10946.890531094667, 11037.668869933916, 11067.059299959514, 11068.39123848188, 3488.164801426151, 3494.3011397720556, 3552.6980206682465, 3565.4295312749837, 3643.9635603644156, 62945.370546294405, 64799.0, 66515.0, 66746.66626666836, 66886.3311366885, 10353.0, 10409.27135100551, 10458.424786636655, 10511.52698128586, 10612.469376531142, 19062.046897655062, 19832.0, 20017.699734503993, 20037.699434508493, 20044.198232070845, 7728.8454230916195, 8032.4778889372, 8045.9597702011115, 8174.67301307941, 8218.0, 4467.5755803198645, 4472.329150627432, 4480.61914737251, 4501.476627521958, 4554.795034223468, 3549.804760738184, 3611.476335931328, 3627.3108109459645, 3644.4351125575577, 3674.9816250918575, 626.6396821827467, 635.6313338263795, 636.3858876184504, 653.6796969484918, 655.2170156662837, 644.8130042287778, 669.4778073102988, 753.0361137743697, 753.4838635534676, 764.537380416918, 9428.15146636806, 9765.267604929517, 9835.3115281931, 9920.603175873028, 10111.443870587189, 612.2652816620074, 627.679269753577, 739.3826155160393, 761.2311565318957, 779.8011507065662, 4319.157764235943, 4321.719088259253, 4402.911941761146, 4612.0545288215835, 4644.790984405642, 54588.454115458335, 58388.0, 87832.68250976241, 89019.55490222508, 90997.0, 78246.0, 79506.0, 80710.5964470174, 81590.0, 83364.58317708493, 67958.98061529081, 68235.31764682289, 68827.3117268831, 71168.64415677992, 72386.27613723795, 8871.866921996305, 8886.244669202932, 8910.331725120512, 8962.417442866194, 9363.0, 48026.9999999986, 48156.27765583449, 48355.5164448351, 49690.0, 50394.244086338, 64457.67771161114, 65866.0, 65890.34109659033, 67763.0, 67879.3212067873, 11404.258723182966, 11477.426128693698, 11596.594119205787, 11703.180777345504, 12147.635570932885, 13097.869021309665, 13452.058355914993, 13462.663433414244, 13541.86458135406, 13601.251931143883, 12154.696132596755, 12190.878091219329, 12197.939010304892, 12375.381230938237, 12614.0, 11183.776324473627, 11580.942095289469, 11591.362475063952, 11677.88322116768, 12153.0, 12551.87448125507, 12715.173513721578, 12738.87261127377, 12821.423035963218, 12833.614991550268, 9749.415035097916, 9899.65351212704, 10033.749156271151, 10121.848172277274, 10269.74325641865, 9721.611135554498, 10164.79670406573, 10170.542325595217, 10205.795884082128, 10218.233632477743], "value": 7098.577124685766, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1465.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 115.0, 111.0, 112.0, 113.0, 111.0, 112.0, 113.0, 112.0, 114.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 122.0, 128.0, 160.0, 124.0, 118.0, 117.0, 123.0, 154.0, 121.0], "value": 131.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 164.0, 163.0, 161.0, 163.0, 164.0, 164.0, 164.0, 164.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 103.0, 76.0, 77.0, 75.0, 76.0, 95.0, 77.0], "value": 80.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 116.0, 81.0, 83.0, 81.0, 96.0, 82.0, 81.0, 111.0], "value": 89.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 120.0, 118.0, 119.0, 118.0, 118.0, 118.0, 118.0, 117.0, 117.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 148.0, 147.0, 147.0, 147.0, 149.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 86.0, 86.0, 85.0, 84.0, 85.0, 85.0, 86.0, 85.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 57.0, 52.0, 52.0, 52.0, 55.0, 52.0, 52.0, 52.0], "value": 52.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 59.0, 59.0, 58.0, 59.0, 59.0, 59.0, 59.0], "value": 59.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 77.0, 81.0, 77.0, 73.0, 74.0, 75.0, 73.0, 79.0], "value": 76.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 123.0, 132.0, 132.0, 127.0, 120.0, 124.0, 121.0, 174.0, 123.0], "value": 129.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 156.0, 157.0, 161.0, 158.0, 153.0, 155.0, 155.0, 155.0, 154.0], "value": 156.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 65.0, 67.0, 63.0, 62.0, 63.0, 62.0, 61.0, 70.0], "value": 63.8, "unit": "score"}]}]} 02:48:36 INFO - Return code: 0 02:48:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:48:36 ERROR - # TBPL SUCCESS # 02:48:36 INFO - Running post-action listener: _resource_record_post_action 02:48:36 INFO - [mozharness: 2016-12-27 10:48:36.093338Z] Finished run-tests step (success) 02:48:36 INFO - Running post-run listener: _resource_record_post_run 02:48:36 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 266240; Write bytes: 356564992; Read time: 32; Write time: 234688 02:48:36 INFO - TinderboxPrint: CPU usage
13.3% 02:48:36 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 32 02:48:36 INFO - TinderboxPrint: I/O write bytes / time
356,564,992 / 234,688 02:48:36 INFO - TinderboxPrint: CPU idle
8,228.7 (86.7%) 02:48:36 INFO - TinderboxPrint: CPU user
1,207.5 (12.7%) 02:48:36 INFO - TinderboxPrint: Swap in / out
0 / 0 02:48:36 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107331584; Read time: 0; Write time: 69864 02:48:36 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 262144; Write bytes: 247918592; Read time: 24; Write time: 164796 02:48:36 INFO - Running post-run listener: _upload_blobber_files 02:48:36 INFO - Blob upload gear active. 02:48:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:48:36 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 02:48:36 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:48:36 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:48:37 INFO - (blobuploader) - INFO - Open directory for files ... 02:48:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:48:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:48:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:48:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:48:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:48:37 INFO - (blobuploader) - INFO - Done attempting. 02:48:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:48:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:48:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:48:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:48:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:48:38 INFO - (blobuploader) - INFO - Done attempting. 02:48:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:48:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:48:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:48:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:48:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:48:42 INFO - (blobuploader) - INFO - Done attempting. 02:48:42 INFO - (blobuploader) - INFO - Iteration through files over. 02:48:42 INFO - Return code: 0 02:48:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:48:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:48:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/25e80fea78c1f8ba4ebc54f825c235081d50e646ab41a2ca2730b7666accb3c7b090fb668a3277d317bc500bb43691eb25f2043e306a2b7786b55ef84ab050e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/09f98714bf773317454114598ea625c91e003ff6d1dcb43ae302189f5525e6d4ec6a9220a85beda7e5866a5ce5777b7b0fe7d443e4f74dc40c79cb008e5d5a94", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/abcaccb0e967fb76edf3ca068ea5dc56e8497434203b7183e868236b4e913225d7f2854338f7bd715544029c903b2f312130d0f884449b9a3f599210d48fccd3"} 02:48:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:48:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:48:42 INFO - Contents: 02:48:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/25e80fea78c1f8ba4ebc54f825c235081d50e646ab41a2ca2730b7666accb3c7b090fb668a3277d317bc500bb43691eb25f2043e306a2b7786b55ef84ab050e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/09f98714bf773317454114598ea625c91e003ff6d1dcb43ae302189f5525e6d4ec6a9220a85beda7e5866a5ce5777b7b0fe7d443e4f74dc40c79cb008e5d5a94", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/abcaccb0e967fb76edf3ca068ea5dc56e8497434203b7183e868236b4e913225d7f2854338f7bd715544029c903b2f312130d0f884449b9a3f599210d48fccd3"} 02:48:42 INFO - Running post-run listener: copy_logs_to_upload_dir 02:48:42 INFO - Copying logs to upload dir... 02:48:42 INFO - mkdir: /builds/slave/test/build/upload/logs 02:48:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.969530 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-12-27 02:48:42.467740) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-27 02:48:42.471742) ========= 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=c6927cf182745ad25b1d38b9000001fe-1482834337.259206-1719056383 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-Aurora/sha512/25e80fea78c1f8ba4ebc54f825c235081d50e646ab41a2ca2730b7666accb3c7b090fb668a3277d317bc500bb43691eb25f2043e306a2b7786b55ef84ab050e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/09f98714bf773317454114598ea625c91e003ff6d1dcb43ae302189f5525e6d4ec6a9220a85beda7e5866a5ce5777b7b0fe7d443e4f74dc40c79cb008e5d5a94", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/abcaccb0e967fb76edf3ca068ea5dc56e8497434203b7183e868236b4e913225d7f2854338f7bd715544029c903b2f312130d0f884449b9a3f599210d48fccd3"} build_url:https://queue.taskcluster.net/v1/task/WeLlevggTVuo2_3ktAhduw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011855 build_url: 'https://queue.taskcluster.net/v1/task/WeLlevggTVuo2_3ktAhduw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/25e80fea78c1f8ba4ebc54f825c235081d50e646ab41a2ca2730b7666accb3c7b090fb668a3277d317bc500bb43691eb25f2043e306a2b7786b55ef84ab050e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/09f98714bf773317454114598ea625c91e003ff6d1dcb43ae302189f5525e6d4ec6a9220a85beda7e5866a5ce5777b7b0fe7d443e4f74dc40c79cb008e5d5a94", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/abcaccb0e967fb76edf3ca068ea5dc56e8497434203b7183e868236b4e913225d7f2854338f7bd715544029c903b2f312130d0f884449b9a3f599210d48fccd3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-27 02:48:42.497128) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-27 02:48:42.497452) ========= 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=c6927cf182745ad25b1d38b9000001fe-1482834337.259206-1719056383 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004505 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-27 02:48:42.581147) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-27 02:48:42.581470) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-27 02:48:42.581763) ========= ========= Total master_lag: 0.24 =========