builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-046 starttime: 1466025339.16 results: success (0) buildid: 20160615113031 builduid: d51862ae52184e2cad82a1a735e7f8ce revision: 6f305ccfd7761c4215f024de0abe264f4e994437 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-15 14:15:39.163756) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-15 14:15:39.164156) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-15 14:15:39.164442) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-15 14:15:39.180230) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 14:15:39.180516) ========= 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=652eb03db935cfc1c15ebda0000001ad-1466016538.877295-370225772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-15 14:15:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 88.5M=0s 2016-06-15 14:15:39 (88.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084619 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 14:15:39.284629) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 14:15:39.284909) ========= 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=652eb03db935cfc1c15ebda0000001ad-1466016538.877295-370225772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021470 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 14:15:39.333983) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-15 14:15:39.334305) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6f305ccfd7761c4215f024de0abe264f4e994437 --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 6f305ccfd7761c4215f024de0abe264f4e994437 --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=652eb03db935cfc1c15ebda0000001ad-1466016538.877295-370225772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-15 14:15:39,515 truncating revision to first 12 chars 2016-06-15 14:15:39,515 Setting DEBUG logging. 2016-06-15 14:15:39,515 attempt 1/10 2016-06-15 14:15:39,515 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6f305ccfd776?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-15 14:15:39,980 unpacking tar archive at: fx-team-6f305ccfd776/testing/mozharness/ program finished with exit code 0 elapsedTime=1.244735 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-15 14:15:40.592784) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-15 14:15:40.593094) ========= script_repo_revision: 6f305ccfd7761c4215f024de0abe264f4e994437 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-15 14:15:40.593499) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-15 14:15:40.593771) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-15 14:15:40.602320) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-06-15 14:15:40.602628) ========= /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=652eb03db935cfc1c15ebda0000001ad-1466016538.877295-370225772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:15:40 INFO - MultiFileLogger online at 20160615 14:15:40 in /builds/slave/test 14:15:40 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 14:15:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:15:40 INFO - {'append_to_log': False, 14:15:40 INFO - 'base_work_dir': '/builds/slave/test', 14:15:40 INFO - 'blob_upload_branch': 'Fx-Team', 14:15:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:15:40 INFO - 'branch': 'Fx-Team', 14:15:40 INFO - 'buildbot_json_path': 'buildprops.json', 14:15:40 INFO - 'config_files': ('talos/linux_config.py',), 14:15:40 INFO - 'default_actions': ('clobber', 14:15:40 INFO - 'read-buildbot-config', 14:15:40 INFO - 'download-and-extract', 14:15:40 INFO - 'populate-webroot', 14:15:40 INFO - 'create-virtualenv', 14:15:40 INFO - 'install', 14:15:40 INFO - 'run-tests'), 14:15:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:15:40 INFO - 'download_minidump_stackwalk': True, 14:15:40 INFO - 'download_symbols': 'ondemand', 14:15:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:15:40 INFO - 'tooltool.py': '/tools/tooltool.py', 14:15:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:15:40 INFO - '/tools/misc-python/virtualenv.py')}, 14:15:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:15:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:15:40 INFO - 'installer_path': 'installer.exe', 14:15:40 INFO - 'log_level': 'info', 14:15:40 INFO - 'log_name': 'talos', 14:15:40 INFO - 'log_to_console': True, 14:15:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:15:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:15:40 INFO - 'opt_config_files': (), 14:15:40 INFO - 'pip_index': False, 14:15:40 INFO - 'sps_profile': False, 14:15:40 INFO - 'sps_profile_interval': 0, 14:15:40 INFO - 'suite': 'dromaeojs', 14:15:40 INFO - 'system_bits': '32', 14:15:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:15:40 INFO - 'title': 'talos-linux64-ix-046', 14:15:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:15:40 INFO - 'use_talos_json': True, 14:15:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:15:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:15:40 INFO - 'work_dir': 'build'} 14:15:40 INFO - ##### 14:15:40 INFO - ##### Running clobber step. 14:15:40 INFO - ##### 14:15:40 INFO - Running pre-action listener: _resource_record_pre_action 14:15:40 INFO - Running main action method: clobber 14:15:40 INFO - rmtree: /builds/slave/test/build 14:15:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:15:41 INFO - Running post-action listener: _resource_record_post_action 14:15:41 INFO - ##### 14:15:41 INFO - ##### Finished clobber step (success) 14:15:41 INFO - ##### 14:15:41 INFO - ##### 14:15:41 INFO - ##### Running read-buildbot-config step. 14:15:41 INFO - ##### 14:15:41 INFO - Running pre-action listener: _resource_record_pre_action 14:15:41 INFO - Running main action method: read_buildbot_config 14:15:41 INFO - Using buildbot properties: 14:15:41 INFO - { 14:15:41 INFO - "project": "", 14:15:41 INFO - "product": "firefox", 14:15:41 INFO - "script_repo_revision": "production", 14:15:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:15:41 INFO - "repository": "", 14:15:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:15:41 INFO - "buildid": "20160615113031", 14:15:41 INFO - "pgo_build": "True", 14:15:41 INFO - "basedir": "/builds/slave/test", 14:15:41 INFO - "buildnumber": 1257, 14:15:41 INFO - "slavename": "talos-linux64-ix-046", 14:15:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:15:41 INFO - "platform": "ubuntu64_hw", 14:15:41 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:15:41 INFO - "branch": "fx-team", 14:15:41 INFO - "repo_path": "integration/fx-team", 14:15:41 INFO - "revision": "6f305ccfd7761c4215f024de0abe264f4e994437", 14:15:41 INFO - "stage_platform": "linux64-pgo", 14:15:41 INFO - "builduid": "d51862ae52184e2cad82a1a735e7f8ce", 14:15:41 INFO - "slavebuilddir": "test" 14:15:41 INFO - } 14:15:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/L4uwurAJRT-1wAKc-SAy8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 14:15:41 INFO - Running post-action listener: _resource_record_post_action 14:15:41 INFO - ##### 14:15:41 INFO - ##### Finished read-buildbot-config step (success) 14:15:41 INFO - ##### 14:15:41 INFO - ##### 14:15:41 INFO - ##### Running download-and-extract step. 14:15:41 INFO - ##### 14:15:41 INFO - Running pre-action listener: _resource_record_pre_action 14:15:41 INFO - Running main action method: download_and_extract 14:15:41 INFO - mkdir: /builds/slave/test/build/tests 14:15:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:41 INFO - https://queue.taskcluster.net/v1/task/L4uwurAJRT-1wAKc-SAy8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:15:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4uwurAJRT-1wAKc-SAy8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:15:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4uwurAJRT-1wAKc-SAy8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:15:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4uwurAJRT-1wAKc-SAy8g/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 14:15:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4uwurAJRT-1wAKc-SAy8g/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 14:15:48 INFO - Downloaded 1361 bytes. 14:15:48 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:15:48 INFO - Using the following test package requirements: 14:15:48 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:15:48 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:15:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:15:48 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:15:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:15:48 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:15:48 INFO - u'jsshell-linux-x86_64.zip'], 14:15:48 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:15:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:15:48 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:15:48 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:15:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:15:48 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:15:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:15:48 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:15:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:15:48 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:15:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:15:48 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:48 INFO - https://queue.taskcluster.net/v1/task/L4uwurAJRT-1wAKc-SAy8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:15:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4uwurAJRT-1wAKc-SAy8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:15:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4uwurAJRT-1wAKc-SAy8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:15:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4uwurAJRT-1wAKc-SAy8g/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 14:15:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4uwurAJRT-1wAKc-SAy8g/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 14:15:56 INFO - Downloaded 24220181 bytes. 14:15:56 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'] 14:15:56 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 14:15:58 INFO - Return code: 0 14:15:58 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 14:15:58 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')]} 14:15:58 INFO - https://queue.taskcluster.net/v1/task/L4uwurAJRT-1wAKc-SAy8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:15:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4uwurAJRT-1wAKc-SAy8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:15:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4uwurAJRT-1wAKc-SAy8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:15:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4uwurAJRT-1wAKc-SAy8g/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 14:15:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4uwurAJRT-1wAKc-SAy8g/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 14:15:59 INFO - Downloaded 24220181 bytes. 14:15:59 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'] 14:15:59 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 14:16:00 INFO - Return code: 0 14: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')]} 14:16:00 INFO - https://queue.taskcluster.net/v1/task/L4uwurAJRT-1wAKc-SAy8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:16:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4uwurAJRT-1wAKc-SAy8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:16:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4uwurAJRT-1wAKc-SAy8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:16:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4uwurAJRT-1wAKc-SAy8g/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 14:16:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4uwurAJRT-1wAKc-SAy8g/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 14:16:01 INFO - Downloaded 14405384 bytes. 14:16:01 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'] 14:16:01 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 14:16:02 INFO - Return code: 0 14: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')]} 14:16:02 INFO - https://queue.taskcluster.net/v1/task/L4uwurAJRT-1wAKc-SAy8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:16:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4uwurAJRT-1wAKc-SAy8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:16:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4uwurAJRT-1wAKc-SAy8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:16:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4uwurAJRT-1wAKc-SAy8g/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 14:16:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4uwurAJRT-1wAKc-SAy8g/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 14:16:03 INFO - Downloaded 59370623 bytes. 14:16:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L4uwurAJRT-1wAKc-SAy8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:16:03 INFO - mkdir: /builds/slave/test/properties 14:16:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:16:03 INFO - Writing to file /builds/slave/test/properties/build_url 14:16:03 INFO - Contents: 14:16:03 INFO - build_url:https://queue.taskcluster.net/v1/task/L4uwurAJRT-1wAKc-SAy8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:16:04 INFO - Running post-action listener: _resource_record_post_action 14:16:04 INFO - Running post-action listener: set_extra_try_arguments 14:16:04 INFO - ##### 14:16:04 INFO - ##### Finished download-and-extract step (success) 14:16:04 INFO - ##### 14:16:04 INFO - ##### 14:16:04 INFO - ##### Running populate-webroot step. 14:16:04 INFO - ##### 14:16:04 INFO - Running pre-action listener: _resource_record_pre_action 14:16:04 INFO - Running main action method: populate_webroot 14:16:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:16:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:16:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:16:04 INFO - '--tppagecycles', 14:16:04 INFO - '7'], 14:16:04 INFO - 'tests': ['tsvgm']}}, 14:16:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:16:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:16:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:16:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:16:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:16:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:16:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:04 INFO - 'talos_options': ['--disable-e10s'], 14:16:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:16:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:16:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:04 INFO - 'talos_options': ['--disable-e10s'], 14:16:04 INFO - 'tests': ['damp', 'tps']}, 14:16:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:04 INFO - 'tests': ['damp', 'tps']}, 14:16:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:16:04 INFO - 'tests': ['dromaeo_dom']}, 14:16:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:16:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:16:04 INFO - 'tests': ['basic_compositor_video']}, 14:16:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:16:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:16:04 INFO - 'tests': ['a11yr', 14:16:04 INFO - 'ts_paint', 14:16:04 INFO - 'tpaint', 14:16:04 INFO - 'sessionrestore', 14:16:04 INFO - 'sessionrestore_no_auto_restore', 14:16:04 INFO - 'tabpaint']}, 14:16:04 INFO - 'other-e10s': {'tests': ['a11yr', 14:16:04 INFO - 'ts_paint', 14:16:04 INFO - 'tpaint', 14:16:04 INFO - 'sessionrestore', 14:16:04 INFO - 'sessionrestore_no_auto_restore', 14:16:04 INFO - 'tabpaint']}, 14:16:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:16:04 INFO - 'ts_paint', 14:16:04 INFO - 'tpaint', 14:16:04 INFO - 'sessionrestore', 14:16:04 INFO - 'sessionrestore_no_auto_restore', 14:16:04 INFO - 'tabpaint']}, 14:16:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:16:04 INFO - 'ts_paint', 14:16:04 INFO - 'tpaint', 14:16:04 INFO - 'sessionrestore', 14:16:04 INFO - 'sessionrestore_no_auto_restore', 14:16:04 INFO - 'tabpaint']}, 14:16:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:16:04 INFO - 'tests': ['a11yr', 14:16:04 INFO - 'ts_paint', 14:16:04 INFO - 'tpaint', 14:16:04 INFO - 'sessionrestore', 14:16:04 INFO - 'sessionrestore_no_auto_restore', 14:16:04 INFO - 'tabpaint']}, 14:16:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:16:04 INFO - 'tests': ['a11yr', 14:16:04 INFO - 'ts_paint', 14:16:04 INFO - 'tpaint', 14:16:04 INFO - 'sessionrestore', 14:16:04 INFO - 'sessionrestore_no_auto_restore', 14:16:04 INFO - 'tabpaint']}, 14:16:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:16:04 INFO - 'tests': ['tsvgx', 14:16:04 INFO - 'tsvgr_opacity', 14:16:04 INFO - 'tart', 14:16:04 INFO - 'tscrollx', 14:16:04 INFO - 'cart']}, 14:16:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:16:04 INFO - 'tsvgr_opacity', 14:16:04 INFO - 'tart', 14:16:04 INFO - 'tscrollx', 14:16:04 INFO - 'cart']}, 14:16:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:04 INFO - 'talos_options': ['--disable-e10s'], 14:16:04 INFO - 'tests': ['tp5o']}, 14:16:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:04 INFO - 'tests': ['tp5o']}, 14:16:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:04 INFO - 'talos_options': ['--disable-e10s', 14:16:04 INFO - '--xperf_path', 14:16:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:16:04 INFO - 'tests': ['tp5n']}, 14:16:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:04 INFO - 'talos_options': ['--xperf_path', 14:16:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:16:04 INFO - 'tests': ['tp5n']}}, 14:16:04 INFO - 'talos.zip': {'path': '', 14:16:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:16:04 INFO - Running post-action listener: _resource_record_post_action 14:16:04 INFO - ##### 14:16:04 INFO - ##### Finished populate-webroot step (success) 14:16:04 INFO - ##### 14:16:04 INFO - ##### 14:16:04 INFO - ##### Running create-virtualenv step. 14:16:04 INFO - ##### 14:16:04 INFO - Running pre-action listener: _resource_record_pre_action 14:16:04 INFO - Running main action method: create_virtualenv 14:16:04 INFO - Creating virtualenv /builds/slave/test/build/venv 14:16:04 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 14:16:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:16:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:16:04 INFO - Using real prefix '/usr' 14:16:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:16:05 INFO - Installing distribute.............................................................................................................................................................................................done. 14:16:07 INFO - Installing pip.................done. 14:16:07 INFO - Return code: 0 14:16:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:16:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef20068f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ee1c0>, '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 0x17ef0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ef550>, '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': '652eb03db935cfc1c15ebda0000001ad-1466016538.877295-370225772', '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 14:16:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:16:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:16:07 INFO - Using env: {'DISPLAY': ':0', 14:16:07 INFO - 'HOME': '/home/cltbld', 14:16:07 INFO - 'LANG': 'en_US.UTF-8', 14:16:07 INFO - 'LANGUAGE': 'en_US:en', 14:16:07 INFO - 'LOGNAME': 'cltbld', 14:16:07 INFO - 'MAIL': '/var/mail/cltbld', 14:16:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:07 INFO - 'MOZ_NO_REMOTE': '1', 14:16:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:16:07 INFO - 'NO_EM_RESTART': '1', 14:16:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:16:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:07 INFO - 'PWD': '/builds/slave/test', 14:16:07 INFO - 'SHELL': '/bin/bash', 14:16:07 INFO - 'SHLVL': '1', 14:16:07 INFO - 'TERM': 'linux', 14:16:07 INFO - 'TMOUT': '86400', 14:16:07 INFO - 'USER': 'cltbld', 14:16:07 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466016538.877295-370225772', 14:16:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:07 INFO - '_': '/tools/buildbot/bin/python'} 14:16:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:07 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 14:16:07 INFO - Cleaning up... 14:16:07 INFO - Return code: 0 14:16:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:16:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fef20068f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ee1c0>, '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 0x17ef0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ef550>, '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': '652eb03db935cfc1c15ebda0000001ad-1466016538.877295-370225772', '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 14:16:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:16:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:16:07 INFO - Using env: {'DISPLAY': ':0', 14:16:07 INFO - 'HOME': '/home/cltbld', 14:16:07 INFO - 'LANG': 'en_US.UTF-8', 14:16:07 INFO - 'LANGUAGE': 'en_US:en', 14:16:07 INFO - 'LOGNAME': 'cltbld', 14:16:07 INFO - 'MAIL': '/var/mail/cltbld', 14:16:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:07 INFO - 'MOZ_NO_REMOTE': '1', 14:16:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:16:07 INFO - 'NO_EM_RESTART': '1', 14:16:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:16:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:07 INFO - 'PWD': '/builds/slave/test', 14:16:07 INFO - 'SHELL': '/bin/bash', 14:16:07 INFO - 'SHLVL': '1', 14:16:07 INFO - 'TERM': 'linux', 14:16:07 INFO - 'TMOUT': '86400', 14:16:07 INFO - 'USER': 'cltbld', 14:16:07 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466016538.877295-370225772', 14:16:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:07 INFO - '_': '/tools/buildbot/bin/python'} 14:16:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:07 INFO - Downloading/unpacking psutil>=3.1.1 14: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 14: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 14: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 14: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 14: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 14: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 14:16:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:16:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:16:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:16:09 INFO - Installing collected packages: psutil 14:16:09 INFO - Running setup.py install for psutil 14:16:09 INFO - building 'psutil._psutil_linux' extension 14:16:09 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 14:16:09 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 14:16:09 INFO - building 'psutil._psutil_posix' extension 14:16:09 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 14:16:09 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 14:16:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:16:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:16:10 INFO - Successfully installed psutil 14:16:10 INFO - Cleaning up... 14:16:10 INFO - Return code: 0 14:16:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:16:10 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')]} 14:16:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:10 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')]} 14:16:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:10 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 0x7fef20068f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ee1c0>, '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 0x17ef0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ef550>, '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': '652eb03db935cfc1c15ebda0000001ad-1466016538.877295-370225772', '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 14:16:10 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 14:16:10 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 14:16:10 INFO - Using env: {'DISPLAY': ':0', 14:16:10 INFO - 'HOME': '/home/cltbld', 14:16:10 INFO - 'LANG': 'en_US.UTF-8', 14:16:10 INFO - 'LANGUAGE': 'en_US:en', 14:16:10 INFO - 'LOGNAME': 'cltbld', 14:16:10 INFO - 'MAIL': '/var/mail/cltbld', 14:16:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:10 INFO - 'MOZ_NO_REMOTE': '1', 14:16:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:16:10 INFO - 'NO_EM_RESTART': '1', 14:16:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:16:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:10 INFO - 'PWD': '/builds/slave/test', 14:16:10 INFO - 'SHELL': '/bin/bash', 14:16:10 INFO - 'SHLVL': '1', 14:16:10 INFO - 'TERM': 'linux', 14:16:10 INFO - 'TMOUT': '86400', 14:16:10 INFO - 'USER': 'cltbld', 14:16:10 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466016538.877295-370225772', 14:16:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:10 INFO - '_': '/tools/buildbot/bin/python'} 14:16:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:16:10 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 14:16:10 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 14:16:10 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 14:16:10 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 14:16:10 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 14:16:10 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 14:16:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:16:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:16:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:16:12 INFO - Installing collected packages: mozsystemmonitor 14:16:12 INFO - Running setup.py install for mozsystemmonitor 14:16:12 INFO - Successfully installed mozsystemmonitor 14:16:12 INFO - Cleaning up... 14:16:12 INFO - Return code: 0 14:16:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:16:12 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')]} 14:16:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:12 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')]} 14:16:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:12 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 0x7fef20068f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ee1c0>, '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 0x17ef0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ef550>, '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': '652eb03db935cfc1c15ebda0000001ad-1466016538.877295-370225772', '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 14:16:12 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 14:16:12 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 14:16:12 INFO - Using env: {'DISPLAY': ':0', 14:16:12 INFO - 'HOME': '/home/cltbld', 14:16:12 INFO - 'LANG': 'en_US.UTF-8', 14:16:12 INFO - 'LANGUAGE': 'en_US:en', 14:16:12 INFO - 'LOGNAME': 'cltbld', 14:16:12 INFO - 'MAIL': '/var/mail/cltbld', 14:16:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:12 INFO - 'MOZ_NO_REMOTE': '1', 14:16:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:16:12 INFO - 'NO_EM_RESTART': '1', 14:16:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:16:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:12 INFO - 'PWD': '/builds/slave/test', 14:16:12 INFO - 'SHELL': '/bin/bash', 14:16:12 INFO - 'SHLVL': '1', 14:16:12 INFO - 'TERM': 'linux', 14:16:12 INFO - 'TMOUT': '86400', 14:16:12 INFO - 'USER': 'cltbld', 14:16:12 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466016538.877295-370225772', 14:16:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:12 INFO - '_': '/tools/buildbot/bin/python'} 14:16:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:12 INFO - Downloading/unpacking jsonschema==2.5.1 14:16:12 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 14:16:12 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 14:16:12 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 14:16:12 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 14:16:12 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 14:16:12 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 14:16:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:16:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:16:14 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 14:16:14 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 14:16:14 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 14:16:14 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 14:16:14 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 14:16:14 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 14:16:14 INFO - Downloading functools32-3.2.3-2.tar.gz 14:16:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:16:14 INFO - warning: no files found matching '*.txt' 14:16:14 INFO - no previously-included directories found matching 'build' 14:16:14 INFO - no previously-included directories found matching 'dist' 14:16:14 INFO - no previously-included directories found matching '.git*' 14:16:14 INFO - Installing collected packages: jsonschema, functools32 14:16:14 INFO - Running setup.py install for functools32 14:16:14 INFO - warning: no files found matching '*.txt' 14:16:14 INFO - no previously-included directories found matching 'build' 14:16:14 INFO - no previously-included directories found matching 'dist' 14:16:14 INFO - no previously-included directories found matching '.git*' 14:16:14 INFO - Successfully installed jsonschema functools32 14:16:14 INFO - Cleaning up... 14:16:14 INFO - Return code: 0 14:16:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:16:14 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')]} 14:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:14 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')]} 14:16:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:14 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 0x7fef20068f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ee1c0>, '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 0x17ef0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ef550>, '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': '652eb03db935cfc1c15ebda0000001ad-1466016538.877295-370225772', '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 14:16:14 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 14:16:14 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 14:16:14 INFO - Using env: {'DISPLAY': ':0', 14:16:14 INFO - 'HOME': '/home/cltbld', 14:16:14 INFO - 'LANG': 'en_US.UTF-8', 14:16:14 INFO - 'LANGUAGE': 'en_US:en', 14:16:14 INFO - 'LOGNAME': 'cltbld', 14:16:14 INFO - 'MAIL': '/var/mail/cltbld', 14:16:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:14 INFO - 'MOZ_NO_REMOTE': '1', 14:16:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:16:14 INFO - 'NO_EM_RESTART': '1', 14:16:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:16:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:14 INFO - 'PWD': '/builds/slave/test', 14:16:14 INFO - 'SHELL': '/bin/bash', 14:16:14 INFO - 'SHLVL': '1', 14:16:14 INFO - 'TERM': 'linux', 14:16:14 INFO - 'TMOUT': '86400', 14:16:14 INFO - 'USER': 'cltbld', 14:16:14 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466016538.877295-370225772', 14:16:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:14 INFO - '_': '/tools/buildbot/bin/python'} 14:16:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:15 INFO - Downloading/unpacking blobuploader==1.2.4 14:16:15 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 14:16:15 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 14:16:15 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 14:16:15 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 14:16:15 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 14:16:15 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 14:16:16 INFO - Downloading blobuploader-1.2.4.tar.gz 14:16:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:16:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:16:17 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 14:16:17 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 14:16:17 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 14:16:17 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 14:16:17 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 14:16:17 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 14:16:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:16:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:16:17 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 14:16:17 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 14:16:17 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 14:16:17 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 14:16:17 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 14:16:17 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 14:16:17 INFO - Downloading docopt-0.6.1.tar.gz 14:16:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:16:17 INFO - Installing collected packages: blobuploader, requests, docopt 14:16:17 INFO - Running setup.py install for blobuploader 14:16:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:16:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:16:17 INFO - Running setup.py install for requests 14:16:18 INFO - Running setup.py install for docopt 14:16:18 INFO - Successfully installed blobuploader requests docopt 14:16:18 INFO - Cleaning up... 14:16:18 INFO - Return code: 0 14:16:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:16:18 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')]} 14:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:18 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')]} 14:16:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:18 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 0x7fef20068f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ee1c0>, '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 0x17ef0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ef550>, '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': '652eb03db935cfc1c15ebda0000001ad-1466016538.877295-370225772', '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 14:16:18 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 14:16:18 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 14:16:18 INFO - Using env: {'DISPLAY': ':0', 14:16:18 INFO - 'HOME': '/home/cltbld', 14:16:18 INFO - 'LANG': 'en_US.UTF-8', 14:16:18 INFO - 'LANGUAGE': 'en_US:en', 14:16:18 INFO - 'LOGNAME': 'cltbld', 14:16:18 INFO - 'MAIL': '/var/mail/cltbld', 14:16:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:18 INFO - 'MOZ_NO_REMOTE': '1', 14:16:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:16:18 INFO - 'NO_EM_RESTART': '1', 14:16:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:16:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:18 INFO - 'PWD': '/builds/slave/test', 14:16:18 INFO - 'SHELL': '/bin/bash', 14:16:18 INFO - 'SHLVL': '1', 14:16:18 INFO - 'TERM': 'linux', 14:16:18 INFO - 'TMOUT': '86400', 14:16:18 INFO - 'USER': 'cltbld', 14:16:18 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466016538.877295-370225772', 14:16:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:18 INFO - '_': '/tools/buildbot/bin/python'} 14:16:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:16:18 INFO - Running setup.py (path:/tmp/pip-2Bumvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:16:18 INFO - Running setup.py (path:/tmp/pip-PKGi9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:16:18 INFO - Running setup.py (path:/tmp/pip-w4dHzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:16:18 INFO - Running setup.py (path:/tmp/pip-U5ybwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:16:18 INFO - Running setup.py (path:/tmp/pip-rQT4Zc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:16:18 INFO - Running setup.py (path:/tmp/pip-fx8mnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:16:18 INFO - Running setup.py (path:/tmp/pip-JczkuV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:16:19 INFO - Running setup.py (path:/tmp/pip-0NX3zC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:16:19 INFO - Running setup.py (path:/tmp/pip-02ICXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:16:19 INFO - Running setup.py (path:/tmp/pip-5lI4c3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:16:19 INFO - Running setup.py (path:/tmp/pip-CjpYY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:16:19 INFO - Running setup.py (path:/tmp/pip-KVloX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:16:19 INFO - Running setup.py (path:/tmp/pip-6n3Q7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:16:19 INFO - Running setup.py (path:/tmp/pip-iMoo3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:16:19 INFO - Running setup.py (path:/tmp/pip-o0w2Cs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:16:19 INFO - Running setup.py (path:/tmp/pip-FvGhPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:16:19 INFO - Running setup.py (path:/tmp/pip-WNxUHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:16:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:16:19 INFO - Running setup.py install for manifestparser 14:16:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:16:19 INFO - Running setup.py install for mozcrash 14:16:19 INFO - Running setup.py install for mozdebug 14:16:20 INFO - Running setup.py install for mozdevice 14:16:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:16:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:16:20 INFO - Running setup.py install for mozfile 14:16:20 INFO - Running setup.py install for mozhttpd 14:16:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:16:20 INFO - Running setup.py install for mozinfo 14:16:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:16:20 INFO - Running setup.py install for mozInstall 14:16:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:16:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:16:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:16:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:16:20 INFO - Running setup.py install for mozleak 14:16:20 INFO - Running setup.py install for mozlog 14:16:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:16:20 INFO - Running setup.py install for moznetwork 14:16:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:16:20 INFO - Running setup.py install for mozprocess 14:16:21 INFO - Running setup.py install for mozprofile 14:16:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:16:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:16:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:16:21 INFO - Running setup.py install for mozrunner 14:16:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:16:21 INFO - Running setup.py install for mozscreenshot 14:16:21 INFO - Running setup.py install for moztest 14:16:21 INFO - Running setup.py install for mozversion 14:16:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:16:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:16:21 INFO - Cleaning up... 14:16:21 INFO - Return code: 0 14:16:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:16:21 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')]} 14:16:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:21 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')]} 14:16:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:21 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 0x7fef20068f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ee1c0>, '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 0x17ef0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ef550>, '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': '652eb03db935cfc1c15ebda0000001ad-1466016538.877295-370225772', '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 14:16:21 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 14:16:21 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 14:16:21 INFO - Using env: {'DISPLAY': ':0', 14:16:21 INFO - 'HOME': '/home/cltbld', 14:16:21 INFO - 'LANG': 'en_US.UTF-8', 14:16:21 INFO - 'LANGUAGE': 'en_US:en', 14:16:21 INFO - 'LOGNAME': 'cltbld', 14:16:21 INFO - 'MAIL': '/var/mail/cltbld', 14:16:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:21 INFO - 'MOZ_NO_REMOTE': '1', 14:16:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:16:21 INFO - 'NO_EM_RESTART': '1', 14:16:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:16:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:21 INFO - 'PWD': '/builds/slave/test', 14:16:21 INFO - 'SHELL': '/bin/bash', 14:16:21 INFO - 'SHLVL': '1', 14:16:21 INFO - 'TERM': 'linux', 14:16:21 INFO - 'TMOUT': '86400', 14:16:21 INFO - 'USER': 'cltbld', 14:16:21 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466016538.877295-370225772', 14:16:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:21 INFO - '_': '/tools/buildbot/bin/python'} 14:16:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:16:21 INFO - Running setup.py (path:/tmp/pip-U63PzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:16:21 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)) 14:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:16:21 INFO - Running setup.py (path:/tmp/pip-0Eiv9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:16:21 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)) 14:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:16:21 INFO - Running setup.py (path:/tmp/pip-DH7yoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:16:21 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)) 14:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:16:21 INFO - Running setup.py (path:/tmp/pip-AWmFiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:16:22 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)) 14:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:16:22 INFO - Running setup.py (path:/tmp/pip-KLf6u1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:16:22 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)) 14:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:16:22 INFO - Running setup.py (path:/tmp/pip-RcIDdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:16:22 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)) 14:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:16:22 INFO - Running setup.py (path:/tmp/pip-GFpV6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:16:22 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)) 14:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:16:22 INFO - Running setup.py (path:/tmp/pip-fCLvYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:16:22 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)) 14:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:16:22 INFO - Running setup.py (path:/tmp/pip-C4sFhq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:16:22 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)) 14:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:16:22 INFO - Running setup.py (path:/tmp/pip-9i7OtR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:16:22 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)) 14:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:16:22 INFO - Running setup.py (path:/tmp/pip-jhj79w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:16:22 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)) 14:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:16:22 INFO - Running setup.py (path:/tmp/pip-0xAAhY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:16:22 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)) 14:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:16:22 INFO - Running setup.py (path:/tmp/pip-peej_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:16:22 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)) 14:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:16:22 INFO - Running setup.py (path:/tmp/pip-HSW7ur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:16:22 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)) 14:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:16:22 INFO - Running setup.py (path:/tmp/pip-A1xDGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:16:22 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)) 14:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:16:22 INFO - Running setup.py (path:/tmp/pip-zSjz76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:16:22 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)) 14:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:16:22 INFO - Running setup.py (path:/tmp/pip-MQfuza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:16:23 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)) 14:16:23 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)) 14:16:23 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)) 14:16:23 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)) 14:16:23 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)) 14:16:23 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)) 14:16:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:16:23 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 14:16:23 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 14:16:23 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 14:16:23 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 14:16:23 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 14:16:23 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 14:16:24 INFO - Downloading blessings-1.6.tar.gz 14:16:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:16:24 INFO - Installing collected packages: blessings 14:16:24 INFO - Running setup.py install for blessings 14:16:25 INFO - Successfully installed blessings 14:16:25 INFO - Cleaning up... 14:16:25 INFO - Return code: 0 14:16:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:16:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:16:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:16:25 INFO - Reading from file tmpfile_stdout 14:16:25 INFO - Current package versions: 14:16:25 INFO - argparse == 1.2.1 14:16:25 INFO - blessings == 1.6 14:16:25 INFO - blobuploader == 1.2.4 14:16:25 INFO - docopt == 0.6.1 14:16:25 INFO - functools32 == 3.2.3-2 14:16:25 INFO - jsonschema == 2.5.1 14:16:25 INFO - manifestparser == 1.1 14:16:25 INFO - mozInstall == 1.12 14:16:25 INFO - mozcrash == 0.17 14:16:25 INFO - mozdebug == 0.1 14:16:25 INFO - mozdevice == 0.48 14:16:25 INFO - mozfile == 1.2 14:16:25 INFO - mozhttpd == 0.7 14:16:25 INFO - mozinfo == 0.9 14:16:25 INFO - mozleak == 0.1 14:16:25 INFO - mozlog == 3.2 14:16:25 INFO - moznetwork == 0.27 14:16:25 INFO - mozprocess == 0.22 14:16:25 INFO - mozprofile == 0.28 14:16:25 INFO - mozrunner == 6.11 14:16:25 INFO - mozscreenshot == 0.1 14:16:25 INFO - mozsystemmonitor == 0.3 14:16:25 INFO - moztest == 0.7 14:16:25 INFO - mozversion == 1.4 14:16:25 INFO - psutil == 3.1.1 14:16:25 INFO - requests == 1.2.3 14:16:25 INFO - wsgiref == 0.1.2 14:16:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:16:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:25 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 0x7fef20068f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ee1c0>, '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 0x17ef0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ef550>, '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': '652eb03db935cfc1c15ebda0000001ad-1466016538.877295-370225772', '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 14:16:25 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 14:16:25 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 14:16:25 INFO - Using env: {'DISPLAY': ':0', 14:16:25 INFO - 'HOME': '/home/cltbld', 14:16:25 INFO - 'LANG': 'en_US.UTF-8', 14:16:25 INFO - 'LANGUAGE': 'en_US:en', 14:16:25 INFO - 'LOGNAME': 'cltbld', 14:16:25 INFO - 'MAIL': '/var/mail/cltbld', 14:16:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:25 INFO - 'MOZ_NO_REMOTE': '1', 14:16:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:16:25 INFO - 'NO_EM_RESTART': '1', 14:16:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:16:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:25 INFO - 'PWD': '/builds/slave/test', 14:16:25 INFO - 'SHELL': '/bin/bash', 14:16:25 INFO - 'SHLVL': '1', 14:16:25 INFO - 'TERM': 'linux', 14:16:25 INFO - 'TMOUT': '86400', 14:16:25 INFO - 'USER': 'cltbld', 14:16:25 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466016538.877295-370225772', 14:16:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:25 INFO - '_': '/tools/buildbot/bin/python'} 14:16:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:25 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)) 14:16:25 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)) 14:16:25 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)) 14:16:25 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)) 14:16:25 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)) 14:16:25 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)) 14:16:25 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)) 14:16:25 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)) 14:16:25 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)) 14:16:25 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)) 14:16:25 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)) 14:16:25 INFO - Cleaning up... 14:16:25 INFO - Return code: 0 14:16:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:16:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef20068f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ee1c0>, '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 0x17ef0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ef550>, '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': '652eb03db935cfc1c15ebda0000001ad-1466016538.877295-370225772', '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 14:16:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:16:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:16:25 INFO - Using env: {'DISPLAY': ':0', 14:16:25 INFO - 'HOME': '/home/cltbld', 14:16:25 INFO - 'LANG': 'en_US.UTF-8', 14:16:25 INFO - 'LANGUAGE': 'en_US:en', 14:16:25 INFO - 'LOGNAME': 'cltbld', 14:16:25 INFO - 'MAIL': '/var/mail/cltbld', 14:16:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:25 INFO - 'MOZ_NO_REMOTE': '1', 14:16:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:16:25 INFO - 'NO_EM_RESTART': '1', 14:16:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:16:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:25 INFO - 'PWD': '/builds/slave/test', 14:16:25 INFO - 'SHELL': '/bin/bash', 14:16:25 INFO - 'SHLVL': '1', 14:16:25 INFO - 'TERM': 'linux', 14:16:25 INFO - 'TMOUT': '86400', 14:16:25 INFO - 'USER': 'cltbld', 14:16:25 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466016538.877295-370225772', 14:16:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:25 INFO - '_': '/tools/buildbot/bin/python'} 14:16:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:16:25 INFO - Cleaning up... 14:16:25 INFO - Return code: 0 14:16:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:16:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef20068f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ee1c0>, '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 0x17ef0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ef550>, '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': '652eb03db935cfc1c15ebda0000001ad-1466016538.877295-370225772', '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 14:16:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:16:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:16:25 INFO - Using env: {'DISPLAY': ':0', 14:16:25 INFO - 'HOME': '/home/cltbld', 14:16:25 INFO - 'LANG': 'en_US.UTF-8', 14:16:25 INFO - 'LANGUAGE': 'en_US:en', 14:16:25 INFO - 'LOGNAME': 'cltbld', 14:16:25 INFO - 'MAIL': '/var/mail/cltbld', 14:16:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:25 INFO - 'MOZ_NO_REMOTE': '1', 14:16:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:16:25 INFO - 'NO_EM_RESTART': '1', 14:16:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:16:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:25 INFO - 'PWD': '/builds/slave/test', 14:16:25 INFO - 'SHELL': '/bin/bash', 14:16:25 INFO - 'SHLVL': '1', 14:16:25 INFO - 'TERM': 'linux', 14:16:25 INFO - 'TMOUT': '86400', 14:16:25 INFO - 'USER': 'cltbld', 14:16:25 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466016538.877295-370225772', 14:16:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:25 INFO - '_': '/tools/buildbot/bin/python'} 14:16:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:25 INFO - Downloading/unpacking flake8 14:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:16:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:16:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:16:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:16:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:16:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:16:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:16:27 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 14:16:27 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 14:16:27 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 14:16:27 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 14:16:27 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 14:16:27 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 14:16:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:16:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:16:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:16:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:16:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:16:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:16:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:16:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:16:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:16:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:16:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:16:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:16:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:16:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:16:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:16:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:16:28 INFO - no previously-included directories found matching 'docs/_build' 14:16:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:16:28 INFO - Running setup.py install for pep8 14:16:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:16:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:16:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:16:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:16:28 INFO - no previously-included directories found matching 'docs/_build' 14:16:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:16:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:16:28 INFO - Cleaning up... 14:16:28 INFO - Return code: 0 14:16:28 INFO - Running post-action listener: _resource_record_post_action 14:16:28 INFO - Running post-action listener: _start_resource_monitoring 14:16:28 INFO - Starting resource monitoring. 14:16:28 INFO - ##### 14:16:28 INFO - ##### Finished create-virtualenv step (success) 14:16:28 INFO - ##### 14:16:28 INFO - ##### 14:16:28 INFO - ##### Running install step. 14:16:28 INFO - ##### 14:16:28 INFO - Running pre-action listener: _resource_record_pre_action 14:16:28 INFO - Running main action method: install 14:16:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:16:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:16:29 INFO - Reading from file tmpfile_stdout 14:16:29 INFO - Detecting whether we're running mozinstall >=1.0... 14:16:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:16:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:16:29 INFO - Reading from file tmpfile_stdout 14:16:29 INFO - Output received: 14:16:29 INFO - Usage: mozinstall [options] installer 14:16:29 INFO - Options: 14:16:29 INFO - -h, --help show this help message and exit 14:16:29 INFO - -d DEST, --destination=DEST 14:16:29 INFO - Directory to install application into. [default: 14:16:29 INFO - "/builds/slave/test"] 14:16:29 INFO - --app=APP Application being installed. [default: firefox] 14:16:29 INFO - mkdir: /builds/slave/test/build/application 14:16:29 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'] 14:16:29 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 14:16:46 INFO - Reading from file tmpfile_stdout 14:16:46 INFO - Output received: 14:16:46 INFO - /builds/slave/test/build/application/firefox/firefox 14:16:46 INFO - Running post-action listener: _resource_record_post_action 14:16:46 INFO - ##### 14:16:46 INFO - ##### Finished install step (success) 14:16:46 INFO - ##### 14:16:46 INFO - ##### 14:16:46 INFO - ##### Running run-tests step. 14:16:46 INFO - ##### 14:16:46 INFO - Running pre-action listener: _resource_record_pre_action 14:16:46 INFO - Running main action method: run_tests 14:16:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:16:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:16:46 INFO - Python 2.7.3 14:16:46 INFO - Return code: 0 14:16:46 INFO - grabbing minidump binary from tooltool 14:16: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')]} 14:16:46 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 0x17ee1c0>, '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 0x17ef0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ef550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:16:46 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 14:16:46 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 14:16:46 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 14:16:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:16:46 INFO - Return code: 0 14:16:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:16:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:16:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:16:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:16:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:16:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:16:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:16:47 INFO - Return code: 0 14:16:47 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/L4uwurAJRT-1wAKc-SAy8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 14:16:47 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/L4uwurAJRT-1wAKc-SAy8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 14:16:47 INFO - Using env: {'DISPLAY': ':0', 14:16:47 INFO - 'HOME': '/home/cltbld', 14:16:47 INFO - 'LANG': 'en_US.UTF-8', 14:16:47 INFO - 'LANGUAGE': 'en_US:en', 14:16:47 INFO - 'LOGNAME': 'cltbld', 14:16:47 INFO - 'MAIL': '/var/mail/cltbld', 14:16:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:16:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:16:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:47 INFO - 'MOZ_NO_REMOTE': '1', 14:16:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:16:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:16:47 INFO - 'NO_EM_RESTART': '1', 14:16:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:16:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:47 INFO - 'PWD': '/builds/slave/test', 14:16:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:16:47 INFO - 'SHELL': '/bin/bash', 14:16:47 INFO - 'SHLVL': '1', 14:16:47 INFO - 'TERM': 'linux', 14:16:47 INFO - 'TMOUT': '86400', 14:16:47 INFO - 'USER': 'cltbld', 14:16:47 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466016538.877295-370225772', 14:16:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:47 INFO - '_': '/tools/buildbot/bin/python'} 14:16:47 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/L4uwurAJRT-1wAKc-SAy8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 14:16:47 INFO - mozversion application_buildid: 20160615113031 14:16:47 INFO - mozversion application_changeset: 6f305ccfd7761c4215f024de0abe264f4e994437 14:16:47 INFO - mozversion application_display_name: Nightly 14:16:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:16:47 INFO - mozversion application_name: Firefox 14:16:47 INFO - mozversion application_remotingname: firefox 14:16:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:16:47 INFO - mozversion application_vendor: Mozilla 14:16:47 INFO - mozversion application_version: 50.0a1 14:16:47 INFO - mozversion platform_buildid: 20160615113031 14:16:47 INFO - mozversion platform_changeset: 6f305ccfd7761c4215f024de0abe264f4e994437 14:16:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:16:47 INFO - mozversion platform_version: 50.0a1 14:16:47 INFO - using testdate: 1466025407 14:16:47 INFO - actual date: 1466025407 14:16:47 INFO - starting webserver on 'localhost:35199' 14:16:47 INFO - SUITE-START | Running 2 tests 14:16:47 INFO - TEST-START | dromaeo_css 14:16:47 INFO - operating with platform_type : linux_ 14:16:47 INFO - Initialising browser for dromaeo_css test... 14:16:47 INFO - TEST-INFO | started process 25925 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptIz_mz/profile http://localhost:35199/getInfo.html) 14:16:51 INFO - PROCESS | 25925 | __metrics Screen width/height:1600/1200 14:16:51 INFO - PROCESS | 25925 | colorDepth:24 14:16:51 INFO - PROCESS | 25925 | Browser inner width/height: 1024/697 14:16:51 INFO - PROCESS | 25925 | __metrics 14:16:52 INFO - PROCESS | 25925 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:16:52 INFO - PROCESS | 25925 | console.error: PushService: 14:16:52 INFO - PROCESS | 25925 | stateChangeProcessEnqueue: Error transitioning state 14:16:52 INFO - PROCESS | 25925 | UnknownError 14:16:53 INFO - TEST-INFO | 25925: exit 0 14:16:53 INFO - Browser initialized. 14:16:53 INFO - Running cycle 1/1 for dromaeo_css test... 14:16:53 INFO - TEST-INFO | started process 26005 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptIz_mz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:17:05 INFO - PROCESS | 26005 | RSS: Main: 174379008 14:17:05 INFO - PROCESS | 26005 | 14:17:55 INFO - PROCESS | 26005 | 1466025475964 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] 14:20:05 INFO - PROCESS | 26005 | Cycle 1(1): loaded http://localhost:35199/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35199/tests/dromaeo/cssquery-ext.html) 14:20:05 INFO - PROCESS | 26005 | RSS: Main: 271863808 14:20:05 INFO - PROCESS | 26005 | 14:23:08 INFO - PROCESS | 26005 | Cycle 1(1): loaded http://localhost:35199/tests/dromaeo/cssquery-ext.html (next: http://localhost:35199/tests/dromaeo/cssquery-jquery.html) 14:23:09 INFO - PROCESS | 26005 | RSS: Main: 258031616 14:23:09 INFO - PROCESS | 26005 | 14:26:11 INFO - PROCESS | 26005 | Cycle 1(1): loaded http://localhost:35199/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35199/tests/dromaeo/cssquery-mootools.html) 14:26:11 INFO - PROCESS | 26005 | RSS: Main: 255700992 14:26:11 INFO - PROCESS | 26005 | 14:29:13 INFO - PROCESS | 26005 | Cycle 1(1): loaded http://localhost:35199/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35199/tests/dromaeo/cssquery-prototype.html) 14:29:14 INFO - PROCESS | 26005 | RSS: Main: 251363328 14:29:14 INFO - PROCESS | 26005 | 14:32:17 INFO - PROCESS | 26005 | Cycle 1(1): loaded http://localhost:35199/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35199/tests/dromaeo/cssquery-yui.html) 14:32:17 INFO - PROCESS | 26005 | RSS: Main: 237846528 14:32:17 INFO - PROCESS | 26005 | 14:35:20 INFO - PROCESS | 26005 | Cycle 1(1): loaded http://localhost:35199/tests/dromaeo/cssquery-yui.html (next: http://localhost:35199/tests/dromaeo/cssquery-dojo.html) 14:35:20 INFO - PROCESS | 26005 | RSS: Main: 293470208 14:35:20 INFO - PROCESS | 26005 | 14:35:20 INFO - PROCESS | 26005 | __start_tp_report 14:35:20 INFO - PROCESS | 26005 | _x_x_mozilla_page_load 14:35:20 INFO - PROCESS | 26005 | _x_x_mozilla_page_load_details 14:35:20 INFO - PROCESS | 26005 | |i|pagename|runs| 14:35:20 INFO - PROCESS | 26005 | |0;dojo.html;3130.467820470521;3133.15404840693;3160.4785210440273;3166.4775312073507;3198.5681932939046;5354.491323324288;5384.515393614579;5396.865078373033;5469.726513674315;5511.283533140686;5351.304330437038;5408.594355423339;5408.783648654049;5416.997855396754;5443.564514838813;4823.807047718087;4845;4878.0975519529;4887.877803054935;5019.447860735316;4934.876628084291;4972.477889821571;4983.327250821148;4996.625253106014;5039.168537191359;4787.425508938914;4796.472388037313;4802.087603355369;4839.177339852234;4863.294822250771;4768.642351823627;4797.496262892381;4802.18362878308;4858.878528036792;4904.950950490485;4840.927386089212;4846.709197448129;4853.927191092136;4864.416270047582;4873.439554451248;5199.376074871039;5229.869253268661;5243.711595862226;5252.947470525284;5316.3620365556;5606.719664016824;5621.690807005613;5640.943590564124;5659.886802263973;5679.119736440858;5642.069058605366;5665.801696940628;5692.146178073281;5701.6864072476;5713.685747283897;5342.946570534284;5396.838094857121;5403.729813509309;5423.538999185034;5481.890362192734;5973.432523910222;5974.761009559569;5980.760769569169;5983.640981541122;5984.072468767348;5573.69344686038;5625.212470254168;5732.971335143381;5736.512396446349;5738.856528586735;5750.993576124161;5802.0426629605645;5802.042662960649;5806.5645076618575;5862.736176872051;5753.482186603226;5772.797952071657;5774.105013722879;5776.624519406225;5777.7977770777825;5634.492895639412;5690.7439165237665;5720.942790572041;5770.5095066919785;5785.50823180026;4378.846740364072;4398.054418300081;4405.515393306734;4445.488768791631;4448.177087238806;3909.667678247381;3934.1738234970976;3942.64516193544;3959.821808018646;3971.285168669667;5334.119870221448;5339;5372.677639341652;5405.297311349499;5414.593905457106;5800.854978625483;5813.79651712188;5837.503812175928;5852.531797456193;5859.853503662357;5423.159410291411;5429.484199001088;5436.6737995719595;5438.211459338374;5477.808276710296;4823.975880120577;4889.853304400874;4913.31213630092;4929.7781599828095;4990.80036798524;6018.879622407615;6025.517958563392;6026.096085587197;6027.065804800263;6034.275886893601;5816.534677225727;5824.242848429677;5824.854378640568;5827.4172582741385;5833.066709326487;5840;5902.4097590240635;5966.76132954677;5970.104484327386;6002.249718785152;5617.269754931833;5650.23721797552;5666.093425051972;5668.093105103164;5673;5658.009848276617;5777.3356064051495;5785.623934444247;5788.479036886701;5790.913136303043;5607.2149899014985;5629.662220266797;5662.603617746719;5662.603617746719;5694.1458781183155;5590.944090559043;5636.689982051026;5636.802711905064;5637.605367624391;5640.182173584725;5398.433164517826;5493.6978466183145;5545.029619816435;5552.222688823487;5558.138488534284;5647.774089036392;5720.713964301852;5740.942590574041;5747.396523364986;5754.251947246831;5510.504054635102;5547.916781248366;5555.944440555542;5564.860878478071;5573.164025396223 14:35:20 INFO - PROCESS | 26005 | |1;ext.html;586.7535635033286;622.7446746833798;625.0717684238906;625.1279465146124;631.3370960491486;32632.347353052955;41056;42245.36631950523;42295.78852105739;42331.153376932445;43017.35473967893;43291.78354108233;43353.566464335345;43409.34885976713;43473.52211823047;8001.559914204717;8868.334874884393;9046.185843274105;9050.637974481013;9069.909300906973;8248.13394593568;8551.102134275905;8554.401191916568;8566.357523185754;10519.894801051969;10593;11121.72195695106;11126.332420054823;11136.777264454706;11144.721381965435;11017.338959662406;11075.556977720882;11093.611723589716;11094.667159985132;11101.888981110167;8201.056878458994;10375.377477351383;10693.091087257593;10757.193210509166;10932.453377331101;42557.36163957543;43277.56722432767;43403.78298108489;43600.78199608982;43723.125537489075;3264.249222678797;3439.7592168548213;3482.460218666111;3586.3544561978833;3663.780173189617;32415.837920810245;32841.83579082089;32906;33358.6664133358;33505.6649433505;4440.822367105312;4498.550144985508;4501.144782491349;4526.6831321807485;4745.145873742725;248489;248912;248930;249619.9999999982;249985;58115.70942145262;58784;58829;58834.70582647059;58843.705781471675;61843.381566183765;61984.380156198764;62204;62270.377296227365;62521;15551.922240388725;16095;16113;16125;16136.75794863078;12323.198992065487;12381.257124572554;12422.689432764253;12425.751484970431;12426.813597796041;16735.665286694442;17119.400820971205;17313.480595582154;17349.2192851322;17383.82616173822;6325.936740632535;6326.228655976334;6389.9680501597195;6393.584417012879;6483.773067942694;899.4917871402637;1042.452712326035;1061.766411389493;1085.1915323084352;1118.970547096673;32484.35031299408;32756;32958.3408331832;32978.67021329804;33288.83355583207;1087.3638921231168;1099.706379393721;1114.6711720042445;1138.0497284767146;1160.0371691496039;16647.419649954278;17231.31074757021;17488.475345739647;17495.30018799234;17510;499281;505611;505655;507059;507205;51019.23471147936;51028.74485627548;51117.23324150141;51128.23307650388;51129.74435127801;1264.4562837979756;1358.701085761131;1398.6433459467771;1405.6275087101926;1419.2052450627682;32544.51183232206;33421.05000847228;33484.83257583697;33619;34324.313513730085;49648;49995;50054.49945500498;50171.24743128783;50195.74902125466;409522;412132;412356;412653;413207;32709.672903270664;41247;42027.36958945679;45317;46366.30450543312;47945;48297.75851120862;48640.2703959448;48986.51013489819;49124;40396;40810.38784418296;41420.58579414288;42117.57882421136;42720.35919461148;42080.36879446872;42298.36552451777;42714;42907;43272.56727432685;41924.790376049146;42453;42676.78661606672;43276;43664.56335436605;36737.632623673424;37439.6256037447;38083;38092.2381552373;38421.807890960365;28413.289667758472;28884;28889;29083.563746543394;29186.56220156657 14:35:20 INFO - PROCESS | 26005 | |2;jquery.html;381.7232506432835;384.40801166204045;393.4648877526564;402.19962275072606;422.2631508018508;14232.146071235733;16583.751243731353;18190.545236369097;19907.900460497694;19908.004599770007;15102.244887755596;15541.689166216669;17424.3030278789;18659.067046647648;18741.718874216862;5408.2428460015535;5532.446755324456;5738.31140263169;5818.243628328311;5819.33077696064;5726.942730572682;5746.626469279484;5766.509846663039;5770.913436298459;5780.132980053005;4115.979420102895;6017.669028203447;6322.557420980534;6334.493240540745;6428.035794630796;6195.721192546302;6380.0748891410485;6382.872342553146;6391.296957334713;6467.83830404239;5663.292088488939;5674.801381951653;5709.143628455765;5711.457411545896;5711.942880571182;22380.328590142322;22757.203497877494;23162.420939476648;23599.29202123922;23677.644835327483;2351.3651314145254;2365.2549446924336;2386.7971222446113;2432.622943443769;2811.931466042911;12891.935540322238;13761.724765504734;13985.370658320298;14129.434822607083;14867.628309292246;1913.7416448779377;1943.2712732725229;2010.577778666482;2011.3463124484601;2058.5985732782115;82575.9999999994;83097;83666.58166709189;84468;84519.5774021126;10429.061384475282;10541.84187237192;10648.627298044532;10695.251332406657;10838.78322433547;14869.330880110421;15057.623559411102;15064.849351506344;15076.095434273979;15085.698286034218;6817.829554261183;7000.299970002959;7963.761087167394;8125.9187408126345;8350.749477515685;7945.245201705829;8010.919890801134;8049.557274349967;8130.878036829452;8177;6623.20521537409;6639.86720265592;6654.600723956578;6749.122614060239;6777;1820.8907465552109;1845.7323688065424;1952.6485232658258;1952.9121189546504;1970.1134489479791;915.9542022898828;981.4160574458186;1007.2797949466167;1045.9372437653765;1113.465536542448;18907.621847562972;19675.60648787016;19731.40805775829;19812.801871981384;20027.799722002594;986.8815742110993;1002.834532302162;1029.6910926721953;1031.3502493429091;1036.657902892044;10479.738006549896;11306.660800176009;11392.715182120513;11450.885491145149;11484;470468;482132;482241;487813.3655990326;491122;80180;81535;81929.59035204786;82428;82473.58763206146;978.6574698855344;990.1830989433746;1005.7183988483237;1006.7483129217695;1037.3775734559204;17375.82624173742;17404;17462.388816391365;17586.29654813844;17626.383076592258;28343.433131336846;41032.384514231715;41562.58437415587;42099;42133.78933105315;44409.33385999148;48376;51998;53009;56306.43693563012;8254.752357429286;8455.704050358208;8703.216710496086;8909.287257019552;8925;9656.855147172657;12738.936305318413;12836;13428.462861485432;13809.930950345184;11955.820662690241;12108.455119519467;12191.878081219074;12316.445759940645;12377.876221237673;11762.470688818852;11938.462769175234;12021.579244726743;12184.329861857683;12283.938580307042;11807.645770626896;11983.400829958642;12413.31726755001;12543.059270554928;12664;7401.481896267425;7668.1181664109345;8690.304775618062;8819.206271435602;8999.245147196234;11772.17594768358;11833.171677982458;12068.51725930988;12173.756524869275;12354.938225308815 14:35:20 INFO - PROCESS | 26005 | |3;mootools.html;1332.7746852616679;1468.7796830475431;1478.0762023735165;1582.8179759327681;1719.191979769508;8354.456960297577;8750.562471876405;8759.781005474866;9020.278377729783;9026.142516460926;8865.157810008039;9052.95473522633;9063.456192628448;9065.909340906588;9066.274698024159;2071.8031786980214;2283.303592404316;2300.022490441564;2326.4416540030356;2376.4771750215014;2352.0591763294647;2359.3511784259294;2362.681038059866;2362.988185059081;2366.301940927422;2336.6845475860796;2344.847584906984;2365.2312998275543;2365.5741966446035;2368.111958015744;1991.2234228650766;2217.733871935378;2283.44055706353;2297.7702229777055;2297.873616951067;2285.1430713482446;2299.7470278269375;2320.3039088273617;2320.47789247418;2320.501092265154;8997.730068097968;9087.863682044775;9092.590833412512;9095.090490950919;9112.8633070504;4991.600671946236;5059.74701264939;5062.569681577033;5121.564667003309;5124.103281925648;3292.654271301503;3412.692857642824;3478.8608455661742;3489.4242449995722;3490.89527314181;1150.7468356961456;1154.3535620052796;1172.6540670502222;1206.3304865799478;1222.2971791220084;12557.434915428828;12573.497060117585;12583.748325033539;12584.993200544026;12585.874141258562;4605.148047611136;4660.277656963176;4764.523547645208;4785.712857228577;4848.781804818792;10476.63331783384;10523.84214236787;10525.947370263253;10532.262741608167;10536.683899483029;5347.973260133675;5350.250964864844;5353.7590808413715;5356.598255130881;5359.356877174686;4357.520672726061;4799.424069111729;4938.08645400602;4939.703617782944;5023.623228257895;3919.9216015679526;3976.9602303977167;4052.756834589934;4094.6928980326593;4180.790960452026;1273.5924504158581;1296.935153242353;1302.3748600671731;1318.2947123288993;1318.63737472194;883.4037025008093;924.366808736018;931.7065124485765;935.9377106983486;945.7115579748242;5791.7683292667825;5794.565407594448;5952.166696662471;5958.582899197101;6039.607425517327;444.9065696203769;455.97720113994166;458.98623041308815;466.8179410030091;469.4390203706606;4013.9598604013586;4019.256437559061;4079.8980025499004;4084.14233011071;4172.624463798273;10606.734831629272;11262.099032077414;11339.773204536028;11373.488193031333;11408.828867566994;10911.127109831194;11152.386618736047;11273.492692828842;11295.548178072784;11321.943390282995;8329.08380078191;8389.45468544555;8391.454555453876;8414.453060551044;8458.703945362005;5889.175515427929;5910;5940.079287710412;5963.880722385615;6190.288116866618;9611.663591774255;10360.637377691744;10454.059134677915;10576.312539684895;10578.312409693346;10483.108935740242;10556.366618002945;10611.89388106109;10692.786144277226;10716.08913242352;7170.462215333767;7386.15059268191;7388.6675099621725;7795.142534321333;7852;8237.135100814328;8461.703840365804;8699.56502174876;8708.998465176332;8815.515146666994;7615.619219039137;7752.65113069902;7834.373250139861;7855.646495907812;7941.642626081955;7585.165631780389;7714.845703085794;7756.767296981099;7885.29032387088;7928.365730741642;6602.966985165235;6639.136912201383;6666;6671.83320416974;6674.866502669823;4967.850964471072;5155.458676838878;5165.096108181128;5185.896282074413;5300.1519756838725;5224.1641337387355;5266.683998960075;5287.339082614673;5293.232481290268;5370.382406023357 14:35:20 INFO - PROCESS | 26005 | |4;prototype.html;331.05153734550504;332.96448046575154;338.8952016426449;341.8376271271148;343.6786604524771;5396.703181325026;5434.184872269162;5445.83662490125;5452;5459.454054594538;5257.474252574741;5286.365636123661;5319.281896943911;5334.146536554152;5378.596605254602;3920.3733498556035;4071.5114186297687;4129.772862492562;4130.8554200602985;4135.875923722293;4045.9595404045876;4136.607022332873;4147.4815648044;4152.190322887038;4201.684873634475;4074.9185016299803;4102.507699076115;4128.62842344189;4138.151678905817;4147.9585204148025;3971.801409929521;4071.389291606253;4137.110521237933;4156.06488540076;4167.5207351154395;3692.907677308062;3698.7965661888584;3708.369577171887;3710.4619830124752;3725.2735716535285;5191.480851914778;5193.350831146106;5197.636165468419;5244.187150991603;5262.421133675331;4669.6731228814;4716.221823399135;4752.714837109785;4774.928376074362;4807.78364973577;5528.253685752412;5559.082751346064;5572.331320241557;5573.164025396182;5583.106702927553;4007;4062.1672557125717;4071.2671719090554;4075.2257071156682;4099.795010249505;5625.915611265835;5734.799282025151;5742.282214723118;5771.672515321499;5889.734961926723;4187.97906010468;4192.28731115705;4207.137536804948;4218.894527636834;4249.107687385684;4260.914781704349;4276.422682937764;4282;4283.571642835692;4288.506821715543;4610.677252592286;4772.976135119302;4800.495947925418;4813.422389313305;4851.660383773102;5545.918545883595;5587.217789509472;5616.293246457319;5622.493975542221;5635.154726790932;1452.6005348529027;1466.7726502392147;1471.1687896338535;1478.874295684879;1480.851914808532;912.8630705394244;926.3006430145332;967.9274054445945;968.6125549780004;980.9215262778961;5287.391949925808;5371.838844834661;5387.141436204503;5402.541313845319;5432.837014889559;5716.342620598602;5732.713364331767;5753.165790960287;5771.422857714195;5800.796972105956;5210.374755029421;5300.496452836975;5348.331458567679;5374.596905232123;5422.457754224546;3043.315254067817;3076.2616971927023;3088.7992280502144;3091.8608662610236;3098.070578826343;5932.436418540232;5985.760569577168;5988.820335389945;5989.460948514655;6038.365971573009;5551.8341148359295;5878.825434265535;5908.4091590841435;5912.970435147797;5964.373740757244;5996.910046349309;6035.396460354017;6039.305479869696;6044.637321760709;6059.757609695651;5601.551875849841;5739.454751798572;5794.565407594531;5827.70861456917;5831.591788574759;5658.490735833795;5692.117721753135;5741.167530708108;5749.476388756899;5752.6836024019085;5902.1736956826935;5958.374370691015;5994.460498555151;6010.54920880927;6020.488258497901;4056.411820286101;4076.612721791425;4092.2838503262406;4102.835886564504;4111.177764447063;5765.538756899522;5843.678597677169;5859.5019423349495;5904.143899134688;5918.970405147947;5585.609007369445;5671.234383358359;5795.291013751118;5797.072468405035;5806.535477161732;5578.386377498553;5586.273784408001;5587.580931430078;5620.718964051699;5663.8867222656145;5319.946800531945;5539.7230138492105;5547.944520554743;5578.553715702815;5578.972105139611;5456;5606.635568688022;5627.409122042291;5636.633618814764;5656.567675899403;5492.182932861623;5496.038193316233;5496.972515137559;5522;5541.667499950016 14:35:20 INFO - PROCESS | 26005 | |5;yui.html;675.7161991963375;728.1771598094152;734.4785202506224;764.293028948223;766.9271419215172;12158.392080395977;12459.517812162641;12535.435905384269;12711.936440317797;13872.791908121386;13172.407241674124;13252;13358.465661373533;13358.465661373533;13365;680.4012469027249;797.1470526536608;799.7960520067375;829.340674164038;836.6736972580699;806.479820515767;826.3595713322163;826.7478419082178;827.0365024746194;827.0571548434789;873.0789017586476;879.7668617816283;880.2034159086037;880.5553195636227;880.7621942075667;716.1728203924449;837.3050368194445;864.4597126795753;873.5064688451037;874.868769684546;631.1857703562399;632.8069938668705;633.7528363938068;633.9049142628596;633.9112524246609;12977;13048.934755326258;13051.934740326238;13067.86932130676;13077.673058173526;12201.328926909016;12535.122541422104;12625.558105466265;12741.554045608453;13022.153560018663;9853.261005424622;9914.40513569188;9987.250956178243;10290.176785857187;10760.515776789985;4279.7218180818145;4367.737935723835;4380.934285985712;4475.731456112644;4509.571590698878;75903.24096759017;76038.99999999945;77322;77470.61264693696;77730.61134694346;10040.096391324816;10079.949600251952;10197.592096316064;10399.270991194482;10460.163186945027;19196.328128515714;19200;19241.90379048096;19251.4224573263;19285.807141928402;7658.540487570764;7662.233776622294;7698.769036928901;7777.883331750028;7940.761777146695;4226.915461690749;4275.102228532043;4278.657707383401;4299.002890967084;4432.357308190359;3109.8445077746474;3178.523221516745;3179.380020895949;3197.328561002216;3201.711845933877;540.8891177308642;627.9309275979639;643.8261669349249;667.576089183372;675.1864003875417;647.9319671434525;671.8421171024805;701.3512500936613;704.3731079339392;713.3971793834202;9443.622255109856;9517.143457088896;9575.712728618153;9621.855672164924;9670.661526846527;581.8050952930815;615.8460384903774;695.4540685561809;721.3039416962656;740.7222291640635;4235.216484950294;4499.505054444008;4526.185286648435;4541.591256786905;4642.65180111493;127889.36055319663;128272;129137.3543132297;129947;130331;106177;106594.46702766592;107081;107892;110527;75459;77745;80465;94650;95110;9349.205317548085;9657.517124143624;9869.753256168653;10006.799864002534;10012.249081319076;49441.50558494369;49724.50275497199;50407.747961259956;50783.74608126936;50872.23691644702;71133;71296.64351678209;72539.63730181316;73363;76828.6158569226;11661.6501504955;12109.455074521844;12501.562445314734;12586.18189817659;13106.672333191747;13409.128406653535;13728.382222799799;14108.78836817428;14143;14235.430582776573;13548.254845983565;13743.793843092562;13952.372143253375;14088.718225635224;14189.929050354682;13573.1856088635;13594.524191653245;13744.175349479063;14059.859401406264;14282.000259981702;12089.455974481345;12221.694457638274;12826.871731282941;12944.805827912778;12961.675958101123;10840.4281379198;10900.945495272474;11173;11277.830832537682;11613.187076904536;10736.248462607542;11072.446377680923;11235.71910702239;11489.195756296978;11525.481353339288 14:35:20 INFO - PROCESS | 26005 | __end_tp_report 14:35:20 INFO - PROCESS | 26005 | __start_cc_report 14:35:20 INFO - PROCESS | 26005 | _x_x_mozilla_cycle_collect,855 14:35:20 INFO - PROCESS | 26005 | __end_cc_report 14:35:20 INFO - PROCESS | 26005 | __startTimestamp1466026520889__endTimestamp 14:35:20 INFO - PROCESS | 26005 | 14:35:20 INFO - PROCESS | 26005 | ------- Summary: start ------- 14:35:20 INFO - PROCESS | 26005 | Number of tests: 6 14:35:20 INFO - PROCESS | 26005 | 14:35:20 INFO - PROCESS | 26005 | [#0] dojo.html Cycles:165 Average:5347.98 Median:5558.14 stddev:609.70 (11.0%) stddev-sans-first:586.22 14:35:20 INFO - PROCESS | 26005 | Values: 3130.5 3133.2 3160.5 3166.5 3198.6 5354.5 5384.5 5396.9 5469.7 5511.3 5351.3 5408.6 5408.8 5417.0 5443.6 4823.8 4845.0 4878.1 4887.9 5019.4 4934.9 4972.5 4983.3 4996.6 5039.2 4787.4 4796.5 4802.1 4839.2 4863.3 4768.6 4797.5 4802.2 4858.9 4905.0 4840.9 4846.7 4853.9 4864.4 4873.4 5199.4 5229.9 5243.7 5252.9 5316.4 5606.7 5621.7 5640.9 5659.9 5679.1 5642.1 5665.8 5692.1 5701.7 5713.7 5342.9 5396.8 5403.7 5423.5 5481.9 5973.4 5974.8 5980.8 5983.6 5984.1 5573.7 5625.2 5733.0 5736.5 5738.9 5751.0 5802.0 5802.0 5806.6 5862.7 5753.5 5772.8 5774.1 5776.6 5777.8 5634.5 5690.7 5720.9 5770.5 5785.5 4378.8 4398.1 4405.5 4445.5 4448.2 3909.7 3934.2 3942.6 3959.8 3971.3 5334.1 5339.0 5372.7 5405.3 5414.6 5800.9 5813.8 5837.5 5852.5 5859.9 5423.2 5429.5 5436.7 5438.2 5477.8 4824.0 4889.9 4913.3 4929.8 4990.8 6018.9 6025.5 6026.1 6027.1 6034.3 5816.5 5824.2 5824.9 5827.4 5833.1 5840.0 5902.4 5966.8 5970.1 6002.2 5617.3 5650.2 5666.1 5668.1 5673.0 5658.0 5777.3 5785.6 5788.5 5790.9 5607.2 5629.7 5662.6 5662.6 5694.1 5590.9 5636.7 5636.8 5637.6 5640.2 5398.4 5493.7 5545.0 5552.2 5558.1 5647.8 5720.7 5740.9 5747.4 5754.3 5510.5 5547.9 5555.9 5564.9 5573.2 14:35:20 INFO - PROCESS | 26005 | 14:35:20 INFO - PROCESS | 26005 | [#1] ext.html Cycles:180 Average:56369.70 Median:412244.00 stddev:106603.56 (25.9%) stddev-sans-first:106820.33 14:35:20 INFO - PROCESS | 26005 | Values: 586.8 622.7 625.1 625.1 631.3 32632.3 41056.0 42245.4 42295.8 42331.2 43017.4 43291.8 43353.6 43409.3 43473.5 8001.6 8868.3 9046.2 9050.6 9069.9 8248.1 8551.1 8554.4 8566.4 10519.9 10593.0 11121.7 11126.3 11136.8 11144.7 11017.3 11075.6 11093.6 11094.7 11101.9 8201.1 10375.4 10693.1 10757.2 10932.5 42557.4 43277.6 43403.8 43600.8 43723.1 3264.2 3439.8 3482.5 3586.4 3663.8 32415.8 32841.8 32906.0 33358.7 33505.7 4440.8 4498.6 4501.1 4526.7 4745.1 248489.0 248912.0 248930.0 249620.0 249985.0 58115.7 58784.0 58829.0 58834.7 58843.7 61843.4 61984.4 62204.0 62270.4 62521.0 15551.9 16095.0 16113.0 16125.0 16136.8 12323.2 12381.3 12422.7 12425.8 12426.8 16735.7 17119.4 17313.5 17349.2 17383.8 6325.9 6326.2 6390.0 6393.6 6483.8 899.5 1042.5 1061.8 1085.2 1119.0 32484.4 32756.0 32958.3 32978.7 33288.8 1087.4 1099.7 1114.7 1138.0 1160.0 16647.4 17231.3 17488.5 17495.3 17510.0 499281.0 505611.0 505655.0 507059.0 507205.0 51019.2 51028.7 51117.2 51128.2 51129.7 1264.5 1358.7 1398.6 1405.6 1419.2 32544.5 33421.1 33484.8 33619.0 34324.3 49648.0 49995.0 50054.5 50171.2 50195.7 409522.0 412132.0 412356.0 412653.0 413207.0 32709.7 41247.0 42027.4 45317.0 46366.3 47945.0 48297.8 48640.3 48986.5 49124.0 40396.0 40810.4 41420.6 42117.6 42720.4 42080.4 42298.4 42714.0 42907.0 43272.6 41924.8 42453.0 42676.8 43276.0 43664.6 36737.6 37439.6 38083.0 38092.2 38421.8 28413.3 28884.0 28889.0 29083.6 29186.6 14:35:20 INFO - PROCESS | 26005 | 14:35:20 INFO - PROCESS | 26005 | [#2] jquery.html Cycles:180 Average:28428.44 Median:13032.22 stddev:79381.04 (609.1%) stddev-sans-first:79575.79 14:35:20 INFO - PROCESS | 26005 | Values: 381.7 384.4 393.5 402.2 422.3 14232.1 16583.8 18190.5 19907.9 19908.0 15102.2 15541.7 17424.3 18659.1 18741.7 5408.2 5532.4 5738.3 5818.2 5819.3 5726.9 5746.6 5766.5 5770.9 5780.1 4116.0 6017.7 6322.6 6334.5 6428.0 6195.7 6380.1 6382.9 6391.3 6467.8 5663.3 5674.8 5709.1 5711.5 5711.9 22380.3 22757.2 23162.4 23599.3 23677.6 2351.4 2365.3 2386.8 2432.6 2811.9 12891.9 13761.7 13985.4 14129.4 14867.6 1913.7 1943.3 2010.6 2011.3 2058.6 82576.0 83097.0 83666.6 84468.0 84519.6 10429.1 10541.8 10648.6 10695.3 10838.8 14869.3 15057.6 15064.8 15076.1 15085.7 6817.8 7000.3 7963.8 8125.9 8350.7 7945.2 8010.9 8049.6 8130.9 8177.0 6623.2 6639.9 6654.6 6749.1 6777.0 1820.9 1845.7 1952.6 1952.9 1970.1 916.0 981.4 1007.3 1045.9 1113.5 18907.6 19675.6 19731.4 19812.8 20027.8 986.9 1002.8 1029.7 1031.4 1036.7 10479.7 11306.7 11392.7 11450.9 11484.0 470468.0 482132.0 482241.0 487813.4 491122.0 80180.0 81535.0 81929.6 82428.0 82473.6 978.7 990.2 1005.7 1006.7 1037.4 17375.8 17404.0 17462.4 17586.3 17626.4 28343.4 41032.4 41562.6 42099.0 42133.8 44409.3 48376.0 51998.0 53009.0 56306.4 8254.8 8455.7 8703.2 8909.3 8925.0 9656.9 12738.9 12836.0 13428.5 13809.9 11955.8 12108.5 12191.9 12316.4 12377.9 11762.5 11938.5 12021.6 12184.3 12283.9 11807.6 11983.4 12413.3 12543.1 12664.0 7401.5 7668.1 8690.3 8819.2 8999.2 11772.2 11833.2 12068.5 12173.8 12354.9 14:35:20 INFO - PROCESS | 26005 | 14:35:20 INFO - PROCESS | 26005 | [#3] mootools.html Cycles:180 Average:5854.72 Median:2564.86 stddev:3405.38 (132.8%) stddev-sans-first:3397.97 14:35:20 INFO - PROCESS | 26005 | Values: 1332.8 1468.8 1478.1 1582.8 1719.2 8354.5 8750.6 8759.8 9020.3 9026.1 8865.2 9053.0 9063.5 9065.9 9066.3 2071.8 2283.3 2300.0 2326.4 2376.5 2352.1 2359.4 2362.7 2363.0 2366.3 2336.7 2344.8 2365.2 2365.6 2368.1 1991.2 2217.7 2283.4 2297.8 2297.9 2285.1 2299.7 2320.3 2320.5 2320.5 8997.7 9087.9 9092.6 9095.1 9112.9 4991.6 5059.7 5062.6 5121.6 5124.1 3292.7 3412.7 3478.9 3489.4 3490.9 1150.7 1154.4 1172.7 1206.3 1222.3 12557.4 12573.5 12583.7 12585.0 12585.9 4605.1 4660.3 4764.5 4785.7 4848.8 10476.6 10523.8 10525.9 10532.3 10536.7 5348.0 5350.3 5353.8 5356.6 5359.4 4357.5 4799.4 4938.1 4939.7 5023.6 3919.9 3977.0 4052.8 4094.7 4180.8 1273.6 1296.9 1302.4 1318.3 1318.6 883.4 924.4 931.7 935.9 945.7 5791.8 5794.6 5952.2 5958.6 6039.6 444.9 456.0 459.0 466.8 469.4 4014.0 4019.3 4079.9 4084.1 4172.6 10606.7 11262.1 11339.8 11373.5 11408.8 10911.1 11152.4 11273.5 11295.5 11321.9 8329.1 8389.5 8391.5 8414.5 8458.7 5889.2 5910.0 5940.1 5963.9 6190.3 9611.7 10360.6 10454.1 10576.3 10578.3 10483.1 10556.4 10611.9 10692.8 10716.1 7170.5 7386.2 7388.7 7795.1 7852.0 8237.1 8461.7 8699.6 8709.0 8815.5 7615.6 7752.7 7834.4 7855.6 7941.6 7585.2 7714.8 7756.8 7885.3 7928.4 6603.0 6639.1 6666.0 6671.8 6674.9 4967.9 5155.5 5165.1 5185.9 5300.2 5224.2 5266.7 5287.3 5293.2 5370.4 14:35:20 INFO - PROCESS | 26005 | 14:35:20 INFO - PROCESS | 26005 | [#4] prototype.html Cycles:180 Average:4739.48 Median:5427.65 stddev:1393.28 (25.7%) stddev-sans-first:1357.33 14:35:20 INFO - PROCESS | 26005 | Values: 331.1 333.0 338.9 341.8 343.7 5396.7 5434.2 5445.8 5452.0 5459.5 5257.5 5286.4 5319.3 5334.1 5378.6 3920.4 4071.5 4129.8 4130.9 4135.9 4046.0 4136.6 4147.5 4152.2 4201.7 4074.9 4102.5 4128.6 4138.2 4148.0 3971.8 4071.4 4137.1 4156.1 4167.5 3692.9 3698.8 3708.4 3710.5 3725.3 5191.5 5193.4 5197.6 5244.2 5262.4 4669.7 4716.2 4752.7 4774.9 4807.8 5528.3 5559.1 5572.3 5573.2 5583.1 4007.0 4062.2 4071.3 4075.2 4099.8 5625.9 5734.8 5742.3 5771.7 5889.7 4188.0 4192.3 4207.1 4218.9 4249.1 4260.9 4276.4 4282.0 4283.6 4288.5 4610.7 4773.0 4800.5 4813.4 4851.7 5545.9 5587.2 5616.3 5622.5 5635.2 1452.6 1466.8 1471.2 1478.9 1480.9 912.9 926.3 967.9 968.6 980.9 5287.4 5371.8 5387.1 5402.5 5432.8 5716.3 5732.7 5753.2 5771.4 5800.8 5210.4 5300.5 5348.3 5374.6 5422.5 3043.3 3076.3 3088.8 3091.9 3098.1 5932.4 5985.8 5988.8 5989.5 6038.4 5551.8 5878.8 5908.4 5913.0 5964.4 5996.9 6035.4 6039.3 6044.6 6059.8 5601.6 5739.5 5794.6 5827.7 5831.6 5658.5 5692.1 5741.2 5749.5 5752.7 5902.2 5958.4 5994.5 6010.5 6020.5 4056.4 4076.6 4092.3 4102.8 4111.2 5765.5 5843.7 5859.5 5904.1 5919.0 5585.6 5671.2 5795.3 5797.1 5806.5 5578.4 5586.3 5587.6 5620.7 5663.9 5319.9 5539.7 5547.9 5578.6 5579.0 5456.0 5606.6 5627.4 5636.6 5656.6 5492.2 5496.0 5497.0 5522.0 5541.7 14:35:20 INFO - PROCESS | 26005 | 14:35:20 INFO - PROCESS | 26005 | [#5] yui.html Cycles:180 Average:20893.69 Median:4374.34 stddev:31833.23 (727.7%) stddev-sans-first:31886.33 14:35:20 INFO - PROCESS | 26005 | Values: 675.7 728.2 734.5 764.3 766.9 12158.4 12459.5 12535.4 12711.9 13872.8 13172.4 13252.0 13358.5 13358.5 13365.0 680.4 797.1 799.8 829.3 836.7 806.5 826.4 826.7 827.0 827.1 873.1 879.8 880.2 880.6 880.8 716.2 837.3 864.5 873.5 874.9 631.2 632.8 633.8 633.9 633.9 12977.0 13048.9 13051.9 13067.9 13077.7 12201.3 12535.1 12625.6 12741.6 13022.2 9853.3 9914.4 9987.3 10290.2 10760.5 4279.7 4367.7 4380.9 4475.7 4509.6 75903.2 76039.0 77322.0 77470.6 77730.6 10040.1 10079.9 10197.6 10399.3 10460.2 19196.3 19200.0 19241.9 19251.4 19285.8 7658.5 7662.2 7698.8 7777.9 7940.8 4226.9 4275.1 4278.7 4299.0 4432.4 3109.8 3178.5 3179.4 3197.3 3201.7 540.9 627.9 643.8 667.6 675.2 647.9 671.8 701.4 704.4 713.4 9443.6 9517.1 9575.7 9621.9 9670.7 581.8 615.8 695.5 721.3 740.7 4235.2 4499.5 4526.2 4541.6 4642.7 127889.4 128272.0 129137.4 129947.0 130331.0 106177.0 106594.5 107081.0 107892.0 110527.0 75459.0 77745.0 80465.0 94650.0 95110.0 9349.2 9657.5 9869.8 10006.8 10012.2 49441.5 49724.5 50407.7 50783.7 50872.2 71133.0 71296.6 72539.6 73363.0 76828.6 11661.7 12109.5 12501.6 12586.2 13106.7 13409.1 13728.4 14108.8 14143.0 14235.4 13548.3 13743.8 13952.4 14088.7 14189.9 13573.2 13594.5 13744.2 14059.9 14282.0 12089.5 12221.7 12826.9 12944.8 12961.7 10840.4 10900.9 11173.0 11277.8 11613.2 10736.2 11072.4 11235.7 11489.2 11525.5 14:35:20 INFO - PROCESS | 26005 | -------- Summary: end -------- 14:35:20 INFO - PROCESS | 26005 | 14:35:21 INFO - TEST-INFO | 26005: exit 0 14:35:21 INFO - TEST-OK | dromaeo_css | took 1114393ms 14:35:21 INFO - TEST-START | kraken 14:35:21 INFO - operating with platform_type : linux_ 14:35:21 INFO - Initialising browser for kraken test... 14:35:21 INFO - TEST-INFO | started process 26193 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTzwRme/profile http://localhost:35199/getInfo.html) 14:35:25 INFO - PROCESS | 26193 | __metrics Screen width/height:1600/1200 14:35:25 INFO - PROCESS | 26193 | colorDepth:24 14:35:25 INFO - PROCESS | 26193 | Browser inner width/height: 1024/697 14:35:25 INFO - PROCESS | 26193 | __metrics 14:35:26 INFO - PROCESS | 26193 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:35:26 INFO - PROCESS | 26193 | console.error: PushService: 14:35:26 INFO - PROCESS | 26193 | stateChangeProcessEnqueue: Error transitioning state 14:35:26 INFO - PROCESS | 26193 | UnknownError 14:35:27 INFO - TEST-INFO | 26193: exit 0 14:35:27 INFO - Browser initialized. 14:35:27 INFO - Running cycle 1/1 for kraken test... 14:35:27 INFO - TEST-INFO | started process 26273 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTzwRme/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:35:39 INFO - PROCESS | 26273 | RSS: Main: 173838336 14:35:39 INFO - PROCESS | 26273 | 14:35:42 INFO - PROCESS | 26273 | Cycle 1(1): loaded http://localhost:35199/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35199/tests/kraken/driver.html?testName=audio-beat-detection) 14:35:43 INFO - PROCESS | 26273 | RSS: Main: 232947712 14:35:43 INFO - PROCESS | 26273 | 14:35:45 INFO - PROCESS | 26273 | Cycle 1(1): loaded http://localhost:35199/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35199/tests/kraken/driver.html?testName=audio-dft) 14:35:46 INFO - PROCESS | 26273 | RSS: Main: 220344320 14:35:46 INFO - PROCESS | 26273 | 14:35:49 INFO - PROCESS | 26273 | Cycle 1(1): loaded http://localhost:35199/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35199/tests/kraken/driver.html?testName=audio-fft) 14:35:50 INFO - PROCESS | 26273 | RSS: Main: 287006720 14:35:50 INFO - PROCESS | 26273 | 14:35:52 INFO - PROCESS | 26273 | Cycle 1(1): loaded http://localhost:35199/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35199/tests/kraken/driver.html?testName=audio-oscillator) 14:35:52 INFO - PROCESS | 26273 | RSS: Main: 197668864 14:35:52 INFO - PROCESS | 26273 | 14:35:54 INFO - PROCESS | 26273 | Cycle 1(1): loaded http://localhost:35199/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35199/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:35:55 INFO - PROCESS | 26273 | RSS: Main: 201478144 14:35:55 INFO - PROCESS | 26273 | 14:35:58 INFO - PROCESS | 26273 | Cycle 1(1): loaded http://localhost:35199/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35199/tests/kraken/driver.html?testName=imaging-darkroom) 14:35:59 INFO - PROCESS | 26273 | RSS: Main: 238137344 14:35:59 INFO - PROCESS | 26273 | 14:36:02 INFO - PROCESS | 26273 | Cycle 1(1): loaded http://localhost:35199/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35199/tests/kraken/driver.html?testName=imaging-desaturate) 14:36:03 INFO - PROCESS | 26273 | RSS: Main: 238870528 14:36:03 INFO - PROCESS | 26273 | 14:36:06 INFO - PROCESS | 26273 | Cycle 1(1): loaded http://localhost:35199/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35199/tests/kraken/driver.html?testName=json-parse-financial) 14:36:06 INFO - PROCESS | 26273 | RSS: Main: 238436352 14:36:06 INFO - PROCESS | 26273 | 14:36:08 INFO - PROCESS | 26273 | Cycle 1(1): loaded http://localhost:35199/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35199/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:36:08 INFO - PROCESS | 26273 | RSS: Main: 228093952 14:36:08 INFO - PROCESS | 26273 | 14:36:10 INFO - PROCESS | 26273 | Cycle 1(1): loaded http://localhost:35199/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35199/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:36:11 INFO - PROCESS | 26273 | RSS: Main: 230309888 14:36:11 INFO - PROCESS | 26273 | 14:36:13 INFO - PROCESS | 26273 | Cycle 1(1): loaded http://localhost:35199/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35199/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:36:13 INFO - PROCESS | 26273 | RSS: Main: 237875200 14:36:13 INFO - PROCESS | 26273 | 14:36:16 INFO - PROCESS | 26273 | Cycle 1(1): loaded http://localhost:35199/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35199/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:36:17 INFO - PROCESS | 26273 | RSS: Main: 241340416 14:36:17 INFO - PROCESS | 26273 | 14:36:19 INFO - PROCESS | 26273 | Cycle 1(1): loaded http://localhost:35199/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35199/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:36:20 INFO - PROCESS | 26273 | RSS: Main: 241561600 14:36:20 INFO - PROCESS | 26273 | 14:36:22 INFO - PROCESS | 26273 | Cycle 1(1): loaded http://localhost:35199/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35199/tests/kraken/driver.html?testName=ai-astar) 14:36:22 INFO - PROCESS | 26273 | RSS: Main: 284864512 14:36:22 INFO - PROCESS | 26273 | 14:36:22 INFO - PROCESS | 26273 | __start_tp_report 14:36:22 INFO - PROCESS | 26273 | _x_x_mozilla_page_load 14:36:22 INFO - PROCESS | 26273 | _x_x_mozilla_page_load_details 14:36:22 INFO - PROCESS | 26273 | |i|pagename|runs| 14:36:22 INFO - PROCESS | 26273 | |0;ai-astar;109;105;112;110;111;110;108;111;110;109 14:36:22 INFO - PROCESS | 26273 | |1;audio-beat-detection;155;130;134;179;127;126;150;123;193;128 14:36:22 INFO - PROCESS | 26273 | |2;audio-dft;160;160;159;159;161;161;162;160;163;161 14:36:22 INFO - PROCESS | 26273 | |3;audio-fft;73;73;75;127;77;75;74;76;102;74 14:36:22 INFO - PROCESS | 26273 | |4;audio-oscillator;85;86;110;86;86;86;119;85;91;133 14:36:22 INFO - PROCESS | 26273 | |5;imaging-gaussian-blur;116;116;116;117;116;117;117;117;116;117 14:36:22 INFO - PROCESS | 26273 | |6;imaging-darkroom;145;147;145;145;146;146;145;145;146;148 14:36:22 INFO - PROCESS | 26273 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;96;96 14:36:22 INFO - PROCESS | 26273 | |8;json-parse-financial;54;55;55;54;55;54;54;55;58;53 14:36:22 INFO - PROCESS | 26273 | |9;json-stringify-tinderbox;61;62;62;62;62;63;62;62;64;64 14:36:22 INFO - PROCESS | 26273 | |10;stanford-crypto-aes;80;85;79;80;80;80;80;87;111;80 14:36:22 INFO - PROCESS | 26273 | |11;stanford-crypto-ccm;144;124;132;119;122;120;118;122;143;123 14:36:22 INFO - PROCESS | 26273 | |12;stanford-crypto-pbkdf2;160;158;162;163;160;164;166;159;160;159 14:36:22 INFO - PROCESS | 26273 | |13;stanford-crypto-sha256-iterative;65;65;66;65;62;66;68;64;63;61 14:36:22 INFO - PROCESS | 26273 | __end_tp_report 14:36:22 INFO - PROCESS | 26273 | __start_cc_report 14:36:22 INFO - PROCESS | 26273 | _x_x_mozilla_cycle_collect,1618 14:36:22 INFO - PROCESS | 26273 | __end_cc_report 14:36:22 INFO - PROCESS | 26273 | __startTimestamp1466026582334__endTimestamp 14:36:22 INFO - PROCESS | 26273 | 14:36:22 INFO - PROCESS | 26273 | ------- Summary: start ------- 14:36:22 INFO - PROCESS | 26273 | Number of tests: 14 14:36:22 INFO - PROCESS | 26273 | 14:36:22 INFO - PROCESS | 26273 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.00 stddev:1.96 (1.8%) stddev-sans-first:2.07 14:36:22 INFO - PROCESS | 26273 | Values: 109.0 105.0 112.0 110.0 111.0 110.0 108.0 111.0 110.0 109.0 14:36:22 INFO - PROCESS | 26273 | 14:36:22 INFO - PROCESS | 26273 | [#1] audio-beat-detection Cycles:10 Average:144.50 Median:142.00 stddev:24.46 (17.2%) stddev-sans-first:25.65 14:36:22 INFO - PROCESS | 26273 | Values: 155.0 130.0 134.0 179.0 127.0 126.0 150.0 123.0 193.0 128.0 14:36:22 INFO - PROCESS | 26273 | 14:36:22 INFO - PROCESS | 26273 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:1.26 (0.8%) stddev-sans-first:1.32 14:36:22 INFO - PROCESS | 26273 | Values: 160.0 160.0 159.0 159.0 161.0 161.0 162.0 160.0 163.0 161.0 14:36:22 INFO - PROCESS | 26273 | 14:36:22 INFO - PROCESS | 26273 | [#3] audio-fft Cycles:10 Average:82.60 Median:74.50 stddev:17.86 (24.0%) stddev-sans-first:18.60 14:36:22 INFO - PROCESS | 26273 | Values: 73.0 73.0 75.0 127.0 77.0 75.0 74.0 76.0 102.0 74.0 14:36:22 INFO - PROCESS | 26273 | 14:36:22 INFO - PROCESS | 26273 | [#4] audio-oscillator Cycles:10 Average:96.70 Median:86.00 stddev:17.50 (20.3%) stddev-sans-first:18.04 14:36:22 INFO - PROCESS | 26273 | Values: 85.0 86.0 110.0 86.0 86.0 86.0 119.0 85.0 91.0 133.0 14:36:22 INFO - PROCESS | 26273 | 14:36:22 INFO - PROCESS | 26273 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 14:36:22 INFO - PROCESS | 26273 | Values: 116.0 116.0 116.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 14:36:22 INFO - PROCESS | 26273 | 14:36:22 INFO - PROCESS | 26273 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:1.03 (0.7%) stddev-sans-first:1.05 14:36:22 INFO - PROCESS | 26273 | Values: 145.0 147.0 145.0 145.0 146.0 146.0 145.0 145.0 146.0 148.0 14:36:22 INFO - PROCESS | 26273 | 14:36:22 INFO - PROCESS | 26273 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 14:36:22 INFO - PROCESS | 26273 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 14:36:22 INFO - PROCESS | 26273 | 14:36:22 INFO - PROCESS | 26273 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:1.34 (2.4%) stddev-sans-first:1.39 14:36:22 INFO - PROCESS | 26273 | Values: 54.0 55.0 55.0 54.0 55.0 54.0 54.0 55.0 58.0 53.0 14:36:22 INFO - PROCESS | 26273 | 14:36:22 INFO - PROCESS | 26273 | [#9] json-stringify-tinderbox Cycles:10 Average:62.40 Median:62.00 stddev:0.97 (1.6%) stddev-sans-first:0.88 14:36:22 INFO - PROCESS | 26273 | Values: 61.0 62.0 62.0 62.0 62.0 63.0 62.0 62.0 64.0 64.0 14:36:22 INFO - PROCESS | 26273 | 14:36:22 INFO - PROCESS | 26273 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:80.00 stddev:9.77 (12.2%) stddev-sans-first:10.25 14:36:22 INFO - PROCESS | 26273 | Values: 80.0 85.0 79.0 80.0 80.0 80.0 80.0 87.0 111.0 80.0 14:36:22 INFO - PROCESS | 26273 | 14:36:22 INFO - PROCESS | 26273 | [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:123.50 stddev:9.65 (7.8%) stddev-sans-first:7.95 14:36:22 INFO - PROCESS | 26273 | Values: 144.0 124.0 132.0 119.0 122.0 120.0 118.0 122.0 143.0 123.0 14:36:22 INFO - PROCESS | 26273 | 14:36:22 INFO - PROCESS | 26273 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.10 Median:161.00 stddev:2.56 (1.6%) stddev-sans-first:2.68 14:36:22 INFO - PROCESS | 26273 | Values: 160.0 158.0 162.0 163.0 160.0 164.0 166.0 159.0 160.0 159.0 14:36:22 INFO - PROCESS | 26273 | 14:36:22 INFO - PROCESS | 26273 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:65.00 stddev:2.07 (3.2%) stddev-sans-first:2.19 14:36:22 INFO - PROCESS | 26273 | Values: 65.0 65.0 66.0 65.0 62.0 66.0 68.0 64.0 63.0 61.0 14:36:22 INFO - PROCESS | 26273 | -------- Summary: end -------- 14:36:22 INFO - PROCESS | 26273 | 14:36:23 INFO - TEST-INFO | 26273: exit 0 14:36:23 INFO - TEST-OK | kraken | took 61746ms 14:36:23 INFO - SUITE-END | took 1176s 14:36:23 INFO - Completed test suite (00:19:36) 14:36:23 INFO - javascript benchmark 14:36:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3130.467820470521, 3133.15404840693, 3160.4785210440273, 3166.4775312073507, 3198.5681932939046, 5354.491323324288, 5384.515393614579, 5396.865078373033, 5469.726513674315, 5511.283533140686, 5351.304330437038, 5408.594355423339, 5408.783648654049, 5416.997855396754, 5443.564514838813, 4823.807047718087, 4845.0, 4878.0975519529, 4887.877803054935, 5019.447860735316, 4934.876628084291, 4972.477889821571, 4983.327250821148, 4996.625253106014, 5039.168537191359, 4787.425508938914, 4796.472388037313, 4802.087603355369, 4839.177339852234, 4863.294822250771, 4768.642351823627, 4797.496262892381, 4802.18362878308, 4858.878528036792, 4904.950950490485, 4840.927386089212, 4846.709197448129, 4853.927191092136, 4864.416270047582, 4873.439554451248, 5199.376074871039, 5229.869253268661, 5243.711595862226, 5252.947470525284, 5316.3620365556, 5606.719664016824, 5621.690807005613, 5640.943590564124, 5659.886802263973, 5679.119736440858, 5642.069058605366, 5665.801696940628, 5692.146178073281, 5701.6864072476, 5713.685747283897, 5342.946570534284, 5396.838094857121, 5403.729813509309, 5423.538999185034, 5481.890362192734, 5973.432523910222, 5974.761009559569, 5980.760769569169, 5983.640981541122, 5984.072468767348, 5573.69344686038, 5625.212470254168, 5732.971335143381, 5736.512396446349, 5738.856528586735, 5750.993576124161, 5802.0426629605645, 5802.042662960649, 5806.5645076618575, 5862.736176872051, 5753.482186603226, 5772.797952071657, 5774.105013722879, 5776.624519406225, 5777.7977770777825, 5634.492895639412, 5690.7439165237665, 5720.942790572041, 5770.5095066919785, 5785.50823180026, 4378.846740364072, 4398.054418300081, 4405.515393306734, 4445.488768791631, 4448.177087238806, 3909.667678247381, 3934.1738234970976, 3942.64516193544, 3959.821808018646, 3971.285168669667, 5334.119870221448, 5339.0, 5372.677639341652, 5405.297311349499, 5414.593905457106, 5800.854978625483, 5813.79651712188, 5837.503812175928, 5852.531797456193, 5859.853503662357, 5423.159410291411, 5429.484199001088, 5436.6737995719595, 5438.211459338374, 5477.808276710296, 4823.975880120577, 4889.853304400874, 4913.31213630092, 4929.7781599828095, 4990.80036798524, 6018.879622407615, 6025.517958563392, 6026.096085587197, 6027.065804800263, 6034.275886893601, 5816.534677225727, 5824.242848429677, 5824.854378640568, 5827.4172582741385, 5833.066709326487, 5840.0, 5902.4097590240635, 5966.76132954677, 5970.104484327386, 6002.249718785152, 5617.269754931833, 5650.23721797552, 5666.093425051972, 5668.093105103164, 5673.0, 5658.009848276617, 5777.3356064051495, 5785.623934444247, 5788.479036886701, 5790.913136303043, 5607.2149899014985, 5629.662220266797, 5662.603617746719, 5662.603617746719, 5694.1458781183155, 5590.944090559043, 5636.689982051026, 5636.802711905064, 5637.605367624391, 5640.182173584725, 5398.433164517826, 5493.6978466183145, 5545.029619816435, 5552.222688823487, 5558.138488534284, 5647.774089036392, 5720.713964301852, 5740.942590574041, 5747.396523364986, 5754.251947246831, 5510.504054635102, 5547.916781248366, 5555.944440555542, 5564.860878478071, 5573.164025396223], "value": 5307.028053566379, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.7535635033286, 622.7446746833798, 625.0717684238906, 625.1279465146124, 631.3370960491486, 32632.347353052955, 41056.0, 42245.36631950523, 42295.78852105739, 42331.153376932445, 43017.35473967893, 43291.78354108233, 43353.566464335345, 43409.34885976713, 43473.52211823047, 8001.559914204717, 8868.334874884393, 9046.185843274105, 9050.637974481013, 9069.909300906973, 8248.13394593568, 8551.102134275905, 8554.401191916568, 8566.357523185754, 10519.894801051969, 10593.0, 11121.72195695106, 11126.332420054823, 11136.777264454706, 11144.721381965435, 11017.338959662406, 11075.556977720882, 11093.611723589716, 11094.667159985132, 11101.888981110167, 8201.056878458994, 10375.377477351383, 10693.091087257593, 10757.193210509166, 10932.453377331101, 42557.36163957543, 43277.56722432767, 43403.78298108489, 43600.78199608982, 43723.125537489075, 3264.249222678797, 3439.7592168548213, 3482.460218666111, 3586.3544561978833, 3663.780173189617, 32415.837920810245, 32841.83579082089, 32906.0, 33358.6664133358, 33505.6649433505, 4440.822367105312, 4498.550144985508, 4501.144782491349, 4526.6831321807485, 4745.145873742725, 248489.0, 248912.0, 248930.0, 249619.9999999982, 249985.0, 58115.70942145262, 58784.0, 58829.0, 58834.70582647059, 58843.705781471675, 61843.381566183765, 61984.380156198764, 62204.0, 62270.377296227365, 62521.0, 15551.922240388725, 16095.0, 16113.0, 16125.0, 16136.75794863078, 12323.198992065487, 12381.257124572554, 12422.689432764253, 12425.751484970431, 12426.813597796041, 16735.665286694442, 17119.400820971205, 17313.480595582154, 17349.2192851322, 17383.82616173822, 6325.936740632535, 6326.228655976334, 6389.9680501597195, 6393.584417012879, 6483.773067942694, 899.4917871402637, 1042.452712326035, 1061.766411389493, 1085.1915323084352, 1118.970547096673, 32484.35031299408, 32756.0, 32958.3408331832, 32978.67021329804, 33288.83355583207, 1087.3638921231168, 1099.706379393721, 1114.6711720042445, 1138.0497284767146, 1160.0371691496039, 16647.419649954278, 17231.31074757021, 17488.475345739647, 17495.30018799234, 17510.0, 499281.0, 505611.0, 505655.0, 507059.0, 507205.0, 51019.23471147936, 51028.74485627548, 51117.23324150141, 51128.23307650388, 51129.74435127801, 1264.4562837979756, 1358.701085761131, 1398.6433459467771, 1405.6275087101926, 1419.2052450627682, 32544.51183232206, 33421.05000847228, 33484.83257583697, 33619.0, 34324.313513730085, 49648.0, 49995.0, 50054.49945500498, 50171.24743128783, 50195.74902125466, 409522.0, 412132.0, 412356.0, 412653.0, 413207.0, 32709.672903270664, 41247.0, 42027.36958945679, 45317.0, 46366.30450543312, 47945.0, 48297.75851120862, 48640.2703959448, 48986.51013489819, 49124.0, 40396.0, 40810.38784418296, 41420.58579414288, 42117.57882421136, 42720.35919461148, 42080.36879446872, 42298.36552451777, 42714.0, 42907.0, 43272.56727432685, 41924.790376049146, 42453.0, 42676.78661606672, 43276.0, 43664.56335436605, 36737.632623673424, 37439.6256037447, 38083.0, 38092.2381552373, 38421.807890960365, 28413.289667758472, 28884.0, 28889.0, 29083.563746543394, 29186.56220156657], "value": 20343.105356840693, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.7232506432835, 384.40801166204045, 393.4648877526564, 402.19962275072606, 422.2631508018508, 14232.146071235733, 16583.751243731353, 18190.545236369097, 19907.900460497694, 19908.004599770007, 15102.244887755596, 15541.689166216669, 17424.3030278789, 18659.067046647648, 18741.718874216862, 5408.2428460015535, 5532.446755324456, 5738.31140263169, 5818.243628328311, 5819.33077696064, 5726.942730572682, 5746.626469279484, 5766.509846663039, 5770.913436298459, 5780.132980053005, 4115.979420102895, 6017.669028203447, 6322.557420980534, 6334.493240540745, 6428.035794630796, 6195.721192546302, 6380.0748891410485, 6382.872342553146, 6391.296957334713, 6467.83830404239, 5663.292088488939, 5674.801381951653, 5709.143628455765, 5711.457411545896, 5711.942880571182, 22380.328590142322, 22757.203497877494, 23162.420939476648, 23599.29202123922, 23677.644835327483, 2351.3651314145254, 2365.2549446924336, 2386.7971222446113, 2432.622943443769, 2811.931466042911, 12891.935540322238, 13761.724765504734, 13985.370658320298, 14129.434822607083, 14867.628309292246, 1913.7416448779377, 1943.2712732725229, 2010.577778666482, 2011.3463124484601, 2058.5985732782115, 82575.9999999994, 83097.0, 83666.58166709189, 84468.0, 84519.5774021126, 10429.061384475282, 10541.84187237192, 10648.627298044532, 10695.251332406657, 10838.78322433547, 14869.330880110421, 15057.623559411102, 15064.849351506344, 15076.095434273979, 15085.698286034218, 6817.829554261183, 7000.299970002959, 7963.761087167394, 8125.9187408126345, 8350.749477515685, 7945.245201705829, 8010.919890801134, 8049.557274349967, 8130.878036829452, 8177.0, 6623.20521537409, 6639.86720265592, 6654.600723956578, 6749.122614060239, 6777.0, 1820.8907465552109, 1845.7323688065424, 1952.6485232658258, 1952.9121189546504, 1970.1134489479791, 915.9542022898828, 981.4160574458186, 1007.2797949466167, 1045.9372437653765, 1113.465536542448, 18907.621847562972, 19675.60648787016, 19731.40805775829, 19812.801871981384, 20027.799722002594, 986.8815742110993, 1002.834532302162, 1029.6910926721953, 1031.3502493429091, 1036.657902892044, 10479.738006549896, 11306.660800176009, 11392.715182120513, 11450.885491145149, 11484.0, 470468.0, 482132.0, 482241.0, 487813.3655990326, 491122.0, 80180.0, 81535.0, 81929.59035204786, 82428.0, 82473.58763206146, 978.6574698855344, 990.1830989433746, 1005.7183988483237, 1006.7483129217695, 1037.3775734559204, 17375.82624173742, 17404.0, 17462.388816391365, 17586.29654813844, 17626.383076592258, 28343.433131336846, 41032.384514231715, 41562.58437415587, 42099.0, 42133.78933105315, 44409.33385999148, 48376.0, 51998.0, 53009.0, 56306.43693563012, 8254.752357429286, 8455.704050358208, 8703.216710496086, 8909.287257019552, 8925.0, 9656.855147172657, 12738.936305318413, 12836.0, 13428.462861485432, 13809.930950345184, 11955.820662690241, 12108.455119519467, 12191.878081219074, 12316.445759940645, 12377.876221237673, 11762.470688818852, 11938.462769175234, 12021.579244726743, 12184.329861857683, 12283.938580307042, 11807.645770626896, 11983.400829958642, 12413.31726755001, 12543.059270554928, 12664.0, 7401.481896267425, 7668.1181664109345, 8690.304775618062, 8819.206271435602, 8999.245147196234, 11772.17594768358, 11833.171677982458, 12068.51725930988, 12173.756524869275, 12354.938225308815], "value": 9337.169673501547, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1332.7746852616679, 1468.7796830475431, 1478.0762023735165, 1582.8179759327681, 1719.191979769508, 8354.456960297577, 8750.562471876405, 8759.781005474866, 9020.278377729783, 9026.142516460926, 8865.157810008039, 9052.95473522633, 9063.456192628448, 9065.909340906588, 9066.274698024159, 2071.8031786980214, 2283.303592404316, 2300.022490441564, 2326.4416540030356, 2376.4771750215014, 2352.0591763294647, 2359.3511784259294, 2362.681038059866, 2362.988185059081, 2366.301940927422, 2336.6845475860796, 2344.847584906984, 2365.2312998275543, 2365.5741966446035, 2368.111958015744, 1991.2234228650766, 2217.733871935378, 2283.44055706353, 2297.7702229777055, 2297.873616951067, 2285.1430713482446, 2299.7470278269375, 2320.3039088273617, 2320.47789247418, 2320.501092265154, 8997.730068097968, 9087.863682044775, 9092.590833412512, 9095.090490950919, 9112.8633070504, 4991.600671946236, 5059.74701264939, 5062.569681577033, 5121.564667003309, 5124.103281925648, 3292.654271301503, 3412.692857642824, 3478.8608455661742, 3489.4242449995722, 3490.89527314181, 1150.7468356961456, 1154.3535620052796, 1172.6540670502222, 1206.3304865799478, 1222.2971791220084, 12557.434915428828, 12573.497060117585, 12583.748325033539, 12584.993200544026, 12585.874141258562, 4605.148047611136, 4660.277656963176, 4764.523547645208, 4785.712857228577, 4848.781804818792, 10476.63331783384, 10523.84214236787, 10525.947370263253, 10532.262741608167, 10536.683899483029, 5347.973260133675, 5350.250964864844, 5353.7590808413715, 5356.598255130881, 5359.356877174686, 4357.520672726061, 4799.424069111729, 4938.08645400602, 4939.703617782944, 5023.623228257895, 3919.9216015679526, 3976.9602303977167, 4052.756834589934, 4094.6928980326593, 4180.790960452026, 1273.5924504158581, 1296.935153242353, 1302.3748600671731, 1318.2947123288993, 1318.63737472194, 883.4037025008093, 924.366808736018, 931.7065124485765, 935.9377106983486, 945.7115579748242, 5791.7683292667825, 5794.565407594448, 5952.166696662471, 5958.582899197101, 6039.607425517327, 444.9065696203769, 455.97720113994166, 458.98623041308815, 466.8179410030091, 469.4390203706606, 4013.9598604013586, 4019.256437559061, 4079.8980025499004, 4084.14233011071, 4172.624463798273, 10606.734831629272, 11262.099032077414, 11339.773204536028, 11373.488193031333, 11408.828867566994, 10911.127109831194, 11152.386618736047, 11273.492692828842, 11295.548178072784, 11321.943390282995, 8329.08380078191, 8389.45468544555, 8391.454555453876, 8414.453060551044, 8458.703945362005, 5889.175515427929, 5910.0, 5940.079287710412, 5963.880722385615, 6190.288116866618, 9611.663591774255, 10360.637377691744, 10454.059134677915, 10576.312539684895, 10578.312409693346, 10483.108935740242, 10556.366618002945, 10611.89388106109, 10692.786144277226, 10716.08913242352, 7170.462215333767, 7386.15059268191, 7388.6675099621725, 7795.142534321333, 7852.0, 8237.135100814328, 8461.703840365804, 8699.56502174876, 8708.998465176332, 8815.515146666994, 7615.619219039137, 7752.65113069902, 7834.373250139861, 7855.646495907812, 7941.642626081955, 7585.165631780389, 7714.845703085794, 7756.767296981099, 7885.29032387088, 7928.365730741642, 6602.966985165235, 6639.136912201383, 6666.0, 6671.83320416974, 6674.866502669823, 4967.850964471072, 5155.458676838878, 5165.096108181128, 5185.896282074413, 5300.1519756838725, 5224.1641337387355, 5266.683998960075, 5287.339082614673, 5293.232481290268, 5370.382406023357], "value": 4579.914013615733, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.05153734550504, 332.96448046575154, 338.8952016426449, 341.8376271271148, 343.6786604524771, 5396.703181325026, 5434.184872269162, 5445.83662490125, 5452.0, 5459.454054594538, 5257.474252574741, 5286.365636123661, 5319.281896943911, 5334.146536554152, 5378.596605254602, 3920.3733498556035, 4071.5114186297687, 4129.772862492562, 4130.8554200602985, 4135.875923722293, 4045.9595404045876, 4136.607022332873, 4147.4815648044, 4152.190322887038, 4201.684873634475, 4074.9185016299803, 4102.507699076115, 4128.62842344189, 4138.151678905817, 4147.9585204148025, 3971.801409929521, 4071.389291606253, 4137.110521237933, 4156.06488540076, 4167.5207351154395, 3692.907677308062, 3698.7965661888584, 3708.369577171887, 3710.4619830124752, 3725.2735716535285, 5191.480851914778, 5193.350831146106, 5197.636165468419, 5244.187150991603, 5262.421133675331, 4669.6731228814, 4716.221823399135, 4752.714837109785, 4774.928376074362, 4807.78364973577, 5528.253685752412, 5559.082751346064, 5572.331320241557, 5573.164025396182, 5583.106702927553, 4007.0, 4062.1672557125717, 4071.2671719090554, 4075.2257071156682, 4099.795010249505, 5625.915611265835, 5734.799282025151, 5742.282214723118, 5771.672515321499, 5889.734961926723, 4187.97906010468, 4192.28731115705, 4207.137536804948, 4218.894527636834, 4249.107687385684, 4260.914781704349, 4276.422682937764, 4282.0, 4283.571642835692, 4288.506821715543, 4610.677252592286, 4772.976135119302, 4800.495947925418, 4813.422389313305, 4851.660383773102, 5545.918545883595, 5587.217789509472, 5616.293246457319, 5622.493975542221, 5635.154726790932, 1452.6005348529027, 1466.7726502392147, 1471.1687896338535, 1478.874295684879, 1480.851914808532, 912.8630705394244, 926.3006430145332, 967.9274054445945, 968.6125549780004, 980.9215262778961, 5287.391949925808, 5371.838844834661, 5387.141436204503, 5402.541313845319, 5432.837014889559, 5716.342620598602, 5732.713364331767, 5753.165790960287, 5771.422857714195, 5800.796972105956, 5210.374755029421, 5300.496452836975, 5348.331458567679, 5374.596905232123, 5422.457754224546, 3043.315254067817, 3076.2616971927023, 3088.7992280502144, 3091.8608662610236, 3098.070578826343, 5932.436418540232, 5985.760569577168, 5988.820335389945, 5989.460948514655, 6038.365971573009, 5551.8341148359295, 5878.825434265535, 5908.4091590841435, 5912.970435147797, 5964.373740757244, 5996.910046349309, 6035.396460354017, 6039.305479869696, 6044.637321760709, 6059.757609695651, 5601.551875849841, 5739.454751798572, 5794.565407594531, 5827.70861456917, 5831.591788574759, 5658.490735833795, 5692.117721753135, 5741.167530708108, 5749.476388756899, 5752.6836024019085, 5902.1736956826935, 5958.374370691015, 5994.460498555151, 6010.54920880927, 6020.488258497901, 4056.411820286101, 4076.612721791425, 4092.2838503262406, 4102.835886564504, 4111.177764447063, 5765.538756899522, 5843.678597677169, 5859.5019423349495, 5904.143899134688, 5918.970405147947, 5585.609007369445, 5671.234383358359, 5795.291013751118, 5797.072468405035, 5806.535477161732, 5578.386377498553, 5586.273784408001, 5587.580931430078, 5620.718964051699, 5663.8867222656145, 5319.946800531945, 5539.7230138492105, 5547.944520554743, 5578.553715702815, 5578.972105139611, 5456.0, 5606.635568688022, 5627.409122042291, 5636.633618814764, 5656.567675899403, 5492.182932861623, 5496.038193316233, 5496.972515137559, 5522.0, 5541.667499950016], "value": 4296.350406429973, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [675.7161991963375, 728.1771598094152, 734.4785202506224, 764.293028948223, 766.9271419215172, 12158.392080395977, 12459.517812162641, 12535.435905384269, 12711.936440317797, 13872.791908121386, 13172.407241674124, 13252.0, 13358.465661373533, 13358.465661373533, 13365.0, 680.4012469027249, 797.1470526536608, 799.7960520067375, 829.340674164038, 836.6736972580699, 806.479820515767, 826.3595713322163, 826.7478419082178, 827.0365024746194, 827.0571548434789, 873.0789017586476, 879.7668617816283, 880.2034159086037, 880.5553195636227, 880.7621942075667, 716.1728203924449, 837.3050368194445, 864.4597126795753, 873.5064688451037, 874.868769684546, 631.1857703562399, 632.8069938668705, 633.7528363938068, 633.9049142628596, 633.9112524246609, 12977.0, 13048.934755326258, 13051.934740326238, 13067.86932130676, 13077.673058173526, 12201.328926909016, 12535.122541422104, 12625.558105466265, 12741.554045608453, 13022.153560018663, 9853.261005424622, 9914.40513569188, 9987.250956178243, 10290.176785857187, 10760.515776789985, 4279.7218180818145, 4367.737935723835, 4380.934285985712, 4475.731456112644, 4509.571590698878, 75903.24096759017, 76038.99999999945, 77322.0, 77470.61264693696, 77730.61134694346, 10040.096391324816, 10079.949600251952, 10197.592096316064, 10399.270991194482, 10460.163186945027, 19196.328128515714, 19200.0, 19241.90379048096, 19251.4224573263, 19285.807141928402, 7658.540487570764, 7662.233776622294, 7698.769036928901, 7777.883331750028, 7940.761777146695, 4226.915461690749, 4275.102228532043, 4278.657707383401, 4299.002890967084, 4432.357308190359, 3109.8445077746474, 3178.523221516745, 3179.380020895949, 3197.328561002216, 3201.711845933877, 540.8891177308642, 627.9309275979639, 643.8261669349249, 667.576089183372, 675.1864003875417, 647.9319671434525, 671.8421171024805, 701.3512500936613, 704.3731079339392, 713.3971793834202, 9443.622255109856, 9517.143457088896, 9575.712728618153, 9621.855672164924, 9670.661526846527, 581.8050952930815, 615.8460384903774, 695.4540685561809, 721.3039416962656, 740.7222291640635, 4235.216484950294, 4499.505054444008, 4526.185286648435, 4541.591256786905, 4642.65180111493, 127889.36055319663, 128272.0, 129137.3543132297, 129947.0, 130331.0, 106177.0, 106594.46702766592, 107081.0, 107892.0, 110527.0, 75459.0, 77745.0, 80465.0, 94650.0, 95110.0, 9349.205317548085, 9657.517124143624, 9869.753256168653, 10006.799864002534, 10012.249081319076, 49441.50558494369, 49724.50275497199, 50407.747961259956, 50783.74608126936, 50872.23691644702, 71133.0, 71296.64351678209, 72539.63730181316, 73363.0, 76828.6158569226, 11661.6501504955, 12109.455074521844, 12501.562445314734, 12586.18189817659, 13106.672333191747, 13409.128406653535, 13728.382222799799, 14108.78836817428, 14143.0, 14235.430582776573, 13548.254845983565, 13743.793843092562, 13952.372143253375, 14088.718225635224, 14189.929050354682, 13573.1856088635, 13594.524191653245, 13744.175349479063, 14059.859401406264, 14282.000259981702, 12089.455974481345, 12221.694457638274, 12826.871731282941, 12944.805827912778, 12961.675958101123, 10840.4281379198, 10900.945495272474, 11173.0, 11277.830832537682, 11613.187076904536, 10736.248462607542, 11072.446377680923, 11235.71910702239, 11489.195756296978, 11525.481353339288], "value": 7305.76909270348, "unit": "score"}], "name": "dromaeo_css", "value": 7247.563972931766, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 105.0, 112.0, 110.0, 111.0, 110.0, 108.0, 111.0, 110.0, 109.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 130.0, 134.0, 179.0, 127.0, 126.0, 150.0, 123.0, 193.0, 128.0], "value": 144.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 159.0, 159.0, 161.0, 161.0, 162.0, 160.0, 163.0, 161.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 75.0, 127.0, 77.0, 75.0, 74.0, 76.0, 102.0, 74.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 110.0, 86.0, 86.0, 86.0, 119.0, 85.0, 91.0, 133.0], "value": 96.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 148.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 55.0, 54.0, 55.0, 54.0, 54.0, 55.0, 58.0, 53.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 62.0, 62.0, 63.0, 62.0, 62.0, 64.0, 64.0], "value": 62.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 85.0, 79.0, 80.0, 80.0, 80.0, 80.0, 87.0, 111.0, 80.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 124.0, 132.0, 119.0, 122.0, 120.0, 118.0, 122.0, 143.0, 123.0], "value": 126.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 158.0, 162.0, 163.0, 160.0, 164.0, 166.0, 159.0, 160.0, 159.0], "value": 161.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 65.0, 62.0, 66.0, 68.0, 64.0, 63.0, 61.0], "value": 64.5, "unit": "score"}], "name": "kraken", "value": 1505.1000000000001, "alertThreshold": 2.0}]} 14:36:23 INFO - Return code: 0 14:36:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:36:23 INFO - # TBPL SUCCESS # 14:36:23 INFO - Running post-action listener: _resource_record_post_action 14:36:23 INFO - ##### 14:36:23 INFO - ##### Finished run-tests step (success) 14:36:23 INFO - ##### 14:36:23 INFO - Running post-run listener: _resource_record_post_run 14:36:23 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 12288; Write bytes: 549048320; Read time: 144; Write time: 536024 14:36:23 INFO - TinderboxPrint: CPU usage
13.2% 14:36:23 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 144 14:36:23 INFO - TinderboxPrint: I/O write bytes / time
549,048,320 / 536,024 14:36:23 INFO - TinderboxPrint: CPU idle
8,272.7 (86.8%) 14:36:23 INFO - TinderboxPrint: CPU user
1,208.0 (12.7%) 14:36:23 INFO - TinderboxPrint: Swap in / out
0 / 0 14:36:23 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247943168; Read time: 0; Write time: 314600 14:36:23 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 12288; Write bytes: 293036032; Read time: 144; Write time: 220448 14:36:24 INFO - Running post-run listener: _upload_blobber_files 14:36:24 INFO - Blob upload gear active. 14:36:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:36:24 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 14:36:24 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'] 14:36:24 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 14:36:24 INFO - (blobuploader) - INFO - Open directory for files ... 14:36:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:36:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:36:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:36:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:36:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:36:25 INFO - (blobuploader) - INFO - Done attempting. 14:36:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:36:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:36:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:36:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:36:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:36:26 INFO - (blobuploader) - INFO - Done attempting. 14:36:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:36:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:36:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:36:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:36:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:36:30 INFO - (blobuploader) - INFO - Done attempting. 14:36:30 INFO - (blobuploader) - INFO - Iteration through files over. 14:36:30 INFO - Return code: 0 14:36:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:36:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:36:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f2ba925f1aa74be169e0b536ce5dbe6633711f0e101be087af4116c4fc3014b229f02fc1cefbd017f70958dbd00b861ca52046c2e7a0c913c86eb719dbc02d61", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d06717d92d65466179c127d1424f9442b9a28eab3ba04daf76c1be1438c90bfef64891ff342b7c2f13b4f3e32f1296b2b2d27c89ec8925db63f9dfcc29fb2d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/24787f38f662bbb44e5b600229ca607e6f06911e7b45fe73511b0612c656c791ab9f40bd1ef3ef140f80bce7f606729e24cba2abd1ae66e4d545959368c52627"} 14:36:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:36:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:36:30 INFO - Contents: 14:36:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f2ba925f1aa74be169e0b536ce5dbe6633711f0e101be087af4116c4fc3014b229f02fc1cefbd017f70958dbd00b861ca52046c2e7a0c913c86eb719dbc02d61", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d06717d92d65466179c127d1424f9442b9a28eab3ba04daf76c1be1438c90bfef64891ff342b7c2f13b4f3e32f1296b2b2d27c89ec8925db63f9dfcc29fb2d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/24787f38f662bbb44e5b600229ca607e6f06911e7b45fe73511b0612c656c791ab9f40bd1ef3ef140f80bce7f606729e24cba2abd1ae66e4d545959368c52627"} 14:36:30 INFO - Running post-run listener: copy_logs_to_upload_dir 14:36:30 INFO - Copying logs to upload dir... 14:36:30 INFO - mkdir: /builds/slave/test/build/upload/logs 14:36:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.812198 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-06-15 14:36:30.433196) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-15 14:36:30.436639) ========= 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=652eb03db935cfc1c15ebda0000001ad-1466016538.877295-370225772 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/f2ba925f1aa74be169e0b536ce5dbe6633711f0e101be087af4116c4fc3014b229f02fc1cefbd017f70958dbd00b861ca52046c2e7a0c913c86eb719dbc02d61", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d06717d92d65466179c127d1424f9442b9a28eab3ba04daf76c1be1438c90bfef64891ff342b7c2f13b4f3e32f1296b2b2d27c89ec8925db63f9dfcc29fb2d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/24787f38f662bbb44e5b600229ca607e6f06911e7b45fe73511b0612c656c791ab9f40bd1ef3ef140f80bce7f606729e24cba2abd1ae66e4d545959368c52627"} build_url:https://queue.taskcluster.net/v1/task/L4uwurAJRT-1wAKc-SAy8g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011321 build_url: 'https://queue.taskcluster.net/v1/task/L4uwurAJRT-1wAKc-SAy8g/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/f2ba925f1aa74be169e0b536ce5dbe6633711f0e101be087af4116c4fc3014b229f02fc1cefbd017f70958dbd00b861ca52046c2e7a0c913c86eb719dbc02d61", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d06717d92d65466179c127d1424f9442b9a28eab3ba04daf76c1be1438c90bfef64891ff342b7c2f13b4f3e32f1296b2b2d27c89ec8925db63f9dfcc29fb2d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/24787f38f662bbb44e5b600229ca607e6f06911e7b45fe73511b0612c656c791ab9f40bd1ef3ef140f80bce7f606729e24cba2abd1ae66e4d545959368c52627"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-15 14:36:30.461337) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 14:36:30.461663) ========= 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=652eb03db935cfc1c15ebda0000001ad-1466016538.877295-370225772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004545 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 14:36:30.547331) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-15 14:36:30.547656) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-15 14:36:30.547957) ========= ========= Total master_lag: 0.17 =========