builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-060 starttime: 1466005285.52 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.519066) ========= 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.521530) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-15 08:41:25.521902) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-15 08:41:25.544731) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 08:41:25.545178) ========= 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=337fe3f4b1febe37b85fccc40000019e-1466004780.56551-2130069505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-15 08:41:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.2M=0s 2016-06-15 08:41:25 (70.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.130953 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 08:41:25.692525) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 08:41:25.692863) ========= 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=337fe3f4b1febe37b85fccc40000019e-1466004780.56551-2130069505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017896 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 08:41:25.742886) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 08:41:25.743260) ========= 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=337fe3f4b1febe37b85fccc40000019e-1466004780.56551-2130069505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-15 08:41:26,025 truncating revision to first 12 chars 2016-06-15 08:41:26,025 Setting DEBUG logging. 2016-06-15 08:41:26,025 attempt 1/10 2016-06-15 08:41:26,025 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,337 unpacking tar archive at: fx-team-153553aecf16/testing/mozharness/ program finished with exit code 0 elapsedTime=0.656894 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 08:41:26.414837) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-15 08:41:26.415200) ========= script_repo_revision: 153553aecf160632bbcb50906ba135511da138e6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-15 08:41:26.415680) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-15 08:41:26.416022) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-15 08:41:26.426857) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-15 08:41:26.427175) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=337fe3f4b1febe37b85fccc40000019e-1466004780.56551-2130069505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:41:26 INFO - MultiFileLogger online at 20160615 08:41:26 in /builds/slave/test 08:41:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:41:26 INFO - {'append_to_log': False, 08:41:26 INFO - 'base_work_dir': '/builds/slave/test', 08:41:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:41:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:41:26 INFO - 'branch': 'Fx-Team-Non-PGO', 08:41:26 INFO - 'buildbot_json_path': 'buildprops.json', 08:41:26 INFO - 'config_files': ('talos/linux_config.py',), 08:41:26 INFO - 'default_actions': ('clobber', 08:41:26 INFO - 'read-buildbot-config', 08:41:26 INFO - 'download-and-extract', 08:41:26 INFO - 'populate-webroot', 08:41:26 INFO - 'create-virtualenv', 08:41:26 INFO - 'install', 08:41:26 INFO - 'run-tests'), 08:41:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:41:26 INFO - 'download_minidump_stackwalk': True, 08:41:26 INFO - 'download_symbols': 'ondemand', 08:41:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:41:26 INFO - 'tooltool.py': '/tools/tooltool.py', 08:41:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:41:26 INFO - '/tools/misc-python/virtualenv.py')}, 08:41:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:41:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:41:26 INFO - 'installer_path': 'installer.exe', 08:41:26 INFO - 'log_level': 'info', 08:41:26 INFO - 'log_name': 'talos', 08:41:26 INFO - 'log_to_console': True, 08:41:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:41:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:41:26 INFO - 'opt_config_files': (), 08:41:26 INFO - 'pip_index': False, 08:41:26 INFO - 'sps_profile': False, 08:41:26 INFO - 'sps_profile_interval': 0, 08:41:26 INFO - 'suite': 'dromaeojs', 08:41:26 INFO - 'system_bits': '32', 08:41:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:41:26 INFO - 'title': 'talos-linux64-ix-060', 08:41:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:41:26 INFO - 'use_talos_json': True, 08:41:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:41:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:41:26 INFO - 'work_dir': 'build'} 08:41:26 INFO - ##### 08:41:26 INFO - ##### Running clobber step. 08:41:26 INFO - ##### 08:41:26 INFO - Running pre-action listener: _resource_record_pre_action 08:41:26 INFO - Running main action method: clobber 08:41:26 INFO - rmtree: /builds/slave/test/build 08:41:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:41:27 INFO - Running post-action listener: _resource_record_post_action 08:41:27 INFO - ##### 08:41:27 INFO - ##### Finished clobber step (success) 08:41:27 INFO - ##### 08:41:27 INFO - ##### 08:41:27 INFO - ##### Running read-buildbot-config 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: read_buildbot_config 08:41:27 INFO - Using buildbot properties: 08:41:27 INFO - { 08:41:27 INFO - "project": "", 08:41:27 INFO - "product": "firefox", 08:41:27 INFO - "script_repo_revision": "production", 08:41:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:41:27 INFO - "repository": "", 08:41:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:41:27 INFO - "buildid": "20160615080629", 08:41:27 INFO - "pgo_build": "False", 08:41:27 INFO - "basedir": "/builds/slave/test", 08:41:27 INFO - "buildnumber": 1863, 08:41:27 INFO - "slavename": "talos-linux64-ix-060", 08:41:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:41:27 INFO - "platform": "ubuntu64_hw", 08:41:27 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:41:27 INFO - "branch": "fx-team", 08:41:27 INFO - "repo_path": "integration/fx-team", 08:41:27 INFO - "revision": "153553aecf160632bbcb50906ba135511da138e6", 08:41:27 INFO - "stage_platform": "linux64", 08:41:27 INFO - "builduid": "2d2f0f31317446fe9be0f3364a0edc7e", 08:41:27 INFO - "slavebuilddir": "test" 08:41:27 INFO - } 08:41:27 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:27 INFO - Running post-action listener: _resource_record_post_action 08:41:27 INFO - ##### 08:41:27 INFO - ##### Finished read-buildbot-config step (success) 08:41:27 INFO - ##### 08:41:27 INFO - ##### 08:41:27 INFO - ##### Running download-and-extract 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: download_and_extract 08:41:27 INFO - mkdir: /builds/slave/test/build/tests 08:41:27 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:27 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:27 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:27 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:27 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:27 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:28 INFO - Downloaded 1361 bytes. 08:41:28 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:41:28 INFO - Using the following test package requirements: 08:41:28 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:41:28 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:41:28 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:41:28 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:28 INFO - u'jsshell-linux-x86_64.zip'], 08:41:28 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:41:28 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:41:28 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:41:28 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:41:28 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:41:28 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:41:28 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 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.common.tests.zip 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.common.tests.zip 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.common.tests.zip 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.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:41:28 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:29 INFO - Downloaded 22654307 bytes. 08:41:29 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:29 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:30 INFO - Return code: 0 08:41:30 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: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:31 INFO - Downloaded 22654307 bytes. 08:41:31 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:31 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:32 INFO - Return code: 0 08:41:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:32 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:32 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:32 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:32 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:32 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:35 INFO - Downloaded 14405384 bytes. 08:41:35 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:35 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:35 INFO - Return code: 0 08:41:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:35 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:35 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:35 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:35 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:35 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:38 INFO - Downloaded 55432984 bytes. 08:41:38 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:38 INFO - mkdir: /builds/slave/test/properties 08:41:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:41:38 INFO - Writing to file /builds/slave/test/properties/build_url 08:41:38 INFO - Contents: 08:41:38 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:38 INFO - Running post-action listener: _resource_record_post_action 08:41:38 INFO - Running post-action listener: set_extra_try_arguments 08:41:38 INFO - ##### 08:41:38 INFO - ##### Finished download-and-extract step (success) 08:41:38 INFO - ##### 08:41:38 INFO - ##### 08:41:38 INFO - ##### Running populate-webroot step. 08:41:38 INFO - ##### 08:41:38 INFO - Running pre-action listener: _resource_record_pre_action 08:41:38 INFO - Running main action method: populate_webroot 08:41:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:41:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:41:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:41:38 INFO - '--tppagecycles', 08:41:38 INFO - '7'], 08:41:38 INFO - 'tests': ['tsvgm']}}, 08:41:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:41:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:41:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:41:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:41:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:41:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:41:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:38 INFO - 'talos_options': ['--disable-e10s'], 08:41:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:41:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:41:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:38 INFO - 'talos_options': ['--disable-e10s'], 08:41:38 INFO - 'tests': ['damp', 'tps']}, 08:41:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:38 INFO - 'tests': ['damp', 'tps']}, 08:41:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:41:38 INFO - 'tests': ['dromaeo_dom']}, 08:41:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:41:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:41:38 INFO - 'tests': ['basic_compositor_video']}, 08:41:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:41:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:41:38 INFO - 'tests': ['a11yr', 08:41:38 INFO - 'ts_paint', 08:41:38 INFO - 'tpaint', 08:41:38 INFO - 'sessionrestore', 08:41:38 INFO - 'sessionrestore_no_auto_restore', 08:41:38 INFO - 'tabpaint']}, 08:41:38 INFO - 'other-e10s': {'tests': ['a11yr', 08:41:38 INFO - 'ts_paint', 08:41:38 INFO - 'tpaint', 08:41:38 INFO - 'sessionrestore', 08:41:38 INFO - 'sessionrestore_no_auto_restore', 08:41:38 INFO - 'tabpaint']}, 08:41:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:41:38 INFO - 'ts_paint', 08:41:38 INFO - 'tpaint', 08:41:38 INFO - 'sessionrestore', 08:41:38 INFO - 'sessionrestore_no_auto_restore', 08:41:38 INFO - 'tabpaint']}, 08:41:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:41:38 INFO - 'ts_paint', 08:41:38 INFO - 'tpaint', 08:41:38 INFO - 'sessionrestore', 08:41:38 INFO - 'sessionrestore_no_auto_restore', 08:41:38 INFO - 'tabpaint']}, 08:41:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:41:38 INFO - 'tests': ['a11yr', 08:41:38 INFO - 'ts_paint', 08:41:38 INFO - 'tpaint', 08:41:38 INFO - 'sessionrestore', 08:41:38 INFO - 'sessionrestore_no_auto_restore', 08:41:38 INFO - 'tabpaint']}, 08:41:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:41:38 INFO - 'tests': ['a11yr', 08:41:38 INFO - 'ts_paint', 08:41:38 INFO - 'tpaint', 08:41:38 INFO - 'sessionrestore', 08:41:38 INFO - 'sessionrestore_no_auto_restore', 08:41:38 INFO - 'tabpaint']}, 08:41:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:41:38 INFO - 'tests': ['tsvgx', 08:41:38 INFO - 'tsvgr_opacity', 08:41:38 INFO - 'tart', 08:41:38 INFO - 'tscrollx', 08:41:38 INFO - 'cart']}, 08:41:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:41:38 INFO - 'tsvgr_opacity', 08:41:38 INFO - 'tart', 08:41:38 INFO - 'tscrollx', 08:41:38 INFO - 'cart']}, 08:41:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:38 INFO - 'talos_options': ['--disable-e10s'], 08:41:38 INFO - 'tests': ['tp5o']}, 08:41:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:38 INFO - 'tests': ['tp5o']}, 08:41:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:38 INFO - 'talos_options': ['--disable-e10s', 08:41:38 INFO - '--xperf_path', 08:41:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:41:38 INFO - 'tests': ['tp5n']}, 08:41:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:38 INFO - 'talos_options': ['--xperf_path', 08:41:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:41:38 INFO - 'tests': ['tp5n']}}, 08:41:38 INFO - 'talos.zip': {'path': '', 08:41:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:41:38 INFO - Running post-action listener: _resource_record_post_action 08:41:38 INFO - ##### 08:41:38 INFO - ##### Finished populate-webroot step (success) 08:41:38 INFO - ##### 08:41:38 INFO - ##### 08:41:38 INFO - ##### Running create-virtualenv step. 08:41:38 INFO - ##### 08:41:38 INFO - Running pre-action listener: _resource_record_pre_action 08:41:38 INFO - Running main action method: create_virtualenv 08:41:38 INFO - Creating virtualenv /builds/slave/test/build/venv 08:41:38 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:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:41:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:41:38 INFO - Using real prefix '/usr' 08:41:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:41:39 INFO - Installing distribute.............................................................................................................................................................................................done. 08:41:41 INFO - Installing pip.................done. 08:41:41 INFO - Return code: 0 08:41:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 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 - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 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 - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2b64a51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3f020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd12e0>, '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 0x2c3d140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3d5d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466004780.56551-2130069505', '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:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:41:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:41:41 INFO - Using env: {'DISPLAY': ':0', 08:41:41 INFO - 'HOME': '/home/cltbld', 08:41:41 INFO - 'LANG': 'en_US.UTF-8', 08:41:41 INFO - 'LANGUAGE': 'en_US:en', 08:41:41 INFO - 'LOGNAME': 'cltbld', 08:41:41 INFO - 'MAIL': '/var/mail/cltbld', 08:41:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:41 INFO - 'MOZ_NO_REMOTE': '1', 08:41:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:41 INFO - 'NO_EM_RESTART': '1', 08:41:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:41 INFO - 'PWD': '/builds/slave/test', 08:41:41 INFO - 'SHELL': '/bin/bash', 08:41:41 INFO - 'SHLVL': '1', 08:41:41 INFO - 'TERM': 'linux', 08:41:41 INFO - 'TMOUT': '86400', 08:41:41 INFO - 'USER': 'cltbld', 08:41:41 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466004780.56551-2130069505', 08:41:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:41 INFO - '_': '/tools/buildbot/bin/python'} 08:41:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:41 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:41 INFO - Cleaning up... 08:41:41 INFO - Return code: 0 08:41:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 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 - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 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 - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2b64a51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3f020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd12e0>, '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 0x2c3d140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3d5d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466004780.56551-2130069505', '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:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:41:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:41:41 INFO - Using env: {'DISPLAY': ':0', 08:41:41 INFO - 'HOME': '/home/cltbld', 08:41:41 INFO - 'LANG': 'en_US.UTF-8', 08:41:41 INFO - 'LANGUAGE': 'en_US:en', 08:41:41 INFO - 'LOGNAME': 'cltbld', 08:41:41 INFO - 'MAIL': '/var/mail/cltbld', 08:41:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:41 INFO - 'MOZ_NO_REMOTE': '1', 08:41:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:41 INFO - 'NO_EM_RESTART': '1', 08:41:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:41 INFO - 'PWD': '/builds/slave/test', 08:41:41 INFO - 'SHELL': '/bin/bash', 08:41:41 INFO - 'SHLVL': '1', 08:41:41 INFO - 'TERM': 'linux', 08:41:41 INFO - 'TMOUT': '86400', 08:41:41 INFO - 'USER': 'cltbld', 08:41:41 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466004780.56551-2130069505', 08:41:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:41 INFO - '_': '/tools/buildbot/bin/python'} 08:41:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:41 INFO - Downloading/unpacking psutil>=3.1.1 08:41:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:41:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:41:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:41:43 INFO - Installing collected packages: psutil 08:41:43 INFO - Running setup.py install for psutil 08:41:43 INFO - building 'psutil._psutil_linux' extension 08:41:43 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:44 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:44 INFO - building 'psutil._psutil_posix' extension 08:41:44 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:44 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:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:41:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:41:44 INFO - Successfully installed psutil 08:41:44 INFO - Cleaning up... 08:41:44 INFO - Return code: 0 08:41:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:41:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:44 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 0x7f2b64a51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3f020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd12e0>, '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 0x2c3d140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3d5d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466004780.56551-2130069505', '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:44 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:44 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:44 INFO - Using env: {'DISPLAY': ':0', 08:41:44 INFO - 'HOME': '/home/cltbld', 08:41:44 INFO - 'LANG': 'en_US.UTF-8', 08:41:44 INFO - 'LANGUAGE': 'en_US:en', 08:41:44 INFO - 'LOGNAME': 'cltbld', 08:41:44 INFO - 'MAIL': '/var/mail/cltbld', 08:41:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:44 INFO - 'MOZ_NO_REMOTE': '1', 08:41:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:44 INFO - 'NO_EM_RESTART': '1', 08:41:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:44 INFO - 'PWD': '/builds/slave/test', 08:41:44 INFO - 'SHELL': '/bin/bash', 08:41:44 INFO - 'SHLVL': '1', 08:41:44 INFO - 'TERM': 'linux', 08:41:44 INFO - 'TMOUT': '86400', 08:41:44 INFO - 'USER': 'cltbld', 08:41:44 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466004780.56551-2130069505', 08:41:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:44 INFO - '_': '/tools/buildbot/bin/python'} 08:41:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:41:44 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:44 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:44 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:44 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:44 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:44 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:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:41:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:41:46 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:46 INFO - Installing collected packages: mozsystemmonitor 08:41:46 INFO - Running setup.py install for mozsystemmonitor 08:41:46 INFO - Successfully installed mozsystemmonitor 08:41:46 INFO - Cleaning up... 08:41:46 INFO - Return code: 0 08:41:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:41:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2b64a51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3f020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd12e0>, '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 0x2c3d140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3d5d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466004780.56551-2130069505', '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:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:41:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:41:46 INFO - Using env: {'DISPLAY': ':0', 08:41:46 INFO - 'HOME': '/home/cltbld', 08:41:46 INFO - 'LANG': 'en_US.UTF-8', 08:41:46 INFO - 'LANGUAGE': 'en_US:en', 08:41:46 INFO - 'LOGNAME': 'cltbld', 08:41:46 INFO - 'MAIL': '/var/mail/cltbld', 08:41:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:46 INFO - 'MOZ_NO_REMOTE': '1', 08:41:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:46 INFO - 'NO_EM_RESTART': '1', 08:41:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:46 INFO - 'PWD': '/builds/slave/test', 08:41:46 INFO - 'SHELL': '/bin/bash', 08:41:46 INFO - 'SHLVL': '1', 08:41:46 INFO - 'TERM': 'linux', 08:41:46 INFO - 'TMOUT': '86400', 08:41:46 INFO - 'USER': 'cltbld', 08:41:46 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466004780.56551-2130069505', 08:41:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:46 INFO - '_': '/tools/buildbot/bin/python'} 08:41:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:46 INFO - Downloading/unpacking jsonschema==2.5.1 08:41:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:41:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.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:49 INFO - Downloading functools32-3.2.3-2.tar.gz 08:41:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:41:49 INFO - warning: no files found matching '*.txt' 08:41:49 INFO - no previously-included directories found matching 'build' 08:41:49 INFO - no previously-included directories found matching 'dist' 08:41:49 INFO - no previously-included directories found matching '.git*' 08:41:49 INFO - Installing collected packages: jsonschema, functools32 08:41:49 INFO - Running setup.py install for functools32 08:41:49 INFO - warning: no files found matching '*.txt' 08:41:49 INFO - no previously-included directories found matching 'build' 08:41:49 INFO - no previously-included directories found matching 'dist' 08:41:49 INFO - no previously-included directories found matching '.git*' 08:41:49 INFO - Successfully installed jsonschema functools32 08:41:49 INFO - Cleaning up... 08:41:49 INFO - Return code: 0 08:41:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:41:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2b64a51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3f020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd12e0>, '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 0x2c3d140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3d5d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466004780.56551-2130069505', '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:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:41:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:41:49 INFO - Using env: {'DISPLAY': ':0', 08:41:49 INFO - 'HOME': '/home/cltbld', 08:41:49 INFO - 'LANG': 'en_US.UTF-8', 08:41:49 INFO - 'LANGUAGE': 'en_US:en', 08:41:49 INFO - 'LOGNAME': 'cltbld', 08:41:49 INFO - 'MAIL': '/var/mail/cltbld', 08:41:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:49 INFO - 'MOZ_NO_REMOTE': '1', 08:41:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:49 INFO - 'NO_EM_RESTART': '1', 08:41:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:49 INFO - 'PWD': '/builds/slave/test', 08:41:49 INFO - 'SHELL': '/bin/bash', 08:41:49 INFO - 'SHLVL': '1', 08:41:49 INFO - 'TERM': 'linux', 08:41:49 INFO - 'TMOUT': '86400', 08:41:49 INFO - 'USER': 'cltbld', 08:41:49 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466004780.56551-2130069505', 08:41:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:49 INFO - '_': '/tools/buildbot/bin/python'} 08:41:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:49 INFO - Downloading/unpacking blobuploader==1.2.4 08:41:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:51 INFO - Downloading blobuploader-1.2.4.tar.gz 08:41:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:41:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 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:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:41:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 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:52 INFO - Downloading docopt-0.6.1.tar.gz 08:41:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:41:52 INFO - Installing collected packages: blobuploader, requests, docopt 08:41:52 INFO - Running setup.py install for blobuploader 08:41:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:41:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:41:52 INFO - Running setup.py install for requests 08:41:52 INFO - Running setup.py install for docopt 08:41:52 INFO - Successfully installed blobuploader requests docopt 08:41:52 INFO - Cleaning up... 08:41:52 INFO - Return code: 0 08:41:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41:52 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:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:52 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:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:52 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 0x7f2b64a51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3f020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd12e0>, '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 0x2c3d140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3d5d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466004780.56551-2130069505', '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:52 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:52 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:52 INFO - Using env: {'DISPLAY': ':0', 08:41:52 INFO - 'HOME': '/home/cltbld', 08:41:52 INFO - 'LANG': 'en_US.UTF-8', 08:41:52 INFO - 'LANGUAGE': 'en_US:en', 08:41:52 INFO - 'LOGNAME': 'cltbld', 08:41:52 INFO - 'MAIL': '/var/mail/cltbld', 08:41:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:52 INFO - 'MOZ_NO_REMOTE': '1', 08:41:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:52 INFO - 'NO_EM_RESTART': '1', 08:41:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:52 INFO - 'PWD': '/builds/slave/test', 08:41:52 INFO - 'SHELL': '/bin/bash', 08:41:52 INFO - 'SHLVL': '1', 08:41:52 INFO - 'TERM': 'linux', 08:41:52 INFO - 'TMOUT': '86400', 08:41:52 INFO - 'USER': 'cltbld', 08:41:52 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466004780.56551-2130069505', 08:41:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:52 INFO - '_': '/tools/buildbot/bin/python'} 08:41:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:41:53 INFO - Running setup.py (path:/tmp/pip-dQeQTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:41:53 INFO - Running setup.py (path:/tmp/pip-j5leNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:41:53 INFO - Running setup.py (path:/tmp/pip-eWtXsi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:41:53 INFO - Running setup.py (path:/tmp/pip-DCJRsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:41:53 INFO - Running setup.py (path:/tmp/pip-Mtl52L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:41:53 INFO - Running setup.py (path:/tmp/pip-Ane81r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:41:53 INFO - Running setup.py (path:/tmp/pip-M_zHpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:41:53 INFO - Running setup.py (path:/tmp/pip-bCIZij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:41:53 INFO - Running setup.py (path:/tmp/pip-odzxxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:41:53 INFO - Running setup.py (path:/tmp/pip-dQuTHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:41:53 INFO - Running setup.py (path:/tmp/pip-8eLA5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:41:53 INFO - Running setup.py (path:/tmp/pip-J4IeVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:41:53 INFO - Running setup.py (path:/tmp/pip-75D278-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:41:53 INFO - Running setup.py (path:/tmp/pip-P61Uja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:54 INFO - Running setup.py (path:/tmp/pip-jJyhNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:41:54 INFO - Running setup.py (path:/tmp/pip-eH7tV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:41:54 INFO - Running setup.py (path:/tmp/pip-orCpgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:41:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:41:54 INFO - Running setup.py install for manifestparser 08:41:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:41:54 INFO - Running setup.py install for mozcrash 08:41:54 INFO - Running setup.py install for mozdebug 08:41:54 INFO - Running setup.py install for mozdevice 08:41:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:41:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:41:54 INFO - Running setup.py install for mozfile 08:41:54 INFO - Running setup.py install for mozhttpd 08:41:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:41:54 INFO - Running setup.py install for mozinfo 08:41:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:41:54 INFO - Running setup.py install for mozInstall 08:41:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:41:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:41:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:41:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:41:55 INFO - Running setup.py install for mozleak 08:41:55 INFO - Running setup.py install for mozlog 08:41:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:41:55 INFO - Running setup.py install for moznetwork 08:41:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:41:55 INFO - Running setup.py install for mozprocess 08:41:55 INFO - Running setup.py install for mozprofile 08:41:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:41:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:41:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:41:55 INFO - Running setup.py install for mozrunner 08:41:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:41:55 INFO - Running setup.py install for mozscreenshot 08:41:55 INFO - Running setup.py install for moztest 08:41:55 INFO - Running setup.py install for mozversion 08:41:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:41:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:41:56 INFO - Cleaning up... 08:41:56 INFO - Return code: 0 08:41:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:56 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 0x7f2b64a51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3f020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd12e0>, '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 0x2c3d140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3d5d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466004780.56551-2130069505', '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:56 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:41:56 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:41:56 INFO - Using env: {'DISPLAY': ':0', 08:41:56 INFO - 'HOME': '/home/cltbld', 08:41:56 INFO - 'LANG': 'en_US.UTF-8', 08:41:56 INFO - 'LANGUAGE': 'en_US:en', 08:41:56 INFO - 'LOGNAME': 'cltbld', 08:41:56 INFO - 'MAIL': '/var/mail/cltbld', 08:41:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:56 INFO - 'MOZ_NO_REMOTE': '1', 08:41:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:56 INFO - 'NO_EM_RESTART': '1', 08:41:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:56 INFO - 'PWD': '/builds/slave/test', 08:41:56 INFO - 'SHELL': '/bin/bash', 08:41:56 INFO - 'SHLVL': '1', 08:41:56 INFO - 'TERM': 'linux', 08:41:56 INFO - 'TMOUT': '86400', 08:41:56 INFO - 'USER': 'cltbld', 08:41:56 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466004780.56551-2130069505', 08:41:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:56 INFO - '_': '/tools/buildbot/bin/python'} 08:41:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:41:56 INFO - Running setup.py (path:/tmp/pip-Figkih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:41:56 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:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:41:56 INFO - Running setup.py (path:/tmp/pip-P1LuKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:41:56 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:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:41:56 INFO - Running setup.py (path:/tmp/pip-5I89O4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:41:56 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:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:41:56 INFO - Running setup.py (path:/tmp/pip-nv1Wmw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:41:56 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:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:41:56 INFO - Running setup.py (path:/tmp/pip-yovtOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:41:56 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:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:41:56 INFO - Running setup.py (path:/tmp/pip-9qgGnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:41:56 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:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:41:56 INFO - Running setup.py (path:/tmp/pip-8mK2Jf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:41:56 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:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:41:56 INFO - Running setup.py (path:/tmp/pip-NuBtjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:41:56 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:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:41:56 INFO - Running setup.py (path:/tmp/pip-6CmR4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:41:56 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:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:41:56 INFO - Running setup.py (path:/tmp/pip-_poPky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:41:56 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:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:41:56 INFO - Running setup.py (path:/tmp/pip-pOszri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:41:57 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:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:41:57 INFO - Running setup.py (path:/tmp/pip-qPITIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:41:57 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:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:41:57 INFO - Running setup.py (path:/tmp/pip-mbgxyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:41:57 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:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:41:57 INFO - Running setup.py (path:/tmp/pip-EXIRbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:41:57 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:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:57 INFO - Running setup.py (path:/tmp/pip-SHszM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:57 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:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:41:57 INFO - Running setup.py (path:/tmp/pip-ijTAVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:41:57 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:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:41:57 INFO - Running setup.py (path:/tmp/pip-1L8BDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:41:57 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:41:57 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:41:57 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:41:57 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:41:57 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:41:57 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:41:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:41:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:59 INFO - Downloading blessings-1.6.tar.gz 08:41:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:41:59 INFO - Installing collected packages: blessings 08:41:59 INFO - Running setup.py install for blessings 08:41:59 INFO - Successfully installed blessings 08:41:59 INFO - Cleaning up... 08:41:59 INFO - Return code: 0 08:41:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:41:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:41:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:41:59 INFO - Reading from file tmpfile_stdout 08:41:59 INFO - Current package versions: 08:41:59 INFO - argparse == 1.2.1 08:41:59 INFO - blessings == 1.6 08:41:59 INFO - blobuploader == 1.2.4 08:41:59 INFO - docopt == 0.6.1 08:41:59 INFO - functools32 == 3.2.3-2 08:41:59 INFO - jsonschema == 2.5.1 08:41:59 INFO - manifestparser == 1.1 08:41:59 INFO - mozInstall == 1.12 08:41:59 INFO - mozcrash == 0.17 08:41:59 INFO - mozdebug == 0.1 08:41:59 INFO - mozdevice == 0.48 08:41:59 INFO - mozfile == 1.2 08:41:59 INFO - mozhttpd == 0.7 08:41:59 INFO - mozinfo == 0.9 08:41:59 INFO - mozleak == 0.1 08:41:59 INFO - mozlog == 3.2 08:41:59 INFO - moznetwork == 0.27 08:41:59 INFO - mozprocess == 0.22 08:41:59 INFO - mozprofile == 0.28 08:41:59 INFO - mozrunner == 6.11 08:41:59 INFO - mozscreenshot == 0.1 08:41:59 INFO - mozsystemmonitor == 0.3 08:41:59 INFO - moztest == 0.7 08:41:59 INFO - mozversion == 1.4 08:41:59 INFO - psutil == 3.1.1 08:41:59 INFO - requests == 1.2.3 08:41:59 INFO - wsgiref == 0.1.2 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', '--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 0x7f2b64a51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3f020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd12e0>, '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 0x2c3d140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3d5d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466004780.56551-2130069505', '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', '--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:41:59 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: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': '337fe3f4b1febe37b85fccc40000019e-1466004780.56551-2130069505', 08:41:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:59 INFO - '_': '/tools/buildbot/bin/python'} 08:42:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:00 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:00 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:00 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:00 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:00 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:00 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:00 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:00 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:00 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:00 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:00 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:00 INFO - Cleaning up... 08:42:00 INFO - Return code: 0 08:42:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:42:00 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:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:00 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:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:00 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 0x7f2b64a51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3f020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd12e0>, '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 0x2c3d140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3d5d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466004780.56551-2130069505', '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:00 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:00 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:00 INFO - Using env: {'DISPLAY': ':0', 08:42:00 INFO - 'HOME': '/home/cltbld', 08:42:00 INFO - 'LANG': 'en_US.UTF-8', 08:42:00 INFO - 'LANGUAGE': 'en_US:en', 08:42:00 INFO - 'LOGNAME': 'cltbld', 08:42:00 INFO - 'MAIL': '/var/mail/cltbld', 08:42:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:00 INFO - 'MOZ_NO_REMOTE': '1', 08:42:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:00 INFO - 'NO_EM_RESTART': '1', 08:42:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:00 INFO - 'PWD': '/builds/slave/test', 08:42:00 INFO - 'SHELL': '/bin/bash', 08:42:00 INFO - 'SHLVL': '1', 08:42:00 INFO - 'TERM': 'linux', 08:42:00 INFO - 'TMOUT': '86400', 08:42:00 INFO - 'USER': 'cltbld', 08:42:00 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466004780.56551-2130069505', 08:42:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:00 INFO - '_': '/tools/buildbot/bin/python'} 08:42:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:42:00 INFO - Cleaning up... 08:42:00 INFO - Return code: 0 08:42:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:42:00 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:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:00 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:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:00 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 0x7f2b64a51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3f020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd12e0>, '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 0x2c3d140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3d5d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466004780.56551-2130069505', '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:00 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:00 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:00 INFO - Using env: {'DISPLAY': ':0', 08:42:00 INFO - 'HOME': '/home/cltbld', 08:42:00 INFO - 'LANG': 'en_US.UTF-8', 08:42:00 INFO - 'LANGUAGE': 'en_US:en', 08:42:00 INFO - 'LOGNAME': 'cltbld', 08:42:00 INFO - 'MAIL': '/var/mail/cltbld', 08:42:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:00 INFO - 'MOZ_NO_REMOTE': '1', 08:42:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:00 INFO - 'NO_EM_RESTART': '1', 08:42:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:00 INFO - 'PWD': '/builds/slave/test', 08:42:00 INFO - 'SHELL': '/bin/bash', 08:42:00 INFO - 'SHLVL': '1', 08:42:00 INFO - 'TERM': 'linux', 08:42:00 INFO - 'TMOUT': '86400', 08:42:00 INFO - 'USER': 'cltbld', 08:42:00 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466004780.56551-2130069505', 08:42:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:00 INFO - '_': '/tools/buildbot/bin/python'} 08:42:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:00 INFO - Downloading/unpacking flake8 08:42:00 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:00 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:00 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:00 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:00 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:00 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:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:42:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:42:02 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:02 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:02 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:02 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:02 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:02 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:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:42:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:42:02 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:02 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:02 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:02 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:02 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:02 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:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:42:02 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:02 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:02 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:02 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:02 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:02 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:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:42:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:42:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:42:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:42:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:42:03 INFO - no previously-included directories found matching 'docs/_build' 08:42:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:42:03 INFO - Running setup.py install for pep8 08:42:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:42:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:42:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:42:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:42:03 INFO - no previously-included directories found matching 'docs/_build' 08:42:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:42:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:42:03 INFO - Cleaning up... 08:42:03 INFO - Return code: 0 08:42:03 INFO - Running post-action listener: _resource_record_post_action 08:42:03 INFO - Running post-action listener: _start_resource_monitoring 08:42:03 INFO - Starting resource monitoring. 08:42:03 INFO - ##### 08:42:03 INFO - ##### Finished create-virtualenv step (success) 08:42:03 INFO - ##### 08:42:03 INFO - ##### 08:42:03 INFO - ##### Running install step. 08:42:03 INFO - ##### 08:42:03 INFO - Running pre-action listener: _resource_record_pre_action 08:42:03 INFO - Running main action method: install 08:42:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:42:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:42:03 INFO - Reading from file tmpfile_stdout 08:42:03 INFO - Detecting whether we're running mozinstall >=1.0... 08:42:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:42:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:42:03 INFO - Reading from file tmpfile_stdout 08:42:03 INFO - Output received: 08:42:03 INFO - Usage: mozinstall [options] installer 08:42:03 INFO - Options: 08:42:03 INFO - -h, --help show this help message and exit 08:42:03 INFO - -d DEST, --destination=DEST 08:42:03 INFO - Directory to install application into. [default: 08:42:03 INFO - "/builds/slave/test"] 08:42:03 INFO - --app=APP Application being installed. [default: firefox] 08:42:03 INFO - mkdir: /builds/slave/test/build/application 08:42:03 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:03 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:19 INFO - Reading from file tmpfile_stdout 08:42:19 INFO - Output received: 08:42:19 INFO - /builds/slave/test/build/application/firefox/firefox 08:42:19 INFO - Running post-action listener: _resource_record_post_action 08:42:19 INFO - ##### 08:42:19 INFO - ##### Finished install step (success) 08:42:19 INFO - ##### 08:42:19 INFO - ##### 08:42:19 INFO - ##### Running run-tests step. 08:42:19 INFO - ##### 08:42:19 INFO - Running pre-action listener: _resource_record_pre_action 08:42:19 INFO - Running main action method: run_tests 08:42:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:42:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:42:19 INFO - Python 2.7.3 08:42:19 INFO - Return code: 0 08:42:19 INFO - grabbing minidump binary from tooltool 08:42:19 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:19 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 0x2cd12e0>, '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 0x2c3d140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3d5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:42:19 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:19 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:19 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:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:42:19 INFO - Return code: 0 08:42:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:42:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:42:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:42:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:42:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:42:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:42:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:42:20 INFO - Return code: 0 08:42:20 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', '--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-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:42:20 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 --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-060 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:42:20 INFO - Using env: {'DISPLAY': ':0', 08:42:20 INFO - 'HOME': '/home/cltbld', 08:42:20 INFO - 'LANG': 'en_US.UTF-8', 08:42:20 INFO - 'LANGUAGE': 'en_US:en', 08:42:20 INFO - 'LOGNAME': 'cltbld', 08:42:20 INFO - 'MAIL': '/var/mail/cltbld', 08:42:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:42:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:42:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:20 INFO - 'MOZ_NO_REMOTE': '1', 08:42:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:42:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:20 INFO - 'NO_EM_RESTART': '1', 08:42:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:20 INFO - 'PWD': '/builds/slave/test', 08:42:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:42:20 INFO - 'SHELL': '/bin/bash', 08:42:20 INFO - 'SHLVL': '1', 08:42:20 INFO - 'TERM': 'linux', 08:42:20 INFO - 'TMOUT': '86400', 08:42:20 INFO - 'USER': 'cltbld', 08:42:20 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466004780.56551-2130069505', 08:42:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:20 INFO - '_': '/tools/buildbot/bin/python'} 08:42:20 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', '--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-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:42:21 INFO - mozversion application_buildid: 20160615080629 08:42:21 INFO - mozversion application_changeset: 153553aecf160632bbcb50906ba135511da138e6 08:42:21 INFO - mozversion application_display_name: Nightly 08:42:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:42:21 INFO - mozversion application_name: Firefox 08:42:21 INFO - mozversion application_remotingname: firefox 08:42:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:42:21 INFO - mozversion application_vendor: Mozilla 08:42:21 INFO - mozversion application_version: 50.0a1 08:42:21 INFO - mozversion platform_buildid: 20160615080629 08:42:21 INFO - mozversion platform_changeset: 153553aecf160632bbcb50906ba135511da138e6 08:42:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:42:21 INFO - mozversion platform_version: 50.0a1 08:42:21 INFO - using testdate: 1466005341 08:42:21 INFO - actual date: 1466005341 08:42:21 INFO - starting webserver on 'localhost:56704' 08:42:21 INFO - SUITE-START | Running 2 tests 08:42:21 INFO - TEST-START | dromaeo_css 08:42:21 INFO - operating with platform_type : linux_ 08:42:21 INFO - Initialising browser for dromaeo_css test... 08:42:21 INFO - TEST-INFO | started process 15195 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFIRnqI/profile http://localhost:56704/getInfo.html) 08:42:25 INFO - PROCESS | 15195 | __metrics Screen width/height:1600/1200 08:42:25 INFO - PROCESS | 15195 | colorDepth:24 08:42:25 INFO - PROCESS | 15195 | Browser inner width/height: 1024/697 08:42:25 INFO - PROCESS | 15195 | __metrics 08:42:26 INFO - PROCESS | 15195 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:42:26 INFO - PROCESS | 15195 | console.error: PushService: 08:42:26 INFO - PROCESS | 15195 | stateChangeProcessEnqueue: Error transitioning state 08:42:26 INFO - PROCESS | 15195 | UnknownError 08:42:27 INFO - TEST-INFO | 15195: exit 0 08:42:27 INFO - Browser initialized. 08:42:27 INFO - Running cycle 1/1 for dromaeo_css test... 08:42:27 INFO - TEST-INFO | started process 15277 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFIRnqI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:42:39 INFO - PROCESS | 15277 | RSS: Main: 175370240 08:42:39 INFO - PROCESS | 15277 | 08:43:30 INFO - PROCESS | 15277 | 1466005410550 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:43 INFO - PROCESS | 15277 | Cycle 1(1): loaded http://localhost:56704/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56704/tests/dromaeo/cssquery-ext.html) 08:45:44 INFO - PROCESS | 15277 | RSS: Main: 288886784 08:45:44 INFO - PROCESS | 15277 | 08:48:46 INFO - PROCESS | 15277 | Cycle 1(1): loaded http://localhost:56704/tests/dromaeo/cssquery-ext.html (next: http://localhost:56704/tests/dromaeo/cssquery-jquery.html) 08:48:47 INFO - PROCESS | 15277 | RSS: Main: 262250496 08:48:47 INFO - PROCESS | 15277 | 08:51:49 INFO - PROCESS | 15277 | Cycle 1(1): loaded http://localhost:56704/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56704/tests/dromaeo/cssquery-mootools.html) 08:51:50 INFO - PROCESS | 15277 | RSS: Main: 261083136 08:51:50 INFO - PROCESS | 15277 | 08:54:52 INFO - PROCESS | 15277 | Cycle 1(1): loaded http://localhost:56704/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56704/tests/dromaeo/cssquery-prototype.html) 08:54:53 INFO - PROCESS | 15277 | RSS: Main: 253018112 08:54:53 INFO - PROCESS | 15277 | 08:57:56 INFO - PROCESS | 15277 | Cycle 1(1): loaded http://localhost:56704/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56704/tests/dromaeo/cssquery-yui.html) 08:57:56 INFO - PROCESS | 15277 | RSS: Main: 238751744 08:57:56 INFO - PROCESS | 15277 | 09:00:59 INFO - PROCESS | 15277 | Cycle 1(1): loaded http://localhost:56704/tests/dromaeo/cssquery-yui.html (next: http://localhost:56704/tests/dromaeo/cssquery-dojo.html) 09:01:00 INFO - PROCESS | 15277 | RSS: Main: 332861440 09:01:00 INFO - PROCESS | 15277 | 09:01:00 INFO - PROCESS | 15277 | __start_tp_report 09:01:00 INFO - PROCESS | 15277 | _x_x_mozilla_page_load 09:01:00 INFO - PROCESS | 15277 | _x_x_mozilla_page_load_details 09:01:00 INFO - PROCESS | 15277 | |i|pagename|runs| 09:01:00 INFO - PROCESS | 15277 | |0;dojo.html;2585.689717233932;2603.8828252728626;2606.960895586568;2636.7626913577774;2643.656324677793;4433.179861725583;4473.955260447395;4608.677392582516;4615.238485649864;4681.6020638245745;4595.954040459595;4623.768811559417;4634.165850146972;4674.766261686919;4721.079389519045;4283.100548884738;4309.612134907858;4330.97834510827;4386.166628340621;4507.076049409863;4397.802098905557;4452.710573812708;4452.933206001912;4472.865814025585;4488.8877778055485;4236.322188449864;4252.277112890816;4284.67864910133;4289.099289149282;4300.204462174492;4283.485981682218;4288.485381754178;4290.377895205178;4298.914021719579;4344.261475549132;4313.719608225455;4335.328024156261;4337.631301339358;4373.103513779667;4379.956200438019;4520.434945631796;4614.077184563067;4662.440507139131;4721.173794585934;4758.238681810928;5062.0888240116765;5070.847874563769;5074.517920797518;5077.669951453144;5080.1617733074;5069.898602027975;5077.416097148838;5084.313617661605;5094.032133894548;5095.770690318945;4550.544945505423;4710.552497512731;4738.4550776660435;4763.571278584875;4768.356271903318;5224.582033437316;5239.580833533309;5311.229871668586;5312.1766126250495;5313;5037.4458809530925;5078.13671675816;5079.796808127708;5082.237664350377;5083.8983220335385;4884.3161957326;5007.349044624176;5059.038782631288;5072.036313100499;5101.744912754348;5020.472850350734;5055.823046193365;5059.06407314648;5061.8228362007885;5114.156164232934;4859.319695242669;5038.899222015539;5057.8735531612;5061.772220250097;5062.240663900445;4261.10516791471;4291.163223171452;4295.3771703102875;4313.892152696208;4362.21480133579;3735.8879233623034;3754.0427191066105;3764.981175094107;3790.8483660653264;3799.772013679188;4188.225178342016;4333.285007973649;4338.891527711769;4385.561443855589;4390.978045109818;4958.305837182797;4998.775055122455;5033.924491132636;5045.31888195089;5078.187490001582;4308.849190278325;4316.762578058174;4327.091310824699;4334.046509767846;4366.956330436655;4392.209402307615;4545.2954792007295;4548.977255113703;4564.612007979293;4595.793189306489;4703.3885594872445;4734.928976065293;4742.644301677319;4762.95237047639;4767.070421267819;5025.145725226647;5046.47012063728;5080.060188865072;5081.44104148536;5126.615503837153;4526;4717.481077081587;4748.192807222711;4767.815748149228;4800.543948324904;4940.901181976412;4954.851354459372;4958.157113290677;4982.526659967298;5005.6996580205305;5010.123228435083;5023.598112151092;5025.974870125626;5026.648134630541;5079.466656001066;4852.1508735971765;4866.245731911559;4869.951300487091;4884.48712885142;4937.28409380645;4871.244957031666;4896.436909755281;4913.3121363008495;4923.359963204761;4966.776495057658;4835.492273311252;4844.15227335222;4845.927311090266;4913.48408417111;4914.115459217375;4748.477667456508;4867.902641947212;4906.362172917497;5025.74871256443;5037.622178336566;4834.323194752667;4845.030993801183;4854.077725232195;4861.076395484988;4914.901701966012 09:01:00 INFO - PROCESS | 15277 | |1;ext.html;536.7984232784322;586.0681516388944;586.7535635033286;593.2702775586029;608.9421504957029;26015.479690406206;28926;28955.420891582155;28973.56539651907;28979.27551811203;28786;29422.264443388925;38901;40057.19885602294;40081.19837603254;7782.571958542278;7906;7913.169117242693;7916.208379162066;7919.693250613642;7807.492512986666;7878.369730421581;7883.724069657563;7887.211278872095;7892.250236227578;7692.769216923473;10084.344517606369;10312.226583006268;10328.690139295833;10741.892581074168;10081.546330415113;10150.289479736348;10153.340032897875;10156.339837910513;10158.542865571068;7644.732434364826;9804;9869.506524673809;10176.491175441199;10178.847317290247;35330;38303.61696383028;38458.230835383416;38465.269062892236;38625.806870965745;3184.85668144934;3189.9202519936957;3232.612086549629;3554.5379100717;3583.7133029357587;28862.71137288642;29220;30138.54792178119;30377.24056898573;30850.38299234025;3488.232588830453;3536.3634545781747;3537.8584856605703;3560.359135355635;3580.1407662160896;233723.8313808437;234506;235052;235465;235837;51074;51445.48554514482;51563.74218128886;51616.99999999925;51675.22487162695;54341.72829135829;54418.45581544213;54496;54505;54580;13920.095193812369;14294.213818240096;14311;14358.138511689333;14396.712065758626;10530.15758739299;10611.469426528643;10646.307989980627;10670.30643008202;10774.19193560486;13251.867481325256;14602.56192314211;14853.405863765545;15181.468648597245;15320.463783767515;6255;6290.182276304051;6359.6184228945485;6369.235691716931;6514.315996820361;835.5738573327646;918.1461241045891;920.3419555018194;940.9931373430501;1017.4861694844057;26203.868980654974;27131.728682713314;27609.171724848286;27631.861840690668;27810.443791124468;920.3143657974852;929.7768535551419;985.2118305355687;995.9393246192926;1024.6823484719762;14703.92648036753;14787.038842475205;14825.216761200241;14916.477923272634;15009.699806003819;364559;364898;366155;367350;368048;49057.509424906006;49132.50867491351;49184.75407623011;49237.753811230716;49268.75365623149;1203.628761960562;1210.03197442046;1233.340163012784;1236.2767780848305;1241.2986662535639;24842.627360589966;26126;26336.34159146037;26425.33936651599;26764.866175668998;41272;41736.58263417448;42004;42116.1576768469;42133.367999480644;316027;318509;318958;318994;319133;34985;36370.09074773152;37021.25957480782;37040;37045.44431833579;33055.33889322152;35138.12154696051;42155.57844421516;45947.540524594326;47003.52996469991;34328.31343373169;36219;36823.26353472969;37205;37675.43486847645;35778;36077.45883811692;36351;36474.45288320624;36780.26439471249;35044.64955350516;35330;35641.82179089088;35707.64292357147;35841.28317433689;31383.84308078445;32469.35061298808;32638.51042234321;32683;32825.50761738623;24289;24621;24714.876425618477;24860.12989545357;24992.250232493054 09:01:00 INFO - PROCESS | 15277 | |2;jquery.html;365.1400950760958;372.20162750899306;372.6608786004736;381.4354754962653;387.14827379764506;15681.686366272683;16804.159792010396;17052.403165889198;17161.141942902836;17186.484405467825;16121.677566448694;16376.75434868475;17216.655666886654;17228.741568876445;17298.13509324532;5095.312132862072;5242.947570524303;5246.580273578104;5277.947220527803;5290.629655924087;3777.508923839897;3982.6614737747327;4931.334269873575;5859.472647461727;6183.319834818189;6185.814425567218;6187.041008643645;6198.256209254896;6204.565680402374;6207.099970504274;5965.4929331006915;6122.448979591836;6144.539159563006;6150.907736383958;6189.783357582485;3420.538227339302;4980.377452818398;5269.604779641504;5278.102722537178;5380.650257733235;19441.80558194428;20022.1991120355;20049.799502005084;20570.38288851322;20608;1918.9232430702755;1988.7514060742408;1989.2983301619122;2069.4412508622736;2273.897674604647;6016.729247183887;6051.092336149569;7066.869300911881;13007.86992130076;13212.471501139942;1707.795064592257;1765.7086580714167;1785.4911350265113;1836.7520384748022;1857.7770667519985;63741.36258637447;63933;64269.357306426806;64389.356106438805;65530.672346638436;8305.169483051646;8781.51701656415;8905.243054340453;9067.093290671011;9079.591418386188;11903.404829758478;11903.70240743971;11996.64010079699;12000.579979700844;12016.459259333351;6908.412784913238;6932.133483314586;6983.615901125385;6989.825254368681;7094.290570942968;6813.216480104752;6878.174619045646;6895.793126206222;6902.792916212522;7030.121234845645;3757.887263382103;3811.3330167220624;3813.180166264211;3828.942565861514;3830.2531006453473;1685.5196269063504;1767.1959258537336;1809.0592891696244;1811.3479147506887;1871;771.4021633234177;810.9918900811034;886.2156991062956;925.5881132895931;944.390867890207;15771.605709857346;16235.269412876449;16323.428679996143;17379.304827807;17386.21762020712;806.9394795390252;851.8168593752249;852.5737131434283;862.3575436299872;921.861720741894;8822.51476168804;8925.598348074353;9167.17495425415;9246.4914429707;9535.90464095364;377608;389004;389924;391377;392459;76958;76999;77090;78897.21102789014;79053.20946790573;810.5420437452821;859.9011113721876;884.8849649545647;888.1207604471656;889.4307643108416;14514.637134071732;15555.511118221482;15904.920475397548;16289.104099274653;16345.427910023092;35619.82190089033;36523.269534608626;36614;37815.62184378121;38639;47965.28052079291;48323.51676483331;49698.75150624224;50181.498185017685;50342.748286258335;6500.447461965786;6653.800385988428;6663.900041499284;6936.167659880846;7637.121731001006;10816.296940698829;11533.942330288295;11830.46762895689;11873.109516786448;11925.045996320447;9958.452285124387;10046.497675116068;10141.49292535385;10303.175745940456;10427.895721042996;10135.847962280424;10386.948065259625;10446.895531044896;10474.214433917334;10543.894561054598;10105.24210684187;10141.594336226763;10514.842277365693;10555.788884222426;10603.469826508797;6734.8653026940165;6856.283276923239;6894.931050689429;6976.546524476096;7143.678534466066;7855.5286682799215;9362.391444556082;9607.51962401863;10138.23963202748;10175.542100605342 09:01:00 INFO - PROCESS | 15277 | |3;mootools.html;1127.8702949160843;1137.4597066393465;1243.5771837575235;1286.813412055252;1610.9113998730072;7026.508144429892;7295.124585049794;7340;7359.632018399078;7467.365273951721;7309.926900730991;7403.148637906643;7445.292697193758;7482.326590606845;7484.139323977731;1893.8579606529497;1956.9902150489227;1958.3635318521467;2177.8039976402083;2217.667349897512;1949.4501871012508;2161.4812445013163;2238.8992495337748;2240.372695645222;2254.075828910139;2198.8016530990567;2217.0466699319286;2238.485148415857;2239.1491233331312;2239.4177513846353;1794.7666803315485;2097.0982477534653;2107.5468774213464;2110.598986192626;2113.598416300898;2083.6978638097544;2153.3432303147533;2154.310620601408;2167.512309730314;2168.046059733712;7243.637818109073;7280.2719728027305;7307.634618269119;7310.926890731131;7311.926880731178;4542.545745425431;4679.836205732783;4680.485146633868;4682.765861706901;4684.882877928045;2832.9150125496267;2867.2975121095465;2942.7057294270403;2944.440556294297;2997.730204281603;901.9639214431414;913.3423934766957;914.1818072824851;929.2194556572512;948.9240860731124;10114.898851011469;10141.594336226543;10164.440955747357;10186.439745813977;10217.131543818785;4097.160082183145;4110.095778928631;4204.684648651363;4208.347706105558;4208.831646734157;8528.488290702579;8635.870461943075;8663.48019118855;8673.913260867437;8781.736547903573;4582.037772067836;4609.700369475973;4628.5371462853445;4643.74459404736;4648.628109751212;3632.164602141522;3749.5125633667994;4134.793260336971;4221.472315960505;4223.028703398236;3509.4911237870874;3621.5473065866768;3705.5923848376656;3705.6850167735506;3719.4420836874683;1138.6185627814775;1177.8292147638545;1189.9583514576948;1193.8806119388166;1206.3847437806605;746.2388363868823;752.3943225703362;785.4565778245775;808.9474184178009;813.4834380168636;4842.806287748521;4856.854294371175;4892.730899800546;4916.827911023097;5005.274235235943;375.7689021251965;382.7569493371673;404.17951558336625;411.51030273974476;426.0477832045376;3267.918302042468;3342.014105838735;3353.413152698268;3626.8549258029384;3753.9624603753614;9035.683751068682;9161.221296189899;9248.537573121317;9284.978652348236;9288.860667089999;8195.303399211134;8551.059383467813;9229.446233226028;9246.306527010502;9252.352335336596;6825.795226143224;6891.793246202622;6971;7010;7014.859702806018;5117.820876269461;5121.974390128025;5309;5452.645578037414;5468.835934921959;8323.41736078493;8521.87217191755;8558.358123140664;8624.482531048157;8630.050694423482;8695.478271303742;8758.211760941545;8808.735737927873;8840.911590884009;8898.777530561787;5859.707014649336;6284.748610055546;6534.4772418205475;6601.768938087144;6754.5609535380045;7364.705411783469;7413.221611730691;7437.107547094383;7501.324880760758;7506.587137707478;6374.681265936591;6583.814913315649;6603.603783772989;6687.331266873273;6698.56459330142;6467.935320646733;6521.739130434729;6531.379518945692;6658.43403310724;6687.899681504684;6088.4215999479975;6154.815355539341;6160.876782464236;6163.322034576104;6168.25980882297;4205.810738516835;4286.335617979218;4312.9137417252105;4327.567243275647;4342.565743425758;4189.832406703697;4297.033167537279;4302.770670950541;4327.134573085458;4489.371487991619 09:01:00 INFO - PROCESS | 15277 | |4;prototype.html;299.7736708784866;305.07714164651924;309.7521982414068;312.25371362443747;314.17215636797044;4716.221823399135;4852.320675105488;4883.804647814088;4940.876478088049;4973.900521989558;4626;4792.962990728944;4834.63740219484;4842.249451335048;4853.344798452208;3842.711796615251;3850.8074596270144;3859.4017927221325;3861.7876016819064;3875.61243875613;3615.529981102453;3680.3191409589176;3825.5409350877935;3860.3244432224387;3867.690584753213;3774.7920665387087;3806.1245913439925;3815.618438156176;3818.3508803503332;3819.2934307153128;3766.905827354324;3779.659830615244;3799.4300854871713;3803.8858834235016;3853.6339047790416;3394.3381040697072;3404.8297585120645;3405.9829700851583;3411.1131105912395;3417.2311229973056;4620.422447194101;4709.317149013408;4712.175369310357;4719.126961512131;4750.928736068961;4343.587359200871;4350.673699472521;4370.781460926973;4383.824647014116;4388.868333949987;5101.591872650179;5109.8722531937;5113.923291150636;5118.436971933084;5121.513456221653;3512.771669841478;3671.724620653462;3703.777753341391;3720.646538578858;3726.5341832270965;5363.222332761728;5382.111951527993;5395.244665746799;5403.2165336026055;5428.104362780176;3831.63599458051;3841.846326146923;3851.345271303885;3852.9807350963624;3858.479105320802;3782.867599634;3835.7890316032326;3903.902402439962;3905.1603905160528;3907.1013666856215;4306.80619372129;4318.265894797829;4327.485380116934;4335.414719012956;4343.674224433117;5066.417362003343;5077.847664570068;5079.923801142986;5099.9490005100215;5101.948980510221;1265.6835791052238;1290.1227165527343;1292.9288889111;1298.8246586710861;1312.4290933443983;848.1942154952819;926.0924294191595;930.0978051290238;941.87755591774;943.3962264150949;4452.75136056296;4457.286834106528;4458.016182798623;4463.486699029589;4471.709338892962;5216.765245563959;5220.112580861262;5221.947780522222;5236.633435659467;5252.107141785906;4306.827726890952;4467.329900514884;4477.820887164542;4494.932331127718;4495.145922274823;2773.3898542320658;2783.9025634103114;2787.428577141681;2787.958180627292;2822.929426764347;4858.493866901272;4864.683795553277;4879.658423910363;4886.486918873538;4887.657863949489;5104.9744751276;5300.814471493556;5307.469253074739;5352.4915133062295;5394.946050539523;4940.135476291706;4944.901101978012;4962.6774259673;4983.551480366785;4984.8753781155765;5277.366715994105;5299.284596579412;5307.230451584422;5309.65487243328;5336.573074154136;4991.550760431579;5203.505666961632;5218.747500599905;5224.895502090013;5225.320708308048;4962;4966.975165124151;4977.303177555217;4996.526024822759;5022.493252024451;3835.8273877675015;3847.134394761268;3878.8836334909997;3894.883153505399;3899.7075219358094;5050.924236136388;5078.390593128848;5204.386640141568;5260.684358938476;5364.624476286778;5028.949710502849;5157.266648676207;5161.793528258828;5188.507091826271;5190.325257716473;5131.56381707559;5139.229115632685;5170.71561064145;5173.904568649703;5174.353205849269;4775.928361074517;5015.423226329019;5065.620078494054;5071.6416866157415;5083.644144909968;5152.639315248047;5169.457206993212;5179.249008893765;5187.559057480156;5196.766145523537;5038.521340472649;5065.468125846733;5068.26510156018;5082.517160869711;5091.465396133352 09:01:00 INFO - PROCESS | 15277 | |5;yui.html;638.0365647871715;664.8969409741492;674.2919934069223;685.3044160177418;693.2651389527101;12471.314077725721;13675.179489230653;14030.298485075757;14056.648583785398;14060.156390616545;12517.18638288513;12784.872151278507;12803.615891523246;12810.551630692928;12828.743425131492;625.9436650701437;756.1568850731436;764.1632412508294;764.6215123513869;768.1742127213269;767.3669222891109;775.7711475114854;776.1113525013856;776.5379599138504;776.638862928738;807.3299161695808;812.4312980913355;813.3168138763438;813.9552324622143;814.0191069760954;656.74715234635;802.1056521977953;807.7536351412816;808.5027707959621;809.3039985612369;587.5798803855264;588.1266319515516;588.8174665853556;589.932157801854;590.7075997381281;13150;13159.86840131596;13200.603981880558;13211.735765284737;13224.206547607078;12022.819657705142;12335;12629.43167557462;12631.91366734905;13419.194848309035;11778.352190629512;12033.217840840318;12248.693782655415;12307.938460307641;12414.131010829245;4182.184474027566;4193.769342686151;4207.158568286355;4255.5744425557505;4300.80646370914;49672.25491617629;52168.47831521712;52252.21621675678;58627;68605.65697171532;10525.10536604382;10568.788624227473;10601.787964240671;10627.096696780705;10683.412412317397;18889.149988250563;18892.622147556973;18912.43262702121;18931.14809833561;18938.24247030131;7084.504084714124;7139.178994415604;7148.428125749928;7273.418126549864;7484.550926944292;3752.568454627698;3850.1914597934187;3876;3887.8639247626197;3932.390479475686;2907.0697376839207;3000.984995075011;3016.592759977375;3017.3965206958696;3017.849107544614;517.3868965276159;526.6182018036892;537.1647088776912;545.6562365709577;545.7735039958372;439.1927219491768;503.83373486749286;564.7938502446659;567.2540609099021;569.834747923106;7140.6072666003865;7581;7665;7707.460477766503;7859.253370929752;539.9487048730364;545.1141894421565;578.6181120460476;585.1340016775112;588.1706793421341;3552.7335449841366;3585.838637261277;3622.3841946869097;3636.836342364547;3713;91151;94570.5271473652;95540;95845;97864.51067744616;82071.17928820755;82125;82996.17003830006;83031.5848420754;84762.5761871199;41694.37458438126;51733.7413312931;55928.44071559314;62010;65536.67231663906;8717.564121793757;8737.301015918583;8766.736997890073;8808.20726134651;8834.823303533765;40304.59695403009;40328.39507407333;40458;41124.588754113276;41243;54561.72719136379;56747.71626141843;57573.13640295483;58728;59371.40628593659;10921.976651143697;10950.780984380428;11317;11592.768144637228;11967.521299147937;12515.185298131537;12556.623301300975;12770;13134;13272;12155.87844121583;12427.537491741361;12594.937025314815;12616.116871819251;12773.297468639314;12118.878811212127;12165.57420490314;12429.378531073591;12577.371131443575;12577.496900123893;12445.066620003718;12697.047721420746;12882.871171288167;12884.291363975071;12930.935345323212;10148.911798396512;10640.574377024832;10741.677749667522;10836.729081773019;10883.401412922365;9617.759556011155;9718.296566009873;10174.856948840968;10619.469026548797;10661.786764264516 09:01:00 INFO - PROCESS | 15277 | __end_tp_report 09:01:00 INFO - PROCESS | 15277 | __start_cc_report 09:01:00 INFO - PROCESS | 15277 | _x_x_mozilla_cycle_collect,1126 09:01:00 INFO - PROCESS | 15277 | __end_cc_report 09:01:00 INFO - PROCESS | 15277 | __startTimestamp1466006460055__endTimestamp 09:01:00 INFO - PROCESS | 15277 | 09:01:00 INFO - PROCESS | 15277 | ------- Summary: start ------- 09:01:00 INFO - PROCESS | 15277 | Number of tests: 6 09:01:00 INFO - PROCESS | 15277 | 09:01:00 INFO - PROCESS | 15277 | [#0] dojo.html Cycles:165 Average:4660.56 Median:4767.07 stddev:496.42 (10.4%) stddev-sans-first:470.50 09:01:00 INFO - PROCESS | 15277 | Values: 2585.7 2603.9 2607.0 2636.8 2643.7 4433.2 4474.0 4608.7 4615.2 4681.6 4596.0 4623.8 4634.2 4674.8 4721.1 4283.1 4309.6 4331.0 4386.2 4507.1 4397.8 4452.7 4452.9 4472.9 4488.9 4236.3 4252.3 4284.7 4289.1 4300.2 4283.5 4288.5 4290.4 4298.9 4344.3 4313.7 4335.3 4337.6 4373.1 4380.0 4520.4 4614.1 4662.4 4721.2 4758.2 5062.1 5070.8 5074.5 5077.7 5080.2 5069.9 5077.4 5084.3 5094.0 5095.8 4550.5 4710.6 4738.5 4763.6 4768.4 5224.6 5239.6 5311.2 5312.2 5313.0 5037.4 5078.1 5079.8 5082.2 5083.9 4884.3 5007.3 5059.0 5072.0 5101.7 5020.5 5055.8 5059.1 5061.8 5114.2 4859.3 5038.9 5057.9 5061.8 5062.2 4261.1 4291.2 4295.4 4313.9 4362.2 3735.9 3754.0 3765.0 3790.8 3799.8 4188.2 4333.3 4338.9 4385.6 4391.0 4958.3 4998.8 5033.9 5045.3 5078.2 4308.8 4316.8 4327.1 4334.0 4367.0 4392.2 4545.3 4549.0 4564.6 4595.8 4703.4 4734.9 4742.6 4763.0 4767.1 5025.1 5046.5 5080.1 5081.4 5126.6 4526.0 4717.5 4748.2 4767.8 4800.5 4940.9 4954.9 4958.2 4982.5 5005.7 5010.1 5023.6 5026.0 5026.6 5079.5 4852.2 4866.2 4870.0 4884.5 4937.3 4871.2 4896.4 4913.3 4923.4 4966.8 4835.5 4844.2 4845.9 4913.5 4914.1 4748.5 4867.9 4906.4 5025.7 5037.6 4834.3 4845.0 4854.1 4861.1 4914.9 09:01:00 INFO - PROCESS | 15277 | 09:01:00 INFO - PROCESS | 15277 | [#1] ext.html Cycles:180 Average:46123.61 Median:19433.18 stddev:81790.34 (420.9%) stddev-sans-first:81948.17 09:01:00 INFO - PROCESS | 15277 | Values: 536.8 586.1 586.8 593.3 608.9 26015.5 28926.0 28955.4 28973.6 28979.3 28786.0 29422.3 38901.0 40057.2 40081.2 7782.6 7906.0 7913.2 7916.2 7919.7 7807.5 7878.4 7883.7 7887.2 7892.3 7692.8 10084.3 10312.2 10328.7 10741.9 10081.5 10150.3 10153.3 10156.3 10158.5 7644.7 9804.0 9869.5 10176.5 10178.8 35330.0 38303.6 38458.2 38465.3 38625.8 3184.9 3189.9 3232.6 3554.5 3583.7 28862.7 29220.0 30138.5 30377.2 30850.4 3488.2 3536.4 3537.9 3560.4 3580.1 233723.8 234506.0 235052.0 235465.0 235837.0 51074.0 51445.5 51563.7 51617.0 51675.2 54341.7 54418.5 54496.0 54505.0 54580.0 13920.1 14294.2 14311.0 14358.1 14396.7 10530.2 10611.5 10646.3 10670.3 10774.2 13251.9 14602.6 14853.4 15181.5 15320.5 6255.0 6290.2 6359.6 6369.2 6514.3 835.6 918.1 920.3 941.0 1017.5 26203.9 27131.7 27609.2 27631.9 27810.4 920.3 929.8 985.2 995.9 1024.7 14703.9 14787.0 14825.2 14916.5 15009.7 364559.0 364898.0 366155.0 367350.0 368048.0 49057.5 49132.5 49184.8 49237.8 49268.8 1203.6 1210.0 1233.3 1236.3 1241.3 24842.6 26126.0 26336.3 26425.3 26764.9 41272.0 41736.6 42004.0 42116.2 42133.4 316027.0 318509.0 318958.0 318994.0 319133.0 34985.0 36370.1 37021.3 37040.0 37045.4 33055.3 35138.1 42155.6 45947.5 47003.5 34328.3 36219.0 36823.3 37205.0 37675.4 35778.0 36077.5 36351.0 36474.5 36780.3 35044.6 35330.0 35641.8 35707.6 35841.3 31383.8 32469.4 32638.5 32683.0 32825.5 24289.0 24621.0 24714.9 24860.1 24992.3 09:01:00 INFO - PROCESS | 15277 | 09:01:00 INFO - PROCESS | 15277 | [#2] jquery.html Cycles:180 Average:23920.13 Median:25973.97 stddev:64045.43 (246.6%) stddev-sans-first:64200.67 09:01:00 INFO - PROCESS | 15277 | Values: 365.1 372.2 372.7 381.4 387.1 15681.7 16804.2 17052.4 17161.1 17186.5 16121.7 16376.8 17216.7 17228.7 17298.1 5095.3 5242.9 5246.6 5277.9 5290.6 3777.5 3982.7 4931.3 5859.5 6183.3 6185.8 6187.0 6198.3 6204.6 6207.1 5965.5 6122.4 6144.5 6150.9 6189.8 3420.5 4980.4 5269.6 5278.1 5380.7 19441.8 20022.2 20049.8 20570.4 20608.0 1918.9 1988.8 1989.3 2069.4 2273.9 6016.7 6051.1 7066.9 13007.9 13212.5 1707.8 1765.7 1785.5 1836.8 1857.8 63741.4 63933.0 64269.4 64389.4 65530.7 8305.2 8781.5 8905.2 9067.1 9079.6 11903.4 11903.7 11996.6 12000.6 12016.5 6908.4 6932.1 6983.6 6989.8 7094.3 6813.2 6878.2 6895.8 6902.8 7030.1 3757.9 3811.3 3813.2 3828.9 3830.3 1685.5 1767.2 1809.1 1811.3 1871.0 771.4 811.0 886.2 925.6 944.4 15771.6 16235.3 16323.4 17379.3 17386.2 806.9 851.8 852.6 862.4 921.9 8822.5 8925.6 9167.2 9246.5 9535.9 377608.0 389004.0 389924.0 391377.0 392459.0 76958.0 76999.0 77090.0 78897.2 79053.2 810.5 859.9 884.9 888.1 889.4 14514.6 15555.5 15904.9 16289.1 16345.4 35619.8 36523.3 36614.0 37815.6 38639.0 47965.3 48323.5 49698.8 50181.5 50342.7 6500.4 6653.8 6663.9 6936.2 7637.1 10816.3 11533.9 11830.5 11873.1 11925.0 9958.5 10046.5 10141.5 10303.2 10427.9 10135.8 10386.9 10446.9 10474.2 10543.9 10105.2 10141.6 10514.8 10555.8 10603.5 6734.9 6856.3 6894.9 6976.5 7143.7 7855.5 9362.4 9607.5 10138.2 10175.5 09:01:00 INFO - PROCESS | 15277 | 09:01:00 INFO - PROCESS | 15277 | [#3] mootools.html Cycles:180 Average:4940.24 Median:4849.83 stddev:2754.49 (56.8%) stddev-sans-first:2747.32 09:01:00 INFO - PROCESS | 15277 | Values: 1127.9 1137.5 1243.6 1286.8 1610.9 7026.5 7295.1 7340.0 7359.6 7467.4 7309.9 7403.1 7445.3 7482.3 7484.1 1893.9 1957.0 1958.4 2177.8 2217.7 1949.5 2161.5 2238.9 2240.4 2254.1 2198.8 2217.0 2238.5 2239.1 2239.4 1794.8 2097.1 2107.5 2110.6 2113.6 2083.7 2153.3 2154.3 2167.5 2168.0 7243.6 7280.3 7307.6 7310.9 7311.9 4542.5 4679.8 4680.5 4682.8 4684.9 2832.9 2867.3 2942.7 2944.4 2997.7 902.0 913.3 914.2 929.2 948.9 10114.9 10141.6 10164.4 10186.4 10217.1 4097.2 4110.1 4204.7 4208.3 4208.8 8528.5 8635.9 8663.5 8673.9 8781.7 4582.0 4609.7 4628.5 4643.7 4648.6 3632.2 3749.5 4134.8 4221.5 4223.0 3509.5 3621.5 3705.6 3705.7 3719.4 1138.6 1177.8 1190.0 1193.9 1206.4 746.2 752.4 785.5 808.9 813.5 4842.8 4856.9 4892.7 4916.8 5005.3 375.8 382.8 404.2 411.5 426.0 3267.9 3342.0 3353.4 3626.9 3754.0 9035.7 9161.2 9248.5 9285.0 9288.9 8195.3 8551.1 9229.4 9246.3 9252.4 6825.8 6891.8 6971.0 7010.0 7014.9 5117.8 5122.0 5309.0 5452.6 5468.8 8323.4 8521.9 8558.4 8624.5 8630.1 8695.5 8758.2 8808.7 8840.9 8898.8 5859.7 6284.7 6534.5 6601.8 6754.6 7364.7 7413.2 7437.1 7501.3 7506.6 6374.7 6583.8 6603.6 6687.3 6698.6 6467.9 6521.7 6531.4 6658.4 6687.9 6088.4 6154.8 6160.9 6163.3 6168.3 4205.8 4286.3 4312.9 4327.6 4342.6 4189.8 4297.0 4302.8 4327.1 4489.4 09:01:00 INFO - PROCESS | 15277 | 09:01:00 INFO - PROCESS | 15277 | [#4] prototype.html Cycles:180 Average:4259.26 Median:4847.29 stddev:1224.76 (25.3%) stddev-sans-first:1191.59 09:01:00 INFO - PROCESS | 15277 | Values: 299.8 305.1 309.8 312.3 314.2 4716.2 4852.3 4883.8 4940.9 4973.9 4626.0 4793.0 4834.6 4842.2 4853.3 3842.7 3850.8 3859.4 3861.8 3875.6 3615.5 3680.3 3825.5 3860.3 3867.7 3774.8 3806.1 3815.6 3818.4 3819.3 3766.9 3779.7 3799.4 3803.9 3853.6 3394.3 3404.8 3406.0 3411.1 3417.2 4620.4 4709.3 4712.2 4719.1 4750.9 4343.6 4350.7 4370.8 4383.8 4388.9 5101.6 5109.9 5113.9 5118.4 5121.5 3512.8 3671.7 3703.8 3720.6 3726.5 5363.2 5382.1 5395.2 5403.2 5428.1 3831.6 3841.8 3851.3 3853.0 3858.5 3782.9 3835.8 3903.9 3905.2 3907.1 4306.8 4318.3 4327.5 4335.4 4343.7 5066.4 5077.8 5079.9 5099.9 5101.9 1265.7 1290.1 1292.9 1298.8 1312.4 848.2 926.1 930.1 941.9 943.4 4452.8 4457.3 4458.0 4463.5 4471.7 5216.8 5220.1 5221.9 5236.6 5252.1 4306.8 4467.3 4477.8 4494.9 4495.1 2773.4 2783.9 2787.4 2788.0 2822.9 4858.5 4864.7 4879.7 4886.5 4887.7 5105.0 5300.8 5307.5 5352.5 5394.9 4940.1 4944.9 4962.7 4983.6 4984.9 5277.4 5299.3 5307.2 5309.7 5336.6 4991.6 5203.5 5218.7 5224.9 5225.3 4962.0 4967.0 4977.3 4996.5 5022.5 3835.8 3847.1 3878.9 3894.9 3899.7 5050.9 5078.4 5204.4 5260.7 5364.6 5028.9 5157.3 5161.8 5188.5 5190.3 5131.6 5139.2 5170.7 5173.9 5174.4 4775.9 5015.4 5065.6 5071.6 5083.6 5152.6 5169.5 5179.2 5187.6 5196.8 5038.5 5065.5 5068.3 5082.5 5091.5 09:01:00 INFO - PROCESS | 15277 | 09:01:00 INFO - PROCESS | 15277 | [#5] yui.html Cycles:180 Average:16904.06 Median:4200.46 stddev:23317.09 (555.1%) stddev-sans-first:23350.51 09:01:00 INFO - PROCESS | 15277 | Values: 638.0 664.9 674.3 685.3 693.3 12471.3 13675.2 14030.3 14056.6 14060.2 12517.2 12784.9 12803.6 12810.6 12828.7 625.9 756.2 764.2 764.6 768.2 767.4 775.8 776.1 776.5 776.6 807.3 812.4 813.3 814.0 814.0 656.7 802.1 807.8 808.5 809.3 587.6 588.1 588.8 589.9 590.7 13150.0 13159.9 13200.6 13211.7 13224.2 12022.8 12335.0 12629.4 12631.9 13419.2 11778.4 12033.2 12248.7 12307.9 12414.1 4182.2 4193.8 4207.2 4255.6 4300.8 49672.3 52168.5 52252.2 58627.0 68605.7 10525.1 10568.8 10601.8 10627.1 10683.4 18889.1 18892.6 18912.4 18931.1 18938.2 7084.5 7139.2 7148.4 7273.4 7484.6 3752.6 3850.2 3876.0 3887.9 3932.4 2907.1 3001.0 3016.6 3017.4 3017.8 517.4 526.6 537.2 545.7 545.8 439.2 503.8 564.8 567.3 569.8 7140.6 7581.0 7665.0 7707.5 7859.3 539.9 545.1 578.6 585.1 588.2 3552.7 3585.8 3622.4 3636.8 3713.0 91151.0 94570.5 95540.0 95845.0 97864.5 82071.2 82125.0 82996.2 83031.6 84762.6 41694.4 51733.7 55928.4 62010.0 65536.7 8717.6 8737.3 8766.7 8808.2 8834.8 40304.6 40328.4 40458.0 41124.6 41243.0 54561.7 56747.7 57573.1 58728.0 59371.4 10922.0 10950.8 11317.0 11592.8 11967.5 12515.2 12556.6 12770.0 13134.0 13272.0 12155.9 12427.5 12594.9 12616.1 12773.3 12118.9 12165.6 12429.4 12577.4 12577.5 12445.1 12697.0 12882.9 12884.3 12930.9 10148.9 10640.6 10741.7 10836.7 10883.4 9617.8 9718.3 10174.9 10619.5 10661.8 09:01:00 INFO - PROCESS | 15277 | -------- Summary: end -------- 09:01:00 INFO - PROCESS | 15277 | 09:01:00 INFO - TEST-INFO | 15277: exit 0 09:01:00 INFO - TEST-OK | dromaeo_css | took 1119828ms 09:01:00 INFO - TEST-START | kraken 09:01:00 INFO - operating with platform_type : linux_ 09:01:00 INFO - Initialising browser for kraken test... 09:01:00 INFO - TEST-INFO | started process 15457 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps4Zg34/profile http://localhost:56704/getInfo.html) 09:01:05 INFO - PROCESS | 15457 | __metrics Screen width/height:1600/1200 09:01:05 INFO - PROCESS | 15457 | colorDepth:24 09:01:05 INFO - PROCESS | 15457 | Browser inner width/height: 1024/697 09:01:05 INFO - PROCESS | 15457 | __metrics 09:01:06 INFO - PROCESS | 15457 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:01:06 INFO - PROCESS | 15457 | console.error: PushService: 09:01:06 INFO - PROCESS | 15457 | stateChangeProcessEnqueue: Error transitioning state 09:01:06 INFO - PROCESS | 15457 | UnknownError 09:01:07 INFO - TEST-INFO | 15457: exit 0 09:01:07 INFO - Browser initialized. 09:01:07 INFO - Running cycle 1/1 for kraken test... 09:01:07 INFO - TEST-INFO | started process 15538 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps4Zg34/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:01:19 INFO - PROCESS | 15538 | RSS: Main: 174968832 09:01:19 INFO - PROCESS | 15538 | 09:01:22 INFO - PROCESS | 15538 | Cycle 1(1): loaded http://localhost:56704/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56704/tests/kraken/driver.html?testName=audio-beat-detection) 09:01:23 INFO - PROCESS | 15538 | RSS: Main: 232632320 09:01:23 INFO - PROCESS | 15538 | 09:01:26 INFO - PROCESS | 15538 | Cycle 1(1): loaded http://localhost:56704/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56704/tests/kraken/driver.html?testName=audio-dft) 09:01:26 INFO - PROCESS | 15538 | RSS: Main: 220278784 09:01:26 INFO - PROCESS | 15538 | 09:01:29 INFO - PROCESS | 15538 | Cycle 1(1): loaded http://localhost:56704/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56704/tests/kraken/driver.html?testName=audio-fft) 09:01:30 INFO - PROCESS | 15538 | RSS: Main: 288174080 09:01:30 INFO - PROCESS | 15538 | 09:01:32 INFO - PROCESS | 15538 | Cycle 1(1): loaded http://localhost:56704/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56704/tests/kraken/driver.html?testName=audio-oscillator) 09:01:33 INFO - PROCESS | 15538 | RSS: Main: 198737920 09:01:33 INFO - PROCESS | 15538 | 09:01:35 INFO - PROCESS | 15538 | Cycle 1(1): loaded http://localhost:56704/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56704/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:01:36 INFO - PROCESS | 15538 | RSS: Main: 202911744 09:01:36 INFO - PROCESS | 15538 | 09:01:39 INFO - PROCESS | 15538 | Cycle 1(1): loaded http://localhost:56704/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56704/tests/kraken/driver.html?testName=imaging-darkroom) 09:01:39 INFO - PROCESS | 15538 | RSS: Main: 238559232 09:01:39 INFO - PROCESS | 15538 | 09:01:43 INFO - PROCESS | 15538 | Cycle 1(1): loaded http://localhost:56704/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56704/tests/kraken/driver.html?testName=imaging-desaturate) 09:01:43 INFO - PROCESS | 15538 | RSS: Main: 234627072 09:01:43 INFO - PROCESS | 15538 | 09:01:46 INFO - PROCESS | 15538 | Cycle 1(1): loaded http://localhost:56704/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56704/tests/kraken/driver.html?testName=json-parse-financial) 09:01:47 INFO - PROCESS | 15538 | RSS: Main: 236965888 09:01:47 INFO - PROCESS | 15538 | 09:01:49 INFO - PROCESS | 15538 | Cycle 1(1): loaded http://localhost:56704/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56704/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:01:49 INFO - PROCESS | 15538 | RSS: Main: 226586624 09:01:49 INFO - PROCESS | 15538 | 09:01:51 INFO - PROCESS | 15538 | Cycle 1(1): loaded http://localhost:56704/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56704/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:01:52 INFO - PROCESS | 15538 | RSS: Main: 231436288 09:01:52 INFO - PROCESS | 15538 | 09:01:54 INFO - PROCESS | 15538 | Cycle 1(1): loaded http://localhost:56704/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56704/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:01:55 INFO - PROCESS | 15538 | RSS: Main: 238891008 09:01:55 INFO - PROCESS | 15538 | 09:01:57 INFO - PROCESS | 15538 | Cycle 1(1): loaded http://localhost:56704/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56704/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:01:58 INFO - PROCESS | 15538 | RSS: Main: 241250304 09:01:58 INFO - PROCESS | 15538 | 09:02:01 INFO - PROCESS | 15538 | Cycle 1(1): loaded http://localhost:56704/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56704/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:02:02 INFO - PROCESS | 15538 | RSS: Main: 239251456 09:02:02 INFO - PROCESS | 15538 | 09:02:03 INFO - PROCESS | 15538 | Cycle 1(1): loaded http://localhost:56704/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56704/tests/kraken/driver.html?testName=ai-astar) 09:02:04 INFO - PROCESS | 15538 | RSS: Main: 283111424 09:02:04 INFO - PROCESS | 15538 | 09:02:04 INFO - PROCESS | 15538 | __start_tp_report 09:02:04 INFO - PROCESS | 15538 | _x_x_mozilla_page_load 09:02:04 INFO - PROCESS | 15538 | _x_x_mozilla_page_load_details 09:02:04 INFO - PROCESS | 15538 | |i|pagename|runs| 09:02:04 INFO - PROCESS | 15538 | |0;ai-astar;113;109;113;115;115;116;115;116;114;114 09:02:04 INFO - PROCESS | 15538 | |1;audio-beat-detection;163;135;137;186;131;162;164;133;193;141 09:02:04 INFO - PROCESS | 15538 | |2;audio-dft;163;163;162;163;161;162;163;163;163;162 09:02:04 INFO - PROCESS | 15538 | |3;audio-fft;76;77;76;125;76;76;74;75;98;76 09:02:04 INFO - PROCESS | 15538 | |4;audio-oscillator;87;86;108;86;86;86;124;86;86;124 09:02:04 INFO - PROCESS | 15538 | |5;imaging-gaussian-blur;117;116;117;117;117;116;117;116;116;117 09:02:04 INFO - PROCESS | 15538 | |6;imaging-darkroom;147;146;147;146;145;146;146;146;145;146 09:02:04 INFO - PROCESS | 15538 | |7;imaging-desaturate;95;94;95;94;94;95;94;95;94;95 09:02:04 INFO - PROCESS | 15538 | |8;json-parse-financial;64;65;64;64;64;66;63;63;63;63 09:02:04 INFO - PROCESS | 15538 | |9;json-stringify-tinderbox;65;65;65;65;65;65;65;65;68;72 09:02:04 INFO - PROCESS | 15538 | |10;stanford-crypto-aes;84;84;83;82;84;84;84;89;117;84 09:02:04 INFO - PROCESS | 15538 | |11;stanford-crypto-ccm;135;131;142;128;132;130;137;137;137;133 09:02:04 INFO - PROCESS | 15538 | |12;stanford-crypto-pbkdf2;173;173;167;170;176;171;171;175;166;166 09:02:04 INFO - PROCESS | 15538 | |13;stanford-crypto-sha256-iterative;68;66;67;67;69;66;67;66;67;67 09:02:04 INFO - PROCESS | 15538 | __end_tp_report 09:02:04 INFO - PROCESS | 15538 | __start_cc_report 09:02:04 INFO - PROCESS | 15538 | _x_x_mozilla_cycle_collect,1864 09:02:04 INFO - PROCESS | 15538 | __end_cc_report 09:02:04 INFO - PROCESS | 15538 | __startTimestamp1466006524149__endTimestamp 09:02:04 INFO - PROCESS | 15538 | 09:02:04 INFO - PROCESS | 15538 | ------- Summary: start ------- 09:02:04 INFO - PROCESS | 15538 | Number of tests: 14 09:02:04 INFO - PROCESS | 15538 | 09:02:04 INFO - PROCESS | 15538 | [#0] ai-astar Cycles:10 Average:114.00 Median:115.00 stddev:2.05 (1.8%) stddev-sans-first:2.15 09:02:04 INFO - PROCESS | 15538 | Values: 113.0 109.0 113.0 115.0 115.0 116.0 115.0 116.0 114.0 114.0 09:02:04 INFO - PROCESS | 15538 | 09:02:04 INFO - PROCESS | 15538 | [#1] audio-beat-detection Cycles:10 Average:154.50 Median:162.50 stddev:22.55 (13.9%) stddev-sans-first:23.71 09:02:04 INFO - PROCESS | 15538 | Values: 163.0 135.0 137.0 186.0 131.0 162.0 164.0 133.0 193.0 141.0 09:02:04 INFO - PROCESS | 15538 | 09:02:04 INFO - PROCESS | 15538 | [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:0.71 (0.4%) stddev-sans-first:0.73 09:02:04 INFO - PROCESS | 15538 | Values: 163.0 163.0 162.0 163.0 161.0 162.0 163.0 163.0 163.0 162.0 09:02:04 INFO - PROCESS | 15538 | 09:02:04 INFO - PROCESS | 15538 | [#3] audio-fft Cycles:10 Average:82.90 Median:76.00 stddev:16.38 (21.6%) stddev-sans-first:17.18 09:02:04 INFO - PROCESS | 15538 | Values: 76.0 77.0 76.0 125.0 76.0 76.0 74.0 75.0 98.0 76.0 09:02:04 INFO - PROCESS | 15538 | 09:02:04 INFO - PROCESS | 15538 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:86.00 stddev:16.31 (19.0%) stddev-sans-first:16.97 09:02:04 INFO - PROCESS | 15538 | Values: 87.0 86.0 108.0 86.0 86.0 86.0 124.0 86.0 86.0 124.0 09:02:04 INFO - PROCESS | 15538 | 09:02:04 INFO - PROCESS | 15538 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 09:02:04 INFO - PROCESS | 15538 | Values: 117.0 116.0 117.0 117.0 117.0 116.0 117.0 116.0 116.0 117.0 09:02:04 INFO - PROCESS | 15538 | 09:02:04 INFO - PROCESS | 15538 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 09:02:04 INFO - PROCESS | 15538 | Values: 147.0 146.0 147.0 146.0 145.0 146.0 146.0 146.0 145.0 146.0 09:02:04 INFO - PROCESS | 15538 | 09:02:04 INFO - PROCESS | 15538 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 09:02:04 INFO - PROCESS | 15538 | Values: 95.0 94.0 95.0 94.0 94.0 95.0 94.0 95.0 94.0 95.0 09:02:04 INFO - PROCESS | 15538 | 09:02:04 INFO - PROCESS | 15538 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:64.00 stddev:0.99 (1.6%) stddev-sans-first:1.05 09:02:04 INFO - PROCESS | 15538 | Values: 64.0 65.0 64.0 64.0 64.0 66.0 63.0 63.0 63.0 63.0 09:02:04 INFO - PROCESS | 15538 | 09:02:04 INFO - PROCESS | 15538 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:65.00 stddev:2.31 (3.6%) stddev-sans-first:2.42 09:02:04 INFO - PROCESS | 15538 | Values: 65.0 65.0 65.0 65.0 65.0 65.0 65.0 65.0 68.0 72.0 09:02:04 INFO - PROCESS | 15538 | 09:02:04 INFO - PROCESS | 15538 | [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:84.00 stddev:10.52 (12.5%) stddev-sans-first:11.08 09:02:04 INFO - PROCESS | 15538 | Values: 84.0 84.0 83.0 82.0 84.0 84.0 84.0 89.0 117.0 84.0 09:02:04 INFO - PROCESS | 15538 | 09:02:04 INFO - PROCESS | 15538 | [#11] stanford-crypto-ccm Cycles:10 Average:134.20 Median:136.00 stddev:4.18 (3.1%) stddev-sans-first:4.43 09:02:04 INFO - PROCESS | 15538 | Values: 135.0 131.0 142.0 128.0 132.0 130.0 137.0 137.0 137.0 133.0 09:02:04 INFO - PROCESS | 15538 | 09:02:04 INFO - PROCESS | 15538 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.80 Median:172.00 stddev:3.58 (2.1%) stddev-sans-first:3.71 09:02:04 INFO - PROCESS | 15538 | Values: 173.0 173.0 167.0 170.0 176.0 171.0 171.0 175.0 166.0 166.0 09:02:04 INFO - PROCESS | 15538 | 09:02:04 INFO - PROCESS | 15538 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:0.94 (1.4%) stddev-sans-first:0.93 09:02:04 INFO - PROCESS | 15538 | Values: 68.0 66.0 67.0 67.0 69.0 66.0 67.0 66.0 67.0 67.0 09:02:04 INFO - PROCESS | 15538 | -------- Summary: end -------- 09:02:04 INFO - PROCESS | 15538 | 09:02:05 INFO - TEST-INFO | 15538: exit 0 09:02:05 INFO - TEST-OK | kraken | took 64395ms 09:02:05 INFO - SUITE-END | took 1184s 09:02:05 INFO - Completed test suite (00:19:44) 09:02:05 INFO - javascript benchmark 09:02:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2585.689717233932, 2603.8828252728626, 2606.960895586568, 2636.7626913577774, 2643.656324677793, 4433.179861725583, 4473.955260447395, 4608.677392582516, 4615.238485649864, 4681.6020638245745, 4595.954040459595, 4623.768811559417, 4634.165850146972, 4674.766261686919, 4721.079389519045, 4283.100548884738, 4309.612134907858, 4330.97834510827, 4386.166628340621, 4507.076049409863, 4397.802098905557, 4452.710573812708, 4452.933206001912, 4472.865814025585, 4488.8877778055485, 4236.322188449864, 4252.277112890816, 4284.67864910133, 4289.099289149282, 4300.204462174492, 4283.485981682218, 4288.485381754178, 4290.377895205178, 4298.914021719579, 4344.261475549132, 4313.719608225455, 4335.328024156261, 4337.631301339358, 4373.103513779667, 4379.956200438019, 4520.434945631796, 4614.077184563067, 4662.440507139131, 4721.173794585934, 4758.238681810928, 5062.0888240116765, 5070.847874563769, 5074.517920797518, 5077.669951453144, 5080.1617733074, 5069.898602027975, 5077.416097148838, 5084.313617661605, 5094.032133894548, 5095.770690318945, 4550.544945505423, 4710.552497512731, 4738.4550776660435, 4763.571278584875, 4768.356271903318, 5224.582033437316, 5239.580833533309, 5311.229871668586, 5312.1766126250495, 5313.0, 5037.4458809530925, 5078.13671675816, 5079.796808127708, 5082.237664350377, 5083.8983220335385, 4884.3161957326, 5007.349044624176, 5059.038782631288, 5072.036313100499, 5101.744912754348, 5020.472850350734, 5055.823046193365, 5059.06407314648, 5061.8228362007885, 5114.156164232934, 4859.319695242669, 5038.899222015539, 5057.8735531612, 5061.772220250097, 5062.240663900445, 4261.10516791471, 4291.163223171452, 4295.3771703102875, 4313.892152696208, 4362.21480133579, 3735.8879233623034, 3754.0427191066105, 3764.981175094107, 3790.8483660653264, 3799.772013679188, 4188.225178342016, 4333.285007973649, 4338.891527711769, 4385.561443855589, 4390.978045109818, 4958.305837182797, 4998.775055122455, 5033.924491132636, 5045.31888195089, 5078.187490001582, 4308.849190278325, 4316.762578058174, 4327.091310824699, 4334.046509767846, 4366.956330436655, 4392.209402307615, 4545.2954792007295, 4548.977255113703, 4564.612007979293, 4595.793189306489, 4703.3885594872445, 4734.928976065293, 4742.644301677319, 4762.95237047639, 4767.070421267819, 5025.145725226647, 5046.47012063728, 5080.060188865072, 5081.44104148536, 5126.615503837153, 4526.0, 4717.481077081587, 4748.192807222711, 4767.815748149228, 4800.543948324904, 4940.901181976412, 4954.851354459372, 4958.157113290677, 4982.526659967298, 5005.6996580205305, 5010.123228435083, 5023.598112151092, 5025.974870125626, 5026.648134630541, 5079.466656001066, 4852.1508735971765, 4866.245731911559, 4869.951300487091, 4884.48712885142, 4937.28409380645, 4871.244957031666, 4896.436909755281, 4913.3121363008495, 4923.359963204761, 4966.776495057658, 4835.492273311252, 4844.15227335222, 4845.927311090266, 4913.48408417111, 4914.115459217375, 4748.477667456508, 4867.902641947212, 4906.362172917497, 5025.74871256443, 5037.622178336566, 4834.323194752667, 4845.030993801183, 4854.077725232195, 4861.076395484988, 4914.901701966012], "value": 4628.523928636916, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [536.7984232784322, 586.0681516388944, 586.7535635033286, 593.2702775586029, 608.9421504957029, 26015.479690406206, 28926.0, 28955.420891582155, 28973.56539651907, 28979.27551811203, 28786.0, 29422.264443388925, 38901.0, 40057.19885602294, 40081.19837603254, 7782.571958542278, 7906.0, 7913.169117242693, 7916.208379162066, 7919.693250613642, 7807.492512986666, 7878.369730421581, 7883.724069657563, 7887.211278872095, 7892.250236227578, 7692.769216923473, 10084.344517606369, 10312.226583006268, 10328.690139295833, 10741.892581074168, 10081.546330415113, 10150.289479736348, 10153.340032897875, 10156.339837910513, 10158.542865571068, 7644.732434364826, 9804.0, 9869.506524673809, 10176.491175441199, 10178.847317290247, 35330.0, 38303.61696383028, 38458.230835383416, 38465.269062892236, 38625.806870965745, 3184.85668144934, 3189.9202519936957, 3232.612086549629, 3554.5379100717, 3583.7133029357587, 28862.71137288642, 29220.0, 30138.54792178119, 30377.24056898573, 30850.38299234025, 3488.232588830453, 3536.3634545781747, 3537.8584856605703, 3560.359135355635, 3580.1407662160896, 233723.8313808437, 234506.0, 235052.0, 235465.0, 235837.0, 51074.0, 51445.48554514482, 51563.74218128886, 51616.99999999925, 51675.22487162695, 54341.72829135829, 54418.45581544213, 54496.0, 54505.0, 54580.0, 13920.095193812369, 14294.213818240096, 14311.0, 14358.138511689333, 14396.712065758626, 10530.15758739299, 10611.469426528643, 10646.307989980627, 10670.30643008202, 10774.19193560486, 13251.867481325256, 14602.56192314211, 14853.405863765545, 15181.468648597245, 15320.463783767515, 6255.0, 6290.182276304051, 6359.6184228945485, 6369.235691716931, 6514.315996820361, 835.5738573327646, 918.1461241045891, 920.3419555018194, 940.9931373430501, 1017.4861694844057, 26203.868980654974, 27131.728682713314, 27609.171724848286, 27631.861840690668, 27810.443791124468, 920.3143657974852, 929.7768535551419, 985.2118305355687, 995.9393246192926, 1024.6823484719762, 14703.92648036753, 14787.038842475205, 14825.216761200241, 14916.477923272634, 15009.699806003819, 364559.0, 364898.0, 366155.0, 367350.0, 368048.0, 49057.509424906006, 49132.50867491351, 49184.75407623011, 49237.753811230716, 49268.75365623149, 1203.628761960562, 1210.03197442046, 1233.340163012784, 1236.2767780848305, 1241.2986662535639, 24842.627360589966, 26126.0, 26336.34159146037, 26425.33936651599, 26764.866175668998, 41272.0, 41736.58263417448, 42004.0, 42116.1576768469, 42133.367999480644, 316027.0, 318509.0, 318958.0, 318994.0, 319133.0, 34985.0, 36370.09074773152, 37021.25957480782, 37040.0, 37045.44431833579, 33055.33889322152, 35138.12154696051, 42155.57844421516, 45947.540524594326, 47003.52996469991, 34328.31343373169, 36219.0, 36823.26353472969, 37205.0, 37675.43486847645, 35778.0, 36077.45883811692, 36351.0, 36474.45288320624, 36780.26439471249, 35044.64955350516, 35330.0, 35641.82179089088, 35707.64292357147, 35841.28317433689, 31383.84308078445, 32469.35061298808, 32638.51042234321, 32683.0, 32825.50761738623, 24289.0, 24621.0, 24714.876425618477, 24860.12989545357, 24992.250232493054], "value": 17590.100203636768, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.1400950760958, 372.20162750899306, 372.6608786004736, 381.4354754962653, 387.14827379764506, 15681.686366272683, 16804.159792010396, 17052.403165889198, 17161.141942902836, 17186.484405467825, 16121.677566448694, 16376.75434868475, 17216.655666886654, 17228.741568876445, 17298.13509324532, 5095.312132862072, 5242.947570524303, 5246.580273578104, 5277.947220527803, 5290.629655924087, 3777.508923839897, 3982.6614737747327, 4931.334269873575, 5859.472647461727, 6183.319834818189, 6185.814425567218, 6187.041008643645, 6198.256209254896, 6204.565680402374, 6207.099970504274, 5965.4929331006915, 6122.448979591836, 6144.539159563006, 6150.907736383958, 6189.783357582485, 3420.538227339302, 4980.377452818398, 5269.604779641504, 5278.102722537178, 5380.650257733235, 19441.80558194428, 20022.1991120355, 20049.799502005084, 20570.38288851322, 20608.0, 1918.9232430702755, 1988.7514060742408, 1989.2983301619122, 2069.4412508622736, 2273.897674604647, 6016.729247183887, 6051.092336149569, 7066.869300911881, 13007.86992130076, 13212.471501139942, 1707.795064592257, 1765.7086580714167, 1785.4911350265113, 1836.7520384748022, 1857.7770667519985, 63741.36258637447, 63933.0, 64269.357306426806, 64389.356106438805, 65530.672346638436, 8305.169483051646, 8781.51701656415, 8905.243054340453, 9067.093290671011, 9079.591418386188, 11903.404829758478, 11903.70240743971, 11996.64010079699, 12000.579979700844, 12016.459259333351, 6908.412784913238, 6932.133483314586, 6983.615901125385, 6989.825254368681, 7094.290570942968, 6813.216480104752, 6878.174619045646, 6895.793126206222, 6902.792916212522, 7030.121234845645, 3757.887263382103, 3811.3330167220624, 3813.180166264211, 3828.942565861514, 3830.2531006453473, 1685.5196269063504, 1767.1959258537336, 1809.0592891696244, 1811.3479147506887, 1871.0, 771.4021633234177, 810.9918900811034, 886.2156991062956, 925.5881132895931, 944.390867890207, 15771.605709857346, 16235.269412876449, 16323.428679996143, 17379.304827807, 17386.21762020712, 806.9394795390252, 851.8168593752249, 852.5737131434283, 862.3575436299872, 921.861720741894, 8822.51476168804, 8925.598348074353, 9167.17495425415, 9246.4914429707, 9535.90464095364, 377608.0, 389004.0, 389924.0, 391377.0, 392459.0, 76958.0, 76999.0, 77090.0, 78897.21102789014, 79053.20946790573, 810.5420437452821, 859.9011113721876, 884.8849649545647, 888.1207604471656, 889.4307643108416, 14514.637134071732, 15555.511118221482, 15904.920475397548, 16289.104099274653, 16345.427910023092, 35619.82190089033, 36523.269534608626, 36614.0, 37815.62184378121, 38639.0, 47965.28052079291, 48323.51676483331, 49698.75150624224, 50181.498185017685, 50342.748286258335, 6500.447461965786, 6653.800385988428, 6663.900041499284, 6936.167659880846, 7637.121731001006, 10816.296940698829, 11533.942330288295, 11830.46762895689, 11873.109516786448, 11925.045996320447, 9958.452285124387, 10046.497675116068, 10141.49292535385, 10303.175745940456, 10427.895721042996, 10135.847962280424, 10386.948065259625, 10446.895531044896, 10474.214433917334, 10543.894561054598, 10105.24210684187, 10141.594336226763, 10514.842277365693, 10555.788884222426, 10603.469826508797, 6734.8653026940165, 6856.283276923239, 6894.931050689429, 6976.546524476096, 7143.678534466066, 7855.5286682799215, 9362.391444556082, 9607.51962401863, 10138.23963202748, 10175.542100605342], "value": 8029.736227444488, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1127.8702949160843, 1137.4597066393465, 1243.5771837575235, 1286.813412055252, 1610.9113998730072, 7026.508144429892, 7295.124585049794, 7340.0, 7359.632018399078, 7467.365273951721, 7309.926900730991, 7403.148637906643, 7445.292697193758, 7482.326590606845, 7484.139323977731, 1893.8579606529497, 1956.9902150489227, 1958.3635318521467, 2177.8039976402083, 2217.667349897512, 1949.4501871012508, 2161.4812445013163, 2238.8992495337748, 2240.372695645222, 2254.075828910139, 2198.8016530990567, 2217.0466699319286, 2238.485148415857, 2239.1491233331312, 2239.4177513846353, 1794.7666803315485, 2097.0982477534653, 2107.5468774213464, 2110.598986192626, 2113.598416300898, 2083.6978638097544, 2153.3432303147533, 2154.310620601408, 2167.512309730314, 2168.046059733712, 7243.637818109073, 7280.2719728027305, 7307.634618269119, 7310.926890731131, 7311.926880731178, 4542.545745425431, 4679.836205732783, 4680.485146633868, 4682.765861706901, 4684.882877928045, 2832.9150125496267, 2867.2975121095465, 2942.7057294270403, 2944.440556294297, 2997.730204281603, 901.9639214431414, 913.3423934766957, 914.1818072824851, 929.2194556572512, 948.9240860731124, 10114.898851011469, 10141.594336226543, 10164.440955747357, 10186.439745813977, 10217.131543818785, 4097.160082183145, 4110.095778928631, 4204.684648651363, 4208.347706105558, 4208.831646734157, 8528.488290702579, 8635.870461943075, 8663.48019118855, 8673.913260867437, 8781.736547903573, 4582.037772067836, 4609.700369475973, 4628.5371462853445, 4643.74459404736, 4648.628109751212, 3632.164602141522, 3749.5125633667994, 4134.793260336971, 4221.472315960505, 4223.028703398236, 3509.4911237870874, 3621.5473065866768, 3705.5923848376656, 3705.6850167735506, 3719.4420836874683, 1138.6185627814775, 1177.8292147638545, 1189.9583514576948, 1193.8806119388166, 1206.3847437806605, 746.2388363868823, 752.3943225703362, 785.4565778245775, 808.9474184178009, 813.4834380168636, 4842.806287748521, 4856.854294371175, 4892.730899800546, 4916.827911023097, 5005.274235235943, 375.7689021251965, 382.7569493371673, 404.17951558336625, 411.51030273974476, 426.0477832045376, 3267.918302042468, 3342.014105838735, 3353.413152698268, 3626.8549258029384, 3753.9624603753614, 9035.683751068682, 9161.221296189899, 9248.537573121317, 9284.978652348236, 9288.860667089999, 8195.303399211134, 8551.059383467813, 9229.446233226028, 9246.306527010502, 9252.352335336596, 6825.795226143224, 6891.793246202622, 6971.0, 7010.0, 7014.859702806018, 5117.820876269461, 5121.974390128025, 5309.0, 5452.645578037414, 5468.835934921959, 8323.41736078493, 8521.87217191755, 8558.358123140664, 8624.482531048157, 8630.050694423482, 8695.478271303742, 8758.211760941545, 8808.735737927873, 8840.911590884009, 8898.777530561787, 5859.707014649336, 6284.748610055546, 6534.4772418205475, 6601.768938087144, 6754.5609535380045, 7364.705411783469, 7413.221611730691, 7437.107547094383, 7501.324880760758, 7506.587137707478, 6374.681265936591, 6583.814913315649, 6603.603783772989, 6687.331266873273, 6698.56459330142, 6467.935320646733, 6521.739130434729, 6531.379518945692, 6658.43403310724, 6687.899681504684, 6088.4215999479975, 6154.815355539341, 6160.876782464236, 6163.322034576104, 6168.25980882297, 4205.810738516835, 4286.335617979218, 4312.9137417252105, 4327.567243275647, 4342.565743425758, 4189.832406703697, 4297.033167537279, 4302.770670950541, 4327.134573085458, 4489.371487991619], "value": 3919.535727728348, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.7736708784866, 305.07714164651924, 309.7521982414068, 312.25371362443747, 314.17215636797044, 4716.221823399135, 4852.320675105488, 4883.804647814088, 4940.876478088049, 4973.900521989558, 4626.0, 4792.962990728944, 4834.63740219484, 4842.249451335048, 4853.344798452208, 3842.711796615251, 3850.8074596270144, 3859.4017927221325, 3861.7876016819064, 3875.61243875613, 3615.529981102453, 3680.3191409589176, 3825.5409350877935, 3860.3244432224387, 3867.690584753213, 3774.7920665387087, 3806.1245913439925, 3815.618438156176, 3818.3508803503332, 3819.2934307153128, 3766.905827354324, 3779.659830615244, 3799.4300854871713, 3803.8858834235016, 3853.6339047790416, 3394.3381040697072, 3404.8297585120645, 3405.9829700851583, 3411.1131105912395, 3417.2311229973056, 4620.422447194101, 4709.317149013408, 4712.175369310357, 4719.126961512131, 4750.928736068961, 4343.587359200871, 4350.673699472521, 4370.781460926973, 4383.824647014116, 4388.868333949987, 5101.591872650179, 5109.8722531937, 5113.923291150636, 5118.436971933084, 5121.513456221653, 3512.771669841478, 3671.724620653462, 3703.777753341391, 3720.646538578858, 3726.5341832270965, 5363.222332761728, 5382.111951527993, 5395.244665746799, 5403.2165336026055, 5428.104362780176, 3831.63599458051, 3841.846326146923, 3851.345271303885, 3852.9807350963624, 3858.479105320802, 3782.867599634, 3835.7890316032326, 3903.902402439962, 3905.1603905160528, 3907.1013666856215, 4306.80619372129, 4318.265894797829, 4327.485380116934, 4335.414719012956, 4343.674224433117, 5066.417362003343, 5077.847664570068, 5079.923801142986, 5099.9490005100215, 5101.948980510221, 1265.6835791052238, 1290.1227165527343, 1292.9288889111, 1298.8246586710861, 1312.4290933443983, 848.1942154952819, 926.0924294191595, 930.0978051290238, 941.87755591774, 943.3962264150949, 4452.75136056296, 4457.286834106528, 4458.016182798623, 4463.486699029589, 4471.709338892962, 5216.765245563959, 5220.112580861262, 5221.947780522222, 5236.633435659467, 5252.107141785906, 4306.827726890952, 4467.329900514884, 4477.820887164542, 4494.932331127718, 4495.145922274823, 2773.3898542320658, 2783.9025634103114, 2787.428577141681, 2787.958180627292, 2822.929426764347, 4858.493866901272, 4864.683795553277, 4879.658423910363, 4886.486918873538, 4887.657863949489, 5104.9744751276, 5300.814471493556, 5307.469253074739, 5352.4915133062295, 5394.946050539523, 4940.135476291706, 4944.901101978012, 4962.6774259673, 4983.551480366785, 4984.8753781155765, 5277.366715994105, 5299.284596579412, 5307.230451584422, 5309.65487243328, 5336.573074154136, 4991.550760431579, 5203.505666961632, 5218.747500599905, 5224.895502090013, 5225.320708308048, 4962.0, 4966.975165124151, 4977.303177555217, 4996.526024822759, 5022.493252024451, 3835.8273877675015, 3847.134394761268, 3878.8836334909997, 3894.883153505399, 3899.7075219358094, 5050.924236136388, 5078.390593128848, 5204.386640141568, 5260.684358938476, 5364.624476286778, 5028.949710502849, 5157.266648676207, 5161.793528258828, 5188.507091826271, 5190.325257716473, 5131.56381707559, 5139.229115632685, 5170.71561064145, 5173.904568649703, 5174.353205849269, 4775.928361074517, 5015.423226329019, 5065.620078494054, 5071.6416866157415, 5083.644144909968, 5152.639315248047, 5169.457206993212, 5179.249008893765, 5187.559057480156, 5196.766145523537, 5038.521340472649, 5065.468125846733, 5068.26510156018, 5082.517160869711, 5091.465396133352], "value": 3873.337309843465, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [638.0365647871715, 664.8969409741492, 674.2919934069223, 685.3044160177418, 693.2651389527101, 12471.314077725721, 13675.179489230653, 14030.298485075757, 14056.648583785398, 14060.156390616545, 12517.18638288513, 12784.872151278507, 12803.615891523246, 12810.551630692928, 12828.743425131492, 625.9436650701437, 756.1568850731436, 764.1632412508294, 764.6215123513869, 768.1742127213269, 767.3669222891109, 775.7711475114854, 776.1113525013856, 776.5379599138504, 776.638862928738, 807.3299161695808, 812.4312980913355, 813.3168138763438, 813.9552324622143, 814.0191069760954, 656.74715234635, 802.1056521977953, 807.7536351412816, 808.5027707959621, 809.3039985612369, 587.5798803855264, 588.1266319515516, 588.8174665853556, 589.932157801854, 590.7075997381281, 13150.0, 13159.86840131596, 13200.603981880558, 13211.735765284737, 13224.206547607078, 12022.819657705142, 12335.0, 12629.43167557462, 12631.91366734905, 13419.194848309035, 11778.352190629512, 12033.217840840318, 12248.693782655415, 12307.938460307641, 12414.131010829245, 4182.184474027566, 4193.769342686151, 4207.158568286355, 4255.5744425557505, 4300.80646370914, 49672.25491617629, 52168.47831521712, 52252.21621675678, 58627.0, 68605.65697171532, 10525.10536604382, 10568.788624227473, 10601.787964240671, 10627.096696780705, 10683.412412317397, 18889.149988250563, 18892.622147556973, 18912.43262702121, 18931.14809833561, 18938.24247030131, 7084.504084714124, 7139.178994415604, 7148.428125749928, 7273.418126549864, 7484.550926944292, 3752.568454627698, 3850.1914597934187, 3876.0, 3887.8639247626197, 3932.390479475686, 2907.0697376839207, 3000.984995075011, 3016.592759977375, 3017.3965206958696, 3017.849107544614, 517.3868965276159, 526.6182018036892, 537.1647088776912, 545.6562365709577, 545.7735039958372, 439.1927219491768, 503.83373486749286, 564.7938502446659, 567.2540609099021, 569.834747923106, 7140.6072666003865, 7581.0, 7665.0, 7707.460477766503, 7859.253370929752, 539.9487048730364, 545.1141894421565, 578.6181120460476, 585.1340016775112, 588.1706793421341, 3552.7335449841366, 3585.838637261277, 3622.3841946869097, 3636.836342364547, 3713.0, 91151.0, 94570.5271473652, 95540.0, 95845.0, 97864.51067744616, 82071.17928820755, 82125.0, 82996.17003830006, 83031.5848420754, 84762.5761871199, 41694.37458438126, 51733.7413312931, 55928.44071559314, 62010.0, 65536.67231663906, 8717.564121793757, 8737.301015918583, 8766.736997890073, 8808.20726134651, 8834.823303533765, 40304.59695403009, 40328.39507407333, 40458.0, 41124.588754113276, 41243.0, 54561.72719136379, 56747.71626141843, 57573.13640295483, 58728.0, 59371.40628593659, 10921.976651143697, 10950.780984380428, 11317.0, 11592.768144637228, 11967.521299147937, 12515.185298131537, 12556.623301300975, 12770.0, 13134.0, 13272.0, 12155.87844121583, 12427.537491741361, 12594.937025314815, 12616.116871819251, 12773.297468639314, 12118.878811212127, 12165.57420490314, 12429.378531073591, 12577.371131443575, 12577.496900123893, 12445.066620003718, 12697.047721420746, 12882.871171288167, 12884.291363975071, 12930.935345323212, 10148.911798396512, 10640.574377024832, 10741.677749667522, 10836.729081773019, 10883.401412922365, 9617.759556011155, 9718.296566009873, 10174.856948840968, 10619.469026548797, 10661.786764264516], "value": 6554.031386690153, "unit": "score"}], "name": "dromaeo_css", "value": 6341.83946330282, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 109.0, 113.0, 115.0, 115.0, 116.0, 115.0, 116.0, 114.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 135.0, 137.0, 186.0, 131.0, 162.0, 164.0, 133.0, 193.0, 141.0], "value": 154.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 163.0, 161.0, 162.0, 163.0, 163.0, 163.0, 162.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 125.0, 76.0, 76.0, 74.0, 75.0, 98.0, 76.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 108.0, 86.0, 86.0, 86.0, 124.0, 86.0, 86.0, 124.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 64.0, 66.0, 63.0, 63.0, 63.0, 63.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 68.0, 72.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 82.0, 84.0, 84.0, 84.0, 89.0, 117.0, 84.0], "value": 87.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 131.0, 142.0, 128.0, 132.0, 130.0, 137.0, 137.0, 137.0, 133.0], "value": 134.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 173.0, 167.0, 170.0, 176.0, 171.0, 171.0, 175.0, 166.0, 166.0], "value": 170.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 67.0, 67.0, 69.0, 66.0, 67.0, 66.0, 67.0, 67.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1556.3, "alertThreshold": 2.0}]} 09:02:05 INFO - Return code: 0 09:02:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:02:05 INFO - # TBPL SUCCESS # 09:02:05 INFO - Running post-action listener: _resource_record_post_action 09:02:05 INFO - ##### 09:02:05 INFO - ##### Finished run-tests step (success) 09:02:05 INFO - ##### 09:02:05 INFO - Running post-run listener: _resource_record_post_run 09:02:05 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 550858752; Read time: 16; Write time: 503280 09:02:05 INFO - TinderboxPrint: CPU usage
13.1% 09:02:05 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 09:02:05 INFO - TinderboxPrint: I/O write bytes / time
550,858,752 / 503,280 09:02:05 INFO - TinderboxPrint: CPU idle
8,330.0 (86.8%) 09:02:05 INFO - TinderboxPrint: CPU user
1,214.0 (12.7%) 09:02:05 INFO - TinderboxPrint: Swap in / out
0 / 0 09:02:05 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 254509056; Read time: 0; Write time: 289328 09:02:05 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296349696; Read time: 16; Write time: 213952 09:02:06 INFO - Running post-run listener: _upload_blobber_files 09:02:06 INFO - Blob upload gear active. 09:02:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:02:06 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:06 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:06 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:06 INFO - (blobuploader) - INFO - Open directory for files ... 09:02:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:02:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:02:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:02:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:02:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:02:07 INFO - (blobuploader) - INFO - Done attempting. 09:02:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:02:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:02:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:02:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:02:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:02:08 INFO - (blobuploader) - INFO - Done attempting. 09:02:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:02:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:02:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:02:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:02:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:02:12 INFO - (blobuploader) - INFO - Done attempting. 09:02:12 INFO - (blobuploader) - INFO - Iteration through files over. 09:02:12 INFO - Return code: 0 09:02:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:02:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:02:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3dd307ec3ce6f097a997686a35a213c8515e506bbde272a3e7af224e630357d23764dbbe34f4d13dbbf87f3acda0bea3cae0f5a3a09577bcb4a4ad3da89151a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ffc9920059a574421a1d08f4af236ec1678c0087eef6ac913f4ea4862b8ec5cef6846c69a078e2401e58b03b69c3f4ece5e34ea29e95f8bf63cbd4f4b32b5cb0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4387842435e9754d806bb02944563d88718e39cdbf5c137ea0e7c6fdc19a6a03ce73635e89e93ad6817e25dc9d42a526bcadb0d3779c6b8f2f888c417bdd45e2"} 09:02:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:02:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:02:12 INFO - Contents: 09:02:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3dd307ec3ce6f097a997686a35a213c8515e506bbde272a3e7af224e630357d23764dbbe34f4d13dbbf87f3acda0bea3cae0f5a3a09577bcb4a4ad3da89151a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ffc9920059a574421a1d08f4af236ec1678c0087eef6ac913f4ea4862b8ec5cef6846c69a078e2401e58b03b69c3f4ece5e34ea29e95f8bf63cbd4f4b32b5cb0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4387842435e9754d806bb02944563d88718e39cdbf5c137ea0e7c6fdc19a6a03ce73635e89e93ad6817e25dc9d42a526bcadb0d3779c6b8f2f888c417bdd45e2"} 09:02:12 INFO - Running post-run listener: copy_logs_to_upload_dir 09:02:12 INFO - Copying logs to upload dir... 09:02:12 INFO - mkdir: /builds/slave/test/build/upload/logs 09:02:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.248805 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-15 09:02:12.695268) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-15 09:02:12.699959) ========= 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=337fe3f4b1febe37b85fccc40000019e-1466004780.56551-2130069505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3dd307ec3ce6f097a997686a35a213c8515e506bbde272a3e7af224e630357d23764dbbe34f4d13dbbf87f3acda0bea3cae0f5a3a09577bcb4a4ad3da89151a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ffc9920059a574421a1d08f4af236ec1678c0087eef6ac913f4ea4862b8ec5cef6846c69a078e2401e58b03b69c3f4ece5e34ea29e95f8bf63cbd4f4b32b5cb0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4387842435e9754d806bb02944563d88718e39cdbf5c137ea0e7c6fdc19a6a03ce73635e89e93ad6817e25dc9d42a526bcadb0d3779c6b8f2f888c417bdd45e2"} 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.011475 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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3dd307ec3ce6f097a997686a35a213c8515e506bbde272a3e7af224e630357d23764dbbe34f4d13dbbf87f3acda0bea3cae0f5a3a09577bcb4a4ad3da89151a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ffc9920059a574421a1d08f4af236ec1678c0087eef6ac913f4ea4862b8ec5cef6846c69a078e2401e58b03b69c3f4ece5e34ea29e95f8bf63cbd4f4b32b5cb0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4387842435e9754d806bb02944563d88718e39cdbf5c137ea0e7c6fdc19a6a03ce73635e89e93ad6817e25dc9d42a526bcadb0d3779c6b8f2f888c417bdd45e2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-15 09:02:12.727302) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 09:02:12.727907) ========= 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=337fe3f4b1febe37b85fccc40000019e-1466004780.56551-2130069505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004464 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 09:02:12.814428) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-15 09:02:12.815018) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-15 09:02:12.815588) ========= ========= Total master_lag: 0.18 =========