builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-028 starttime: 1466705740.41 results: success (0) buildid: 20160623083101 builduid: 95fec6d82f064764affe3f1953256a50 revision: a7e793ef71a31643eddd1bf7cb7a80b580cb8284 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 11:15:40.415320) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 11:15:40.416196) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 11:15:40.416520) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 11:15:40.432074) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 11:15:40.432567) ========= 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=836cfdc75598d54cb747368e000001a9-1466704507.732576-158787255 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-23 11:15:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 88.5M=0s 2016-06-23 11:15:40 (88.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.090562 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 11:15:40.537259) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 11:15:40.537674) ========= 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=836cfdc75598d54cb747368e000001a9-1466704507.732576-158787255 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020721 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 11:15:40.590129) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 11:15:40.590509) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a7e793ef71a31643eddd1bf7cb7a80b580cb8284 --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 a7e793ef71a31643eddd1bf7cb7a80b580cb8284 --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=836cfdc75598d54cb747368e000001a9-1466704507.732576-158787255 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-23 11:15:40,828 truncating revision to first 12 chars 2016-06-23 11:15:40,828 Setting DEBUG logging. 2016-06-23 11:15:40,828 attempt 1/10 2016-06-23 11:15:40,828 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a7e793ef71a3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-23 11:15:41,130 unpacking tar archive at: fx-team-a7e793ef71a3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.648100 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 11:15:41.253144) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 11:15:41.253451) ========= script_repo_revision: a7e793ef71a31643eddd1bf7cb7a80b580cb8284 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 11:15:41.253845) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 11:15:41.254119) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 11:15:41.265241) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-23 11:15:41.265625) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=836cfdc75598d54cb747368e000001a9-1466704507.732576-158787255 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:15:41 INFO - MultiFileLogger online at 20160623 11:15:41 in /builds/slave/test 11:15:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:15:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:15:41 INFO - {'append_to_log': False, 11:15:41 INFO - 'base_work_dir': '/builds/slave/test', 11:15:41 INFO - 'blob_upload_branch': 'Fx-Team', 11:15:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:15:41 INFO - 'branch': 'Fx-Team', 11:15:41 INFO - 'buildbot_json_path': 'buildprops.json', 11:15:41 INFO - 'config_files': ('talos/linux_config.py',), 11:15:41 INFO - 'default_actions': ('clobber', 11:15:41 INFO - 'read-buildbot-config', 11:15:41 INFO - 'download-and-extract', 11:15:41 INFO - 'populate-webroot', 11:15:41 INFO - 'create-virtualenv', 11:15:41 INFO - 'install', 11:15:41 INFO - 'run-tests'), 11:15:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:15:41 INFO - 'download_minidump_stackwalk': True, 11:15:41 INFO - 'download_symbols': 'ondemand', 11:15:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:15:41 INFO - 'tooltool.py': '/tools/tooltool.py', 11:15:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:15:41 INFO - '/tools/misc-python/virtualenv.py')}, 11:15:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:15:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:15:41 INFO - 'installer_path': 'installer.exe', 11:15:41 INFO - 'log_level': 'info', 11:15:41 INFO - 'log_name': 'talos', 11:15:41 INFO - 'log_to_console': True, 11:15:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:15:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:15:41 INFO - 'opt_config_files': (), 11:15:41 INFO - 'pip_index': False, 11:15:41 INFO - 'sps_profile': False, 11:15:41 INFO - 'sps_profile_interval': 0, 11:15:41 INFO - 'suite': 'dromaeojs', 11:15:41 INFO - 'system_bits': '32', 11:15:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:15:41 INFO - 'title': 'talos-linux64-ix-028', 11:15:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:15:41 INFO - 'use_talos_json': True, 11:15:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:15:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:15:41 INFO - 'work_dir': 'build'} 11:15:41 INFO - ##### 11:15:41 INFO - ##### Running clobber step. 11:15:41 INFO - ##### 11:15:41 INFO - Running pre-action listener: _resource_record_pre_action 11:15:41 INFO - Running main action method: clobber 11:15:41 INFO - rmtree: /builds/slave/test/build 11:15:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:15:42 INFO - Running post-action listener: _resource_record_post_action 11:15:42 INFO - ##### 11:15:42 INFO - ##### Finished clobber step (success) 11:15:42 INFO - ##### 11:15:42 INFO - ##### 11:15:42 INFO - ##### Running read-buildbot-config step. 11:15:42 INFO - ##### 11:15:42 INFO - Running pre-action listener: _resource_record_pre_action 11:15:42 INFO - Running main action method: read_buildbot_config 11:15:42 INFO - Using buildbot properties: 11:15:42 INFO - { 11:15:42 INFO - "project": "", 11:15:42 INFO - "product": "firefox", 11:15:42 INFO - "script_repo_revision": "production", 11:15:42 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:15:42 INFO - "repository": "", 11:15:42 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:15:42 INFO - "buildid": "20160623083101", 11:15:42 INFO - "pgo_build": "True", 11:15:42 INFO - "basedir": "/builds/slave/test", 11:15:42 INFO - "buildnumber": 1279, 11:15:42 INFO - "slavename": "talos-linux64-ix-028", 11:15:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:15:42 INFO - "platform": "ubuntu64_hw", 11:15:42 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:15:42 INFO - "branch": "fx-team", 11:15:42 INFO - "repo_path": "integration/fx-team", 11:15:42 INFO - "revision": "a7e793ef71a31643eddd1bf7cb7a80b580cb8284", 11:15:42 INFO - "stage_platform": "linux64-pgo", 11:15:42 INFO - "builduid": "95fec6d82f064764affe3f1953256a50", 11:15:42 INFO - "slavebuilddir": "test" 11:15:42 INFO - } 11:15:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 11:15:42 INFO - Running post-action listener: _resource_record_post_action 11:15:42 INFO - ##### 11:15:42 INFO - ##### Finished read-buildbot-config step (success) 11:15:42 INFO - ##### 11:15:42 INFO - ##### 11:15:42 INFO - ##### Running download-and-extract step. 11:15:42 INFO - ##### 11:15:42 INFO - Running pre-action listener: _resource_record_pre_action 11:15:42 INFO - Running main action method: download_and_extract 11:15:42 INFO - mkdir: /builds/slave/test/build/tests 11:15:42 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')]} 11:15:42 INFO - https://queue.taskcluster.net/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:15:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:15:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:15:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/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 11:15:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/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 11:15:43 INFO - Downloaded 1361 bytes. 11:15:43 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:15:43 INFO - Using the following test package requirements: 11:15:43 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:15:43 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:15:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:15:43 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:15:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:15:43 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:15:43 INFO - u'jsshell-linux-x86_64.zip'], 11:15:43 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:15:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:15:43 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:15:43 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:15:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:15:43 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:15:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:15:43 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:15:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:15:43 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:15:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:15:43 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:15:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:43 INFO - https://queue.taskcluster.net/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:15:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:15:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:15:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/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 11:15:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/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 11:15:44 INFO - Downloaded 24275576 bytes. 11:15:44 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'] 11:15:44 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 11:15:46 INFO - Return code: 0 11:15:46 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 11:15: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')]} 11:15:46 INFO - https://queue.taskcluster.net/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:15:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:15:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:15:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/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 11:15:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/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 11:15:48 INFO - Downloaded 24275576 bytes. 11:15:48 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'] 11:15:48 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 11:15:49 INFO - Return code: 0 11:15: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')]} 11:15:49 INFO - https://queue.taskcluster.net/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:15:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:15:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:15:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/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 11:15:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/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 11:15:50 INFO - Downloaded 14405384 bytes. 11:15:50 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'] 11:15:50 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 11:15:50 INFO - Return code: 0 11:15:50 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')]} 11:15:50 INFO - https://queue.taskcluster.net/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:15:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:15:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:15:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/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 11:15:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/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 11:15:53 INFO - Downloaded 60162197 bytes. 11:15:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:15:53 INFO - mkdir: /builds/slave/test/properties 11:15:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:15:53 INFO - Writing to file /builds/slave/test/properties/build_url 11:15:53 INFO - Contents: 11:15:53 INFO - build_url:https://queue.taskcluster.net/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:15:54 INFO - Running post-action listener: _resource_record_post_action 11:15:54 INFO - Running post-action listener: set_extra_try_arguments 11:15:54 INFO - ##### 11:15:54 INFO - ##### Finished download-and-extract step (success) 11:15:54 INFO - ##### 11:15:54 INFO - ##### 11:15:54 INFO - ##### Running populate-webroot step. 11:15:54 INFO - ##### 11:15:54 INFO - Running pre-action listener: _resource_record_pre_action 11:15:54 INFO - Running main action method: populate_webroot 11:15:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:15:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:15:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:15:54 INFO - '--tppagecycles', 11:15:54 INFO - '7'], 11:15:54 INFO - 'tests': ['tsvgm']}}, 11:15:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:15:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:15:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:15:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:15:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:15:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:15:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:54 INFO - 'talos_options': ['--disable-e10s'], 11:15:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:15:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:15:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:54 INFO - 'talos_options': ['--disable-e10s'], 11:15:54 INFO - 'tests': ['damp', 'tps']}, 11:15:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:54 INFO - 'tests': ['damp', 'tps']}, 11:15:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:15:54 INFO - 'tests': ['dromaeo_dom']}, 11:15:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:15:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:15:54 INFO - 'tests': ['basic_compositor_video']}, 11:15:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:15:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:15:54 INFO - 'tests': ['a11yr', 11:15:54 INFO - 'ts_paint', 11:15:54 INFO - 'tpaint', 11:15:54 INFO - 'sessionrestore', 11:15:54 INFO - 'sessionrestore_no_auto_restore', 11:15:54 INFO - 'tabpaint']}, 11:15:54 INFO - 'other-e10s': {'tests': ['a11yr', 11:15:54 INFO - 'ts_paint', 11:15:54 INFO - 'tpaint', 11:15:54 INFO - 'sessionrestore', 11:15:54 INFO - 'sessionrestore_no_auto_restore', 11:15:54 INFO - 'tabpaint']}, 11:15:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:15:54 INFO - 'ts_paint', 11:15:54 INFO - 'tpaint', 11:15:54 INFO - 'sessionrestore', 11:15:54 INFO - 'sessionrestore_no_auto_restore', 11:15:54 INFO - 'tabpaint']}, 11:15:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:15:54 INFO - 'ts_paint', 11:15:54 INFO - 'tpaint', 11:15:54 INFO - 'sessionrestore', 11:15:54 INFO - 'sessionrestore_no_auto_restore', 11:15:54 INFO - 'tabpaint']}, 11:15:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:15:54 INFO - 'tests': ['a11yr', 11:15:54 INFO - 'ts_paint', 11:15:54 INFO - 'tpaint', 11:15:54 INFO - 'sessionrestore', 11:15:54 INFO - 'sessionrestore_no_auto_restore', 11:15:54 INFO - 'tabpaint']}, 11:15:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:15:54 INFO - 'tests': ['a11yr', 11:15:54 INFO - 'ts_paint', 11:15:54 INFO - 'tpaint', 11:15:54 INFO - 'sessionrestore', 11:15:54 INFO - 'sessionrestore_no_auto_restore', 11:15:54 INFO - 'tabpaint']}, 11:15:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:15:54 INFO - 'tests': ['tsvgx', 11:15:54 INFO - 'tsvgr_opacity', 11:15:54 INFO - 'tart', 11:15:54 INFO - 'tscrollx', 11:15:54 INFO - 'cart']}, 11:15:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:15:54 INFO - 'tsvgr_opacity', 11:15:54 INFO - 'tart', 11:15:54 INFO - 'tscrollx', 11:15:54 INFO - 'cart']}, 11:15:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:54 INFO - 'talos_options': ['--disable-e10s'], 11:15:54 INFO - 'tests': ['tp5o']}, 11:15:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:54 INFO - 'tests': ['tp5o']}, 11:15:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:54 INFO - 'talos_options': ['--disable-e10s', 11:15:54 INFO - '--xperf_path', 11:15:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:15:54 INFO - 'tests': ['tp5n']}, 11:15:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:54 INFO - 'talos_options': ['--xperf_path', 11:15:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:15:54 INFO - 'tests': ['tp5n']}}, 11:15:54 INFO - 'talos.zip': {'path': '', 11:15:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:15:54 INFO - Running post-action listener: _resource_record_post_action 11:15:54 INFO - ##### 11:15:54 INFO - ##### Finished populate-webroot step (success) 11:15:54 INFO - ##### 11:15:54 INFO - ##### 11:15:54 INFO - ##### Running create-virtualenv step. 11:15:54 INFO - ##### 11:15:54 INFO - Running pre-action listener: _resource_record_pre_action 11:15:54 INFO - Running main action method: create_virtualenv 11:15:54 INFO - Creating virtualenv /builds/slave/test/build/venv 11:15:54 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 11:15:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:15:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:15:54 INFO - Using real prefix '/usr' 11:15:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:15:55 INFO - Installing distribute.............................................................................................................................................................................................done. 11:15:57 INFO - Installing pip.................done. 11:15:57 INFO - Return code: 0 11:15:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:15:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7effd4b30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ba1c0>, '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 0x16bb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bb550>, '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': '836cfdc75598d54cb747368e000001a9-1466704507.732576-158787255', '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 11:15:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:15:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:15:57 INFO - Using env: {'DISPLAY': ':0', 11:15:57 INFO - 'HOME': '/home/cltbld', 11:15:57 INFO - 'LANG': 'en_US.UTF-8', 11:15:57 INFO - 'LANGUAGE': 'en_US:en', 11:15:57 INFO - 'LOGNAME': 'cltbld', 11:15:57 INFO - 'MAIL': '/var/mail/cltbld', 11:15:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:57 INFO - 'MOZ_NO_REMOTE': '1', 11:15:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:57 INFO - 'NO_EM_RESTART': '1', 11:15:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:57 INFO - 'PWD': '/builds/slave/test', 11:15:57 INFO - 'SHELL': '/bin/bash', 11:15:57 INFO - 'SHLVL': '1', 11:15:57 INFO - 'TERM': 'linux', 11:15:57 INFO - 'TMOUT': '86400', 11:15:57 INFO - 'USER': 'cltbld', 11:15:57 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1466704507.732576-158787255', 11:15:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:57 INFO - '_': '/tools/buildbot/bin/python'} 11:15:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:57 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 11:15:57 INFO - Cleaning up... 11:15:57 INFO - Return code: 0 11:15:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:15:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7effd4b30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ba1c0>, '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 0x16bb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bb550>, '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': '836cfdc75598d54cb747368e000001a9-1466704507.732576-158787255', '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 11:15:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:15:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:15:57 INFO - Using env: {'DISPLAY': ':0', 11:15:57 INFO - 'HOME': '/home/cltbld', 11:15:57 INFO - 'LANG': 'en_US.UTF-8', 11:15:57 INFO - 'LANGUAGE': 'en_US:en', 11:15:57 INFO - 'LOGNAME': 'cltbld', 11:15:57 INFO - 'MAIL': '/var/mail/cltbld', 11:15:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:57 INFO - 'MOZ_NO_REMOTE': '1', 11:15:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:57 INFO - 'NO_EM_RESTART': '1', 11:15:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:57 INFO - 'PWD': '/builds/slave/test', 11:15:57 INFO - 'SHELL': '/bin/bash', 11:15:57 INFO - 'SHLVL': '1', 11:15:57 INFO - 'TERM': 'linux', 11:15:57 INFO - 'TMOUT': '86400', 11:15:57 INFO - 'USER': 'cltbld', 11:15:57 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1466704507.732576-158787255', 11:15:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:57 INFO - '_': '/tools/buildbot/bin/python'} 11:15:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:57 INFO - Downloading/unpacking psutil>=3.1.1 11:15: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 11:15: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 11:15: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 11:15: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 11:15: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 11:15: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 11:15:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:15:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:15:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:15:59 INFO - Installing collected packages: psutil 11:15:59 INFO - Running setup.py install for psutil 11:15:59 INFO - building 'psutil._psutil_linux' extension 11:15:59 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 11:15:59 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 11:15:59 INFO - building 'psutil._psutil_posix' extension 11:15:59 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 11:15:59 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 11:16:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:16:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:16:00 INFO - Successfully installed psutil 11:16:00 INFO - Cleaning up... 11:16:00 INFO - Return code: 0 11:16:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:16: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')]} 11:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16: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')]} 11:16:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7effd4b30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ba1c0>, '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 0x16bb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bb550>, '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': '836cfdc75598d54cb747368e000001a9-1466704507.732576-158787255', '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 11:16: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:16: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 mozsystemmonitor==0.3 11:16:00 INFO - Using env: {'DISPLAY': ':0', 11:16:00 INFO - 'HOME': '/home/cltbld', 11:16:00 INFO - 'LANG': 'en_US.UTF-8', 11:16:00 INFO - 'LANGUAGE': 'en_US:en', 11:16:00 INFO - 'LOGNAME': 'cltbld', 11:16:00 INFO - 'MAIL': '/var/mail/cltbld', 11:16:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:00 INFO - 'MOZ_NO_REMOTE': '1', 11:16:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:00 INFO - 'NO_EM_RESTART': '1', 11:16:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:00 INFO - 'PWD': '/builds/slave/test', 11:16:00 INFO - 'SHELL': '/bin/bash', 11:16:00 INFO - 'SHLVL': '1', 11:16:00 INFO - 'TERM': 'linux', 11:16:00 INFO - 'TMOUT': '86400', 11:16:00 INFO - 'USER': 'cltbld', 11:16:00 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1466704507.732576-158787255', 11:16:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:00 INFO - '_': '/tools/buildbot/bin/python'} 11:16:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:16: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 11:16: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 11:16: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 11:16: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 11:16: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 11:16: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 11:16:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:16:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:16:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:16:02 INFO - Installing collected packages: mozsystemmonitor 11:16:02 INFO - Running setup.py install for mozsystemmonitor 11:16:02 INFO - Successfully installed mozsystemmonitor 11:16:02 INFO - Cleaning up... 11:16:02 INFO - Return code: 0 11:16:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:16:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:02 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 0x7effd4b30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ba1c0>, '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 0x16bb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bb550>, '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': '836cfdc75598d54cb747368e000001a9-1466704507.732576-158787255', '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 11:16:02 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 11:16:02 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 11:16:02 INFO - Using env: {'DISPLAY': ':0', 11:16:02 INFO - 'HOME': '/home/cltbld', 11:16:02 INFO - 'LANG': 'en_US.UTF-8', 11:16:02 INFO - 'LANGUAGE': 'en_US:en', 11:16:02 INFO - 'LOGNAME': 'cltbld', 11:16:02 INFO - 'MAIL': '/var/mail/cltbld', 11:16:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:02 INFO - 'MOZ_NO_REMOTE': '1', 11:16:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:02 INFO - 'NO_EM_RESTART': '1', 11:16:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:02 INFO - 'PWD': '/builds/slave/test', 11:16:02 INFO - 'SHELL': '/bin/bash', 11:16:02 INFO - 'SHLVL': '1', 11:16:02 INFO - 'TERM': 'linux', 11:16:02 INFO - 'TMOUT': '86400', 11:16:02 INFO - 'USER': 'cltbld', 11:16:02 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1466704507.732576-158787255', 11:16:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:02 INFO - '_': '/tools/buildbot/bin/python'} 11:16:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:02 INFO - Downloading/unpacking jsonschema==2.5.1 11:16: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 11:16: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 11:16: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 11:16: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 11:16: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 11:16: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 11:16:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:16:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:04 INFO - Downloading functools32-3.2.3-2.tar.gz 11:16:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:16:04 INFO - warning: no files found matching '*.txt' 11:16:04 INFO - no previously-included directories found matching 'build' 11:16:04 INFO - no previously-included directories found matching 'dist' 11:16:04 INFO - no previously-included directories found matching '.git*' 11:16:04 INFO - Installing collected packages: jsonschema, functools32 11:16:04 INFO - Running setup.py install for functools32 11:16:04 INFO - warning: no files found matching '*.txt' 11:16:04 INFO - no previously-included directories found matching 'build' 11:16:04 INFO - no previously-included directories found matching 'dist' 11:16:04 INFO - no previously-included directories found matching '.git*' 11:16:04 INFO - Successfully installed jsonschema functools32 11:16:04 INFO - Cleaning up... 11:16:05 INFO - Return code: 0 11:16:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:16:05 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')]} 11:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:05 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')]} 11:16:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:05 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 0x7effd4b30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ba1c0>, '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 0x16bb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bb550>, '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': '836cfdc75598d54cb747368e000001a9-1466704507.732576-158787255', '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 11:16:05 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 11:16:05 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 11:16:05 INFO - Using env: {'DISPLAY': ':0', 11:16:05 INFO - 'HOME': '/home/cltbld', 11:16:05 INFO - 'LANG': 'en_US.UTF-8', 11:16:05 INFO - 'LANGUAGE': 'en_US:en', 11:16:05 INFO - 'LOGNAME': 'cltbld', 11:16:05 INFO - 'MAIL': '/var/mail/cltbld', 11:16:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:05 INFO - 'MOZ_NO_REMOTE': '1', 11:16:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:05 INFO - 'NO_EM_RESTART': '1', 11:16:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:05 INFO - 'PWD': '/builds/slave/test', 11:16:05 INFO - 'SHELL': '/bin/bash', 11:16:05 INFO - 'SHLVL': '1', 11:16:05 INFO - 'TERM': 'linux', 11:16:05 INFO - 'TMOUT': '86400', 11:16:05 INFO - 'USER': 'cltbld', 11:16:05 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1466704507.732576-158787255', 11:16:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:05 INFO - '_': '/tools/buildbot/bin/python'} 11:16:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:05 INFO - Downloading/unpacking blobuploader==1.2.4 11:16:05 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 11:16:05 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 11:16:05 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 11:16:05 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 11:16:05 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 11:16:05 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 11:16:07 INFO - Downloading blobuploader-1.2.4.tar.gz 11:16:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:16:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:16:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:07 INFO - Downloading docopt-0.6.1.tar.gz 11:16:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:16:07 INFO - Installing collected packages: blobuploader, requests, docopt 11:16:07 INFO - Running setup.py install for blobuploader 11:16:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:16:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:16:07 INFO - Running setup.py install for requests 11:16:08 INFO - Running setup.py install for docopt 11:16:08 INFO - Successfully installed blobuploader requests docopt 11:16:08 INFO - Cleaning up... 11:16:08 INFO - Return code: 0 11:16:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:16:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:16:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:08 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 0x7effd4b30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ba1c0>, '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 0x16bb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bb550>, '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': '836cfdc75598d54cb747368e000001a9-1466704507.732576-158787255', '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 11:16:08 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 11:16:08 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 11:16:08 INFO - Using env: {'DISPLAY': ':0', 11:16:08 INFO - 'HOME': '/home/cltbld', 11:16:08 INFO - 'LANG': 'en_US.UTF-8', 11:16:08 INFO - 'LANGUAGE': 'en_US:en', 11:16:08 INFO - 'LOGNAME': 'cltbld', 11:16:08 INFO - 'MAIL': '/var/mail/cltbld', 11:16:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:08 INFO - 'MOZ_NO_REMOTE': '1', 11:16:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:08 INFO - 'NO_EM_RESTART': '1', 11:16:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:08 INFO - 'PWD': '/builds/slave/test', 11:16:08 INFO - 'SHELL': '/bin/bash', 11:16:08 INFO - 'SHLVL': '1', 11:16:08 INFO - 'TERM': 'linux', 11:16:08 INFO - 'TMOUT': '86400', 11:16:08 INFO - 'USER': 'cltbld', 11:16:08 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1466704507.732576-158787255', 11:16:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:08 INFO - '_': '/tools/buildbot/bin/python'} 11:16:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:16:08 INFO - Running setup.py (path:/tmp/pip-TRdFEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:16:08 INFO - Running setup.py (path:/tmp/pip-eq7omp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:16:08 INFO - Running setup.py (path:/tmp/pip-AbY12G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:16:08 INFO - Running setup.py (path:/tmp/pip-hFOov0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:16:09 INFO - Running setup.py (path:/tmp/pip-mH1scN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:16:09 INFO - Running setup.py (path:/tmp/pip-wMv5oC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:16:09 INFO - Running setup.py (path:/tmp/pip-xP_Lc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:16:09 INFO - Running setup.py (path:/tmp/pip-W6qzuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:16:09 INFO - Running setup.py (path:/tmp/pip-whuDXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:16:09 INFO - Running setup.py (path:/tmp/pip-ZGFUmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:16:09 INFO - Running setup.py (path:/tmp/pip-FSCKpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:16:09 INFO - Running setup.py (path:/tmp/pip-BGh7vd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:16:09 INFO - Running setup.py (path:/tmp/pip-SZSeez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:16:09 INFO - Running setup.py (path:/tmp/pip-lONanu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:16:09 INFO - Running setup.py (path:/tmp/pip-Qwh9Gt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:16:09 INFO - Running setup.py (path:/tmp/pip-oCJHaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:16:09 INFO - Running setup.py (path:/tmp/pip-YkDO1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:16:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:16:09 INFO - Running setup.py install for manifestparser 11:16:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:16:10 INFO - Running setup.py install for mozcrash 11:16:10 INFO - Running setup.py install for mozdebug 11:16:10 INFO - Running setup.py install for mozdevice 11:16:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:16:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:16:10 INFO - Running setup.py install for mozfile 11:16:10 INFO - Running setup.py install for mozhttpd 11:16:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:16:10 INFO - Running setup.py install for mozinfo 11:16:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:16:10 INFO - Running setup.py install for mozInstall 11:16:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:16:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:16:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:16:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:16:10 INFO - Running setup.py install for mozleak 11:16:10 INFO - Running setup.py install for mozlog 11:16:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:16:11 INFO - Running setup.py install for moznetwork 11:16:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:16:11 INFO - Running setup.py install for mozprocess 11:16:11 INFO - Running setup.py install for mozprofile 11:16:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:16:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:16:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:16:11 INFO - Running setup.py install for mozrunner 11:16:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:16:11 INFO - Running setup.py install for mozscreenshot 11:16:11 INFO - Running setup.py install for moztest 11:16:11 INFO - Running setup.py install for mozversion 11:16:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:16:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:16:11 INFO - Cleaning up... 11:16:11 INFO - Return code: 0 11:16:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:16:11 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')]} 11:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:11 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')]} 11:16:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:11 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 0x7effd4b30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ba1c0>, '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 0x16bb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bb550>, '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': '836cfdc75598d54cb747368e000001a9-1466704507.732576-158787255', '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 11:16:11 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 11:16:11 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 11:16:11 INFO - Using env: {'DISPLAY': ':0', 11:16:11 INFO - 'HOME': '/home/cltbld', 11:16:11 INFO - 'LANG': 'en_US.UTF-8', 11:16:11 INFO - 'LANGUAGE': 'en_US:en', 11:16:11 INFO - 'LOGNAME': 'cltbld', 11:16:11 INFO - 'MAIL': '/var/mail/cltbld', 11:16:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:11 INFO - 'MOZ_NO_REMOTE': '1', 11:16:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:11 INFO - 'NO_EM_RESTART': '1', 11:16:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:11 INFO - 'PWD': '/builds/slave/test', 11:16:11 INFO - 'SHELL': '/bin/bash', 11:16:11 INFO - 'SHLVL': '1', 11:16:11 INFO - 'TERM': 'linux', 11:16:11 INFO - 'TMOUT': '86400', 11:16:11 INFO - 'USER': 'cltbld', 11:16:11 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1466704507.732576-158787255', 11:16:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:11 INFO - '_': '/tools/buildbot/bin/python'} 11:16:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:16:11 INFO - Running setup.py (path:/tmp/pip-qb4nyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:16:12 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)) 11:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:16:12 INFO - Running setup.py (path:/tmp/pip-0QeDTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:16:12 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)) 11:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:16:12 INFO - Running setup.py (path:/tmp/pip-MLiSRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:16:12 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)) 11:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:16:12 INFO - Running setup.py (path:/tmp/pip-OtUXFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:16:12 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)) 11:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:16:12 INFO - Running setup.py (path:/tmp/pip-0aS9P0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:16:12 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)) 11:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:16:12 INFO - Running setup.py (path:/tmp/pip-zTGfFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:16:12 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)) 11:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:16:12 INFO - Running setup.py (path:/tmp/pip-gHfVFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:16:12 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)) 11:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:16:12 INFO - Running setup.py (path:/tmp/pip-0VRmHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:16:12 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)) 11:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:16:12 INFO - Running setup.py (path:/tmp/pip-y9U9lI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:16:12 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)) 11:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:16:12 INFO - Running setup.py (path:/tmp/pip-pP9lu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:16:12 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)) 11:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:16:12 INFO - Running setup.py (path:/tmp/pip-4Pbut0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:16:12 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)) 11:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:16:12 INFO - Running setup.py (path:/tmp/pip-5QmVEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:16:12 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)) 11:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:16:12 INFO - Running setup.py (path:/tmp/pip-7zQWuz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:16:12 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)) 11:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:16:12 INFO - Running setup.py (path:/tmp/pip-nriqyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:16:13 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)) 11:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:16:13 INFO - Running setup.py (path:/tmp/pip-UJ8OdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:16:13 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)) 11:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:16:13 INFO - Running setup.py (path:/tmp/pip-mcbAQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:16:13 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)) 11:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:16:13 INFO - Running setup.py (path:/tmp/pip-gIyfc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:16:13 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)) 11:16:13 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)) 11:16:13 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)) 11:16:13 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)) 11:16:13 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)) 11:16:13 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)) 11:16:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:16:13 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 11:16:13 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 11:16:13 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 11:16:13 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 11:16:13 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 11:16:13 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 11:16:15 INFO - Downloading blessings-1.6.tar.gz 11:16:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:16:15 INFO - Installing collected packages: blessings 11:16:15 INFO - Running setup.py install for blessings 11:16:15 INFO - Successfully installed blessings 11:16:15 INFO - Cleaning up... 11:16:15 INFO - Return code: 0 11:16:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:16:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:16:15 INFO - Reading from file tmpfile_stdout 11:16:15 INFO - Current package versions: 11:16:15 INFO - argparse == 1.2.1 11:16:15 INFO - blessings == 1.6 11:16:15 INFO - blobuploader == 1.2.4 11:16:15 INFO - docopt == 0.6.1 11:16:15 INFO - functools32 == 3.2.3-2 11:16:15 INFO - jsonschema == 2.5.1 11:16:15 INFO - manifestparser == 1.1 11:16:15 INFO - mozInstall == 1.12 11:16:15 INFO - mozcrash == 0.17 11:16:15 INFO - mozdebug == 0.1 11:16:15 INFO - mozdevice == 0.48 11:16:15 INFO - mozfile == 1.2 11:16:15 INFO - mozhttpd == 0.7 11:16:15 INFO - mozinfo == 0.9 11:16:15 INFO - mozleak == 0.1 11:16:15 INFO - mozlog == 3.2 11:16:15 INFO - moznetwork == 0.27 11:16:15 INFO - mozprocess == 0.22 11:16:15 INFO - mozprofile == 0.28 11:16:15 INFO - mozrunner == 6.11 11:16:15 INFO - mozscreenshot == 0.1 11:16:15 INFO - mozsystemmonitor == 0.3 11:16:15 INFO - moztest == 0.7 11:16:15 INFO - mozversion == 1.4 11:16:15 INFO - psutil == 3.1.1 11:16:15 INFO - requests == 1.2.3 11:16:15 INFO - wsgiref == 0.1.2 11:16:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:16:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:15 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 0x7effd4b30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ba1c0>, '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 0x16bb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bb550>, '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': '836cfdc75598d54cb747368e000001a9-1466704507.732576-158787255', '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 11:16:15 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 11:16:15 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 11:16:15 INFO - Using env: {'DISPLAY': ':0', 11:16:15 INFO - 'HOME': '/home/cltbld', 11:16:15 INFO - 'LANG': 'en_US.UTF-8', 11:16:15 INFO - 'LANGUAGE': 'en_US:en', 11:16:15 INFO - 'LOGNAME': 'cltbld', 11:16:15 INFO - 'MAIL': '/var/mail/cltbld', 11:16:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:15 INFO - 'MOZ_NO_REMOTE': '1', 11:16:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:15 INFO - 'NO_EM_RESTART': '1', 11:16:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:15 INFO - 'PWD': '/builds/slave/test', 11:16:15 INFO - 'SHELL': '/bin/bash', 11:16:15 INFO - 'SHLVL': '1', 11:16:15 INFO - 'TERM': 'linux', 11:16:15 INFO - 'TMOUT': '86400', 11:16:15 INFO - 'USER': 'cltbld', 11:16:15 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1466704507.732576-158787255', 11:16:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:15 INFO - '_': '/tools/buildbot/bin/python'} 11:16:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:15 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)) 11:16:15 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)) 11:16:15 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)) 11:16:15 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)) 11:16:15 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)) 11:16:15 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)) 11:16:15 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)) 11:16:15 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)) 11:16:15 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)) 11:16:15 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)) 11:16:15 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)) 11:16:15 INFO - Cleaning up... 11:16:15 INFO - Return code: 0 11:16:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:16:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:15 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 0x7effd4b30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ba1c0>, '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 0x16bb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bb550>, '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': '836cfdc75598d54cb747368e000001a9-1466704507.732576-158787255', '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 11:16:15 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 11:16:15 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 11:16:15 INFO - Using env: {'DISPLAY': ':0', 11:16:15 INFO - 'HOME': '/home/cltbld', 11:16:15 INFO - 'LANG': 'en_US.UTF-8', 11:16:15 INFO - 'LANGUAGE': 'en_US:en', 11:16:15 INFO - 'LOGNAME': 'cltbld', 11:16:15 INFO - 'MAIL': '/var/mail/cltbld', 11:16:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:15 INFO - 'MOZ_NO_REMOTE': '1', 11:16:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:15 INFO - 'NO_EM_RESTART': '1', 11:16:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:15 INFO - 'PWD': '/builds/slave/test', 11:16:15 INFO - 'SHELL': '/bin/bash', 11:16:15 INFO - 'SHLVL': '1', 11:16:15 INFO - 'TERM': 'linux', 11:16:15 INFO - 'TMOUT': '86400', 11:16:15 INFO - 'USER': 'cltbld', 11:16:15 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1466704507.732576-158787255', 11:16:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:15 INFO - '_': '/tools/buildbot/bin/python'} 11:16:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:16:15 INFO - Cleaning up... 11:16:16 INFO - Return code: 0 11:16:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:16:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:16 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 0x7effd4b30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ba1c0>, '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 0x16bb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bb550>, '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': '836cfdc75598d54cb747368e000001a9-1466704507.732576-158787255', '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 11:16:16 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 11:16:16 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 11:16:16 INFO - Using env: {'DISPLAY': ':0', 11:16:16 INFO - 'HOME': '/home/cltbld', 11:16:16 INFO - 'LANG': 'en_US.UTF-8', 11:16:16 INFO - 'LANGUAGE': 'en_US:en', 11:16:16 INFO - 'LOGNAME': 'cltbld', 11:16:16 INFO - 'MAIL': '/var/mail/cltbld', 11:16:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:16 INFO - 'MOZ_NO_REMOTE': '1', 11:16:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:16 INFO - 'NO_EM_RESTART': '1', 11:16:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:16 INFO - 'PWD': '/builds/slave/test', 11:16:16 INFO - 'SHELL': '/bin/bash', 11:16:16 INFO - 'SHLVL': '1', 11:16:16 INFO - 'TERM': 'linux', 11:16:16 INFO - 'TMOUT': '86400', 11:16:16 INFO - 'USER': 'cltbld', 11:16:16 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1466704507.732576-158787255', 11:16:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:16 INFO - '_': '/tools/buildbot/bin/python'} 11:16:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:16 INFO - Downloading/unpacking flake8 11:16:16 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 11:16:16 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 11:16:16 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 11:16:16 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 11:16:16 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 11:16:16 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 11:16:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:16:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:16:18 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 11:16:18 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 11:16:18 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 11:16:18 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 11:16:18 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 11:16:18 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 11:16:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:16:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:16:18 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 11:16:18 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 11:16:18 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 11:16:18 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 11:16:18 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 11:16:18 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 11:16:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:16:18 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 11:16:18 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 11:16:18 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 11:16:18 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 11:16:18 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 11:16:18 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 11:16:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:16:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:16:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:16:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:16:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:16:18 INFO - no previously-included directories found matching 'docs/_build' 11:16:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:16:18 INFO - Running setup.py install for pep8 11:16:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:16:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:16:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:16:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:16:18 INFO - no previously-included directories found matching 'docs/_build' 11:16:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:16:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:16:19 INFO - Cleaning up... 11:16:19 INFO - Return code: 0 11:16:19 INFO - Running post-action listener: _resource_record_post_action 11:16:19 INFO - Running post-action listener: _start_resource_monitoring 11:16:19 INFO - Starting resource monitoring. 11:16:19 INFO - ##### 11:16:19 INFO - ##### Finished create-virtualenv step (success) 11:16:19 INFO - ##### 11:16:19 INFO - ##### 11:16:19 INFO - ##### Running install step. 11:16:19 INFO - ##### 11:16:19 INFO - Running pre-action listener: _resource_record_pre_action 11:16:19 INFO - Running main action method: install 11:16:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:16:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:16:19 INFO - Reading from file tmpfile_stdout 11:16:19 INFO - Detecting whether we're running mozinstall >=1.0... 11:16:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:16:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:16:19 INFO - Reading from file tmpfile_stdout 11:16:19 INFO - Output received: 11:16:19 INFO - Usage: mozinstall [options] installer 11:16:19 INFO - Options: 11:16:19 INFO - -h, --help show this help message and exit 11:16:19 INFO - -d DEST, --destination=DEST 11:16:19 INFO - Directory to install application into. [default: 11:16:19 INFO - "/builds/slave/test"] 11:16:19 INFO - --app=APP Application being installed. [default: firefox] 11:16:19 INFO - mkdir: /builds/slave/test/build/application 11:16:19 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'] 11:16:19 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 11:16:36 INFO - Reading from file tmpfile_stdout 11:16:36 INFO - Output received: 11:16:36 INFO - /builds/slave/test/build/application/firefox/firefox 11:16:36 INFO - Running post-action listener: _resource_record_post_action 11:16:36 INFO - ##### 11:16:36 INFO - ##### Finished install step (success) 11:16:36 INFO - ##### 11:16:36 INFO - ##### 11:16:36 INFO - ##### Running run-tests step. 11:16:36 INFO - ##### 11:16:36 INFO - Running pre-action listener: _resource_record_pre_action 11:16:36 INFO - Running main action method: run_tests 11:16:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:16:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:16:36 INFO - Python 2.7.3 11:16:36 INFO - Return code: 0 11:16:36 INFO - grabbing minidump binary from tooltool 11:16:36 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')]} 11:16:36 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 0x16ba1c0>, '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 0x16bb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bb550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:16:36 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 11:16:36 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 11:16:36 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 11:16:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:16:36 INFO - Return code: 0 11:16:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:16:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:16:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:16:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:16:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:16:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:16:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:16:37 INFO - Return code: 0 11:16:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 11:16:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --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 11:16:37 INFO - Using env: {'DISPLAY': ':0', 11:16:37 INFO - 'HOME': '/home/cltbld', 11:16:37 INFO - 'LANG': 'en_US.UTF-8', 11:16:37 INFO - 'LANGUAGE': 'en_US:en', 11:16:37 INFO - 'LOGNAME': 'cltbld', 11:16:37 INFO - 'MAIL': '/var/mail/cltbld', 11:16:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:16:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:16:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:37 INFO - 'MOZ_NO_REMOTE': '1', 11:16:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:16:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:37 INFO - 'NO_EM_RESTART': '1', 11:16:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:37 INFO - 'PWD': '/builds/slave/test', 11:16:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:16:37 INFO - 'SHELL': '/bin/bash', 11:16:37 INFO - 'SHLVL': '1', 11:16:37 INFO - 'TERM': 'linux', 11:16:37 INFO - 'TMOUT': '86400', 11:16:37 INFO - 'USER': 'cltbld', 11:16:37 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1466704507.732576-158787255', 11:16:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:37 INFO - '_': '/tools/buildbot/bin/python'} 11:16:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 11:16:37 INFO - mozversion application_buildid: 20160623083101 11:16:37 INFO - mozversion application_changeset: a7e793ef71a31643eddd1bf7cb7a80b580cb8284 11:16:37 INFO - mozversion application_display_name: Nightly 11:16:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:16:37 INFO - mozversion application_name: Firefox 11:16:37 INFO - mozversion application_remotingname: firefox 11:16:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:16:37 INFO - mozversion application_vendor: Mozilla 11:16:37 INFO - mozversion application_version: 50.0a1 11:16:37 INFO - mozversion platform_buildid: 20160623083101 11:16:37 INFO - mozversion platform_changeset: a7e793ef71a31643eddd1bf7cb7a80b580cb8284 11:16:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:16:37 INFO - mozversion platform_version: 50.0a1 11:16:37 INFO - using testdate: 1466705797 11:16:37 INFO - actual date: 1466705797 11:16:37 INFO - starting webserver on 'localhost:60733' 11:16:37 INFO - SUITE-START | Running 2 tests 11:16:37 INFO - TEST-START | dromaeo_css 11:16:37 INFO - operating with platform_type : linux_ 11:16:37 INFO - Initialising browser for dromaeo_css test... 11:16:37 INFO - TEST-INFO | started process 3722 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHvCCl8/profile http://localhost:60733/getInfo.html) 11:16:41 INFO - PROCESS | 3722 | __metrics Screen width/height:1600/1200 11:16:41 INFO - PROCESS | 3722 | colorDepth:24 11:16:41 INFO - PROCESS | 3722 | Browser inner width/height: 1024/697 11:16:41 INFO - PROCESS | 3722 | __metrics 11:16:43 INFO - PROCESS | 3722 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:16:43 INFO - PROCESS | 3722 | console.error: PushService: 11:16:43 INFO - PROCESS | 3722 | stateChangeProcessEnqueue: Error transitioning state 11:16:43 INFO - PROCESS | 3722 | UnknownError 11:16:44 INFO - TEST-INFO | 3722: exit 0 11:16:44 INFO - Browser initialized. 11:16:44 INFO - Running cycle 1/1 for dromaeo_css test... 11:16:44 INFO - TEST-INFO | started process 3805 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHvCCl8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:16:56 INFO - PROCESS | 3805 | RSS: Main: 174321664 11:16:56 INFO - PROCESS | 3805 | 11:17:46 INFO - PROCESS | 3805 | 1466705866759 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] 11:19:55 INFO - PROCESS | 3805 | Cycle 1(1): loaded http://localhost:60733/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60733/tests/dromaeo/cssquery-ext.html) 11:19:56 INFO - PROCESS | 3805 | RSS: Main: 264323072 11:19:56 INFO - PROCESS | 3805 | 11:22:59 INFO - PROCESS | 3805 | Cycle 1(1): loaded http://localhost:60733/tests/dromaeo/cssquery-ext.html (next: http://localhost:60733/tests/dromaeo/cssquery-jquery.html) 11:22:59 INFO - PROCESS | 3805 | RSS: Main: 271237120 11:22:59 INFO - PROCESS | 3805 | 11:26:01 INFO - PROCESS | 3805 | Cycle 1(1): loaded http://localhost:60733/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60733/tests/dromaeo/cssquery-mootools.html) 11:26:02 INFO - PROCESS | 3805 | RSS: Main: 261480448 11:26:02 INFO - PROCESS | 3805 | 11:29:04 INFO - PROCESS | 3805 | Cycle 1(1): loaded http://localhost:60733/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60733/tests/dromaeo/cssquery-prototype.html) 11:29:05 INFO - PROCESS | 3805 | RSS: Main: 262012928 11:29:05 INFO - PROCESS | 3805 | 11:32:07 INFO - PROCESS | 3805 | Cycle 1(1): loaded http://localhost:60733/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60733/tests/dromaeo/cssquery-yui.html) 11:32:08 INFO - PROCESS | 3805 | RSS: Main: 250990592 11:32:08 INFO - PROCESS | 3805 | 11:35:11 INFO - PROCESS | 3805 | Cycle 1(1): loaded http://localhost:60733/tests/dromaeo/cssquery-yui.html (next: http://localhost:60733/tests/dromaeo/cssquery-dojo.html) 11:35:11 INFO - PROCESS | 3805 | RSS: Main: 293494784 11:35:11 INFO - PROCESS | 3805 | 11:35:11 INFO - PROCESS | 3805 | __start_tp_report 11:35:11 INFO - PROCESS | 3805 | _x_x_mozilla_page_load 11:35:11 INFO - PROCESS | 3805 | _x_x_mozilla_page_load_details 11:35:11 INFO - PROCESS | 3805 | |i|pagename|runs| 11:35:11 INFO - PROCESS | 3805 | |0;dojo.html;3147.9999999999986;3152.5744024556684;3165.6359518655363;3172.0959526534944;3201.40773956818;5342.839714808562;5355.812546560871;5445.673259604427;5456.809011684587;5484.670919744814;5415.214793854899;5416.83749487515;5431.4840090191365;5491.176323551469;5521.779128834852;4919.877003074916;4922.55696987271;4968.826091086813;4984.576311013569;5100.183970564711;5007.724575148365;5040.1935690289565;5050.368703912011;5054.1913293872985;5074.517920797518;4818.855434336975;4861.9027619447415;4891.437484689235;4917.483664215241;4971.527704868032;4889.559939605417;4896.436909755388;4900.191468407708;4960.950390496121;4994.150994330972;4925.704457732548;4929.827456039057;4932.876678083041;4946.40643122824;4979.203327467624;5247.86880327991;5325.4142044375085;5400.540954018913;5413.512783849433;5461.754221060062;5826.126081087828;5847.8245652630485;5858.912116318259;5861.150133230658;5867.442592953663;5623.522000629951;5891.941080589225;5909.4090590941;5918.201042859245;5919.585629005971;5359.303290572239;5408.432114627947;5410.08028635133;5470.72646367688;5488.341399032061;6020.337762846083;6023.668698221552;6024.879502409927;6027.126066720301;6027.819165425044;5589.357223919302;5656.123300888369;5773.566982476331;5779;5781.82654520365;5774.364819869811;5809.970950145307;5815.273090863642;5815.82552523425;5869.178315035899;5748.109043098327;5784.59507834456;5793.94206057934;5795.420457954255;5799.101139323411;5549.694766787785;5732.541396688255;5778.653280803165;5784.652920824764;5792.768289268382;4415.2935530315;4417.939694473367;4425.690201685916;4452.799624016862;4453.020335526179;3940.960590394059;3963.9801800991386;3966.36538153894;3990.8204130814183;4001.299772539794;5338.97330513345;5396.271503347077;5403.054465468527;5431.891362172734;5440.347158341025;5802.303723553201;5852.385499522574;5875.324337701134;5881.323647780475;5915.970420147872;5430.484104010192;5456.154296084113;5494.2857428534035;5500.064988951888;5505.834824955257;4838.395200599925;4968.403791544965;5011.6241281904;5012.874678133076;5034.0938631046765;5992.970035149797;5993.4905533029305;5995.490383317379;5997.940020599825;6028.367021462771;5827.24245848054;5843.561732869966;5848.239728835224;5849.853753656193;5851.765929362778;5715.542756579381;5888.381719919518;5949.613275137275;5954.315253745702;5980.970095149496;5692.1461780733225;5719.656820590778;5737.08206686928;5738.426157384228;5738.885222295614;5795.39148389413;5837.949169149594;5843.824685259449;5846.298444186725;5859.326177489473;5550.611457197957;5655.038643430709;5735.541156707537;5738.053221218453;5770.480656740913;5727.31272247333;5736.6558006519745;5738.626989245686;5742.339630942495;5743.224664670216;5334.11987022137;5580.079286917613;5595.216669666169;5598.076317407745;5650.915236271541;5597.776088956396;5664.745086471036;5673.149027645886;5739.225204597493;5745.885082298414;5528.834134975958;5557.666540007613;5558.194061860927;5560.4161563035295;5568.192612071146 11:35:11 INFO - PROCESS | 3805 | |1;ext.html;618.2241287184584;622.6979914741353;638.9553080713035;640.0910706796349;647.2007071266985;33540;42329.78835105824;43851.99999999996;43949;47598.524014759845;45069.549304506945;45511.317330240076;45512.77243613786;45521.77239113808;45551.77224113875;8719.738407847759;8961.327900407463;8961.955190224073;8966.462012279251;8968.64125434985;8778.078301778318;8853.291736661084;8868.556572171397;8870.334724895627;8873.866891996626;8901.06538813425;8915.509646969414;8946.41848279863;8948.910510894906;8955.328350373715;8814.823703525926;8854.645814167425;8860.379773415863;8862.379633425662;8865.645374185056;8756.299496040301;8841.513716745576;8845.513496757676;8853.645854165825;8854;41906.37140442896;42346.364804527955;42359.152816943795;42389;42518.14963700709;3204.7916885402374;3425.743069269815;3521.4365701487895;3916.432117342998;4026.7583944963103;32680.836595817105;32964.3407131856;33141.6685833141;33181.6681833181;33275.500867487004;4372.781360931973;4431.268840641323;4431.778411079433;4440.711353762027;4530.184566777979;225379;225722;225843;225917.99999999837;226335;51037;56651;57176.71411642915;57681.71159144177;58135.70932145312;62437.68781156065;62590.374096259366;62761.37238627555;62820;62854.68572657107;16832;17115.572110697332;17116.572085697957;17124.229409676595;17125.400610978555;12200.75598488043;12421.31682757457;13160.078794484485;13272.070955033056;13361.66595835112;16893.15534223284;16977.066261355743;16982;17003.574910627332;17043.14784260782;6449.709763060673;6540.869182616321;6609.812340967005;6640.136782218281;6856.108705868205;928.1878356438117;1055.4617145255975;1062.8830828608848;1081.3565928272665;1097.1442275025333;32388.86638967625;32623.836880815445;32802.67197328044;33295.99705292311;33559.83220083933;1072.769354588767;1112.7496313329598;1116.1573012375604;1182.8403165572709;1230.083587727149;16415.507534773977;17038.914805426142;17254.741178882326;17287.74068388975;17400.65198696019;461020;468138;468405;470970;472233;56804;57079.71460142756;57295.42704572901;57302;57357.71321143451;1248.1263115818963;1334.212814439466;1381.1298881704463;1385.4181243877595;1401.4814518628173;32390;33629.83185084059;33925.66074339324;33931;34190.65809341974;49875.25187122123;50275.49724502708;50328.74835625799;50349;50391.49608503868;391865;392532;396273;396533;396550;36299.63700362963;41011.384829228184;41238.79380603078;41293;42252.57747422486;48816.75591622161;49344.506554935426;49389;49776;49932.25101623551;40552.391714124904;41399.58600413957;41470.58529414667;42331.365029523964;42933;40505.34538244591;41516;41743.7912810434;41775;42624;40268.597314027655;40742.59257407388;40873;41303.58696412997;41314.58685413108;35444.82277588596;36488.27023459569;36591.26817463583;36698;37171.256574868894;27732.861335693193;27816.033830578785;28093.719062809112;28098.438031238853;28110.296531349748 11:35:11 INFO - PROCESS | 3805 | |2;jquery.html;381.57645014034415;392.67408051317403;394.0064438492296;397.52694293790387;400.8897553172877;14512.274386280696;16134.515964521053;18617;19261.614767704654;19274.42176734697;18128.728069078974;18299.725504117414;19068.71396929044;19127.61744765104;19154.712679309785;5112.718800465973;5140.126178549637;5869.090291004901;5893.675847828367;5899.056151015839;4024.9396259055993;5734.856628584277;5774.5091667208335;5863.8534036649;5881.294244690643;5988.071848863433;6018.398160183969;6063.757449702007;6073.180120683717;6092.360302168275;5611.9438805612235;5910.67491287979;5918.201042859202;6024.608400453956;6027.9095813562835;5738.942610573882;5777.133429985536;5786.103154011135;5789.536837053026;5809.477147056785;13541.729165416735;13766.862331376758;14067.085639433404;14094.788578171336;14271;2367.9526409471887;2382.9642555361684;2407.9759202407927;2552.3746682063015;2837.67366752824;10071.395716257048;10249.9487502562;10786.406747628876;12747.936260318731;13782.65543361414;1954.0522846419476;2005.9097340619708;2100.85294029418;2107.4520624637553;2154.762976072631;74406;77056.61471692662;78574.21425785784;79717;80762.59618701869;10586.735331616617;10602.310849794738;10756.408397538054;10777.51501182433;11149.386783726974;13798.310084495735;15416;15435.30541125652;15436.845631543765;26424.603630945552;9936.155426788659;10031.949840250898;10261.640842570474;10331.896681033244;10525.105366043972;8573.699920502877;8645.697400590949;8713.695020674246;8765.824683506295;9196.080391960884;8628.568571571523;8872.955635221782;8952;8961.327900407496;9007.729768106967;3142.5443310719816;3203.0531910642267;3298.8185649789493;3311.718503927193;3460.584729832386;868.5917618719318;951.1059603972244;962.8603852441357;994.9452780097164;1023.6877752285476;18846.52883677919;19006.144723487476;19558.413247602595;20210.898945505178;20723.58552828935;926.8285367207088;934.756963189562;975.9365641233297;1015.94920253987;1045.1951996962448;11086.944565277123;11298.644162700528;11412.657620271406;11481.942590287163;11499.77000459986;482786;487872;488344;495151;498667;84531;91162.54418727863;93791;94008.52995734978;94416;1026.743314171457;1051.0960573906282;1054.7415883108688;1064.3720205079042;1069.7486090768664;17651.852629579036;18078.90960545189;18197.636047278716;18233.908830455763;18365.265389384276;41701.16597667969;41917.79041104897;41963.37054944117;42291.57708423;43363.78318108389;53754.73122634362;55281.723591381786;59234.70382648059;59481;59558.40441595702;8710.47737135774;8824.294056475595;8973.865392019256;8984.281257499515;9212.677556285766;10010.699679009642;10205.336653117523;12761.48954041865;13278.203307801563;13755.10591811529;11916.642500724993;11992.820107698217;12030.939845300718;12048.457819397972;12151.331676757864;11576.90019448151;11675.766484670428;11774.352410617155;11974.940125299318;12527.12310138318;12431.067669924973;12481.126321157431;12522.123451358317;12724.554640587905;12752.234865908074;8897.065808090058;9130.543472826464;9178.357514974155;9272.350935434455;9353;12179.512819487476;12296.81554776697;12307.323097229739;12445.62663120108;12457.06572007085 11:35:11 INFO - PROCESS | 3805 | |3;mootools.html;1341.6712905338193;1438.3455527734882;1505.292512519116;1568.2629164292778;1743.1894169211314;7520.511166774156;8275.75172744817;8544.829103417927;8545.74362769118;8728.083551227124;8446.070932197454;8631.48211107334;8632.913670863289;8651.091635378289;8652.610632521535;1970.290695349673;2249.302716157988;2261.570301642691;2300.7929286364224;2342.894569744357;2339.6841426407473;2361;2362.5511152880986;2363.4327761337327;2364.47981444082;2287.622542280522;2291.564602725477;2315.7568455312203;2316.3630001749484;2320.385097949036;1928.2479832865195;1980.7524059492564;2161.1139432832465;2228.275810361639;2236.7204099487562;2228.9665655015187;2241.5068684889297;2248.4828489447355;2248.910043598254;2249.49386388063;8649.610767515476;8709.69516066941;8723.607437665256;8736.301095912375;8747.125287471266;5006.5744411725045;5143.768530416103;5161.664491808058;5163.122269214243;5207.218917162418;3114.7663925205475;3231.579894613709;3238.352329534079;3306.3883181611477;3362.562866827321;1133.6145710458484;1139.1342579639452;1152.3719572832827;1164.615676826645;1164.8078067119;12202.389880506027;12224.877751222462;12238.755224895542;12243.32661703606;12268;4313.051128751669;4444.422225110715;4541.568550987651;4549.909001819945;4627.814887404534;10308.742281442874;10310.175185985103;10324.43215623148;10324.535395907202;10336.379817210842;5181.171012637959;5210.97394513025;5238.423773384925;5246.97376513115;5257.894842103136;4179.6029377209115;4660.394148760707;4785.784639691222;4799.952000480021;4877.756112194447;3836.462895194675;3859.150986782903;3896.9610303897166;3912.5304963404574;3984.4858953598027;1166.457597217281;1200.2858299311895;1201.2552217625127;1214.1076308913118;1242.105683907585;922.7831459606987;952.0289304908954;954.5609019850947;961.5913236874441;994.8358520844124;5859.53123750099;6001.4298641628975;6011.158437818709;6067.271927368744;6098.847528811726;939.7791518993031;943.8065196634674;947.6777895515557;952.8094381123803;968.7384406210284;4294.248506511411;4342.82628694855;4358.912821743547;4372.868813935587;4424.31423129409;10786.244962852681;10993.725156871142;11114.777704445865;11139.387333696724;11152.442377881074;10208.846867296996;10644.574217031231;11045.005949464587;11051.668449946514;11061.059809916247;8094.797630059295;8201.22088401601;8229.670813167526;8267.421280510307;8283.130271321425;6074.696265186634;6317.936820631735;6333.271673757393;6418.614883106842;6424.458130048848;10145.137663298407;10150.847737284093;10219.948900255451;10273.640422585173;10286.485675716334;9946.204303655546;10568.89431105679;10606.893931060591;10612.097971672185;10624.521896514521;7217.494775365674;7603.353714934293;7649.808754781175;7749.651265692944;7897.210278972057;8648.82702345937;8666.35002374837;8740.737777866674;8747.212750852454;8751.168638979287;7570.280823321776;7794.376449884109;7798.454108212371;7855.332296754611;7864.095629002738;7632.274933881273;7653.808654783452;7660.69357225727;7788.065432148179;7901.17037711055;7088.397486213729;7114.964425177841;7159.212486626571;7174.605396703231;7198.172210195685;5103.974480127576;5119;5179.40436849752;5205.401378841481;5273.7363131842485;4861.124997500484;4932.21084626458;5000.774965126505;5103.234514822658;5141.53726164647 11:35:11 INFO - PROCESS | 3805 | |4;prototype.html;318.97607679424044;319.50955283639615;328.20901627078746;336.1562478179768;337.2428897125953;5006.399232092145;5283.233931079996;5332.893342133155;5333.706646134461;5381.730913454327;5266.841994740154;5269.76286067127;5300.602454815895;5313.22958171065;5314.734263286839;4070.9389359159636;4081.5102187737366;4089.1003979124544;4101.159262351226;4101.200265948141;3950.604939506041;4072.3687828386646;4077.3068578341604;4112.876613701579;4156.480439945007;4116.847282760817;4118.444010058649;4119.917601647965;4130.8554200602985;4144.927536231884;4117.64999975001;4157.91684166315;4163.3138578875305;4164.8125834337525;4174.686898482626;3681.208540163878;3698.1124530112847;3706.629337066299;3709.888703338904;3724.2737666155112;5023.598112151056;5142.562882155022;5148.510891465305;5171.276021357013;5181.766820493049;4721.032188401369;4742.620590352763;4746.762661866893;4755.952440475586;4762.3332733417;5327.174287985368;5476.424975377608;5502.422245664187;5515.834524964257;5521.171824226358;3931.410288456726;3940.330143875548;3941.960580394188;3944.9408258876138;3950.348192548226;5429.972850135763;5533.723313834292;5629.296337957755;5732.684702341411;5739;4131.772752498581;4141.420201171838;4158.584141585818;4167.437395951508;4179.373094035858;4163.417121602978;4184.28867092595;4190.1200747843295;4210.45264115663;4214.683898707609;4517.5482451755215;4576.039031803359;4743.66794324394;4759.833405830779;4804.8318308859025;5537.086380747212;5539.390667026624;5559.24950131727;5616.248038461124;5648.830535083954;1423.5515812519022;1452.3246690289066;1468.3319089814108;1470.6176394137601;1472.263868065967;919.3059240273684;947.7298969793576;948.7201275623707;949.2548349545574;961.8990006049404;4791.5687588117235;4791.969726508817;4820.6143508519235;4877.804887804448;4881.975590122027;5107.67200527858;5110.795568177231;5125.436202017775;5125.436741793714;5154.793808247703;4544.681872268976;4830.8792280193275;4835;4856.927146092811;4865.245886887538;2650.966123211949;2725.3459169799107;2747.931301717433;2748.2030211238516;2750.7111753266017;5144.6913185209005;5161.225816127536;5185.844424667266;5204.8178313758835;5275.762590683428;5084;5148.794048238104;5463.535599474089;5820.806734619393;5918.704064796829;5816.970915145482;5825.825225243165;5838.649681018983;5846.532277417797;5862.296524417097;5503.174523821459;5694.4590263924865;5730.885382292247;5737.942620573741;5818.33089194748;5644.8306550803545;5656;5676.971615141898;5677.5457963362005;5713.7428815704225;5627.90255900112;5746;5890.558208134321;5972.611780234271;5979.4618484336615;4080.551139374607;4092.7135100542678;4095.4266402704243;4118.258713431491;4150.647194988339;5718;5788.247527821356;5819.738111785065;5862.824115276378;5864.885671722359;5564.137558678412;5565.693886836263;5568.327202942529;5608.971955140199;5648.435156484319;5542.445755424425;5542.916856247079;5548.916766248591;5582.8325150245555;5589.496945274945;5366.141417373202;5419.241306217212;5491.917621235605;5518.013515134468;5527.613067085265;5545.334559852682;5553.278073850373;5579.525740312119;5628.324601047901;5655.547556195576;5445.917779058851;5484.972575137258;5493.642913210629;5506.669599824023;5527.115661494142 11:35:11 INFO - PROCESS | 3805 | |5;yui.html;715.609992554058;764.8049747314434;781.2070748190588;832.5670651261348;857.1685465098856;15177.544673659793;16562.7515587266;16610.41863534775;16814.24335904884;16874.156292185387;14915.627109322273;15007.399704011827;15048.398064077452;15055.849441505581;15086.3211155498;660.8645227728316;780.3055280800093;797.5573556676043;800.4716886854677;804.3565147881671;768.8116411479167;777.6306254529081;784.8940393046951;785.0383280481421;785.6543121026758;700.4536461559966;839.5844057191699;839.8782176584422;840.1850205300879;841.1252297610478;831.3681601982506;840.197611281228;841.6801615386145;848.567230712335;848.8217474330398;619.3280290884351;619.3991827926949;619.5632079384023;619.7644894939939;620.1751670278563;14112.435502579885;14134.081284716563;14159.646008849759;14181.929090354586;14203.218822964733;14184.43262269508;14356.49752258666;14488.71022579553;14555.272236388244;14745;12783.680407989781;12925.935370323183;13000.349982500837;13092.149010314299;13189.208647481182;4380.167768124046;4430.933535996963;4516.616087632555;4571.908561828778;4731.432228132646;79980.20019799785;81380.59309703413;81649.59175204145;82599.58700206461;82733.17266827375;11769.705757355963;11780.352080635475;11983.221090629082;12003.339816310012;12041.39793010346;21177.470563236042;21179.470513236985;21206;21220.151193952377;21241.575168496853;8184.754457366289;8271.090180080186;8342.62458189383;8450.661973521113;8874.600642971081;4772.809087636525;4777.904441911142;4784.617230621542;4881.633877459205;4882.5605695487575;3423.9486407703407;3487.720982321408;3522.330757156132;3525.541679581638;3534.717222622184;603.2820943077724;617.4597227426002;623.1991890420787;631.4380201620561;648.0926702616281;572.6764378126428;660.3198705333514;666.756633828649;686.9484788640872;723.1430754555868;9527.38072025316;9572.952135239419;9599.808003839884;9768.658096966572;9804.656837010813;560.2744445942515;572.4447286132445;578.3522454850594;641.7304732012566;721.4192574977194;4618.30725391194;4756.167670657621;4758.738269395217;4819.325294458778;4877.024595080998;112441.43779281215;112757;115751.42124289492;116010.4199479014;116146.41926790313;99555;105866.47066764616;105955.47022264994;106114.46942765237;108185.45907270414;88145;88409;89110.55444722735;89205.10794892098;90155.54922225347;8630.39587228888;8680.565971701515;8863.778405539913;8865.290776737716;9051.773705657411;51640.48359516357;52019.47980520298;52605.210921836966;52829.15125462423;53630.73184634052;71053.644731776;77491.61254193693;77786;77845;77885.61057194677;11496.770064598828;11849.229800062969;11938.224015439317;12095.879041209475;12489.375531223584;10955.370711029454;11544.67583731468;11735.941320293345;12773.680657983254;12775.808362874379;13354.866451335361;13410.932945335211;13491.392887319898;14325.426982920982;14351.712965740835;13797.379117939918;13955.790663139858;14014.789778153132;14109.576712698636;14338.928305358406;13503.527376542166;13579.45682172702;13606.251656159006;13792.793108103186;15060.849391505944;10289.228307877089;10547.314424562379;10575.576976921146;10623.309484883457;10657.467126643793;11190.832137518106;11328.433578321215;11393.829092563785;11609.245399049034;11628.709282268012 11:35:11 INFO - PROCESS | 3805 | __end_tp_report 11:35:11 INFO - PROCESS | 3805 | __start_cc_report 11:35:11 INFO - PROCESS | 3805 | _x_x_mozilla_cycle_collect,773 11:35:11 INFO - PROCESS | 3805 | __end_cc_report 11:35:11 INFO - PROCESS | 3805 | __startTimestamp1466706911322__endTimestamp 11:35:11 INFO - PROCESS | 3805 | 11:35:11 INFO - PROCESS | 3805 | ------- Summary: start ------- 11:35:11 INFO - PROCESS | 3805 | Number of tests: 6 11:35:11 INFO - PROCESS | 3805 | 11:35:11 INFO - PROCESS | 3805 | [#0] dojo.html Cycles:165 Average:5395.36 Median:5568.19 stddev:610.05 (11.0%) stddev-sans-first:585.89 11:35:11 INFO - PROCESS | 3805 | Values: 3148.0 3152.6 3165.6 3172.1 3201.4 5342.8 5355.8 5445.7 5456.8 5484.7 5415.2 5416.8 5431.5 5491.2 5521.8 4919.9 4922.6 4968.8 4984.6 5100.2 5007.7 5040.2 5050.4 5054.2 5074.5 4818.9 4861.9 4891.4 4917.5 4971.5 4889.6 4896.4 4900.2 4961.0 4994.2 4925.7 4929.8 4932.9 4946.4 4979.2 5247.9 5325.4 5400.5 5413.5 5461.8 5826.1 5847.8 5858.9 5861.2 5867.4 5623.5 5891.9 5909.4 5918.2 5919.6 5359.3 5408.4 5410.1 5470.7 5488.3 6020.3 6023.7 6024.9 6027.1 6027.8 5589.4 5656.1 5773.6 5779.0 5781.8 5774.4 5810.0 5815.3 5815.8 5869.2 5748.1 5784.6 5793.9 5795.4 5799.1 5549.7 5732.5 5778.7 5784.7 5792.8 4415.3 4417.9 4425.7 4452.8 4453.0 3941.0 3964.0 3966.4 3990.8 4001.3 5339.0 5396.3 5403.1 5431.9 5440.3 5802.3 5852.4 5875.3 5881.3 5916.0 5430.5 5456.2 5494.3 5500.1 5505.8 4838.4 4968.4 5011.6 5012.9 5034.1 5993.0 5993.5 5995.5 5997.9 6028.4 5827.2 5843.6 5848.2 5849.9 5851.8 5715.5 5888.4 5949.6 5954.3 5981.0 5692.1 5719.7 5737.1 5738.4 5738.9 5795.4 5837.9 5843.8 5846.3 5859.3 5550.6 5655.0 5735.5 5738.1 5770.5 5727.3 5736.7 5738.6 5742.3 5743.2 5334.1 5580.1 5595.2 5598.1 5650.9 5597.8 5664.7 5673.1 5739.2 5745.9 5528.8 5557.7 5558.2 5560.4 5568.2 11:35:11 INFO - PROCESS | 3805 | 11:35:11 INFO - PROCESS | 3805 | [#1] ext.html Cycles:180 Average:54177.73 Median:41840.69 stddev:99588.47 (238.0%) stddev-sans-first:99786.65 11:35:11 INFO - PROCESS | 3805 | Values: 618.2 622.7 639.0 640.1 647.2 33540.0 42329.8 43852.0 43949.0 47598.5 45069.5 45511.3 45512.8 45521.8 45551.8 8719.7 8961.3 8962.0 8966.5 8968.6 8778.1 8853.3 8868.6 8870.3 8873.9 8901.1 8915.5 8946.4 8948.9 8955.3 8814.8 8854.6 8860.4 8862.4 8865.6 8756.3 8841.5 8845.5 8853.6 8854.0 41906.4 42346.4 42359.2 42389.0 42518.1 3204.8 3425.7 3521.4 3916.4 4026.8 32680.8 32964.3 33141.7 33181.7 33275.5 4372.8 4431.3 4431.8 4440.7 4530.2 225379.0 225722.0 225843.0 225918.0 226335.0 51037.0 56651.0 57176.7 57681.7 58135.7 62437.7 62590.4 62761.4 62820.0 62854.7 16832.0 17115.6 17116.6 17124.2 17125.4 12200.8 12421.3 13160.1 13272.1 13361.7 16893.2 16977.1 16982.0 17003.6 17043.1 6449.7 6540.9 6609.8 6640.1 6856.1 928.2 1055.5 1062.9 1081.4 1097.1 32388.9 32623.8 32802.7 33296.0 33559.8 1072.8 1112.7 1116.2 1182.8 1230.1 16415.5 17038.9 17254.7 17287.7 17400.7 461020.0 468138.0 468405.0 470970.0 472233.0 56804.0 57079.7 57295.4 57302.0 57357.7 1248.1 1334.2 1381.1 1385.4 1401.5 32390.0 33629.8 33925.7 33931.0 34190.7 49875.3 50275.5 50328.7 50349.0 50391.5 391865.0 392532.0 396273.0 396533.0 396550.0 36299.6 41011.4 41238.8 41293.0 42252.6 48816.8 49344.5 49389.0 49776.0 49932.3 40552.4 41399.6 41470.6 42331.4 42933.0 40505.3 41516.0 41743.8 41775.0 42624.0 40268.6 40742.6 40873.0 41303.6 41314.6 35444.8 36488.3 36591.3 36698.0 37171.3 27732.9 27816.0 28093.7 28098.4 28110.3 11:35:11 INFO - PROCESS | 3805 | 11:35:11 INFO - PROCESS | 3805 | [#2] jquery.html Cycles:180 Average:29050.30 Median:14631.14 stddev:80767.38 (552.0%) stddev-sans-first:80965.27 11:35:11 INFO - PROCESS | 3805 | Values: 381.6 392.7 394.0 397.5 400.9 14512.3 16134.5 18617.0 19261.6 19274.4 18128.7 18299.7 19068.7 19127.6 19154.7 5112.7 5140.1 5869.1 5893.7 5899.1 4024.9 5734.9 5774.5 5863.9 5881.3 5988.1 6018.4 6063.8 6073.2 6092.4 5611.9 5910.7 5918.2 6024.6 6027.9 5738.9 5777.1 5786.1 5789.5 5809.5 13541.7 13766.9 14067.1 14094.8 14271.0 2368.0 2383.0 2408.0 2552.4 2837.7 10071.4 10249.9 10786.4 12747.9 13782.7 1954.1 2005.9 2100.9 2107.5 2154.8 74406.0 77056.6 78574.2 79717.0 80762.6 10586.7 10602.3 10756.4 10777.5 11149.4 13798.3 15416.0 15435.3 15436.8 26424.6 9936.2 10031.9 10261.6 10331.9 10525.1 8573.7 8645.7 8713.7 8765.8 9196.1 8628.6 8873.0 8952.0 8961.3 9007.7 3142.5 3203.1 3298.8 3311.7 3460.6 868.6 951.1 962.9 994.9 1023.7 18846.5 19006.1 19558.4 20210.9 20723.6 926.8 934.8 975.9 1015.9 1045.2 11086.9 11298.6 11412.7 11481.9 11499.8 482786.0 487872.0 488344.0 495151.0 498667.0 84531.0 91162.5 93791.0 94008.5 94416.0 1026.7 1051.1 1054.7 1064.4 1069.7 17651.9 18078.9 18197.6 18233.9 18365.3 41701.2 41917.8 41963.4 42291.6 43363.8 53754.7 55281.7 59234.7 59481.0 59558.4 8710.5 8824.3 8973.9 8984.3 9212.7 10010.7 10205.3 12761.5 13278.2 13755.1 11916.6 11992.8 12030.9 12048.5 12151.3 11576.9 11675.8 11774.4 11974.9 12527.1 12431.1 12481.1 12522.1 12724.6 12752.2 8897.1 9130.5 9178.4 9272.4 9353.0 12179.5 12296.8 12307.3 12445.6 12457.1 11:35:11 INFO - PROCESS | 3805 | 11:35:11 INFO - PROCESS | 3805 | [#3] mootools.html Cycles:180 Average:5791.04 Median:4723.09 stddev:3319.51 (70.3%) stddev-sans-first:3311.98 11:35:11 INFO - PROCESS | 3805 | Values: 1341.7 1438.3 1505.3 1568.3 1743.2 7520.5 8275.8 8544.8 8545.7 8728.1 8446.1 8631.5 8632.9 8651.1 8652.6 1970.3 2249.3 2261.6 2300.8 2342.9 2339.7 2361.0 2362.6 2363.4 2364.5 2287.6 2291.6 2315.8 2316.4 2320.4 1928.2 1980.8 2161.1 2228.3 2236.7 2229.0 2241.5 2248.5 2248.9 2249.5 8649.6 8709.7 8723.6 8736.3 8747.1 5006.6 5143.8 5161.7 5163.1 5207.2 3114.8 3231.6 3238.4 3306.4 3362.6 1133.6 1139.1 1152.4 1164.6 1164.8 12202.4 12224.9 12238.8 12243.3 12268.0 4313.1 4444.4 4541.6 4549.9 4627.8 10308.7 10310.2 10324.4 10324.5 10336.4 5181.2 5211.0 5238.4 5247.0 5257.9 4179.6 4660.4 4785.8 4800.0 4877.8 3836.5 3859.2 3897.0 3912.5 3984.5 1166.5 1200.3 1201.3 1214.1 1242.1 922.8 952.0 954.6 961.6 994.8 5859.5 6001.4 6011.2 6067.3 6098.8 939.8 943.8 947.7 952.8 968.7 4294.2 4342.8 4358.9 4372.9 4424.3 10786.2 10993.7 11114.8 11139.4 11152.4 10208.8 10644.6 11045.0 11051.7 11061.1 8094.8 8201.2 8229.7 8267.4 8283.1 6074.7 6317.9 6333.3 6418.6 6424.5 10145.1 10150.8 10219.9 10273.6 10286.5 9946.2 10568.9 10606.9 10612.1 10624.5 7217.5 7603.4 7649.8 7749.7 7897.2 8648.8 8666.4 8740.7 8747.2 8751.2 7570.3 7794.4 7798.5 7855.3 7864.1 7632.3 7653.8 7660.7 7788.1 7901.2 7088.4 7115.0 7159.2 7174.6 7198.2 5104.0 5119.0 5179.4 5205.4 5273.7 4861.1 4932.2 5000.8 5103.2 5141.5 11:35:11 INFO - PROCESS | 3805 | 11:35:11 INFO - PROCESS | 3805 | [#4] prototype.html Cycles:180 Average:4604.82 Median:5151.79 stddev:1346.00 (26.1%) stddev-sans-first:1310.77 11:35:11 INFO - PROCESS | 3805 | Values: 319.0 319.5 328.2 336.2 337.2 5006.4 5283.2 5332.9 5333.7 5381.7 5266.8 5269.8 5300.6 5313.2 5314.7 4070.9 4081.5 4089.1 4101.2 4101.2 3950.6 4072.4 4077.3 4112.9 4156.5 4116.8 4118.4 4119.9 4130.9 4144.9 4117.6 4157.9 4163.3 4164.8 4174.7 3681.2 3698.1 3706.6 3709.9 3724.3 5023.6 5142.6 5148.5 5171.3 5181.8 4721.0 4742.6 4746.8 4756.0 4762.3 5327.2 5476.4 5502.4 5515.8 5521.2 3931.4 3940.3 3942.0 3944.9 3950.3 5430.0 5533.7 5629.3 5732.7 5739.0 4131.8 4141.4 4158.6 4167.4 4179.4 4163.4 4184.3 4190.1 4210.5 4214.7 4517.5 4576.0 4743.7 4759.8 4804.8 5537.1 5539.4 5559.2 5616.2 5648.8 1423.6 1452.3 1468.3 1470.6 1472.3 919.3 947.7 948.7 949.3 961.9 4791.6 4792.0 4820.6 4877.8 4882.0 5107.7 5110.8 5125.4 5125.4 5154.8 4544.7 4830.9 4835.0 4856.9 4865.2 2651.0 2725.3 2747.9 2748.2 2750.7 5144.7 5161.2 5185.8 5204.8 5275.8 5084.0 5148.8 5463.5 5820.8 5918.7 5817.0 5825.8 5838.6 5846.5 5862.3 5503.2 5694.5 5730.9 5737.9 5818.3 5644.8 5656.0 5677.0 5677.5 5713.7 5627.9 5746.0 5890.6 5972.6 5979.5 4080.6 4092.7 4095.4 4118.3 4150.6 5718.0 5788.2 5819.7 5862.8 5864.9 5564.1 5565.7 5568.3 5609.0 5648.4 5542.4 5542.9 5548.9 5582.8 5589.5 5366.1 5419.2 5491.9 5518.0 5527.6 5545.3 5553.3 5579.5 5628.3 5655.5 5445.9 5485.0 5493.6 5506.7 5527.1 11:35:11 INFO - PROCESS | 3805 | 11:35:11 INFO - PROCESS | 3805 | [#5] yui.html Cycles:180 Average:21228.43 Median:4757.45 stddev:30944.81 (650.4%) stddev-sans-first:30993.28 11:35:11 INFO - PROCESS | 3805 | Values: 715.6 764.8 781.2 832.6 857.2 15177.5 16562.8 16610.4 16814.2 16874.2 14915.6 15007.4 15048.4 15055.8 15086.3 660.9 780.3 797.6 800.5 804.4 768.8 777.6 784.9 785.0 785.7 700.5 839.6 839.9 840.2 841.1 831.4 840.2 841.7 848.6 848.8 619.3 619.4 619.6 619.8 620.2 14112.4 14134.1 14159.6 14181.9 14203.2 14184.4 14356.5 14488.7 14555.3 14745.0 12783.7 12925.9 13000.3 13092.1 13189.2 4380.2 4430.9 4516.6 4571.9 4731.4 79980.2 81380.6 81649.6 82599.6 82733.2 11769.7 11780.4 11983.2 12003.3 12041.4 21177.5 21179.5 21206.0 21220.2 21241.6 8184.8 8271.1 8342.6 8450.7 8874.6 4772.8 4777.9 4784.6 4881.6 4882.6 3423.9 3487.7 3522.3 3525.5 3534.7 603.3 617.5 623.2 631.4 648.1 572.7 660.3 666.8 686.9 723.1 9527.4 9573.0 9599.8 9768.7 9804.7 560.3 572.4 578.4 641.7 721.4 4618.3 4756.2 4758.7 4819.3 4877.0 112441.4 112757.0 115751.4 116010.4 116146.4 99555.0 105866.5 105955.5 106114.5 108185.5 88145.0 88409.0 89110.6 89205.1 90155.5 8630.4 8680.6 8863.8 8865.3 9051.8 51640.5 52019.5 52605.2 52829.2 53630.7 71053.6 77491.6 77786.0 77845.0 77885.6 11496.8 11849.2 11938.2 12095.9 12489.4 10955.4 11544.7 11735.9 12773.7 12775.8 13354.9 13410.9 13491.4 14325.4 14351.7 13797.4 13955.8 14014.8 14109.6 14338.9 13503.5 13579.5 13606.3 13792.8 15060.8 10289.2 10547.3 10575.6 10623.3 10657.5 11190.8 11328.4 11393.8 11609.2 11628.7 11:35:11 INFO - PROCESS | 3805 | -------- Summary: end -------- 11:35:11 INFO - PROCESS | 3805 | 11:35:12 INFO - TEST-INFO | 3805: exit 0 11:35:12 INFO - TEST-OK | dromaeo_css | took 1114371ms 11:35:12 INFO - TEST-START | kraken 11:35:12 INFO - operating with platform_type : linux_ 11:35:12 INFO - Initialising browser for kraken test... 11:35:12 INFO - TEST-INFO | started process 3987 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6cka1R/profile http://localhost:60733/getInfo.html) 11:35:16 INFO - PROCESS | 3987 | __metrics Screen width/height:1600/1200 11:35:16 INFO - PROCESS | 3987 | colorDepth:24 11:35:16 INFO - PROCESS | 3987 | Browser inner width/height: 1024/697 11:35:16 INFO - PROCESS | 3987 | __metrics 11:35:17 INFO - PROCESS | 3987 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:35:18 INFO - TEST-INFO | 3987: exit 0 11:35:18 INFO - Browser initialized. 11:35:18 INFO - Running cycle 1/1 for kraken test... 11:35:18 INFO - TEST-INFO | started process 4070 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6cka1R/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:35:30 INFO - PROCESS | 4070 | RSS: Main: 173936640 11:35:30 INFO - PROCESS | 4070 | 11:35:32 INFO - PROCESS | 4070 | Cycle 1(1): loaded http://localhost:60733/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60733/tests/kraken/driver.html?testName=audio-beat-detection) 11:35:33 INFO - PROCESS | 4070 | RSS: Main: 232108032 11:35:33 INFO - PROCESS | 4070 | 11:35:36 INFO - PROCESS | 4070 | Cycle 1(1): loaded http://localhost:60733/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60733/tests/kraken/driver.html?testName=audio-dft) 11:35:36 INFO - PROCESS | 4070 | RSS: Main: 220442624 11:35:36 INFO - PROCESS | 4070 | 11:35:40 INFO - PROCESS | 4070 | Cycle 1(1): loaded http://localhost:60733/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60733/tests/kraken/driver.html?testName=audio-fft) 11:35:40 INFO - PROCESS | 4070 | RSS: Main: 286740480 11:35:40 INFO - PROCESS | 4070 | 11:35:42 INFO - PROCESS | 4070 | Cycle 1(1): loaded http://localhost:60733/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60733/tests/kraken/driver.html?testName=audio-oscillator) 11:35:43 INFO - PROCESS | 4070 | RSS: Main: 198262784 11:35:43 INFO - PROCESS | 4070 | 11:35:45 INFO - PROCESS | 4070 | Cycle 1(1): loaded http://localhost:60733/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60733/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:35:46 INFO - PROCESS | 4070 | RSS: Main: 200896512 11:35:46 INFO - PROCESS | 4070 | 11:35:49 INFO - PROCESS | 4070 | Cycle 1(1): loaded http://localhost:60733/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60733/tests/kraken/driver.html?testName=imaging-darkroom) 11:35:49 INFO - PROCESS | 4070 | RSS: Main: 237465600 11:35:49 INFO - PROCESS | 4070 | 11:35:53 INFO - PROCESS | 4070 | Cycle 1(1): loaded http://localhost:60733/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60733/tests/kraken/driver.html?testName=imaging-desaturate) 11:35:53 INFO - PROCESS | 4070 | RSS: Main: 238219264 11:35:53 INFO - PROCESS | 4070 | 11:35:56 INFO - PROCESS | 4070 | Cycle 1(1): loaded http://localhost:60733/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60733/tests/kraken/driver.html?testName=json-parse-financial) 11:35:57 INFO - PROCESS | 4070 | RSS: Main: 238170112 11:35:57 INFO - PROCESS | 4070 | 11:35:58 INFO - PROCESS | 4070 | Cycle 1(1): loaded http://localhost:60733/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60733/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:35:59 INFO - PROCESS | 4070 | RSS: Main: 225828864 11:35:59 INFO - PROCESS | 4070 | 11:36:00 INFO - PROCESS | 4070 | Cycle 1(1): loaded http://localhost:60733/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60733/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:36:01 INFO - PROCESS | 4070 | RSS: Main: 230379520 11:36:01 INFO - PROCESS | 4070 | 11:36:03 INFO - PROCESS | 4070 | Cycle 1(1): loaded http://localhost:60733/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60733/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:36:04 INFO - PROCESS | 4070 | RSS: Main: 236531712 11:36:04 INFO - PROCESS | 4070 | 11:36:06 INFO - PROCESS | 4070 | Cycle 1(1): loaded http://localhost:60733/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60733/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:36:07 INFO - PROCESS | 4070 | RSS: Main: 239063040 11:36:07 INFO - PROCESS | 4070 | 11:36:10 INFO - PROCESS | 4070 | Cycle 1(1): loaded http://localhost:60733/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60733/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:36:10 INFO - PROCESS | 4070 | RSS: Main: 240652288 11:36:10 INFO - PROCESS | 4070 | 11:36:12 INFO - PROCESS | 4070 | Cycle 1(1): loaded http://localhost:60733/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60733/tests/kraken/driver.html?testName=ai-astar) 11:36:12 INFO - PROCESS | 4070 | RSS: Main: 283262976 11:36:12 INFO - PROCESS | 4070 | 11:36:12 INFO - PROCESS | 4070 | __start_tp_report 11:36:12 INFO - PROCESS | 4070 | _x_x_mozilla_page_load 11:36:12 INFO - PROCESS | 4070 | _x_x_mozilla_page_load_details 11:36:12 INFO - PROCESS | 4070 | |i|pagename|runs| 11:36:12 INFO - PROCESS | 4070 | |0;ai-astar;103;109;109;109;111;109;109;109;109;108 11:36:12 INFO - PROCESS | 4070 | |1;audio-beat-detection;153;128;126;177;127;130;158;126;163;126 11:36:12 INFO - PROCESS | 4070 | |2;audio-dft;162;162;162;162;162;162;164;161;160;162 11:36:12 INFO - PROCESS | 4070 | |3;audio-fft;74;75;74;121;75;75;74;76;96;74 11:36:12 INFO - PROCESS | 4070 | |4;audio-oscillator;86;85;117;84;85;84;123;85;84;130 11:36:12 INFO - PROCESS | 4070 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;116;116;117 11:36:12 INFO - PROCESS | 4070 | |6;imaging-darkroom;145;146;145;146;146;147;145;146;145;146 11:36:12 INFO - PROCESS | 4070 | |7;imaging-desaturate;94;95;95;95;95;95;96;95;97;95 11:36:12 INFO - PROCESS | 4070 | |8;json-parse-financial;57;57;55;57;56;56;57;55;57;55 11:36:12 INFO - PROCESS | 4070 | |9;json-stringify-tinderbox;61;62;61;61;62;63;61;61;61;62 11:36:12 INFO - PROCESS | 4070 | |10;stanford-crypto-aes;85;86;81;79;85;79;80;80;94;80 11:36:12 INFO - PROCESS | 4070 | |11;stanford-crypto-ccm;123;120;120;118;129;122;120;122;146;125 11:36:12 INFO - PROCESS | 4070 | |12;stanford-crypto-pbkdf2;163;157;162;159;158;158;161;159;157;159 11:36:12 INFO - PROCESS | 4070 | |13;stanford-crypto-sha256-iterative;65;64;63;63;63;62;64;63;61;62 11:36:12 INFO - PROCESS | 4070 | __end_tp_report 11:36:12 INFO - PROCESS | 4070 | __start_cc_report 11:36:12 INFO - PROCESS | 4070 | _x_x_mozilla_cycle_collect,1619 11:36:12 INFO - PROCESS | 4070 | __end_cc_report 11:36:12 INFO - PROCESS | 4070 | __startTimestamp1466706972603__endTimestamp 11:36:12 INFO - PROCESS | 4070 | 11:36:12 INFO - PROCESS | 4070 | ------- Summary: start ------- 11:36:12 INFO - PROCESS | 4070 | Number of tests: 14 11:36:12 INFO - PROCESS | 4070 | 11:36:12 INFO - PROCESS | 4070 | [#0] ai-astar Cycles:10 Average:108.50 Median:109.00 stddev:2.07 (1.9%) stddev-sans-first:0.78 11:36:12 INFO - PROCESS | 4070 | Values: 103.0 109.0 109.0 109.0 111.0 109.0 109.0 109.0 109.0 108.0 11:36:12 INFO - PROCESS | 4070 | 11:36:12 INFO - PROCESS | 4070 | [#1] audio-beat-detection Cycles:10 Average:141.40 Median:141.50 stddev:19.36 (13.7%) stddev-sans-first:20.07 11:36:12 INFO - PROCESS | 4070 | Values: 153.0 128.0 126.0 177.0 127.0 130.0 158.0 126.0 163.0 126.0 11:36:12 INFO - PROCESS | 4070 | 11:36:12 INFO - PROCESS | 4070 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 11:36:12 INFO - PROCESS | 4070 | Values: 162.0 162.0 162.0 162.0 162.0 162.0 164.0 161.0 160.0 162.0 11:36:12 INFO - PROCESS | 4070 | 11:36:12 INFO - PROCESS | 4070 | [#3] audio-fft Cycles:10 Average:81.40 Median:75.00 stddev:15.46 (20.6%) stddev-sans-first:16.17 11:36:12 INFO - PROCESS | 4070 | Values: 74.0 75.0 74.0 121.0 75.0 75.0 74.0 76.0 96.0 74.0 11:36:12 INFO - PROCESS | 4070 | 11:36:12 INFO - PROCESS | 4070 | [#4] audio-oscillator Cycles:10 Average:96.30 Median:84.50 stddev:18.92 (22.4%) stddev-sans-first:19.69 11:36:12 INFO - PROCESS | 4070 | Values: 86.0 85.0 117.0 84.0 85.0 84.0 123.0 85.0 84.0 130.0 11:36:12 INFO - PROCESS | 4070 | 11:36:12 INFO - PROCESS | 4070 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 11:36:12 INFO - PROCESS | 4070 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 116.0 117.0 11:36:12 INFO - PROCESS | 4070 | 11:36:12 INFO - PROCESS | 4070 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 11:36:12 INFO - PROCESS | 4070 | Values: 145.0 146.0 145.0 146.0 146.0 147.0 145.0 146.0 145.0 146.0 11:36:12 INFO - PROCESS | 4070 | 11:36:12 INFO - PROCESS | 4070 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.79 (0.8%) stddev-sans-first:0.71 11:36:12 INFO - PROCESS | 4070 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 97.0 95.0 11:36:12 INFO - PROCESS | 4070 | 11:36:12 INFO - PROCESS | 4070 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:57.00 stddev:0.92 (1.6%) stddev-sans-first:0.93 11:36:12 INFO - PROCESS | 4070 | Values: 57.0 57.0 55.0 57.0 56.0 56.0 57.0 55.0 57.0 55.0 11:36:12 INFO - PROCESS | 4070 | 11:36:12 INFO - PROCESS | 4070 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:61.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 11:36:12 INFO - PROCESS | 4070 | Values: 61.0 62.0 61.0 61.0 62.0 63.0 61.0 61.0 61.0 62.0 11:36:12 INFO - PROCESS | 4070 | 11:36:12 INFO - PROCESS | 4070 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.00 stddev:4.72 (5.7%) stddev-sans-first:4.95 11:36:12 INFO - PROCESS | 4070 | Values: 85.0 86.0 81.0 79.0 85.0 79.0 80.0 80.0 94.0 80.0 11:36:12 INFO - PROCESS | 4070 | 11:36:12 INFO - PROCESS | 4070 | [#11] stanford-crypto-ccm Cycles:10 Average:124.50 Median:122.50 stddev:8.17 (6.7%) stddev-sans-first:8.65 11:36:12 INFO - PROCESS | 4070 | Values: 123.0 120.0 120.0 118.0 129.0 122.0 120.0 122.0 146.0 125.0 11:36:12 INFO - PROCESS | 4070 | 11:36:12 INFO - PROCESS | 4070 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.30 Median:159.00 stddev:2.06 (1.3%) stddev-sans-first:1.69 11:36:12 INFO - PROCESS | 4070 | Values: 163.0 157.0 162.0 159.0 158.0 158.0 161.0 159.0 157.0 159.0 11:36:12 INFO - PROCESS | 4070 | 11:36:12 INFO - PROCESS | 4070 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.00 stddev:1.15 (1.8%) stddev-sans-first:0.97 11:36:12 INFO - PROCESS | 4070 | Values: 65.0 64.0 63.0 63.0 63.0 62.0 64.0 63.0 61.0 62.0 11:36:12 INFO - PROCESS | 4070 | -------- Summary: end -------- 11:36:12 INFO - PROCESS | 4070 | 11:36:13 INFO - TEST-INFO | 4070: exit 0 11:36:13 INFO - TEST-OK | kraken | took 61559ms 11:36:13 INFO - SUITE-END | took 1175s 11:36:13 INFO - Completed test suite (00:19:36) 11:36:13 INFO - javascript benchmark 11:36:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3147.9999999999986, 3152.5744024556684, 3165.6359518655363, 3172.0959526534944, 3201.40773956818, 5342.839714808562, 5355.812546560871, 5445.673259604427, 5456.809011684587, 5484.670919744814, 5415.214793854899, 5416.83749487515, 5431.4840090191365, 5491.176323551469, 5521.779128834852, 4919.877003074916, 4922.55696987271, 4968.826091086813, 4984.576311013569, 5100.183970564711, 5007.724575148365, 5040.1935690289565, 5050.368703912011, 5054.1913293872985, 5074.517920797518, 4818.855434336975, 4861.9027619447415, 4891.437484689235, 4917.483664215241, 4971.527704868032, 4889.559939605417, 4896.436909755388, 4900.191468407708, 4960.950390496121, 4994.150994330972, 4925.704457732548, 4929.827456039057, 4932.876678083041, 4946.40643122824, 4979.203327467624, 5247.86880327991, 5325.4142044375085, 5400.540954018913, 5413.512783849433, 5461.754221060062, 5826.126081087828, 5847.8245652630485, 5858.912116318259, 5861.150133230658, 5867.442592953663, 5623.522000629951, 5891.941080589225, 5909.4090590941, 5918.201042859245, 5919.585629005971, 5359.303290572239, 5408.432114627947, 5410.08028635133, 5470.72646367688, 5488.341399032061, 6020.337762846083, 6023.668698221552, 6024.879502409927, 6027.126066720301, 6027.819165425044, 5589.357223919302, 5656.123300888369, 5773.566982476331, 5779.0, 5781.82654520365, 5774.364819869811, 5809.970950145307, 5815.273090863642, 5815.82552523425, 5869.178315035899, 5748.109043098327, 5784.59507834456, 5793.94206057934, 5795.420457954255, 5799.101139323411, 5549.694766787785, 5732.541396688255, 5778.653280803165, 5784.652920824764, 5792.768289268382, 4415.2935530315, 4417.939694473367, 4425.690201685916, 4452.799624016862, 4453.020335526179, 3940.960590394059, 3963.9801800991386, 3966.36538153894, 3990.8204130814183, 4001.299772539794, 5338.97330513345, 5396.271503347077, 5403.054465468527, 5431.891362172734, 5440.347158341025, 5802.303723553201, 5852.385499522574, 5875.324337701134, 5881.323647780475, 5915.970420147872, 5430.484104010192, 5456.154296084113, 5494.2857428534035, 5500.064988951888, 5505.834824955257, 4838.395200599925, 4968.403791544965, 5011.6241281904, 5012.874678133076, 5034.0938631046765, 5992.970035149797, 5993.4905533029305, 5995.490383317379, 5997.940020599825, 6028.367021462771, 5827.24245848054, 5843.561732869966, 5848.239728835224, 5849.853753656193, 5851.765929362778, 5715.542756579381, 5888.381719919518, 5949.613275137275, 5954.315253745702, 5980.970095149496, 5692.1461780733225, 5719.656820590778, 5737.08206686928, 5738.426157384228, 5738.885222295614, 5795.39148389413, 5837.949169149594, 5843.824685259449, 5846.298444186725, 5859.326177489473, 5550.611457197957, 5655.038643430709, 5735.541156707537, 5738.053221218453, 5770.480656740913, 5727.31272247333, 5736.6558006519745, 5738.626989245686, 5742.339630942495, 5743.224664670216, 5334.11987022137, 5580.079286917613, 5595.216669666169, 5598.076317407745, 5650.915236271541, 5597.776088956396, 5664.745086471036, 5673.149027645886, 5739.225204597493, 5745.885082298414, 5528.834134975958, 5557.666540007613, 5558.194061860927, 5560.4161563035295, 5568.192612071146], "value": 5354.545354293613, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [618.2241287184584, 622.6979914741353, 638.9553080713035, 640.0910706796349, 647.2007071266985, 33540.0, 42329.78835105824, 43851.99999999996, 43949.0, 47598.524014759845, 45069.549304506945, 45511.317330240076, 45512.77243613786, 45521.77239113808, 45551.77224113875, 8719.738407847759, 8961.327900407463, 8961.955190224073, 8966.462012279251, 8968.64125434985, 8778.078301778318, 8853.291736661084, 8868.556572171397, 8870.334724895627, 8873.866891996626, 8901.06538813425, 8915.509646969414, 8946.41848279863, 8948.910510894906, 8955.328350373715, 8814.823703525926, 8854.645814167425, 8860.379773415863, 8862.379633425662, 8865.645374185056, 8756.299496040301, 8841.513716745576, 8845.513496757676, 8853.645854165825, 8854.0, 41906.37140442896, 42346.364804527955, 42359.152816943795, 42389.0, 42518.14963700709, 3204.7916885402374, 3425.743069269815, 3521.4365701487895, 3916.432117342998, 4026.7583944963103, 32680.836595817105, 32964.3407131856, 33141.6685833141, 33181.6681833181, 33275.500867487004, 4372.781360931973, 4431.268840641323, 4431.778411079433, 4440.711353762027, 4530.184566777979, 225379.0, 225722.0, 225843.0, 225917.99999999837, 226335.0, 51037.0, 56651.0, 57176.71411642915, 57681.71159144177, 58135.70932145312, 62437.68781156065, 62590.374096259366, 62761.37238627555, 62820.0, 62854.68572657107, 16832.0, 17115.572110697332, 17116.572085697957, 17124.229409676595, 17125.400610978555, 12200.75598488043, 12421.31682757457, 13160.078794484485, 13272.070955033056, 13361.66595835112, 16893.15534223284, 16977.066261355743, 16982.0, 17003.574910627332, 17043.14784260782, 6449.709763060673, 6540.869182616321, 6609.812340967005, 6640.136782218281, 6856.108705868205, 928.1878356438117, 1055.4617145255975, 1062.8830828608848, 1081.3565928272665, 1097.1442275025333, 32388.86638967625, 32623.836880815445, 32802.67197328044, 33295.99705292311, 33559.83220083933, 1072.769354588767, 1112.7496313329598, 1116.1573012375604, 1182.8403165572709, 1230.083587727149, 16415.507534773977, 17038.914805426142, 17254.741178882326, 17287.74068388975, 17400.65198696019, 461020.0, 468138.0, 468405.0, 470970.0, 472233.0, 56804.0, 57079.71460142756, 57295.42704572901, 57302.0, 57357.71321143451, 1248.1263115818963, 1334.212814439466, 1381.1298881704463, 1385.4181243877595, 1401.4814518628173, 32390.0, 33629.83185084059, 33925.66074339324, 33931.0, 34190.65809341974, 49875.25187122123, 50275.49724502708, 50328.74835625799, 50349.0, 50391.49608503868, 391865.0, 392532.0, 396273.0, 396533.0, 396550.0, 36299.63700362963, 41011.384829228184, 41238.79380603078, 41293.0, 42252.57747422486, 48816.75591622161, 49344.506554935426, 49389.0, 49776.0, 49932.25101623551, 40552.391714124904, 41399.58600413957, 41470.58529414667, 42331.365029523964, 42933.0, 40505.34538244591, 41516.0, 41743.7912810434, 41775.0, 42624.0, 40268.597314027655, 40742.59257407388, 40873.0, 41303.58696412997, 41314.58685413108, 35444.82277588596, 36488.27023459569, 36591.26817463583, 36698.0, 37171.256574868894, 27732.861335693193, 27816.033830578785, 28093.719062809112, 28098.438031238853, 28110.296531349748], "value": 20007.34748331945, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.57645014034415, 392.67408051317403, 394.0064438492296, 397.52694293790387, 400.8897553172877, 14512.274386280696, 16134.515964521053, 18617.0, 19261.614767704654, 19274.42176734697, 18128.728069078974, 18299.725504117414, 19068.71396929044, 19127.61744765104, 19154.712679309785, 5112.718800465973, 5140.126178549637, 5869.090291004901, 5893.675847828367, 5899.056151015839, 4024.9396259055993, 5734.856628584277, 5774.5091667208335, 5863.8534036649, 5881.294244690643, 5988.071848863433, 6018.398160183969, 6063.757449702007, 6073.180120683717, 6092.360302168275, 5611.9438805612235, 5910.67491287979, 5918.201042859202, 6024.608400453956, 6027.9095813562835, 5738.942610573882, 5777.133429985536, 5786.103154011135, 5789.536837053026, 5809.477147056785, 13541.729165416735, 13766.862331376758, 14067.085639433404, 14094.788578171336, 14271.0, 2367.9526409471887, 2382.9642555361684, 2407.9759202407927, 2552.3746682063015, 2837.67366752824, 10071.395716257048, 10249.9487502562, 10786.406747628876, 12747.936260318731, 13782.65543361414, 1954.0522846419476, 2005.9097340619708, 2100.85294029418, 2107.4520624637553, 2154.762976072631, 74406.0, 77056.61471692662, 78574.21425785784, 79717.0, 80762.59618701869, 10586.735331616617, 10602.310849794738, 10756.408397538054, 10777.51501182433, 11149.386783726974, 13798.310084495735, 15416.0, 15435.30541125652, 15436.845631543765, 26424.603630945552, 9936.155426788659, 10031.949840250898, 10261.640842570474, 10331.896681033244, 10525.105366043972, 8573.699920502877, 8645.697400590949, 8713.695020674246, 8765.824683506295, 9196.080391960884, 8628.568571571523, 8872.955635221782, 8952.0, 8961.327900407496, 9007.729768106967, 3142.5443310719816, 3203.0531910642267, 3298.8185649789493, 3311.718503927193, 3460.584729832386, 868.5917618719318, 951.1059603972244, 962.8603852441357, 994.9452780097164, 1023.6877752285476, 18846.52883677919, 19006.144723487476, 19558.413247602595, 20210.898945505178, 20723.58552828935, 926.8285367207088, 934.756963189562, 975.9365641233297, 1015.94920253987, 1045.1951996962448, 11086.944565277123, 11298.644162700528, 11412.657620271406, 11481.942590287163, 11499.77000459986, 482786.0, 487872.0, 488344.0, 495151.0, 498667.0, 84531.0, 91162.54418727863, 93791.0, 94008.52995734978, 94416.0, 1026.743314171457, 1051.0960573906282, 1054.7415883108688, 1064.3720205079042, 1069.7486090768664, 17651.852629579036, 18078.90960545189, 18197.636047278716, 18233.908830455763, 18365.265389384276, 41701.16597667969, 41917.79041104897, 41963.37054944117, 42291.57708423, 43363.78318108389, 53754.73122634362, 55281.723591381786, 59234.70382648059, 59481.0, 59558.40441595702, 8710.47737135774, 8824.294056475595, 8973.865392019256, 8984.281257499515, 9212.677556285766, 10010.699679009642, 10205.336653117523, 12761.48954041865, 13278.203307801563, 13755.10591811529, 11916.642500724993, 11992.820107698217, 12030.939845300718, 12048.457819397972, 12151.331676757864, 11576.90019448151, 11675.766484670428, 11774.352410617155, 11974.940125299318, 12527.12310138318, 12431.067669924973, 12481.126321157431, 12522.123451358317, 12724.554640587905, 12752.234865908074, 8897.065808090058, 9130.543472826464, 9178.357514974155, 9272.350935434455, 9353.0, 12179.512819487476, 12296.81554776697, 12307.323097229739, 12445.62663120108, 12457.06572007085], "value": 9620.285948322507, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.6712905338193, 1438.3455527734882, 1505.292512519116, 1568.2629164292778, 1743.1894169211314, 7520.511166774156, 8275.75172744817, 8544.829103417927, 8545.74362769118, 8728.083551227124, 8446.070932197454, 8631.48211107334, 8632.913670863289, 8651.091635378289, 8652.610632521535, 1970.290695349673, 2249.302716157988, 2261.570301642691, 2300.7929286364224, 2342.894569744357, 2339.6841426407473, 2361.0, 2362.5511152880986, 2363.4327761337327, 2364.47981444082, 2287.622542280522, 2291.564602725477, 2315.7568455312203, 2316.3630001749484, 2320.385097949036, 1928.2479832865195, 1980.7524059492564, 2161.1139432832465, 2228.275810361639, 2236.7204099487562, 2228.9665655015187, 2241.5068684889297, 2248.4828489447355, 2248.910043598254, 2249.49386388063, 8649.610767515476, 8709.69516066941, 8723.607437665256, 8736.301095912375, 8747.125287471266, 5006.5744411725045, 5143.768530416103, 5161.664491808058, 5163.122269214243, 5207.218917162418, 3114.7663925205475, 3231.579894613709, 3238.352329534079, 3306.3883181611477, 3362.562866827321, 1133.6145710458484, 1139.1342579639452, 1152.3719572832827, 1164.615676826645, 1164.8078067119, 12202.389880506027, 12224.877751222462, 12238.755224895542, 12243.32661703606, 12268.0, 4313.051128751669, 4444.422225110715, 4541.568550987651, 4549.909001819945, 4627.814887404534, 10308.742281442874, 10310.175185985103, 10324.43215623148, 10324.535395907202, 10336.379817210842, 5181.171012637959, 5210.97394513025, 5238.423773384925, 5246.97376513115, 5257.894842103136, 4179.6029377209115, 4660.394148760707, 4785.784639691222, 4799.952000480021, 4877.756112194447, 3836.462895194675, 3859.150986782903, 3896.9610303897166, 3912.5304963404574, 3984.4858953598027, 1166.457597217281, 1200.2858299311895, 1201.2552217625127, 1214.1076308913118, 1242.105683907585, 922.7831459606987, 952.0289304908954, 954.5609019850947, 961.5913236874441, 994.8358520844124, 5859.53123750099, 6001.4298641628975, 6011.158437818709, 6067.271927368744, 6098.847528811726, 939.7791518993031, 943.8065196634674, 947.6777895515557, 952.8094381123803, 968.7384406210284, 4294.248506511411, 4342.82628694855, 4358.912821743547, 4372.868813935587, 4424.31423129409, 10786.244962852681, 10993.725156871142, 11114.777704445865, 11139.387333696724, 11152.442377881074, 10208.846867296996, 10644.574217031231, 11045.005949464587, 11051.668449946514, 11061.059809916247, 8094.797630059295, 8201.22088401601, 8229.670813167526, 8267.421280510307, 8283.130271321425, 6074.696265186634, 6317.936820631735, 6333.271673757393, 6418.614883106842, 6424.458130048848, 10145.137663298407, 10150.847737284093, 10219.948900255451, 10273.640422585173, 10286.485675716334, 9946.204303655546, 10568.89431105679, 10606.893931060591, 10612.097971672185, 10624.521896514521, 7217.494775365674, 7603.353714934293, 7649.808754781175, 7749.651265692944, 7897.210278972057, 8648.82702345937, 8666.35002374837, 8740.737777866674, 8747.212750852454, 8751.168638979287, 7570.280823321776, 7794.376449884109, 7798.454108212371, 7855.332296754611, 7864.095629002738, 7632.274933881273, 7653.808654783452, 7660.69357225727, 7788.065432148179, 7901.17037711055, 7088.397486213729, 7114.964425177841, 7159.212486626571, 7174.605396703231, 7198.172210195685, 5103.974480127576, 5119.0, 5179.40436849752, 5205.401378841481, 5273.7363131842485, 4861.124997500484, 4932.21084626458, 5000.774965126505, 5103.234514822658, 5141.53726164647], "value": 4611.430095310584, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.97607679424044, 319.50955283639615, 328.20901627078746, 336.1562478179768, 337.2428897125953, 5006.399232092145, 5283.233931079996, 5332.893342133155, 5333.706646134461, 5381.730913454327, 5266.841994740154, 5269.76286067127, 5300.602454815895, 5313.22958171065, 5314.734263286839, 4070.9389359159636, 4081.5102187737366, 4089.1003979124544, 4101.159262351226, 4101.200265948141, 3950.604939506041, 4072.3687828386646, 4077.3068578341604, 4112.876613701579, 4156.480439945007, 4116.847282760817, 4118.444010058649, 4119.917601647965, 4130.8554200602985, 4144.927536231884, 4117.64999975001, 4157.91684166315, 4163.3138578875305, 4164.8125834337525, 4174.686898482626, 3681.208540163878, 3698.1124530112847, 3706.629337066299, 3709.888703338904, 3724.2737666155112, 5023.598112151056, 5142.562882155022, 5148.510891465305, 5171.276021357013, 5181.766820493049, 4721.032188401369, 4742.620590352763, 4746.762661866893, 4755.952440475586, 4762.3332733417, 5327.174287985368, 5476.424975377608, 5502.422245664187, 5515.834524964257, 5521.171824226358, 3931.410288456726, 3940.330143875548, 3941.960580394188, 3944.9408258876138, 3950.348192548226, 5429.972850135763, 5533.723313834292, 5629.296337957755, 5732.684702341411, 5739.0, 4131.772752498581, 4141.420201171838, 4158.584141585818, 4167.437395951508, 4179.373094035858, 4163.417121602978, 4184.28867092595, 4190.1200747843295, 4210.45264115663, 4214.683898707609, 4517.5482451755215, 4576.039031803359, 4743.66794324394, 4759.833405830779, 4804.8318308859025, 5537.086380747212, 5539.390667026624, 5559.24950131727, 5616.248038461124, 5648.830535083954, 1423.5515812519022, 1452.3246690289066, 1468.3319089814108, 1470.6176394137601, 1472.263868065967, 919.3059240273684, 947.7298969793576, 948.7201275623707, 949.2548349545574, 961.8990006049404, 4791.5687588117235, 4791.969726508817, 4820.6143508519235, 4877.804887804448, 4881.975590122027, 5107.67200527858, 5110.795568177231, 5125.436202017775, 5125.436741793714, 5154.793808247703, 4544.681872268976, 4830.8792280193275, 4835.0, 4856.927146092811, 4865.245886887538, 2650.966123211949, 2725.3459169799107, 2747.931301717433, 2748.2030211238516, 2750.7111753266017, 5144.6913185209005, 5161.225816127536, 5185.844424667266, 5204.8178313758835, 5275.762590683428, 5084.0, 5148.794048238104, 5463.535599474089, 5820.806734619393, 5918.704064796829, 5816.970915145482, 5825.825225243165, 5838.649681018983, 5846.532277417797, 5862.296524417097, 5503.174523821459, 5694.4590263924865, 5730.885382292247, 5737.942620573741, 5818.33089194748, 5644.8306550803545, 5656.0, 5676.971615141898, 5677.5457963362005, 5713.7428815704225, 5627.90255900112, 5746.0, 5890.558208134321, 5972.611780234271, 5979.4618484336615, 4080.551139374607, 4092.7135100542678, 4095.4266402704243, 4118.258713431491, 4150.647194988339, 5718.0, 5788.247527821356, 5819.738111785065, 5862.824115276378, 5864.885671722359, 5564.137558678412, 5565.693886836263, 5568.327202942529, 5608.971955140199, 5648.435156484319, 5542.445755424425, 5542.916856247079, 5548.916766248591, 5582.8325150245555, 5589.496945274945, 5366.141417373202, 5419.241306217212, 5491.917621235605, 5518.013515134468, 5527.613067085265, 5545.334559852682, 5553.278073850373, 5579.525740312119, 5628.324601047901, 5655.547556195576, 5445.917779058851, 5484.972575137258, 5493.642913210629, 5506.669599824023, 5527.115661494142], "value": 4178.205299928558, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [715.609992554058, 764.8049747314434, 781.2070748190588, 832.5670651261348, 857.1685465098856, 15177.544673659793, 16562.7515587266, 16610.41863534775, 16814.24335904884, 16874.156292185387, 14915.627109322273, 15007.399704011827, 15048.398064077452, 15055.849441505581, 15086.3211155498, 660.8645227728316, 780.3055280800093, 797.5573556676043, 800.4716886854677, 804.3565147881671, 768.8116411479167, 777.6306254529081, 784.8940393046951, 785.0383280481421, 785.6543121026758, 700.4536461559966, 839.5844057191699, 839.8782176584422, 840.1850205300879, 841.1252297610478, 831.3681601982506, 840.197611281228, 841.6801615386145, 848.567230712335, 848.8217474330398, 619.3280290884351, 619.3991827926949, 619.5632079384023, 619.7644894939939, 620.1751670278563, 14112.435502579885, 14134.081284716563, 14159.646008849759, 14181.929090354586, 14203.218822964733, 14184.43262269508, 14356.49752258666, 14488.71022579553, 14555.272236388244, 14745.0, 12783.680407989781, 12925.935370323183, 13000.349982500837, 13092.149010314299, 13189.208647481182, 4380.167768124046, 4430.933535996963, 4516.616087632555, 4571.908561828778, 4731.432228132646, 79980.20019799785, 81380.59309703413, 81649.59175204145, 82599.58700206461, 82733.17266827375, 11769.705757355963, 11780.352080635475, 11983.221090629082, 12003.339816310012, 12041.39793010346, 21177.470563236042, 21179.470513236985, 21206.0, 21220.151193952377, 21241.575168496853, 8184.754457366289, 8271.090180080186, 8342.62458189383, 8450.661973521113, 8874.600642971081, 4772.809087636525, 4777.904441911142, 4784.617230621542, 4881.633877459205, 4882.5605695487575, 3423.9486407703407, 3487.720982321408, 3522.330757156132, 3525.541679581638, 3534.717222622184, 603.2820943077724, 617.4597227426002, 623.1991890420787, 631.4380201620561, 648.0926702616281, 572.6764378126428, 660.3198705333514, 666.756633828649, 686.9484788640872, 723.1430754555868, 9527.38072025316, 9572.952135239419, 9599.808003839884, 9768.658096966572, 9804.656837010813, 560.2744445942515, 572.4447286132445, 578.3522454850594, 641.7304732012566, 721.4192574977194, 4618.30725391194, 4756.167670657621, 4758.738269395217, 4819.325294458778, 4877.024595080998, 112441.43779281215, 112757.0, 115751.42124289492, 116010.4199479014, 116146.41926790313, 99555.0, 105866.47066764616, 105955.47022264994, 106114.46942765237, 108185.45907270414, 88145.0, 88409.0, 89110.55444722735, 89205.10794892098, 90155.54922225347, 8630.39587228888, 8680.565971701515, 8863.778405539913, 8865.290776737716, 9051.773705657411, 51640.48359516357, 52019.47980520298, 52605.210921836966, 52829.15125462423, 53630.73184634052, 71053.644731776, 77491.61254193693, 77786.0, 77845.0, 77885.61057194677, 11496.770064598828, 11849.229800062969, 11938.224015439317, 12095.879041209475, 12489.375531223584, 10955.370711029454, 11544.67583731468, 11735.941320293345, 12773.680657983254, 12775.808362874379, 13354.866451335361, 13410.932945335211, 13491.392887319898, 14325.426982920982, 14351.712965740835, 13797.379117939918, 13955.790663139858, 14014.789778153132, 14109.576712698636, 14338.928305358406, 13503.527376542166, 13579.45682172702, 13606.251656159006, 13792.793108103186, 15060.849391505944, 10289.228307877089, 10547.314424562379, 10575.576976921146, 10623.309484883457, 10657.467126643793, 11190.832137518106, 11328.433578321215, 11393.829092563785, 11609.245399049034, 11628.709282268012], "value": 7528.7323683417135, "unit": "score"}], "name": "dromaeo_css", "value": 7285.324598491395, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 109.0, 109.0, 109.0, 111.0, 109.0, 109.0, 109.0, 109.0, 108.0], "value": 108.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 128.0, 126.0, 177.0, 127.0, 130.0, 158.0, 126.0, 163.0, 126.0], "value": 141.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 162.0, 162.0, 162.0, 164.0, 161.0, 160.0, 162.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 121.0, 75.0, 75.0, 74.0, 76.0, 96.0, 74.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 117.0, 84.0, 85.0, 84.0, 123.0, 85.0, 84.0, 130.0], "value": 96.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 146.0, 146.0, 147.0, 145.0, 146.0, 145.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 97.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 55.0, 57.0, 56.0, 56.0, 57.0, 55.0, 57.0, 55.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 61.0, 62.0, 63.0, 61.0, 61.0, 61.0, 62.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 81.0, 79.0, 85.0, 79.0, 80.0, 80.0, 94.0, 80.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 120.0, 120.0, 118.0, 129.0, 122.0, 120.0, 122.0, 146.0, 125.0], "value": 124.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 157.0, 162.0, 159.0, 158.0, 158.0, 161.0, 159.0, 157.0, 159.0], "value": 159.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 63.0, 63.0, 63.0, 62.0, 64.0, 63.0, 61.0, 62.0], "value": 63.0, "unit": "score"}], "name": "kraken", "value": 1494.5000000000002, "alertThreshold": 2.0}]} 11:36:13 INFO - Return code: 0 11:36:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:36:13 INFO - # TBPL SUCCESS # 11:36:13 INFO - Running post-action listener: _resource_record_post_action 11:36:13 INFO - ##### 11:36:13 INFO - ##### Finished run-tests step (success) 11:36:13 INFO - ##### 11:36:13 INFO - Running post-run listener: _resource_record_post_run 11:36:13 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 563163136; Read time: 12; Write time: 612412 11:36:13 INFO - TinderboxPrint: CPU usage
13.2% 11:36:13 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 11:36:13 INFO - TinderboxPrint: I/O write bytes / time
563,163,136 / 612,412 11:36:13 INFO - TinderboxPrint: CPU idle
8,270.8 (86.8%) 11:36:13 INFO - TinderboxPrint: CPU user
1,205.6 (12.7%) 11:36:13 INFO - TinderboxPrint: Swap in / out
0 / 0 11:36:13 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 268644352; Read time: 0; Write time: 320540 11:36:13 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293797888; Read time: 12; Write time: 291844 11:36:14 INFO - Running post-run listener: _upload_blobber_files 11:36:14 INFO - Blob upload gear active. 11:36:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:36:14 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 11:36:14 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:36:14 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:36:14 INFO - (blobuploader) - INFO - Open directory for files ... 11:36:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:36:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:36:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:36:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:36:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:36:16 INFO - (blobuploader) - INFO - Done attempting. 11:36:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:36:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:36:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:36:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:36:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:36:20 INFO - (blobuploader) - INFO - Done attempting. 11:36:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:36:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:36:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:36:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:36:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:36:20 INFO - (blobuploader) - INFO - Done attempting. 11:36:20 INFO - (blobuploader) - INFO - Iteration through files over. 11:36:21 INFO - Return code: 0 11:36:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:36:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:36:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bec71589812a2d24802897e40e0f423e19037aa810f86f176808e66c2e31dc1907ea9a0b0516b2b0a9c7be7d2eaa3aab372635083df17cab61953be344544f3f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d23ad6e886c79ce422e1def9b061e0b8b7c193d8bc81a549bbd130414beffb7092f44d011a92dea62510b0de99456d681db1df2c339ebf0fcb37ec5c4d652322", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/461fb2ff87926f0e2dc2ff236778794b0b0b8f4e19daf88b2435d5e4a1b3fc0a11a9117745c204eab85b1c0855f545ad5dd9c443761b751e8efb8414c2787284"} 11:36:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:36:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:36:21 INFO - Contents: 11:36:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bec71589812a2d24802897e40e0f423e19037aa810f86f176808e66c2e31dc1907ea9a0b0516b2b0a9c7be7d2eaa3aab372635083df17cab61953be344544f3f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d23ad6e886c79ce422e1def9b061e0b8b7c193d8bc81a549bbd130414beffb7092f44d011a92dea62510b0de99456d681db1df2c339ebf0fcb37ec5c4d652322", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/461fb2ff87926f0e2dc2ff236778794b0b0b8f4e19daf88b2435d5e4a1b3fc0a11a9117745c204eab85b1c0855f545ad5dd9c443761b751e8efb8414c2787284"} 11:36:21 INFO - Running post-run listener: copy_logs_to_upload_dir 11:36:21 INFO - Copying logs to upload dir... 11:36:21 INFO - mkdir: /builds/slave/test/build/upload/logs 11:36:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.578257 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-23 11:36:20.855534) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 11:36:20.859570) ========= 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=836cfdc75598d54cb747368e000001a9-1466704507.732576-158787255 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/sha512/bec71589812a2d24802897e40e0f423e19037aa810f86f176808e66c2e31dc1907ea9a0b0516b2b0a9c7be7d2eaa3aab372635083df17cab61953be344544f3f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d23ad6e886c79ce422e1def9b061e0b8b7c193d8bc81a549bbd130414beffb7092f44d011a92dea62510b0de99456d681db1df2c339ebf0fcb37ec5c4d652322", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/461fb2ff87926f0e2dc2ff236778794b0b0b8f4e19daf88b2435d5e4a1b3fc0a11a9117745c204eab85b1c0855f545ad5dd9c443761b751e8efb8414c2787284"} build_url:https://queue.taskcluster.net/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011330 build_url: 'https://queue.taskcluster.net/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/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/sha512/bec71589812a2d24802897e40e0f423e19037aa810f86f176808e66c2e31dc1907ea9a0b0516b2b0a9c7be7d2eaa3aab372635083df17cab61953be344544f3f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d23ad6e886c79ce422e1def9b061e0b8b7c193d8bc81a549bbd130414beffb7092f44d011a92dea62510b0de99456d681db1df2c339ebf0fcb37ec5c4d652322", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/461fb2ff87926f0e2dc2ff236778794b0b0b8f4e19daf88b2435d5e4a1b3fc0a11a9117745c204eab85b1c0855f545ad5dd9c443761b751e8efb8414c2787284"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 11:36:20.885527) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 11:36:20.885908) ========= 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=836cfdc75598d54cb747368e000001a9-1466704507.732576-158787255 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004472 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 11:36:20.971414) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 11:36:20.971757) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 11:36:20.972187) ========= ========= Total master_lag: 0.17 =========