builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-062 starttime: 1466038024.74 results: success (0) buildid: 20160615143006 builduid: c84279e32457496b9dc8dcf171e4ff13 revision: c914e1312fd6cede0da6dcaa1c605eaf07849138 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-15 17:47:04.737469) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-15 17:47:04.737917) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-15 17:47:04.738254) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-15 17:47:04.785094) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 17:47:04.785428) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1466033728.788593-639538985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-15 17:47:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-06-15 17:47:06 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110649 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 17:47:04.921358) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 17:47:04.921680) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1466033728.788593-639538985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020161 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 17:47:04.973598) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 17:47:04.974006) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c914e1312fd6cede0da6dcaa1c605eaf07849138 --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 c914e1312fd6cede0da6dcaa1c605eaf07849138 --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=a4ce256d2ec601f24a60a71e000001bc-1466033728.788593-639538985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-15 17:47:06,733 truncating revision to first 12 chars 2016-06-15 17:47:06,733 Setting DEBUG logging. 2016-06-15 17:47:06,733 attempt 1/10 2016-06-15 17:47:06,733 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c914e1312fd6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-15 17:47:07,140 unpacking tar archive at: fx-team-c914e1312fd6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.742998 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 17:47:05.774102) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-15 17:47:05.774434) ========= script_repo_revision: c914e1312fd6cede0da6dcaa1c605eaf07849138 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-15 17:47:05.774865) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-15 17:47:05.775203) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-15 17:47:05.801329) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 44 secs) (at 2016-06-15 17:47:05.801628) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=a4ce256d2ec601f24a60a71e000001bc-1466033728.788593-639538985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:47:07 INFO - MultiFileLogger online at 20160615 17:47:07 in /builds/slave/test 17:47:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:47:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:47:07 INFO - {'append_to_log': False, 17:47:07 INFO - 'base_work_dir': '/builds/slave/test', 17:47:07 INFO - 'blob_upload_branch': 'Fx-Team', 17:47:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:47:07 INFO - 'branch': 'Fx-Team', 17:47:07 INFO - 'buildbot_json_path': 'buildprops.json', 17:47:07 INFO - 'config_files': ('talos/linux_config.py',), 17:47:07 INFO - 'default_actions': ('clobber', 17:47:07 INFO - 'read-buildbot-config', 17:47:07 INFO - 'download-and-extract', 17:47:07 INFO - 'populate-webroot', 17:47:07 INFO - 'create-virtualenv', 17:47:07 INFO - 'install', 17:47:07 INFO - 'run-tests'), 17:47:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:47:07 INFO - 'download_minidump_stackwalk': True, 17:47:07 INFO - 'download_symbols': 'ondemand', 17:47:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:47:07 INFO - 'tooltool.py': '/tools/tooltool.py', 17:47:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:47:07 INFO - '/tools/misc-python/virtualenv.py')}, 17:47:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:47:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:47:07 INFO - 'installer_path': 'installer.exe', 17:47:07 INFO - 'log_level': 'info', 17:47:07 INFO - 'log_name': 'talos', 17:47:07 INFO - 'log_to_console': True, 17:47:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:47:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:47:07 INFO - 'opt_config_files': (), 17:47:07 INFO - 'pip_index': False, 17:47:07 INFO - 'sps_profile': False, 17:47:07 INFO - 'sps_profile_interval': 0, 17:47:07 INFO - 'suite': 'dromaeojs-e10s', 17:47:07 INFO - 'system_bits': '32', 17:47:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:47:07 INFO - 'title': 'talos-linux64-ix-062', 17:47:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:47:07 INFO - 'use_talos_json': True, 17:47:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:47:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:47:07 INFO - 'work_dir': 'build'} 17:47:07 INFO - ##### 17:47:07 INFO - ##### Running clobber step. 17:47:07 INFO - ##### 17:47:07 INFO - Running pre-action listener: _resource_record_pre_action 17:47:07 INFO - Running main action method: clobber 17:47:07 INFO - rmtree: /builds/slave/test/build 17:47:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:47:08 INFO - Running post-action listener: _resource_record_post_action 17:47:08 INFO - ##### 17:47:08 INFO - ##### Finished clobber step (success) 17:47:08 INFO - ##### 17:47:08 INFO - ##### 17:47:08 INFO - ##### Running read-buildbot-config step. 17:47:08 INFO - ##### 17:47:08 INFO - Running pre-action listener: _resource_record_pre_action 17:47:08 INFO - Running main action method: read_buildbot_config 17:47:08 INFO - Using buildbot properties: 17:47:08 INFO - { 17:47:08 INFO - "project": "", 17:47:08 INFO - "product": "firefox", 17:47:08 INFO - "script_repo_revision": "production", 17:47:08 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:47:08 INFO - "repository": "", 17:47:08 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 17:47:08 INFO - "buildid": "20160615143006", 17:47:08 INFO - "pgo_build": "True", 17:47:08 INFO - "basedir": "/builds/slave/test", 17:47:08 INFO - "buildnumber": 560, 17:47:08 INFO - "slavename": "talos-linux64-ix-062", 17:47:08 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:47:08 INFO - "platform": "ubuntu64_hw", 17:47:08 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:47:08 INFO - "branch": "fx-team", 17:47:08 INFO - "repo_path": "integration/fx-team", 17:47:08 INFO - "revision": "c914e1312fd6cede0da6dcaa1c605eaf07849138", 17:47:08 INFO - "stage_platform": "linux64-pgo", 17:47:08 INFO - "builduid": "c84279e32457496b9dc8dcf171e4ff13", 17:47:08 INFO - "slavebuilddir": "test" 17:47:08 INFO - } 17:47:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/N868x4RNQuKiKY4ykh02Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 17:47:08 INFO - Running post-action listener: _resource_record_post_action 17:47:08 INFO - ##### 17:47:08 INFO - ##### Finished read-buildbot-config step (success) 17:47:08 INFO - ##### 17:47:08 INFO - ##### 17:47:08 INFO - ##### Running download-and-extract step. 17:47:08 INFO - ##### 17:47:08 INFO - Running pre-action listener: _resource_record_pre_action 17:47:08 INFO - Running main action method: download_and_extract 17:47:08 INFO - mkdir: /builds/slave/test/build/tests 17:47:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:47:08 INFO - https://queue.taskcluster.net/v1/task/N868x4RNQuKiKY4ykh02Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:47:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N868x4RNQuKiKY4ykh02Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:47:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N868x4RNQuKiKY4ykh02Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:47:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N868x4RNQuKiKY4ykh02Gw/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 17:47:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N868x4RNQuKiKY4ykh02Gw/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 17:47:25 INFO - Downloaded 1361 bytes. 17:47:25 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:47:25 INFO - Using the following test package requirements: 17:47:25 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:47:25 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:47:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:47:25 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:47:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:47:25 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:47:25 INFO - u'jsshell-linux-x86_64.zip'], 17:47:25 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:47:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:47:25 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:47:25 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:47:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:47:25 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:47:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:47:25 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:47:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:47:25 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:47:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:47:25 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:47: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')]} 17:47:25 INFO - https://queue.taskcluster.net/v1/task/N868x4RNQuKiKY4ykh02Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:47:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N868x4RNQuKiKY4ykh02Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:47:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N868x4RNQuKiKY4ykh02Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:47:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N868x4RNQuKiKY4ykh02Gw/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 17:47:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N868x4RNQuKiKY4ykh02Gw/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 17:47:33 INFO - Downloaded 24220662 bytes. 17:47:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:47:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:47:34 INFO - Return code: 0 17:47:34 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:47:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:47:34 INFO - https://queue.taskcluster.net/v1/task/N868x4RNQuKiKY4ykh02Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:47:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N868x4RNQuKiKY4ykh02Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:47:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N868x4RNQuKiKY4ykh02Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:47:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N868x4RNQuKiKY4ykh02Gw/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 17:47:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N868x4RNQuKiKY4ykh02Gw/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 17:49:20 INFO - Downloaded 24220662 bytes. 17:49:20 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'] 17:49:20 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 17:49:21 INFO - Return code: 0 17:49: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')]} 17:49:21 INFO - https://queue.taskcluster.net/v1/task/N868x4RNQuKiKY4ykh02Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:49:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N868x4RNQuKiKY4ykh02Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:49:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N868x4RNQuKiKY4ykh02Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:49:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N868x4RNQuKiKY4ykh02Gw/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 17:49:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N868x4RNQuKiKY4ykh02Gw/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 17:49:22 INFO - Downloaded 14405384 bytes. 17:49:22 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'] 17:49:22 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 17:49:23 INFO - Return code: 0 17:49:23 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')]} 17:49:23 INFO - https://queue.taskcluster.net/v1/task/N868x4RNQuKiKY4ykh02Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:49:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N868x4RNQuKiKY4ykh02Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:49:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N868x4RNQuKiKY4ykh02Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:49:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N868x4RNQuKiKY4ykh02Gw/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 17:49:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N868x4RNQuKiKY4ykh02Gw/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 17:49:25 INFO - Downloaded 59367946 bytes. 17:49:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N868x4RNQuKiKY4ykh02Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:49:25 INFO - mkdir: /builds/slave/test/properties 17:49:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:49:25 INFO - Writing to file /builds/slave/test/properties/build_url 17:49:25 INFO - Contents: 17:49:25 INFO - build_url:https://queue.taskcluster.net/v1/task/N868x4RNQuKiKY4ykh02Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:49:28 INFO - Running post-action listener: _resource_record_post_action 17:49:28 INFO - Running post-action listener: set_extra_try_arguments 17:49:28 INFO - ##### 17:49:28 INFO - ##### Finished download-and-extract step (success) 17:49:28 INFO - ##### 17:49:28 INFO - ##### 17:49:28 INFO - ##### Running populate-webroot step. 17:49:28 INFO - ##### 17:49:28 INFO - Running pre-action listener: _resource_record_pre_action 17:49:28 INFO - Running main action method: populate_webroot 17:49:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:49:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:49:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:49:28 INFO - '--tppagecycles', 17:49:28 INFO - '7'], 17:49:28 INFO - 'tests': ['tsvgm']}}, 17:49:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:49:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:49:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:49:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:49:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:49:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:49:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:49:28 INFO - 'talos_options': ['--disable-e10s'], 17:49:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:49:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:49:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:49:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:49:28 INFO - 'talos_options': ['--disable-e10s'], 17:49:28 INFO - 'tests': ['damp', 'tps']}, 17:49:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:49:28 INFO - 'tests': ['damp', 'tps']}, 17:49:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:49:28 INFO - 'tests': ['dromaeo_dom']}, 17:49:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:49:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:49:28 INFO - 'tests': ['basic_compositor_video']}, 17:49:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:49:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:49:28 INFO - 'tests': ['a11yr', 17:49:28 INFO - 'ts_paint', 17:49:28 INFO - 'tpaint', 17:49:28 INFO - 'sessionrestore', 17:49:28 INFO - 'sessionrestore_no_auto_restore', 17:49:28 INFO - 'tabpaint']}, 17:49:28 INFO - 'other-e10s': {'tests': ['a11yr', 17:49:28 INFO - 'ts_paint', 17:49:28 INFO - 'tpaint', 17:49:28 INFO - 'sessionrestore', 17:49:28 INFO - 'sessionrestore_no_auto_restore', 17:49:28 INFO - 'tabpaint']}, 17:49:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:49:28 INFO - 'ts_paint', 17:49:28 INFO - 'tpaint', 17:49:28 INFO - 'sessionrestore', 17:49:28 INFO - 'sessionrestore_no_auto_restore', 17:49:28 INFO - 'tabpaint']}, 17:49:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:49:28 INFO - 'ts_paint', 17:49:28 INFO - 'tpaint', 17:49:28 INFO - 'sessionrestore', 17:49:28 INFO - 'sessionrestore_no_auto_restore', 17:49:28 INFO - 'tabpaint']}, 17:49:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:49:28 INFO - 'tests': ['a11yr', 17:49:28 INFO - 'ts_paint', 17:49:28 INFO - 'tpaint', 17:49:28 INFO - 'sessionrestore', 17:49:28 INFO - 'sessionrestore_no_auto_restore', 17:49:28 INFO - 'tabpaint']}, 17:49:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:49:28 INFO - 'tests': ['a11yr', 17:49:28 INFO - 'ts_paint', 17:49:28 INFO - 'tpaint', 17:49:28 INFO - 'sessionrestore', 17:49:28 INFO - 'sessionrestore_no_auto_restore', 17:49:28 INFO - 'tabpaint']}, 17:49:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:49:28 INFO - 'tests': ['tsvgx', 17:49:28 INFO - 'tsvgr_opacity', 17:49:28 INFO - 'tart', 17:49:28 INFO - 'tscrollx', 17:49:28 INFO - 'cart']}, 17:49:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:49:28 INFO - 'tsvgr_opacity', 17:49:28 INFO - 'tart', 17:49:28 INFO - 'tscrollx', 17:49:28 INFO - 'cart']}, 17:49:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:49:28 INFO - 'talos_options': ['--disable-e10s'], 17:49:28 INFO - 'tests': ['tp5o']}, 17:49:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:49:28 INFO - 'tests': ['tp5o']}, 17:49:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:49:28 INFO - 'talos_options': ['--disable-e10s', 17:49:28 INFO - '--xperf_path', 17:49:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:49:28 INFO - 'tests': ['tp5n']}, 17:49:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:49:28 INFO - 'talos_options': ['--xperf_path', 17:49:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:49:28 INFO - 'tests': ['tp5n']}}, 17:49:28 INFO - 'talos.zip': {'path': '', 17:49:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:49:28 INFO - Running post-action listener: _resource_record_post_action 17:49:28 INFO - ##### 17:49:28 INFO - ##### Finished populate-webroot step (success) 17:49:28 INFO - ##### 17:49:28 INFO - ##### 17:49:28 INFO - ##### Running create-virtualenv step. 17:49:28 INFO - ##### 17:49:28 INFO - Running pre-action listener: _resource_record_pre_action 17:49:28 INFO - Running main action method: create_virtualenv 17:49:28 INFO - Creating virtualenv /builds/slave/test/build/venv 17:49:28 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 17:49:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:49:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:49:28 INFO - Using real prefix '/usr' 17:49:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:49:28 INFO - Installing distribute.............................................................................................................................................................................................done. 17:49:30 INFO - Installing pip.................done. 17:49:30 INFO - Return code: 0 17:49:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:49:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:49:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:30 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 0x7f9107997f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d8a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d5d00>, '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 0x26d6ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d6f60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1466033728.788593-639538985', '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 17:49:30 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 17:49:30 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 17:49:30 INFO - Using env: {'DISPLAY': ':0', 17:49:30 INFO - 'HOME': '/home/cltbld', 17:49:30 INFO - 'LANG': 'en_US.UTF-8', 17:49:30 INFO - 'LANGUAGE': 'en_US:en', 17:49:30 INFO - 'LOGNAME': 'cltbld', 17:49:30 INFO - 'MAIL': '/var/mail/cltbld', 17:49:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:30 INFO - 'MOZ_NO_REMOTE': '1', 17:49:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:30 INFO - 'NO_EM_RESTART': '1', 17:49:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:30 INFO - 'PWD': '/builds/slave/test', 17:49:30 INFO - 'SHELL': '/bin/bash', 17:49:30 INFO - 'SHLVL': '1', 17:49:30 INFO - 'TERM': 'linux', 17:49:30 INFO - 'TMOUT': '86400', 17:49:30 INFO - 'USER': 'cltbld', 17:49:30 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1466033728.788593-639538985', 17:49:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:30 INFO - '_': '/tools/buildbot/bin/python'} 17:49:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:30 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 17:49:30 INFO - Cleaning up... 17:49:31 INFO - Return code: 0 17:49:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:49:31 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')]} 17:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:31 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')]} 17:49:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:31 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 0x7f9107997f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d8a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d5d00>, '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 0x26d6ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d6f60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1466033728.788593-639538985', '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 17:49:31 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 17:49:31 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 17:49:31 INFO - Using env: {'DISPLAY': ':0', 17:49:31 INFO - 'HOME': '/home/cltbld', 17:49:31 INFO - 'LANG': 'en_US.UTF-8', 17:49:31 INFO - 'LANGUAGE': 'en_US:en', 17:49:31 INFO - 'LOGNAME': 'cltbld', 17:49:31 INFO - 'MAIL': '/var/mail/cltbld', 17:49:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:31 INFO - 'MOZ_NO_REMOTE': '1', 17:49:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:31 INFO - 'NO_EM_RESTART': '1', 17:49:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:31 INFO - 'PWD': '/builds/slave/test', 17:49:31 INFO - 'SHELL': '/bin/bash', 17:49:31 INFO - 'SHLVL': '1', 17:49:31 INFO - 'TERM': 'linux', 17:49:31 INFO - 'TMOUT': '86400', 17:49:31 INFO - 'USER': 'cltbld', 17:49:31 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1466033728.788593-639538985', 17:49:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:31 INFO - '_': '/tools/buildbot/bin/python'} 17:49:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:31 INFO - Downloading/unpacking psutil>=3.1.1 17:49:31 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 17:49:31 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 17:49:31 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 17:49:31 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 17:49:31 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 17:49:31 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 17:49:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:49:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:49:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:49:33 INFO - Installing collected packages: psutil 17:49:33 INFO - Running setup.py install for psutil 17:49:33 INFO - building 'psutil._psutil_linux' extension 17:49:33 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 17:49:33 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 17:49:33 INFO - building 'psutil._psutil_posix' extension 17:49:33 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 17:49:33 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 17:49:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:49:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:49:33 INFO - Successfully installed psutil 17:49:33 INFO - Cleaning up... 17:49:33 INFO - Return code: 0 17:49:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:49:33 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')]} 17:49:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:33 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')]} 17:49:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:33 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 0x7f9107997f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d8a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d5d00>, '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 0x26d6ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d6f60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1466033728.788593-639538985', '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 17:49:33 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 17:49:33 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 17:49:33 INFO - Using env: {'DISPLAY': ':0', 17:49:33 INFO - 'HOME': '/home/cltbld', 17:49:33 INFO - 'LANG': 'en_US.UTF-8', 17:49:33 INFO - 'LANGUAGE': 'en_US:en', 17:49:33 INFO - 'LOGNAME': 'cltbld', 17:49:33 INFO - 'MAIL': '/var/mail/cltbld', 17:49:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:33 INFO - 'MOZ_NO_REMOTE': '1', 17:49:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:33 INFO - 'NO_EM_RESTART': '1', 17:49:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:33 INFO - 'PWD': '/builds/slave/test', 17:49:33 INFO - 'SHELL': '/bin/bash', 17:49:33 INFO - 'SHLVL': '1', 17:49:33 INFO - 'TERM': 'linux', 17:49:33 INFO - 'TMOUT': '86400', 17:49:33 INFO - 'USER': 'cltbld', 17:49:33 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1466033728.788593-639538985', 17:49:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:33 INFO - '_': '/tools/buildbot/bin/python'} 17:49:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:49:34 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 17:49:34 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 17:49:34 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 17:49:34 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 17:49:34 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 17:49:34 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 17:49:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:49:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:49:36 INFO - Installing collected packages: mozsystemmonitor 17:49:36 INFO - Running setup.py install for mozsystemmonitor 17:49:36 INFO - Successfully installed mozsystemmonitor 17:49:36 INFO - Cleaning up... 17:49:36 INFO - Return code: 0 17:49:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:49:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:49:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:36 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 0x7f9107997f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d8a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d5d00>, '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 0x26d6ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d6f60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1466033728.788593-639538985', '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 17:49:36 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 17:49:36 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 17:49:36 INFO - Using env: {'DISPLAY': ':0', 17:49:36 INFO - 'HOME': '/home/cltbld', 17:49:36 INFO - 'LANG': 'en_US.UTF-8', 17:49:36 INFO - 'LANGUAGE': 'en_US:en', 17:49:36 INFO - 'LOGNAME': 'cltbld', 17:49:36 INFO - 'MAIL': '/var/mail/cltbld', 17:49:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:36 INFO - 'MOZ_NO_REMOTE': '1', 17:49:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:36 INFO - 'NO_EM_RESTART': '1', 17:49:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:36 INFO - 'PWD': '/builds/slave/test', 17:49:36 INFO - 'SHELL': '/bin/bash', 17:49:36 INFO - 'SHLVL': '1', 17:49:36 INFO - 'TERM': 'linux', 17:49:36 INFO - 'TMOUT': '86400', 17:49:36 INFO - 'USER': 'cltbld', 17:49:36 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1466033728.788593-639538985', 17:49:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:36 INFO - '_': '/tools/buildbot/bin/python'} 17:49:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:36 INFO - Downloading/unpacking jsonschema==2.5.1 17:49:36 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 17:49:36 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 17:49:36 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 17:49:36 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 17:49:36 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 17:49:36 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 17:49:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:49:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:38 INFO - Downloading functools32-3.2.3-2.tar.gz 17:49:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:49:38 INFO - warning: no files found matching '*.txt' 17:49:38 INFO - no previously-included directories found matching 'build' 17:49:38 INFO - no previously-included directories found matching 'dist' 17:49:38 INFO - no previously-included directories found matching '.git*' 17:49:38 INFO - Installing collected packages: jsonschema, functools32 17:49:38 INFO - Running setup.py install for functools32 17:49:38 INFO - warning: no files found matching '*.txt' 17:49:38 INFO - no previously-included directories found matching 'build' 17:49:38 INFO - no previously-included directories found matching 'dist' 17:49:38 INFO - no previously-included directories found matching '.git*' 17:49:38 INFO - Successfully installed jsonschema functools32 17:49:38 INFO - Cleaning up... 17:49:38 INFO - Return code: 0 17:49:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:49:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:49:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9107997f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d8a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d5d00>, '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 0x26d6ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d6f60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1466033728.788593-639538985', '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 17:49:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:49:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:49:38 INFO - Using env: {'DISPLAY': ':0', 17:49:38 INFO - 'HOME': '/home/cltbld', 17:49:38 INFO - 'LANG': 'en_US.UTF-8', 17:49:38 INFO - 'LANGUAGE': 'en_US:en', 17:49:38 INFO - 'LOGNAME': 'cltbld', 17:49:38 INFO - 'MAIL': '/var/mail/cltbld', 17:49:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:38 INFO - 'MOZ_NO_REMOTE': '1', 17:49:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:38 INFO - 'NO_EM_RESTART': '1', 17:49:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:38 INFO - 'PWD': '/builds/slave/test', 17:49:38 INFO - 'SHELL': '/bin/bash', 17:49:38 INFO - 'SHLVL': '1', 17:49:38 INFO - 'TERM': 'linux', 17:49:38 INFO - 'TMOUT': '86400', 17:49:38 INFO - 'USER': 'cltbld', 17:49:38 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1466033728.788593-639538985', 17:49:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:38 INFO - '_': '/tools/buildbot/bin/python'} 17:49:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:38 INFO - Downloading/unpacking blobuploader==1.2.4 17:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:40 INFO - Downloading blobuploader-1.2.4.tar.gz 17:49:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:49:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:49:40 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 17:49:40 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 17:49:40 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 17:49:40 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 17:49:40 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 17:49:40 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 17:49:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:49:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:49:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:41 INFO - Downloading docopt-0.6.1.tar.gz 17:49:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:49:41 INFO - Installing collected packages: blobuploader, requests, docopt 17:49:41 INFO - Running setup.py install for blobuploader 17:49:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:49:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:49:41 INFO - Running setup.py install for requests 17:49:42 INFO - Running setup.py install for docopt 17:49:42 INFO - Successfully installed blobuploader requests docopt 17:49:42 INFO - Cleaning up... 17:49:42 INFO - Return code: 0 17:49:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:49:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:42 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 0x7f9107997f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d8a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d5d00>, '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 0x26d6ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d6f60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1466033728.788593-639538985', '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 17:49:42 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 17:49:42 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 17:49:42 INFO - Using env: {'DISPLAY': ':0', 17:49:42 INFO - 'HOME': '/home/cltbld', 17:49:42 INFO - 'LANG': 'en_US.UTF-8', 17:49:42 INFO - 'LANGUAGE': 'en_US:en', 17:49:42 INFO - 'LOGNAME': 'cltbld', 17:49:42 INFO - 'MAIL': '/var/mail/cltbld', 17:49:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:42 INFO - 'MOZ_NO_REMOTE': '1', 17:49:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:42 INFO - 'NO_EM_RESTART': '1', 17:49:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:42 INFO - 'PWD': '/builds/slave/test', 17:49:42 INFO - 'SHELL': '/bin/bash', 17:49:42 INFO - 'SHLVL': '1', 17:49:42 INFO - 'TERM': 'linux', 17:49:42 INFO - 'TMOUT': '86400', 17:49:42 INFO - 'USER': 'cltbld', 17:49:42 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1466033728.788593-639538985', 17:49:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:42 INFO - '_': '/tools/buildbot/bin/python'} 17:49:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:49:42 INFO - Running setup.py (path:/tmp/pip-IecYd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:49:42 INFO - Running setup.py (path:/tmp/pip-x5kG_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:49:42 INFO - Running setup.py (path:/tmp/pip-he08Lh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:49:42 INFO - Running setup.py (path:/tmp/pip-oasiUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:49:42 INFO - Running setup.py (path:/tmp/pip-Bzhomn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:49:42 INFO - Running setup.py (path:/tmp/pip-dRjJzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:49:42 INFO - Running setup.py (path:/tmp/pip-qvveov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:49:42 INFO - Running setup.py (path:/tmp/pip-D1tdhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:49:43 INFO - Running setup.py (path:/tmp/pip-6WRPNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:49:43 INFO - Running setup.py (path:/tmp/pip-COB6Kw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:49:43 INFO - Running setup.py (path:/tmp/pip-qN6mpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:49:43 INFO - Running setup.py (path:/tmp/pip-C0wDpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:49:43 INFO - Running setup.py (path:/tmp/pip-TycML6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:49:43 INFO - Running setup.py (path:/tmp/pip-5Id9K2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:49:43 INFO - Running setup.py (path:/tmp/pip-vwEnjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:49:43 INFO - Running setup.py (path:/tmp/pip-mS2iH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:49:43 INFO - Running setup.py (path:/tmp/pip-vdcVYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:49:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:49:43 INFO - Running setup.py install for manifestparser 17:49:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:49:43 INFO - Running setup.py install for mozcrash 17:49:43 INFO - Running setup.py install for mozdebug 17:49:43 INFO - Running setup.py install for mozdevice 17:49:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:49:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:49:44 INFO - Running setup.py install for mozfile 17:49:44 INFO - Running setup.py install for mozhttpd 17:49:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:49:44 INFO - Running setup.py install for mozinfo 17:49:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:49:44 INFO - Running setup.py install for mozInstall 17:49:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:49:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:49:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:49:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:49:44 INFO - Running setup.py install for mozleak 17:49:44 INFO - Running setup.py install for mozlog 17:49:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:49:44 INFO - Running setup.py install for moznetwork 17:49:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:49:44 INFO - Running setup.py install for mozprocess 17:49:44 INFO - Running setup.py install for mozprofile 17:49:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:49:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:49:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:49:45 INFO - Running setup.py install for mozrunner 17:49:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:49:45 INFO - Running setup.py install for mozscreenshot 17:49:45 INFO - Running setup.py install for moztest 17:49:45 INFO - Running setup.py install for mozversion 17:49:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:49:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:49:45 INFO - Cleaning up... 17:49:45 INFO - Return code: 0 17:49:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:49:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:49:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:45 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 0x7f9107997f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d8a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d5d00>, '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 0x26d6ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d6f60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1466033728.788593-639538985', '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 17:49:45 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 17:49:45 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 17:49:45 INFO - Using env: {'DISPLAY': ':0', 17:49:45 INFO - 'HOME': '/home/cltbld', 17:49:45 INFO - 'LANG': 'en_US.UTF-8', 17:49:45 INFO - 'LANGUAGE': 'en_US:en', 17:49:45 INFO - 'LOGNAME': 'cltbld', 17:49:45 INFO - 'MAIL': '/var/mail/cltbld', 17:49:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:45 INFO - 'MOZ_NO_REMOTE': '1', 17:49:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:45 INFO - 'NO_EM_RESTART': '1', 17:49:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:45 INFO - 'PWD': '/builds/slave/test', 17:49:45 INFO - 'SHELL': '/bin/bash', 17:49:45 INFO - 'SHLVL': '1', 17:49:45 INFO - 'TERM': 'linux', 17:49:45 INFO - 'TMOUT': '86400', 17:49:45 INFO - 'USER': 'cltbld', 17:49:45 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1466033728.788593-639538985', 17:49:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:45 INFO - '_': '/tools/buildbot/bin/python'} 17:49:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:49:45 INFO - Running setup.py (path:/tmp/pip-_jORIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:49:45 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)) 17:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:49:45 INFO - Running setup.py (path:/tmp/pip-U7ri48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:49:45 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)) 17:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:49:45 INFO - Running setup.py (path:/tmp/pip-FpNgDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:49:45 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)) 17:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:49:45 INFO - Running setup.py (path:/tmp/pip-6C5_Ey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:49:45 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)) 17:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:49:45 INFO - Running setup.py (path:/tmp/pip-na4FEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:49:46 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)) 17:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:49:46 INFO - Running setup.py (path:/tmp/pip-0pJCGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:49:46 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)) 17:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:49:46 INFO - Running setup.py (path:/tmp/pip-QD1nY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:49:46 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)) 17:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:49:46 INFO - Running setup.py (path:/tmp/pip-h1RxlT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:49:46 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)) 17:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:49:46 INFO - Running setup.py (path:/tmp/pip-Bkq29s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:49:46 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)) 17:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:49:46 INFO - Running setup.py (path:/tmp/pip-1aBn8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:49:46 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)) 17:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:49:46 INFO - Running setup.py (path:/tmp/pip-B2GM8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:49:46 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)) 17:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:49:46 INFO - Running setup.py (path:/tmp/pip-VVN1YU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:49:46 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)) 17:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:49:46 INFO - Running setup.py (path:/tmp/pip-Op5N6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:49:46 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)) 17:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:49:46 INFO - Running setup.py (path:/tmp/pip-I21BsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:49:46 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)) 17:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:49:46 INFO - Running setup.py (path:/tmp/pip-jKMM4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:49:46 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)) 17:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:49:46 INFO - Running setup.py (path:/tmp/pip-8GmwZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:49:46 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)) 17:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:49:46 INFO - Running setup.py (path:/tmp/pip-CqWXMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:49:46 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)) 17:49:46 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)) 17:49:46 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)) 17:49:46 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)) 17:49:46 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)) 17:49:46 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)) 17:49:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:48 INFO - Downloading blessings-1.6.tar.gz 17:49:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:49:48 INFO - Installing collected packages: blessings 17:49:48 INFO - Running setup.py install for blessings 17:49:49 INFO - Successfully installed blessings 17:49:49 INFO - Cleaning up... 17:49:49 INFO - Return code: 0 17:49:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:49:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:49:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:49:49 INFO - Reading from file tmpfile_stdout 17:49:49 INFO - Current package versions: 17:49:49 INFO - argparse == 1.2.1 17:49:49 INFO - blessings == 1.6 17:49:49 INFO - blobuploader == 1.2.4 17:49:49 INFO - docopt == 0.6.1 17:49:49 INFO - functools32 == 3.2.3-2 17:49:49 INFO - jsonschema == 2.5.1 17:49:49 INFO - manifestparser == 1.1 17:49:49 INFO - mozInstall == 1.12 17:49:49 INFO - mozcrash == 0.17 17:49:49 INFO - mozdebug == 0.1 17:49:49 INFO - mozdevice == 0.48 17:49:49 INFO - mozfile == 1.2 17:49:49 INFO - mozhttpd == 0.7 17:49:49 INFO - mozinfo == 0.9 17:49:49 INFO - mozleak == 0.1 17:49:49 INFO - mozlog == 3.2 17:49:49 INFO - moznetwork == 0.27 17:49:49 INFO - mozprocess == 0.22 17:49:49 INFO - mozprofile == 0.28 17:49:49 INFO - mozrunner == 6.11 17:49:49 INFO - mozscreenshot == 0.1 17:49:49 INFO - mozsystemmonitor == 0.3 17:49:49 INFO - moztest == 0.7 17:49:49 INFO - mozversion == 1.4 17:49:49 INFO - psutil == 3.1.1 17:49:49 INFO - requests == 1.2.3 17:49:49 INFO - wsgiref == 0.1.2 17:49:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:49:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:49:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:49 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 0x7f9107997f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d8a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d5d00>, '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 0x26d6ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d6f60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1466033728.788593-639538985', '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 17:49:49 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 17:49:49 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 17:49:49 INFO - Using env: {'DISPLAY': ':0', 17:49:49 INFO - 'HOME': '/home/cltbld', 17:49:49 INFO - 'LANG': 'en_US.UTF-8', 17:49:49 INFO - 'LANGUAGE': 'en_US:en', 17:49:49 INFO - 'LOGNAME': 'cltbld', 17:49:49 INFO - 'MAIL': '/var/mail/cltbld', 17:49:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:49 INFO - 'MOZ_NO_REMOTE': '1', 17:49:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:49 INFO - 'NO_EM_RESTART': '1', 17:49:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:49 INFO - 'PWD': '/builds/slave/test', 17:49:49 INFO - 'SHELL': '/bin/bash', 17:49:49 INFO - 'SHLVL': '1', 17:49:49 INFO - 'TERM': 'linux', 17:49:49 INFO - 'TMOUT': '86400', 17:49:49 INFO - 'USER': 'cltbld', 17:49:49 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1466033728.788593-639538985', 17:49:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:49 INFO - '_': '/tools/buildbot/bin/python'} 17:49:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:49 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)) 17:49:49 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)) 17:49:49 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)) 17:49:49 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)) 17:49:49 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)) 17:49:49 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)) 17:49:49 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)) 17:49:49 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)) 17:49:49 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)) 17:49:49 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)) 17:49:49 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)) 17:49:49 INFO - Cleaning up... 17:49:49 INFO - Return code: 0 17:49:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:49:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:49:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9107997f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d8a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d5d00>, '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 0x26d6ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d6f60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1466033728.788593-639538985', '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 17:49:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:49:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:49:49 INFO - Using env: {'DISPLAY': ':0', 17:49:49 INFO - 'HOME': '/home/cltbld', 17:49:49 INFO - 'LANG': 'en_US.UTF-8', 17:49:49 INFO - 'LANGUAGE': 'en_US:en', 17:49:49 INFO - 'LOGNAME': 'cltbld', 17:49:49 INFO - 'MAIL': '/var/mail/cltbld', 17:49:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:49 INFO - 'MOZ_NO_REMOTE': '1', 17:49:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:49 INFO - 'NO_EM_RESTART': '1', 17:49:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:49 INFO - 'PWD': '/builds/slave/test', 17:49:49 INFO - 'SHELL': '/bin/bash', 17:49:49 INFO - 'SHLVL': '1', 17:49:49 INFO - 'TERM': 'linux', 17:49:49 INFO - 'TMOUT': '86400', 17:49:49 INFO - 'USER': 'cltbld', 17:49:49 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1466033728.788593-639538985', 17:49:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:49 INFO - '_': '/tools/buildbot/bin/python'} 17:49:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:49:49 INFO - Cleaning up... 17:49:49 INFO - Return code: 0 17:49:49 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:49:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:49:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9107997f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d8a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d5d00>, '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 0x26d6ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d6f60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1466033728.788593-639538985', '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 17:49:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:49:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:49:49 INFO - Using env: {'DISPLAY': ':0', 17:49:49 INFO - 'HOME': '/home/cltbld', 17:49:49 INFO - 'LANG': 'en_US.UTF-8', 17:49:49 INFO - 'LANGUAGE': 'en_US:en', 17:49:49 INFO - 'LOGNAME': 'cltbld', 17:49:49 INFO - 'MAIL': '/var/mail/cltbld', 17:49:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:49 INFO - 'MOZ_NO_REMOTE': '1', 17:49:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:49 INFO - 'NO_EM_RESTART': '1', 17:49:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:49 INFO - 'PWD': '/builds/slave/test', 17:49:49 INFO - 'SHELL': '/bin/bash', 17:49:49 INFO - 'SHLVL': '1', 17:49:49 INFO - 'TERM': 'linux', 17:49:49 INFO - 'TMOUT': '86400', 17:49:49 INFO - 'USER': 'cltbld', 17:49:49 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1466033728.788593-639538985', 17:49:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:49 INFO - '_': '/tools/buildbot/bin/python'} 17:49:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:49 INFO - Downloading/unpacking flake8 17:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:49:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:49:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:49:52 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 17:49:52 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 17:49:52 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 17:49:52 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 17:49:52 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 17:49:52 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 17:49:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:49:52 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 17:49:52 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 17:49:52 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 17:49:52 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 17:49:52 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 17:49:52 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 17:49:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:49:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:49:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:49:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:49:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:49:52 INFO - no previously-included directories found matching 'docs/_build' 17:49:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:49:52 INFO - Running setup.py install for pep8 17:49:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:49:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:49:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:49:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:49:52 INFO - no previously-included directories found matching 'docs/_build' 17:49:52 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:49:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:49:52 INFO - Cleaning up... 17:49:53 INFO - Return code: 0 17:49:53 INFO - Running post-action listener: _resource_record_post_action 17:49:53 INFO - Running post-action listener: _start_resource_monitoring 17:49:53 INFO - Starting resource monitoring. 17:49:53 INFO - ##### 17:49:53 INFO - ##### Finished create-virtualenv step (success) 17:49:53 INFO - ##### 17:49:53 INFO - ##### 17:49:53 INFO - ##### Running install step. 17:49:53 INFO - ##### 17:49:53 INFO - Running pre-action listener: _resource_record_pre_action 17:49:53 INFO - Running main action method: install 17:49:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:49:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:49:53 INFO - Reading from file tmpfile_stdout 17:49:53 INFO - Detecting whether we're running mozinstall >=1.0... 17:49:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:49:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:49:53 INFO - Reading from file tmpfile_stdout 17:49:53 INFO - Output received: 17:49:53 INFO - Usage: mozinstall [options] installer 17:49:53 INFO - Options: 17:49:53 INFO - -h, --help show this help message and exit 17:49:53 INFO - -d DEST, --destination=DEST 17:49:53 INFO - Directory to install application into. [default: 17:49:53 INFO - "/builds/slave/test"] 17:49:53 INFO - --app=APP Application being installed. [default: firefox] 17:49:53 INFO - mkdir: /builds/slave/test/build/application 17:49:53 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'] 17:49:53 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 17:50:10 INFO - Reading from file tmpfile_stdout 17:50:10 INFO - Output received: 17:50:10 INFO - /builds/slave/test/build/application/firefox/firefox 17:50:10 INFO - Running post-action listener: _resource_record_post_action 17:50:10 INFO - ##### 17:50:10 INFO - ##### Finished install step (success) 17:50:10 INFO - ##### 17:50:10 INFO - ##### 17:50:10 INFO - ##### Running run-tests step. 17:50:10 INFO - ##### 17:50:10 INFO - Running pre-action listener: _resource_record_pre_action 17:50:10 INFO - Running main action method: run_tests 17:50:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:50:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:50:10 INFO - Python 2.7.3 17:50:10 INFO - Return code: 0 17:50:10 INFO - grabbing minidump binary from tooltool 17:50: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')]} 17:50:10 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 0x26d5d00>, '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 0x26d6ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d6f60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:50:10 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 17:50:10 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 17:50:10 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 17:50:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:50:10 INFO - Return code: 0 17:50:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:50:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:50:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:50:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:50:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:50:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:50:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:50:11 INFO - Return code: 0 17:50:11 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N868x4RNQuKiKY4ykh02Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:50:11 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/N868x4RNQuKiKY4ykh02Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:50:11 INFO - Using env: {'DISPLAY': ':0', 17:50:11 INFO - 'HOME': '/home/cltbld', 17:50:11 INFO - 'LANG': 'en_US.UTF-8', 17:50:11 INFO - 'LANGUAGE': 'en_US:en', 17:50:11 INFO - 'LOGNAME': 'cltbld', 17:50:11 INFO - 'MAIL': '/var/mail/cltbld', 17:50:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:50:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:50:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:11 INFO - 'MOZ_NO_REMOTE': '1', 17:50:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:50:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:50:11 INFO - 'NO_EM_RESTART': '1', 17:50:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:50:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:11 INFO - 'PWD': '/builds/slave/test', 17:50:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:50:11 INFO - 'SHELL': '/bin/bash', 17:50:11 INFO - 'SHLVL': '1', 17:50:11 INFO - 'TERM': 'linux', 17:50:11 INFO - 'TMOUT': '86400', 17:50:11 INFO - 'USER': 'cltbld', 17:50:11 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1466033728.788593-639538985', 17:50:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:11 INFO - '_': '/tools/buildbot/bin/python'} 17:50:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N868x4RNQuKiKY4ykh02Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:50:12 INFO - mozversion application_buildid: 20160615143006 17:50:12 INFO - mozversion application_changeset: c914e1312fd6cede0da6dcaa1c605eaf07849138 17:50:12 INFO - mozversion application_display_name: Nightly 17:50:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:50:12 INFO - mozversion application_name: Firefox 17:50:12 INFO - mozversion application_remotingname: firefox 17:50:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:50:12 INFO - mozversion application_vendor: Mozilla 17:50:12 INFO - mozversion application_version: 50.0a1 17:50:12 INFO - mozversion platform_buildid: 20160615143006 17:50:12 INFO - mozversion platform_changeset: c914e1312fd6cede0da6dcaa1c605eaf07849138 17:50:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:50:12 INFO - mozversion platform_version: 50.0a1 17:50:12 INFO - using testdate: 1466038212 17:50:12 INFO - actual date: 1466038212 17:50:12 INFO - starting webserver on 'localhost:57906' 17:50:12 INFO - SUITE-START | Running 2 tests 17:50:12 INFO - TEST-START | dromaeo_css 17:50:12 INFO - operating with platform_type : linux_ 17:50:12 INFO - Initialising browser for dromaeo_css test... 17:50:12 INFO - TEST-INFO | started process 12163 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRCLrRd/profile http://localhost:57906/getInfo.html) 17:50:16 INFO - PROCESS | 12163 | __metrics Screen width/height:1600/1200 17:50:16 INFO - PROCESS | 12163 | colorDepth:24 17:50:16 INFO - PROCESS | 12163 | Browser inner width/height: 1024/697 17:50:16 INFO - PROCESS | 12163 | __metrics 17:50:17 ERROR - PROCESS | 12163 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 17:50:17 INFO - TEST-INFO | 12163: exit 0 17:50:17 INFO - Browser initialized. 17:50:17 INFO - Running cycle 1/1 for dromaeo_css test... 17:50:18 INFO - TEST-INFO | started process 12281 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRCLrRd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:50:30 INFO - PROCESS | 12281 | RSS: Main: 184975360 17:50:30 INFO - PROCESS | 12281 | 17:51:19 INFO - PROCESS | 12281 | 1466038279630 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] 17:53:27 INFO - PROCESS | 12281 | Cycle 1(1): loaded http://localhost:57906/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57906/tests/dromaeo/cssquery-ext.html) 17:53:28 INFO - PROCESS | 12281 | RSS: Main: 189739008 17:53:28 INFO - PROCESS | 12281 | 17:56:31 INFO - PROCESS | 12281 | Cycle 1(1): loaded http://localhost:57906/tests/dromaeo/cssquery-ext.html (next: http://localhost:57906/tests/dromaeo/cssquery-jquery.html) 17:56:31 INFO - PROCESS | 12281 | RSS: Main: 187240448 17:56:31 INFO - PROCESS | 12281 | 17:59:33 INFO - PROCESS | 12281 | Cycle 1(1): loaded http://localhost:57906/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57906/tests/dromaeo/cssquery-mootools.html) 17:59:34 INFO - PROCESS | 12281 | RSS: Main: 188444672 17:59:34 INFO - PROCESS | 12281 | 18:02:35 INFO - PROCESS | 12281 | Cycle 1(1): loaded http://localhost:57906/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57906/tests/dromaeo/cssquery-prototype.html) 18:02:36 INFO - PROCESS | 12281 | RSS: Main: 185618432 18:02:36 INFO - PROCESS | 12281 | 18:05:38 INFO - PROCESS | 12281 | Cycle 1(1): loaded http://localhost:57906/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57906/tests/dromaeo/cssquery-yui.html) 18:05:39 INFO - PROCESS | 12281 | RSS: Main: 187629568 18:05:39 INFO - PROCESS | 12281 | 18:08:42 INFO - PROCESS | 12281 | Cycle 1(1): loaded http://localhost:57906/tests/dromaeo/cssquery-yui.html (next: http://localhost:57906/tests/dromaeo/cssquery-dojo.html) 18:08:42 INFO - PROCESS | 12281 | RSS: Main: 188891136 18:08:42 INFO - PROCESS | 12281 | 18:08:42 INFO - PROCESS | 12281 | __start_tp_report 18:08:42 INFO - PROCESS | 12281 | _x_x_mozilla_page_load 18:08:42 INFO - PROCESS | 12281 | _x_x_mozilla_page_load_details 18:08:42 INFO - PROCESS | 12281 | |i|pagename|runs| 18:08:42 INFO - PROCESS | 12281 | |0;dojo.html;3054.602901622789;3105.720485156336;3109.95335069974;3148.4490214212506;3153.2432216268103;5319.654222475541;5355.89288214236;5360.169173778066;5452.073147564914;5507.669539827613;5309.787608495655;5455.672659640414;5472.534834539059;5522.972385138069;5525.336959564847;4919.212925931861;4931.3835770528685;4977.800887964477;5085.771140298677;5119.027384796896;4932.8520144395725;5124.846254612349;5165.199394093921;5172.689638621676;5177.585793136559;4823.855284341475;4901.852944411673;4920.975395123037;4994.225894986283;5008.048470790556;4915.459299477055;4921.237208232694;4932.21084626458;4940.5059494050665;5013.398392192924;4870.196417591093;4881.438634557036;4883.389576302962;4884.780184891652;4911.263310503417;5189.403218629868;5364.973175134139;5382.111951527993;5433.809816656438;5467.152591348347;5776.191333213354;5837.007708689533;5854;5862.267216597926;5893.204417403681;5666.433356664342;5926.140709597084;5927.2590926134235;5930.525557955353;5938.6436813791315;5462.562994960394;5492.780288788444;5525.585581081435;5533.08704063829;5571.66570005801;6034.39656034393;6049.818505444844;6054.606450580698;6070.817875463743;6104.3590423005835;5593.161025846156;5746.913796293059;5820.883582328414;5822.621529600562;5846.795362162304;5850.444207800252;5914.792982245601;5924.4667979882015;5934.9406505934385;5966.224390829165;5594.972025139929;5802.6808525531505;5875.236219291465;5875.882482350329;5908.291005079418;5637.210790489335;5845.210896528914;5877.735501902424;5948.078047902495;5964.373740757244;4498.820047198141;4500.302453119772;4500.662450316239;4530.79611417487;4552.952820851223;3968.900777480586;3989.4215338775716;4020;4020.5979402060143;4042.2521833460905;5583.581231407661;5595.38450770415;5597.888042239132;5616.185653080281;5626.774929002876;5857.297124345021;5902.439268269508;5920.348761636216;5924.911126333109;5943.078822782476;5642.181883626933;5643.322801263875;5658.632188907708;5659.858503537444;5681.431856814368;4949.975250123726;5001.299818025479;5005.174146265898;5012.649114561946;5026.095302845523;6014.669193194329;6038.5772995889865;6054.848628784315;6094.146819445193;6096.603720758137;5735.311762588516;5859.150423188699;5866.442687944638;5873.2658417697785;5896.204012458435;6031.185789918481;6053.969730151321;6062.302835174011;6077.544184186292;6091.177691011657;5736.942630573641;5775.566832487496;5776.133579962871;5782.7686892523825;5799.043157879071;5646.661200327993;5720.39935806751;5843.1235314703135;5849.444302791228;5888.823335299948;5552.056150454352;5582.078956972054;5588.189712491747;5617.045102332531;5665.433456654301;5703.116017017369;5712.542996560348;5713.400092990342;5731.025725626737;5780.450857168562;5658.5473162147755;5676.2337084493065;5677.74450149736;5686.57350698691;5698.0598201296325;5659.094544872801;5686.374498805211;5692.231548740867;5761.107028410603;5776.220210271727;5631.63394379364;5645.633033852787;5650.23721797552;5660.462256085665;5678 18:08:42 INFO - PROCESS | 12281 | |1;ext.html;565.5758181363977;590.9084091965746;625.9749610015601;627.4854619212248;633.6958260035186;35662.2867542649;40469;40720.18559628806;40834.59165408349;41037.3844392334;40115.19769604606;40485.39271910924;40492.59507404925;40680.796596016975;40695.59304406955;8583;8759.474431534096;8796.120387961184;8821.823563528726;8828.514431706253;8749.387542872002;8759;8760.211580957712;8814.515201663906;8858.025617182106;8732.781680458007;8759.080296568864;8786.560671966408;8831.60257788401;8870.112988701143;8789.121087891224;8790.736277911672;8821.867671984925;8827.33794965377;8876;8639.39524233304;8756.124387561256;8856;8869.955650221707;8872.245859101984;32482.675173248437;39271.41092883609;39496.40755388672;39703.60296397028;39880.601193987975;3083.5991321128336;3278.016595021508;3449.758516903818;3477.600075991268;3586.28274345132;29607.407851842843;29782.255443613867;29962.25094372636;29966.55050174249;30103.247418814484;4029.49631296088;4060.1473690525027;4092.9590704092875;4111.444954931106;4202.70581059326;361052;361476;362308;362319;363998;33120.66879331224;59272.407275926686;59588;59892.401075989554;60275;34263.4860477093;35903.64096359055;35907;36217.63782362143;36225.45661815075;13959.86040139606;13985.3706583204;14095.154290742588;14108.717825643429;14110.64723381903;12854.67863303425;12972.481100755864;13036.41336139876;13066.54267100647;13074.542391016268;8097.271245587807;8176.918230817735;8187.3040791533385;8258.091609922903;8275.83448331042;3252.902412927616;3286.9506957395656;3289.687479689426;3321.3191295784304;3347.7991320520846;998.1415982255255;1002.9548670309707;1053.2942928238099;1063.7340664833791;1148.4487446025787;30369.696303036686;30842.383152336828;31065.534016989764;31454.685453145634;31798.2050448736;1086.7717779266284;1091.7871015152127;1169.5555688838188;1171.800793865045;1200.4837919694442;16237.51287461378;16542.503724888273;16572.419965301156;16712.164391780363;17005.48983530496;518580;521079;522073;523599;523883;55818;57406.138907916415;57656.71171644115;57701.42298577044;57784.71107644435;1341.745068436994;1357.8710022547841;1367.4803574641771;1375.1680233458615;1385.2658091211674;29421.705782942754;30477.23806904845;30687.539686905162;30962.69037309688;30994;49233.75383123061;49763.75118124386;49809.75095124501;49836.501634983186;49934.75032624813;330071;335776;335863;337740;339884;27266.182014539594;27587.724122758515;27618.5857212146;27624.447511050068;27725.227477252112;46598.53401465942;47362.28956565723;47614.523854762396;48453;48647.27029094637;34461;36303.45544816777;36418.63581364152;40307.1938561233;40748;38329.80835095807;38440.231195376495;38464.230715384976;38549;38727.6127238724;35785.46321805227;37377.43933841049;39742.205155897296;40440;41174.382384264856;34813.30373392467;36757;37027.62972370242;37108;37112.62887371092;27961.860190698917;28468.288292792848;28559.857200713865;28701.71298287074;28855.134345969655 18:08:42 INFO - PROCESS | 12281 | |2;jquery.html;392.80752431308656;394.378853306043;394.9368101103824;396.1759540156473;422.18939635899073;18289.451316460512;19128.33050843221;19396.127174277157;19595.5101122472;19719.30982415614;17617.64764704705;17812.910935445303;17915.64168716628;19080.427587172406;19110.42668719937;5590.105583106703;5602.915956260659;5629.634073785191;5730.9426905730825;5746.339170995348;5650.208970744099;5674.546036317085;5690;5719.456651618089;5744;5598.076317407623;5672.404397538261;5691;5704.3154821421485;5705.172749951254;5629.6340737852115;5656.971715141419;5668.858278543028;5693.686847223401;5728.653766364901;5019.723915184663;5149.0474262261605;5150.227465880111;5151.407588127376;5155.587552995751;21213.151473941023;22173.33479995603;23006.19478318251;23027.194048208232;23040.65439018416;2393.916212932539;2404.1224952892067;2555.1184841229747;2722.537168681329;2760.8205466644604;14834.480793172188;15230.314635841414;15417;15608.375664973388;16172.75740863888;1980.2475059477306;2000.41987823531;2030.67509198529;2038.7451568553931;2066.6590012648044;91820;92440.53779731058;93930.53034734851;97073.51463242709;97153;16774.154842967262;17615.647687046443;17819.73270400945;17873.463796086136;18062.729059063862;30471.695283047327;30794;31144.844275778476;31219.843900780805;31307.843460783006;9543.188828949616;9610.135087842127;10206.744831379276;10250.436226007641;10396.896031039592;7831.530108193527;7886.408519361071;8254.133316001733;8417.70538031166;8473.894585267708;8754.51850148248;8844.248238899638;8980.191782739585;8997.955010224907;9037.954810226038;3439.040175237696;3534.505169276303;3572.6427357264065;3572.711668196901;3698.7780733156096;447.93728877957113;450.99098018039456;453.80259587079723;466.84594083952214;846.7713717296295;11843;11911.702207444883;11947.10396720232;12067.215630983957;12179.451924663412;468.365364930521;475.5316013726477;485.37871524448764;500.97244651544514;514.4315531337818;6215.34738852414;6384.138141350951;6437.259715132726;6443.806685799434;6477.676116194171;417483;419668;432066;439891;441427;87704;88922.55538722264;89456.6581501278;89624.5518772402;90845.54577227203;462.4612326639495;462.94213223347754;464.88610290478374;465.0373726386348;470.64466327922884;10448.68653940383;10683.679489615324;10697.465126743788;10721;10781.784364312512;38236.617633823305;38917;39466;40609.79695101506;41194.176116478106;55610.72194639001;57489;57592.84814303774;57833.710831445576;58220.08899554921;8629;8842.646294148419;8917.751514787806;8935.463872167691;8944.68693595721;10086.79826403453;13441.395137218653;13459.394327255493;13540.526081587097;13596.320183990958;11459.31244125355;11580.594679186188;11634.12744044217;11685.591004314809;11794.351310677996;11189.272697274651;11247.381394023407;11258.7748245033;11448.82826757616;11649.534018639159;11632.592859249886;11834.76330473403;11904.464299106734;11960.401979900797;12184;8762.693305734269;8814.474210315924;8830.116988301119;9029.864552031857;9075.682351117679;8930.464172149692;11047.171462140212;11375.374354410587;11551.671557770964;11566.669832968979 18:08:42 INFO - PROCESS | 12281 | |3;mootools.html;1447.3703938786625;1476.3135142158894;1578.8342224066473;1702.982970170298;1722.7415887616855;6918.308169183079;7644.655990480428;7929.76210713678;8083.91916080839;8139.511629302246;7959.164287749775;8121.553314567696;8183.508989460636;8219.794505137375;8251.257386835183;2186.562687462506;2226.944326391845;2245.618244898363;2255.8872056397195;2256.7404748453973;2215.9335219943428;2236.910523579055;2253.6281513550325;2276.3967548599635;2282.8858557072163;2195;2206.6689996500572;2219.5893759654437;2222.466608014081;2241.831862610303;2184.759676435599;2198.2416066457045;2198.703175071361;2208.7459942106702;2211.1708109458955;2141.1328411993168;2149.312220089572;2152.7954844289766;2160.2115227941845;2161.211157927345;8163;8218.753437396888;8279.875801862976;8293.21214484623;8378.078411374743;4669.906601867978;4722.1736196165875;4722.527747225285;4751.501092385284;4764.261539461354;3026.2585666511627;3168.8732450702173;3222.7099561039618;3260.4294248506417;3263.6573159818113;1104.7956128116243;1138.7153211697075;1140.5608840596346;1161.3380373187288;1181.462434592267;10471.63349282779;10480;10508.316959397614;10548.156147508182;10550.261481696207;4181.790910454465;4191.8532851350055;4286.764227967492;4316.935245971313;4334.718243314174;9039.63841446348;9047.32145089121;9051.773705657411;9062.093790620886;9093.136152065543;4836.419629644395;4842.322074909515;4849;4850.175470170079;4859.1496488114435;3830;4348.043430445297;4410.316400957857;4455.6658250631335;4617.053504031665;3623.8912832615065;3689.7232707546505;3741.9625803741615;3781.0925377909102;3781.5084039074745;1192.6243233381458;1196.3001644038336;1209.673388185185;1236.8206610041493;1240.2124650846777;878.868169774539;898.4788822482944;964.508100868548;981.7202097402206;1027.5119318323887;5495.148252020943;5781.884362312814;5853.795117170964;5997.760089596454;6013.067974463877;434.6414208278183;449.76162633804137;456.5685427271263;461.0801451105;465.0605776331791;4049.331860243086;4111.259973204792;4124.319487284624;4163.417121602978;4196.601322874383;9768;10025.699229023141;10056.145227655732;10207.030332118436;10255.179585633132;10030.899691003142;10120.949395253125;10124.645637402802;10139.543720532594;10179;7699.036745629828;7762.92237077622;7809.648565814552;7810.765677029698;7826.178251283647;5551.472610102034;5831.35855055952;5940.376260492586;6003.429674180946;6121.540884433774;9143.634254630006;9297.535123243675;9364.063593640582;9477.52612369365;9534.666286679932;9582.329236953625;9622.326437149612;9629.518524073908;9657.951710241405;9714.562844671866;6496.480281577368;7151;7154.892676609959;7236.276372362721;7458.8508229834015;8060.073091594541;8086.555239461886;8125.918740812516;8172.468789528662;8179.182081791773;6969.477289203229;7356.48504604694;7593;7649.541027538366;7685.23147685227;6827.48793840454;7176.102987126609;7187.7843664690145;7188;7196.496245262991;6585.374389432996;6625.403713665601;6671.633060181736;6689.76585819494;6691.197056353269;4143.19207754485;4220.240356735817;4321.2005778931;4357.847475338348;4381.298992161239;4780.259059845729;4885.9022819544125;4888.780004899717;4891.90216195667;4950.480199578992 18:08:42 INFO - PROCESS | 12281 | |4;prototype.html;321.5032774363608;326.8970274363576;329.6719763834983;337.75175246194027;340.4977657954516;5669.433056694324;5696.6866822324755;5723.141528770676;5729.828105156842;5751.626144300618;5595.509998050869;5616.466435688613;5639.943600563993;5643.181738647893;5649.519790817775;4146.606072423123;4221.810018549173;4328.913421731563;4340.7395556266565;4345.109252603209;4299.118680670455;4304.655627549804;4323.978380108095;4327.242732521812;4329.350597410382;4272.252355837716;4336.327869180266;4338.804753786071;4350.651298097584;4376.934345984812;4235.682323825726;4239.215745087154;4307.073979094478;4315.07225946423;4350.084340388907;3804.2771873343977;3829.5021647185686;3839.6928245740273;3845.5000849889616;3852.595477474853;5385.542228910547;5459;5465.289512363407;5473.972630136864;5498;4902.681325713817;5005.3242812220615;5005.424376196711;5012.824551140692;5019.673721208146;5666.4050274721385;5670.234518340013;5713.714314284311;5831.650100993911;5846.415358464162;4161.854335098257;4178.6657067434535;4212.199682060399;4235.0682849773;4244.236037513247;5843.415658434165;5939.70301484924;5976.133460648225;6013.444286178356;6041.6375017499095;4261.975561608211;4267.97866010668;4274.978625106917;4288.935665965013;4309.612134907873;4300.526942036374;4320.157569274024;4342.609165175149;4344.892052526586;4344.9348259776125;4816.759162041884;4940.604751619861;4949.752512374367;4965.255211718271;4977.601791856643;5866.2373891393845;5878.5297176225795;5900.940990590125;5904.61619994699;5933.554983376178;1512.8108986376703;1520.1791032842361;1531.1349087765377;1536.05532597454;1536.508317338441;962.9662961796444;968.6706519783307;985.1724551376877;992.6029588164647;998.6754304850807;5527.972360138174;5549.445055494499;5588.161775733591;5589.664620122806;5638.718064096779;5891.911621325684;5908.527317814564;5926.733297001645;5967.850803729854;5991.670458124845;5382.757775900094;5531.814933101403;5711.742971566289;5715.885682286331;5742.54059675225;3180.936381272362;3234.1106195795874;3248.902532924016;3255.967440325614;3260.2012506935953;6035.215421995113;6157.784477543264;6242.313345531988;6258.340205412682;6265.8120256392385;6161.815145545641;6172.259328880563;6215.192025036717;6230.348957526259;6247.75008999644;6097.878042439126;6196.721147548371;6210.596311239845;6216.285127210338;6229.53933196394;6000.279966404059;6014.578979471395;6021.42796434338;6049.909251361321;6074.301455332693;5891.528677705687;5964.642121472725;5998.34018258;6018.4884284834525;6071.787487437919;5830.941690583039;6165.506759459322;6178.258608966773;6229.221347331583;6277.403646653561;4241.197491066347;4285.314349704033;4290.227759003409;4293.463317085364;4294;5918.378570250234;5995.46040856325;6020.729067192075;6022.54830887694;6056.576039677357;5828.6211396259105;5832.300123985149;5846.94153058464;5863.17915491823;5868.178455016216;5750.942490575041;5768.365479797135;5783.884322313615;5847.918135145012;5855.59010869235;5188.766505507337;5703.372629010889;5727.856803579777;5742.19609254713;5830.679312637845;5808.332041815076;5841.620294680833;5882.323532793613;5900.763969441175;5901.29184497863;5523.917141242965;5744.684042377709;5817.94182058174;5832.154337621106;5894.557908156819 18:08:42 INFO - PROCESS | 12281 | |5;yui.html;694.836713372357;734.8493558820443;758.7951253161647;797.2864286463615;838.0906716212909;15556.688866222683;15888.126153061577;16013.919930400332;16306.83693163068;16504.504864854043;14508.854911450882;14643.853561464382;14659.92670036651;14675.77986330206;14678.119312841238;791.7545560876118;802.8434455281223;802.9397795165356;811.0794248527905;823.4812068396901;799.5362689639995;805.5368163306093;806.995965020177;809.2029351089172;809.4050872608628;839.7270886961762;846.3398549131656;849.0660273698912;852.1563651984553;852.8635418333068;831.2726364431123;837.401258100458;841.0202114536588;843.9831203375898;845.8477474054667;609.1958614628692;616.2697203813451;618.3661746709614;619.1888625900085;619.5446346934999;15947.202639868075;16009.519714408587;16064.919675401548;16145.757813632805;16153.91923040389;13997.160170389809;14043;14343.928280358636;14367.13797172173;14423;11975.101867359983;12055.879441205563;12171.573994910224;12261.509539618404;12279.079069069856;3797.1646237827636;3847.8653247136494;3853.910148101523;3896.08442016126;4096.9795151024355;74272.62863685648;75090.24909750887;76068.61965690191;76179.6191019047;76556;11125.72185695348;11213.831792523119;11705.297682139098;11777.764444711229;11830.349330786888;22584.0966361347;22595.661065084038;22664.320070397913;22717.88641056817;22912.541749165255;7983.880241796378;8170;8202.466839655403;8620.870686939701;8917.509536975398;4781.330613714083;4944.802207911715;4950.232713929347;4980.526849949249;5115.411727651293;3438.1404648837793;3574.37448446526;3577.856885724542;3578.499010138583;3598.7480876338404;617.3301967365459;617.7714245729019;623.2894500269696;627.1282916745727;634.3086036220542;632.788016014631;648.597869321024;658.4830907737403;672.1832972937904;681.7818298144546;8380.706675266458;8965.193132618097;9232.53837308132;9431.764205894908;9442.686541797166;596.1147695671924;606.9059295809157;615.9630422174683;646.2277578293894;650.7559665125578;4388.5162541303425;4389.956100439019;4414.161309351213;4466.865994020184;4550.886227844264;113667;114406;115175;116448;116850;81754.18245817584;84763.57618211993;103069;103412;105861.47069264605;64556.03165952514;66373;88244.5587772057;92905;96220.51889740507;8779.429337093325;9694.00390296099;9706.611735530782;9773.31586788918;9789.058004087723;38078.619213807506;45863.31205031861;46348.53651463442;47337.763311183226;47664.761676191396;66125;67292.66353668396;67667;67746.66126669335;68407;12867.099303049072;12888.291143987171;13030.869691302965;13428.798568021683;13457.405871122883;13055.151415157985;13059.738805224033;13139.54011609589;13267.66830829237;13275.40260688252;13154.34228288601;13273.734525309634;13296.667583310495;13501.662458438617;13790.931045344709;13144;13470.595882123553;13490;13514.662133446742;13567;13260.734785304432;13475.528356507475;13509.392077356346;13511.121777084458;13527.729445411234;10637.734056648645;10649.148068154374;10696;10781.784364312512;11664;10654.8934510657;10993.945030274797;11134.721631959266;11148.721281968015;11240.83138752903 18:08:42 INFO - PROCESS | 12281 | __end_tp_report 18:08:42 INFO - PROCESS | 12281 | __start_cc_report 18:08:42 INFO - PROCESS | 12281 | _x_x_mozilla_cycle_collect,349 18:08:42 INFO - PROCESS | 12281 | __end_cc_report 18:08:42 INFO - PROCESS | 12281 | __startTimestamp1466039322358__endTimestamp 18:08:42 INFO - PROCESS | 12281 | 18:08:42 INFO - PROCESS | 12281 | ------- Summary: start ------- 18:08:42 INFO - PROCESS | 12281 | Number of tests: 6 18:08:42 INFO - PROCESS | 12281 | 18:08:42 INFO - PROCESS | 12281 | [#0] dojo.html Cycles:165 Average:5438.69 Median:5650.24 stddev:626.67 (11.1%) stddev-sans-first:600.03 18:08:42 INFO - PROCESS | 12281 | Values: 3054.6 3105.7 3110.0 3148.4 3153.2 5319.7 5355.9 5360.2 5452.1 5507.7 5309.8 5455.7 5472.5 5523.0 5525.3 4919.2 4931.4 4977.8 5085.8 5119.0 4932.9 5124.8 5165.2 5172.7 5177.6 4823.9 4901.9 4921.0 4994.2 5008.0 4915.5 4921.2 4932.2 4940.5 5013.4 4870.2 4881.4 4883.4 4884.8 4911.3 5189.4 5365.0 5382.1 5433.8 5467.2 5776.2 5837.0 5854.0 5862.3 5893.2 5666.4 5926.1 5927.3 5930.5 5938.6 5462.6 5492.8 5525.6 5533.1 5571.7 6034.4 6049.8 6054.6 6070.8 6104.4 5593.2 5746.9 5820.9 5822.6 5846.8 5850.4 5914.8 5924.5 5934.9 5966.2 5595.0 5802.7 5875.2 5875.9 5908.3 5637.2 5845.2 5877.7 5948.1 5964.4 4498.8 4500.3 4500.7 4530.8 4553.0 3968.9 3989.4 4020.0 4020.6 4042.3 5583.6 5595.4 5597.9 5616.2 5626.8 5857.3 5902.4 5920.3 5924.9 5943.1 5642.2 5643.3 5658.6 5659.9 5681.4 4950.0 5001.3 5005.2 5012.6 5026.1 6014.7 6038.6 6054.8 6094.1 6096.6 5735.3 5859.2 5866.4 5873.3 5896.2 6031.2 6054.0 6062.3 6077.5 6091.2 5736.9 5775.6 5776.1 5782.8 5799.0 5646.7 5720.4 5843.1 5849.4 5888.8 5552.1 5582.1 5588.2 5617.0 5665.4 5703.1 5712.5 5713.4 5731.0 5780.5 5658.5 5676.2 5677.7 5686.6 5698.1 5659.1 5686.4 5692.2 5761.1 5776.2 5631.6 5645.6 5650.2 5660.5 5678.0 18:08:42 INFO - PROCESS | 12281 | 18:08:42 INFO - PROCESS | 12281 | [#1] ext.html Cycles:180 Average:55365.75 Median:37245.03 stddev:110146.83 (295.7%) stddev-sans-first:110378.98 18:08:42 INFO - PROCESS | 12281 | Values: 565.6 590.9 626.0 627.5 633.7 35662.3 40469.0 40720.2 40834.6 41037.4 40115.2 40485.4 40492.6 40680.8 40695.6 8583.0 8759.5 8796.1 8821.8 8828.5 8749.4 8759.0 8760.2 8814.5 8858.0 8732.8 8759.1 8786.6 8831.6 8870.1 8789.1 8790.7 8821.9 8827.3 8876.0 8639.4 8756.1 8856.0 8870.0 8872.2 32482.7 39271.4 39496.4 39703.6 39880.6 3083.6 3278.0 3449.8 3477.6 3586.3 29607.4 29782.3 29962.3 29966.6 30103.2 4029.5 4060.1 4093.0 4111.4 4202.7 361052.0 361476.0 362308.0 362319.0 363998.0 33120.7 59272.4 59588.0 59892.4 60275.0 34263.5 35903.6 35907.0 36217.6 36225.5 13959.9 13985.4 14095.2 14108.7 14110.6 12854.7 12972.5 13036.4 13066.5 13074.5 8097.3 8176.9 8187.3 8258.1 8275.8 3252.9 3287.0 3289.7 3321.3 3347.8 998.1 1003.0 1053.3 1063.7 1148.4 30369.7 30842.4 31065.5 31454.7 31798.2 1086.8 1091.8 1169.6 1171.8 1200.5 16237.5 16542.5 16572.4 16712.2 17005.5 518580.0 521079.0 522073.0 523599.0 523883.0 55818.0 57406.1 57656.7 57701.4 57784.7 1341.7 1357.9 1367.5 1375.2 1385.3 29421.7 30477.2 30687.5 30962.7 30994.0 49233.8 49763.8 49809.8 49836.5 49934.8 330071.0 335776.0 335863.0 337740.0 339884.0 27266.2 27587.7 27618.6 27624.4 27725.2 46598.5 47362.3 47614.5 48453.0 48647.3 34461.0 36303.5 36418.6 40307.2 40748.0 38329.8 38440.2 38464.2 38549.0 38727.6 35785.5 37377.4 39742.2 40440.0 41174.4 34813.3 36757.0 37027.6 37108.0 37112.6 27961.9 28468.3 28559.9 28701.7 28855.1 18:08:42 INFO - PROCESS | 12281 | 18:08:42 INFO - PROCESS | 12281 | [#2] jquery.html Cycles:180 Average:27928.21 Median:229338.59 stddev:71512.74 (31.2%) stddev-sans-first:71683.47 18:08:42 INFO - PROCESS | 12281 | Values: 392.8 394.4 394.9 396.2 422.2 18289.5 19128.3 19396.1 19595.5 19719.3 17617.6 17812.9 17915.6 19080.4 19110.4 5590.1 5602.9 5629.6 5730.9 5746.3 5650.2 5674.5 5690.0 5719.5 5744.0 5598.1 5672.4 5691.0 5704.3 5705.2 5629.6 5657.0 5668.9 5693.7 5728.7 5019.7 5149.0 5150.2 5151.4 5155.6 21213.2 22173.3 23006.2 23027.2 23040.7 2393.9 2404.1 2555.1 2722.5 2760.8 14834.5 15230.3 15417.0 15608.4 16172.8 1980.2 2000.4 2030.7 2038.7 2066.7 91820.0 92440.5 93930.5 97073.5 97153.0 16774.2 17615.6 17819.7 17873.5 18062.7 30471.7 30794.0 31144.8 31219.8 31307.8 9543.2 9610.1 10206.7 10250.4 10396.9 7831.5 7886.4 8254.1 8417.7 8473.9 8754.5 8844.2 8980.2 8998.0 9038.0 3439.0 3534.5 3572.6 3572.7 3698.8 447.9 451.0 453.8 466.8 846.8 11843.0 11911.7 11947.1 12067.2 12179.5 468.4 475.5 485.4 501.0 514.4 6215.3 6384.1 6437.3 6443.8 6477.7 417483.0 419668.0 432066.0 439891.0 441427.0 87704.0 88922.6 89456.7 89624.6 90845.5 462.5 462.9 464.9 465.0 470.6 10448.7 10683.7 10697.5 10721.0 10781.8 38236.6 38917.0 39466.0 40609.8 41194.2 55610.7 57489.0 57592.8 57833.7 58220.1 8629.0 8842.6 8917.8 8935.5 8944.7 10086.8 13441.4 13459.4 13540.5 13596.3 11459.3 11580.6 11634.1 11685.6 11794.4 11189.3 11247.4 11258.8 11448.8 11649.5 11632.6 11834.8 11904.5 11960.4 12184.0 8762.7 8814.5 8830.1 9029.9 9075.7 8930.5 11047.2 11375.4 11551.7 11566.7 18:08:42 INFO - PROCESS | 12281 | 18:08:42 INFO - PROCESS | 12281 | [#3] mootools.html Cycles:180 Average:5378.81 Median:4696.04 stddev:3006.25 (64.0%) stddev-sans-first:3000.16 18:08:42 INFO - PROCESS | 12281 | Values: 1447.4 1476.3 1578.8 1703.0 1722.7 6918.3 7644.7 7929.8 8083.9 8139.5 7959.2 8121.6 8183.5 8219.8 8251.3 2186.6 2226.9 2245.6 2255.9 2256.7 2215.9 2236.9 2253.6 2276.4 2282.9 2195.0 2206.7 2219.6 2222.5 2241.8 2184.8 2198.2 2198.7 2208.7 2211.2 2141.1 2149.3 2152.8 2160.2 2161.2 8163.0 8218.8 8279.9 8293.2 8378.1 4669.9 4722.2 4722.5 4751.5 4764.3 3026.3 3168.9 3222.7 3260.4 3263.7 1104.8 1138.7 1140.6 1161.3 1181.5 10471.6 10480.0 10508.3 10548.2 10550.3 4181.8 4191.9 4286.8 4316.9 4334.7 9039.6 9047.3 9051.8 9062.1 9093.1 4836.4 4842.3 4849.0 4850.2 4859.1 3830.0 4348.0 4410.3 4455.7 4617.1 3623.9 3689.7 3742.0 3781.1 3781.5 1192.6 1196.3 1209.7 1236.8 1240.2 878.9 898.5 964.5 981.7 1027.5 5495.1 5781.9 5853.8 5997.8 6013.1 434.6 449.8 456.6 461.1 465.1 4049.3 4111.3 4124.3 4163.4 4196.6 9768.0 10025.7 10056.1 10207.0 10255.2 10030.9 10120.9 10124.6 10139.5 10179.0 7699.0 7762.9 7809.6 7810.8 7826.2 5551.5 5831.4 5940.4 6003.4 6121.5 9143.6 9297.5 9364.1 9477.5 9534.7 9582.3 9622.3 9629.5 9658.0 9714.6 6496.5 7151.0 7154.9 7236.3 7458.9 8060.1 8086.6 8125.9 8172.5 8179.2 6969.5 7356.5 7593.0 7649.5 7685.2 6827.5 7176.1 7187.8 7188.0 7196.5 6585.4 6625.4 6671.6 6689.8 6691.2 4143.2 4220.2 4321.2 4357.8 4381.3 4780.3 4885.9 4888.8 4891.9 4950.5 18:08:42 INFO - PROCESS | 12281 | 18:08:42 INFO - PROCESS | 12281 | [#4] prototype.html Cycles:180 Average:4926.36 Median:5669.83 stddev:1449.62 (25.6%) stddev-sans-first:1411.88 18:08:42 INFO - PROCESS | 12281 | Values: 321.5 326.9 329.7 337.8 340.5 5669.4 5696.7 5723.1 5729.8 5751.6 5595.5 5616.5 5639.9 5643.2 5649.5 4146.6 4221.8 4328.9 4340.7 4345.1 4299.1 4304.7 4324.0 4327.2 4329.4 4272.3 4336.3 4338.8 4350.7 4376.9 4235.7 4239.2 4307.1 4315.1 4350.1 3804.3 3829.5 3839.7 3845.5 3852.6 5385.5 5459.0 5465.3 5474.0 5498.0 4902.7 5005.3 5005.4 5012.8 5019.7 5666.4 5670.2 5713.7 5831.7 5846.4 4161.9 4178.7 4212.2 4235.1 4244.2 5843.4 5939.7 5976.1 6013.4 6041.6 4262.0 4268.0 4275.0 4288.9 4309.6 4300.5 4320.2 4342.6 4344.9 4344.9 4816.8 4940.6 4949.8 4965.3 4977.6 5866.2 5878.5 5900.9 5904.6 5933.6 1512.8 1520.2 1531.1 1536.1 1536.5 963.0 968.7 985.2 992.6 998.7 5528.0 5549.4 5588.2 5589.7 5638.7 5891.9 5908.5 5926.7 5967.9 5991.7 5382.8 5531.8 5711.7 5715.9 5742.5 3180.9 3234.1 3248.9 3256.0 3260.2 6035.2 6157.8 6242.3 6258.3 6265.8 6161.8 6172.3 6215.2 6230.3 6247.8 6097.9 6196.7 6210.6 6216.3 6229.5 6000.3 6014.6 6021.4 6049.9 6074.3 5891.5 5964.6 5998.3 6018.5 6071.8 5830.9 6165.5 6178.3 6229.2 6277.4 4241.2 4285.3 4290.2 4293.5 4294.0 5918.4 5995.5 6020.7 6022.5 6056.6 5828.6 5832.3 5846.9 5863.2 5868.2 5750.9 5768.4 5783.9 5847.9 5855.6 5188.8 5703.4 5727.9 5742.2 5830.7 5808.3 5841.6 5882.3 5900.8 5901.3 5523.9 5744.7 5817.9 5832.2 5894.6 18:08:42 INFO - PROCESS | 12281 | 18:08:42 INFO - PROCESS | 12281 | [#5] yui.html Cycles:180 Average:20200.21 Median:4402.06 stddev:29057.64 (660.1%) stddev-sans-first:29102.25 18:08:42 INFO - PROCESS | 12281 | Values: 694.8 734.8 758.8 797.3 838.1 15556.7 15888.1 16013.9 16306.8 16504.5 14508.9 14643.9 14659.9 14675.8 14678.1 791.8 802.8 802.9 811.1 823.5 799.5 805.5 807.0 809.2 809.4 839.7 846.3 849.1 852.2 852.9 831.3 837.4 841.0 844.0 845.8 609.2 616.3 618.4 619.2 619.5 15947.2 16009.5 16064.9 16145.8 16153.9 13997.2 14043.0 14343.9 14367.1 14423.0 11975.1 12055.9 12171.6 12261.5 12279.1 3797.2 3847.9 3853.9 3896.1 4097.0 74272.6 75090.2 76068.6 76179.6 76556.0 11125.7 11213.8 11705.3 11777.8 11830.3 22584.1 22595.7 22664.3 22717.9 22912.5 7983.9 8170.0 8202.5 8620.9 8917.5 4781.3 4944.8 4950.2 4980.5 5115.4 3438.1 3574.4 3577.9 3578.5 3598.7 617.3 617.8 623.3 627.1 634.3 632.8 648.6 658.5 672.2 681.8 8380.7 8965.2 9232.5 9431.8 9442.7 596.1 606.9 616.0 646.2 650.8 4388.5 4390.0 4414.2 4466.9 4550.9 113667.0 114406.0 115175.0 116448.0 116850.0 81754.2 84763.6 103069.0 103412.0 105861.5 64556.0 66373.0 88244.6 92905.0 96220.5 8779.4 9694.0 9706.6 9773.3 9789.1 38078.6 45863.3 46348.5 47337.8 47664.8 66125.0 67292.7 67667.0 67746.7 68407.0 12867.1 12888.3 13030.9 13428.8 13457.4 13055.2 13059.7 13139.5 13267.7 13275.4 13154.3 13273.7 13296.7 13501.7 13790.9 13144.0 13470.6 13490.0 13514.7 13567.0 13260.7 13475.5 13509.4 13511.1 13527.7 10637.7 10649.1 10696.0 10781.8 11664.0 10654.9 10993.9 11134.7 11148.7 11240.8 18:08:42 INFO - PROCESS | 12281 | -------- Summary: end -------- 18:08:42 INFO - PROCESS | 12281 | 18:08:43 INFO - TEST-INFO | 12281: exit 0 18:08:43 INFO - TEST-OK | dromaeo_css | took 1111106ms 18:08:43 INFO - TEST-START | kraken 18:08:43 INFO - operating with platform_type : linux_ 18:08:43 INFO - Initialising browser for kraken test... 18:08:43 INFO - TEST-INFO | started process 12519 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaXd2Zk/profile http://localhost:57906/getInfo.html) 18:08:47 INFO - PROCESS | 12519 | __metrics Screen width/height:1600/1200 18:08:47 INFO - PROCESS | 12519 | colorDepth:24 18:08:47 INFO - PROCESS | 12519 | Browser inner width/height: 1024/697 18:08:47 INFO - PROCESS | 12519 | __metrics 18:08:47 ERROR - PROCESS | 12519 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 18:08:48 INFO - TEST-INFO | 12519: exit 0 18:08:48 INFO - Browser initialized. 18:08:48 INFO - Running cycle 1/1 for kraken test... 18:08:48 INFO - TEST-INFO | started process 12638 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaXd2Zk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:09:00 INFO - PROCESS | 12638 | RSS: Main: 185024512 18:09:00 INFO - PROCESS | 12638 | 18:09:03 INFO - PROCESS | 12638 | Cycle 1(1): loaded http://localhost:57906/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57906/tests/kraken/driver.html?testName=audio-beat-detection) 18:09:04 INFO - PROCESS | 12638 | RSS: Main: 190148608 18:09:04 INFO - PROCESS | 12638 | 18:09:07 INFO - PROCESS | 12638 | Cycle 1(1): loaded http://localhost:57906/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57906/tests/kraken/driver.html?testName=audio-dft) 18:09:07 INFO - PROCESS | 12638 | RSS: Main: 188882944 18:09:07 INFO - PROCESS | 12638 | 18:09:10 INFO - PROCESS | 12638 | Cycle 1(1): loaded http://localhost:57906/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57906/tests/kraken/driver.html?testName=audio-fft) 18:09:11 INFO - PROCESS | 12638 | RSS: Main: 184721408 18:09:11 INFO - PROCESS | 12638 | 18:09:13 INFO - PROCESS | 12638 | Cycle 1(1): loaded http://localhost:57906/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57906/tests/kraken/driver.html?testName=audio-oscillator) 18:09:13 INFO - PROCESS | 12638 | RSS: Main: 185352192 18:09:13 INFO - PROCESS | 12638 | 18:09:16 INFO - PROCESS | 12638 | Cycle 1(1): loaded http://localhost:57906/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57906/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:09:16 INFO - PROCESS | 12638 | RSS: Main: 185937920 18:09:16 INFO - PROCESS | 12638 | 18:09:19 INFO - PROCESS | 12638 | Cycle 1(1): loaded http://localhost:57906/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57906/tests/kraken/driver.html?testName=imaging-darkroom) 18:09:20 INFO - PROCESS | 12638 | RSS: Main: 186413056 18:09:20 INFO - PROCESS | 12638 | 18:09:23 INFO - PROCESS | 12638 | Cycle 1(1): loaded http://localhost:57906/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57906/tests/kraken/driver.html?testName=imaging-desaturate) 18:09:24 INFO - PROCESS | 12638 | RSS: Main: 186724352 18:09:24 INFO - PROCESS | 12638 | 18:09:27 INFO - PROCESS | 12638 | Cycle 1(1): loaded http://localhost:57906/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57906/tests/kraken/driver.html?testName=json-parse-financial) 18:09:28 INFO - PROCESS | 12638 | RSS: Main: 186548224 18:09:28 INFO - PROCESS | 12638 | 18:09:29 INFO - PROCESS | 12638 | Cycle 1(1): loaded http://localhost:57906/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57906/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:09:30 INFO - PROCESS | 12638 | RSS: Main: 186499072 18:09:30 INFO - PROCESS | 12638 | 18:09:32 INFO - PROCESS | 12638 | Cycle 1(1): loaded http://localhost:57906/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57906/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:09:32 INFO - PROCESS | 12638 | RSS: Main: 186933248 18:09:32 INFO - PROCESS | 12638 | 18:09:34 INFO - PROCESS | 12638 | Cycle 1(1): loaded http://localhost:57906/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57906/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:09:35 INFO - PROCESS | 12638 | RSS: Main: 187531264 18:09:35 INFO - PROCESS | 12638 | 18:09:38 INFO - PROCESS | 12638 | Cycle 1(1): loaded http://localhost:57906/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57906/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:09:38 INFO - PROCESS | 12638 | RSS: Main: 187576320 18:09:38 INFO - PROCESS | 12638 | 18:09:41 INFO - PROCESS | 12638 | Cycle 1(1): loaded http://localhost:57906/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57906/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:09:42 INFO - PROCESS | 12638 | RSS: Main: 187461632 18:09:42 INFO - PROCESS | 12638 | 18:09:43 INFO - PROCESS | 12638 | Cycle 1(1): loaded http://localhost:57906/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57906/tests/kraken/driver.html?testName=ai-astar) 18:09:44 INFO - PROCESS | 12638 | RSS: Main: 188469248 18:09:44 INFO - PROCESS | 12638 | 18:09:44 INFO - PROCESS | 12638 | __start_tp_report 18:09:44 INFO - PROCESS | 12638 | _x_x_mozilla_page_load 18:09:44 INFO - PROCESS | 12638 | _x_x_mozilla_page_load_details 18:09:44 INFO - PROCESS | 12638 | |i|pagename|runs| 18:09:44 INFO - PROCESS | 12638 | |0;ai-astar;114;106;112;111;112;113;112;111;110;111 18:09:44 INFO - PROCESS | 12638 | |1;audio-beat-detection;164;130;156;181;127;165;166;128;179;127 18:09:44 INFO - PROCESS | 12638 | |2;audio-dft;164;164;163;165;171;165;166;169;163;165 18:09:44 INFO - PROCESS | 12638 | |3;audio-fft;77;76;77;163;77;76;77;77;164;76 18:09:44 INFO - PROCESS | 12638 | |4;audio-oscillator;87;86;151;87;85;86;154;87;86;140 18:09:44 INFO - PROCESS | 12638 | |5;imaging-gaussian-blur;119;120;118;118;118;118;119;118;119;118 18:09:44 INFO - PROCESS | 12638 | |6;imaging-darkroom;149;148;149;147;147;146;148;148;146;147 18:09:44 INFO - PROCESS | 12638 | |7;imaging-desaturate;96;96;95;101;96;97;98;97;96;97 18:09:44 INFO - PROCESS | 12638 | |8;json-parse-financial;57;57;55;54;57;57;55;55;55;55 18:09:44 INFO - PROCESS | 12638 | |9;json-stringify-tinderbox;62;62;62;60;63;62;62;63;64;62 18:09:44 INFO - PROCESS | 12638 | |10;stanford-crypto-aes;81;80;80;82;82;80;81;86;107;81 18:09:44 INFO - PROCESS | 12638 | |11;stanford-crypto-ccm;123;124;127;129;122;140;133;124;136;129 18:09:44 INFO - PROCESS | 12638 | |12;stanford-crypto-pbkdf2;173;160;164;164;166;165;169;159;163;164 18:09:44 INFO - PROCESS | 12638 | |13;stanford-crypto-sha256-iterative;68;68;67;64;69;64;65;64;65;68 18:09:44 INFO - PROCESS | 12638 | __end_tp_report 18:09:44 INFO - PROCESS | 12638 | __start_cc_report 18:09:44 INFO - PROCESS | 12638 | _x_x_mozilla_cycle_collect,889 18:09:44 INFO - PROCESS | 12638 | __end_cc_report 18:09:44 INFO - PROCESS | 12638 | __startTimestamp1466039384064__endTimestamp 18:09:44 INFO - PROCESS | 12638 | 18:09:44 INFO - PROCESS | 12638 | ------- Summary: start ------- 18:09:44 INFO - PROCESS | 12638 | Number of tests: 14 18:09:44 INFO - PROCESS | 12638 | 18:09:44 INFO - PROCESS | 12638 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.00 stddev:2.15 (1.9%) stddev-sans-first:2.03 18:09:44 INFO - PROCESS | 12638 | Values: 114.0 106.0 112.0 111.0 112.0 113.0 112.0 111.0 110.0 111.0 18:09:44 INFO - PROCESS | 12638 | 18:09:44 INFO - PROCESS | 12638 | [#1] audio-beat-detection Cycles:10 Average:152.30 Median:164.50 stddev:22.12 (13.4%) stddev-sans-first:23.05 18:09:44 INFO - PROCESS | 12638 | Values: 164.0 130.0 156.0 181.0 127.0 165.0 166.0 128.0 179.0 127.0 18:09:44 INFO - PROCESS | 12638 | 18:09:44 INFO - PROCESS | 12638 | [#2] audio-dft Cycles:10 Average:165.50 Median:165.00 stddev:2.59 (1.6%) stddev-sans-first:2.69 18:09:44 INFO - PROCESS | 12638 | Values: 164.0 164.0 163.0 165.0 171.0 165.0 166.0 169.0 163.0 165.0 18:09:44 INFO - PROCESS | 12638 | 18:09:44 INFO - PROCESS | 12638 | [#3] audio-fft Cycles:10 Average:94.00 Median:77.00 stddev:36.63 (47.6%) stddev-sans-first:38.34 18:09:44 INFO - PROCESS | 12638 | Values: 77.0 76.0 77.0 163.0 77.0 76.0 77.0 77.0 164.0 76.0 18:09:44 INFO - PROCESS | 12638 | 18:09:44 INFO - PROCESS | 12638 | [#4] audio-oscillator Cycles:10 Average:104.90 Median:86.00 stddev:30.18 (35.1%) stddev-sans-first:31.31 18:09:44 INFO - PROCESS | 12638 | Values: 87.0 86.0 151.0 87.0 85.0 86.0 154.0 87.0 86.0 140.0 18:09:44 INFO - PROCESS | 12638 | 18:09:44 INFO - PROCESS | 12638 | [#5] imaging-gaussian-blur Cycles:10 Average:118.50 Median:118.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 18:09:44 INFO - PROCESS | 12638 | Values: 119.0 120.0 118.0 118.0 118.0 118.0 119.0 118.0 119.0 118.0 18:09:44 INFO - PROCESS | 12638 | 18:09:44 INFO - PROCESS | 12638 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:1.08 (0.7%) stddev-sans-first:1.00 18:09:44 INFO - PROCESS | 12638 | Values: 149.0 148.0 149.0 147.0 147.0 146.0 148.0 148.0 146.0 147.0 18:09:44 INFO - PROCESS | 12638 | 18:09:44 INFO - PROCESS | 12638 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:96.50 stddev:1.66 (1.7%) stddev-sans-first:1.73 18:09:44 INFO - PROCESS | 12638 | Values: 96.0 96.0 95.0 101.0 96.0 97.0 98.0 97.0 96.0 97.0 18:09:44 INFO - PROCESS | 12638 | 18:09:44 INFO - PROCESS | 12638 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:56.00 stddev:1.16 (2.1%) stddev-sans-first:1.13 18:09:44 INFO - PROCESS | 12638 | Values: 57.0 57.0 55.0 54.0 57.0 57.0 55.0 55.0 55.0 55.0 18:09:44 INFO - PROCESS | 12638 | 18:09:44 INFO - PROCESS | 12638 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:1.03 (1.7%) stddev-sans-first:1.09 18:09:44 INFO - PROCESS | 12638 | Values: 62.0 62.0 62.0 60.0 63.0 62.0 62.0 63.0 64.0 62.0 18:09:44 INFO - PROCESS | 12638 | 18:09:44 INFO - PROCESS | 12638 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:81.00 stddev:8.27 (10.2%) stddev-sans-first:8.70 18:09:44 INFO - PROCESS | 12638 | Values: 81.0 80.0 80.0 82.0 82.0 80.0 81.0 86.0 107.0 81.0 18:09:44 INFO - PROCESS | 12638 | 18:09:44 INFO - PROCESS | 12638 | [#11] stanford-crypto-ccm Cycles:10 Average:128.70 Median:129.00 stddev:6.00 (4.7%) stddev-sans-first:6.00 18:09:44 INFO - PROCESS | 12638 | Values: 123.0 124.0 127.0 129.0 122.0 140.0 133.0 124.0 136.0 129.0 18:09:44 INFO - PROCESS | 12638 | 18:09:44 INFO - PROCESS | 12638 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.70 Median:164.50 stddev:4.06 (2.5%) stddev-sans-first:2.99 18:09:44 INFO - PROCESS | 12638 | Values: 173.0 160.0 164.0 164.0 166.0 165.0 169.0 159.0 163.0 164.0 18:09:44 INFO - PROCESS | 12638 | 18:09:44 INFO - PROCESS | 12638 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:67.50 stddev:1.99 (2.9%) stddev-sans-first:2.00 18:09:44 INFO - PROCESS | 12638 | Values: 68.0 68.0 67.0 64.0 69.0 64.0 65.0 64.0 65.0 68.0 18:09:44 INFO - PROCESS | 12638 | -------- Summary: end -------- 18:09:44 INFO - PROCESS | 12638 | 18:09:45 INFO - TEST-INFO | 12638: exit 0 18:09:45 INFO - TEST-OK | kraken | took 61905ms 18:09:45 INFO - SUITE-END | took 1173s 18:09:45 INFO - Completed test suite (00:19:33) 18:09:45 INFO - javascript benchmark 18:09:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7087.180164808742, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3054.602901622789, 3105.720485156336, 3109.95335069974, 3148.4490214212506, 3153.2432216268103, 5319.654222475541, 5355.89288214236, 5360.169173778066, 5452.073147564914, 5507.669539827613, 5309.787608495655, 5455.672659640414, 5472.534834539059, 5522.972385138069, 5525.336959564847, 4919.212925931861, 4931.3835770528685, 4977.800887964477, 5085.771140298677, 5119.027384796896, 4932.8520144395725, 5124.846254612349, 5165.199394093921, 5172.689638621676, 5177.585793136559, 4823.855284341475, 4901.852944411673, 4920.975395123037, 4994.225894986283, 5008.048470790556, 4915.459299477055, 4921.237208232694, 4932.21084626458, 4940.5059494050665, 5013.398392192924, 4870.196417591093, 4881.438634557036, 4883.389576302962, 4884.780184891652, 4911.263310503417, 5189.403218629868, 5364.973175134139, 5382.111951527993, 5433.809816656438, 5467.152591348347, 5776.191333213354, 5837.007708689533, 5854.0, 5862.267216597926, 5893.204417403681, 5666.433356664342, 5926.140709597084, 5927.2590926134235, 5930.525557955353, 5938.6436813791315, 5462.562994960394, 5492.780288788444, 5525.585581081435, 5533.08704063829, 5571.66570005801, 6034.39656034393, 6049.818505444844, 6054.606450580698, 6070.817875463743, 6104.3590423005835, 5593.161025846156, 5746.913796293059, 5820.883582328414, 5822.621529600562, 5846.795362162304, 5850.444207800252, 5914.792982245601, 5924.4667979882015, 5934.9406505934385, 5966.224390829165, 5594.972025139929, 5802.6808525531505, 5875.236219291465, 5875.882482350329, 5908.291005079418, 5637.210790489335, 5845.210896528914, 5877.735501902424, 5948.078047902495, 5964.373740757244, 4498.820047198141, 4500.302453119772, 4500.662450316239, 4530.79611417487, 4552.952820851223, 3968.900777480586, 3989.4215338775716, 4020.0, 4020.5979402060143, 4042.2521833460905, 5583.581231407661, 5595.38450770415, 5597.888042239132, 5616.185653080281, 5626.774929002876, 5857.297124345021, 5902.439268269508, 5920.348761636216, 5924.911126333109, 5943.078822782476, 5642.181883626933, 5643.322801263875, 5658.632188907708, 5659.858503537444, 5681.431856814368, 4949.975250123726, 5001.299818025479, 5005.174146265898, 5012.649114561946, 5026.095302845523, 6014.669193194329, 6038.5772995889865, 6054.848628784315, 6094.146819445193, 6096.603720758137, 5735.311762588516, 5859.150423188699, 5866.442687944638, 5873.2658417697785, 5896.204012458435, 6031.185789918481, 6053.969730151321, 6062.302835174011, 6077.544184186292, 6091.177691011657, 5736.942630573641, 5775.566832487496, 5776.133579962871, 5782.7686892523825, 5799.043157879071, 5646.661200327993, 5720.39935806751, 5843.1235314703135, 5849.444302791228, 5888.823335299948, 5552.056150454352, 5582.078956972054, 5588.189712491747, 5617.045102332531, 5665.433456654301, 5703.116017017369, 5712.542996560348, 5713.400092990342, 5731.025725626737, 5780.450857168562, 5658.5473162147755, 5676.2337084493065, 5677.74450149736, 5686.57350698691, 5698.0598201296325, 5659.094544872801, 5686.374498805211, 5692.231548740867, 5761.107028410603, 5776.220210271727, 5631.63394379364, 5645.633033852787, 5650.23721797552, 5660.462256085665, 5678.0], "value": 5395.599697472863, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.5758181363977, 590.9084091965746, 625.9749610015601, 627.4854619212248, 633.6958260035186, 35662.2867542649, 40469.0, 40720.18559628806, 40834.59165408349, 41037.3844392334, 40115.19769604606, 40485.39271910924, 40492.59507404925, 40680.796596016975, 40695.59304406955, 8583.0, 8759.474431534096, 8796.120387961184, 8821.823563528726, 8828.514431706253, 8749.387542872002, 8759.0, 8760.211580957712, 8814.515201663906, 8858.025617182106, 8732.781680458007, 8759.080296568864, 8786.560671966408, 8831.60257788401, 8870.112988701143, 8789.121087891224, 8790.736277911672, 8821.867671984925, 8827.33794965377, 8876.0, 8639.39524233304, 8756.124387561256, 8856.0, 8869.955650221707, 8872.245859101984, 32482.675173248437, 39271.41092883609, 39496.40755388672, 39703.60296397028, 39880.601193987975, 3083.5991321128336, 3278.016595021508, 3449.758516903818, 3477.600075991268, 3586.28274345132, 29607.407851842843, 29782.255443613867, 29962.25094372636, 29966.55050174249, 30103.247418814484, 4029.49631296088, 4060.1473690525027, 4092.9590704092875, 4111.444954931106, 4202.70581059326, 361052.0, 361476.0, 362308.0, 362319.0, 363998.0, 33120.66879331224, 59272.407275926686, 59588.0, 59892.401075989554, 60275.0, 34263.4860477093, 35903.64096359055, 35907.0, 36217.63782362143, 36225.45661815075, 13959.86040139606, 13985.3706583204, 14095.154290742588, 14108.717825643429, 14110.64723381903, 12854.67863303425, 12972.481100755864, 13036.41336139876, 13066.54267100647, 13074.542391016268, 8097.271245587807, 8176.918230817735, 8187.3040791533385, 8258.091609922903, 8275.83448331042, 3252.902412927616, 3286.9506957395656, 3289.687479689426, 3321.3191295784304, 3347.7991320520846, 998.1415982255255, 1002.9548670309707, 1053.2942928238099, 1063.7340664833791, 1148.4487446025787, 30369.696303036686, 30842.383152336828, 31065.534016989764, 31454.685453145634, 31798.2050448736, 1086.7717779266284, 1091.7871015152127, 1169.5555688838188, 1171.800793865045, 1200.4837919694442, 16237.51287461378, 16542.503724888273, 16572.419965301156, 16712.164391780363, 17005.48983530496, 518580.0, 521079.0, 522073.0, 523599.0, 523883.0, 55818.0, 57406.138907916415, 57656.71171644115, 57701.42298577044, 57784.71107644435, 1341.745068436994, 1357.8710022547841, 1367.4803574641771, 1375.1680233458615, 1385.2658091211674, 29421.705782942754, 30477.23806904845, 30687.539686905162, 30962.69037309688, 30994.0, 49233.75383123061, 49763.75118124386, 49809.75095124501, 49836.501634983186, 49934.75032624813, 330071.0, 335776.0, 335863.0, 337740.0, 339884.0, 27266.182014539594, 27587.724122758515, 27618.5857212146, 27624.447511050068, 27725.227477252112, 46598.53401465942, 47362.28956565723, 47614.523854762396, 48453.0, 48647.27029094637, 34461.0, 36303.45544816777, 36418.63581364152, 40307.1938561233, 40748.0, 38329.80835095807, 38440.231195376495, 38464.230715384976, 38549.0, 38727.6127238724, 35785.46321805227, 37377.43933841049, 39742.205155897296, 40440.0, 41174.382384264856, 34813.30373392467, 36757.0, 37027.62972370242, 37108.0, 37112.62887371092, 27961.860190698917, 28468.288292792848, 28559.857200713865, 28701.71298287074, 28855.134345969655], "value": 18306.508165285915, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.80752431308656, 394.378853306043, 394.9368101103824, 396.1759540156473, 422.18939635899073, 18289.451316460512, 19128.33050843221, 19396.127174277157, 19595.5101122472, 19719.30982415614, 17617.64764704705, 17812.910935445303, 17915.64168716628, 19080.427587172406, 19110.42668719937, 5590.105583106703, 5602.915956260659, 5629.634073785191, 5730.9426905730825, 5746.339170995348, 5650.208970744099, 5674.546036317085, 5690.0, 5719.456651618089, 5744.0, 5598.076317407623, 5672.404397538261, 5691.0, 5704.3154821421485, 5705.172749951254, 5629.6340737852115, 5656.971715141419, 5668.858278543028, 5693.686847223401, 5728.653766364901, 5019.723915184663, 5149.0474262261605, 5150.227465880111, 5151.407588127376, 5155.587552995751, 21213.151473941023, 22173.33479995603, 23006.19478318251, 23027.194048208232, 23040.65439018416, 2393.916212932539, 2404.1224952892067, 2555.1184841229747, 2722.537168681329, 2760.8205466644604, 14834.480793172188, 15230.314635841414, 15417.0, 15608.375664973388, 16172.75740863888, 1980.2475059477306, 2000.41987823531, 2030.67509198529, 2038.7451568553931, 2066.6590012648044, 91820.0, 92440.53779731058, 93930.53034734851, 97073.51463242709, 97153.0, 16774.154842967262, 17615.647687046443, 17819.73270400945, 17873.463796086136, 18062.729059063862, 30471.695283047327, 30794.0, 31144.844275778476, 31219.843900780805, 31307.843460783006, 9543.188828949616, 9610.135087842127, 10206.744831379276, 10250.436226007641, 10396.896031039592, 7831.530108193527, 7886.408519361071, 8254.133316001733, 8417.70538031166, 8473.894585267708, 8754.51850148248, 8844.248238899638, 8980.191782739585, 8997.955010224907, 9037.954810226038, 3439.040175237696, 3534.505169276303, 3572.6427357264065, 3572.711668196901, 3698.7780733156096, 447.93728877957113, 450.99098018039456, 453.80259587079723, 466.84594083952214, 846.7713717296295, 11843.0, 11911.702207444883, 11947.10396720232, 12067.215630983957, 12179.451924663412, 468.365364930521, 475.5316013726477, 485.37871524448764, 500.97244651544514, 514.4315531337818, 6215.34738852414, 6384.138141350951, 6437.259715132726, 6443.806685799434, 6477.676116194171, 417483.0, 419668.0, 432066.0, 439891.0, 441427.0, 87704.0, 88922.55538722264, 89456.6581501278, 89624.5518772402, 90845.54577227203, 462.4612326639495, 462.94213223347754, 464.88610290478374, 465.0373726386348, 470.64466327922884, 10448.68653940383, 10683.679489615324, 10697.465126743788, 10721.0, 10781.784364312512, 38236.617633823305, 38917.0, 39466.0, 40609.79695101506, 41194.176116478106, 55610.72194639001, 57489.0, 57592.84814303774, 57833.710831445576, 58220.08899554921, 8629.0, 8842.646294148419, 8917.751514787806, 8935.463872167691, 8944.68693595721, 10086.79826403453, 13441.395137218653, 13459.394327255493, 13540.526081587097, 13596.320183990958, 11459.31244125355, 11580.594679186188, 11634.12744044217, 11685.591004314809, 11794.351310677996, 11189.272697274651, 11247.381394023407, 11258.7748245033, 11448.82826757616, 11649.534018639159, 11632.592859249886, 11834.76330473403, 11904.464299106734, 11960.401979900797, 12184.0, 8762.693305734269, 8814.474210315924, 8830.116988301119, 9029.864552031857, 9075.682351117679, 8930.464172149692, 11047.171462140212, 11375.374354410587, 11551.671557770964, 11566.669832968979], "value": 9049.724352359342, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1447.3703938786625, 1476.3135142158894, 1578.8342224066473, 1702.982970170298, 1722.7415887616855, 6918.308169183079, 7644.655990480428, 7929.76210713678, 8083.91916080839, 8139.511629302246, 7959.164287749775, 8121.553314567696, 8183.508989460636, 8219.794505137375, 8251.257386835183, 2186.562687462506, 2226.944326391845, 2245.618244898363, 2255.8872056397195, 2256.7404748453973, 2215.9335219943428, 2236.910523579055, 2253.6281513550325, 2276.3967548599635, 2282.8858557072163, 2195.0, 2206.6689996500572, 2219.5893759654437, 2222.466608014081, 2241.831862610303, 2184.759676435599, 2198.2416066457045, 2198.703175071361, 2208.7459942106702, 2211.1708109458955, 2141.1328411993168, 2149.312220089572, 2152.7954844289766, 2160.2115227941845, 2161.211157927345, 8163.0, 8218.753437396888, 8279.875801862976, 8293.21214484623, 8378.078411374743, 4669.906601867978, 4722.1736196165875, 4722.527747225285, 4751.501092385284, 4764.261539461354, 3026.2585666511627, 3168.8732450702173, 3222.7099561039618, 3260.4294248506417, 3263.6573159818113, 1104.7956128116243, 1138.7153211697075, 1140.5608840596346, 1161.3380373187288, 1181.462434592267, 10471.63349282779, 10480.0, 10508.316959397614, 10548.156147508182, 10550.261481696207, 4181.790910454465, 4191.8532851350055, 4286.764227967492, 4316.935245971313, 4334.718243314174, 9039.63841446348, 9047.32145089121, 9051.773705657411, 9062.093790620886, 9093.136152065543, 4836.419629644395, 4842.322074909515, 4849.0, 4850.175470170079, 4859.1496488114435, 3830.0, 4348.043430445297, 4410.316400957857, 4455.6658250631335, 4617.053504031665, 3623.8912832615065, 3689.7232707546505, 3741.9625803741615, 3781.0925377909102, 3781.5084039074745, 1192.6243233381458, 1196.3001644038336, 1209.673388185185, 1236.8206610041493, 1240.2124650846777, 878.868169774539, 898.4788822482944, 964.508100868548, 981.7202097402206, 1027.5119318323887, 5495.148252020943, 5781.884362312814, 5853.795117170964, 5997.760089596454, 6013.067974463877, 434.6414208278183, 449.76162633804137, 456.5685427271263, 461.0801451105, 465.0605776331791, 4049.331860243086, 4111.259973204792, 4124.319487284624, 4163.417121602978, 4196.601322874383, 9768.0, 10025.699229023141, 10056.145227655732, 10207.030332118436, 10255.179585633132, 10030.899691003142, 10120.949395253125, 10124.645637402802, 10139.543720532594, 10179.0, 7699.036745629828, 7762.92237077622, 7809.648565814552, 7810.765677029698, 7826.178251283647, 5551.472610102034, 5831.35855055952, 5940.376260492586, 6003.429674180946, 6121.540884433774, 9143.634254630006, 9297.535123243675, 9364.063593640582, 9477.52612369365, 9534.666286679932, 9582.329236953625, 9622.326437149612, 9629.518524073908, 9657.951710241405, 9714.562844671866, 6496.480281577368, 7151.0, 7154.892676609959, 7236.276372362721, 7458.8508229834015, 8060.073091594541, 8086.555239461886, 8125.918740812516, 8172.468789528662, 8179.182081791773, 6969.477289203229, 7356.48504604694, 7593.0, 7649.541027538366, 7685.23147685227, 6827.48793840454, 7176.102987126609, 7187.7843664690145, 7188.0, 7196.496245262991, 6585.374389432996, 6625.403713665601, 6671.633060181736, 6689.76585819494, 6691.197056353269, 4143.19207754485, 4220.240356735817, 4321.2005778931, 4357.847475338348, 4381.298992161239, 4780.259059845729, 4885.9022819544125, 4888.780004899717, 4891.90216195667, 4950.480199578992], "value": 4280.707319588533, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.5032774363608, 326.8970274363576, 329.6719763834983, 337.75175246194027, 340.4977657954516, 5669.433056694324, 5696.6866822324755, 5723.141528770676, 5729.828105156842, 5751.626144300618, 5595.509998050869, 5616.466435688613, 5639.943600563993, 5643.181738647893, 5649.519790817775, 4146.606072423123, 4221.810018549173, 4328.913421731563, 4340.7395556266565, 4345.109252603209, 4299.118680670455, 4304.655627549804, 4323.978380108095, 4327.242732521812, 4329.350597410382, 4272.252355837716, 4336.327869180266, 4338.804753786071, 4350.651298097584, 4376.934345984812, 4235.682323825726, 4239.215745087154, 4307.073979094478, 4315.07225946423, 4350.084340388907, 3804.2771873343977, 3829.5021647185686, 3839.6928245740273, 3845.5000849889616, 3852.595477474853, 5385.542228910547, 5459.0, 5465.289512363407, 5473.972630136864, 5498.0, 4902.681325713817, 5005.3242812220615, 5005.424376196711, 5012.824551140692, 5019.673721208146, 5666.4050274721385, 5670.234518340013, 5713.714314284311, 5831.650100993911, 5846.415358464162, 4161.854335098257, 4178.6657067434535, 4212.199682060399, 4235.0682849773, 4244.236037513247, 5843.415658434165, 5939.70301484924, 5976.133460648225, 6013.444286178356, 6041.6375017499095, 4261.975561608211, 4267.97866010668, 4274.978625106917, 4288.935665965013, 4309.612134907873, 4300.526942036374, 4320.157569274024, 4342.609165175149, 4344.892052526586, 4344.9348259776125, 4816.759162041884, 4940.604751619861, 4949.752512374367, 4965.255211718271, 4977.601791856643, 5866.2373891393845, 5878.5297176225795, 5900.940990590125, 5904.61619994699, 5933.554983376178, 1512.8108986376703, 1520.1791032842361, 1531.1349087765377, 1536.05532597454, 1536.508317338441, 962.9662961796444, 968.6706519783307, 985.1724551376877, 992.6029588164647, 998.6754304850807, 5527.972360138174, 5549.445055494499, 5588.161775733591, 5589.664620122806, 5638.718064096779, 5891.911621325684, 5908.527317814564, 5926.733297001645, 5967.850803729854, 5991.670458124845, 5382.757775900094, 5531.814933101403, 5711.742971566289, 5715.885682286331, 5742.54059675225, 3180.936381272362, 3234.1106195795874, 3248.902532924016, 3255.967440325614, 3260.2012506935953, 6035.215421995113, 6157.784477543264, 6242.313345531988, 6258.340205412682, 6265.8120256392385, 6161.815145545641, 6172.259328880563, 6215.192025036717, 6230.348957526259, 6247.75008999644, 6097.878042439126, 6196.721147548371, 6210.596311239845, 6216.285127210338, 6229.53933196394, 6000.279966404059, 6014.578979471395, 6021.42796434338, 6049.909251361321, 6074.301455332693, 5891.528677705687, 5964.642121472725, 5998.34018258, 6018.4884284834525, 6071.787487437919, 5830.941690583039, 6165.506759459322, 6178.258608966773, 6229.221347331583, 6277.403646653561, 4241.197491066347, 4285.314349704033, 4290.227759003409, 4293.463317085364, 4294.0, 5918.378570250234, 5995.46040856325, 6020.729067192075, 6022.54830887694, 6056.576039677357, 5828.6211396259105, 5832.300123985149, 5846.94153058464, 5863.17915491823, 5868.178455016216, 5750.942490575041, 5768.365479797135, 5783.884322313615, 5847.918135145012, 5855.59010869235, 5188.766505507337, 5703.372629010889, 5727.856803579777, 5742.19609254713, 5830.679312637845, 5808.332041815076, 5841.620294680833, 5882.323532793613, 5900.763969441175, 5901.29184497863, 5523.917141242965, 5744.684042377709, 5817.94182058174, 5832.154337621106, 5894.557908156819], "value": 4458.709893228509, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.836713372357, 734.8493558820443, 758.7951253161647, 797.2864286463615, 838.0906716212909, 15556.688866222683, 15888.126153061577, 16013.919930400332, 16306.83693163068, 16504.504864854043, 14508.854911450882, 14643.853561464382, 14659.92670036651, 14675.77986330206, 14678.119312841238, 791.7545560876118, 802.8434455281223, 802.9397795165356, 811.0794248527905, 823.4812068396901, 799.5362689639995, 805.5368163306093, 806.995965020177, 809.2029351089172, 809.4050872608628, 839.7270886961762, 846.3398549131656, 849.0660273698912, 852.1563651984553, 852.8635418333068, 831.2726364431123, 837.401258100458, 841.0202114536588, 843.9831203375898, 845.8477474054667, 609.1958614628692, 616.2697203813451, 618.3661746709614, 619.1888625900085, 619.5446346934999, 15947.202639868075, 16009.519714408587, 16064.919675401548, 16145.757813632805, 16153.91923040389, 13997.160170389809, 14043.0, 14343.928280358636, 14367.13797172173, 14423.0, 11975.101867359983, 12055.879441205563, 12171.573994910224, 12261.509539618404, 12279.079069069856, 3797.1646237827636, 3847.8653247136494, 3853.910148101523, 3896.08442016126, 4096.9795151024355, 74272.62863685648, 75090.24909750887, 76068.61965690191, 76179.6191019047, 76556.0, 11125.72185695348, 11213.831792523119, 11705.297682139098, 11777.764444711229, 11830.349330786888, 22584.0966361347, 22595.661065084038, 22664.320070397913, 22717.88641056817, 22912.541749165255, 7983.880241796378, 8170.0, 8202.466839655403, 8620.870686939701, 8917.509536975398, 4781.330613714083, 4944.802207911715, 4950.232713929347, 4980.526849949249, 5115.411727651293, 3438.1404648837793, 3574.37448446526, 3577.856885724542, 3578.499010138583, 3598.7480876338404, 617.3301967365459, 617.7714245729019, 623.2894500269696, 627.1282916745727, 634.3086036220542, 632.788016014631, 648.597869321024, 658.4830907737403, 672.1832972937904, 681.7818298144546, 8380.706675266458, 8965.193132618097, 9232.53837308132, 9431.764205894908, 9442.686541797166, 596.1147695671924, 606.9059295809157, 615.9630422174683, 646.2277578293894, 650.7559665125578, 4388.5162541303425, 4389.956100439019, 4414.161309351213, 4466.865994020184, 4550.886227844264, 113667.0, 114406.0, 115175.0, 116448.0, 116850.0, 81754.18245817584, 84763.57618211993, 103069.0, 103412.0, 105861.47069264605, 64556.03165952514, 66373.0, 88244.5587772057, 92905.0, 96220.51889740507, 8779.429337093325, 9694.00390296099, 9706.611735530782, 9773.31586788918, 9789.058004087723, 38078.619213807506, 45863.31205031861, 46348.53651463442, 47337.763311183226, 47664.761676191396, 66125.0, 67292.66353668396, 67667.0, 67746.66126669335, 68407.0, 12867.099303049072, 12888.291143987171, 13030.869691302965, 13428.798568021683, 13457.405871122883, 13055.151415157985, 13059.738805224033, 13139.54011609589, 13267.66830829237, 13275.40260688252, 13154.34228288601, 13273.734525309634, 13296.667583310495, 13501.662458438617, 13790.931045344709, 13144.0, 13470.595882123553, 13490.0, 13514.662133446742, 13567.0, 13260.734785304432, 13475.528356507475, 13509.392077356346, 13511.121777084458, 13527.729445411234, 10637.734056648645, 10649.148068154374, 10696.0, 10781.784364312512, 11664.0, 10654.8934510657, 10993.945030274797, 11134.721631959266, 11148.721281968015, 11240.83138752903], "value": 7426.6618039006225, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1552.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 106.0, 112.0, 111.0, 112.0, 113.0, 112.0, 111.0, 110.0, 111.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 130.0, 156.0, 181.0, 127.0, 165.0, 166.0, 128.0, 179.0, 127.0], "value": 152.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 163.0, 165.0, 171.0, 165.0, 166.0, 169.0, 163.0, 165.0], "value": 165.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 163.0, 77.0, 76.0, 77.0, 77.0, 164.0, 76.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 151.0, 87.0, 85.0, 86.0, 154.0, 87.0, 86.0, 140.0], "value": 104.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 120.0, 118.0, 118.0, 118.0, 118.0, 119.0, 118.0, 119.0, 118.0], "value": 118.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 149.0, 147.0, 147.0, 146.0, 148.0, 148.0, 146.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 101.0, 96.0, 97.0, 98.0, 97.0, 96.0, 97.0], "value": 96.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 55.0, 54.0, 57.0, 57.0, 55.0, 55.0, 55.0, 55.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 60.0, 63.0, 62.0, 62.0, 63.0, 64.0, 62.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 80.0, 82.0, 82.0, 80.0, 81.0, 86.0, 107.0, 81.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 124.0, 127.0, 129.0, 122.0, 140.0, 133.0, 124.0, 136.0, 129.0], "value": 128.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 160.0, 164.0, 164.0, 166.0, 165.0, 169.0, 159.0, 163.0, 164.0], "value": 164.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 64.0, 69.0, 64.0, 65.0, 64.0, 65.0, 68.0], "value": 66.2, "unit": "score"}]}]} 18:09:45 INFO - Return code: 0 18:09:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:09:45 ERROR - # TBPL SUCCESS # 18:09:45 INFO - Running post-action listener: _resource_record_post_action 18:09:45 INFO - ##### 18:09:45 INFO - ##### Finished run-tests step (success) 18:09:45 INFO - ##### 18:09:45 INFO - Running post-run listener: _resource_record_post_run 18:09:45 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 12288; Write bytes: 403288064; Read time: 320; Write time: 342748 18:09:45 INFO - TinderboxPrint: CPU usage
13.5% 18:09:45 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 320 18:09:45 INFO - TinderboxPrint: I/O write bytes / time
403,288,064 / 342,748 18:09:45 INFO - TinderboxPrint: CPU idle
8,217.0 (86.5%) 18:09:45 INFO - TinderboxPrint: CPU user
1,224.9 (12.9%) 18:09:45 INFO - TinderboxPrint: Swap in / out
0 / 0 18:09:45 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 108376064; Read time: 0; Write time: 97660 18:09:45 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 12288; Write bytes: 294912000; Read time: 320; Write time: 245088 18:09:46 INFO - Running post-run listener: _upload_blobber_files 18:09:46 INFO - Blob upload gear active. 18:09:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:09:46 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 18:09:46 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'] 18:09:46 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 18:09:46 INFO - (blobuploader) - INFO - Open directory for files ... 18:09:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:09:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:09:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:09:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:09:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:09:47 INFO - (blobuploader) - INFO - Done attempting. 18:09:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:09:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:09:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:09:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:09:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:09:51 INFO - (blobuploader) - INFO - Done attempting. 18:09:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:09:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:09:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:09:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:09:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:09:52 INFO - (blobuploader) - INFO - Done attempting. 18:09:52 INFO - (blobuploader) - INFO - Iteration through files over. 18:09:52 INFO - Return code: 0 18:09:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:09:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:09:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d2b2911cdd58de4d44b69c1afa2a75fd81fbe434d1ece00962818d4cc580a882593a28add763a4972727150edc5e08fb183bbee3b8538733100b05dff63cbde9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e500addd821284643f2eb999b1b6f81b662fa57dbca9b3344cbf02c554201e740c9708d91140eac0db1c351345d6f94bc185db3b1618c3c7126f0a17429d8fff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7b548e05d3962f12a1776fce9c6905d3f93345c1eadd73295dbb901c36b5dd96b8f859c9e77152f33f5047076290f5ccf0eb16ba50995cc25a2353bf98070c40"} 18:09:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:09:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:09:52 INFO - Contents: 18:09:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d2b2911cdd58de4d44b69c1afa2a75fd81fbe434d1ece00962818d4cc580a882593a28add763a4972727150edc5e08fb183bbee3b8538733100b05dff63cbde9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e500addd821284643f2eb999b1b6f81b662fa57dbca9b3344cbf02c554201e740c9708d91140eac0db1c351345d6f94bc185db3b1618c3c7126f0a17429d8fff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7b548e05d3962f12a1776fce9c6905d3f93345c1eadd73295dbb901c36b5dd96b8f859c9e77152f33f5047076290f5ccf0eb16ba50995cc25a2353bf98070c40"} 18:09:52 INFO - Running post-run listener: copy_logs_to_upload_dir 18:09:52 INFO - Copying logs to upload dir... 18:09:52 INFO - mkdir: /builds/slave/test/build/upload/logs 18:09:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1364.549371 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 44 secs) (at 2016-06-15 18:09:50.368046) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-15 18:09:50.371762) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1466033728.788593-639538985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d2b2911cdd58de4d44b69c1afa2a75fd81fbe434d1ece00962818d4cc580a882593a28add763a4972727150edc5e08fb183bbee3b8538733100b05dff63cbde9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e500addd821284643f2eb999b1b6f81b662fa57dbca9b3344cbf02c554201e740c9708d91140eac0db1c351345d6f94bc185db3b1618c3c7126f0a17429d8fff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7b548e05d3962f12a1776fce9c6905d3f93345c1eadd73295dbb901c36b5dd96b8f859c9e77152f33f5047076290f5ccf0eb16ba50995cc25a2353bf98070c40"} build_url:https://queue.taskcluster.net/v1/task/N868x4RNQuKiKY4ykh02Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011544 build_url: 'https://queue.taskcluster.net/v1/task/N868x4RNQuKiKY4ykh02Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d2b2911cdd58de4d44b69c1afa2a75fd81fbe434d1ece00962818d4cc580a882593a28add763a4972727150edc5e08fb183bbee3b8538733100b05dff63cbde9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e500addd821284643f2eb999b1b6f81b662fa57dbca9b3344cbf02c554201e740c9708d91140eac0db1c351345d6f94bc185db3b1618c3c7126f0a17429d8fff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7b548e05d3962f12a1776fce9c6905d3f93345c1eadd73295dbb901c36b5dd96b8f859c9e77152f33f5047076290f5ccf0eb16ba50995cc25a2353bf98070c40"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-15 18:09:50.398026) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 18:09:50.398460) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1466033728.788593-639538985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004458 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 18:09:50.480717) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-15 18:09:50.481073) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-15 18:09:50.481498) ========= ========= Total master_lag: 0.22 =========