builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-017 starttime: 1466005285.91 results: success (0) buildid: 20160615080629 builduid: 2d2f0f31317446fe9be0f3364a0edc7e revision: 153553aecf160632bbcb50906ba135511da138e6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-15 08:41:25.911396) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-15 08:41:25.911875) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-15 08:41:25.912194) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-15 08:41:25.939570) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 08:41:25.939882) ========= 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=0333a256a5e4f052382dd180000001b1-1466004465.430263-695516675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-15 08:41:26-- 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% 46.2M=0s 2016-06-15 08:41:26 (46.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127922 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 08:41:26.082074) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 08:41:26.082410) ========= 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=0333a256a5e4f052382dd180000001b1-1466004465.430263-695516675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015098 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 08:41:26.167114) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 08:41:26.167554) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 153553aecf160632bbcb50906ba135511da138e6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 153553aecf160632bbcb50906ba135511da138e6 --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=0333a256a5e4f052382dd180000001b1-1466004465.430263-695516675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-15 08:41:26,484 truncating revision to first 12 chars 2016-06-15 08:41:26,484 Setting DEBUG logging. 2016-06-15 08:41:26,484 attempt 1/10 2016-06-15 08:41:26,484 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/153553aecf16?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-15 08:41:26,804 unpacking tar archive at: fx-team-153553aecf16/testing/mozharness/ program finished with exit code 0 elapsedTime=0.667432 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 08:41:26.848740) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-15 08:41:26.849079) ========= script_repo_revision: 153553aecf160632bbcb50906ba135511da138e6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-15 08:41:26.849541) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-15 08:41:26.849866) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-15 08:41:26.859679) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-06-15 08:41:26.859988) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=0333a256a5e4f052382dd180000001b1-1466004465.430263-695516675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:41:27 INFO - MultiFileLogger online at 20160615 08:41:27 in /builds/slave/test 08:41:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 08:41:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:41:27 INFO - {'append_to_log': False, 08:41:27 INFO - 'base_work_dir': '/builds/slave/test', 08:41:27 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:41:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:41:27 INFO - 'branch': 'Fx-Team-Non-PGO', 08:41:27 INFO - 'buildbot_json_path': 'buildprops.json', 08:41:27 INFO - 'config_files': ('talos/linux_config.py',), 08:41:27 INFO - 'default_actions': ('clobber', 08:41:27 INFO - 'read-buildbot-config', 08:41:27 INFO - 'download-and-extract', 08:41:27 INFO - 'populate-webroot', 08:41:27 INFO - 'create-virtualenv', 08:41:27 INFO - 'install', 08:41:27 INFO - 'run-tests'), 08:41:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:41:27 INFO - 'download_minidump_stackwalk': True, 08:41:27 INFO - 'download_symbols': 'ondemand', 08:41:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:41:27 INFO - 'tooltool.py': '/tools/tooltool.py', 08:41:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:41:27 INFO - '/tools/misc-python/virtualenv.py')}, 08:41:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:41:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:41:27 INFO - 'installer_path': 'installer.exe', 08:41:27 INFO - 'log_level': 'info', 08:41:27 INFO - 'log_name': 'talos', 08:41:27 INFO - 'log_to_console': True, 08:41:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:41:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:41:27 INFO - 'opt_config_files': (), 08:41:27 INFO - 'pip_index': False, 08:41:27 INFO - 'sps_profile': False, 08:41:27 INFO - 'sps_profile_interval': 0, 08:41:27 INFO - 'suite': 'dromaeojs-e10s', 08:41:27 INFO - 'system_bits': '32', 08:41:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:41:27 INFO - 'title': 'talos-linux64-ix-017', 08:41:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:41:27 INFO - 'use_talos_json': True, 08:41:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:41:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:41:27 INFO - 'work_dir': 'build'} 08:41:27 INFO - ##### 08:41:27 INFO - ##### Running clobber step. 08:41:27 INFO - ##### 08:41:27 INFO - Running pre-action listener: _resource_record_pre_action 08:41:27 INFO - Running main action method: clobber 08:41:27 INFO - rmtree: /builds/slave/test/build 08:41:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:41:28 INFO - Running post-action listener: _resource_record_post_action 08:41:28 INFO - ##### 08:41:28 INFO - ##### Finished clobber step (success) 08:41:28 INFO - ##### 08:41:28 INFO - ##### 08:41:28 INFO - ##### Running read-buildbot-config step. 08:41:28 INFO - ##### 08:41:28 INFO - Running pre-action listener: _resource_record_pre_action 08:41:28 INFO - Running main action method: read_buildbot_config 08:41:28 INFO - Using buildbot properties: 08:41:28 INFO - { 08:41:28 INFO - "project": "", 08:41:28 INFO - "product": "firefox", 08:41:28 INFO - "script_repo_revision": "production", 08:41:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:41:28 INFO - "repository": "", 08:41:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 08:41:28 INFO - "buildid": "20160615080629", 08:41:28 INFO - "pgo_build": "False", 08:41:28 INFO - "basedir": "/builds/slave/test", 08:41:28 INFO - "buildnumber": 1369, 08:41:28 INFO - "slavename": "talos-linux64-ix-017", 08:41:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:41:28 INFO - "platform": "ubuntu64_hw", 08:41:28 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:41:28 INFO - "branch": "fx-team", 08:41:28 INFO - "repo_path": "integration/fx-team", 08:41:28 INFO - "revision": "153553aecf160632bbcb50906ba135511da138e6", 08:41:28 INFO - "stage_platform": "linux64", 08:41:28 INFO - "builduid": "2d2f0f31317446fe9be0f3364a0edc7e", 08:41:28 INFO - "slavebuilddir": "test" 08:41:28 INFO - } 08:41:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/ODEE5zyDSoScYh7lh3au1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:41:28 INFO - Running post-action listener: _resource_record_post_action 08:41:28 INFO - ##### 08:41:28 INFO - ##### Finished read-buildbot-config step (success) 08:41:28 INFO - ##### 08:41:28 INFO - ##### 08:41:28 INFO - ##### Running download-and-extract step. 08:41:28 INFO - ##### 08:41:28 INFO - Running pre-action listener: _resource_record_pre_action 08:41:28 INFO - Running main action method: download_and_extract 08:41:28 INFO - mkdir: /builds/slave/test/build/tests 08:41:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:41:28 INFO - https://queue.taskcluster.net/v1/task/ODEE5zyDSoScYh7lh3au1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:41:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ODEE5zyDSoScYh7lh3au1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:41:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ODEE5zyDSoScYh7lh3au1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:41:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ODEE5zyDSoScYh7lh3au1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:41:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ODEE5zyDSoScYh7lh3au1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:41:30 INFO - Downloaded 1361 bytes. 08:41:30 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:41:30 INFO - Using the following test package requirements: 08:41:30 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:41:30 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:41:30 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:41:30 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:30 INFO - u'jsshell-linux-x86_64.zip'], 08:41:30 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:41:30 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:41:30 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:41:30 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:41:30 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:41:30 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:41:30 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:41:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:41:30 INFO - https://queue.taskcluster.net/v1/task/ODEE5zyDSoScYh7lh3au1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:41:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ODEE5zyDSoScYh7lh3au1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:41:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ODEE5zyDSoScYh7lh3au1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:41:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ODEE5zyDSoScYh7lh3au1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:41:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ODEE5zyDSoScYh7lh3au1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:41:33 INFO - Downloaded 22654307 bytes. 08:41:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:41:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:41:34 INFO - Return code: 0 08:41:34 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:41:34 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')]} 08:41:34 INFO - https://queue.taskcluster.net/v1/task/ODEE5zyDSoScYh7lh3au1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:41:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ODEE5zyDSoScYh7lh3au1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:41:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ODEE5zyDSoScYh7lh3au1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:41:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ODEE5zyDSoScYh7lh3au1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:41:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ODEE5zyDSoScYh7lh3au1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:41:39 INFO - Downloaded 22654307 bytes. 08:41:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:41:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:41:41 INFO - Return code: 0 08:41: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')]} 08:41:41 INFO - https://queue.taskcluster.net/v1/task/ODEE5zyDSoScYh7lh3au1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:41:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ODEE5zyDSoScYh7lh3au1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:41:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ODEE5zyDSoScYh7lh3au1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:41:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ODEE5zyDSoScYh7lh3au1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:41:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ODEE5zyDSoScYh7lh3au1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:41:43 INFO - Downloaded 14405384 bytes. 08:41:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:41:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:41:43 INFO - Return code: 0 08:41: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')]} 08:41:43 INFO - https://queue.taskcluster.net/v1/task/ODEE5zyDSoScYh7lh3au1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:41:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ODEE5zyDSoScYh7lh3au1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:41:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ODEE5zyDSoScYh7lh3au1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:41:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ODEE5zyDSoScYh7lh3au1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:41:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ODEE5zyDSoScYh7lh3au1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:41:44 INFO - Downloaded 55432984 bytes. 08:41:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ODEE5zyDSoScYh7lh3au1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:41:44 INFO - mkdir: /builds/slave/test/properties 08:41:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:41:44 INFO - Writing to file /builds/slave/test/properties/build_url 08:41:44 INFO - Contents: 08:41:44 INFO - build_url:https://queue.taskcluster.net/v1/task/ODEE5zyDSoScYh7lh3au1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:41:45 INFO - Running post-action listener: _resource_record_post_action 08:41:45 INFO - Running post-action listener: set_extra_try_arguments 08:41:45 INFO - ##### 08:41:45 INFO - ##### Finished download-and-extract step (success) 08:41:45 INFO - ##### 08:41:45 INFO - ##### 08:41:45 INFO - ##### Running populate-webroot step. 08:41:45 INFO - ##### 08:41:45 INFO - Running pre-action listener: _resource_record_pre_action 08:41:45 INFO - Running main action method: populate_webroot 08:41:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:41:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:41:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:41:45 INFO - '--tppagecycles', 08:41:45 INFO - '7'], 08:41:45 INFO - 'tests': ['tsvgm']}}, 08:41:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:41:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:41:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:41:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:41:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:41:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:41:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:45 INFO - 'talos_options': ['--disable-e10s'], 08:41:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:41:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:41:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:45 INFO - 'talos_options': ['--disable-e10s'], 08:41:45 INFO - 'tests': ['damp', 'tps']}, 08:41:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:45 INFO - 'tests': ['damp', 'tps']}, 08:41:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:41:45 INFO - 'tests': ['dromaeo_dom']}, 08:41:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:41:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:41:45 INFO - 'tests': ['basic_compositor_video']}, 08:41:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:41:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:41:45 INFO - 'tests': ['a11yr', 08:41:45 INFO - 'ts_paint', 08:41:45 INFO - 'tpaint', 08:41:45 INFO - 'sessionrestore', 08:41:45 INFO - 'sessionrestore_no_auto_restore', 08:41:45 INFO - 'tabpaint']}, 08:41:45 INFO - 'other-e10s': {'tests': ['a11yr', 08:41:45 INFO - 'ts_paint', 08:41:45 INFO - 'tpaint', 08:41:45 INFO - 'sessionrestore', 08:41:45 INFO - 'sessionrestore_no_auto_restore', 08:41:45 INFO - 'tabpaint']}, 08:41:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:41:45 INFO - 'ts_paint', 08:41:45 INFO - 'tpaint', 08:41:45 INFO - 'sessionrestore', 08:41:45 INFO - 'sessionrestore_no_auto_restore', 08:41:45 INFO - 'tabpaint']}, 08:41:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:41:45 INFO - 'ts_paint', 08:41:45 INFO - 'tpaint', 08:41:45 INFO - 'sessionrestore', 08:41:45 INFO - 'sessionrestore_no_auto_restore', 08:41:45 INFO - 'tabpaint']}, 08:41:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:41:45 INFO - 'tests': ['a11yr', 08:41:45 INFO - 'ts_paint', 08:41:45 INFO - 'tpaint', 08:41:45 INFO - 'sessionrestore', 08:41:45 INFO - 'sessionrestore_no_auto_restore', 08:41:45 INFO - 'tabpaint']}, 08:41:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:41:45 INFO - 'tests': ['a11yr', 08:41:45 INFO - 'ts_paint', 08:41:45 INFO - 'tpaint', 08:41:45 INFO - 'sessionrestore', 08:41:45 INFO - 'sessionrestore_no_auto_restore', 08:41:45 INFO - 'tabpaint']}, 08:41:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:41:45 INFO - 'tests': ['tsvgx', 08:41:45 INFO - 'tsvgr_opacity', 08:41:45 INFO - 'tart', 08:41:45 INFO - 'tscrollx', 08:41:45 INFO - 'cart']}, 08:41:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:41:45 INFO - 'tsvgr_opacity', 08:41:45 INFO - 'tart', 08:41:45 INFO - 'tscrollx', 08:41:45 INFO - 'cart']}, 08:41:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:45 INFO - 'talos_options': ['--disable-e10s'], 08:41:45 INFO - 'tests': ['tp5o']}, 08:41:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:45 INFO - 'tests': ['tp5o']}, 08:41:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:45 INFO - 'talos_options': ['--disable-e10s', 08:41:45 INFO - '--xperf_path', 08:41:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:41:45 INFO - 'tests': ['tp5n']}, 08:41:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:45 INFO - 'talos_options': ['--xperf_path', 08:41:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:41:45 INFO - 'tests': ['tp5n']}}, 08:41:45 INFO - 'talos.zip': {'path': '', 08:41:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:41:45 INFO - Running post-action listener: _resource_record_post_action 08:41:45 INFO - ##### 08:41:45 INFO - ##### Finished populate-webroot step (success) 08:41:45 INFO - ##### 08:41:45 INFO - ##### 08:41:45 INFO - ##### Running create-virtualenv step. 08:41:45 INFO - ##### 08:41:45 INFO - Running pre-action listener: _resource_record_pre_action 08:41:45 INFO - Running main action method: create_virtualenv 08:41:45 INFO - Creating virtualenv /builds/slave/test/build/venv 08:41:45 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 08:41:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:41:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:41:45 INFO - Using real prefix '/usr' 08:41:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:41:46 INFO - Installing distribute.............................................................................................................................................................................................done. 08:41:48 INFO - Installing pip.................done. 08:41:48 INFO - Return code: 0 08:41:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:41:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:41:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:41:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:48 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 0x7f746fbb5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c28020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cba2e0>, '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 0x2c26140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c265d0>, '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': '0333a256a5e4f052382dd180000001b1-1466004465.430263-695516675', '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 08:41:48 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 08:41:48 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 08:41:48 INFO - Using env: {'DISPLAY': ':0', 08:41:48 INFO - 'HOME': '/home/cltbld', 08:41:48 INFO - 'LANG': 'en_US.UTF-8', 08:41:48 INFO - 'LANGUAGE': 'en_US:en', 08:41:48 INFO - 'LOGNAME': 'cltbld', 08:41:48 INFO - 'MAIL': '/var/mail/cltbld', 08:41:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:48 INFO - 'MOZ_NO_REMOTE': '1', 08:41:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:48 INFO - 'NO_EM_RESTART': '1', 08:41:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:48 INFO - 'PWD': '/builds/slave/test', 08:41:48 INFO - 'SHELL': '/bin/bash', 08:41:48 INFO - 'SHLVL': '1', 08:41:48 INFO - 'TERM': 'linux', 08:41:48 INFO - 'TMOUT': '86400', 08:41:48 INFO - 'USER': 'cltbld', 08:41:48 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466004465.430263-695516675', 08:41:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:48 INFO - '_': '/tools/buildbot/bin/python'} 08:41:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:48 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 08:41:48 INFO - Cleaning up... 08:41:48 INFO - Return code: 0 08:41:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:41:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:41:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:41:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:48 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 0x7f746fbb5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c28020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cba2e0>, '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 0x2c26140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c265d0>, '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': '0333a256a5e4f052382dd180000001b1-1466004465.430263-695516675', '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 08:41:48 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 08:41:48 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 08:41:48 INFO - Using env: {'DISPLAY': ':0', 08:41:48 INFO - 'HOME': '/home/cltbld', 08:41:48 INFO - 'LANG': 'en_US.UTF-8', 08:41:48 INFO - 'LANGUAGE': 'en_US:en', 08:41:48 INFO - 'LOGNAME': 'cltbld', 08:41:48 INFO - 'MAIL': '/var/mail/cltbld', 08:41:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:48 INFO - 'MOZ_NO_REMOTE': '1', 08:41:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:48 INFO - 'NO_EM_RESTART': '1', 08:41:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:48 INFO - 'PWD': '/builds/slave/test', 08:41:48 INFO - 'SHELL': '/bin/bash', 08:41:48 INFO - 'SHLVL': '1', 08:41:48 INFO - 'TERM': 'linux', 08:41:48 INFO - 'TMOUT': '86400', 08:41:48 INFO - 'USER': 'cltbld', 08:41:48 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466004465.430263-695516675', 08:41:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:48 INFO - '_': '/tools/buildbot/bin/python'} 08:41:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:48 INFO - Downloading/unpacking psutil>=3.1.1 08:41: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 08:41: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 08:41: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 08:41: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 08:41: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 08:41: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 08:41:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:41:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:41:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:41:50 INFO - Installing collected packages: psutil 08:41:50 INFO - Running setup.py install for psutil 08:41:50 INFO - building 'psutil._psutil_linux' extension 08:41:50 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 08:41:50 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 08:41:50 INFO - building 'psutil._psutil_posix' extension 08:41:50 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 08:41:50 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 08:41:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:41:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:41:50 INFO - Successfully installed psutil 08:41:50 INFO - Cleaning up... 08:41:51 INFO - Return code: 0 08:41:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:41:51 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')]} 08:41:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:51 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')]} 08:41:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:51 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 0x7f746fbb5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c28020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cba2e0>, '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 0x2c26140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c265d0>, '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': '0333a256a5e4f052382dd180000001b1-1466004465.430263-695516675', '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 08:41:51 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 08:41:51 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 08:41:51 INFO - Using env: {'DISPLAY': ':0', 08:41:51 INFO - 'HOME': '/home/cltbld', 08:41:51 INFO - 'LANG': 'en_US.UTF-8', 08:41:51 INFO - 'LANGUAGE': 'en_US:en', 08:41:51 INFO - 'LOGNAME': 'cltbld', 08:41:51 INFO - 'MAIL': '/var/mail/cltbld', 08:41:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:51 INFO - 'MOZ_NO_REMOTE': '1', 08:41:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:51 INFO - 'NO_EM_RESTART': '1', 08:41:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:51 INFO - 'PWD': '/builds/slave/test', 08:41:51 INFO - 'SHELL': '/bin/bash', 08:41:51 INFO - 'SHLVL': '1', 08:41:51 INFO - 'TERM': 'linux', 08:41:51 INFO - 'TMOUT': '86400', 08:41:51 INFO - 'USER': 'cltbld', 08:41:51 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466004465.430263-695516675', 08:41:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:51 INFO - '_': '/tools/buildbot/bin/python'} 08:41:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:41:51 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 08:41:51 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 08:41:51 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 08:41:51 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 08:41:51 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 08:41:51 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 08:41:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:41:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:41:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:41:53 INFO - Installing collected packages: mozsystemmonitor 08:41:53 INFO - Running setup.py install for mozsystemmonitor 08:41:53 INFO - Successfully installed mozsystemmonitor 08:41:53 INFO - Cleaning up... 08:41:53 INFO - Return code: 0 08:41:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:41: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')]} 08:41:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41: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')]} 08:41:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:53 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 0x7f746fbb5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c28020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cba2e0>, '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 0x2c26140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c265d0>, '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': '0333a256a5e4f052382dd180000001b1-1466004465.430263-695516675', '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 08:41:53 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 08:41:53 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 08:41:53 INFO - Using env: {'DISPLAY': ':0', 08:41:53 INFO - 'HOME': '/home/cltbld', 08:41:53 INFO - 'LANG': 'en_US.UTF-8', 08:41:53 INFO - 'LANGUAGE': 'en_US:en', 08:41:53 INFO - 'LOGNAME': 'cltbld', 08:41:53 INFO - 'MAIL': '/var/mail/cltbld', 08:41:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:53 INFO - 'MOZ_NO_REMOTE': '1', 08:41:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:53 INFO - 'NO_EM_RESTART': '1', 08:41:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:53 INFO - 'PWD': '/builds/slave/test', 08:41:53 INFO - 'SHELL': '/bin/bash', 08:41:53 INFO - 'SHLVL': '1', 08:41:53 INFO - 'TERM': 'linux', 08:41:53 INFO - 'TMOUT': '86400', 08:41:53 INFO - 'USER': 'cltbld', 08:41:53 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466004465.430263-695516675', 08:41:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:53 INFO - '_': '/tools/buildbot/bin/python'} 08:41:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:53 INFO - Downloading/unpacking jsonschema==2.5.1 08:41:53 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 08:41:53 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 08:41:53 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 08:41:53 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 08:41:53 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 08:41:53 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 08:41:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:41:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:41:55 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 08:41:55 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 08:41:55 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 08:41:55 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 08:41:55 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 08:41:55 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 08:41:55 INFO - Downloading functools32-3.2.3-2.tar.gz 08:41:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:41:55 INFO - warning: no files found matching '*.txt' 08:41:55 INFO - no previously-included directories found matching 'build' 08:41:55 INFO - no previously-included directories found matching 'dist' 08:41:55 INFO - no previously-included directories found matching '.git*' 08:41:55 INFO - Installing collected packages: jsonschema, functools32 08:41:55 INFO - Running setup.py install for functools32 08:41:55 INFO - warning: no files found matching '*.txt' 08:41:55 INFO - no previously-included directories found matching 'build' 08:41:55 INFO - no previously-included directories found matching 'dist' 08:41:55 INFO - no previously-included directories found matching '.git*' 08:41:55 INFO - Successfully installed jsonschema functools32 08:41:55 INFO - Cleaning up... 08:41:55 INFO - Return code: 0 08:41:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:41:55 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')]} 08:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:55 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')]} 08:41:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:55 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 0x7f746fbb5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c28020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cba2e0>, '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 0x2c26140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c265d0>, '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': '0333a256a5e4f052382dd180000001b1-1466004465.430263-695516675', '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 08:41:55 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 08:41:55 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 08:41:55 INFO - Using env: {'DISPLAY': ':0', 08:41:55 INFO - 'HOME': '/home/cltbld', 08:41:55 INFO - 'LANG': 'en_US.UTF-8', 08:41:55 INFO - 'LANGUAGE': 'en_US:en', 08:41:55 INFO - 'LOGNAME': 'cltbld', 08:41:55 INFO - 'MAIL': '/var/mail/cltbld', 08:41:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:55 INFO - 'MOZ_NO_REMOTE': '1', 08:41:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:55 INFO - 'NO_EM_RESTART': '1', 08:41:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:55 INFO - 'PWD': '/builds/slave/test', 08:41:55 INFO - 'SHELL': '/bin/bash', 08:41:55 INFO - 'SHLVL': '1', 08:41:55 INFO - 'TERM': 'linux', 08:41:55 INFO - 'TMOUT': '86400', 08:41:55 INFO - 'USER': 'cltbld', 08:41:55 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466004465.430263-695516675', 08:41:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:55 INFO - '_': '/tools/buildbot/bin/python'} 08:41:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:56 INFO - Downloading/unpacking blobuploader==1.2.4 08:41:56 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 08:41:56 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 08:41:56 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 08:41:56 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 08:41:56 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 08:41:56 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 08:41:58 INFO - Downloading blobuploader-1.2.4.tar.gz 08:41:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:41:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:41:58 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 08:41:58 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 08:41:58 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 08:41:58 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 08:41:58 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 08:41:58 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 08:41:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:41:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:41:58 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 08:41:58 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 08:41:58 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 08:41:58 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 08:41:58 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 08:41:58 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 08:41:58 INFO - Downloading docopt-0.6.1.tar.gz 08:41:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:41:58 INFO - Installing collected packages: blobuploader, requests, docopt 08:41:58 INFO - Running setup.py install for blobuploader 08:41:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:41:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:41:58 INFO - Running setup.py install for requests 08:41:59 INFO - Running setup.py install for docopt 08:41:59 INFO - Successfully installed blobuploader requests docopt 08:41:59 INFO - Cleaning up... 08:41:59 INFO - Return code: 0 08:41:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41:59 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')]} 08:41:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:59 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')]} 08:41:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:59 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 0x7f746fbb5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c28020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cba2e0>, '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 0x2c26140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c265d0>, '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': '0333a256a5e4f052382dd180000001b1-1466004465.430263-695516675', '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 08:41:59 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 08:41:59 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 08:41:59 INFO - Using env: {'DISPLAY': ':0', 08:41:59 INFO - 'HOME': '/home/cltbld', 08:41:59 INFO - 'LANG': 'en_US.UTF-8', 08:41:59 INFO - 'LANGUAGE': 'en_US:en', 08:41:59 INFO - 'LOGNAME': 'cltbld', 08:41:59 INFO - 'MAIL': '/var/mail/cltbld', 08:41:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:59 INFO - 'MOZ_NO_REMOTE': '1', 08:41:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:59 INFO - 'NO_EM_RESTART': '1', 08:41:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:59 INFO - 'PWD': '/builds/slave/test', 08:41:59 INFO - 'SHELL': '/bin/bash', 08:41:59 INFO - 'SHLVL': '1', 08:41:59 INFO - 'TERM': 'linux', 08:41:59 INFO - 'TMOUT': '86400', 08:41:59 INFO - 'USER': 'cltbld', 08:41:59 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466004465.430263-695516675', 08:41:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:59 INFO - '_': '/tools/buildbot/bin/python'} 08:41:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:41:59 INFO - Running setup.py (path:/tmp/pip-IX0i6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:41:59 INFO - Running setup.py (path:/tmp/pip-nZA8JN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:41:59 INFO - Running setup.py (path:/tmp/pip-CSDNFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:41:59 INFO - Running setup.py (path:/tmp/pip-mKnv_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:41:59 INFO - Running setup.py (path:/tmp/pip-LURr89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:41:59 INFO - Running setup.py (path:/tmp/pip-Jbb3zM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:42:00 INFO - Running setup.py (path:/tmp/pip-TJsUF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:42:00 INFO - Running setup.py (path:/tmp/pip-mScuNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:42:00 INFO - Running setup.py (path:/tmp/pip-9I5Dgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:42:00 INFO - Running setup.py (path:/tmp/pip-vOYwyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:42:00 INFO - Running setup.py (path:/tmp/pip-Dob8Rk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:42:00 INFO - Running setup.py (path:/tmp/pip-vdW32R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:42:00 INFO - Running setup.py (path:/tmp/pip-h7Icr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:42:00 INFO - Running setup.py (path:/tmp/pip-QpGwuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:00 INFO - Running setup.py (path:/tmp/pip-O0fowK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:42:00 INFO - Running setup.py (path:/tmp/pip-4qsbfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:42:00 INFO - Running setup.py (path:/tmp/pip-oPTvB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:42:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:42:00 INFO - Running setup.py install for manifestparser 08:42:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:42:00 INFO - Running setup.py install for mozcrash 08:42:01 INFO - Running setup.py install for mozdebug 08:42:01 INFO - Running setup.py install for mozdevice 08:42:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:42:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:42:01 INFO - Running setup.py install for mozfile 08:42:01 INFO - Running setup.py install for mozhttpd 08:42:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:42:01 INFO - Running setup.py install for mozinfo 08:42:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:42:01 INFO - Running setup.py install for mozInstall 08:42:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:42:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:42:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:42:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:42:01 INFO - Running setup.py install for mozleak 08:42:01 INFO - Running setup.py install for mozlog 08:42:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:42:01 INFO - Running setup.py install for moznetwork 08:42:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:42:01 INFO - Running setup.py install for mozprocess 08:42:02 INFO - Running setup.py install for mozprofile 08:42:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:42:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:42:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:42:02 INFO - Running setup.py install for mozrunner 08:42:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:42:02 INFO - Running setup.py install for mozscreenshot 08:42:02 INFO - Running setup.py install for moztest 08:42:02 INFO - Running setup.py install for mozversion 08:42:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:42:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:42:02 INFO - Cleaning up... 08:42:02 INFO - Return code: 0 08:42:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42:02 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')]} 08:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:02 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')]} 08:42:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:02 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 0x7f746fbb5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c28020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cba2e0>, '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 0x2c26140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c265d0>, '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': '0333a256a5e4f052382dd180000001b1-1466004465.430263-695516675', '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 08:42:02 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 08:42:02 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 08:42:02 INFO - Using env: {'DISPLAY': ':0', 08:42:02 INFO - 'HOME': '/home/cltbld', 08:42:02 INFO - 'LANG': 'en_US.UTF-8', 08:42:02 INFO - 'LANGUAGE': 'en_US:en', 08:42:02 INFO - 'LOGNAME': 'cltbld', 08:42:02 INFO - 'MAIL': '/var/mail/cltbld', 08:42:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:02 INFO - 'MOZ_NO_REMOTE': '1', 08:42:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:02 INFO - 'NO_EM_RESTART': '1', 08:42:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:02 INFO - 'PWD': '/builds/slave/test', 08:42:02 INFO - 'SHELL': '/bin/bash', 08:42:02 INFO - 'SHLVL': '1', 08:42:02 INFO - 'TERM': 'linux', 08:42:02 INFO - 'TMOUT': '86400', 08:42:02 INFO - 'USER': 'cltbld', 08:42:02 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466004465.430263-695516675', 08:42:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:02 INFO - '_': '/tools/buildbot/bin/python'} 08:42:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:42:02 INFO - Running setup.py (path:/tmp/pip-cF1jTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:42:02 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)) 08:42:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:42:02 INFO - Running setup.py (path:/tmp/pip-TMZufr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:42:02 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)) 08:42:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:42:02 INFO - Running setup.py (path:/tmp/pip-wAmJQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:42:03 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)) 08:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:42:03 INFO - Running setup.py (path:/tmp/pip-PG8vFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:42:03 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)) 08:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:42:03 INFO - Running setup.py (path:/tmp/pip-GHMQQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:42:03 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)) 08:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:42:03 INFO - Running setup.py (path:/tmp/pip-dB9hE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:42:03 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)) 08:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:42:03 INFO - Running setup.py (path:/tmp/pip-Tl_dzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:42:03 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)) 08:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:42:03 INFO - Running setup.py (path:/tmp/pip-Dgb6pz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:42:03 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)) 08:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:42:03 INFO - Running setup.py (path:/tmp/pip-g9k8Q2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:42:03 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)) 08:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:42:03 INFO - Running setup.py (path:/tmp/pip-dlbjuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:42:03 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)) 08:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:42:03 INFO - Running setup.py (path:/tmp/pip-Fc5dVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:42:03 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)) 08:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:42:03 INFO - Running setup.py (path:/tmp/pip-S1HlEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:42:03 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)) 08:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:42:03 INFO - Running setup.py (path:/tmp/pip-8KcEe7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:42:03 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)) 08:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:42:03 INFO - Running setup.py (path:/tmp/pip-lq2inR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:42:03 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)) 08:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:03 INFO - Running setup.py (path:/tmp/pip-V40kkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:03 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)) 08:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:42:03 INFO - Running setup.py (path:/tmp/pip-CvHTVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:42:03 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)) 08:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:42:03 INFO - Running setup.py (path:/tmp/pip-Jw3dxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:42:04 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)) 08:42:04 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)) 08:42:04 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)) 08:42:04 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)) 08:42:04 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)) 08:42:04 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)) 08:42:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:42:04 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 08:42:04 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 08:42:04 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 08:42:04 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 08:42:04 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 08:42:04 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 08:42:05 INFO - Downloading blessings-1.6.tar.gz 08:42:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:42:06 INFO - Installing collected packages: blessings 08:42:06 INFO - Running setup.py install for blessings 08:42:06 INFO - Successfully installed blessings 08:42:06 INFO - Cleaning up... 08:42:06 INFO - Return code: 0 08:42:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:42:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:42:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:42:06 INFO - Reading from file tmpfile_stdout 08:42:06 INFO - Current package versions: 08:42:06 INFO - argparse == 1.2.1 08:42:06 INFO - blessings == 1.6 08:42:06 INFO - blobuploader == 1.2.4 08:42:06 INFO - docopt == 0.6.1 08:42:06 INFO - functools32 == 3.2.3-2 08:42:06 INFO - jsonschema == 2.5.1 08:42:06 INFO - manifestparser == 1.1 08:42:06 INFO - mozInstall == 1.12 08:42:06 INFO - mozcrash == 0.17 08:42:06 INFO - mozdebug == 0.1 08:42:06 INFO - mozdevice == 0.48 08:42:06 INFO - mozfile == 1.2 08:42:06 INFO - mozhttpd == 0.7 08:42:06 INFO - mozinfo == 0.9 08:42:06 INFO - mozleak == 0.1 08:42:06 INFO - mozlog == 3.2 08:42:06 INFO - moznetwork == 0.27 08:42:06 INFO - mozprocess == 0.22 08:42:06 INFO - mozprofile == 0.28 08:42:06 INFO - mozrunner == 6.11 08:42:06 INFO - mozscreenshot == 0.1 08:42:06 INFO - mozsystemmonitor == 0.3 08:42:06 INFO - moztest == 0.7 08:42:06 INFO - mozversion == 1.4 08:42:06 INFO - psutil == 3.1.1 08:42:06 INFO - requests == 1.2.3 08:42:06 INFO - wsgiref == 0.1.2 08:42:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:42:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:42:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:06 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 0x7f746fbb5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c28020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cba2e0>, '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 0x2c26140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c265d0>, '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': '0333a256a5e4f052382dd180000001b1-1466004465.430263-695516675', '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 08:42:06 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 08:42:06 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 08:42:06 INFO - Using env: {'DISPLAY': ':0', 08:42:06 INFO - 'HOME': '/home/cltbld', 08:42:06 INFO - 'LANG': 'en_US.UTF-8', 08:42:06 INFO - 'LANGUAGE': 'en_US:en', 08:42:06 INFO - 'LOGNAME': 'cltbld', 08:42:06 INFO - 'MAIL': '/var/mail/cltbld', 08:42:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:06 INFO - 'MOZ_NO_REMOTE': '1', 08:42:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:06 INFO - 'NO_EM_RESTART': '1', 08:42:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:06 INFO - 'PWD': '/builds/slave/test', 08:42:06 INFO - 'SHELL': '/bin/bash', 08:42:06 INFO - 'SHLVL': '1', 08:42:06 INFO - 'TERM': 'linux', 08:42:06 INFO - 'TMOUT': '86400', 08:42:06 INFO - 'USER': 'cltbld', 08:42:06 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466004465.430263-695516675', 08:42:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:06 INFO - '_': '/tools/buildbot/bin/python'} 08:42:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:06 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)) 08:42:06 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)) 08:42:06 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)) 08:42:06 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)) 08:42:06 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)) 08:42:06 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)) 08:42:06 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)) 08:42:06 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)) 08:42:06 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)) 08:42:06 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)) 08:42:06 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)) 08:42:06 INFO - Cleaning up... 08:42:06 INFO - Return code: 0 08:42:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:42:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:42:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:42:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:06 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 0x7f746fbb5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c28020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cba2e0>, '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 0x2c26140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c265d0>, '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': '0333a256a5e4f052382dd180000001b1-1466004465.430263-695516675', '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 08:42:06 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 08:42:06 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 08:42:06 INFO - Using env: {'DISPLAY': ':0', 08:42:06 INFO - 'HOME': '/home/cltbld', 08:42:06 INFO - 'LANG': 'en_US.UTF-8', 08:42:06 INFO - 'LANGUAGE': 'en_US:en', 08:42:06 INFO - 'LOGNAME': 'cltbld', 08:42:06 INFO - 'MAIL': '/var/mail/cltbld', 08:42:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:07 INFO - 'MOZ_NO_REMOTE': '1', 08:42:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:07 INFO - 'NO_EM_RESTART': '1', 08:42:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:07 INFO - 'PWD': '/builds/slave/test', 08:42:07 INFO - 'SHELL': '/bin/bash', 08:42:07 INFO - 'SHLVL': '1', 08:42:07 INFO - 'TERM': 'linux', 08:42:07 INFO - 'TMOUT': '86400', 08:42:07 INFO - 'USER': 'cltbld', 08:42:07 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466004465.430263-695516675', 08:42:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:07 INFO - '_': '/tools/buildbot/bin/python'} 08:42:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:42:07 INFO - Cleaning up... 08:42:07 INFO - Return code: 0 08:42:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:42:07 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')]} 08:42:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:07 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')]} 08:42:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:07 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 0x7f746fbb5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c28020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cba2e0>, '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 0x2c26140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c265d0>, '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': '0333a256a5e4f052382dd180000001b1-1466004465.430263-695516675', '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 08:42:07 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 08:42:07 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 08:42:07 INFO - Using env: {'DISPLAY': ':0', 08:42:07 INFO - 'HOME': '/home/cltbld', 08:42:07 INFO - 'LANG': 'en_US.UTF-8', 08:42:07 INFO - 'LANGUAGE': 'en_US:en', 08:42:07 INFO - 'LOGNAME': 'cltbld', 08:42:07 INFO - 'MAIL': '/var/mail/cltbld', 08:42:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:07 INFO - 'MOZ_NO_REMOTE': '1', 08:42:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:07 INFO - 'NO_EM_RESTART': '1', 08:42:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:07 INFO - 'PWD': '/builds/slave/test', 08:42:07 INFO - 'SHELL': '/bin/bash', 08:42:07 INFO - 'SHLVL': '1', 08:42:07 INFO - 'TERM': 'linux', 08:42:07 INFO - 'TMOUT': '86400', 08:42:07 INFO - 'USER': 'cltbld', 08:42:07 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466004465.430263-695516675', 08:42:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:07 INFO - '_': '/tools/buildbot/bin/python'} 08:42:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:07 INFO - Downloading/unpacking flake8 08:42:07 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 08:42:07 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 08:42:07 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 08:42:07 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 08:42:07 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 08:42:07 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 08:42:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:42:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:42:09 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 08:42:09 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 08:42:09 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 08:42:09 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 08:42:09 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 08:42:09 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 08:42:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:42:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:42:09 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 08:42:09 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 08:42:09 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 08:42:09 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 08:42:09 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 08:42:09 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 08:42:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:42:09 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 08:42:09 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 08:42:09 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 08:42:09 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 08:42:09 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 08:42:09 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 08:42:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:42:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:42:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:42:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:42:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:42:10 INFO - no previously-included directories found matching 'docs/_build' 08:42:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:42:10 INFO - Running setup.py install for pep8 08:42:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:42:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:42:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:42:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:42:10 INFO - no previously-included directories found matching 'docs/_build' 08:42:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:42:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:42:10 INFO - Cleaning up... 08:42:10 INFO - Return code: 0 08:42:10 INFO - Running post-action listener: _resource_record_post_action 08:42:10 INFO - Running post-action listener: _start_resource_monitoring 08:42:10 INFO - Starting resource monitoring. 08:42:10 INFO - ##### 08:42:10 INFO - ##### Finished create-virtualenv step (success) 08:42:10 INFO - ##### 08:42:10 INFO - ##### 08:42:10 INFO - ##### Running install step. 08:42:10 INFO - ##### 08:42:10 INFO - Running pre-action listener: _resource_record_pre_action 08:42:10 INFO - Running main action method: install 08:42:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:42:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:42:10 INFO - Reading from file tmpfile_stdout 08:42:10 INFO - Detecting whether we're running mozinstall >=1.0... 08:42:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:42:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:42:10 INFO - Reading from file tmpfile_stdout 08:42:10 INFO - Output received: 08:42:10 INFO - Usage: mozinstall [options] installer 08:42:10 INFO - Options: 08:42:10 INFO - -h, --help show this help message and exit 08:42:10 INFO - -d DEST, --destination=DEST 08:42:10 INFO - Directory to install application into. [default: 08:42:10 INFO - "/builds/slave/test"] 08:42:10 INFO - --app=APP Application being installed. [default: firefox] 08:42:10 INFO - mkdir: /builds/slave/test/build/application 08:42:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:42:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:42:26 INFO - Reading from file tmpfile_stdout 08:42:26 INFO - Output received: 08:42:26 INFO - /builds/slave/test/build/application/firefox/firefox 08:42:26 INFO - Running post-action listener: _resource_record_post_action 08:42:26 INFO - ##### 08:42:26 INFO - ##### Finished install step (success) 08:42:26 INFO - ##### 08:42:26 INFO - ##### 08:42:26 INFO - ##### Running run-tests step. 08:42:26 INFO - ##### 08:42:26 INFO - Running pre-action listener: _resource_record_pre_action 08:42:26 INFO - Running main action method: run_tests 08:42:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:42:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:42:26 INFO - Python 2.7.3 08:42:26 INFO - Return code: 0 08:42:26 INFO - grabbing minidump binary from tooltool 08:42:26 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')]} 08:42:26 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 0x2cba2e0>, '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 0x2c26140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c265d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:42:26 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 08:42:26 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 08:42:26 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 08:42:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:42:26 INFO - Return code: 0 08:42:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:42:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:42:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:42:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:42:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:42:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:42:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:42:27 INFO - Return code: 0 08:42:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ODEE5zyDSoScYh7lh3au1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 08:42:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ODEE5zyDSoScYh7lh3au1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 08:42:27 INFO - Using env: {'DISPLAY': ':0', 08:42:27 INFO - 'HOME': '/home/cltbld', 08:42:27 INFO - 'LANG': 'en_US.UTF-8', 08:42:27 INFO - 'LANGUAGE': 'en_US:en', 08:42:27 INFO - 'LOGNAME': 'cltbld', 08:42:27 INFO - 'MAIL': '/var/mail/cltbld', 08:42:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:42:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:42:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:27 INFO - 'MOZ_NO_REMOTE': '1', 08:42:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:42:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:27 INFO - 'NO_EM_RESTART': '1', 08:42:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:27 INFO - 'PWD': '/builds/slave/test', 08:42:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:42:27 INFO - 'SHELL': '/bin/bash', 08:42:27 INFO - 'SHLVL': '1', 08:42:27 INFO - 'TERM': 'linux', 08:42:27 INFO - 'TMOUT': '86400', 08:42:27 INFO - 'USER': 'cltbld', 08:42:27 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466004465.430263-695516675', 08:42:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:27 INFO - '_': '/tools/buildbot/bin/python'} 08:42:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ODEE5zyDSoScYh7lh3au1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 08:42:27 INFO - mozversion application_buildid: 20160615080629 08:42:27 INFO - mozversion application_changeset: 153553aecf160632bbcb50906ba135511da138e6 08:42:27 INFO - mozversion application_display_name: Nightly 08:42:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:42:27 INFO - mozversion application_name: Firefox 08:42:27 INFO - mozversion application_remotingname: firefox 08:42:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:42:27 INFO - mozversion application_vendor: Mozilla 08:42:27 INFO - mozversion application_version: 50.0a1 08:42:27 INFO - mozversion platform_buildid: 20160615080629 08:42:27 INFO - mozversion platform_changeset: 153553aecf160632bbcb50906ba135511da138e6 08:42:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:42:27 INFO - mozversion platform_version: 50.0a1 08:42:27 INFO - using testdate: 1466005347 08:42:27 INFO - actual date: 1466005347 08:42:27 INFO - starting webserver on 'localhost:59033' 08:42:27 INFO - SUITE-START | Running 2 tests 08:42:27 INFO - TEST-START | dromaeo_css 08:42:27 INFO - operating with platform_type : linux_ 08:42:27 INFO - Initialising browser for dromaeo_css test... 08:42:27 INFO - TEST-INFO | started process 13813 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFV6VmO/profile http://localhost:59033/getInfo.html) 08:42:32 INFO - PROCESS | 13813 | __metrics Screen width/height:1600/1200 08:42:32 INFO - PROCESS | 13813 | colorDepth:24 08:42:32 INFO - PROCESS | 13813 | Browser inner width/height: 1024/697 08:42:32 INFO - PROCESS | 13813 | __metrics 08:42:33 ERROR - PROCESS | 13813 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 08:42:34 INFO - TEST-INFO | 13813: exit 0 08:42:34 INFO - Browser initialized. 08:42:34 INFO - Running cycle 1/1 for dromaeo_css test... 08:42:34 INFO - TEST-INFO | started process 13933 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFV6VmO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:42:46 INFO - PROCESS | 13933 | RSS: Main: 186441728 08:42:46 INFO - PROCESS | 13933 | 08:43:36 INFO - PROCESS | 13933 | 1466005416039 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] 08:45:48 INFO - PROCESS | 13933 | Cycle 1(1): loaded http://localhost:59033/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59033/tests/dromaeo/cssquery-ext.html) 08:45:49 INFO - PROCESS | 13933 | RSS: Main: 188313600 08:45:49 INFO - PROCESS | 13933 | 08:48:51 INFO - PROCESS | 13933 | Cycle 1(1): loaded http://localhost:59033/tests/dromaeo/cssquery-ext.html (next: http://localhost:59033/tests/dromaeo/cssquery-jquery.html) 08:48:52 INFO - PROCESS | 13933 | RSS: Main: 187277312 08:48:52 INFO - PROCESS | 13933 | 08:51:54 INFO - PROCESS | 13933 | Cycle 1(1): loaded http://localhost:59033/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59033/tests/dromaeo/cssquery-mootools.html) 08:51:54 INFO - PROCESS | 13933 | RSS: Main: 188616704 08:51:54 INFO - PROCESS | 13933 | 08:54:56 INFO - PROCESS | 13933 | Cycle 1(1): loaded http://localhost:59033/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59033/tests/dromaeo/cssquery-prototype.html) 08:54:57 INFO - PROCESS | 13933 | RSS: Main: 186449920 08:54:57 INFO - PROCESS | 13933 | 08:57:59 INFO - PROCESS | 13933 | Cycle 1(1): loaded http://localhost:59033/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59033/tests/dromaeo/cssquery-yui.html) 08:58:00 INFO - PROCESS | 13933 | RSS: Main: 188387328 08:58:00 INFO - PROCESS | 13933 | 09:01:03 INFO - PROCESS | 13933 | Cycle 1(1): loaded http://localhost:59033/tests/dromaeo/cssquery-yui.html (next: http://localhost:59033/tests/dromaeo/cssquery-dojo.html) 09:01:03 INFO - PROCESS | 13933 | RSS: Main: 190263296 09:01:03 INFO - PROCESS | 13933 | 09:01:03 INFO - PROCESS | 13933 | __start_tp_report 09:01:03 INFO - PROCESS | 13933 | _x_x_mozilla_page_load 09:01:03 INFO - PROCESS | 13933 | _x_x_mozilla_page_load_details 09:01:03 INFO - PROCESS | 13933 | |i|pagename|runs| 09:01:03 INFO - PROCESS | 13933 | |0;dojo.html;2599.064336838738;2647.3778662014424;2661.4277930244994;2672.625832383467;2676.81262311638;4586.289125185597;4614.838480653182;4652.534746525345;4716.457607375153;4778.737169455679;4700.905981880361;4722.59857912077;4737.455192652846;4774.570288674027;4781.784819683114;4348.2825333819965;4360.10617823347;4445.444319460067;4467.620252278561;4485.3944717463055;4163.229802486535;4484.865454036368;4516.9774151129195;4520.864374068767;4529.932051019237;4317.15815415994;4333.934990975138;4339.088791353819;4436.223660859337;4500.8649740507835;4348.760818155;4363.127374525107;4370.300751879716;4405.251107311733;4425.3140763181755;4366.104948485553;4393.340998850166;4402.097569998175;4414.161309351245;4432.22436073689;4688.812447502096;4760.024195040043;4779.307000484945;4814.422269327668;4835.492273311287;5134.358205224347;5141.794328226866;5148.459411761786;5155.5617772489;5178.326817513736;4971.6271279654175;5155.71643559604;5162.974185129088;5174.663646862942;5181.274621552986;4685.929711054337;4707.388039554836;4738.549837765407;4755.9286610700865;4756.453007904066;5205.47945205484;5212.713300768418;5224.138017227191;5225.294585231021;5283.128283833202;4923.606111511071;5015.3229314042865;5020.347354843847;5025.195968645073;5034.622403319766;5144.30551875492;5167.509086636764;5185.325907631984;5196.090684130262;5223.373195216598;4982.153033984231;5022;5037.823676171316;5053.69677819332;5072.340595722532;4952.900941981212;5047.722375269322;5059.089363914531;5068.011737711185;5129.435762066169;4348.804303806336;4363.716358436755;4377.299632058855;4388.605025547716;4407.206702793528;3804.505414296124;3811.8856434307013;3816.809159542012;3857.0935830079907;3857.9035524112123;4266.232078225887;4373.606375426227;4424.424824772824;4446.73319600825;4475.552444755564;5123.538881500683;5163.380394352702;5173.767180476888;5185.377754669464;5224.582033437316;4369.71596846204;4423.734575925455;4432.202203603318;4456.844010459683;4461.13007963444;4477.731336119843;4611.331356953223;4646.047560250141;4646.303054541846;4646.7444290564345;4804.2073057945045;4826.565609095198;4834.250691142808;4864.416270047617;4864.683795553277;5118.513741194581;5143.459936706592;5159.613029022763;5174.172132458789;5175.275461435477;4702.412198475191;4714.245720684811;4744.122337367598;4744.4069491313585;4871.2206047032305;4968.031233909497;4971.527704868032;4978.726170060681;4978.8257410990445;5084.898302034013;5096.949030509648;5099.464556221544;5099.719515426687;5107.744612769272;5150.9227361588855;4798.880027999328;4849.151398505177;4940.975295123501;4973.801047958186;5004.3494345734825;4902.607791376753;4926.802927882988;4939.629527785359;4970.900581988412;4974.5771609413605;4855.1260773061185;4896.877578060577;4909.729964851967;4910.582600478856;4965.280034395065;4913.459519452929;4980.8754781130765;5020.648554601143;5029.572486338702;5079.8570321677325;4935.75321233944;4945.727984960861;4979.3526841510375;4979.427365852974;5022.874428139326 09:01:03 INFO - PROCESS | 13933 | |1;ext.html;552.2992029429797;565.9575531835111;580.9128630705394;601.3955974245882;619.5663035874888;35042.12394690134;38629.22741545171;38631.61368386315;38698.22603547931;38720.225595488075;32688.673113268862;32864.34271314572;32990;33028.33943321138;33143.33713325732;7813.296803287703;7873.921260787376;7906.2884340409355;7923;7941.642626081812;7814.218578142197;7816.452848300622;7869.331106855924;7894.960525197366;7895.24995125465;7762.340201082915;7819.609019549028;7875.606219689022;7889.5266284022855;7933.16701746317;7855.253750893656;7872.960635196816;7895.684172633117;7906.051273847118;7912.960435197845;7694.499857509244;7823.100343460518;7823.882641760378;7835.667936450817;7861.724839630586;37147.81426092879;37374;37435.25129497422;37486.06284842874;37524.24951500982;2652.8938842446278;2922.9853850730824;2964.9851750741323;3145.748340132807;3164.5411415344647;27363.589546156825;27878.721212787816;28287.29281767972;28366.858165709247;28779.85610071957;3134.7805653604255;3185.267388500658;3190.0589326148843;3204.279037216631;3206.679332066798;205948;206856;207138;207873;207994;31695.683043169272;32024.83987580094;32025;32043.67956320407;32066.358672826413;29159.271018224288;29469;29526.114216573107;29532.704672953427;29553.556696649568;13412.798808017887;13415.597532074053;13437.462501500026;13466.730665386833;13483.730325393633;10901.618443354444;10986;10997.450127493594;11004.064654504456;11030.2278840482;18308.633827323378;18333.63332733338;18355.81644183541;18359.541011474554;18396.356127535473;6749.156355455568;6811.318868113248;6959.965200173967;7011.649417529103;7075.858482830417;793.5833687314091;912.2565109435789;924.5608336040461;961.9422834629804;990.9891910251503;27742.583861242096;27972;28190.85904570505;28378.716212837608;28689.426211475653;899.572702966099;922.5295099499303;937.376644531379;967.8209531236744;977.3647129365969;14407.135571865721;14822.40710371573;15018.924905375403;15031.323590438456;15095.169765662993;114847.42576287065;116587.41706291414;117135.41432292784;117393;365358;48652.75673621609;49451.258231126565;49479;49527.25709114366;49631.50368496341;1174.8179032250016;1201.4773573495556;1202.8736982616874;1221.8167274908835;1223.663492539541;24869.25392238236;25916.222513323875;26174.214773556825;26209.213723588324;26491.08598054174;42544.57455425406;43235.567644324416;43428;43479.56520434755;43528;318905;322125;322966;323415;325882;24741.87629061843;25157.87421062883;25331.6200257;25649.871750641127;25845.22464326073;40991.590084098774;41282.38076428796;41315.586844131176;41699.7915010423;42306.576934231496;35752.82123589365;35918.640813591526;36014.63985360217;36184.27631447409;36198.09504762402;35205.82397087998;35399.469007964384;35489.467657984635;35549.82225088858;35756;34585.65414345925;34969.125771855906;35253.823730882206;35512.82243588869;35538.82230588831;30955.226119347197;32265;32307.676923231407;32867;32909.50635740418;24844.50310993806;24897.128600498894;25039.12363067284;25387;25486.23541293764 09:01:03 INFO - PROCESS | 13933 | |2;jquery.html;357.2390807579855;359.9712023038157;366.2071614953625;371.1352548561851;374.2122831439819;15436.69126617467;16777.24502397392;17204.397846075375;17776.555586110353;17796.822031779677;16117.758233626475;16538.7519187212;17269.39557115501;17309.913450432763;17328.220230089646;5011.749412529368;5212.087884620195;5237.580993520528;5239.502247286502;5248.343957005374;3679.742418030739;4901.509849015106;5795.768169273224;6127.264728232596;6131.202943617323;6097.512199024068;6128.356522565134;6135.3557876423;6153.230846144232;6163.106349579309;5041.445441001487;5341.973290133525;5344.4922732340365;5349;5415.512603865632;5103.260027296058;5171.793128274864;5214.947850521484;5245.26566280721;5270;18649.813501864945;19947.40157795254;19947.80052199474;20105;20261;1856.1925562380409;2014.4460273424925;2179.2372669565684;2227.8774667393286;2371.1819422299277;8278.254957053894;8427.620757065946;8849.513276769776;8975.461472311683;9040.095990400972;1621.6675581505763;1677.4715964471152;1707.197617119964;1738.5132162994382;1805.900675462849;64472.677636611515;65080.3491965079;67890;68564.6571767143;68672.9999999995;8104.959475202586;8596;8765.737027889174;8816.77958051041;9004.81990360189;11139.108871290277;11217.55129794799;11252.718682032852;11293.661190164308;11348.205625606293;6632.966835165793;6679.064930909676;6689.063531105649;6765.932340676629;6774.525783195228;6684.2647308795995;6810.829729256809;6818.4886133540185;6947.096877405905;6983.580985140908;3580.979420865041;3623.239119784822;3677.9816100919325;3678.1540245743095;3717.739758216953;1626.6584017356488;1650.290375138678;1701.6936951348875;1730.411660035594;1790.1944125143737;832.5629044751554;847.326375531454;856.7301300090452;871.7907702151565;922.372786505183;16415.42546010884;16704.582385440463;16791.2443940023;16829.242684079247;16894.831051689573;840.2689659995721;844.0668676349636;866.6403442571388;867.1328671328671;868.6916144768643;8927.018028016913;9483.762905927408;9489.478078705737;9495.477748723748;9610.990845961074;380850;385536;389945;391443;392876;78524;78563;79055.60472197717;79190.60404698054;79371.20628793638;821.6097353757037;824.9628766705513;829.9087100418828;833.1668331668332;835.6337388370059;14642.560723178321;15012.24938753036;15047.322870471075;15084.472043478425;15384.000039997365;29125;35261;35785.284294314486;36116.45825312675;37818.62181378151;49311.50688493069;50725.492745073556;51226.74386628192;51581;51649.741751291;7370.078740157481;7417;7448.851022979618;7538.585377804054;7558.622068896423;10413.166946644098;10686.57253709843;10973.3964631946;11584;11719.355435451133;9260.675876344296;9268.443893366419;9531.285153613368;9535.761605959906;9720.319577629782;9736.610535578497;9768.902310976799;9977.900220997697;10140.188784897338;10281.485925703835;5009.799608015638;5605.691686957257;9677.274204434836;9812.901870981199;9853.408795472295;7299.489035767445;7440.441966852616;7460.813479662835;7545;7569.6593653284635;7222.783316500513;8337.499750015018;9232.169104780602;9252.95373523128;9915.256355773201 09:01:03 INFO - PROCESS | 13933 | |3;mootools.html;1318.657149141223;1367.384676895397;1416.914985100894;1631.8857679962407;1643.7205675035243;6598.10925525054;7169.318914703095;7243.927560724391;7732.45872788905;7762.068551773788;7329.230430804755;7526.924730752691;7549.886751698729;7575.166731659527;7575.772726818191;2123.925662601809;2170.1861801824316;2171.0338899189865;2179.1501314487364;2186.3768825884626;2090.9059092340804;2093.86389884657;2153.074178103415;2154.63371226891;2160.4490854832075;2087.425957861585;2093.9267125650604;2097.8741275523516;2098.2970704813906;2151.752548456924;2094.3193462124796;2096.6540520814046;2096.790320967906;2103.5161912760072;2104.6106470303043;2141.539568992674;2144.1316266911927;2157.33122731952;2178.1287485005964;2181.7054697615936;7483.8503229935095;7572.734954276629;7577.469577129603;7613.972113764682;7655.387568994467;4404.2512772828695;4447.977760111211;4511.819527218908;4516.616087632555;4520.254158063915;2839;2880.5391137417914;2894.305366711995;2897.203269101014;2900.129961011709;879.2087121590556;905.2712566384058;914.6524320758069;922.7693076730817;940.4921342475055;10145.188384929188;10185.694429167062;10196.439195844225;10201.642942496977;10201.846972295421;4021.557628660845;4078.6125318094732;4127.7936103194725;4152.294110001307;4161.209370219649;8742.038375778659;8776.429532080521;8777.605007774666;8795.956020219857;8800.251978581764;4491.932621010687;4516.751578663139;4553.772311384418;4568.954310456919;4571.588557029883;3599.802010889374;3945.11234972129;4093.0176757577965;4133.772642504691;4154.584541545822;3537.0803591066506;3567.7502574820032;3670.522832031819;3670.7614005089586;3688.39141541648;1172.0017370383646;1174.4186627619213;1187.3350923482876;1198.8381568488317;1210.2738356985737;744.9813754656177;795.1809636074852;804.5735760047185;814.0150417994294;835.2566216067584;4658.650601204923;4676.836310729108;4801.831935882227;4825.034993001414;4867.3915760529935;864.7146441674232;869.4609342207872;873.157403105993;902.1294450854956;907.8275127725711;3282.163048422637;3322.235885746292;3366.7474939379645;3378.3243351329343;3395.609504906918;8979.910200898039;9239.72280831576;9241.630334786532;9283.39657922233;9298.302627302979;9067.319951003701;9102.772430689154;9117.863232051524;9125.17873391398;9173.03683113277;7024.473164512682;7106.680199391039;7123.964380178066;7202.747903823446;7211.531250468703;4706.1528924793865;4706.294055891643;4724.220503617003;4736.715797052188;4791;8219;8357.540335281617;8529.061803201766;8577.528235947082;8608.827823443622;8517.105703901001;8534.82930341402;8609.569521523774;8634.30925525969;8710.085441028601;5484.561235101102;5830.154627578892;6029.728662210124;6077.149199112039;6238.500919926304;7196.280371962762;7216.819579510554;7247.1303443585;7285.380742636723;7288.234735352924;6085.908711369421;6330.841728956813;6375.6493392861985;6381.329960354282;6387.073874288109;6219.0982307566055;6329.208848893888;6432.517561183024;6468.579542329921;6523.739050438119;5985.132155837292;6049.848753781014;6082.087686847009;6092.573519853568;6148.508119350352;4170.103427763045;4241.554636763095;4254.383114448449;4329.502107257706;4370.694051416371;4018.437418761317;4115.279826030493;4157;4271.996080920919;4329.675274354373 09:01:03 INFO - PROCESS | 13933 | |4;prototype.html;278.45006112926967;282.2435871863407;290.5380445092304;293.5069083938984;295.1955920117678;4923.956558028419;5026.849194524161;5040.697558146514;5047.949520504799;5074.949250507499;4992.75036248187;4992.950070499294;4997.60067181189;5011.574016208618;5020.0963826511215;3710.666040056394;3851.73037887348;3937.566867644564;3943;3944.4280579315982;3949.6642785363133;3951.3677811550156;3963.524377074755;3964.6431821136093;3967.682585393162;3854;3856.573067964857;3904.1606054698236;3907.413887916821;3930.2532518821477;3781.300459415017;3921.431392448079;3937.6652984496354;3949.308870947587;3963.1479231965122;3402.6767457091537;3413.7951722896705;3418.1967237699123;3422.8973130806116;3424.6404127566498;4897.877553061202;4901.779419926112;4917.72952487613;4942.690187100386;4954.727489988085;4454.621357184643;4460.7323560586465;4480.708753931017;4495.43807024122;4512.3682684423875;5082.4663410341755;5265.6840589564745;5266.262723218752;5276.551493123089;5283.735813209362;3736.57029441615;3742.8128593570214;3747.662710356081;3757.906052348686;3772.2078363543687;5494.148406996922;5499.50504454601;5510.476504732044;5511.035568775448;5526.723663816793;3742.2702572998005;3765.7631684900707;3840.3663395539984;3846.615338466187;3856.2480316338606;3859.4403811447182;3876.9806150969066;3877.0888841122314;3889.7277190596387;3899.980500097538;4467.106578684276;4485.775711214426;4498.482674492475;4500.347449619787;4521.480029796549;4971.37857767779;5302.973485132627;5340.305760251143;5344.812931547377;5367.651102678314;1345.1928842694306;1355.627202519315;1356.1591813075759;1357.5045108535314;1360.2450639894953;841.5497708725925;856.9442986205877;866.0992567729617;879.7536689726886;883.4875772052194;4454.131444368317;4609.8156073757345;4636.374089497875;4640.23436133041;4652.767361631905;5488.4785945335125;5495.021792154821;5496.285482887199;5502.284702988666;5507.862303442446;4507.346434766941;4657.813687452532;4667.719936803803;4699.765011749467;4701.459332176843;2936.309967157716;2937.2803663102677;2937.5459147722013;2941.352902361477;2944.7349738523635;5122.154844450624;5138.254953031864;5141.537261646395;5145.305383773218;5168.715720635401;5429.972850135724;5606.775728970877;5629.437056294338;5632.957902787997;5664.716764161775;5064.974675126675;5124.180131179068;5129.897402051938;5135.563477104413;5150.1502252127975;5425.4808653577065;5448.809291674773;5475.945240547703;5480.6437581557075;5486.670799752028;5176.6704982758665;5390.865228369165;5416.2688037114485;5417.6478528895495;5434.212039254365;5081.517255860687;5139.871503212449;5143.177091665316;5171.482851714798;5179.145441002343;3920.745151565139;3921.8235179417566;3922.78424686645;3924.941125883057;3946.723729338919;5148.665336753099;5477.972610136924;5490.752916118864;5497.4607110009265;5540.584456165723;5274.578033757367;5276.39321478035;5289.338832645919;5301.231321458444;5302.602304827076;5175.844724658266;5273.525382715574;5292.470752924831;5304.7082410466255;5379.623426360117;5215.904660021438;5235.842924712265;5266.368035835724;5267.920981185209;5294.152935530296;5097.235414687826;5224.268602395591;5404.648697834628;5406.486383793534;5406.702631355313;5238.214267859699;5248.58011359098;5250.26496290512;5281.075811732854;5290.153575427913 09:01:03 INFO - PROCESS | 13933 | |5;yui.html;627.6641996531856;657.4050484311698;668.5186665600772;703.3810246982655;709.6309918842202;12627.55803546876;12711.36443177841;12863.099583029192;12937.935310323435;13030.087893847434;12648.936755316234;12959.93520032401;12961.416736246869;12999.610011699664;13000.154989925648;773.4740376543933;783.1307248953657;786.4455558831011;787.629813987425;788.329919568368;619.7613918641333;760.0992823504138;791.6318911706055;793.2226418110256;797.9361651067929;827.3257295304338;831.8003679116998;831.9126491718343;838.4801423117675;838.5094719589048;828.9253967142926;829.2619568583965;831.3930830493713;833.729038062629;835.3108685334593;610.112286622967;610.5603965145133;610.8472881779555;611.1169360274405;614.5268143529457;13288;13368.197908125447;13412.195268283836;13416.46334146633;13446.596602101952;13211.867881321255;13285.269310187936;13478.595642130751;13575.728485430236;13851;10524.210684198715;10602.840957385646;10604.681859544226;10675.199360048027;10836.945815270952;3366.848491817874;3382.509536117274;3430.1939044324563;3430.9828450857835;3492.4935884296888;60958;61041.694791525755;61920.38079619191;62181.689091554705;62548.687256563426;10455.548966156532;10587.788244235073;10623.521941512496;10714.73213169677;10841.349519028883;20420.489487762923;20512.17951281932;20513;20636.07137678778;20876.791232087788;7071.540349877241;7117.82205444868;7190.424766018706;7244.239354867768;7394.186639469654;3690.317291301118;3760.417135344026;3781.1870447853844;3799.430085487144;3870.903227419281;2949.233199368137;3065.432894914448;3082.5838511801066;3083.152133163398;3085.506318988951;538.7764077907624;565.7284503438291;571.0691572736413;577.3793172339751;580.6487075319455;474.4259446070225;520.3937412913989;548.4405905975962;602.8733965867217;633.1863555331469;8118.188181181835;8155.469894456842;8215.548144851971;8255.834883302301;8312.168783121639;535.0315928170024;574.2764117212342;627.3569591169088;628.8616504369123;632.7627139822566;3893.442622950786;3895;3975.7018223632763;3977.1449138435373;4077.55146933837;55264.17103743447;73520;75584.24415755882;76542;89894.55052724695;83659.58170209231;86519;87693;88317;88566.55716721374;76071.23928760752;76649;78381.60809195918;78414;78692.21307786963;8944.776380590538;9013.594388252675;9055.18503334703;9186.127317904788;9194.862077068983;42559.787201063795;43575.47485837981;43966.56033439752;44414.77792611016;45974.942756296114;56948.430515694316;67140.66429668016;67922.66038669775;68096.6595167021;68360;9214.124658157465;10351.948240258751;10938.234323597271;10984.945075274572;11410.14423918226;12176.75646487083;12519.186252893533;12848.807267890803;13005.934970325088;13511.86488135106;12073.637790866289;12433.875661243634;12446.315452650191;13119;13185.868141318464;12484.937575312066;12652.810207847073;13165.868341316464;13398.933005334911;13409.128406653535;11817.350045747222;11959.983401410978;12162.452689628812;12433.254004759743;12632.557860474839;10193.949030254802;10554.683359499228;10589.311694739818;10622.52198651078;11072.39101849406;10494.160467162761;10614.787704245717;10688.946555267485;10740.194485413782;10790.74878865097 09:01:03 INFO - PROCESS | 13933 | __end_tp_report 09:01:03 INFO - PROCESS | 13933 | __start_cc_report 09:01:03 INFO - PROCESS | 13933 | _x_x_mozilla_cycle_collect,406 09:01:03 INFO - PROCESS | 13933 | __end_cc_report 09:01:03 INFO - PROCESS | 13933 | __startTimestamp1466006463423__endTimestamp 09:01:03 INFO - PROCESS | 13933 | 09:01:03 INFO - PROCESS | 13933 | ------- Summary: start ------- 09:01:03 INFO - PROCESS | 13933 | Number of tests: 6 09:01:03 INFO - PROCESS | 13933 | 09:01:03 INFO - PROCESS | 13933 | [#0] dojo.html Cycles:165 Average:4721.10 Median:4835.49 stddev:493.85 (10.2%) stddev-sans-first:466.46 09:01:03 INFO - PROCESS | 13933 | Values: 2599.1 2647.4 2661.4 2672.6 2676.8 4586.3 4614.8 4652.5 4716.5 4778.7 4700.9 4722.6 4737.5 4774.6 4781.8 4348.3 4360.1 4445.4 4467.6 4485.4 4163.2 4484.9 4517.0 4520.9 4529.9 4317.2 4333.9 4339.1 4436.2 4500.9 4348.8 4363.1 4370.3 4405.3 4425.3 4366.1 4393.3 4402.1 4414.2 4432.2 4688.8 4760.0 4779.3 4814.4 4835.5 5134.4 5141.8 5148.5 5155.6 5178.3 4971.6 5155.7 5163.0 5174.7 5181.3 4685.9 4707.4 4738.5 4755.9 4756.5 5205.5 5212.7 5224.1 5225.3 5283.1 4923.6 5015.3 5020.3 5025.2 5034.6 5144.3 5167.5 5185.3 5196.1 5223.4 4982.2 5022.0 5037.8 5053.7 5072.3 4952.9 5047.7 5059.1 5068.0 5129.4 4348.8 4363.7 4377.3 4388.6 4407.2 3804.5 3811.9 3816.8 3857.1 3857.9 4266.2 4373.6 4424.4 4446.7 4475.6 5123.5 5163.4 5173.8 5185.4 5224.6 4369.7 4423.7 4432.2 4456.8 4461.1 4477.7 4611.3 4646.0 4646.3 4646.7 4804.2 4826.6 4834.3 4864.4 4864.7 5118.5 5143.5 5159.6 5174.2 5175.3 4702.4 4714.2 4744.1 4744.4 4871.2 4968.0 4971.5 4978.7 4978.8 5084.9 5096.9 5099.5 5099.7 5107.7 5150.9 4798.9 4849.2 4941.0 4973.8 5004.3 4902.6 4926.8 4939.6 4970.9 4974.6 4855.1 4896.9 4909.7 4910.6 4965.3 4913.5 4980.9 5020.6 5029.6 5079.9 4935.8 4945.7 4979.4 4979.4 5022.9 09:01:03 INFO - PROCESS | 13933 | 09:01:03 INFO - PROCESS | 13933 | [#1] ext.html Cycles:180 Average:38478.82 Median:32949.75 stddev:65316.90 (198.2%) stddev-sans-first:65438.05 09:01:03 INFO - PROCESS | 13933 | Values: 552.3 566.0 580.9 601.4 619.6 35042.1 38629.2 38631.6 38698.2 38720.2 32688.7 32864.3 32990.0 33028.3 33143.3 7813.3 7873.9 7906.3 7923.0 7941.6 7814.2 7816.5 7869.3 7895.0 7895.2 7762.3 7819.6 7875.6 7889.5 7933.2 7855.3 7873.0 7895.7 7906.1 7913.0 7694.5 7823.1 7823.9 7835.7 7861.7 37147.8 37374.0 37435.3 37486.1 37524.2 2652.9 2923.0 2965.0 3145.7 3164.5 27363.6 27878.7 28287.3 28366.9 28779.9 3134.8 3185.3 3190.1 3204.3 3206.7 205948.0 206856.0 207138.0 207873.0 207994.0 31695.7 32024.8 32025.0 32043.7 32066.4 29159.3 29469.0 29526.1 29532.7 29553.6 13412.8 13415.6 13437.5 13466.7 13483.7 10901.6 10986.0 10997.5 11004.1 11030.2 18308.6 18333.6 18355.8 18359.5 18396.4 6749.2 6811.3 6960.0 7011.6 7075.9 793.6 912.3 924.6 961.9 991.0 27742.6 27972.0 28190.9 28378.7 28689.4 899.6 922.5 937.4 967.8 977.4 14407.1 14822.4 15018.9 15031.3 15095.2 114847.4 116587.4 117135.4 117393.0 365358.0 48652.8 49451.3 49479.0 49527.3 49631.5 1174.8 1201.5 1202.9 1221.8 1223.7 24869.3 25916.2 26174.2 26209.2 26491.1 42544.6 43235.6 43428.0 43479.6 43528.0 318905.0 322125.0 322966.0 323415.0 325882.0 24741.9 25157.9 25331.6 25649.9 25845.2 40991.6 41282.4 41315.6 41699.8 42306.6 35752.8 35918.6 36014.6 36184.3 36198.1 35205.8 35399.5 35489.5 35549.8 35756.0 34585.7 34969.1 35253.8 35512.8 35538.8 30955.2 32265.0 32307.7 32867.0 32909.5 24844.5 24897.1 25039.1 25387.0 25486.2 09:01:03 INFO - PROCESS | 13933 | 09:01:03 INFO - PROCESS | 13933 | [#2] jquery.html Cycles:180 Average:23840.59 Median:5305.99 stddev:64168.10 (1209.4%) stddev-sans-first:64323.89 09:01:03 INFO - PROCESS | 13933 | Values: 357.2 360.0 366.2 371.1 374.2 15436.7 16777.2 17204.4 17776.6 17796.8 16117.8 16538.8 17269.4 17309.9 17328.2 5011.7 5212.1 5237.6 5239.5 5248.3 3679.7 4901.5 5795.8 6127.3 6131.2 6097.5 6128.4 6135.4 6153.2 6163.1 5041.4 5342.0 5344.5 5349.0 5415.5 5103.3 5171.8 5214.9 5245.3 5270.0 18649.8 19947.4 19947.8 20105.0 20261.0 1856.2 2014.4 2179.2 2227.9 2371.2 8278.3 8427.6 8849.5 8975.5 9040.1 1621.7 1677.5 1707.2 1738.5 1805.9 64472.7 65080.3 67890.0 68564.7 68673.0 8105.0 8596.0 8765.7 8816.8 9004.8 11139.1 11217.6 11252.7 11293.7 11348.2 6633.0 6679.1 6689.1 6765.9 6774.5 6684.3 6810.8 6818.5 6947.1 6983.6 3581.0 3623.2 3678.0 3678.2 3717.7 1626.7 1650.3 1701.7 1730.4 1790.2 832.6 847.3 856.7 871.8 922.4 16415.4 16704.6 16791.2 16829.2 16894.8 840.3 844.1 866.6 867.1 868.7 8927.0 9483.8 9489.5 9495.5 9611.0 380850.0 385536.0 389945.0 391443.0 392876.0 78524.0 78563.0 79055.6 79190.6 79371.2 821.6 825.0 829.9 833.2 835.6 14642.6 15012.2 15047.3 15084.5 15384.0 29125.0 35261.0 35785.3 36116.5 37818.6 49311.5 50725.5 51226.7 51581.0 51649.7 7370.1 7417.0 7448.9 7538.6 7558.6 10413.2 10686.6 10973.4 11584.0 11719.4 9260.7 9268.4 9531.3 9535.8 9720.3 9736.6 9768.9 9977.9 10140.2 10281.5 5009.8 5605.7 9677.3 9812.9 9853.4 7299.5 7440.4 7460.8 7545.0 7569.7 7222.8 8337.5 9232.2 9253.0 9915.3 09:01:03 INFO - PROCESS | 13933 | 09:01:03 INFO - PROCESS | 13933 | [#3] mootools.html Cycles:180 Average:4907.74 Median:4763.86 stddev:2728.64 (57.3%) stddev-sans-first:2722.96 09:01:03 INFO - PROCESS | 13933 | Values: 1318.7 1367.4 1416.9 1631.9 1643.7 6598.1 7169.3 7243.9 7732.5 7762.1 7329.2 7526.9 7549.9 7575.2 7575.8 2123.9 2170.2 2171.0 2179.2 2186.4 2090.9 2093.9 2153.1 2154.6 2160.4 2087.4 2093.9 2097.9 2098.3 2151.8 2094.3 2096.7 2096.8 2103.5 2104.6 2141.5 2144.1 2157.3 2178.1 2181.7 7483.9 7572.7 7577.5 7614.0 7655.4 4404.3 4448.0 4511.8 4516.6 4520.3 2839.0 2880.5 2894.3 2897.2 2900.1 879.2 905.3 914.7 922.8 940.5 10145.2 10185.7 10196.4 10201.6 10201.8 4021.6 4078.6 4127.8 4152.3 4161.2 8742.0 8776.4 8777.6 8796.0 8800.3 4491.9 4516.8 4553.8 4569.0 4571.6 3599.8 3945.1 4093.0 4133.8 4154.6 3537.1 3567.8 3670.5 3670.8 3688.4 1172.0 1174.4 1187.3 1198.8 1210.3 745.0 795.2 804.6 814.0 835.3 4658.7 4676.8 4801.8 4825.0 4867.4 864.7 869.5 873.2 902.1 907.8 3282.2 3322.2 3366.7 3378.3 3395.6 8979.9 9239.7 9241.6 9283.4 9298.3 9067.3 9102.8 9117.9 9125.2 9173.0 7024.5 7106.7 7124.0 7202.7 7211.5 4706.2 4706.3 4724.2 4736.7 4791.0 8219.0 8357.5 8529.1 8577.5 8608.8 8517.1 8534.8 8609.6 8634.3 8710.1 5484.6 5830.2 6029.7 6077.1 6238.5 7196.3 7216.8 7247.1 7285.4 7288.2 6085.9 6330.8 6375.6 6381.3 6387.1 6219.1 6329.2 6432.5 6468.6 6523.7 5985.1 6049.8 6082.1 6092.6 6148.5 4170.1 4241.6 4254.4 4329.5 4370.7 4018.4 4115.3 4157.0 4272.0 4329.7 09:01:03 INFO - PROCESS | 13933 | 09:01:03 INFO - PROCESS | 13933 | [#4] prototype.html Cycles:180 Average:4394.72 Median:5015.84 stddev:1285.85 (25.6%) stddev-sans-first:1251.79 09:01:03 INFO - PROCESS | 13933 | Values: 278.5 282.2 290.5 293.5 295.2 4924.0 5026.8 5040.7 5047.9 5074.9 4992.8 4993.0 4997.6 5011.6 5020.1 3710.7 3851.7 3937.6 3943.0 3944.4 3949.7 3951.4 3963.5 3964.6 3967.7 3854.0 3856.6 3904.2 3907.4 3930.3 3781.3 3921.4 3937.7 3949.3 3963.1 3402.7 3413.8 3418.2 3422.9 3424.6 4897.9 4901.8 4917.7 4942.7 4954.7 4454.6 4460.7 4480.7 4495.4 4512.4 5082.5 5265.7 5266.3 5276.6 5283.7 3736.6 3742.8 3747.7 3757.9 3772.2 5494.1 5499.5 5510.5 5511.0 5526.7 3742.3 3765.8 3840.4 3846.6 3856.2 3859.4 3877.0 3877.1 3889.7 3900.0 4467.1 4485.8 4498.5 4500.3 4521.5 4971.4 5303.0 5340.3 5344.8 5367.7 1345.2 1355.6 1356.2 1357.5 1360.2 841.5 856.9 866.1 879.8 883.5 4454.1 4609.8 4636.4 4640.2 4652.8 5488.5 5495.0 5496.3 5502.3 5507.9 4507.3 4657.8 4667.7 4699.8 4701.5 2936.3 2937.3 2937.5 2941.4 2944.7 5122.2 5138.3 5141.5 5145.3 5168.7 5430.0 5606.8 5629.4 5633.0 5664.7 5065.0 5124.2 5129.9 5135.6 5150.2 5425.5 5448.8 5475.9 5480.6 5486.7 5176.7 5390.9 5416.3 5417.6 5434.2 5081.5 5139.9 5143.2 5171.5 5179.1 3920.7 3921.8 3922.8 3924.9 3946.7 5148.7 5478.0 5490.8 5497.5 5540.6 5274.6 5276.4 5289.3 5301.2 5302.6 5175.8 5273.5 5292.5 5304.7 5379.6 5215.9 5235.8 5266.4 5267.9 5294.2 5097.2 5224.3 5404.6 5406.5 5406.7 5238.2 5248.6 5250.3 5281.1 5290.2 09:01:03 INFO - PROCESS | 13933 | 09:01:03 INFO - PROCESS | 13933 | [#5] yui.html Cycles:180 Average:17562.12 Median:43771.02 stddev:24096.26 (55.1%) stddev-sans-first:24130.31 09:01:03 INFO - PROCESS | 13933 | Values: 627.7 657.4 668.5 703.4 709.6 12627.6 12711.4 12863.1 12937.9 13030.1 12648.9 12959.9 12961.4 12999.6 13000.2 773.5 783.1 786.4 787.6 788.3 619.8 760.1 791.6 793.2 797.9 827.3 831.8 831.9 838.5 838.5 828.9 829.3 831.4 833.7 835.3 610.1 610.6 610.8 611.1 614.5 13288.0 13368.2 13412.2 13416.5 13446.6 13211.9 13285.3 13478.6 13575.7 13851.0 10524.2 10602.8 10604.7 10675.2 10836.9 3366.8 3382.5 3430.2 3431.0 3492.5 60958.0 61041.7 61920.4 62181.7 62548.7 10455.5 10587.8 10623.5 10714.7 10841.3 20420.5 20512.2 20513.0 20636.1 20876.8 7071.5 7117.8 7190.4 7244.2 7394.2 3690.3 3760.4 3781.2 3799.4 3870.9 2949.2 3065.4 3082.6 3083.2 3085.5 538.8 565.7 571.1 577.4 580.6 474.4 520.4 548.4 602.9 633.2 8118.2 8155.5 8215.5 8255.8 8312.2 535.0 574.3 627.4 628.9 632.8 3893.4 3895.0 3975.7 3977.1 4077.6 55264.2 73520.0 75584.2 76542.0 89894.6 83659.6 86519.0 87693.0 88317.0 88566.6 76071.2 76649.0 78381.6 78414.0 78692.2 8944.8 9013.6 9055.2 9186.1 9194.9 42559.8 43575.5 43966.6 44414.8 45974.9 56948.4 67140.7 67922.7 68096.7 68360.0 9214.1 10351.9 10938.2 10984.9 11410.1 12176.8 12519.2 12848.8 13005.9 13511.9 12073.6 12433.9 12446.3 13119.0 13185.9 12484.9 12652.8 13165.9 13398.9 13409.1 11817.4 11960.0 12162.5 12433.3 12632.6 10193.9 10554.7 10589.3 10622.5 11072.4 10494.2 10614.8 10688.9 10740.2 10790.7 09:01:03 INFO - PROCESS | 13933 | -------- Summary: end -------- 09:01:03 INFO - PROCESS | 13933 | 09:01:04 INFO - TEST-INFO | 13933: exit 0 09:01:04 INFO - TEST-OK | dromaeo_css | took 1116355ms 09:01:04 INFO - TEST-START | kraken 09:01:04 INFO - operating with platform_type : linux_ 09:01:04 INFO - Initialising browser for kraken test... 09:01:04 INFO - TEST-INFO | started process 14170 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxEfHd6/profile http://localhost:59033/getInfo.html) 09:01:08 INFO - PROCESS | 14170 | __metrics Screen width/height:1600/1200 09:01:08 INFO - PROCESS | 14170 | colorDepth:24 09:01:08 INFO - PROCESS | 14170 | Browser inner width/height: 1024/697 09:01:08 INFO - PROCESS | 14170 | __metrics 09:01:09 ERROR - PROCESS | 14170 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 09:01:10 INFO - TEST-INFO | 14170: exit 0 09:01:10 INFO - Browser initialized. 09:01:10 INFO - Running cycle 1/1 for kraken test... 09:01:10 INFO - TEST-INFO | started process 14288 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxEfHd6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:01:22 INFO - PROCESS | 14288 | RSS: Main: 185921536 09:01:22 INFO - PROCESS | 14288 | 09:01:25 INFO - PROCESS | 14288 | Cycle 1(1): loaded http://localhost:59033/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59033/tests/kraken/driver.html?testName=audio-beat-detection) 09:01:26 INFO - PROCESS | 14288 | RSS: Main: 190631936 09:01:26 INFO - PROCESS | 14288 | 09:01:28 INFO - PROCESS | 14288 | Cycle 1(1): loaded http://localhost:59033/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59033/tests/kraken/driver.html?testName=audio-dft) 09:01:29 INFO - PROCESS | 14288 | RSS: Main: 190205952 09:01:29 INFO - PROCESS | 14288 | 09:01:32 INFO - PROCESS | 14288 | Cycle 1(1): loaded http://localhost:59033/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59033/tests/kraken/driver.html?testName=audio-fft) 09:01:33 INFO - PROCESS | 14288 | RSS: Main: 185856000 09:01:33 INFO - PROCESS | 14288 | 09:01:35 INFO - PROCESS | 14288 | Cycle 1(1): loaded http://localhost:59033/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59033/tests/kraken/driver.html?testName=audio-oscillator) 09:01:36 INFO - PROCESS | 14288 | RSS: Main: 186576896 09:01:36 INFO - PROCESS | 14288 | 09:01:38 INFO - PROCESS | 14288 | Cycle 1(1): loaded http://localhost:59033/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59033/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:01:38 INFO - PROCESS | 14288 | RSS: Main: 187047936 09:01:38 INFO - PROCESS | 14288 | 09:01:42 INFO - PROCESS | 14288 | Cycle 1(1): loaded http://localhost:59033/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59033/tests/kraken/driver.html?testName=imaging-darkroom) 09:01:42 INFO - PROCESS | 14288 | RSS: Main: 187199488 09:01:42 INFO - PROCESS | 14288 | 09:01:46 INFO - PROCESS | 14288 | Cycle 1(1): loaded http://localhost:59033/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59033/tests/kraken/driver.html?testName=imaging-desaturate) 09:01:46 INFO - PROCESS | 14288 | RSS: Main: 184315904 09:01:46 INFO - PROCESS | 14288 | 09:01:49 INFO - PROCESS | 14288 | Cycle 1(1): loaded http://localhost:59033/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59033/tests/kraken/driver.html?testName=json-parse-financial) 09:01:50 INFO - PROCESS | 14288 | RSS: Main: 185679872 09:01:50 INFO - PROCESS | 14288 | 09:01:52 INFO - PROCESS | 14288 | Cycle 1(1): loaded http://localhost:59033/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59033/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:01:52 INFO - PROCESS | 14288 | RSS: Main: 186155008 09:01:52 INFO - PROCESS | 14288 | 09:01:54 INFO - PROCESS | 14288 | Cycle 1(1): loaded http://localhost:59033/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59033/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:01:55 INFO - PROCESS | 14288 | RSS: Main: 186421248 09:01:55 INFO - PROCESS | 14288 | 09:01:57 INFO - PROCESS | 14288 | Cycle 1(1): loaded http://localhost:59033/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59033/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:01:58 INFO - PROCESS | 14288 | RSS: Main: 186650624 09:01:58 INFO - PROCESS | 14288 | 09:02:01 INFO - PROCESS | 14288 | Cycle 1(1): loaded http://localhost:59033/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59033/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:02:01 INFO - PROCESS | 14288 | RSS: Main: 186679296 09:02:01 INFO - PROCESS | 14288 | 09:02:04 INFO - PROCESS | 14288 | Cycle 1(1): loaded http://localhost:59033/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59033/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:02:05 INFO - PROCESS | 14288 | RSS: Main: 186798080 09:02:05 INFO - PROCESS | 14288 | 09:02:07 INFO - PROCESS | 14288 | Cycle 1(1): loaded http://localhost:59033/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59033/tests/kraken/driver.html?testName=ai-astar) 09:02:07 INFO - PROCESS | 14288 | RSS: Main: 188264448 09:02:07 INFO - PROCESS | 14288 | 09:02:07 INFO - PROCESS | 14288 | __start_tp_report 09:02:07 INFO - PROCESS | 14288 | _x_x_mozilla_page_load 09:02:07 INFO - PROCESS | 14288 | _x_x_mozilla_page_load_details 09:02:07 INFO - PROCESS | 14288 | |i|pagename|runs| 09:02:07 INFO - PROCESS | 14288 | |0;ai-astar;116;110;114;113;116;116;114;114;113;113 09:02:07 INFO - PROCESS | 14288 | |1;audio-beat-detection;172;134;155;197;134;162;155;140;188;133 09:02:07 INFO - PROCESS | 14288 | |2;audio-dft;166;166;170;163;163;165;164;165;164;163 09:02:07 INFO - PROCESS | 14288 | |3;audio-fft;78;77;75;168;78;75;77;77;175;78 09:02:07 INFO - PROCESS | 14288 | |4;audio-oscillator;86;87;161;88;87;86;138;88;87;135 09:02:07 INFO - PROCESS | 14288 | |5;imaging-gaussian-blur;117;117;118;117;118;118;119;121;117;117 09:02:07 INFO - PROCESS | 14288 | |6;imaging-darkroom;148;149;149;148;151;150;149;149;148;148 09:02:07 INFO - PROCESS | 14288 | |7;imaging-desaturate;97;96;96;96;95;95;95;96;96;95 09:02:07 INFO - PROCESS | 14288 | |8;json-parse-financial;64;64;66;62;63;63;64;64;64;63 09:02:07 INFO - PROCESS | 14288 | |9;json-stringify-tinderbox;65;65;66;66;65;66;65;64;67;65 09:02:07 INFO - PROCESS | 14288 | |10;stanford-crypto-aes;84;85;87;86;85;85;85;84;119;86 09:02:07 INFO - PROCESS | 14288 | |11;stanford-crypto-ccm;141;140;133;133;142;132;133;144;155;147 09:02:07 INFO - PROCESS | 14288 | |12;stanford-crypto-pbkdf2;170;171;168;166;169;175;176;168;168;167 09:02:07 INFO - PROCESS | 14288 | |13;stanford-crypto-sha256-iterative;70;68;68;69;69;69;66;68;77;67 09:02:07 INFO - PROCESS | 14288 | __end_tp_report 09:02:07 INFO - PROCESS | 14288 | __start_cc_report 09:02:07 INFO - PROCESS | 14288 | _x_x_mozilla_cycle_collect,1008 09:02:07 INFO - PROCESS | 14288 | __end_cc_report 09:02:07 INFO - PROCESS | 14288 | __startTimestamp1466006527332__endTimestamp 09:02:07 INFO - PROCESS | 14288 | 09:02:07 INFO - PROCESS | 14288 | ------- Summary: start ------- 09:02:07 INFO - PROCESS | 14288 | Number of tests: 14 09:02:07 INFO - PROCESS | 14288 | 09:02:07 INFO - PROCESS | 14288 | [#0] ai-astar Cycles:10 Average:113.90 Median:114.00 stddev:1.85 (1.6%) stddev-sans-first:1.80 09:02:07 INFO - PROCESS | 14288 | Values: 116.0 110.0 114.0 113.0 116.0 116.0 114.0 114.0 113.0 113.0 09:02:07 INFO - PROCESS | 14288 | 09:02:07 INFO - PROCESS | 14288 | [#1] audio-beat-detection Cycles:10 Average:157.00 Median:158.50 stddev:22.95 (14.5%) stddev-sans-first:23.70 09:02:07 INFO - PROCESS | 14288 | Values: 172.0 134.0 155.0 197.0 134.0 162.0 155.0 140.0 188.0 133.0 09:02:07 INFO - PROCESS | 14288 | 09:02:07 INFO - PROCESS | 14288 | [#2] audio-dft Cycles:10 Average:164.90 Median:165.00 stddev:2.13 (1.3%) stddev-sans-first:2.22 09:02:07 INFO - PROCESS | 14288 | Values: 166.0 166.0 170.0 163.0 163.0 165.0 164.0 165.0 164.0 163.0 09:02:07 INFO - PROCESS | 14288 | 09:02:07 INFO - PROCESS | 14288 | [#3] audio-fft Cycles:10 Average:95.80 Median:77.00 stddev:39.95 (51.9%) stddev-sans-first:41.85 09:02:07 INFO - PROCESS | 14288 | Values: 78.0 77.0 75.0 168.0 78.0 75.0 77.0 77.0 175.0 78.0 09:02:07 INFO - PROCESS | 14288 | 09:02:07 INFO - PROCESS | 14288 | [#4] audio-oscillator Cycles:10 Average:104.30 Median:87.00 stddev:28.66 (32.9%) stddev-sans-first:29.62 09:02:07 INFO - PROCESS | 14288 | Values: 86.0 87.0 161.0 88.0 87.0 86.0 138.0 88.0 87.0 135.0 09:02:07 INFO - PROCESS | 14288 | 09:02:07 INFO - PROCESS | 14288 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:1.29 (1.1%) stddev-sans-first:1.32 09:02:07 INFO - PROCESS | 14288 | Values: 117.0 117.0 118.0 117.0 118.0 118.0 119.0 121.0 117.0 117.0 09:02:07 INFO - PROCESS | 14288 | 09:02:07 INFO - PROCESS | 14288 | [#6] imaging-darkroom Cycles:10 Average:148.90 Median:149.00 stddev:0.99 (0.7%) stddev-sans-first:1.00 09:02:07 INFO - PROCESS | 14288 | Values: 148.0 149.0 149.0 148.0 151.0 150.0 149.0 149.0 148.0 148.0 09:02:07 INFO - PROCESS | 14288 | 09:02:07 INFO - PROCESS | 14288 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.53 09:02:07 INFO - PROCESS | 14288 | Values: 97.0 96.0 96.0 96.0 95.0 95.0 95.0 96.0 96.0 95.0 09:02:07 INFO - PROCESS | 14288 | 09:02:07 INFO - PROCESS | 14288 | [#8] json-parse-financial Cycles:10 Average:63.70 Median:64.00 stddev:1.06 (1.7%) stddev-sans-first:1.12 09:02:07 INFO - PROCESS | 14288 | Values: 64.0 64.0 66.0 62.0 63.0 63.0 64.0 64.0 64.0 63.0 09:02:07 INFO - PROCESS | 14288 | 09:02:07 INFO - PROCESS | 14288 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.50 stddev:0.84 (1.3%) stddev-sans-first:0.88 09:02:07 INFO - PROCESS | 14288 | Values: 65.0 65.0 66.0 66.0 65.0 66.0 65.0 64.0 67.0 65.0 09:02:07 INFO - PROCESS | 14288 | 09:02:07 INFO - PROCESS | 14288 | [#10] stanford-crypto-aes Cycles:10 Average:88.60 Median:85.00 stddev:10.72 (12.6%) stddev-sans-first:11.24 09:02:07 INFO - PROCESS | 14288 | Values: 84.0 85.0 87.0 86.0 85.0 85.0 85.0 84.0 119.0 86.0 09:02:07 INFO - PROCESS | 14288 | 09:02:07 INFO - PROCESS | 14288 | [#11] stanford-crypto-ccm Cycles:10 Average:140.00 Median:141.50 stddev:7.50 (5.3%) stddev-sans-first:7.94 09:02:07 INFO - PROCESS | 14288 | Values: 141.0 140.0 133.0 133.0 142.0 132.0 133.0 144.0 155.0 147.0 09:02:07 INFO - PROCESS | 14288 | 09:02:07 INFO - PROCESS | 14288 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.80 Median:169.50 stddev:3.33 (2.0%) stddev-sans-first:3.53 09:02:07 INFO - PROCESS | 14288 | Values: 170.0 171.0 168.0 166.0 169.0 175.0 176.0 168.0 168.0 167.0 09:02:07 INFO - PROCESS | 14288 | 09:02:07 INFO - PROCESS | 14288 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.00 stddev:3.00 (4.3%) stddev-sans-first:3.16 09:02:07 INFO - PROCESS | 14288 | Values: 70.0 68.0 68.0 69.0 69.0 69.0 66.0 68.0 77.0 67.0 09:02:07 INFO - PROCESS | 14288 | -------- Summary: end -------- 09:02:07 INFO - PROCESS | 14288 | 09:02:08 INFO - TEST-INFO | 14288: exit 0 09:02:08 INFO - TEST-OK | kraken | took 64246ms 09:02:08 INFO - SUITE-END | took 1180s 09:02:08 INFO - Completed test suite (00:19:40) 09:02:08 INFO - javascript benchmark 09:02:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6318.576323198936, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2599.064336838738, 2647.3778662014424, 2661.4277930244994, 2672.625832383467, 2676.81262311638, 4586.289125185597, 4614.838480653182, 4652.534746525345, 4716.457607375153, 4778.737169455679, 4700.905981880361, 4722.59857912077, 4737.455192652846, 4774.570288674027, 4781.784819683114, 4348.2825333819965, 4360.10617823347, 4445.444319460067, 4467.620252278561, 4485.3944717463055, 4163.229802486535, 4484.865454036368, 4516.9774151129195, 4520.864374068767, 4529.932051019237, 4317.15815415994, 4333.934990975138, 4339.088791353819, 4436.223660859337, 4500.8649740507835, 4348.760818155, 4363.127374525107, 4370.300751879716, 4405.251107311733, 4425.3140763181755, 4366.104948485553, 4393.340998850166, 4402.097569998175, 4414.161309351245, 4432.22436073689, 4688.812447502096, 4760.024195040043, 4779.307000484945, 4814.422269327668, 4835.492273311287, 5134.358205224347, 5141.794328226866, 5148.459411761786, 5155.5617772489, 5178.326817513736, 4971.6271279654175, 5155.71643559604, 5162.974185129088, 5174.663646862942, 5181.274621552986, 4685.929711054337, 4707.388039554836, 4738.549837765407, 4755.9286610700865, 4756.453007904066, 5205.47945205484, 5212.713300768418, 5224.138017227191, 5225.294585231021, 5283.128283833202, 4923.606111511071, 5015.3229314042865, 5020.347354843847, 5025.195968645073, 5034.622403319766, 5144.30551875492, 5167.509086636764, 5185.325907631984, 5196.090684130262, 5223.373195216598, 4982.153033984231, 5022.0, 5037.823676171316, 5053.69677819332, 5072.340595722532, 4952.900941981212, 5047.722375269322, 5059.089363914531, 5068.011737711185, 5129.435762066169, 4348.804303806336, 4363.716358436755, 4377.299632058855, 4388.605025547716, 4407.206702793528, 3804.505414296124, 3811.8856434307013, 3816.809159542012, 3857.0935830079907, 3857.9035524112123, 4266.232078225887, 4373.606375426227, 4424.424824772824, 4446.73319600825, 4475.552444755564, 5123.538881500683, 5163.380394352702, 5173.767180476888, 5185.377754669464, 5224.582033437316, 4369.71596846204, 4423.734575925455, 4432.202203603318, 4456.844010459683, 4461.13007963444, 4477.731336119843, 4611.331356953223, 4646.047560250141, 4646.303054541846, 4646.7444290564345, 4804.2073057945045, 4826.565609095198, 4834.250691142808, 4864.416270047617, 4864.683795553277, 5118.513741194581, 5143.459936706592, 5159.613029022763, 5174.172132458789, 5175.275461435477, 4702.412198475191, 4714.245720684811, 4744.122337367598, 4744.4069491313585, 4871.2206047032305, 4968.031233909497, 4971.527704868032, 4978.726170060681, 4978.8257410990445, 5084.898302034013, 5096.949030509648, 5099.464556221544, 5099.719515426687, 5107.744612769272, 5150.9227361588855, 4798.880027999328, 4849.151398505177, 4940.975295123501, 4973.801047958186, 5004.3494345734825, 4902.607791376753, 4926.802927882988, 4939.629527785359, 4970.900581988412, 4974.5771609413605, 4855.1260773061185, 4896.877578060577, 4909.729964851967, 4910.582600478856, 4965.280034395065, 4913.459519452929, 4980.8754781130765, 5020.648554601143, 5029.572486338702, 5079.8570321677325, 4935.75321233944, 4945.727984960861, 4979.3526841510375, 4979.427365852974, 5022.874428139326], "value": 4689.572069201182, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.2992029429797, 565.9575531835111, 580.9128630705394, 601.3955974245882, 619.5663035874888, 35042.12394690134, 38629.22741545171, 38631.61368386315, 38698.22603547931, 38720.225595488075, 32688.673113268862, 32864.34271314572, 32990.0, 33028.33943321138, 33143.33713325732, 7813.296803287703, 7873.921260787376, 7906.2884340409355, 7923.0, 7941.642626081812, 7814.218578142197, 7816.452848300622, 7869.331106855924, 7894.960525197366, 7895.24995125465, 7762.340201082915, 7819.609019549028, 7875.606219689022, 7889.5266284022855, 7933.16701746317, 7855.253750893656, 7872.960635196816, 7895.684172633117, 7906.051273847118, 7912.960435197845, 7694.499857509244, 7823.100343460518, 7823.882641760378, 7835.667936450817, 7861.724839630586, 37147.81426092879, 37374.0, 37435.25129497422, 37486.06284842874, 37524.24951500982, 2652.8938842446278, 2922.9853850730824, 2964.9851750741323, 3145.748340132807, 3164.5411415344647, 27363.589546156825, 27878.721212787816, 28287.29281767972, 28366.858165709247, 28779.85610071957, 3134.7805653604255, 3185.267388500658, 3190.0589326148843, 3204.279037216631, 3206.679332066798, 205948.0, 206856.0, 207138.0, 207873.0, 207994.0, 31695.683043169272, 32024.83987580094, 32025.0, 32043.67956320407, 32066.358672826413, 29159.271018224288, 29469.0, 29526.114216573107, 29532.704672953427, 29553.556696649568, 13412.798808017887, 13415.597532074053, 13437.462501500026, 13466.730665386833, 13483.730325393633, 10901.618443354444, 10986.0, 10997.450127493594, 11004.064654504456, 11030.2278840482, 18308.633827323378, 18333.63332733338, 18355.81644183541, 18359.541011474554, 18396.356127535473, 6749.156355455568, 6811.318868113248, 6959.965200173967, 7011.649417529103, 7075.858482830417, 793.5833687314091, 912.2565109435789, 924.5608336040461, 961.9422834629804, 990.9891910251503, 27742.583861242096, 27972.0, 28190.85904570505, 28378.716212837608, 28689.426211475653, 899.572702966099, 922.5295099499303, 937.376644531379, 967.8209531236744, 977.3647129365969, 14407.135571865721, 14822.40710371573, 15018.924905375403, 15031.323590438456, 15095.169765662993, 114847.42576287065, 116587.41706291414, 117135.41432292784, 117393.0, 365358.0, 48652.75673621609, 49451.258231126565, 49479.0, 49527.25709114366, 49631.50368496341, 1174.8179032250016, 1201.4773573495556, 1202.8736982616874, 1221.8167274908835, 1223.663492539541, 24869.25392238236, 25916.222513323875, 26174.214773556825, 26209.213723588324, 26491.08598054174, 42544.57455425406, 43235.567644324416, 43428.0, 43479.56520434755, 43528.0, 318905.0, 322125.0, 322966.0, 323415.0, 325882.0, 24741.87629061843, 25157.87421062883, 25331.6200257, 25649.871750641127, 25845.22464326073, 40991.590084098774, 41282.38076428796, 41315.586844131176, 41699.7915010423, 42306.576934231496, 35752.82123589365, 35918.640813591526, 36014.63985360217, 36184.27631447409, 36198.09504762402, 35205.82397087998, 35399.469007964384, 35489.467657984635, 35549.82225088858, 35756.0, 34585.65414345925, 34969.125771855906, 35253.823730882206, 35512.82243588869, 35538.82230588831, 30955.226119347197, 32265.0, 32307.676923231407, 32867.0, 32909.50635740418, 24844.50310993806, 24897.128600498894, 25039.12363067284, 25387.0, 25486.23541293764], "value": 16258.914816428143, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.2390807579855, 359.9712023038157, 366.2071614953625, 371.1352548561851, 374.2122831439819, 15436.69126617467, 16777.24502397392, 17204.397846075375, 17776.555586110353, 17796.822031779677, 16117.758233626475, 16538.7519187212, 17269.39557115501, 17309.913450432763, 17328.220230089646, 5011.749412529368, 5212.087884620195, 5237.580993520528, 5239.502247286502, 5248.343957005374, 3679.742418030739, 4901.509849015106, 5795.768169273224, 6127.264728232596, 6131.202943617323, 6097.512199024068, 6128.356522565134, 6135.3557876423, 6153.230846144232, 6163.106349579309, 5041.445441001487, 5341.973290133525, 5344.4922732340365, 5349.0, 5415.512603865632, 5103.260027296058, 5171.793128274864, 5214.947850521484, 5245.26566280721, 5270.0, 18649.813501864945, 19947.40157795254, 19947.80052199474, 20105.0, 20261.0, 1856.1925562380409, 2014.4460273424925, 2179.2372669565684, 2227.8774667393286, 2371.1819422299277, 8278.254957053894, 8427.620757065946, 8849.513276769776, 8975.461472311683, 9040.095990400972, 1621.6675581505763, 1677.4715964471152, 1707.197617119964, 1738.5132162994382, 1805.900675462849, 64472.677636611515, 65080.3491965079, 67890.0, 68564.6571767143, 68672.9999999995, 8104.959475202586, 8596.0, 8765.737027889174, 8816.77958051041, 9004.81990360189, 11139.108871290277, 11217.55129794799, 11252.718682032852, 11293.661190164308, 11348.205625606293, 6632.966835165793, 6679.064930909676, 6689.063531105649, 6765.932340676629, 6774.525783195228, 6684.2647308795995, 6810.829729256809, 6818.4886133540185, 6947.096877405905, 6983.580985140908, 3580.979420865041, 3623.239119784822, 3677.9816100919325, 3678.1540245743095, 3717.739758216953, 1626.6584017356488, 1650.290375138678, 1701.6936951348875, 1730.411660035594, 1790.1944125143737, 832.5629044751554, 847.326375531454, 856.7301300090452, 871.7907702151565, 922.372786505183, 16415.42546010884, 16704.582385440463, 16791.2443940023, 16829.242684079247, 16894.831051689573, 840.2689659995721, 844.0668676349636, 866.6403442571388, 867.1328671328671, 868.6916144768643, 8927.018028016913, 9483.762905927408, 9489.478078705737, 9495.477748723748, 9610.990845961074, 380850.0, 385536.0, 389945.0, 391443.0, 392876.0, 78524.0, 78563.0, 79055.60472197717, 79190.60404698054, 79371.20628793638, 821.6097353757037, 824.9628766705513, 829.9087100418828, 833.1668331668332, 835.6337388370059, 14642.560723178321, 15012.24938753036, 15047.322870471075, 15084.472043478425, 15384.000039997365, 29125.0, 35261.0, 35785.284294314486, 36116.45825312675, 37818.62181378151, 49311.50688493069, 50725.492745073556, 51226.74386628192, 51581.0, 51649.741751291, 7370.078740157481, 7417.0, 7448.851022979618, 7538.585377804054, 7558.622068896423, 10413.166946644098, 10686.57253709843, 10973.3964631946, 11584.0, 11719.355435451133, 9260.675876344296, 9268.443893366419, 9531.285153613368, 9535.761605959906, 9720.319577629782, 9736.610535578497, 9768.902310976799, 9977.900220997697, 10140.188784897338, 10281.485925703835, 5009.799608015638, 5605.691686957257, 9677.274204434836, 9812.901870981199, 9853.408795472295, 7299.489035767445, 7440.441966852616, 7460.813479662835, 7545.0, 7569.6593653284635, 7222.783316500513, 8337.499750015018, 9232.169104780602, 9252.95373523128, 9915.256355773201], "value": 7878.64528364349, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1318.657149141223, 1367.384676895397, 1416.914985100894, 1631.8857679962407, 1643.7205675035243, 6598.10925525054, 7169.318914703095, 7243.927560724391, 7732.45872788905, 7762.068551773788, 7329.230430804755, 7526.924730752691, 7549.886751698729, 7575.166731659527, 7575.772726818191, 2123.925662601809, 2170.1861801824316, 2171.0338899189865, 2179.1501314487364, 2186.3768825884626, 2090.9059092340804, 2093.86389884657, 2153.074178103415, 2154.63371226891, 2160.4490854832075, 2087.425957861585, 2093.9267125650604, 2097.8741275523516, 2098.2970704813906, 2151.752548456924, 2094.3193462124796, 2096.6540520814046, 2096.790320967906, 2103.5161912760072, 2104.6106470303043, 2141.539568992674, 2144.1316266911927, 2157.33122731952, 2178.1287485005964, 2181.7054697615936, 7483.8503229935095, 7572.734954276629, 7577.469577129603, 7613.972113764682, 7655.387568994467, 4404.2512772828695, 4447.977760111211, 4511.819527218908, 4516.616087632555, 4520.254158063915, 2839.0, 2880.5391137417914, 2894.305366711995, 2897.203269101014, 2900.129961011709, 879.2087121590556, 905.2712566384058, 914.6524320758069, 922.7693076730817, 940.4921342475055, 10145.188384929188, 10185.694429167062, 10196.439195844225, 10201.642942496977, 10201.846972295421, 4021.557628660845, 4078.6125318094732, 4127.7936103194725, 4152.294110001307, 4161.209370219649, 8742.038375778659, 8776.429532080521, 8777.605007774666, 8795.956020219857, 8800.251978581764, 4491.932621010687, 4516.751578663139, 4553.772311384418, 4568.954310456919, 4571.588557029883, 3599.802010889374, 3945.11234972129, 4093.0176757577965, 4133.772642504691, 4154.584541545822, 3537.0803591066506, 3567.7502574820032, 3670.522832031819, 3670.7614005089586, 3688.39141541648, 1172.0017370383646, 1174.4186627619213, 1187.3350923482876, 1198.8381568488317, 1210.2738356985737, 744.9813754656177, 795.1809636074852, 804.5735760047185, 814.0150417994294, 835.2566216067584, 4658.650601204923, 4676.836310729108, 4801.831935882227, 4825.034993001414, 4867.3915760529935, 864.7146441674232, 869.4609342207872, 873.157403105993, 902.1294450854956, 907.8275127725711, 3282.163048422637, 3322.235885746292, 3366.7474939379645, 3378.3243351329343, 3395.609504906918, 8979.910200898039, 9239.72280831576, 9241.630334786532, 9283.39657922233, 9298.302627302979, 9067.319951003701, 9102.772430689154, 9117.863232051524, 9125.17873391398, 9173.03683113277, 7024.473164512682, 7106.680199391039, 7123.964380178066, 7202.747903823446, 7211.531250468703, 4706.1528924793865, 4706.294055891643, 4724.220503617003, 4736.715797052188, 4791.0, 8219.0, 8357.540335281617, 8529.061803201766, 8577.528235947082, 8608.827823443622, 8517.105703901001, 8534.82930341402, 8609.569521523774, 8634.30925525969, 8710.085441028601, 5484.561235101102, 5830.154627578892, 6029.728662210124, 6077.149199112039, 6238.500919926304, 7196.280371962762, 7216.819579510554, 7247.1303443585, 7285.380742636723, 7288.234735352924, 6085.908711369421, 6330.841728956813, 6375.6493392861985, 6381.329960354282, 6387.073874288109, 6219.0982307566055, 6329.208848893888, 6432.517561183024, 6468.579542329921, 6523.739050438119, 5985.132155837292, 6049.848753781014, 6082.087686847009, 6092.573519853568, 6148.508119350352, 4170.103427763045, 4241.554636763095, 4254.383114448449, 4329.502107257706, 4370.694051416371, 4018.437418761317, 4115.279826030493, 4157.0, 4271.996080920919, 4329.675274354373], "value": 3981.6606334851535, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [278.45006112926967, 282.2435871863407, 290.5380445092304, 293.5069083938984, 295.1955920117678, 4923.956558028419, 5026.849194524161, 5040.697558146514, 5047.949520504799, 5074.949250507499, 4992.75036248187, 4992.950070499294, 4997.60067181189, 5011.574016208618, 5020.0963826511215, 3710.666040056394, 3851.73037887348, 3937.566867644564, 3943.0, 3944.4280579315982, 3949.6642785363133, 3951.3677811550156, 3963.524377074755, 3964.6431821136093, 3967.682585393162, 3854.0, 3856.573067964857, 3904.1606054698236, 3907.413887916821, 3930.2532518821477, 3781.300459415017, 3921.431392448079, 3937.6652984496354, 3949.308870947587, 3963.1479231965122, 3402.6767457091537, 3413.7951722896705, 3418.1967237699123, 3422.8973130806116, 3424.6404127566498, 4897.877553061202, 4901.779419926112, 4917.72952487613, 4942.690187100386, 4954.727489988085, 4454.621357184643, 4460.7323560586465, 4480.708753931017, 4495.43807024122, 4512.3682684423875, 5082.4663410341755, 5265.6840589564745, 5266.262723218752, 5276.551493123089, 5283.735813209362, 3736.57029441615, 3742.8128593570214, 3747.662710356081, 3757.906052348686, 3772.2078363543687, 5494.148406996922, 5499.50504454601, 5510.476504732044, 5511.035568775448, 5526.723663816793, 3742.2702572998005, 3765.7631684900707, 3840.3663395539984, 3846.615338466187, 3856.2480316338606, 3859.4403811447182, 3876.9806150969066, 3877.0888841122314, 3889.7277190596387, 3899.980500097538, 4467.106578684276, 4485.775711214426, 4498.482674492475, 4500.347449619787, 4521.480029796549, 4971.37857767779, 5302.973485132627, 5340.305760251143, 5344.812931547377, 5367.651102678314, 1345.1928842694306, 1355.627202519315, 1356.1591813075759, 1357.5045108535314, 1360.2450639894953, 841.5497708725925, 856.9442986205877, 866.0992567729617, 879.7536689726886, 883.4875772052194, 4454.131444368317, 4609.8156073757345, 4636.374089497875, 4640.23436133041, 4652.767361631905, 5488.4785945335125, 5495.021792154821, 5496.285482887199, 5502.284702988666, 5507.862303442446, 4507.346434766941, 4657.813687452532, 4667.719936803803, 4699.765011749467, 4701.459332176843, 2936.309967157716, 2937.2803663102677, 2937.5459147722013, 2941.352902361477, 2944.7349738523635, 5122.154844450624, 5138.254953031864, 5141.537261646395, 5145.305383773218, 5168.715720635401, 5429.972850135724, 5606.775728970877, 5629.437056294338, 5632.957902787997, 5664.716764161775, 5064.974675126675, 5124.180131179068, 5129.897402051938, 5135.563477104413, 5150.1502252127975, 5425.4808653577065, 5448.809291674773, 5475.945240547703, 5480.6437581557075, 5486.670799752028, 5176.6704982758665, 5390.865228369165, 5416.2688037114485, 5417.6478528895495, 5434.212039254365, 5081.517255860687, 5139.871503212449, 5143.177091665316, 5171.482851714798, 5179.145441002343, 3920.745151565139, 3921.8235179417566, 3922.78424686645, 3924.941125883057, 3946.723729338919, 5148.665336753099, 5477.972610136924, 5490.752916118864, 5497.4607110009265, 5540.584456165723, 5274.578033757367, 5276.39321478035, 5289.338832645919, 5301.231321458444, 5302.602304827076, 5175.844724658266, 5273.525382715574, 5292.470752924831, 5304.7082410466255, 5379.623426360117, 5215.904660021438, 5235.842924712265, 5266.368035835724, 5267.920981185209, 5294.152935530296, 5097.235414687826, 5224.268602395591, 5404.648697834628, 5406.486383793534, 5406.702631355313, 5238.214267859699, 5248.58011359098, 5250.26496290512, 5281.075811732854, 5290.153575427913], "value": 3976.237618636985, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [627.6641996531856, 657.4050484311698, 668.5186665600772, 703.3810246982655, 709.6309918842202, 12627.55803546876, 12711.36443177841, 12863.099583029192, 12937.935310323435, 13030.087893847434, 12648.936755316234, 12959.93520032401, 12961.416736246869, 12999.610011699664, 13000.154989925648, 773.4740376543933, 783.1307248953657, 786.4455558831011, 787.629813987425, 788.329919568368, 619.7613918641333, 760.0992823504138, 791.6318911706055, 793.2226418110256, 797.9361651067929, 827.3257295304338, 831.8003679116998, 831.9126491718343, 838.4801423117675, 838.5094719589048, 828.9253967142926, 829.2619568583965, 831.3930830493713, 833.729038062629, 835.3108685334593, 610.112286622967, 610.5603965145133, 610.8472881779555, 611.1169360274405, 614.5268143529457, 13288.0, 13368.197908125447, 13412.195268283836, 13416.46334146633, 13446.596602101952, 13211.867881321255, 13285.269310187936, 13478.595642130751, 13575.728485430236, 13851.0, 10524.210684198715, 10602.840957385646, 10604.681859544226, 10675.199360048027, 10836.945815270952, 3366.848491817874, 3382.509536117274, 3430.1939044324563, 3430.9828450857835, 3492.4935884296888, 60958.0, 61041.694791525755, 61920.38079619191, 62181.689091554705, 62548.687256563426, 10455.548966156532, 10587.788244235073, 10623.521941512496, 10714.73213169677, 10841.349519028883, 20420.489487762923, 20512.17951281932, 20513.0, 20636.07137678778, 20876.791232087788, 7071.540349877241, 7117.82205444868, 7190.424766018706, 7244.239354867768, 7394.186639469654, 3690.317291301118, 3760.417135344026, 3781.1870447853844, 3799.430085487144, 3870.903227419281, 2949.233199368137, 3065.432894914448, 3082.5838511801066, 3083.152133163398, 3085.506318988951, 538.7764077907624, 565.7284503438291, 571.0691572736413, 577.3793172339751, 580.6487075319455, 474.4259446070225, 520.3937412913989, 548.4405905975962, 602.8733965867217, 633.1863555331469, 8118.188181181835, 8155.469894456842, 8215.548144851971, 8255.834883302301, 8312.168783121639, 535.0315928170024, 574.2764117212342, 627.3569591169088, 628.8616504369123, 632.7627139822566, 3893.442622950786, 3895.0, 3975.7018223632763, 3977.1449138435373, 4077.55146933837, 55264.17103743447, 73520.0, 75584.24415755882, 76542.0, 89894.55052724695, 83659.58170209231, 86519.0, 87693.0, 88317.0, 88566.55716721374, 76071.23928760752, 76649.0, 78381.60809195918, 78414.0, 78692.21307786963, 8944.776380590538, 9013.594388252675, 9055.18503334703, 9186.127317904788, 9194.862077068983, 42559.787201063795, 43575.47485837981, 43966.56033439752, 44414.77792611016, 45974.942756296114, 56948.430515694316, 67140.66429668016, 67922.66038669775, 68096.6595167021, 68360.0, 9214.124658157465, 10351.948240258751, 10938.234323597271, 10984.945075274572, 11410.14423918226, 12176.75646487083, 12519.186252893533, 12848.807267890803, 13005.934970325088, 13511.86488135106, 12073.637790866289, 12433.875661243634, 12446.315452650191, 13119.0, 13185.868141318464, 12484.937575312066, 12652.810207847073, 13165.868341316464, 13398.933005334911, 13409.128406653535, 11817.350045747222, 11959.983401410978, 12162.452689628812, 12433.254004759743, 12632.557860474839, 10193.949030254802, 10554.683359499228, 10589.311694739818, 10622.52198651078, 11072.39101849406, 10494.160467162761, 10614.787704245717, 10688.946555267485, 10740.194485413782, 10790.74878865097], "value": 6690.480140847782, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1594.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 110.0, 114.0, 113.0, 116.0, 116.0, 114.0, 114.0, 113.0, 113.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 134.0, 155.0, 197.0, 134.0, 162.0, 155.0, 140.0, 188.0, 133.0], "value": 157.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 170.0, 163.0, 163.0, 165.0, 164.0, 165.0, 164.0, 163.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 75.0, 168.0, 78.0, 75.0, 77.0, 77.0, 175.0, 78.0], "value": 95.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 161.0, 88.0, 87.0, 86.0, 138.0, 88.0, 87.0, 135.0], "value": 104.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 119.0, 121.0, 117.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 149.0, 148.0, 151.0, 150.0, 149.0, 149.0, 148.0, 148.0], "value": 148.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 66.0, 62.0, 63.0, 63.0, 64.0, 64.0, 64.0, 63.0], "value": 63.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 66.0, 65.0, 66.0, 65.0, 64.0, 67.0, 65.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 87.0, 86.0, 85.0, 85.0, 85.0, 84.0, 119.0, 86.0], "value": 88.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 140.0, 133.0, 133.0, 142.0, 132.0, 133.0, 144.0, 155.0, 147.0], "value": 140.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 171.0, 168.0, 166.0, 169.0, 175.0, 176.0, 168.0, 168.0, 167.0], "value": 169.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 68.0, 69.0, 69.0, 69.0, 66.0, 68.0, 77.0, 67.0], "value": 69.1, "unit": "score"}]}]} 09:02:08 INFO - Return code: 0 09:02:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:02:08 ERROR - # TBPL SUCCESS # 09:02:08 INFO - Running post-action listener: _resource_record_post_action 09:02:08 INFO - ##### 09:02:08 INFO - ##### Finished run-tests step (success) 09:02:08 INFO - ##### 09:02:08 INFO - Running post-run listener: _resource_record_post_run 09:02:08 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 545218560; Read time: 0; Write time: 438764 09:02:08 INFO - TinderboxPrint: CPU usage
13.4% 09:02:08 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 09:02:08 INFO - TinderboxPrint: I/O write bytes / time
545,218,560 / 438,764 09:02:08 INFO - TinderboxPrint: CPU idle
8,271.5 (86.6%) 09:02:08 INFO - TinderboxPrint: CPU user
1,231.4 (12.9%) 09:02:08 INFO - TinderboxPrint: Swap in / out
0 / 0 09:02:08 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 209018880; Read time: 0; Write time: 195672 09:02:08 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 299601920; Read time: 0; Write time: 224104 09:02:09 INFO - Running post-run listener: _upload_blobber_files 09:02:09 INFO - Blob upload gear active. 09:02:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:02:09 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 09:02:09 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:02:09 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:02:09 INFO - (blobuploader) - INFO - Open directory for files ... 09:02:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:02:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:02:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:02:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:02:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:02:10 INFO - (blobuploader) - INFO - Done attempting. 09:02:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:02:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:02:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:02:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:02:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:02:11 INFO - (blobuploader) - INFO - Done attempting. 09:02:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:02:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:02:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:02:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:02:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:02:16 INFO - (blobuploader) - INFO - Done attempting. 09:02:16 INFO - (blobuploader) - INFO - Iteration through files over. 09:02:16 INFO - Return code: 0 09:02:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:02:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:02:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fb316e2173a8c5a564fbd867c554ed6eeeac27a41c0a0adc0c9ecbdb332e9bb397c26b0573475812020994625db12d348f9f92493879cde0962f2b54ef97bed4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/659f66d8abe2415c812b9ac525834bfaf50be0ce9b535706eae72c7c582fde59f4a6a5f4a04a270ef582721155fd53f9c89106989af9a3718b73b0d4ccd49b72", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/668ef9654af79654de9881fdfc7cf4df83fc30ae8f793274c4c6e65a424190b6de345435914582c4407c9a54d43ac9a85c5333945e7dadca96bc5c596cd99a58"} 09:02:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:02:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:02:16 INFO - Contents: 09:02:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fb316e2173a8c5a564fbd867c554ed6eeeac27a41c0a0adc0c9ecbdb332e9bb397c26b0573475812020994625db12d348f9f92493879cde0962f2b54ef97bed4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/659f66d8abe2415c812b9ac525834bfaf50be0ce9b535706eae72c7c582fde59f4a6a5f4a04a270ef582721155fd53f9c89106989af9a3718b73b0d4ccd49b72", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/668ef9654af79654de9881fdfc7cf4df83fc30ae8f793274c4c6e65a424190b6de345435914582c4407c9a54d43ac9a85c5333945e7dadca96bc5c596cd99a58"} 09:02:16 INFO - Running post-run listener: copy_logs_to_upload_dir 09:02:16 INFO - Copying logs to upload dir... 09:02:16 INFO - mkdir: /builds/slave/test/build/upload/logs 09:02:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.104557 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-06-15 09:02:15.979181) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-15 09:02:15.982875) ========= 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=0333a256a5e4f052382dd180000001b1-1466004465.430263-695516675 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/Fx-Team-Non-PGO/sha512/fb316e2173a8c5a564fbd867c554ed6eeeac27a41c0a0adc0c9ecbdb332e9bb397c26b0573475812020994625db12d348f9f92493879cde0962f2b54ef97bed4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/659f66d8abe2415c812b9ac525834bfaf50be0ce9b535706eae72c7c582fde59f4a6a5f4a04a270ef582721155fd53f9c89106989af9a3718b73b0d4ccd49b72", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/668ef9654af79654de9881fdfc7cf4df83fc30ae8f793274c4c6e65a424190b6de345435914582c4407c9a54d43ac9a85c5333945e7dadca96bc5c596cd99a58"} build_url:https://queue.taskcluster.net/v1/task/ODEE5zyDSoScYh7lh3au1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011286 build_url: 'https://queue.taskcluster.net/v1/task/ODEE5zyDSoScYh7lh3au1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fb316e2173a8c5a564fbd867c554ed6eeeac27a41c0a0adc0c9ecbdb332e9bb397c26b0573475812020994625db12d348f9f92493879cde0962f2b54ef97bed4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/659f66d8abe2415c812b9ac525834bfaf50be0ce9b535706eae72c7c582fde59f4a6a5f4a04a270ef582721155fd53f9c89106989af9a3718b73b0d4ccd49b72", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/668ef9654af79654de9881fdfc7cf4df83fc30ae8f793274c4c6e65a424190b6de345435914582c4407c9a54d43ac9a85c5333945e7dadca96bc5c596cd99a58"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-15 09:02:16.008101) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 09:02:16.008420) ========= 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=0333a256a5e4f052382dd180000001b1-1466004465.430263-695516675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004533 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 09:02:16.091767) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-15 09:02:16.092069) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-15 09:02:16.092331) ========= ========= Total master_lag: 0.21 =========