builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-015 starttime: 1468320278.11 results: success (0) buildid: 20160712004050 builduid: 9466084a6d5c4350bef37e735a4b09ec revision: 632484723c99dc0ac9dcf11e25ec10e8fdb8dabf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 03:44:38.106331) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 03:44:38.106887) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 03:44:38.107270) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 03:44:38.122476) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 03:44:38.122789) ========= 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=20e666a3d4cfbb71505a330e000001b4-1468320277.277778-373876036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-12 03:44:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-07-12 03:44:38 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.070616 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 03:44:38.209010) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 03:44:38.209395) ========= 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=20e666a3d4cfbb71505a330e000001b4-1468320277.277778-373876036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020021 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 03:44:38.262356) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 03:44:38.263087) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 632484723c99dc0ac9dcf11e25ec10e8fdb8dabf --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 632484723c99dc0ac9dcf11e25ec10e8fdb8dabf --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=20e666a3d4cfbb71505a330e000001b4-1468320277.277778-373876036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-12 03:44:38,412 truncating revision to first 12 chars 2016-07-12 03:44:38,412 Setting DEBUG logging. 2016-07-12 03:44:38,412 attempt 1/10 2016-07-12 03:44:38,412 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/632484723c99?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-12 03:44:38,710 unpacking tar archive at: mozilla-aurora-632484723c99/testing/mozharness/ program finished with exit code 0 elapsedTime=0.648589 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 03:44:38.927534) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 03:44:38.927909) ========= script_repo_revision: 632484723c99dc0ac9dcf11e25ec10e8fdb8dabf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 03:44:38.928367) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 03:44:38.928672) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 03:44:38.938707) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-07-12 03:44:38.939424) ========= /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=20e666a3d4cfbb71505a330e000001b4-1468320277.277778-373876036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:44:39 INFO - MultiFileLogger online at 20160712 03:44:39 in /builds/slave/test 03:44:39 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 03:44:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:44:39 INFO - {'append_to_log': False, 03:44:39 INFO - 'base_work_dir': '/builds/slave/test', 03:44:39 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:44:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:44:39 INFO - 'branch': 'Mozilla-Aurora', 03:44:39 INFO - 'buildbot_json_path': 'buildprops.json', 03:44:39 INFO - 'config_files': ('talos/linux_config.py',), 03:44:39 INFO - 'default_actions': ('clobber', 03:44:39 INFO - 'read-buildbot-config', 03:44:39 INFO - 'download-and-extract', 03:44:39 INFO - 'populate-webroot', 03:44:39 INFO - 'create-virtualenv', 03:44:39 INFO - 'install', 03:44:39 INFO - 'run-tests'), 03:44:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:44:39 INFO - 'download_minidump_stackwalk': True, 03:44:39 INFO - 'download_symbols': 'ondemand', 03:44:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:44:39 INFO - 'tooltool.py': '/tools/tooltool.py', 03:44:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:44:39 INFO - '/tools/misc-python/virtualenv.py')}, 03:44:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:44:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:44:39 INFO - 'installer_path': 'installer.exe', 03:44:39 INFO - 'log_level': 'info', 03:44:39 INFO - 'log_name': 'talos', 03:44:39 INFO - 'log_to_console': True, 03:44:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:44:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:44:39 INFO - 'opt_config_files': (), 03:44:39 INFO - 'pip_index': False, 03:44:39 INFO - 'sps_profile': False, 03:44:39 INFO - 'sps_profile_interval': 0, 03:44:39 INFO - 'suite': 'dromaeojs-e10s', 03:44:39 INFO - 'system_bits': '32', 03:44:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:44:39 INFO - 'title': 'talos-linux64-ix-015', 03:44:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:44:39 INFO - 'use_talos_json': True, 03:44:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:44:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:44:39 INFO - 'work_dir': 'build'} 03:44:39 INFO - ##### 03:44:39 INFO - ##### Running clobber step. 03:44:39 INFO - ##### 03:44:39 INFO - Running pre-action listener: _resource_record_pre_action 03:44:39 INFO - Running main action method: clobber 03:44:39 INFO - rmtree: /builds/slave/test/build 03:44:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:44:40 INFO - Running post-action listener: _resource_record_post_action 03:44:40 INFO - ##### 03:44:40 INFO - ##### Finished clobber step (success) 03:44:40 INFO - ##### 03:44:40 INFO - ##### 03:44:40 INFO - ##### Running read-buildbot-config step. 03:44:40 INFO - ##### 03:44:40 INFO - Running pre-action listener: _resource_record_pre_action 03:44:40 INFO - Running main action method: read_buildbot_config 03:44:40 INFO - Using buildbot properties: 03:44:40 INFO - { 03:44:40 INFO - "project": "", 03:44:40 INFO - "product": "firefox", 03:44:40 INFO - "script_repo_revision": "production", 03:44:40 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:44:40 INFO - "repository": "", 03:44:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:44:40 INFO - "buildid": "20160712004050", 03:44:40 INFO - "stage_platform": "linux64-pgo", 03:44:40 INFO - "basedir": "/builds/slave/test", 03:44:40 INFO - "nightly_build": "True", 03:44:40 INFO - "buildnumber": 439, 03:44:40 INFO - "slavename": "talos-linux64-ix-015", 03:44:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:44:40 INFO - "platform": "ubuntu64_hw", 03:44:40 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:44:40 INFO - "branch": "mozilla-aurora", 03:44:40 INFO - "repo_path": "releases/mozilla-aurora", 03:44:40 INFO - "revision": "632484723c99dc0ac9dcf11e25ec10e8fdb8dabf", 03:44:40 INFO - "pgo_build": "True", 03:44:40 INFO - "builduid": "9466084a6d5c4350bef37e735a4b09ec", 03:44:40 INFO - "slavebuilddir": "test" 03:44:40 INFO - } 03:44:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 03:44:40 INFO - Running post-action listener: _resource_record_post_action 03:44:40 INFO - ##### 03:44:40 INFO - ##### Finished read-buildbot-config step (success) 03:44:40 INFO - ##### 03:44:40 INFO - ##### 03:44:40 INFO - ##### Running download-and-extract step. 03:44:40 INFO - ##### 03:44:40 INFO - Running pre-action listener: _resource_record_pre_action 03:44:40 INFO - Running main action method: download_and_extract 03:44:40 INFO - mkdir: /builds/slave/test/build/tests 03:44: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:40 INFO - https://queue.taskcluster.net/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:44:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:44:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:44:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:44:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:44:40 INFO - Downloaded 1361 bytes. 03:44:40 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:44:40 INFO - Using the following test package requirements: 03:44:40 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:44:40 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:44:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:44:40 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:44:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:44:40 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:44:40 INFO - u'jsshell-linux-x86_64.zip'], 03:44:40 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:44:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:44:40 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:44:40 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:44:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:44:40 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:44:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:44:40 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:44:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:44:40 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:44:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:44:40 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:44: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:40 INFO - https://queue.taskcluster.net/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:44:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:44:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:44:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:44:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:44:42 INFO - Downloaded 24526838 bytes. 03:44:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:44:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:44:43 INFO - Return code: 0 03:44:43 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:44:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:43 INFO - https://queue.taskcluster.net/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:44:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:44:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:44:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:44:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:44:44 INFO - Downloaded 24526838 bytes. 03:44:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:44:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:44:45 INFO - Return code: 0 03:44: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:45 INFO - https://queue.taskcluster.net/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:44:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:44:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:44:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:44:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:44:46 INFO - Downloaded 10833369 bytes. 03:44:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:44:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:44:47 INFO - Return code: 0 03:44:47 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:47 INFO - https://queue.taskcluster.net/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:44:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:44:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:44:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:44:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:45:00 WARNING - URL Error: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:45:00 INFO - Running command: ['nslookup', 'queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com'] 03:45:00 INFO - Copy/paste: nslookup queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com 03:45:01 INFO - Server: 10.26.75.40 03:45:01 INFO - Address: 10.26.75.40#53 03:45:01 INFO - queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com canonical name = proxxy1.srv.releng.scl3.mozilla.com. 03:45:01 INFO - Name: proxxy1.srv.releng.scl3.mozilla.com 03:45:01 INFO - Address: 10.26.48.46 03:45:01 INFO - Return code: 0 03:45:01 INFO - retry: attempt #1 caught exception: 03:45:01 INFO - retry: Failed, sleeping 30 seconds before retrying 03:45:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #2 03:45:35 INFO - Downloaded 63640850 bytes. 03:45:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:45:35 INFO - mkdir: /builds/slave/test/properties 03:45:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:45:35 INFO - Writing to file /builds/slave/test/properties/build_url 03:45:35 INFO - Contents: 03:45:35 INFO - build_url:https://queue.taskcluster.net/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:45:35 INFO - Running post-action listener: _resource_record_post_action 03:45:35 INFO - Running post-action listener: set_extra_try_arguments 03:45:35 INFO - ##### 03:45:35 INFO - ##### Finished download-and-extract step (success) 03:45:35 INFO - ##### 03:45:35 INFO - ##### 03:45:35 INFO - ##### Running populate-webroot step. 03:45:35 INFO - ##### 03:45:35 INFO - Running pre-action listener: _resource_record_pre_action 03:45:35 INFO - Running main action method: populate_webroot 03:45:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:45:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:45:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:45:35 INFO - '--tppagecycles', 03:45:35 INFO - '7'], 03:45:35 INFO - 'tests': ['tsvgm']}}, 03:45:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:45:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:45:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:45:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:45:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:45:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:45:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:35 INFO - 'talos_options': ['--disable-e10s'], 03:45:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:45:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:45:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:35 INFO - 'talos_options': ['--disable-e10s'], 03:45:35 INFO - 'tests': ['damp', 'tps']}, 03:45:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:35 INFO - 'tests': ['damp', 'tps']}, 03:45:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:45:35 INFO - 'tests': ['dromaeo_dom']}, 03:45:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:45:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:45:35 INFO - 'tests': ['a11yr', 03:45:35 INFO - 'ts_paint', 03:45:35 INFO - 'tpaint', 03:45:35 INFO - 'sessionrestore', 03:45:35 INFO - 'sessionrestore_no_auto_restore', 03:45:35 INFO - 'tabpaint']}, 03:45:35 INFO - 'other-e10s': {'tests': ['a11yr', 03:45:35 INFO - 'ts_paint', 03:45:35 INFO - 'tpaint', 03:45:35 INFO - 'sessionrestore', 03:45:35 INFO - 'sessionrestore_no_auto_restore', 03:45:35 INFO - 'tabpaint']}, 03:45:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:45:35 INFO - 'ts_paint', 03:45:35 INFO - 'tpaint', 03:45:35 INFO - 'sessionrestore', 03:45:35 INFO - 'sessionrestore_no_auto_restore', 03:45:35 INFO - 'tabpaint']}, 03:45:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:45:35 INFO - 'ts_paint', 03:45:35 INFO - 'tpaint', 03:45:35 INFO - 'sessionrestore', 03:45:35 INFO - 'sessionrestore_no_auto_restore', 03:45:35 INFO - 'tabpaint']}, 03:45:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:45:35 INFO - 'tests': ['a11yr', 03:45:35 INFO - 'ts_paint', 03:45:35 INFO - 'tpaint', 03:45:35 INFO - 'sessionrestore', 03:45:35 INFO - 'sessionrestore_no_auto_restore', 03:45:35 INFO - 'tabpaint']}, 03:45:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:45:35 INFO - 'tests': ['a11yr', 03:45:35 INFO - 'ts_paint', 03:45:35 INFO - 'tpaint', 03:45:35 INFO - 'sessionrestore', 03:45:35 INFO - 'sessionrestore_no_auto_restore', 03:45:35 INFO - 'tabpaint']}, 03:45:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:45:35 INFO - 'tests': ['tsvgx', 03:45:35 INFO - 'tsvgr_opacity', 03:45:35 INFO - 'tart', 03:45:35 INFO - 'tscrollx', 03:45:35 INFO - 'cart']}, 03:45:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:45:35 INFO - 'tsvgr_opacity', 03:45:35 INFO - 'tart', 03:45:35 INFO - 'tscrollx', 03:45:35 INFO - 'cart']}, 03:45:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:35 INFO - 'talos_options': ['--disable-e10s'], 03:45:35 INFO - 'tests': ['tp5o']}, 03:45:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:35 INFO - 'tests': ['tp5o']}, 03:45:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:35 INFO - 'talos_options': ['--disable-e10s', 03:45:35 INFO - '--xperf_path', 03:45:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:45:35 INFO - 'tests': ['tp5n']}, 03:45:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:35 INFO - 'talos_options': ['--xperf_path', 03:45:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:45:35 INFO - 'tests': ['tp5n']}}, 03:45:35 INFO - 'talos.zip': {'path': '', 03:45:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:45:35 INFO - Running post-action listener: _resource_record_post_action 03:45:35 INFO - ##### 03:45:35 INFO - ##### Finished populate-webroot step (success) 03:45:35 INFO - ##### 03:45:35 INFO - ##### 03:45:35 INFO - ##### Running create-virtualenv step. 03:45:35 INFO - ##### 03:45:35 INFO - Running pre-action listener: _resource_record_pre_action 03:45:35 INFO - Running main action method: create_virtualenv 03:45:35 INFO - Creating virtualenv /builds/slave/test/build/venv 03:45:35 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:45:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:45:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:45:35 INFO - Using real prefix '/usr' 03:45:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:45:36 INFO - Installing distribute.............................................................................................................................................................................................done. 03:45:38 INFO - Installing pip.................done. 03:45:38 INFO - Return code: 0 03:45:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:45:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80d0619f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c762e0>, '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 0x1be2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be25d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1468320277.277778-373876036', '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 03:45:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:45:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:45:38 INFO - Using env: {'DISPLAY': ':0', 03:45:38 INFO - 'HOME': '/home/cltbld', 03:45:38 INFO - 'LANG': 'en_US.UTF-8', 03:45:38 INFO - 'LANGUAGE': 'en_US:en', 03:45:38 INFO - 'LOGNAME': 'cltbld', 03:45:38 INFO - 'MAIL': '/var/mail/cltbld', 03:45:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:38 INFO - 'MOZ_NO_REMOTE': '1', 03:45:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:38 INFO - 'NO_EM_RESTART': '1', 03:45:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:38 INFO - 'PWD': '/builds/slave/test', 03:45:38 INFO - 'SHELL': '/bin/bash', 03:45:38 INFO - 'SHLVL': '1', 03:45:38 INFO - 'TERM': 'linux', 03:45:38 INFO - 'TMOUT': '86400', 03:45:38 INFO - 'USER': 'cltbld', 03:45:38 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1468320277.277778-373876036', 03:45:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:38 INFO - '_': '/tools/buildbot/bin/python'} 03:45:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:38 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:45:38 INFO - Cleaning up... 03:45:38 INFO - Return code: 0 03:45:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:45:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80d0619f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c762e0>, '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 0x1be2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be25d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1468320277.277778-373876036', '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 03:45:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:45:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:45:38 INFO - Using env: {'DISPLAY': ':0', 03:45:38 INFO - 'HOME': '/home/cltbld', 03:45:38 INFO - 'LANG': 'en_US.UTF-8', 03:45:38 INFO - 'LANGUAGE': 'en_US:en', 03:45:38 INFO - 'LOGNAME': 'cltbld', 03:45:38 INFO - 'MAIL': '/var/mail/cltbld', 03:45:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:38 INFO - 'MOZ_NO_REMOTE': '1', 03:45:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:38 INFO - 'NO_EM_RESTART': '1', 03:45:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:38 INFO - 'PWD': '/builds/slave/test', 03:45:38 INFO - 'SHELL': '/bin/bash', 03:45:38 INFO - 'SHLVL': '1', 03:45:38 INFO - 'TERM': 'linux', 03:45:38 INFO - 'TMOUT': '86400', 03:45:38 INFO - 'USER': 'cltbld', 03:45:38 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1468320277.277778-373876036', 03:45:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:38 INFO - '_': '/tools/buildbot/bin/python'} 03:45:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:38 INFO - Downloading/unpacking psutil>=3.1.1 03:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:45:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:45:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:45:40 INFO - Installing collected packages: psutil 03:45:40 INFO - Running setup.py install for psutil 03:45:40 INFO - building 'psutil._psutil_linux' extension 03:45:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:45:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:45:41 INFO - building 'psutil._psutil_posix' extension 03:45:41 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 03:45:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:45:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:45:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:45:41 INFO - Successfully installed psutil 03:45:41 INFO - Cleaning up... 03:45:41 INFO - Return code: 0 03:45:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:45:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80d0619f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c762e0>, '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 0x1be2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be25d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1468320277.277778-373876036', '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 03:45:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:45:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:45:41 INFO - Using env: {'DISPLAY': ':0', 03:45:41 INFO - 'HOME': '/home/cltbld', 03:45:41 INFO - 'LANG': 'en_US.UTF-8', 03:45:41 INFO - 'LANGUAGE': 'en_US:en', 03:45:41 INFO - 'LOGNAME': 'cltbld', 03:45:41 INFO - 'MAIL': '/var/mail/cltbld', 03:45:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:41 INFO - 'MOZ_NO_REMOTE': '1', 03:45:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:41 INFO - 'NO_EM_RESTART': '1', 03:45:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:41 INFO - 'PWD': '/builds/slave/test', 03:45:41 INFO - 'SHELL': '/bin/bash', 03:45:41 INFO - 'SHLVL': '1', 03:45:41 INFO - 'TERM': 'linux', 03:45:41 INFO - 'TMOUT': '86400', 03:45:41 INFO - 'USER': 'cltbld', 03:45:41 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1468320277.277778-373876036', 03:45:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:41 INFO - '_': '/tools/buildbot/bin/python'} 03:45:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:45:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:45:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:45:43 INFO - Installing collected packages: mozsystemmonitor 03:45:43 INFO - Running setup.py install for mozsystemmonitor 03:45:43 INFO - Successfully installed mozsystemmonitor 03:45:43 INFO - Cleaning up... 03:45:43 INFO - Return code: 0 03:45:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:45:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80d0619f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c762e0>, '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 0x1be2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be25d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1468320277.277778-373876036', '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 03:45:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:45:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:45:43 INFO - Using env: {'DISPLAY': ':0', 03:45:43 INFO - 'HOME': '/home/cltbld', 03:45:43 INFO - 'LANG': 'en_US.UTF-8', 03:45:43 INFO - 'LANGUAGE': 'en_US:en', 03:45:43 INFO - 'LOGNAME': 'cltbld', 03:45:43 INFO - 'MAIL': '/var/mail/cltbld', 03:45:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:43 INFO - 'MOZ_NO_REMOTE': '1', 03:45:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:43 INFO - 'NO_EM_RESTART': '1', 03:45:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:43 INFO - 'PWD': '/builds/slave/test', 03:45:43 INFO - 'SHELL': '/bin/bash', 03:45:43 INFO - 'SHLVL': '1', 03:45:43 INFO - 'TERM': 'linux', 03:45:43 INFO - 'TMOUT': '86400', 03:45:43 INFO - 'USER': 'cltbld', 03:45:43 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1468320277.277778-373876036', 03:45:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:43 INFO - '_': '/tools/buildbot/bin/python'} 03:45:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:43 INFO - Downloading/unpacking jsonschema==2.5.1 03:45:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:45:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:46 INFO - Downloading functools32-3.2.3-2.tar.gz 03:45:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:45:46 INFO - warning: no files found matching '*.txt' 03:45:46 INFO - no previously-included directories found matching 'build' 03:45:46 INFO - no previously-included directories found matching 'dist' 03:45:46 INFO - no previously-included directories found matching '.git*' 03:45:46 INFO - Installing collected packages: jsonschema, functools32 03:45:46 INFO - Running setup.py install for functools32 03:45:46 INFO - warning: no files found matching '*.txt' 03:45:46 INFO - no previously-included directories found matching 'build' 03:45:46 INFO - no previously-included directories found matching 'dist' 03:45:46 INFO - no previously-included directories found matching '.git*' 03:45:46 INFO - Successfully installed jsonschema functools32 03:45:46 INFO - Cleaning up... 03:45:46 INFO - Return code: 0 03:45:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:45:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80d0619f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c762e0>, '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 0x1be2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be25d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1468320277.277778-373876036', '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 03:45:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:45:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:45:46 INFO - Using env: {'DISPLAY': ':0', 03:45:46 INFO - 'HOME': '/home/cltbld', 03:45:46 INFO - 'LANG': 'en_US.UTF-8', 03:45:46 INFO - 'LANGUAGE': 'en_US:en', 03:45:46 INFO - 'LOGNAME': 'cltbld', 03:45:46 INFO - 'MAIL': '/var/mail/cltbld', 03:45:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:46 INFO - 'MOZ_NO_REMOTE': '1', 03:45:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:46 INFO - 'NO_EM_RESTART': '1', 03:45:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:46 INFO - 'PWD': '/builds/slave/test', 03:45:46 INFO - 'SHELL': '/bin/bash', 03:45:46 INFO - 'SHLVL': '1', 03:45:46 INFO - 'TERM': 'linux', 03:45:46 INFO - 'TMOUT': '86400', 03:45:46 INFO - 'USER': 'cltbld', 03:45:46 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1468320277.277778-373876036', 03:45:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:46 INFO - '_': '/tools/buildbot/bin/python'} 03:45:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:46 INFO - Downloading/unpacking blobuploader==1.2.4 03:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:48 INFO - Downloading blobuploader-1.2.4.tar.gz 03:45:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:45:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:45:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:45:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:45:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:49 INFO - Downloading docopt-0.6.1.tar.gz 03:45:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:45:49 INFO - Installing collected packages: blobuploader, requests, docopt 03:45:49 INFO - Running setup.py install for blobuploader 03:45:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:45:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:45:49 INFO - Running setup.py install for requests 03:45:49 INFO - Running setup.py install for docopt 03:45:49 INFO - Successfully installed blobuploader requests docopt 03:45:49 INFO - Cleaning up... 03:45:49 INFO - Return code: 0 03:45:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:45:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80d0619f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c762e0>, '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 0x1be2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be25d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1468320277.277778-373876036', '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 03:45:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:45:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:45:49 INFO - Using env: {'DISPLAY': ':0', 03:45:49 INFO - 'HOME': '/home/cltbld', 03:45:49 INFO - 'LANG': 'en_US.UTF-8', 03:45:49 INFO - 'LANGUAGE': 'en_US:en', 03:45:49 INFO - 'LOGNAME': 'cltbld', 03:45:49 INFO - 'MAIL': '/var/mail/cltbld', 03:45:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:49 INFO - 'MOZ_NO_REMOTE': '1', 03:45:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:49 INFO - 'NO_EM_RESTART': '1', 03:45:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:49 INFO - 'PWD': '/builds/slave/test', 03:45:49 INFO - 'SHELL': '/bin/bash', 03:45:49 INFO - 'SHLVL': '1', 03:45:49 INFO - 'TERM': 'linux', 03:45:49 INFO - 'TMOUT': '86400', 03:45:49 INFO - 'USER': 'cltbld', 03:45:49 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1468320277.277778-373876036', 03:45:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:49 INFO - '_': '/tools/buildbot/bin/python'} 03:45:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:45:50 INFO - Running setup.py (path:/tmp/pip-vkLpdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:45:50 INFO - Running setup.py (path:/tmp/pip-ZyaFxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:45:50 INFO - Running setup.py (path:/tmp/pip-PV_boh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:45:50 INFO - Running setup.py (path:/tmp/pip-hz5RLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:45:50 INFO - Running setup.py (path:/tmp/pip-iBIaxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:45:50 INFO - Running setup.py (path:/tmp/pip-GzTX3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:45:50 INFO - Running setup.py (path:/tmp/pip-Moequm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:45:50 INFO - Running setup.py (path:/tmp/pip-3STzZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:45:50 INFO - Running setup.py (path:/tmp/pip-7Vcwlj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:45:50 INFO - Running setup.py (path:/tmp/pip-CilKaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:45:50 INFO - Running setup.py (path:/tmp/pip-7ziFep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:45:50 INFO - Running setup.py (path:/tmp/pip-TefdH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:45:50 INFO - Running setup.py (path:/tmp/pip-DFNG0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:45:50 INFO - Running setup.py (path:/tmp/pip-QIgVgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:45:51 INFO - Running setup.py (path:/tmp/pip-qNFbMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:45:51 INFO - Running setup.py (path:/tmp/pip-3JcJ5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:45:51 INFO - Running setup.py (path:/tmp/pip-7dI0fq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:45:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:45:51 INFO - Running setup.py install for manifestparser 03:45:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:45:51 INFO - Running setup.py install for mozcrash 03:45:51 INFO - Running setup.py install for mozdebug 03:45:51 INFO - Running setup.py install for mozdevice 03:45:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:45:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:45:51 INFO - Running setup.py install for mozfile 03:45:51 INFO - Running setup.py install for mozhttpd 03:45:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:45:51 INFO - Running setup.py install for mozinfo 03:45:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:45:51 INFO - Running setup.py install for mozInstall 03:45:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:45:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:45:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:45:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:45:52 INFO - Running setup.py install for mozleak 03:45:52 INFO - Running setup.py install for mozlog 03:45:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:45:52 INFO - Running setup.py install for moznetwork 03:45:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:45:52 INFO - Running setup.py install for mozprocess 03:45:52 INFO - Running setup.py install for mozprofile 03:45:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:45:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:45:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:45:52 INFO - Running setup.py install for mozrunner 03:45:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:45:52 INFO - Running setup.py install for mozscreenshot 03:45:52 INFO - Running setup.py install for moztest 03:45:52 INFO - Running setup.py install for mozversion 03:45:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:45:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:45:52 INFO - Cleaning up... 03:45:53 INFO - Return code: 0 03:45:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:45:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80d0619f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c762e0>, '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 0x1be2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be25d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1468320277.277778-373876036', '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 03:45:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:45:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:45:53 INFO - Using env: {'DISPLAY': ':0', 03:45:53 INFO - 'HOME': '/home/cltbld', 03:45:53 INFO - 'LANG': 'en_US.UTF-8', 03:45:53 INFO - 'LANGUAGE': 'en_US:en', 03:45:53 INFO - 'LOGNAME': 'cltbld', 03:45:53 INFO - 'MAIL': '/var/mail/cltbld', 03:45:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:53 INFO - 'MOZ_NO_REMOTE': '1', 03:45:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:53 INFO - 'NO_EM_RESTART': '1', 03:45:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:53 INFO - 'PWD': '/builds/slave/test', 03:45:53 INFO - 'SHELL': '/bin/bash', 03:45:53 INFO - 'SHLVL': '1', 03:45:53 INFO - 'TERM': 'linux', 03:45:53 INFO - 'TMOUT': '86400', 03:45:53 INFO - 'USER': 'cltbld', 03:45:53 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1468320277.277778-373876036', 03:45:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:53 INFO - '_': '/tools/buildbot/bin/python'} 03:45:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:45:53 INFO - Running setup.py (path:/tmp/pip-RHYne5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:45:53 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:45:53 INFO - Running setup.py (path:/tmp/pip-wieYXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:45:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:45:53 INFO - Running setup.py (path:/tmp/pip-P80E_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:45:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:45:53 INFO - Running setup.py (path:/tmp/pip-gRqhT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:45:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:45:53 INFO - Running setup.py (path:/tmp/pip-gIcdCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:45:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:45:53 INFO - Running setup.py (path:/tmp/pip-ze7MBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:45:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:45:53 INFO - Running setup.py (path:/tmp/pip-bMU7_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:45:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:45:53 INFO - Running setup.py (path:/tmp/pip-o0hTSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:45:53 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)) 03:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:45:53 INFO - Running setup.py (path:/tmp/pip-HkPLJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:45:53 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)) 03:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:45:53 INFO - Running setup.py (path:/tmp/pip-adM0Sm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:45:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 03:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:45:53 INFO - Running setup.py (path:/tmp/pip-9faYj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:45:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:45:54 INFO - Running setup.py (path:/tmp/pip-0yubcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:45:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 03:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:45:54 INFO - Running setup.py (path:/tmp/pip-MpL7lu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:45:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:45:54 INFO - Running setup.py (path:/tmp/pip-ku34XA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:45:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 03:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:45:54 INFO - Running setup.py (path:/tmp/pip-5TX9z9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:45:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:45:54 INFO - Running setup.py (path:/tmp/pip-tbX9sQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:45:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:45:54 INFO - Running setup.py (path:/tmp/pip-jaK9ky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:45:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:45:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:45:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:45:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:45:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:45:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:45:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:56 INFO - Downloading blessings-1.6.tar.gz 03:45:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:45:56 INFO - Installing collected packages: blessings 03:45:56 INFO - Running setup.py install for blessings 03:45:56 INFO - Successfully installed blessings 03:45:56 INFO - Cleaning up... 03:45:56 INFO - Return code: 0 03:45:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:45:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:45:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:45:56 INFO - Reading from file tmpfile_stdout 03:45:56 INFO - Current package versions: 03:45:56 INFO - argparse == 1.2.1 03:45:56 INFO - blessings == 1.6 03:45:56 INFO - blobuploader == 1.2.4 03:45:56 INFO - docopt == 0.6.1 03:45:56 INFO - functools32 == 3.2.3-2 03:45:56 INFO - jsonschema == 2.5.1 03:45:56 INFO - manifestparser == 1.1 03:45:56 INFO - mozInstall == 1.12 03:45:56 INFO - mozcrash == 0.17 03:45:56 INFO - mozdebug == 0.1 03:45:56 INFO - mozdevice == 0.48 03:45:56 INFO - mozfile == 1.2 03:45:56 INFO - mozhttpd == 0.7 03:45:56 INFO - mozinfo == 0.9 03:45:56 INFO - mozleak == 0.1 03:45:56 INFO - mozlog == 3.2 03:45:56 INFO - moznetwork == 0.27 03:45:56 INFO - mozprocess == 0.22 03:45:56 INFO - mozprofile == 0.28 03:45:56 INFO - mozrunner == 6.11 03:45:56 INFO - mozscreenshot == 0.1 03:45:56 INFO - mozsystemmonitor == 0.3 03:45:56 INFO - moztest == 0.7 03:45:56 INFO - mozversion == 1.4 03:45:56 INFO - psutil == 3.1.1 03:45:56 INFO - requests == 1.2.3 03:45:56 INFO - wsgiref == 0.1.2 03:45:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:45:56 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:56 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:56 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 0x7f80d0619f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c762e0>, '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 0x1be2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be25d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1468320277.277778-373876036', '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 03:45:56 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 03:45:56 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 03:45:56 INFO - Using env: {'DISPLAY': ':0', 03:45:56 INFO - 'HOME': '/home/cltbld', 03:45:56 INFO - 'LANG': 'en_US.UTF-8', 03:45:56 INFO - 'LANGUAGE': 'en_US:en', 03:45:56 INFO - 'LOGNAME': 'cltbld', 03:45:56 INFO - 'MAIL': '/var/mail/cltbld', 03:45:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:56 INFO - 'MOZ_NO_REMOTE': '1', 03:45:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:56 INFO - 'NO_EM_RESTART': '1', 03:45:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:56 INFO - 'PWD': '/builds/slave/test', 03:45:56 INFO - 'SHELL': '/bin/bash', 03:45:56 INFO - 'SHLVL': '1', 03:45:56 INFO - 'TERM': 'linux', 03:45:56 INFO - 'TMOUT': '86400', 03:45:56 INFO - 'USER': 'cltbld', 03:45:56 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1468320277.277778-373876036', 03:45:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:56 INFO - '_': '/tools/buildbot/bin/python'} 03:45:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:45:57 INFO - Cleaning up... 03:45:57 INFO - Return code: 0 03:45:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:45:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80d0619f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c762e0>, '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 0x1be2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be25d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1468320277.277778-373876036', '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 03:45:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:45:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:45:57 INFO - Using env: {'DISPLAY': ':0', 03:45:57 INFO - 'HOME': '/home/cltbld', 03:45:57 INFO - 'LANG': 'en_US.UTF-8', 03:45:57 INFO - 'LANGUAGE': 'en_US:en', 03:45:57 INFO - 'LOGNAME': 'cltbld', 03:45:57 INFO - 'MAIL': '/var/mail/cltbld', 03:45:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:57 INFO - 'MOZ_NO_REMOTE': '1', 03:45:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:57 INFO - 'NO_EM_RESTART': '1', 03:45:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:57 INFO - 'PWD': '/builds/slave/test', 03:45:57 INFO - 'SHELL': '/bin/bash', 03:45:57 INFO - 'SHLVL': '1', 03:45:57 INFO - 'TERM': 'linux', 03:45:57 INFO - 'TMOUT': '86400', 03:45:57 INFO - 'USER': 'cltbld', 03:45:57 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1468320277.277778-373876036', 03:45:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:57 INFO - '_': '/tools/buildbot/bin/python'} 03:45:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:45:57 INFO - Cleaning up... 03:45:57 INFO - Return code: 0 03:45:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:45:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80d0619f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c762e0>, '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 0x1be2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be25d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1468320277.277778-373876036', '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 03:45:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:45:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:45:57 INFO - Using env: {'DISPLAY': ':0', 03:45:57 INFO - 'HOME': '/home/cltbld', 03:45:57 INFO - 'LANG': 'en_US.UTF-8', 03:45:57 INFO - 'LANGUAGE': 'en_US:en', 03:45:57 INFO - 'LOGNAME': 'cltbld', 03:45:57 INFO - 'MAIL': '/var/mail/cltbld', 03:45:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:57 INFO - 'MOZ_NO_REMOTE': '1', 03:45:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:57 INFO - 'NO_EM_RESTART': '1', 03:45:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:57 INFO - 'PWD': '/builds/slave/test', 03:45:57 INFO - 'SHELL': '/bin/bash', 03:45:57 INFO - 'SHLVL': '1', 03:45:57 INFO - 'TERM': 'linux', 03:45:57 INFO - 'TMOUT': '86400', 03:45:57 INFO - 'USER': 'cltbld', 03:45:57 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1468320277.277778-373876036', 03:45:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:57 INFO - '_': '/tools/buildbot/bin/python'} 03:45:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:57 INFO - Downloading/unpacking flake8 03:45:57 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 03:45:57 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 03:45:57 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 03:45:57 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 03:45:57 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 03:45:57 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 03:45:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:45:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:45:59 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 03:45:59 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 03:45:59 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 03:45:59 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 03:45:59 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 03:45:59 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 03:45:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:45:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:45:59 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 03:45:59 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 03:45:59 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 03:45:59 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 03:45:59 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 03:45:59 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 03:45:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:45:59 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 03:45:59 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 03:45:59 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 03:45:59 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 03:45:59 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 03:45:59 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 03:46:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:46:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:46:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:46:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:46:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:46:00 INFO - no previously-included directories found matching 'docs/_build' 03:46:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:46:00 INFO - Running setup.py install for pep8 03:46:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:46:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:46:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:46:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:46:00 INFO - no previously-included directories found matching 'docs/_build' 03:46:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:46:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:46:00 INFO - Cleaning up... 03:46:00 INFO - Return code: 0 03:46:00 INFO - Running post-action listener: _resource_record_post_action 03:46:00 INFO - Running post-action listener: _start_resource_monitoring 03:46:00 INFO - Starting resource monitoring. 03:46:00 INFO - ##### 03:46:00 INFO - ##### Finished create-virtualenv step (success) 03:46:00 INFO - ##### 03:46:00 INFO - ##### 03:46:00 INFO - ##### Running install step. 03:46:00 INFO - ##### 03:46:00 INFO - Running pre-action listener: _resource_record_pre_action 03:46:00 INFO - Running main action method: install 03:46:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:46:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:46:00 INFO - Reading from file tmpfile_stdout 03:46:00 INFO - Detecting whether we're running mozinstall >=1.0... 03:46:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:46:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:46:00 INFO - Reading from file tmpfile_stdout 03:46:00 INFO - Output received: 03:46:00 INFO - Usage: mozinstall [options] installer 03:46:00 INFO - Options: 03:46:00 INFO - -h, --help show this help message and exit 03:46:00 INFO - -d DEST, --destination=DEST 03:46:00 INFO - Directory to install application into. [default: 03:46:00 INFO - "/builds/slave/test"] 03:46:00 INFO - --app=APP Application being installed. [default: firefox] 03:46:00 INFO - mkdir: /builds/slave/test/build/application 03:46:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:46:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:46:16 INFO - Reading from file tmpfile_stdout 03:46:16 INFO - Output received: 03:46:16 INFO - /builds/slave/test/build/application/firefox/firefox 03:46:16 INFO - Running post-action listener: _resource_record_post_action 03:46:16 INFO - ##### 03:46:16 INFO - ##### Finished install step (success) 03:46:16 INFO - ##### 03:46:16 INFO - ##### 03:46:16 INFO - ##### Running run-tests step. 03:46:16 INFO - ##### 03:46:16 INFO - Running pre-action listener: _resource_record_pre_action 03:46:16 INFO - Running main action method: run_tests 03:46:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:46:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:46:16 INFO - Python 2.7.3 03:46:16 INFO - Return code: 0 03:46:16 INFO - grabbing minidump binary from tooltool 03:46:16 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:16 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 0x1c762e0>, '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 0x1be2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be25d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:46:16 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 03:46:16 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 03:46:16 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 03:46:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:46:16 INFO - Return code: 0 03:46:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:46:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:46:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:46:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:46:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:46:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:46:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:46:17 INFO - Return code: 0 03:46:17 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/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 03:46:17 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/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --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 03:46:17 INFO - Using env: {'DISPLAY': ':0', 03:46:17 INFO - 'HOME': '/home/cltbld', 03:46:17 INFO - 'LANG': 'en_US.UTF-8', 03:46:17 INFO - 'LANGUAGE': 'en_US:en', 03:46:17 INFO - 'LOGNAME': 'cltbld', 03:46:17 INFO - 'MAIL': '/var/mail/cltbld', 03:46:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:46:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:46:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:17 INFO - 'MOZ_NO_REMOTE': '1', 03:46:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:46:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:17 INFO - 'NO_EM_RESTART': '1', 03:46:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:17 INFO - 'PWD': '/builds/slave/test', 03:46:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:46:17 INFO - 'SHELL': '/bin/bash', 03:46:17 INFO - 'SHLVL': '1', 03:46:17 INFO - 'TERM': 'linux', 03:46:17 INFO - 'TMOUT': '86400', 03:46:17 INFO - 'USER': 'cltbld', 03:46:17 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1468320277.277778-373876036', 03:46:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:17 INFO - '_': '/tools/buildbot/bin/python'} 03:46:17 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/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 03:46:17 INFO - mozversion application_buildid: 20160712004050 03:46:17 INFO - mozversion application_changeset: 632484723c99dc0ac9dcf11e25ec10e8fdb8dabf 03:46:17 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:46:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:46:17 INFO - mozversion application_name: Firefox 03:46:17 INFO - mozversion application_remotingname: firefox-dev 03:46:17 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:46:17 INFO - mozversion application_vendor: Mozilla 03:46:17 INFO - mozversion application_version: 49.0a2 03:46:17 INFO - mozversion platform_buildid: 20160712004050 03:46:17 INFO - mozversion platform_changeset: 632484723c99dc0ac9dcf11e25ec10e8fdb8dabf 03:46:17 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:46:17 INFO - mozversion platform_version: 49.0a2 03:46:17 INFO - using testdate: 1468320377 03:46:17 INFO - actual date: 1468320377 03:46:17 INFO - starting webserver on 'localhost:37925' 03:46:17 INFO - SUITE-START | Running 2 tests 03:46:17 INFO - TEST-START | dromaeo_css 03:46:17 INFO - operating with platform_type : linux_ 03:46:17 INFO - Initialising browser for dromaeo_css test... 03:46:17 INFO - TEST-INFO | started process 8142 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_nlRPf/profile http://localhost:37925/getInfo.html) 03:46:22 INFO - PROCESS | 8142 | __metrics Screen width/height:1600/1200 03:46:22 INFO - PROCESS | 8142 | colorDepth:24 03:46:22 INFO - PROCESS | 8142 | Browser inner width/height: 1024/697 03:46:22 INFO - PROCESS | 8142 | __metrics 03:46:22 ERROR - PROCESS | 8142 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 03:46:23 INFO - TEST-INFO | 8142: exit 0 03:46:23 INFO - Browser initialized. 03:46:23 INFO - Running cycle 1/1 for dromaeo_css test... 03:46:23 INFO - TEST-INFO | started process 8272 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_nlRPf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:46:35 INFO - PROCESS | 8272 | RSS: Main: 156217344 03:46:35 INFO - PROCESS | 8272 | 03:47:25 INFO - PROCESS | 8272 | 1468320445188 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] 03:49:33 INFO - PROCESS | 8272 | Cycle 1(1): loaded http://localhost:37925/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37925/tests/dromaeo/cssquery-ext.html) 03:49:34 INFO - PROCESS | 8272 | RSS: Main: 159805440 03:49:34 INFO - PROCESS | 8272 | 03:52:36 INFO - PROCESS | 8272 | Cycle 1(1): loaded http://localhost:37925/tests/dromaeo/cssquery-ext.html (next: http://localhost:37925/tests/dromaeo/cssquery-jquery.html) 03:52:36 INFO - PROCESS | 8272 | RSS: Main: 157515776 03:52:36 INFO - PROCESS | 8272 | 03:55:38 INFO - PROCESS | 8272 | Cycle 1(1): loaded http://localhost:37925/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37925/tests/dromaeo/cssquery-mootools.html) 03:55:39 INFO - PROCESS | 8272 | RSS: Main: 157536256 03:55:39 INFO - PROCESS | 8272 | 03:58:40 INFO - PROCESS | 8272 | Cycle 1(1): loaded http://localhost:37925/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37925/tests/dromaeo/cssquery-prototype.html) 03:58:41 INFO - PROCESS | 8272 | RSS: Main: 156815360 03:58:41 INFO - PROCESS | 8272 | 04:01:44 INFO - PROCESS | 8272 | Cycle 1(1): loaded http://localhost:37925/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37925/tests/dromaeo/cssquery-yui.html) 04:01:44 INFO - PROCESS | 8272 | RSS: Main: 159055872 04:01:44 INFO - PROCESS | 8272 | 04:04:46 INFO - PROCESS | 8272 | Cycle 1(1): loaded http://localhost:37925/tests/dromaeo/cssquery-yui.html (next: http://localhost:37925/tests/dromaeo/cssquery-dojo.html) 04:04:47 INFO - PROCESS | 8272 | RSS: Main: 158617600 04:04:47 INFO - PROCESS | 8272 | 04:04:47 INFO - PROCESS | 8272 | __start_tp_report 04:04:47 INFO - PROCESS | 8272 | _x_x_mozilla_page_load 04:04:47 INFO - PROCESS | 8272 | _x_x_mozilla_page_load_details 04:04:47 INFO - PROCESS | 8272 | |i|pagename|runs| 04:04:47 INFO - PROCESS | 8272 | |0;dojo.html;3346.481295399214;3363.3441478911614;3398.7790793598415;3410.607780105289;3417.0432278961885;5572.0527510323245;5580.6093573449925;5587.580931430144;5627.915581266284;5642.774289028444;5584.636998595089;5618.522425593819;5639.2668953036155;5680.977424063667;5685.943140568593;5072.771725272371;5198.480151984809;5201.9479805201845;5225.451327610604;5226.634135610509;5040.36995375578;5060.493950604947;5262.158054711247;5265.578753699695;5285.2600635911;5125.026245013435;5168.689878607295;5197.948020519784;5229.633925625208;5233.084210263208;5204.817831375903;5255.421903590602;5264.184051472028;5276.050310944029;5311.601629877775;4901.607871370282;5080.415752188509;5118.6416950813455;5130.384353877521;5215.295935048758;5521.254630624894;5601.327840659147;5606.103023516218;5640.464155905182;5658.745356458928;6128.142060111588;6164;6169.876602467971;6179.412955769195;6185.659788711664;5930.703464826742;6047.425494578008;6074.96962515189;6235.844103897439;6250.3749625037135;5761.711914404305;5766.336871259775;5768.653880767126;5771.220885180531;5807.970960145172;6271.905921411182;6281.528885333618;6287.245530536365;6287.528435367366;6294.716737746812;5723.112917497794;5924.4667979882015;5956.970215148896;5991.940080599138;6019.4883434908525;6136.815895523141;6142.477889379364;6156.969215153985;6157.168782214433;6160.691965401802;6013.51891848651;6046.123312119718;6077.665728384981;6080.422359875804;6084.361142080106;5872.354041055481;6033.18551995475;6099.786507472217;6108.358622344679;6180.196574445294;4736.384270044872;4738.028704115648;4738.976305118453;4757.714537127784;4758.214894542361;4124.835006599762;4230.703850730481;4230.830766769356;4242.300020496584;4255.680823938217;5745.8563535911935;5841.474267315877;5865.706714664249;5894.322152952465;5897.52819774417;6116.694165291807;6135.386461353829;6206.968965155145;6222.906656400158;6231.158793562811;5747.885042299131;5985.191999080155;5988.161657367972;5989.221401217814;6012.939870601325;5204.245384419238;5237.73811309433;5251.789928402821;5276.973615131977;5301.602379821452;6441.066045423388;6452.387023232785;6453.935460645427;6457.580257283262;6464.450521705708;5904.0553511437965;6041.2750469943885;6255.46828519581;6257.155284036597;6270.7805226816845;6267.091271765659;6359.236891572856;6389.456896163878;6389.648569328546;6392;5984.341722410619;6037.154798328325;6052.757889684363;6054.666993315233;6058.909116363347;5971.581989260884;6132.754689812357;6136.926037943253;6143.72353244114;6156.661383623944;5996.160537524837;6085.1785009023215;6107.603005804608;6114.6636934969;6136.662483563268;6022.638641681513;6032.819015429544;6041.335453100068;6051.33435322123;6058.545609079249;5703.030484817508;5747.770089196385;5854.414558544111;5978.312494063064;6009.519238461;5987.850303742267;6005.39946005396;6038.396160383926;6049.455549000611;6051.485623721856;5951.285845698544;5951.91072133927;5961.970190149195;5962.165296858357;5979 04:04:47 INFO - PROCESS | 8272 | |1;ext.html;594.4234092929859;646.4698946863572;656.7569999100334;663.4294506724218;667.6795138333599;35365.292694146105;39150;44876.551234487684;45930.7703461483;46067.99999999991;48707;48996.26505602419;49059.26411103836;49111.26333104997;49227.26159107607;8979.506127163004;9086.50024248666;9092;9107.772305692377;9122.954385228064;8839.24866386358;8864.290856731479;8942.910570894306;8968.148025937526;8984.910150898473;8842.292616590657;8943.5975381108;8957.507337096456;8971.865422018675;8995.460272383678;8890.110988901122;8906.064863189402;8911.420757650765;8924.8661270081;8942.19520243178;8783.253423459013;8890.599923003416;8898.4660920345;8904.198622123975;8906.51014194219;44173.55826441727;44664.55335446669;44818.77590612026;44879.10241795146;44970.32544511835;3676.9632303677154;3704.407294832814;3785.337565925952;3832.5209348831395;3842.3852183650483;34097.318053639035;34616.48075278873;34812.477812832825;34862.30275394478;34910.476342854876;4552.840650577214;4629.884252893671;4643.683883011823;4678.578927896506;4707.693999889996;383539;384665;387439;388204;388568;37782.62217377846;65431.34568654348;66249.66875165593;66323.66838165779;66375;39076.80461597674;40677;40790.38814417786;40863.38704919429;40980.59019409768;14247;14495.420183192766;14523.564293071226;14540.563783086523;14588.124712517283;12122.27266364021;12155.939220303842;12188.268703877795;12229.816552751716;12254.387280635932;9203.815923681623;9203.861942070875;9210.309226807882;9225.07749225072;9305.162535371848;3465.2722928185362;3506.4214404623463;3520.2607452435277;3531.2054787673083;3577.069961809896;932.2215949681956;939.5302348825587;950.097407462913;1042.525650828871;1042.7497400623795;33048;33967.83016084904;34251.314973700384;34271.4859277111;34772;1162.2968104296947;1181.2321990705939;1225.191373693376;1261.5836773864603;1262.4255963536568;17568.38510652121;17577.121143942753;17883.910580447013;18068.90965545164;18097;652655;661074;661446;666030;677722;58275.417245827;64525.677371612845;64930;64964.350356496776;65190;1443.6968236670416;1444.7616143336231;1453.382312517176;1457.249516499004;1465.567657541028;32411;33495.665043349254;33674.326513470085;33800.49299260562;34025.82987085148;55281.17078243749;55613;55767;55805;55949.44050559442;556950;566641;567387;569629;573124;30517.542236866022;30564.847175763978;30606.693933061277;30700.84649576738;30898.227544311572;50290.24564631606;50435;50744;51015.489845101074;51360.74319628378;42509.78745106255;42929.57070429256;42933.57066429421;43019.56980430156;43670.56329436665;42792;42940.35589466223;43172;43222.78388608163;43385.349219762364;42501.523978934805;42837.78581107199;43363.78318108389;43482.34776478419;43761.124777504905;35776;36226.275474489834;36272;36883.815580921924;37150.071248219014;28974.27564310909;29044.7095529042;29135.708642913298;29153.125406237847;29289.85355073211 04:04:47 INFO - PROCESS | 8272 | |2;jquery.html;410.97534147951126;411.1632827196655;412.81717954570263;417.97492150470964;425.84456673314247;18712.90643546782;19499.805001949975;20107.89946050268;20180.495487612818;20353.28763493278;16231.990876539443;16505.17474126295;17634.647307053885;17780.377686780965;17870.731939020927;5483.698396588186;5628.26832511774;5770.249867517216;5805.867855768127;5816.912746308788;5779.3642699303045;5780.7687692492245;5826.504747096502;5892.852678683046;6636.369544893251;6510.511711621623;6547.148870646809;6605.900911486331;6612.173478315211;6614.107095542088;5979.312379076375;5982.521398288149;5988.97005514974;6116.602420842653;6543.770968016121;5760.8271751847515;5784.913226301609;5792.565557583198;5793;5803.53571714266;13928.58214253574;14585.562433127023;14593.92703036478;14667.413303467954;14705.55883323502;2176.086043861582;2291.301153148289;2422.2975337152207;2521.344450442898;2629.2638061342664;10689.091427228695;10790.946045269802;10983.890161098367;11015.228933974626;11191.776164476665;1928.3829174664113;2022.5247066939257;2073.8029887160696;2126.595946770124;2139.3368055902565;73590.99999999946;82491.58754206251;84065.57967210186;85786.57106714426;90070.54964725266;11001.669949901516;11439.714007149887;11506;11518.308901465938;11790.764184716258;16273.59316017109;16338.264778085015;16345.42791002333;16467.670646587;16525.421610243582;8143.6742530298125;8214.096449390563;8273.544955027412;8274.420790544604;8310.335173186251;7765.689372425153;7808.141104478503;7816.68733250675;7846.8430631387055;8066.637001334954;4897.3878265216845;4999.200127979506;5012.223105418666;5054.7472626368535;5108.770105345268;2048.337161689827;2052.722882410885;2067.2041264113423;2085.384811480617;2115.3336698939784;982.6364245229167;1001.689476262361;1062.4634559547378;1114.9275297105823;1115.5649296774266;17577.736333955;19480.902595487216;19914.402567922985;20035.198592056153;20128.798712012984;1000.4247557654378;1029.433811403725;1040.661784919904;1075.6611667324767;1094.2887123369715;10894.836577451344;11283.379414132138;11291.717707057225;11327.263727857662;11494.94252528732;563844;572805;575757;578295;591367;90719.54640226757;100675.49662251642;102757.48621256996;102903.48548257211;102933.48533257286;962.8074385123003;1012.696191142669;1017.8829434614966;1018.0328687746522;1020.9132223761063;18044.54888627795;18386.172622232298;18441.63116737631;18574.907125464288;18587.535311617317;39711;42101.578984209766;42444.15111697811;42843.357349639155;43780.34329484997;62444;63824;64096;64152.679236603515;64156.67921660362;7671;8229.876551851847;8799.824003519765;8991.190792828676;9031.142041506046;11869.52521899149;13442.663933401744;13470.595882123553;13509.324533773468;13579.388927498088;10858.899979102354;11560.884391156318;11897.167198296382;12042.85592868676;12241.877581224073;11943.984761295387;12161;12171.026317894724;12173.391330433265;12402.5659101931;12152.939235303767;12334.198277111958;12356.691082723004;12448;12524.624261272176;8917.643294268157;9035.548222588975;9167.220786233245;9234.307426942873;9296;10703.892961070602;11104.61133860311;11722.648320550397;11766.117541184616;12055.336956467478 04:04:47 INFO - PROCESS | 8272 | |3;mootools.html;1578.3011051102617;1593.3626549380247;1781.8485428738556;1882.9905850470764;1926.3161577639928;8230.547319897403;8578.056413794486;9149.862752058707;9179.541022948859;9214.354995150334;9200.309976751736;9493.145616894479;9547.618095276199;9578.664746733866;9593.952030239856;2428.1865575032384;2443.4135807406183;2465.938351541208;2473.4311108444977;2479.7396273391305;2444.2300675287315;2452.3010941881566;2466.1738317663603;2469.259222233332;2480.5038992201544;2423.3941514621347;2426.757324267568;2501.8373805702663;2502.73721259267;2505.473850491399;2378.155754707089;2386.7493913139133;2414.106780491221;2464.765847244527;2467.4201562632766;2344.0858065354523;2432.9513409731708;2451.36264571211;2458.0782206672498;2480.08236952327;9480.431174129575;9509.57206925683;9525.761855953657;9546.809063818755;9561.235101191958;5340.25236466895;5424.077906755861;5425.945740542584;5433.1850222466555;5433.913217356545;3645.270945810822;3730.0861288984374;3777.6033516480925;3809.466674665549;3832.118612719062;1173.178774857603;1201.3932963853285;1221.1696046688248;1233.7717522258322;1262.5959692898277;13399.59801205975;13478.39347229377;13516.662083447894;13526.391312390868;13527.594172174851;4931.3589233399425;4986.376702912136;5067.467915868854;5098.362704661918;5114.028334616411;11325.603603873826;11478.655640330804;11522.827157592643;11541.480633371519;11557.942210288895;5498.340199176125;5521.337439507285;5558.72206389687;5570.610057296031;5583.664980101207;4394.472663280427;4717.481077081518;4884.607886752329;4887.218045112836;5105.719185444762;4260.723053001607;4318.805653745589;4337.73973561581;4359.280718681445;4417.690761646654;1327.588447581253;1328.8073229381685;1337.8394592648945;1342.9865701343058;1343.6506508307714;1012.6708819633649;1024.6925922223304;1027.6043723166636;1030.4384110659707;1042.0517329230363;6216.160818289473;6302;6370.0763389308295;6439.162908821917;6512.6092434454085;460.10739166017817;468.29989166196754;470.3203870407229;473.94312682477636;474.058992899095;4588.908221835544;4673.462551806518;4734.171519983989;4748.477667456577;4815.22956326986;11298.7175320616;11923.940380298043;12298;12342.506299747909;12347.073969452327;11618.419079046183;12055.578054768217;12087;12156.574519891761;12160.69598260033;8425.789355266168;8520.318374530023;8537.530435825965;8554.35842311829;8586.441881277697;6556.770513032021;6638.734450621921;6714.429273511806;6817.89773153413;6837.589744615339;10855.511501982272;10925.289856159325;11149.777004459704;11194.160437967348;11256.212065155689;11290.81446448144;11483.827742584035;11485.540578376771;11612;11746;7736.7292144774665;8192.54940978252;8285;8303.792405189919;8501.27739142155;9404.670836520689;9438.905610944077;9467.053294670477;9479.28905332089;9548.761280968032;8193.59032048407;8413.116622754767;8498.192671696179;8519.06290308078;8595.871061934202;8212.58937053133;8237.176282371714;8417.116202798617;8420.326373889951;8517.276031537142;7287.8542429152185;7446.106467223968;7514.211007844097;7542.6605802740105;7546.622668866425;5451.618386712892;5597.272354593877;5693.658380497018;5766;5845.006348920609;5322.840314790563;5370.9731451342495;5456.645318054314;5519.39286678473;5529.861753456195 04:04:47 INFO - PROCESS | 8272 | |4;prototype.html;346.674126321258;349.58923265163435;349.66257561453193;350.84738138909563;353.62162486139806;5597.3283206015285;5619.690916999563;5631.099983508486;5652.07829338025;5720.427957204278;5570.136628822539;5571;5593.356763972144;5594.524465420434;5597.580181486384;4122.42286079949;4342;4362.214801335758;4363.934540981888;4389.144116897206;4352.173087113454;4365.497967733703;4379.255526560476;4400.97799511002;4405.735655860659;4167.9583204167875;4336.21948049351;4350.934735978963;4366.607005369516;4372.540883207265;4328.134373125356;4346.391505189276;4348.934765978513;4357.694961352707;4373.256546387106;3837.827297771579;3850.5175507429562;3857.594952529972;3860.305145073886;3890.5720370759195;5216.626434972079;5485.753141108659;5489.725513724298;5492.835214943558;5520.392756796749;4997.700137991696;5013.298138260647;5013.423456302499;5026.441803041069;5028.22062580297;5878.206442130343;5905.970470147622;5918.704064796786;5928.940710592882;5944.673042982634;4005.359142537209;4212.873613791591;4229.090745489734;4238.830446782125;4247.426597409372;6113.327533971304;6143.32423433422;6168.722407491674;6175.876482470326;6179.969100154515;4277.807498662505;4299.634531064832;4302.7848607569495;4309.202797482476;4313.762743049162;4269.914601707948;4310.568943105664;4374.03771170342;4403.603675669206;4424.446944131983;4985.551300382983;5003.099442100457;5007.173816320266;5036.899262014813;5039.949600504021;5870.148828419855;5889;5926.7925622603;5928.970355148283;5934.347221805598;1492.7387707151206;1533.5092770313393;1551.7517197248385;1554.9533513994597;1564.7105285522214;988.9961688885787;993.3493561717087;1011.8937511561327;1016.3292227130206;1031.886492485826;5150.072986862326;5155.587552995751;5177.352830896138;5193.766280517386;5223.947760522422;5342.332208473941;5383.43473935239;5414.810481633124;5436.864078398072;5440.001598824861;5447.264619276426;5689.004424225744;5833.329167145747;5844.211031510692;5867.765289388462;3223;3234.433974054531;3244.5782048334036;3267.950980735291;3295.736341092707;6142.78500252489;6203.635200255936;6314.273858506331;6334.524910631629;6400.647964361911;6149.38651073292;6202.937970620236;6203.945329294031;6212.1303017577575;6226.5641405101205;6180.289266734293;6282.963311053625;6310.305866354697;6325.873482530324;6328.430441260309;5898.764049437975;6085.391460853879;6086;6159.706461643105;6164.4143806338325;5958.225430693982;5982.341942386247;6011.27864656244;6022.939770602238;6024.638521688713;6104.26748790148;6232.69113486173;6321.1782468278825;6350.237971443456;6351.522906066545;4368;4375.47494300686;4386.960063570455;4399.054203346296;4428.911421771611;5906.586538942232;6030.6080104793045;6082.7262773174425;6098.603590766586;6120.908186377297;5975.462208401264;5977.970110149421;5982.312034116132;5984.970075149597;5989.850253743692;5905.084711869667;5909.674967876808;5921.585489015728;5956.731947062306;5961.493273071837;5746.068544876526;5758.222639943554;5870.354261031369;5890.410958904075;5910.615809972338;5933.376995415592;5965.642061476326;5974.520573961931;5987.940120598738;6015.947209238453;5701.372848986525;5788.160716695971;5848.327442344014;5862.589618726648;5864.618799778001 04:04:47 INFO - PROCESS | 8272 | |5;yui.html;845.1506236232585;852.2585350744852;893.2005854759994;901.3150005995445;909.1226965977833;16411.34354625815;16631.584210394747;16943;16990.5752356191;17008.319667213313;15456.613584660388;15699.921500392511;15726;15735.92132039341;15740;703.0965209705529;836.7364280251701;845.6828689241535;857.9656813727474;860.926821220197;837.4723923927917;838.6645341863242;840.6553313141613;844.6494704697574;844.8859403980446;908.7500937242245;910.9225715814164;913.5295322908707;915.9816803663923;917.3624331089895;900.6667533012761;903.0698380667923;906.537665790445;909.2816674826879;910.4855756497558;668.2916108924555;670.6747227594612;671.6675245753335;672.2269390201259;674.6188403551978;15085.924570377078;15087.849121508863;15088;15097.32062057199;15176.089434633957;14590.197539135343;14595.051321664057;14882.479113230986;15553.377864885391;16434.6713065738;12382.688877738103;12807.359632018362;12935.741285174337;12972.286524241163;13273.07088503805;4017.61832625903;4034.9394759078637;4047.5750046245307;4057.6956728245204;4082.9183416331803;66848;74730;74762.25237747608;74995;75660.97356105804;11801;12160.452779624939;12370.81443778344;12478;12843.422046007952;20596.897015515126;21405.67891481629;21425.357239282846;22246.77753222447;22343;8807.647694092164;8953.955230223937;9005.819883602291;9068.365214434927;9478.573464194127;4781.211100168433;4814.903701925942;4847.684900481528;4904.166291730415;4907.754612269372;3918.275119102975;4012.29784787661;4020.7587544747407;4024.436578878959;4025.215083058834;683.4737252315689;688.7899190746871;693.1335830212234;703.9507234493639;708.4898872811567;804.0672819529318;808.0667178143302;818.3657665309432;820.327331588104;840.3319361107812;10601.734956626146;10614.203934704929;10762.192835537366;10777.515011824487;10962.616308429167;739.8187444076236;792.6789650191681;817.4686453805074;835.6740871060291;838.4843321357322;4813.78337974792;4918.008266481854;4936.605071594264;4992.340899596174;5055.620828437882;117187;119537.40231298788;121093.39453302677;123365;124215;64028;64422.033669494995;64817.67591162108;66193;101192.98807011983;67295;70106;93194.53402732943;93453;93486;9565.713028609152;9739.41563506192;9848.409095454295;9853.605855765689;9936.155426788515;55073.17390239069;55576;55582.72208638931;56299.43700563106;57084;50011;51794.22308665298;57177.71411143084;76213;76483.23516764761;12822.974162066826;12882.96936245117;12987.090903636654;13769;14381.64045898861;15198.772018419511;15686.137262450675;15770;15852.048877067413;15903.443379481663;14465.13209207451;14773.704525909636;15217;15769.29038193307;16298.674026519166;15123.243837807846;15193.316300766272;15310.464133755711;15506;15584.766228506354;13801.861981380058;14512.201828899511;14976;15075.170865602497;15138.924305378403;10564.735881603021;10634.627788027381;10754.462276885968;10800.729981750519;10889.346639201673;10769.62306319275;11136.939666161787;11213;11287.20989530725;11376 04:04:47 INFO - PROCESS | 8272 | __end_tp_report 04:04:47 INFO - PROCESS | 8272 | __start_cc_report 04:04:47 INFO - PROCESS | 8272 | _x_x_mozilla_cycle_collect,341 04:04:47 INFO - PROCESS | 8272 | __end_cc_report 04:04:47 INFO - PROCESS | 8272 | __startTimestamp1468321487227__endTimestamp 04:04:47 INFO - PROCESS | 8272 | 04:04:47 INFO - PROCESS | 8272 | ------- Summary: start ------- 04:04:47 INFO - PROCESS | 8272 | Number of tests: 6 04:04:47 INFO - PROCESS | 8272 | 04:04:47 INFO - PROCESS | 8272 | [#0] dojo.html Cycles:165 Average:5695.39 Median:5961.97 stddev:645.81 (10.8%) stddev-sans-first:620.94 04:04:47 INFO - PROCESS | 8272 | Values: 3346.5 3363.3 3398.8 3410.6 3417.0 5572.1 5580.6 5587.6 5627.9 5642.8 5584.6 5618.5 5639.3 5681.0 5685.9 5072.8 5198.5 5201.9 5225.5 5226.6 5040.4 5060.5 5262.2 5265.6 5285.3 5125.0 5168.7 5197.9 5229.6 5233.1 5204.8 5255.4 5264.2 5276.1 5311.6 4901.6 5080.4 5118.6 5130.4 5215.3 5521.3 5601.3 5606.1 5640.5 5658.7 6128.1 6164.0 6169.9 6179.4 6185.7 5930.7 6047.4 6075.0 6235.8 6250.4 5761.7 5766.3 5768.7 5771.2 5808.0 6271.9 6281.5 6287.2 6287.5 6294.7 5723.1 5924.5 5957.0 5991.9 6019.5 6136.8 6142.5 6157.0 6157.2 6160.7 6013.5 6046.1 6077.7 6080.4 6084.4 5872.4 6033.2 6099.8 6108.4 6180.2 4736.4 4738.0 4739.0 4757.7 4758.2 4124.8 4230.7 4230.8 4242.3 4255.7 5745.9 5841.5 5865.7 5894.3 5897.5 6116.7 6135.4 6207.0 6222.9 6231.2 5747.9 5985.2 5988.2 5989.2 6012.9 5204.2 5237.7 5251.8 5277.0 5301.6 6441.1 6452.4 6453.9 6457.6 6464.5 5904.1 6041.3 6255.5 6257.2 6270.8 6267.1 6359.2 6389.5 6389.6 6392.0 5984.3 6037.2 6052.8 6054.7 6058.9 5971.6 6132.8 6136.9 6143.7 6156.7 5996.2 6085.2 6107.6 6114.7 6136.7 6022.6 6032.8 6041.3 6051.3 6058.5 5703.0 5747.8 5854.4 5978.3 6009.5 5987.9 6005.4 6038.4 6049.5 6051.5 5951.3 5951.9 5962.0 5962.2 5979.0 04:04:47 INFO - PROCESS | 8272 | 04:04:47 INFO - PROCESS | 8272 | [#1] ext.html Cycles:180 Average:68511.08 Median:43374.57 stddev:147327.17 (339.7%) stddev-sans-first:147652.21 04:04:47 INFO - PROCESS | 8272 | Values: 594.4 646.5 656.8 663.4 667.7 35365.3 39150.0 44876.6 45930.8 46068.0 48707.0 48996.3 49059.3 49111.3 49227.3 8979.5 9086.5 9092.0 9107.8 9123.0 8839.2 8864.3 8942.9 8968.1 8984.9 8842.3 8943.6 8957.5 8971.9 8995.5 8890.1 8906.1 8911.4 8924.9 8942.2 8783.3 8890.6 8898.5 8904.2 8906.5 44173.6 44664.6 44818.8 44879.1 44970.3 3677.0 3704.4 3785.3 3832.5 3842.4 34097.3 34616.5 34812.5 34862.3 34910.5 4552.8 4629.9 4643.7 4678.6 4707.7 383539.0 384665.0 387439.0 388204.0 388568.0 37782.6 65431.3 66249.7 66323.7 66375.0 39076.8 40677.0 40790.4 40863.4 40980.6 14247.0 14495.4 14523.6 14540.6 14588.1 12122.3 12155.9 12188.3 12229.8 12254.4 9203.8 9203.9 9210.3 9225.1 9305.2 3465.3 3506.4 3520.3 3531.2 3577.1 932.2 939.5 950.1 1042.5 1042.7 33048.0 33967.8 34251.3 34271.5 34772.0 1162.3 1181.2 1225.2 1261.6 1262.4 17568.4 17577.1 17883.9 18068.9 18097.0 652655.0 661074.0 661446.0 666030.0 677722.0 58275.4 64525.7 64930.0 64964.4 65190.0 1443.7 1444.8 1453.4 1457.2 1465.6 32411.0 33495.7 33674.3 33800.5 34025.8 55281.2 55613.0 55767.0 55805.0 55949.4 556950.0 566641.0 567387.0 569629.0 573124.0 30517.5 30564.8 30606.7 30700.8 30898.2 50290.2 50435.0 50744.0 51015.5 51360.7 42509.8 42929.6 42933.6 43019.6 43670.6 42792.0 42940.4 43172.0 43222.8 43385.3 42501.5 42837.8 43363.8 43482.3 43761.1 35776.0 36226.3 36272.0 36883.8 37150.1 28974.3 29044.7 29135.7 29153.1 29289.9 04:04:47 INFO - PROCESS | 8272 | 04:04:47 INFO - PROCESS | 8272 | [#2] jquery.html Cycles:180 Average:31799.79 Median:2059.96 stddev:94877.60 (4605.8%) stddev-sans-first:95114.48 04:04:47 INFO - PROCESS | 8272 | Values: 411.0 411.2 412.8 418.0 425.8 18712.9 19499.8 20107.9 20180.5 20353.3 16232.0 16505.2 17634.6 17780.4 17870.7 5483.7 5628.3 5770.2 5805.9 5816.9 5779.4 5780.8 5826.5 5892.9 6636.4 6510.5 6547.1 6605.9 6612.2 6614.1 5979.3 5982.5 5989.0 6116.6 6543.8 5760.8 5784.9 5792.6 5793.0 5803.5 13928.6 14585.6 14593.9 14667.4 14705.6 2176.1 2291.3 2422.3 2521.3 2629.3 10689.1 10790.9 10983.9 11015.2 11191.8 1928.4 2022.5 2073.8 2126.6 2139.3 73591.0 82491.6 84065.6 85786.6 90070.5 11001.7 11439.7 11506.0 11518.3 11790.8 16273.6 16338.3 16345.4 16467.7 16525.4 8143.7 8214.1 8273.5 8274.4 8310.3 7765.7 7808.1 7816.7 7846.8 8066.6 4897.4 4999.2 5012.2 5054.7 5108.8 2048.3 2052.7 2067.2 2085.4 2115.3 982.6 1001.7 1062.5 1114.9 1115.6 17577.7 19480.9 19914.4 20035.2 20128.8 1000.4 1029.4 1040.7 1075.7 1094.3 10894.8 11283.4 11291.7 11327.3 11494.9 563844.0 572805.0 575757.0 578295.0 591367.0 90719.5 100675.5 102757.5 102903.5 102933.5 962.8 1012.7 1017.9 1018.0 1020.9 18044.5 18386.2 18441.6 18574.9 18587.5 39711.0 42101.6 42444.2 42843.4 43780.3 62444.0 63824.0 64096.0 64152.7 64156.7 7671.0 8229.9 8799.8 8991.2 9031.1 11869.5 13442.7 13470.6 13509.3 13579.4 10858.9 11560.9 11897.2 12042.9 12241.9 11944.0 12161.0 12171.0 12173.4 12402.6 12152.9 12334.2 12356.7 12448.0 12524.6 8917.6 9035.5 9167.2 9234.3 9296.0 10703.9 11104.6 11722.6 11766.1 12055.3 04:04:47 INFO - PROCESS | 8272 | 04:04:47 INFO - PROCESS | 8272 | [#3] mootools.html Cycles:180 Average:6273.02 Median:2593.90 stddev:3651.55 (140.8%) stddev-sans-first:3644.75 04:04:47 INFO - PROCESS | 8272 | Values: 1578.3 1593.4 1781.8 1883.0 1926.3 8230.5 8578.1 9149.9 9179.5 9214.4 9200.3 9493.1 9547.6 9578.7 9594.0 2428.2 2443.4 2465.9 2473.4 2479.7 2444.2 2452.3 2466.2 2469.3 2480.5 2423.4 2426.8 2501.8 2502.7 2505.5 2378.2 2386.7 2414.1 2464.8 2467.4 2344.1 2433.0 2451.4 2458.1 2480.1 9480.4 9509.6 9525.8 9546.8 9561.2 5340.3 5424.1 5425.9 5433.2 5433.9 3645.3 3730.1 3777.6 3809.5 3832.1 1173.2 1201.4 1221.2 1233.8 1262.6 13399.6 13478.4 13516.7 13526.4 13527.6 4931.4 4986.4 5067.5 5098.4 5114.0 11325.6 11478.7 11522.8 11541.5 11557.9 5498.3 5521.3 5558.7 5570.6 5583.7 4394.5 4717.5 4884.6 4887.2 5105.7 4260.7 4318.8 4337.7 4359.3 4417.7 1327.6 1328.8 1337.8 1343.0 1343.7 1012.7 1024.7 1027.6 1030.4 1042.1 6216.2 6302.0 6370.1 6439.2 6512.6 460.1 468.3 470.3 473.9 474.1 4588.9 4673.5 4734.2 4748.5 4815.2 11298.7 11923.9 12298.0 12342.5 12347.1 11618.4 12055.6 12087.0 12156.6 12160.7 8425.8 8520.3 8537.5 8554.4 8586.4 6556.8 6638.7 6714.4 6817.9 6837.6 10855.5 10925.3 11149.8 11194.2 11256.2 11290.8 11483.8 11485.5 11612.0 11746.0 7736.7 8192.5 8285.0 8303.8 8501.3 9404.7 9438.9 9467.1 9479.3 9548.8 8193.6 8413.1 8498.2 8519.1 8595.9 8212.6 8237.2 8417.1 8420.3 8517.3 7287.9 7446.1 7514.2 7542.7 7546.6 5451.6 5597.3 5693.7 5766.0 5845.0 5322.8 5371.0 5456.6 5519.4 5529.9 04:04:47 INFO - PROCESS | 8272 | 04:04:47 INFO - PROCESS | 8272 | [#4] prototype.html Cycles:180 Average:4953.16 Median:5582.18 stddev:1457.35 (26.1%) stddev-sans-first:1419.84 04:04:47 INFO - PROCESS | 8272 | Values: 346.7 349.6 349.7 350.8 353.6 5597.3 5619.7 5631.1 5652.1 5720.4 5570.1 5571.0 5593.4 5594.5 5597.6 4122.4 4342.0 4362.2 4363.9 4389.1 4352.2 4365.5 4379.3 4401.0 4405.7 4168.0 4336.2 4350.9 4366.6 4372.5 4328.1 4346.4 4348.9 4357.7 4373.3 3837.8 3850.5 3857.6 3860.3 3890.6 5216.6 5485.8 5489.7 5492.8 5520.4 4997.7 5013.3 5013.4 5026.4 5028.2 5878.2 5906.0 5918.7 5928.9 5944.7 4005.4 4212.9 4229.1 4238.8 4247.4 6113.3 6143.3 6168.7 6175.9 6180.0 4277.8 4299.6 4302.8 4309.2 4313.8 4269.9 4310.6 4374.0 4403.6 4424.4 4985.6 5003.1 5007.2 5036.9 5039.9 5870.1 5889.0 5926.8 5929.0 5934.3 1492.7 1533.5 1551.8 1555.0 1564.7 989.0 993.3 1011.9 1016.3 1031.9 5150.1 5155.6 5177.4 5193.8 5223.9 5342.3 5383.4 5414.8 5436.9 5440.0 5447.3 5689.0 5833.3 5844.2 5867.8 3223.0 3234.4 3244.6 3268.0 3295.7 6142.8 6203.6 6314.3 6334.5 6400.6 6149.4 6202.9 6203.9 6212.1 6226.6 6180.3 6283.0 6310.3 6325.9 6328.4 5898.8 6085.4 6086.0 6159.7 6164.4 5958.2 5982.3 6011.3 6022.9 6024.6 6104.3 6232.7 6321.2 6350.2 6351.5 4368.0 4375.5 4387.0 4399.1 4428.9 5906.6 6030.6 6082.7 6098.6 6120.9 5975.5 5978.0 5982.3 5985.0 5989.9 5905.1 5909.7 5921.6 5956.7 5961.5 5746.1 5758.2 5870.4 5890.4 5910.6 5933.4 5965.6 5974.5 5987.9 6015.9 5701.4 5788.2 5848.3 5862.6 5864.6 04:04:47 INFO - PROCESS | 8272 | 04:04:47 INFO - PROCESS | 8272 | [#5] yui.html Cycles:180 Average:20251.27 Median:4432.06 stddev:28210.16 (636.5%) stddev-sans-first:28251.66 04:04:47 INFO - PROCESS | 8272 | Values: 845.2 852.3 893.2 901.3 909.1 16411.3 16631.6 16943.0 16990.6 17008.3 15456.6 15699.9 15726.0 15735.9 15740.0 703.1 836.7 845.7 858.0 860.9 837.5 838.7 840.7 844.6 844.9 908.8 910.9 913.5 916.0 917.4 900.7 903.1 906.5 909.3 910.5 668.3 670.7 671.7 672.2 674.6 15085.9 15087.8 15088.0 15097.3 15176.1 14590.2 14595.1 14882.5 15553.4 16434.7 12382.7 12807.4 12935.7 12972.3 13273.1 4017.6 4034.9 4047.6 4057.7 4082.9 66848.0 74730.0 74762.3 74995.0 75661.0 11801.0 12160.5 12370.8 12478.0 12843.4 20596.9 21405.7 21425.4 22246.8 22343.0 8807.6 8954.0 9005.8 9068.4 9478.6 4781.2 4814.9 4847.7 4904.2 4907.8 3918.3 4012.3 4020.8 4024.4 4025.2 683.5 688.8 693.1 704.0 708.5 804.1 808.1 818.4 820.3 840.3 10601.7 10614.2 10762.2 10777.5 10962.6 739.8 792.7 817.5 835.7 838.5 4813.8 4918.0 4936.6 4992.3 5055.6 117187.0 119537.4 121093.4 123365.0 124215.0 64028.0 64422.0 64817.7 66193.0 101193.0 67295.0 70106.0 93194.5 93453.0 93486.0 9565.7 9739.4 9848.4 9853.6 9936.2 55073.2 55576.0 55582.7 56299.4 57084.0 50011.0 51794.2 57177.7 76213.0 76483.2 12823.0 12883.0 12987.1 13769.0 14381.6 15198.8 15686.1 15770.0 15852.0 15903.4 14465.1 14773.7 15217.0 15769.3 16298.7 15123.2 15193.3 15310.5 15506.0 15584.8 13801.9 14512.2 14976.0 15075.2 15138.9 10564.7 10634.6 10754.5 10800.7 10889.3 10769.6 11136.9 11213.0 11287.2 11376.0 04:04:47 INFO - PROCESS | 8272 | -------- Summary: end -------- 04:04:47 INFO - PROCESS | 8272 | 04:04:47 INFO - TEST-INFO | 8272: exit 0 04:04:47 INFO - TEST-OK | dromaeo_css | took 1110072ms 04:04:47 INFO - TEST-START | kraken 04:04:47 INFO - operating with platform_type : linux_ 04:04:47 INFO - Initialising browser for kraken test... 04:04:47 INFO - TEST-INFO | started process 8515 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9Y0uRG/profile http://localhost:37925/getInfo.html) 04:04:52 INFO - PROCESS | 8515 | __metrics Screen width/height:1600/1200 04:04:52 INFO - PROCESS | 8515 | colorDepth:24 04:04:52 INFO - PROCESS | 8515 | Browser inner width/height: 1024/697 04:04:52 INFO - PROCESS | 8515 | __metrics 04:04:52 ERROR - PROCESS | 8515 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 04:04:53 INFO - TEST-INFO | 8515: exit 0 04:04:53 INFO - Browser initialized. 04:04:53 INFO - Running cycle 1/1 for kraken test... 04:04:53 INFO - TEST-INFO | started process 8645 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9Y0uRG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:05:05 INFO - PROCESS | 8645 | RSS: Main: 156286976 04:05:05 INFO - PROCESS | 8645 | 04:05:07 INFO - PROCESS | 8645 | Cycle 1(1): loaded http://localhost:37925/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37925/tests/kraken/driver.html?testName=audio-beat-detection) 04:05:08 INFO - PROCESS | 8645 | RSS: Main: 161206272 04:05:08 INFO - PROCESS | 8645 | 04:05:11 INFO - PROCESS | 8645 | Cycle 1(1): loaded http://localhost:37925/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37925/tests/kraken/driver.html?testName=audio-dft) 04:05:12 INFO - PROCESS | 8645 | RSS: Main: 160063488 04:05:12 INFO - PROCESS | 8645 | 04:05:15 INFO - PROCESS | 8645 | Cycle 1(1): loaded http://localhost:37925/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37925/tests/kraken/driver.html?testName=audio-fft) 04:05:15 INFO - PROCESS | 8645 | RSS: Main: 160993280 04:05:15 INFO - PROCESS | 8645 | 04:05:17 INFO - PROCESS | 8645 | Cycle 1(1): loaded http://localhost:37925/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37925/tests/kraken/driver.html?testName=audio-oscillator) 04:05:18 INFO - PROCESS | 8645 | RSS: Main: 160755712 04:05:18 INFO - PROCESS | 8645 | 04:05:20 INFO - PROCESS | 8645 | Cycle 1(1): loaded http://localhost:37925/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37925/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:05:21 INFO - PROCESS | 8645 | RSS: Main: 160890880 04:05:21 INFO - PROCESS | 8645 | 04:05:24 INFO - PROCESS | 8645 | Cycle 1(1): loaded http://localhost:37925/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37925/tests/kraken/driver.html?testName=imaging-darkroom) 04:05:24 INFO - PROCESS | 8645 | RSS: Main: 160448512 04:05:24 INFO - PROCESS | 8645 | 04:05:28 INFO - PROCESS | 8645 | Cycle 1(1): loaded http://localhost:37925/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37925/tests/kraken/driver.html?testName=imaging-desaturate) 04:05:28 INFO - PROCESS | 8645 | RSS: Main: 160776192 04:05:28 INFO - PROCESS | 8645 | 04:05:31 INFO - PROCESS | 8645 | Cycle 1(1): loaded http://localhost:37925/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37925/tests/kraken/driver.html?testName=json-parse-financial) 04:05:32 INFO - PROCESS | 8645 | RSS: Main: 161771520 04:05:32 INFO - PROCESS | 8645 | 04:05:33 INFO - PROCESS | 8645 | Cycle 1(1): loaded http://localhost:37925/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37925/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:05:34 INFO - PROCESS | 8645 | RSS: Main: 161374208 04:05:34 INFO - PROCESS | 8645 | 04:05:36 INFO - PROCESS | 8645 | Cycle 1(1): loaded http://localhost:37925/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37925/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:05:36 INFO - PROCESS | 8645 | RSS: Main: 160915456 04:05:36 INFO - PROCESS | 8645 | 04:05:38 INFO - PROCESS | 8645 | Cycle 1(1): loaded http://localhost:37925/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37925/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:05:39 INFO - PROCESS | 8645 | RSS: Main: 160944128 04:05:39 INFO - PROCESS | 8645 | 04:05:42 INFO - PROCESS | 8645 | Cycle 1(1): loaded http://localhost:37925/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37925/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:05:42 INFO - PROCESS | 8645 | RSS: Main: 162394112 04:05:42 INFO - PROCESS | 8645 | 04:05:45 INFO - PROCESS | 8645 | Cycle 1(1): loaded http://localhost:37925/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37925/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:05:45 INFO - PROCESS | 8645 | RSS: Main: 161910784 04:05:45 INFO - PROCESS | 8645 | 04:05:47 INFO - PROCESS | 8645 | Cycle 1(1): loaded http://localhost:37925/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37925/tests/kraken/driver.html?testName=ai-astar) 04:05:47 INFO - PROCESS | 8645 | RSS: Main: 162615296 04:05:47 INFO - PROCESS | 8645 | 04:05:47 INFO - PROCESS | 8645 | __start_tp_report 04:05:47 INFO - PROCESS | 8645 | _x_x_mozilla_page_load 04:05:47 INFO - PROCESS | 8645 | _x_x_mozilla_page_load_details 04:05:47 INFO - PROCESS | 8645 | |i|pagename|runs| 04:05:47 INFO - PROCESS | 8645 | |0;ai-astar;111;105;110;111;115;110;111;112;111;112 04:05:47 INFO - PROCESS | 8645 | |1;audio-beat-detection;162;126;148;170;126;161;155;125;193;125 04:05:47 INFO - PROCESS | 8645 | |2;audio-dft;162;163;161;163;163;162;161;161;162;164 04:05:47 INFO - PROCESS | 8645 | |3;audio-fft;76;77;77;183;76;76;75;76;185;76 04:05:47 INFO - PROCESS | 8645 | |4;audio-oscillator;85;85;141;84;86;84;131;85;86;151 04:05:47 INFO - PROCESS | 8645 | |5;imaging-gaussian-blur;117;117;118;118;117;117;117;117;118;118 04:05:47 INFO - PROCESS | 8645 | |6;imaging-darkroom;147;147;147;148;147;148;150;149;148;149 04:05:47 INFO - PROCESS | 8645 | |7;imaging-desaturate;95;95;96;95;95;95;95;95;100;100 04:05:47 INFO - PROCESS | 8645 | |8;json-parse-financial;51;51;52;51;51;53;52;54;50;54 04:05:47 INFO - PROCESS | 8645 | |9;json-stringify-tinderbox;59;59;60;60;60;65;59;60;61;59 04:05:47 INFO - PROCESS | 8645 | |10;stanford-crypto-aes;77;78;75;83;78;77;81;77;117;78 04:05:47 INFO - PROCESS | 8645 | |11;stanford-crypto-ccm;130;129;130;120;119;116;129;119;136;132 04:05:47 INFO - PROCESS | 8645 | |12;stanford-crypto-pbkdf2;160;155;153;155;153;151;152;155;153;154 04:05:47 INFO - PROCESS | 8645 | |13;stanford-crypto-sha256-iterative;64;63;65;62;62;64;63;61;60;73 04:05:47 INFO - PROCESS | 8645 | __end_tp_report 04:05:47 INFO - PROCESS | 8645 | __start_cc_report 04:05:47 INFO - PROCESS | 8645 | _x_x_mozilla_cycle_collect,876 04:05:47 INFO - PROCESS | 8645 | __end_cc_report 04:05:47 INFO - PROCESS | 8645 | __startTimestamp1468321547826__endTimestamp 04:05:47 INFO - PROCESS | 8645 | 04:05:47 INFO - PROCESS | 8645 | ------- Summary: start ------- 04:05:47 INFO - PROCESS | 8645 | Number of tests: 14 04:05:47 INFO - PROCESS | 8645 | 04:05:47 INFO - PROCESS | 8645 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:2.49 (2.2%) stddev-sans-first:2.64 04:05:47 INFO - PROCESS | 8645 | Values: 111.0 105.0 110.0 111.0 115.0 110.0 111.0 112.0 111.0 112.0 04:05:47 INFO - PROCESS | 8645 | 04:05:47 INFO - PROCESS | 8645 | [#1] audio-beat-detection Cycles:10 Average:149.10 Median:158.00 stddev:23.42 (14.8%) stddev-sans-first:24.37 04:05:47 INFO - PROCESS | 8645 | Values: 162.0 126.0 148.0 170.0 126.0 161.0 155.0 125.0 193.0 125.0 04:05:47 INFO - PROCESS | 8645 | 04:05:47 INFO - PROCESS | 8645 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.50 stddev:1.03 (0.6%) stddev-sans-first:1.09 04:05:47 INFO - PROCESS | 8645 | Values: 162.0 163.0 161.0 163.0 163.0 162.0 161.0 161.0 162.0 164.0 04:05:47 INFO - PROCESS | 8645 | 04:05:47 INFO - PROCESS | 8645 | [#3] audio-fft Cycles:10 Average:97.70 Median:76.00 stddev:45.49 (59.9%) stddev-sans-first:47.57 04:05:47 INFO - PROCESS | 8645 | Values: 76.0 77.0 77.0 183.0 76.0 76.0 75.0 76.0 185.0 76.0 04:05:47 INFO - PROCESS | 8645 | 04:05:47 INFO - PROCESS | 8645 | [#4] audio-oscillator Cycles:10 Average:101.80 Median:85.00 stddev:27.47 (32.3%) stddev-sans-first:28.45 04:05:47 INFO - PROCESS | 8645 | Values: 85.0 85.0 141.0 84.0 86.0 84.0 131.0 85.0 86.0 151.0 04:05:47 INFO - PROCESS | 8645 | 04:05:47 INFO - PROCESS | 8645 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:05:47 INFO - PROCESS | 8645 | Values: 117.0 117.0 118.0 118.0 117.0 117.0 117.0 117.0 118.0 118.0 04:05:47 INFO - PROCESS | 8645 | 04:05:47 INFO - PROCESS | 8645 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:1.05 (0.7%) stddev-sans-first:1.05 04:05:47 INFO - PROCESS | 8645 | Values: 147.0 147.0 147.0 148.0 147.0 148.0 150.0 149.0 148.0 149.0 04:05:47 INFO - PROCESS | 8645 | 04:05:47 INFO - PROCESS | 8645 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:95.00 stddev:2.08 (2.2%) stddev-sans-first:2.17 04:05:47 INFO - PROCESS | 8645 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 100.0 100.0 04:05:47 INFO - PROCESS | 8645 | 04:05:47 INFO - PROCESS | 8645 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:52.00 stddev:1.37 (2.6%) stddev-sans-first:1.41 04:05:47 INFO - PROCESS | 8645 | Values: 51.0 51.0 52.0 51.0 51.0 53.0 52.0 54.0 50.0 54.0 04:05:47 INFO - PROCESS | 8645 | 04:05:47 INFO - PROCESS | 8645 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:1.81 (3.0%) stddev-sans-first:1.87 04:05:47 INFO - PROCESS | 8645 | Values: 59.0 59.0 60.0 60.0 60.0 65.0 59.0 60.0 61.0 59.0 04:05:47 INFO - PROCESS | 8645 | 04:05:47 INFO - PROCESS | 8645 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:78.00 stddev:12.47 (16.0%) stddev-sans-first:13.09 04:05:47 INFO - PROCESS | 8645 | Values: 77.0 78.0 75.0 83.0 78.0 77.0 81.0 77.0 117.0 78.0 04:05:47 INFO - PROCESS | 8645 | 04:05:47 INFO - PROCESS | 8645 | [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:129.50 stddev:6.83 (5.3%) stddev-sans-first:7.09 04:05:47 INFO - PROCESS | 8645 | Values: 130.0 129.0 130.0 120.0 119.0 116.0 129.0 119.0 136.0 132.0 04:05:47 INFO - PROCESS | 8645 | 04:05:47 INFO - PROCESS | 8645 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.10 Median:154.50 stddev:2.47 (1.6%) stddev-sans-first:1.42 04:05:47 INFO - PROCESS | 8645 | Values: 160.0 155.0 153.0 155.0 153.0 151.0 152.0 155.0 153.0 154.0 04:05:47 INFO - PROCESS | 8645 | 04:05:47 INFO - PROCESS | 8645 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:63.50 stddev:3.59 (5.7%) stddev-sans-first:3.81 04:05:47 INFO - PROCESS | 8645 | Values: 64.0 63.0 65.0 62.0 62.0 64.0 63.0 61.0 60.0 73.0 04:05:47 INFO - PROCESS | 8645 | -------- Summary: end -------- 04:05:47 INFO - PROCESS | 8645 | 04:05:48 INFO - TEST-INFO | 8645: exit 0 04:05:48 INFO - TEST-OK | kraken | took 60790ms 04:05:48 INFO - SUITE-END | took 1170s 04:05:48 INFO - Completed test suite (00:19:31) 04:05:48 INFO - javascript benchmark 04:05:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7554.003564272144, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3346.481295399214, 3363.3441478911614, 3398.7790793598415, 3410.607780105289, 3417.0432278961885, 5572.0527510323245, 5580.6093573449925, 5587.580931430144, 5627.915581266284, 5642.774289028444, 5584.636998595089, 5618.522425593819, 5639.2668953036155, 5680.977424063667, 5685.943140568593, 5072.771725272371, 5198.480151984809, 5201.9479805201845, 5225.451327610604, 5226.634135610509, 5040.36995375578, 5060.493950604947, 5262.158054711247, 5265.578753699695, 5285.2600635911, 5125.026245013435, 5168.689878607295, 5197.948020519784, 5229.633925625208, 5233.084210263208, 5204.817831375903, 5255.421903590602, 5264.184051472028, 5276.050310944029, 5311.601629877775, 4901.607871370282, 5080.415752188509, 5118.6416950813455, 5130.384353877521, 5215.295935048758, 5521.254630624894, 5601.327840659147, 5606.103023516218, 5640.464155905182, 5658.745356458928, 6128.142060111588, 6164.0, 6169.876602467971, 6179.412955769195, 6185.659788711664, 5930.703464826742, 6047.425494578008, 6074.96962515189, 6235.844103897439, 6250.3749625037135, 5761.711914404305, 5766.336871259775, 5768.653880767126, 5771.220885180531, 5807.970960145172, 6271.905921411182, 6281.528885333618, 6287.245530536365, 6287.528435367366, 6294.716737746812, 5723.112917497794, 5924.4667979882015, 5956.970215148896, 5991.940080599138, 6019.4883434908525, 6136.815895523141, 6142.477889379364, 6156.969215153985, 6157.168782214433, 6160.691965401802, 6013.51891848651, 6046.123312119718, 6077.665728384981, 6080.422359875804, 6084.361142080106, 5872.354041055481, 6033.18551995475, 6099.786507472217, 6108.358622344679, 6180.196574445294, 4736.384270044872, 4738.028704115648, 4738.976305118453, 4757.714537127784, 4758.214894542361, 4124.835006599762, 4230.703850730481, 4230.830766769356, 4242.300020496584, 4255.680823938217, 5745.8563535911935, 5841.474267315877, 5865.706714664249, 5894.322152952465, 5897.52819774417, 6116.694165291807, 6135.386461353829, 6206.968965155145, 6222.906656400158, 6231.158793562811, 5747.885042299131, 5985.191999080155, 5988.161657367972, 5989.221401217814, 6012.939870601325, 5204.245384419238, 5237.73811309433, 5251.789928402821, 5276.973615131977, 5301.602379821452, 6441.066045423388, 6452.387023232785, 6453.935460645427, 6457.580257283262, 6464.450521705708, 5904.0553511437965, 6041.2750469943885, 6255.46828519581, 6257.155284036597, 6270.7805226816845, 6267.091271765659, 6359.236891572856, 6389.456896163878, 6389.648569328546, 6392.0, 5984.341722410619, 6037.154798328325, 6052.757889684363, 6054.666993315233, 6058.909116363347, 5971.581989260884, 6132.754689812357, 6136.926037943253, 6143.72353244114, 6156.661383623944, 5996.160537524837, 6085.1785009023215, 6107.603005804608, 6114.6636934969, 6136.662483563268, 6022.638641681513, 6032.819015429544, 6041.335453100068, 6051.33435322123, 6058.545609079249, 5703.030484817508, 5747.770089196385, 5854.414558544111, 5978.312494063064, 6009.519238461, 5987.850303742267, 6005.39946005396, 6038.396160383926, 6049.455549000611, 6051.485623721856, 5951.285845698544, 5951.91072133927, 5961.970190149195, 5962.165296858357, 5979.0], "value": 5652.669319331142, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.4234092929859, 646.4698946863572, 656.7569999100334, 663.4294506724218, 667.6795138333599, 35365.292694146105, 39150.0, 44876.551234487684, 45930.7703461483, 46067.99999999991, 48707.0, 48996.26505602419, 49059.26411103836, 49111.26333104997, 49227.26159107607, 8979.506127163004, 9086.50024248666, 9092.0, 9107.772305692377, 9122.954385228064, 8839.24866386358, 8864.290856731479, 8942.910570894306, 8968.148025937526, 8984.910150898473, 8842.292616590657, 8943.5975381108, 8957.507337096456, 8971.865422018675, 8995.460272383678, 8890.110988901122, 8906.064863189402, 8911.420757650765, 8924.8661270081, 8942.19520243178, 8783.253423459013, 8890.599923003416, 8898.4660920345, 8904.198622123975, 8906.51014194219, 44173.55826441727, 44664.55335446669, 44818.77590612026, 44879.10241795146, 44970.32544511835, 3676.9632303677154, 3704.407294832814, 3785.337565925952, 3832.5209348831395, 3842.3852183650483, 34097.318053639035, 34616.48075278873, 34812.477812832825, 34862.30275394478, 34910.476342854876, 4552.840650577214, 4629.884252893671, 4643.683883011823, 4678.578927896506, 4707.693999889996, 383539.0, 384665.0, 387439.0, 388204.0, 388568.0, 37782.62217377846, 65431.34568654348, 66249.66875165593, 66323.66838165779, 66375.0, 39076.80461597674, 40677.0, 40790.38814417786, 40863.38704919429, 40980.59019409768, 14247.0, 14495.420183192766, 14523.564293071226, 14540.563783086523, 14588.124712517283, 12122.27266364021, 12155.939220303842, 12188.268703877795, 12229.816552751716, 12254.387280635932, 9203.815923681623, 9203.861942070875, 9210.309226807882, 9225.07749225072, 9305.162535371848, 3465.2722928185362, 3506.4214404623463, 3520.2607452435277, 3531.2054787673083, 3577.069961809896, 932.2215949681956, 939.5302348825587, 950.097407462913, 1042.525650828871, 1042.7497400623795, 33048.0, 33967.83016084904, 34251.314973700384, 34271.4859277111, 34772.0, 1162.2968104296947, 1181.2321990705939, 1225.191373693376, 1261.5836773864603, 1262.4255963536568, 17568.38510652121, 17577.121143942753, 17883.910580447013, 18068.90965545164, 18097.0, 652655.0, 661074.0, 661446.0, 666030.0, 677722.0, 58275.417245827, 64525.677371612845, 64930.0, 64964.350356496776, 65190.0, 1443.6968236670416, 1444.7616143336231, 1453.382312517176, 1457.249516499004, 1465.567657541028, 32411.0, 33495.665043349254, 33674.326513470085, 33800.49299260562, 34025.82987085148, 55281.17078243749, 55613.0, 55767.0, 55805.0, 55949.44050559442, 556950.0, 566641.0, 567387.0, 569629.0, 573124.0, 30517.542236866022, 30564.847175763978, 30606.693933061277, 30700.84649576738, 30898.227544311572, 50290.24564631606, 50435.0, 50744.0, 51015.489845101074, 51360.74319628378, 42509.78745106255, 42929.57070429256, 42933.57066429421, 43019.56980430156, 43670.56329436665, 42792.0, 42940.35589466223, 43172.0, 43222.78388608163, 43385.349219762364, 42501.523978934805, 42837.78581107199, 43363.78318108389, 43482.34776478419, 43761.124777504905, 35776.0, 36226.275474489834, 36272.0, 36883.815580921924, 37150.071248219014, 28974.27564310909, 29044.7095529042, 29135.708642913298, 29153.125406237847, 29289.85355073211], "value": 20014.221354930098, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.97534147951126, 411.1632827196655, 412.81717954570263, 417.97492150470964, 425.84456673314247, 18712.90643546782, 19499.805001949975, 20107.89946050268, 20180.495487612818, 20353.28763493278, 16231.990876539443, 16505.17474126295, 17634.647307053885, 17780.377686780965, 17870.731939020927, 5483.698396588186, 5628.26832511774, 5770.249867517216, 5805.867855768127, 5816.912746308788, 5779.3642699303045, 5780.7687692492245, 5826.504747096502, 5892.852678683046, 6636.369544893251, 6510.511711621623, 6547.148870646809, 6605.900911486331, 6612.173478315211, 6614.107095542088, 5979.312379076375, 5982.521398288149, 5988.97005514974, 6116.602420842653, 6543.770968016121, 5760.8271751847515, 5784.913226301609, 5792.565557583198, 5793.0, 5803.53571714266, 13928.58214253574, 14585.562433127023, 14593.92703036478, 14667.413303467954, 14705.55883323502, 2176.086043861582, 2291.301153148289, 2422.2975337152207, 2521.344450442898, 2629.2638061342664, 10689.091427228695, 10790.946045269802, 10983.890161098367, 11015.228933974626, 11191.776164476665, 1928.3829174664113, 2022.5247066939257, 2073.8029887160696, 2126.595946770124, 2139.3368055902565, 73590.99999999946, 82491.58754206251, 84065.57967210186, 85786.57106714426, 90070.54964725266, 11001.669949901516, 11439.714007149887, 11506.0, 11518.308901465938, 11790.764184716258, 16273.59316017109, 16338.264778085015, 16345.42791002333, 16467.670646587, 16525.421610243582, 8143.6742530298125, 8214.096449390563, 8273.544955027412, 8274.420790544604, 8310.335173186251, 7765.689372425153, 7808.141104478503, 7816.68733250675, 7846.8430631387055, 8066.637001334954, 4897.3878265216845, 4999.200127979506, 5012.223105418666, 5054.7472626368535, 5108.770105345268, 2048.337161689827, 2052.722882410885, 2067.2041264113423, 2085.384811480617, 2115.3336698939784, 982.6364245229167, 1001.689476262361, 1062.4634559547378, 1114.9275297105823, 1115.5649296774266, 17577.736333955, 19480.902595487216, 19914.402567922985, 20035.198592056153, 20128.798712012984, 1000.4247557654378, 1029.433811403725, 1040.661784919904, 1075.6611667324767, 1094.2887123369715, 10894.836577451344, 11283.379414132138, 11291.717707057225, 11327.263727857662, 11494.94252528732, 563844.0, 572805.0, 575757.0, 578295.0, 591367.0, 90719.54640226757, 100675.49662251642, 102757.48621256996, 102903.48548257211, 102933.48533257286, 962.8074385123003, 1012.696191142669, 1017.8829434614966, 1018.0328687746522, 1020.9132223761063, 18044.54888627795, 18386.172622232298, 18441.63116737631, 18574.907125464288, 18587.535311617317, 39711.0, 42101.578984209766, 42444.15111697811, 42843.357349639155, 43780.34329484997, 62444.0, 63824.0, 64096.0, 64152.679236603515, 64156.67921660362, 7671.0, 8229.876551851847, 8799.824003519765, 8991.190792828676, 9031.142041506046, 11869.52521899149, 13442.663933401744, 13470.595882123553, 13509.324533773468, 13579.388927498088, 10858.899979102354, 11560.884391156318, 11897.167198296382, 12042.85592868676, 12241.877581224073, 11943.984761295387, 12161.0, 12171.026317894724, 12173.391330433265, 12402.5659101931, 12152.939235303767, 12334.198277111958, 12356.691082723004, 12448.0, 12524.624261272176, 8917.643294268157, 9035.548222588975, 9167.220786233245, 9234.307426942873, 9296.0, 10703.892961070602, 11104.61133860311, 11722.648320550397, 11766.117541184616, 12055.336956467478], "value": 9458.77507173489, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1578.3011051102617, 1593.3626549380247, 1781.8485428738556, 1882.9905850470764, 1926.3161577639928, 8230.547319897403, 8578.056413794486, 9149.862752058707, 9179.541022948859, 9214.354995150334, 9200.309976751736, 9493.145616894479, 9547.618095276199, 9578.664746733866, 9593.952030239856, 2428.1865575032384, 2443.4135807406183, 2465.938351541208, 2473.4311108444977, 2479.7396273391305, 2444.2300675287315, 2452.3010941881566, 2466.1738317663603, 2469.259222233332, 2480.5038992201544, 2423.3941514621347, 2426.757324267568, 2501.8373805702663, 2502.73721259267, 2505.473850491399, 2378.155754707089, 2386.7493913139133, 2414.106780491221, 2464.765847244527, 2467.4201562632766, 2344.0858065354523, 2432.9513409731708, 2451.36264571211, 2458.0782206672498, 2480.08236952327, 9480.431174129575, 9509.57206925683, 9525.761855953657, 9546.809063818755, 9561.235101191958, 5340.25236466895, 5424.077906755861, 5425.945740542584, 5433.1850222466555, 5433.913217356545, 3645.270945810822, 3730.0861288984374, 3777.6033516480925, 3809.466674665549, 3832.118612719062, 1173.178774857603, 1201.3932963853285, 1221.1696046688248, 1233.7717522258322, 1262.5959692898277, 13399.59801205975, 13478.39347229377, 13516.662083447894, 13526.391312390868, 13527.594172174851, 4931.3589233399425, 4986.376702912136, 5067.467915868854, 5098.362704661918, 5114.028334616411, 11325.603603873826, 11478.655640330804, 11522.827157592643, 11541.480633371519, 11557.942210288895, 5498.340199176125, 5521.337439507285, 5558.72206389687, 5570.610057296031, 5583.664980101207, 4394.472663280427, 4717.481077081518, 4884.607886752329, 4887.218045112836, 5105.719185444762, 4260.723053001607, 4318.805653745589, 4337.73973561581, 4359.280718681445, 4417.690761646654, 1327.588447581253, 1328.8073229381685, 1337.8394592648945, 1342.9865701343058, 1343.6506508307714, 1012.6708819633649, 1024.6925922223304, 1027.6043723166636, 1030.4384110659707, 1042.0517329230363, 6216.160818289473, 6302.0, 6370.0763389308295, 6439.162908821917, 6512.6092434454085, 460.10739166017817, 468.29989166196754, 470.3203870407229, 473.94312682477636, 474.058992899095, 4588.908221835544, 4673.462551806518, 4734.171519983989, 4748.477667456577, 4815.22956326986, 11298.7175320616, 11923.940380298043, 12298.0, 12342.506299747909, 12347.073969452327, 11618.419079046183, 12055.578054768217, 12087.0, 12156.574519891761, 12160.69598260033, 8425.789355266168, 8520.318374530023, 8537.530435825965, 8554.35842311829, 8586.441881277697, 6556.770513032021, 6638.734450621921, 6714.429273511806, 6817.89773153413, 6837.589744615339, 10855.511501982272, 10925.289856159325, 11149.777004459704, 11194.160437967348, 11256.212065155689, 11290.81446448144, 11483.827742584035, 11485.540578376771, 11612.0, 11746.0, 7736.7292144774665, 8192.54940978252, 8285.0, 8303.792405189919, 8501.27739142155, 9404.670836520689, 9438.905610944077, 9467.053294670477, 9479.28905332089, 9548.761280968032, 8193.59032048407, 8413.116622754767, 8498.192671696179, 8519.06290308078, 8595.871061934202, 8212.58937053133, 8237.176282371714, 8417.116202798617, 8420.326373889951, 8517.276031537142, 7287.8542429152185, 7446.106467223968, 7514.211007844097, 7542.6605802740105, 7546.622668866425, 5451.618386712892, 5597.272354593877, 5693.658380497018, 5766.0, 5845.006348920609, 5322.840314790563, 5370.9731451342495, 5456.645318054314, 5519.39286678473, 5529.861753456195], "value": 4902.630972174122, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.674126321258, 349.58923265163435, 349.66257561453193, 350.84738138909563, 353.62162486139806, 5597.3283206015285, 5619.690916999563, 5631.099983508486, 5652.07829338025, 5720.427957204278, 5570.136628822539, 5571.0, 5593.356763972144, 5594.524465420434, 5597.580181486384, 4122.42286079949, 4342.0, 4362.214801335758, 4363.934540981888, 4389.144116897206, 4352.173087113454, 4365.497967733703, 4379.255526560476, 4400.97799511002, 4405.735655860659, 4167.9583204167875, 4336.21948049351, 4350.934735978963, 4366.607005369516, 4372.540883207265, 4328.134373125356, 4346.391505189276, 4348.934765978513, 4357.694961352707, 4373.256546387106, 3837.827297771579, 3850.5175507429562, 3857.594952529972, 3860.305145073886, 3890.5720370759195, 5216.626434972079, 5485.753141108659, 5489.725513724298, 5492.835214943558, 5520.392756796749, 4997.700137991696, 5013.298138260647, 5013.423456302499, 5026.441803041069, 5028.22062580297, 5878.206442130343, 5905.970470147622, 5918.704064796786, 5928.940710592882, 5944.673042982634, 4005.359142537209, 4212.873613791591, 4229.090745489734, 4238.830446782125, 4247.426597409372, 6113.327533971304, 6143.32423433422, 6168.722407491674, 6175.876482470326, 6179.969100154515, 4277.807498662505, 4299.634531064832, 4302.7848607569495, 4309.202797482476, 4313.762743049162, 4269.914601707948, 4310.568943105664, 4374.03771170342, 4403.603675669206, 4424.446944131983, 4985.551300382983, 5003.099442100457, 5007.173816320266, 5036.899262014813, 5039.949600504021, 5870.148828419855, 5889.0, 5926.7925622603, 5928.970355148283, 5934.347221805598, 1492.7387707151206, 1533.5092770313393, 1551.7517197248385, 1554.9533513994597, 1564.7105285522214, 988.9961688885787, 993.3493561717087, 1011.8937511561327, 1016.3292227130206, 1031.886492485826, 5150.072986862326, 5155.587552995751, 5177.352830896138, 5193.766280517386, 5223.947760522422, 5342.332208473941, 5383.43473935239, 5414.810481633124, 5436.864078398072, 5440.001598824861, 5447.264619276426, 5689.004424225744, 5833.329167145747, 5844.211031510692, 5867.765289388462, 3223.0, 3234.433974054531, 3244.5782048334036, 3267.950980735291, 3295.736341092707, 6142.78500252489, 6203.635200255936, 6314.273858506331, 6334.524910631629, 6400.647964361911, 6149.38651073292, 6202.937970620236, 6203.945329294031, 6212.1303017577575, 6226.5641405101205, 6180.289266734293, 6282.963311053625, 6310.305866354697, 6325.873482530324, 6328.430441260309, 5898.764049437975, 6085.391460853879, 6086.0, 6159.706461643105, 6164.4143806338325, 5958.225430693982, 5982.341942386247, 6011.27864656244, 6022.939770602238, 6024.638521688713, 6104.26748790148, 6232.69113486173, 6321.1782468278825, 6350.237971443456, 6351.522906066545, 4368.0, 4375.47494300686, 4386.960063570455, 4399.054203346296, 4428.911421771611, 5906.586538942232, 6030.6080104793045, 6082.7262773174425, 6098.603590766586, 6120.908186377297, 5975.462208401264, 5977.970110149421, 5982.312034116132, 5984.970075149597, 5989.850253743692, 5905.084711869667, 5909.674967876808, 5921.585489015728, 5956.731947062306, 5961.493273071837, 5746.068544876526, 5758.222639943554, 5870.354261031369, 5890.410958904075, 5910.615809972338, 5933.376995415592, 5965.642061476326, 5974.520573961931, 5987.940120598738, 6015.947209238453, 5701.372848986525, 5788.160716695971, 5848.327442344014, 5862.589618726648, 5864.618799778001], "value": 4490.553891798622, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [845.1506236232585, 852.2585350744852, 893.2005854759994, 901.3150005995445, 909.1226965977833, 16411.34354625815, 16631.584210394747, 16943.0, 16990.5752356191, 17008.319667213313, 15456.613584660388, 15699.921500392511, 15726.0, 15735.92132039341, 15740.0, 703.0965209705529, 836.7364280251701, 845.6828689241535, 857.9656813727474, 860.926821220197, 837.4723923927917, 838.6645341863242, 840.6553313141613, 844.6494704697574, 844.8859403980446, 908.7500937242245, 910.9225715814164, 913.5295322908707, 915.9816803663923, 917.3624331089895, 900.6667533012761, 903.0698380667923, 906.537665790445, 909.2816674826879, 910.4855756497558, 668.2916108924555, 670.6747227594612, 671.6675245753335, 672.2269390201259, 674.6188403551978, 15085.924570377078, 15087.849121508863, 15088.0, 15097.32062057199, 15176.089434633957, 14590.197539135343, 14595.051321664057, 14882.479113230986, 15553.377864885391, 16434.6713065738, 12382.688877738103, 12807.359632018362, 12935.741285174337, 12972.286524241163, 13273.07088503805, 4017.61832625903, 4034.9394759078637, 4047.5750046245307, 4057.6956728245204, 4082.9183416331803, 66848.0, 74730.0, 74762.25237747608, 74995.0, 75660.97356105804, 11801.0, 12160.452779624939, 12370.81443778344, 12478.0, 12843.422046007952, 20596.897015515126, 21405.67891481629, 21425.357239282846, 22246.77753222447, 22343.0, 8807.647694092164, 8953.955230223937, 9005.819883602291, 9068.365214434927, 9478.573464194127, 4781.211100168433, 4814.903701925942, 4847.684900481528, 4904.166291730415, 4907.754612269372, 3918.275119102975, 4012.29784787661, 4020.7587544747407, 4024.436578878959, 4025.215083058834, 683.4737252315689, 688.7899190746871, 693.1335830212234, 703.9507234493639, 708.4898872811567, 804.0672819529318, 808.0667178143302, 818.3657665309432, 820.327331588104, 840.3319361107812, 10601.734956626146, 10614.203934704929, 10762.192835537366, 10777.515011824487, 10962.616308429167, 739.8187444076236, 792.6789650191681, 817.4686453805074, 835.6740871060291, 838.4843321357322, 4813.78337974792, 4918.008266481854, 4936.605071594264, 4992.340899596174, 5055.620828437882, 117187.0, 119537.40231298788, 121093.39453302677, 123365.0, 124215.0, 64028.0, 64422.033669494995, 64817.67591162108, 66193.0, 101192.98807011983, 67295.0, 70106.0, 93194.53402732943, 93453.0, 93486.0, 9565.713028609152, 9739.41563506192, 9848.409095454295, 9853.605855765689, 9936.155426788515, 55073.17390239069, 55576.0, 55582.72208638931, 56299.43700563106, 57084.0, 50011.0, 51794.22308665298, 57177.71411143084, 76213.0, 76483.23516764761, 12822.974162066826, 12882.96936245117, 12987.090903636654, 13769.0, 14381.64045898861, 15198.772018419511, 15686.137262450675, 15770.0, 15852.048877067413, 15903.443379481663, 14465.13209207451, 14773.704525909636, 15217.0, 15769.29038193307, 16298.674026519166, 15123.243837807846, 15193.316300766272, 15310.464133755711, 15506.0, 15584.766228506354, 13801.861981380058, 14512.201828899511, 14976.0, 15075.170865602497, 15138.924305378403, 10564.735881603021, 10634.627788027381, 10754.462276885968, 10800.729981750519, 10889.346639201673, 10769.62306319275, 11136.939666161787, 11213.0, 11287.20989530725, 11376.0], "value": 7886.185154761609, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1521.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 110.0, 111.0, 115.0, 110.0, 111.0, 112.0, 111.0, 112.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 126.0, 148.0, 170.0, 126.0, 161.0, 155.0, 125.0, 193.0, 125.0], "value": 149.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 161.0, 163.0, 163.0, 162.0, 161.0, 161.0, 162.0, 164.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 183.0, 76.0, 76.0, 75.0, 76.0, 185.0, 76.0], "value": 97.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 141.0, 84.0, 86.0, 84.0, 131.0, 85.0, 86.0, 151.0], "value": 101.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 147.0, 148.0, 150.0, 149.0, 148.0, 149.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 100.0, 100.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 52.0, 51.0, 51.0, 53.0, 52.0, 54.0, 50.0, 54.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 60.0, 60.0, 60.0, 65.0, 59.0, 60.0, 61.0, 59.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 75.0, 83.0, 78.0, 77.0, 81.0, 77.0, 117.0, 78.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 129.0, 130.0, 120.0, 119.0, 116.0, 129.0, 119.0, 136.0, 132.0], "value": 126.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 155.0, 153.0, 155.0, 153.0, 151.0, 152.0, 155.0, 153.0, 154.0], "value": 154.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 65.0, 62.0, 62.0, 64.0, 63.0, 61.0, 60.0, 73.0], "value": 63.7, "unit": "score"}]}]} 04:05:49 INFO - Return code: 0 04:05:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:05:49 ERROR - # TBPL SUCCESS # 04:05:49 INFO - Running post-action listener: _resource_record_post_action 04:05:49 INFO - ##### 04:05:49 INFO - ##### Finished run-tests step (success) 04:05:49 INFO - ##### 04:05:49 INFO - Running post-run listener: _resource_record_post_run 04:05:49 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 303104; Write bytes: 263229440; Read time: 136; Write time: 146132 04:05:49 INFO - TinderboxPrint: CPU usage
13.4% 04:05:49 INFO - TinderboxPrint: I/O read bytes / time
303,104 / 136 04:05:49 INFO - TinderboxPrint: I/O write bytes / time
263,229,440 / 146,132 04:05:49 INFO - TinderboxPrint: CPU idle
8,212.4 (86.6%) 04:05:49 INFO - TinderboxPrint: CPU user
1,213.2 (12.8%) 04:05:49 INFO - TinderboxPrint: Swap in / out
0 / 0 04:05:49 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 14340096; Read time: 0; Write time: 5040 04:05:49 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 278528; Write bytes: 248889344; Read time: 128; Write time: 141092 04:05:49 INFO - Running post-run listener: _upload_blobber_files 04:05:49 INFO - Blob upload gear active. 04:05:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:05:49 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 04:05:49 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'] 04:05:49 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 04:05:50 INFO - (blobuploader) - INFO - Open directory for files ... 04:05:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:05:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:05:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:05:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:05:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:05:51 INFO - (blobuploader) - INFO - Done attempting. 04:05:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:05:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:05:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:05:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:05:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:05:54 INFO - (blobuploader) - INFO - Done attempting. 04:05:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:05:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:05:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:05:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:05:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:05:55 INFO - (blobuploader) - INFO - Done attempting. 04:05:55 INFO - (blobuploader) - INFO - Iteration through files over. 04:05:55 INFO - Return code: 0 04:05:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:05:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:05:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/53a677cee8b0dc39f6a93e5f4c0a0896041ba7f18354e93aabbf09c93402c4e1b69788b2f4c9c874647c8663438b67badc1c5af619ccde2a8ac6ce03be80ed4e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9db8ce0ab252e4c7152563cb6778638383c401d92ab37e04b965a15d9b7868ceaf8548d0e0d2a220465fec1cc188b2d1801a1a3df61e797cf04bf0151bf62070", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e1b808e54b11bd45cc7e88d6db87acf0953fa5a4e79baccae1aac355a050cd36601618b43182a3284ce1e76d789c1e5edcaea2fe696b10aa8286f7f9bc346832"} 04:05:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:05:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:05:55 INFO - Contents: 04:05:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/53a677cee8b0dc39f6a93e5f4c0a0896041ba7f18354e93aabbf09c93402c4e1b69788b2f4c9c874647c8663438b67badc1c5af619ccde2a8ac6ce03be80ed4e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9db8ce0ab252e4c7152563cb6778638383c401d92ab37e04b965a15d9b7868ceaf8548d0e0d2a220465fec1cc188b2d1801a1a3df61e797cf04bf0151bf62070", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e1b808e54b11bd45cc7e88d6db87acf0953fa5a4e79baccae1aac355a050cd36601618b43182a3284ce1e76d789c1e5edcaea2fe696b10aa8286f7f9bc346832"} 04:05:55 INFO - Running post-run listener: copy_logs_to_upload_dir 04:05:55 INFO - Copying logs to upload dir... 04:05:55 INFO - mkdir: /builds/slave/test/build/upload/logs 04:05:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.221583 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-07-12 04:05:55.181807) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 04:05:55.185727) ========= 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=20e666a3d4cfbb71505a330e000001b4-1468320277.277778-373876036 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/53a677cee8b0dc39f6a93e5f4c0a0896041ba7f18354e93aabbf09c93402c4e1b69788b2f4c9c874647c8663438b67badc1c5af619ccde2a8ac6ce03be80ed4e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9db8ce0ab252e4c7152563cb6778638383c401d92ab37e04b965a15d9b7868ceaf8548d0e0d2a220465fec1cc188b2d1801a1a3df61e797cf04bf0151bf62070", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e1b808e54b11bd45cc7e88d6db87acf0953fa5a4e79baccae1aac355a050cd36601618b43182a3284ce1e76d789c1e5edcaea2fe696b10aa8286f7f9bc346832"} build_url:https://queue.taskcluster.net/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011168 build_url: 'https://queue.taskcluster.net/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.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/53a677cee8b0dc39f6a93e5f4c0a0896041ba7f18354e93aabbf09c93402c4e1b69788b2f4c9c874647c8663438b67badc1c5af619ccde2a8ac6ce03be80ed4e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9db8ce0ab252e4c7152563cb6778638383c401d92ab37e04b965a15d9b7868ceaf8548d0e0d2a220465fec1cc188b2d1801a1a3df61e797cf04bf0151bf62070", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e1b808e54b11bd45cc7e88d6db87acf0953fa5a4e79baccae1aac355a050cd36601618b43182a3284ce1e76d789c1e5edcaea2fe696b10aa8286f7f9bc346832"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 04:05:55.212249) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 04:05:55.212628) ========= 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=20e666a3d4cfbb71505a330e000001b4-1468320277.277778-373876036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004469 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 04:05:55.297960) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 04:05:55.298406) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 04:05:55.298798) ========= ========= Total master_lag: 0.18 =========