builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-039 starttime: 1469722562.15 results: success (0) buildid: 20160728083825 builduid: c43f57b0146341ab9fee591d6c9f8cc6 revision: f10815c6925054c5a46596ff95d7ef41ab8951b5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 09:16:02.155311) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 09:16:02.155756) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 09:16:02.156030) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 09:16:02.170820) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 09:16:02.171143) ========= 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=5bd038846534b2fdfa68eeae000001e2-1469722103.606545-1003784098 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-28 09:16:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.8M=0s 2016-07-28 09:16:02 (37.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124368 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 09:16:02.310270) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 09:16:02.310597) ========= 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=5bd038846534b2fdfa68eeae000001e2-1469722103.606545-1003784098 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019117 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 09:16:02.377138) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-28 09:16:02.377490) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f10815c6925054c5a46596ff95d7ef41ab8951b5 --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 f10815c6925054c5a46596ff95d7ef41ab8951b5 --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=5bd038846534b2fdfa68eeae000001e2-1469722103.606545-1003784098 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-28 09:16:02,551 truncating revision to first 12 chars 2016-07-28 09:16:02,551 Setting DEBUG logging. 2016-07-28 09:16:02,551 attempt 1/10 2016-07-28 09:16:02,551 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f10815c69250?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-28 09:16:02,870 unpacking tar archive at: fx-team-f10815c69250/testing/mozharness/ program finished with exit code 0 elapsedTime=0.639938 ========= master_lag: 1.29 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-28 09:16:04.304476) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 09:16:04.304755) ========= script_repo_revision: f10815c6925054c5a46596ff95d7ef41ab8951b5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 09:16:04.305112) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 09:16:04.305423) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 09:16:04.374764) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-07-28 09:16:04.375068) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5bd038846534b2fdfa68eeae000001e2-1469722103.606545-1003784098 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:16:04 INFO - MultiFileLogger online at 20160728 09:16:04 in /builds/slave/test 09:16:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 09:16:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:16:04 INFO - {'append_to_log': False, 09:16:04 INFO - 'base_work_dir': '/builds/slave/test', 09:16:04 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:16:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:16:04 INFO - 'branch': 'Fx-Team-Non-PGO', 09:16:04 INFO - 'buildbot_json_path': 'buildprops.json', 09:16:04 INFO - 'config_files': ('talos/linux_config.py',), 09:16:04 INFO - 'default_actions': ('clobber', 09:16:04 INFO - 'read-buildbot-config', 09:16:04 INFO - 'download-and-extract', 09:16:04 INFO - 'populate-webroot', 09:16:04 INFO - 'create-virtualenv', 09:16:04 INFO - 'install', 09:16:04 INFO - 'run-tests'), 09:16:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:16:04 INFO - 'download_minidump_stackwalk': True, 09:16:04 INFO - 'download_symbols': 'ondemand', 09:16:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:16:04 INFO - 'tooltool.py': '/tools/tooltool.py', 09:16:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:16:04 INFO - '/tools/misc-python/virtualenv.py')}, 09:16:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:16:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:16:04 INFO - 'installer_path': 'installer.exe', 09:16:04 INFO - 'log_level': 'info', 09:16:04 INFO - 'log_name': 'talos', 09:16:04 INFO - 'log_to_console': True, 09:16:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:16:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:16:04 INFO - 'opt_config_files': (), 09:16:04 INFO - 'pip_index': False, 09:16:04 INFO - 'sps_profile': False, 09:16:04 INFO - 'sps_profile_interval': 0, 09:16:04 INFO - 'suite': 'dromaeojs', 09:16:04 INFO - 'system_bits': '32', 09:16:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:16:04 INFO - 'title': 'talos-linux64-ix-039', 09:16:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:16:04 INFO - 'use_talos_json': True, 09:16:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:16:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:16:04 INFO - 'work_dir': 'build'} 09:16:04 INFO - [mozharness: 2016-07-28 16:16:04.644196Z] Running clobber step. 09:16:04 INFO - Running pre-action listener: _resource_record_pre_action 09:16:04 INFO - Running main action method: clobber 09:16:04 INFO - rmtree: /builds/slave/test/build 09:16:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:16:05 INFO - Running post-action listener: _resource_record_post_action 09:16:05 INFO - [mozharness: 2016-07-28 16:16:05.615437Z] Finished clobber step (success) 09:16:05 INFO - [mozharness: 2016-07-28 16:16:05.615538Z] Running read-buildbot-config step. 09:16:05 INFO - Running pre-action listener: _resource_record_pre_action 09:16:05 INFO - Running main action method: read_buildbot_config 09:16:05 INFO - Using buildbot properties: 09:16:05 INFO - { 09:16:05 INFO - "project": "", 09:16:05 INFO - "product": "firefox", 09:16:05 INFO - "script_repo_revision": "production", 09:16:05 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:16:05 INFO - "repository": "", 09:16:05 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 09:16:05 INFO - "buildid": "20160728083825", 09:16:05 INFO - "pgo_build": "False", 09:16:05 INFO - "basedir": "/builds/slave/test", 09:16:05 INFO - "buildnumber": 2029, 09:16:05 INFO - "slavename": "talos-linux64-ix-039", 09:16:05 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:16:05 INFO - "platform": "ubuntu64_hw", 09:16:05 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:16:05 INFO - "branch": "fx-team", 09:16:05 INFO - "repo_path": "integration/fx-team", 09:16:05 INFO - "revision": "f10815c6925054c5a46596ff95d7ef41ab8951b5", 09:16:05 INFO - "stage_platform": "linux64", 09:16:05 INFO - "builduid": "c43f57b0146341ab9fee591d6c9f8cc6", 09:16:05 INFO - "slavebuilddir": "test" 09:16:05 INFO - } 09:16:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/WJ4YQRL-S1W0MXW5E5IF2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 09:16:05 INFO - Running post-action listener: _resource_record_post_action 09:16:05 INFO - [mozharness: 2016-07-28 16:16:05.617969Z] Finished read-buildbot-config step (success) 09:16:05 INFO - [mozharness: 2016-07-28 16:16:05.618058Z] Running download-and-extract step. 09:16:05 INFO - Running pre-action listener: _resource_record_pre_action 09:16:05 INFO - Running main action method: download_and_extract 09:16:05 INFO - mkdir: /builds/slave/test/build/tests 09:16:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:05 INFO - https://queue.taskcluster.net/v1/task/WJ4YQRL-S1W0MXW5E5IF2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:16:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WJ4YQRL-S1W0MXW5E5IF2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:16:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WJ4YQRL-S1W0MXW5E5IF2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:16:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WJ4YQRL-S1W0MXW5E5IF2A/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 09:16:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WJ4YQRL-S1W0MXW5E5IF2A/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 09:16:07 INFO - Downloaded 1361 bytes. 09:16:07 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:16:07 INFO - Using the following test package requirements: 09:16:07 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:16:07 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:16:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:16:07 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:16:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:16:07 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:16:07 INFO - u'jsshell-linux-x86_64.zip'], 09:16:07 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:16:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:16:07 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:16:07 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:16:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:16:07 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:16:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:16:07 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:16:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:16:07 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:16:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:16:07 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:16:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:07 INFO - https://queue.taskcluster.net/v1/task/WJ4YQRL-S1W0MXW5E5IF2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:16:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WJ4YQRL-S1W0MXW5E5IF2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:16:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WJ4YQRL-S1W0MXW5E5IF2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:16:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WJ4YQRL-S1W0MXW5E5IF2A/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 09:16:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WJ4YQRL-S1W0MXW5E5IF2A/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 09:16:09 INFO - Downloaded 22746624 bytes. 09:16:09 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'] 09:16:09 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 09:16:10 INFO - Return code: 0 09:16:10 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 09:16:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:10 INFO - https://queue.taskcluster.net/v1/task/WJ4YQRL-S1W0MXW5E5IF2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:16:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WJ4YQRL-S1W0MXW5E5IF2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:16:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WJ4YQRL-S1W0MXW5E5IF2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:16:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WJ4YQRL-S1W0MXW5E5IF2A/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 09:16:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WJ4YQRL-S1W0MXW5E5IF2A/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 09:16:15 INFO - Downloaded 22746624 bytes. 09:16:15 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'] 09:16:15 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 09:16:16 INFO - Return code: 0 09:16:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:16 INFO - https://queue.taskcluster.net/v1/task/WJ4YQRL-S1W0MXW5E5IF2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:16:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WJ4YQRL-S1W0MXW5E5IF2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:16:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WJ4YQRL-S1W0MXW5E5IF2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:16:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WJ4YQRL-S1W0MXW5E5IF2A/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 09:16:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WJ4YQRL-S1W0MXW5E5IF2A/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 09:16:17 INFO - Downloaded 14413725 bytes. 09:16:17 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'] 09:16:17 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 09:16:17 INFO - Return code: 0 09:16:17 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')]} 09:16:17 INFO - https://queue.taskcluster.net/v1/task/WJ4YQRL-S1W0MXW5E5IF2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:16:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WJ4YQRL-S1W0MXW5E5IF2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:16:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WJ4YQRL-S1W0MXW5E5IF2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:16:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WJ4YQRL-S1W0MXW5E5IF2A/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 09:16:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WJ4YQRL-S1W0MXW5E5IF2A/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 09:16:19 INFO - Downloaded 57154346 bytes. 09:16:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WJ4YQRL-S1W0MXW5E5IF2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:16:19 INFO - mkdir: /builds/slave/test/properties 09:16:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:16:19 INFO - Writing to file /builds/slave/test/properties/build_url 09:16:19 INFO - Contents: 09:16:19 INFO - build_url:https://queue.taskcluster.net/v1/task/WJ4YQRL-S1W0MXW5E5IF2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:16:19 INFO - Running post-action listener: _resource_record_post_action 09:16:19 INFO - Running post-action listener: set_extra_try_arguments 09:16:19 INFO - [mozharness: 2016-07-28 16:16:19.890998Z] Finished download-and-extract step (success) 09:16:19 INFO - [mozharness: 2016-07-28 16:16:19.891231Z] Running populate-webroot step. 09:16:19 INFO - Running pre-action listener: _resource_record_pre_action 09:16:19 INFO - Running main action method: populate_webroot 09:16:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:16:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:16:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:16:19 INFO - '--tppagecycles', 09:16:19 INFO - '7'], 09:16:19 INFO - 'tests': ['tsvgm']}}, 09:16:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:16:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:16:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:16:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:16:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:16:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:16:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:19 INFO - 'talos_options': ['--disable-e10s'], 09:16:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:16:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:16:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:19 INFO - 'talos_options': ['--disable-e10s'], 09:16:19 INFO - 'tests': ['damp', 'tps']}, 09:16:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:19 INFO - 'tests': ['damp', 'tps']}, 09:16:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:16:19 INFO - 'tests': ['dromaeo_dom']}, 09:16:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:16:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:16:19 INFO - 'tests': ['basic_compositor_video']}, 09:16:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:16:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:16:19 INFO - 'tests': ['a11yr', 09:16:19 INFO - 'ts_paint', 09:16:19 INFO - 'tpaint', 09:16:19 INFO - 'sessionrestore', 09:16:19 INFO - 'sessionrestore_no_auto_restore', 09:16:19 INFO - 'tabpaint']}, 09:16:19 INFO - 'other-e10s': {'tests': ['a11yr', 09:16:19 INFO - 'ts_paint', 09:16:19 INFO - 'tpaint', 09:16:19 INFO - 'sessionrestore', 09:16:19 INFO - 'sessionrestore_no_auto_restore', 09:16:19 INFO - 'tabpaint']}, 09:16:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:16:19 INFO - 'ts_paint', 09:16:19 INFO - 'tpaint', 09:16:19 INFO - 'sessionrestore', 09:16:19 INFO - 'sessionrestore_no_auto_restore', 09:16:19 INFO - 'tabpaint']}, 09:16:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:16:19 INFO - 'ts_paint', 09:16:19 INFO - 'tpaint', 09:16:19 INFO - 'sessionrestore', 09:16:19 INFO - 'sessionrestore_no_auto_restore', 09:16:19 INFO - 'tabpaint']}, 09:16:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:16:19 INFO - 'tests': ['a11yr', 09:16:19 INFO - 'ts_paint', 09:16:19 INFO - 'tpaint', 09:16:19 INFO - 'sessionrestore', 09:16:19 INFO - 'sessionrestore_no_auto_restore', 09:16:19 INFO - 'tabpaint']}, 09:16:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:16:19 INFO - 'tests': ['a11yr', 09:16:19 INFO - 'ts_paint', 09:16:19 INFO - 'tpaint', 09:16:19 INFO - 'sessionrestore', 09:16:19 INFO - 'sessionrestore_no_auto_restore', 09:16:19 INFO - 'tabpaint']}, 09:16:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:16:19 INFO - 'tests': ['tsvgx', 09:16:19 INFO - 'tsvgr_opacity', 09:16:19 INFO - 'tart', 09:16:19 INFO - 'tscrollx', 09:16:19 INFO - 'cart']}, 09:16:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:16:19 INFO - 'tsvgr_opacity', 09:16:19 INFO - 'tart', 09:16:19 INFO - 'tscrollx', 09:16:19 INFO - 'cart']}, 09:16:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:19 INFO - 'talos_options': ['--disable-e10s'], 09:16:19 INFO - 'tests': ['tp5o']}, 09:16:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:19 INFO - 'tests': ['tp5o']}, 09:16:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:19 INFO - 'talos_options': ['--disable-e10s', 09:16:19 INFO - '--xperf_path', 09:16:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:16:19 INFO - 'tests': ['tp5n']}, 09:16:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:19 INFO - 'talos_options': ['--xperf_path', 09:16:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:16:19 INFO - 'tests': ['tp5n']}}, 09:16:19 INFO - 'talos.zip': {'path': '', 09:16:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:16:19 INFO - Running post-action listener: _resource_record_post_action 09:16:19 INFO - [mozharness: 2016-07-28 16:16:19.911862Z] Finished populate-webroot step (success) 09:16:19 INFO - [mozharness: 2016-07-28 16:16:19.911951Z] Running create-virtualenv step. 09:16:19 INFO - Running pre-action listener: _resource_record_pre_action 09:16:19 INFO - Running main action method: create_virtualenv 09:16:19 INFO - Creating virtualenv /builds/slave/test/build/venv 09:16:19 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 09:16:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:16:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:16:20 INFO - Using real prefix '/usr' 09:16:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:16:20 INFO - Installing distribute.............................................................................................................................................................................................done. 09:16:22 INFO - Installing pip.................done. 09:16:22 INFO - Return code: 0 09:16:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:16:22 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')]} 09:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:22 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')]} 09:16:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:22 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 0x1732030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f13b0>, '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 0x19f22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f2740>, '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': '5bd038846534b2fdfa68eeae000001e2-1469722103.606545-1003784098', '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 09:16:22 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 09:16:22 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 09:16:22 INFO - Using env: {'DISPLAY': ':0', 09:16:22 INFO - 'HOME': '/home/cltbld', 09:16:22 INFO - 'LANG': 'en_US.UTF-8', 09:16:22 INFO - 'LANGUAGE': 'en_US:en', 09:16:22 INFO - 'LOGNAME': 'cltbld', 09:16:22 INFO - 'MAIL': '/var/mail/cltbld', 09:16:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:22 INFO - 'MOZ_NO_REMOTE': '1', 09:16:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:22 INFO - 'NO_EM_RESTART': '1', 09:16:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:22 INFO - 'PWD': '/builds/slave/test', 09:16:22 INFO - 'SHELL': '/bin/bash', 09:16:22 INFO - 'SHLVL': '1', 09:16:22 INFO - 'TERM': 'linux', 09:16:22 INFO - 'TMOUT': '86400', 09:16:22 INFO - 'USER': 'cltbld', 09:16:22 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1469722103.606545-1003784098', 09:16:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:22 INFO - '_': '/tools/buildbot/bin/python'} 09:16:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:22 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 09:16:22 INFO - Cleaning up... 09:16:22 INFO - Return code: 0 09:16:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:16:22 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')]} 09:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:22 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')]} 09:16:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:22 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 0x1732030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f13b0>, '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 0x19f22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f2740>, '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': '5bd038846534b2fdfa68eeae000001e2-1469722103.606545-1003784098', '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 09:16:22 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 09:16:22 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 09:16:22 INFO - Using env: {'DISPLAY': ':0', 09:16:22 INFO - 'HOME': '/home/cltbld', 09:16:22 INFO - 'LANG': 'en_US.UTF-8', 09:16:22 INFO - 'LANGUAGE': 'en_US:en', 09:16:22 INFO - 'LOGNAME': 'cltbld', 09:16:22 INFO - 'MAIL': '/var/mail/cltbld', 09:16:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:22 INFO - 'MOZ_NO_REMOTE': '1', 09:16:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:22 INFO - 'NO_EM_RESTART': '1', 09:16:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:22 INFO - 'PWD': '/builds/slave/test', 09:16:22 INFO - 'SHELL': '/bin/bash', 09:16:22 INFO - 'SHLVL': '1', 09:16:22 INFO - 'TERM': 'linux', 09:16:22 INFO - 'TMOUT': '86400', 09:16:22 INFO - 'USER': 'cltbld', 09:16:22 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1469722103.606545-1003784098', 09:16:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:22 INFO - '_': '/tools/buildbot/bin/python'} 09:16:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:23 INFO - Downloading/unpacking psutil>=3.1.1 09:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:16:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:16:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:16:25 INFO - Installing collected packages: psutil 09:16:25 INFO - Running setup.py install for psutil 09:16:25 INFO - building 'psutil._psutil_linux' extension 09:16:25 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 09:16:25 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 09:16:25 INFO - building 'psutil._psutil_posix' extension 09:16:25 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 09:16:25 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 09:16:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:16:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:16:25 INFO - Successfully installed psutil 09:16:25 INFO - Cleaning up... 09:16:25 INFO - Return code: 0 09:16:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1732030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f13b0>, '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 0x19f22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f2740>, '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': '5bd038846534b2fdfa68eeae000001e2-1469722103.606545-1003784098', '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 09:16:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:16:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:16:25 INFO - Using env: {'DISPLAY': ':0', 09:16:25 INFO - 'HOME': '/home/cltbld', 09:16:25 INFO - 'LANG': 'en_US.UTF-8', 09:16:25 INFO - 'LANGUAGE': 'en_US:en', 09:16:25 INFO - 'LOGNAME': 'cltbld', 09:16:25 INFO - 'MAIL': '/var/mail/cltbld', 09:16:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:25 INFO - 'MOZ_NO_REMOTE': '1', 09:16:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:25 INFO - 'NO_EM_RESTART': '1', 09:16:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:25 INFO - 'PWD': '/builds/slave/test', 09:16:25 INFO - 'SHELL': '/bin/bash', 09:16:25 INFO - 'SHLVL': '1', 09:16:25 INFO - 'TERM': 'linux', 09:16:25 INFO - 'TMOUT': '86400', 09:16:25 INFO - 'USER': 'cltbld', 09:16:25 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1469722103.606545-1003784098', 09:16:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:25 INFO - '_': '/tools/buildbot/bin/python'} 09:16:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:16:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:16:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:16:27 INFO - Installing collected packages: mozsystemmonitor 09:16:27 INFO - Running setup.py install for mozsystemmonitor 09:16:27 INFO - Successfully installed mozsystemmonitor 09:16:27 INFO - Cleaning up... 09:16:27 INFO - Return code: 0 09:16:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:27 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 0x1732030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f13b0>, '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 0x19f22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f2740>, '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': '5bd038846534b2fdfa68eeae000001e2-1469722103.606545-1003784098', '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 09:16:27 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 09:16:27 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 09:16:27 INFO - Using env: {'DISPLAY': ':0', 09:16:27 INFO - 'HOME': '/home/cltbld', 09:16:27 INFO - 'LANG': 'en_US.UTF-8', 09:16:27 INFO - 'LANGUAGE': 'en_US:en', 09:16:27 INFO - 'LOGNAME': 'cltbld', 09:16:27 INFO - 'MAIL': '/var/mail/cltbld', 09:16:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:27 INFO - 'MOZ_NO_REMOTE': '1', 09:16:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:27 INFO - 'NO_EM_RESTART': '1', 09:16:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:27 INFO - 'PWD': '/builds/slave/test', 09:16:27 INFO - 'SHELL': '/bin/bash', 09:16:27 INFO - 'SHLVL': '1', 09:16:27 INFO - 'TERM': 'linux', 09:16:27 INFO - 'TMOUT': '86400', 09:16:27 INFO - 'USER': 'cltbld', 09:16:27 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1469722103.606545-1003784098', 09:16:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:27 INFO - '_': '/tools/buildbot/bin/python'} 09:16:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:28 INFO - Downloading/unpacking jsonschema==2.5.1 09:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:16:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:16:30 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 09:16:30 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 09:16:30 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 09:16:30 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 09:16:30 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 09:16:30 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 09:16:30 INFO - Downloading functools32-3.2.3-2.tar.gz 09:16:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:16:30 INFO - warning: no files found matching '*.txt' 09:16:30 INFO - no previously-included directories found matching 'build' 09:16:30 INFO - no previously-included directories found matching 'dist' 09:16:30 INFO - no previously-included directories found matching '.git*' 09:16:30 INFO - Installing collected packages: jsonschema, functools32 09:16:30 INFO - Running setup.py install for functools32 09:16:30 INFO - warning: no files found matching '*.txt' 09:16:30 INFO - no previously-included directories found matching 'build' 09:16:30 INFO - no previously-included directories found matching 'dist' 09:16:30 INFO - no previously-included directories found matching '.git*' 09:16:30 INFO - Successfully installed jsonschema functools32 09:16:30 INFO - Cleaning up... 09:16:30 INFO - Return code: 0 09:16:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:16: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')]} 09:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16: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')]} 09:16:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16: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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1732030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f13b0>, '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 0x19f22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f2740>, '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': '5bd038846534b2fdfa68eeae000001e2-1469722103.606545-1003784098', '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 09:16: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:16: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 functools32==3.2.3-2 09:16:30 INFO - Using env: {'DISPLAY': ':0', 09:16:30 INFO - 'HOME': '/home/cltbld', 09:16:30 INFO - 'LANG': 'en_US.UTF-8', 09:16:30 INFO - 'LANGUAGE': 'en_US:en', 09:16:30 INFO - 'LOGNAME': 'cltbld', 09:16:30 INFO - 'MAIL': '/var/mail/cltbld', 09:16:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:30 INFO - 'MOZ_NO_REMOTE': '1', 09:16:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:30 INFO - 'NO_EM_RESTART': '1', 09:16:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:30 INFO - 'PWD': '/builds/slave/test', 09:16:30 INFO - 'SHELL': '/bin/bash', 09:16:30 INFO - 'SHLVL': '1', 09:16:30 INFO - 'TERM': 'linux', 09:16:30 INFO - 'TMOUT': '86400', 09:16:30 INFO - 'USER': 'cltbld', 09:16:30 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1469722103.606545-1003784098', 09:16:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:30 INFO - '_': '/tools/buildbot/bin/python'} 09:16:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:16:30 INFO - Cleaning up... 09:16:30 INFO - Return code: 0 09:16:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:16: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')]} 09:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16: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')]} 09:16:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16: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', '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 0x1732030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f13b0>, '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 0x19f22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f2740>, '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': '5bd038846534b2fdfa68eeae000001e2-1469722103.606545-1003784098', '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 09:16: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:16: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 blobuploader==1.2.4 09:16:30 INFO - Using env: {'DISPLAY': ':0', 09:16:30 INFO - 'HOME': '/home/cltbld', 09:16:30 INFO - 'LANG': 'en_US.UTF-8', 09:16:30 INFO - 'LANGUAGE': 'en_US:en', 09:16:30 INFO - 'LOGNAME': 'cltbld', 09:16:30 INFO - 'MAIL': '/var/mail/cltbld', 09:16:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:30 INFO - 'MOZ_NO_REMOTE': '1', 09:16:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:30 INFO - 'NO_EM_RESTART': '1', 09:16:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:30 INFO - 'PWD': '/builds/slave/test', 09:16:30 INFO - 'SHELL': '/bin/bash', 09:16:30 INFO - 'SHLVL': '1', 09:16:30 INFO - 'TERM': 'linux', 09:16:30 INFO - 'TMOUT': '86400', 09:16:30 INFO - 'USER': 'cltbld', 09:16:30 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1469722103.606545-1003784098', 09:16:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:30 INFO - '_': '/tools/buildbot/bin/python'} 09:16:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:30 INFO - Downloading/unpacking blobuploader==1.2.4 09:16:30 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 09:16:30 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 09:16:30 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 09:16:30 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 09:16:30 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 09:16:30 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 09:16:32 INFO - Downloading blobuploader-1.2.4.tar.gz 09:16:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:16:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:16:32 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 09:16:32 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 09:16:32 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 09:16:32 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 09:16:32 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 09:16:32 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 09:16:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:16:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:16:33 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 09:16:33 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 09:16:33 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 09:16:33 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 09:16:33 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 09:16:33 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 09:16:33 INFO - Downloading docopt-0.6.1.tar.gz 09:16:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:16:33 INFO - Installing collected packages: blobuploader, requests, docopt 09:16:33 INFO - Running setup.py install for blobuploader 09:16:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:16:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:16:33 INFO - Running setup.py install for requests 09:16:34 INFO - Running setup.py install for docopt 09:16:34 INFO - Successfully installed blobuploader requests docopt 09:16:34 INFO - Cleaning up... 09:16:34 INFO - Return code: 0 09:16:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:16: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')]} 09:16:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16: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')]} 09:16:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:34 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 0x1732030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f13b0>, '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 0x19f22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f2740>, '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': '5bd038846534b2fdfa68eeae000001e2-1469722103.606545-1003784098', '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 09:16:34 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 09:16:34 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 09:16:34 INFO - Using env: {'DISPLAY': ':0', 09:16:34 INFO - 'HOME': '/home/cltbld', 09:16:34 INFO - 'LANG': 'en_US.UTF-8', 09:16:34 INFO - 'LANGUAGE': 'en_US:en', 09:16:34 INFO - 'LOGNAME': 'cltbld', 09:16:34 INFO - 'MAIL': '/var/mail/cltbld', 09:16:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:34 INFO - 'MOZ_NO_REMOTE': '1', 09:16:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:34 INFO - 'NO_EM_RESTART': '1', 09:16:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:34 INFO - 'PWD': '/builds/slave/test', 09:16:34 INFO - 'SHELL': '/bin/bash', 09:16:34 INFO - 'SHLVL': '1', 09:16:34 INFO - 'TERM': 'linux', 09:16:34 INFO - 'TMOUT': '86400', 09:16:34 INFO - 'USER': 'cltbld', 09:16:34 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1469722103.606545-1003784098', 09:16:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:34 INFO - '_': '/tools/buildbot/bin/python'} 09:16:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:16:34 INFO - Running setup.py (path:/tmp/pip-P2Uvid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:16:34 INFO - Running setup.py (path:/tmp/pip-FPuPN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:16:34 INFO - Running setup.py (path:/tmp/pip-Rgrwj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:16:34 INFO - Running setup.py (path:/tmp/pip-6Rc73B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:16:34 INFO - Running setup.py (path:/tmp/pip-Rienut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:16:34 INFO - Running setup.py (path:/tmp/pip-8Qd1Xa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:16:34 INFO - Running setup.py (path:/tmp/pip-yI1EhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:16:34 INFO - Running setup.py (path:/tmp/pip-H_ZWDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:16:35 INFO - Running setup.py (path:/tmp/pip-_lEucn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:16:35 INFO - Running setup.py (path:/tmp/pip-xVMz7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:16:35 INFO - Running setup.py (path:/tmp/pip-JmVYwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:16:35 INFO - Running setup.py (path:/tmp/pip-kyAos6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:16:35 INFO - Running setup.py (path:/tmp/pip-xWsLkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:16:35 INFO - Running setup.py (path:/tmp/pip-S94ThO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:35 INFO - Running setup.py (path:/tmp/pip-Kh46Ti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:16:35 INFO - Running setup.py (path:/tmp/pip-WphOxx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:16:35 INFO - Running setup.py (path:/tmp/pip-9RkyWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:16:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:16:35 INFO - Running setup.py install for manifestparser 09:16:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:16:35 INFO - Running setup.py install for mozcrash 09:16:35 INFO - Running setup.py install for mozdebug 09:16:35 INFO - Running setup.py install for mozdevice 09:16:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:16:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:16:36 INFO - Running setup.py install for mozfile 09:16:36 INFO - Running setup.py install for mozhttpd 09:16:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:16:36 INFO - Running setup.py install for mozinfo 09:16:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:16:36 INFO - Running setup.py install for mozInstall 09:16:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:16:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:16:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:16:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:16:36 INFO - Running setup.py install for mozleak 09:16:36 INFO - Running setup.py install for mozlog 09:16:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:16:36 INFO - Running setup.py install for moznetwork 09:16:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:16:36 INFO - Running setup.py install for mozprocess 09:16:36 INFO - Running setup.py install for mozprofile 09:16:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:16:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:16:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:16:37 INFO - Running setup.py install for mozrunner 09:16:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:16:37 INFO - Running setup.py install for mozscreenshot 09:16:37 INFO - Running setup.py install for moztest 09:16:37 INFO - Running setup.py install for mozversion 09:16:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:16:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:16:37 INFO - Cleaning up... 09:16:37 INFO - Return code: 0 09:16:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:16:37 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')]} 09:16:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:37 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')]} 09:16:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:37 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 0x1732030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f13b0>, '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 0x19f22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f2740>, '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': '5bd038846534b2fdfa68eeae000001e2-1469722103.606545-1003784098', '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 09:16:37 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 09:16:37 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 09:16:37 INFO - Using env: {'DISPLAY': ':0', 09:16:37 INFO - 'HOME': '/home/cltbld', 09:16:37 INFO - 'LANG': 'en_US.UTF-8', 09:16:37 INFO - 'LANGUAGE': 'en_US:en', 09:16:37 INFO - 'LOGNAME': 'cltbld', 09:16:37 INFO - 'MAIL': '/var/mail/cltbld', 09:16:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:37 INFO - 'MOZ_NO_REMOTE': '1', 09:16:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:37 INFO - 'NO_EM_RESTART': '1', 09:16:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:37 INFO - 'PWD': '/builds/slave/test', 09:16:37 INFO - 'SHELL': '/bin/bash', 09:16:37 INFO - 'SHLVL': '1', 09:16:37 INFO - 'TERM': 'linux', 09:16:37 INFO - 'TMOUT': '86400', 09:16:37 INFO - 'USER': 'cltbld', 09:16:37 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1469722103.606545-1003784098', 09:16:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:37 INFO - '_': '/tools/buildbot/bin/python'} 09:16:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:16:37 INFO - Running setup.py (path:/tmp/pip-NKnQ52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:16:37 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)) 09:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:16:37 INFO - Running setup.py (path:/tmp/pip-ccaF8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:16:37 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)) 09:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:16:37 INFO - Running setup.py (path:/tmp/pip-YeT94f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:16:37 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)) 09:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:16:37 INFO - Running setup.py (path:/tmp/pip-rZPs9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:16:37 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)) 09:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:16:37 INFO - Running setup.py (path:/tmp/pip-gx3zua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:16:38 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)) 09:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:16:38 INFO - Running setup.py (path:/tmp/pip-krBEOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:16:38 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)) 09:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:16:38 INFO - Running setup.py (path:/tmp/pip-861P5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:16:38 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)) 09:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:16:38 INFO - Running setup.py (path:/tmp/pip-cW0gTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:16:38 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)) 09:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:16:38 INFO - Running setup.py (path:/tmp/pip-Am_Nqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:16:38 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)) 09:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:16:38 INFO - Running setup.py (path:/tmp/pip-v8cDK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 09:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:16:38 INFO - Running setup.py (path:/tmp/pip-6r_gF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:16:38 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)) 09:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:16:38 INFO - Running setup.py (path:/tmp/pip-vEmS3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 09:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:16:38 INFO - Running setup.py (path:/tmp/pip-PQcRWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:16:38 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)) 09:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:16:38 INFO - Running setup.py (path:/tmp/pip-KWd14r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 09:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:38 INFO - Running setup.py (path:/tmp/pip-M4SKFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:38 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)) 09:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:16:38 INFO - Running setup.py (path:/tmp/pip-NHcLTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:16:38 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)) 09:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:16:38 INFO - Running setup.py (path:/tmp/pip-7aCc34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:16:38 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)) 09:16:38 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)) 09:16:38 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)) 09:16:38 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)) 09:16:38 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)) 09:16:38 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)) 09:16:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:16: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 09:16: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 09:16: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 09:16: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 09:16: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 09:16: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 09:16:40 INFO - Downloading blessings-1.6.tar.gz 09:16:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:16:40 INFO - Installing collected packages: blessings 09:16:40 INFO - Running setup.py install for blessings 09:16:41 INFO - Successfully installed blessings 09:16:41 INFO - Cleaning up... 09:16:41 INFO - Return code: 0 09:16:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:16:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:16:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:16:41 INFO - Reading from file tmpfile_stdout 09:16:41 INFO - Current package versions: 09:16:41 INFO - argparse == 1.2.1 09:16:41 INFO - blessings == 1.6 09:16:41 INFO - blobuploader == 1.2.4 09:16:41 INFO - docopt == 0.6.1 09:16:41 INFO - functools32 == 3.2.3-2 09:16:41 INFO - jsonschema == 2.5.1 09:16:41 INFO - manifestparser == 1.1 09:16:41 INFO - mozInstall == 1.12 09:16:41 INFO - mozcrash == 0.17 09:16:41 INFO - mozdebug == 0.1 09:16:41 INFO - mozdevice == 0.48 09:16:41 INFO - mozfile == 1.2 09:16:41 INFO - mozhttpd == 0.7 09:16:41 INFO - mozinfo == 0.9 09:16:41 INFO - mozleak == 0.1 09:16:41 INFO - mozlog == 3.3 09:16:41 INFO - moznetwork == 0.27 09:16:41 INFO - mozprocess == 0.23 09:16:41 INFO - mozprofile == 0.28 09:16:41 INFO - mozrunner == 6.12 09:16:41 INFO - mozscreenshot == 0.1 09:16:41 INFO - mozsystemmonitor == 0.3 09:16:41 INFO - moztest == 0.7 09:16:41 INFO - mozversion == 1.4 09:16:41 INFO - psutil == 3.1.1 09:16:41 INFO - requests == 1.2.3 09:16:41 INFO - wsgiref == 0.1.2 09:16:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:41 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 0x1732030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f13b0>, '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 0x19f22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f2740>, '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': '5bd038846534b2fdfa68eeae000001e2-1469722103.606545-1003784098', '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 09:16:41 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 09:16:41 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 09:16:41 INFO - Using env: {'DISPLAY': ':0', 09:16:41 INFO - 'HOME': '/home/cltbld', 09:16:41 INFO - 'LANG': 'en_US.UTF-8', 09:16:41 INFO - 'LANGUAGE': 'en_US:en', 09:16:41 INFO - 'LOGNAME': 'cltbld', 09:16:41 INFO - 'MAIL': '/var/mail/cltbld', 09:16:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:41 INFO - 'MOZ_NO_REMOTE': '1', 09:16:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:41 INFO - 'NO_EM_RESTART': '1', 09:16:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:41 INFO - 'PWD': '/builds/slave/test', 09:16:41 INFO - 'SHELL': '/bin/bash', 09:16:41 INFO - 'SHLVL': '1', 09:16:41 INFO - 'TERM': 'linux', 09:16:41 INFO - 'TMOUT': '86400', 09:16:41 INFO - 'USER': 'cltbld', 09:16:41 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1469722103.606545-1003784098', 09:16:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:41 INFO - '_': '/tools/buildbot/bin/python'} 09:16:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:41 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)) 09:16:41 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)) 09:16:41 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)) 09:16:41 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)) 09:16:41 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)) 09:16:41 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)) 09:16:41 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)) 09:16:41 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)) 09:16:41 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)) 09:16:41 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)) 09:16:41 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)) 09:16:41 INFO - Cleaning up... 09:16:41 INFO - Return code: 0 09:16:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1732030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f13b0>, '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 0x19f22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f2740>, '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': '5bd038846534b2fdfa68eeae000001e2-1469722103.606545-1003784098', '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 09:16:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:16:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:16:41 INFO - Using env: {'DISPLAY': ':0', 09:16:41 INFO - 'HOME': '/home/cltbld', 09:16:41 INFO - 'LANG': 'en_US.UTF-8', 09:16:41 INFO - 'LANGUAGE': 'en_US:en', 09:16:41 INFO - 'LOGNAME': 'cltbld', 09:16:41 INFO - 'MAIL': '/var/mail/cltbld', 09:16:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:41 INFO - 'MOZ_NO_REMOTE': '1', 09:16:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:41 INFO - 'NO_EM_RESTART': '1', 09:16:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:41 INFO - 'PWD': '/builds/slave/test', 09:16:41 INFO - 'SHELL': '/bin/bash', 09:16:41 INFO - 'SHLVL': '1', 09:16:41 INFO - 'TERM': 'linux', 09:16:41 INFO - 'TMOUT': '86400', 09:16:41 INFO - 'USER': 'cltbld', 09:16:41 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1469722103.606545-1003784098', 09:16:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:41 INFO - '_': '/tools/buildbot/bin/python'} 09:16:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:16:41 INFO - Cleaning up... 09:16:41 INFO - Return code: 0 09:16:41 INFO - Running post-action listener: _resource_record_post_action 09:16:41 INFO - Running post-action listener: _start_resource_monitoring 09:16:41 INFO - Starting resource monitoring. 09:16:41 INFO - [mozharness: 2016-07-28 16:16:41.793218Z] Finished create-virtualenv step (success) 09:16:41 INFO - [mozharness: 2016-07-28 16:16:41.793657Z] Running install step. 09:16:41 INFO - Running pre-action listener: _resource_record_pre_action 09:16:41 INFO - Running main action method: install 09:16:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:16:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:16:42 INFO - Reading from file tmpfile_stdout 09:16:42 INFO - Detecting whether we're running mozinstall >=1.0... 09:16:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:16:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:16:42 INFO - Reading from file tmpfile_stdout 09:16:42 INFO - Output received: 09:16:42 INFO - Usage: mozinstall [options] installer 09:16:42 INFO - Options: 09:16:42 INFO - -h, --help show this help message and exit 09:16:42 INFO - -d DEST, --destination=DEST 09:16:42 INFO - Directory to install application into. [default: 09:16:42 INFO - "/builds/slave/test"] 09:16:42 INFO - --app=APP Application being installed. [default: firefox] 09:16:42 INFO - mkdir: /builds/slave/test/build/application 09:16:42 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'] 09:16:42 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 09:16:58 INFO - Reading from file tmpfile_stdout 09:16:58 INFO - Output received: 09:16:58 INFO - /builds/slave/test/build/application/firefox/firefox 09:16:58 INFO - Running post-action listener: _resource_record_post_action 09:16:58 INFO - [mozharness: 2016-07-28 16:16:58.500983Z] Finished install step (success) 09:16:58 INFO - [mozharness: 2016-07-28 16:16:58.501260Z] Running run-tests step. 09:16:58 INFO - Running pre-action listener: _resource_record_pre_action 09:16:58 INFO - Running main action method: run_tests 09:16:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:16:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:16:58 INFO - Python 2.7.3 09:16:58 INFO - Return code: 0 09:16:58 INFO - grabbing minidump binary from tooltool 09:16:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:58 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 0x19f13b0>, '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 0x19f22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f2740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:16:58 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 09:16:58 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 09:16:58 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 09:16:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:16:58 INFO - Return code: 0 09:16:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:16:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:16:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:16:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:16:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:16:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WJ4YQRL-S1W0MXW5E5IF2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:16:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WJ4YQRL-S1W0MXW5E5IF2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:16:58 INFO - Using env: {'DISPLAY': ':0', 09:16:58 INFO - 'HOME': '/home/cltbld', 09:16:58 INFO - 'LANG': 'en_US.UTF-8', 09:16:58 INFO - 'LANGUAGE': 'en_US:en', 09:16:58 INFO - 'LOGNAME': 'cltbld', 09:16:58 INFO - 'MAIL': '/var/mail/cltbld', 09:16:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:16:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:16:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:58 INFO - 'MOZ_NO_REMOTE': '1', 09:16:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:16:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:58 INFO - 'NO_EM_RESTART': '1', 09:16:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:58 INFO - 'PWD': '/builds/slave/test', 09:16:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:16:58 INFO - 'SHELL': '/bin/bash', 09:16:58 INFO - 'SHLVL': '1', 09:16:58 INFO - 'TERM': 'linux', 09:16:58 INFO - 'TMOUT': '86400', 09:16:58 INFO - 'USER': 'cltbld', 09:16:58 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1469722103.606545-1003784098', 09:16:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:58 INFO - '_': '/tools/buildbot/bin/python'} 09:16:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WJ4YQRL-S1W0MXW5E5IF2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:16:58 INFO - mozversion application_buildid: 20160728083825 09:16:58 INFO - mozversion application_changeset: f10815c6925054c5a46596ff95d7ef41ab8951b5 09:16:58 INFO - mozversion application_display_name: Nightly 09:16:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:16:58 INFO - mozversion application_name: Firefox 09:16:58 INFO - mozversion application_remotingname: firefox 09:16:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:16:58 INFO - mozversion application_vendor: Mozilla 09:16:58 INFO - mozversion application_version: 50.0a1 09:16:58 INFO - mozversion platform_buildid: 20160728083825 09:16:58 INFO - mozversion platform_changeset: f10815c6925054c5a46596ff95d7ef41ab8951b5 09:16:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:16:58 INFO - mozversion platform_version: 50.0a1 09:16:58 INFO - using testdate: 1469722618 09:16:58 INFO - actual date: 1469722618 09:16:58 INFO - starting webserver on 'localhost:46381' 09:16:58 INFO - SUITE-START | Running 2 tests 09:16:58 INFO - TEST-START | dromaeo_css 09:16:58 INFO - operating with platform_type : linux_ 09:16:58 INFO - Initialising browser for dromaeo_css test... 09:16:58 INFO - TEST-INFO | started process 4483 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_hFcWc/profile http://localhost:46381/getInfo.html) 09:17:02 INFO - PROCESS | 4483 | JavaScript error: , line 0: uncaught exception: undefined 09:17:03 INFO - PROCESS | 4483 | __metrics Screen width/height:1600/1200 09:17:03 INFO - PROCESS | 4483 | colorDepth:24 09:17:03 INFO - PROCESS | 4483 | Browser inner width/height: 1024/697 09:17:03 INFO - PROCESS | 4483 | __metrics 09:17:04 INFO - PROCESS | 4483 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:17:04 INFO - PROCESS | 4483 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:17:04 INFO - PROCESS | 4483 | console.error: PushService: 09:17:04 INFO - PROCESS | 4483 | stateChangeProcessEnqueue: Error transitioning state 09:17:04 INFO - PROCESS | 4483 | UnknownError 09:17:05 INFO - TEST-INFO | 4483: exit 0 09:17:05 INFO - Browser initialized. 09:17:05 INFO - Running cycle 1/1 for dromaeo_css test... 09:17:05 INFO - TEST-INFO | started process 4563 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_hFcWc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:17:17 INFO - PROCESS | 4563 | RSS: Main: 159105024 09:17:17 INFO - PROCESS | 4563 | 09:18:07 INFO - PROCESS | 4563 | 1469722687782 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] 09:20:20 INFO - PROCESS | 4563 | Cycle 1(1): loaded http://localhost:46381/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46381/tests/dromaeo/cssquery-ext.html) 09:20:22 INFO - PROCESS | 4563 | RSS: Main: 280449024 09:20:22 INFO - PROCESS | 4563 | 09:23:24 INFO - PROCESS | 4563 | Cycle 1(1): loaded http://localhost:46381/tests/dromaeo/cssquery-ext.html (next: http://localhost:46381/tests/dromaeo/cssquery-jquery.html) 09:23:25 INFO - PROCESS | 4563 | RSS: Main: 238112768 09:23:25 INFO - PROCESS | 4563 | 09:26:27 INFO - PROCESS | 4563 | Cycle 1(1): loaded http://localhost:46381/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46381/tests/dromaeo/cssquery-mootools.html) 09:26:28 INFO - PROCESS | 4563 | RSS: Main: 213598208 09:26:28 INFO - PROCESS | 4563 | 09:29:30 INFO - PROCESS | 4563 | Cycle 1(1): loaded http://localhost:46381/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46381/tests/dromaeo/cssquery-prototype.html) 09:29:30 INFO - PROCESS | 4563 | RSS: Main: 199540736 09:29:30 INFO - PROCESS | 4563 | 09:32:33 INFO - PROCESS | 4563 | Cycle 1(1): loaded http://localhost:46381/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46381/tests/dromaeo/cssquery-yui.html) 09:32:34 INFO - PROCESS | 4563 | RSS: Main: 191492096 09:32:34 INFO - PROCESS | 4563 | 09:35:37 INFO - PROCESS | 4563 | Cycle 1(1): loaded http://localhost:46381/tests/dromaeo/cssquery-yui.html (next: http://localhost:46381/tests/dromaeo/cssquery-dojo.html) 09:35:37 INFO - PROCESS | 4563 | RSS: Main: 277704704 09:35:37 INFO - PROCESS | 4563 | 09:35:37 INFO - PROCESS | 4563 | __start_tp_report 09:35:37 INFO - PROCESS | 4563 | _x_x_mozilla_page_load 09:35:37 INFO - PROCESS | 4563 | _x_x_mozilla_page_load_details 09:35:37 INFO - PROCESS | 4563 | |i|pagename|runs| 09:35:37 INFO - PROCESS | 4563 | |0;dojo.html;2578.149210760449;2620.2270330252572;2662.015054429861;2675.7725593324567;2681.503921774472;4579.221532339502;4651.069786042788;4750.1428819919;4900.583450406715;4914.950850491494;4647.674662773607;4649.349091127245;4657.953420465794;4752.786124624392;4807.23084306511;4360.324149756792;4409.29451287794;4410.6030457259;4447.288433850576;4451.910961780763;4349.934750978738;4454.309582014793;4476.955230447703;4501.887452813673;4547.772611369435;4482.910341793162;4529.660275479336;4535.160995215879;4551.863444096666;4553.4991150973365;4272.6795490338345;4287.035417031174;4287.656987440997;4363.803628836678;4384.320430333303;4316.136772645452;4338.891527711801;4349.586789255016;4355.477342718862;4355.956440435587;4775.880602984918;4780.569748722597;4812.663113582051;4820.9634928490195;4876.634252431082;4957.132501812204;5117.8464646060675;5159.922601160985;5176.120059589879;5182.222666600002;5070.264811602334;5117.283580298761;5122.359705036871;5138.46046165151;5143.8456846294675;4780.282957556395;4815.879603009917;4825.565699087099;4828.637852161031;4829.154897892855;5070.594352451795;5151.07280689472;5299.284596579412;5302.045631786315;5312.601554883399;4988.925166122511;5048.596112311006;5052.621053421009;5075.492450754969;5095.414027386898;5105.642605017613;5109.978004399135;5145.408278048072;5147.97426012875;5161.406438259648;4936.234883593049;4997.375328083989;5007.599392048627;5009.173486374781;5056.393232812013;4982.825601104017;4983.103041452573;5042.621803364762;5086.4659210783075;5100.464451232641;4306.978465107717;4323.6757243206885;4325.070109926381;4333.068390296102;4360.345948107809;3790.886273411802;3792.563855156637;3797.3924172132324;3819.4461803038403;3819.8663046793786;4231.682623803165;4307.332363483665;4356.194104090753;4363.192809330284;4395.406620106309;5085.847424577195;5089.465606111305;5102.234664800236;5122.718250496258;5159.25190847325;4371.278739008092;4373.387725718402;4383.824647014084;4404.647628189737;4428.158649856517;4442.311441726538;4565.543445655474;4569.611583015414;4591.47198072226;4618.122556714214;4847.491013443538;4855.708657480563;4876.634252431011;4893.657443978887;4903.33804936329;5124.359455068116;5137.306463627362;5160.845174644616;5162.483751624807;5169.379674439091;4689.6717229793585;4828.275758636232;4867.537583929521;4873.780679869344;4893.070316639827;5090.796368145233;5105.336306280308;5114;5117.667351622282;5146.25379320004;5171.482851714798;5178.844634660966;5199.142141546602;5199.974000129975;5245.6852588844795;4828.4688684244;4924.778384972613;4957.702537847741;4970.726610036482;5034.521720436553;4960.627952903475;4977.552020318189;4984.675996060245;4999.225120106389;5029.874253143701;4919.950800492093;4935.851924442129;4945.579625731853;4956.876078097932;4968.981358821506;4865.051314993542;4922.532359425992;4926.211806111005;4986.825461108844;5023.748812559431;4892.68197567157;4893.975530122327;4895.853124406273;4916.262560615936;4942.925856112233 09:35:37 INFO - PROCESS | 4563 | |1;ext.html;578.5920925747347;586.9559783016274;592.6414519215874;593.5162842283538;604.6674329118983;26907.865460672692;41973.58026419735;43256.78371608137;43369.91575210625;43410.13179736403;40401.59598404022;40793.7960310198;40888.29784574775;40896.182076358455;40916;7730.072391313036;7880.960595197016;7881.527108373516;7883.408744344169;7887.921120788805;7440.888386674204;9488.810223795519;9712.22302215821;9716.222702183844;9970.551325190383;10137.087662110409;10213.182945364353;10237.897621023769;10238.948805255963;10247.538860751283;9982.700518984442;10052.045055719695;10053.648122315757;10062.89937100627;10064.49677516125;9648.517574121266;9694.466804325759;9701.757456063584;9707.223422126213;9713.660021899199;38092.61907380918;38347.23305533874;38358.808205959074;38415.61584384176;38416.42375364372;2773.1541879726674;2826.9575956360673;2845.5447128459555;2863.141057682687;3178.666240044785;28533.144005679864;28576.28559286014;28999.275018124717;29163.41673166546;29501.557476637867;2725.8637068146713;2802.677692065398;2820.8307501549766;2826.7738580913683;2837.6305240758193;249103;249120;250050;250744;251181;51018.74490627523;51280;51310.48689513132;51415.48584514182;51558.74220628873;32700.345993080005;33677;33711;47929.76035119802;47982.28026579604;13524.12093213938;13700.24648644334;13700.65748356279;13708.108972916729;13714.65713357174;9921.553530091163;10536.631217907336;10761.623343183108;10936.835947460635;10943.945280273547;17354.566135846704;17866.19602117908;17880.731789023175;17903.73144402835;18096.366627167987;6712.261651218362;6742.83142921421;6772.2211945625895;6864.519483636098;7047.89428158578;815.8857759913617;868.1101870582703;937.0722984245684;946.2808265717966;985.6205360935948;27934.3016424591;28101.578476322873;28146.85926570395;28400.147995560168;28603.427931441256;926.6895589977433;962.7881865989611;975.4683697384942;1052.4369462337613;1077.3482043363651;14724.779128313085;14928.701425971636;15058.171800551076;15089.24553772307;15205.239738013055;405639;410074;411082;412552;412756;48105.51894481081;48675.513244867805;48756.756216218695;48758.5124148754;48769.75615121973;1072.1797824664138;1114.793763153819;1123.2137503747572;1168.456667649547;1197.9041676665845;20867.304045202996;27312;28048.71951280461;29560.122579774095;30160.396792064475;45275.54724452713;45692.314615280135;45735;45844.31233531433;45909.31136033029;349787;353160;354242;354497;355179;20062.699059514413;21900.780992189873;24585;24697.753022469544;25036.874815625804;39951.20097597974;40249;40352.59647403606;40446;40461;34332.82833585816;34626.48060279148;34718.30563388667;35055.64944350524;35593.46609800907;35291.470627940085;35365.64634353624;35498.64501354953;36109.0972725684;36169.27661446704;34557.481637775956;34733;35244.29511409809;35414.64585354114;35810;30356;32269.35461290714;32539.674603253665;32566.34867302688;32789.83605081959;24721.381965451008;25116;25214.62178067367;25459.49081018332;25643.230703078938 09:35:37 INFO - PROCESS | 4563 | |2;jquery.html;339.33490358896563;347.0179392319735;349.4932348095261;355.6674509333773;365.48466662006575;12744.872551274497;16023.359065637374;16251.431199908006;16749.078800665957;16929.66140677186;17102.657946841056;17145.74281385777;17171.742423863652;17364.739528907077;17399.34706202912;4409.184300904327;4986.925196122052;5179.870503237412;5192.091384007784;5216.452272511388;5139.640225184238;5217.087009773293;5220.373555173384;5231.843044708646;5232.92150617741;4922.064807686528;5035.647504674675;5188.16989281715;5190.636655434121;5192.844214673566;5031.823886163985;5084.694918304895;5096.694198348111;5097.643164978453;5100.464451232604;4354.477462704464;4472.664550158718;4500.302453119772;4522.796474158671;4523.592876641118;20519.5896082079;20735;20783.896080519502;20866.79133208679;21038.684419733716;1769.6814573376787;1787.6156626325273;1821.4444594398703;2024.1093918675735;2228.2423975848287;13003.284819334933;13254.801177982337;13463.932680336535;13933.233672148028;13995.30023498821;1660.418853401312;1669.190442635321;1690.6196105876202;1700.3538655311027;1761.6212514309484;69772;70252;70916;71821.6408917952;73485;9024.819503609891;9082.727518174466;9266.629334826532;9298.349115561845;9448.149666529907;12189.51241950312;12193.207441516273;12206.938965305117;12213.267203967791;12220.877791222152;7046.506744527834;7135.072440582795;7209.531380460253;7292.3801476874;7366.189719130892;6991.19601245853;7098.716051357887;7173.426125909915;7311.597862117635;7338.192798792129;6087.391260873966;6209.9068513972325;6216.818804427145;6226.844328891814;6320.431161195423;1651.7604947282578;1706.2833609883878;1720.9483715488554;1739.1391261325725;1758.5603599100225;887.2502735188755;897.9730608081637;946.4368700623119;947.3889341374775;969.5055521683992;16876.240569174417;17555.82444175542;18397.724034139497;18565.535861603566;18877.339293124674;883.5979629268668;887.2813021452644;898.9056149104381;902.6930843513237;908.5139450394007;9545.809083818285;10230.897691022994;10478.109360704273;10496.212784041074;10535.683929482127;403453;419405;425673;426960;428782;72046;72279;72364.63817680877;73758;74390.62804685942;876.2814492116531;885.9069797671281;894.4499133033138;916.0015583014413;928.1831987850649;14797.112173269637;15193.696126077637;15568.766468503209;15666.608334791266;15721;41087.178256435305;41109.58890411058;41115.588844112375;41718.374224386054;41986.79006605069;54137.458625413245;55570;55722.72138639281;56444.71777641086;57187.714061429426;7535.962320188364;7583.658735357032;7611.010568626043;7654.655540500802;7756.0304961879765;10902;11527.193096483166;11661;11910.404479775803;12159.939200304296;4983.27742477346;10225.59097636116;10263;10277.476901882423;10513.474326283502;9838.901610984085;10090.344127631974;10250.897491025293;10258.333208341433;10448.32085914413;9383.483908385104;10006.349587276804;10160.08559229673;10248.64129755455;10527.210459215436;7402.629868506661;7592.658330375257;7659.846803063796;7732.188120247293;7802.531848089133;9363.531823408666;9841.311108222355;10437.530311136168;10528.052475277262;10769.676909692722 09:35:37 INFO - PROCESS | 4563 | |3;mootools.html;1153.3771763247844;1167.3112863410586;1261.28106979022;1301.4598941439303;1621.7243068678324;6597.175353080859;7455.254474552542;7778.377729781625;7782.571958542278;8028.076771171317;7828.138904720477;7885.172056934025;7889.053313602361;7890.605469726505;7902.960485197566;2107.704921311014;2139.358192542239;2139.935801925945;2141.1328411993168;2142.475093602062;2051.866628669139;2107.7365329333834;2113.2497963223063;2115.841311901606;2118.766935637079;2063.515073957619;2084.2809230815346;2091.1530830013867;2093.675480300556;2103.8737675739426;2055.352563942361;2056.352249041547;2061.494933741243;2061.701053347264;2062.669972804359;2028.7261219735442;2040.0411806450945;2065.215218217083;2071.7721050684563;2072.0365030261;7677.500962437423;7706.460547761659;7780.533168009937;7790.065192176919;7790.143084260727;4334.674899382528;4488.8877778055485;4491.416115904912;4491.663125265585;4501.549845015505;2695.447433276174;2775.777937764974;2840.3751174741524;2843.815152015133;2850.686424493304;887.3123279776601;896.8116695493954;909.1862782809415;912.63494602159;913.7943962608426;10558.630447934285;10722.839157412645;10749.978752018624;10761.946190268998;10764;3776.4712940188397;3969.4839670842607;4080.5307389649975;4113.177364527107;4118.567550407224;8414.579271036424;8425.95787021061;8426.07313195548;8432.873506897402;8435.578221088921;4438.023634800339;4440.533743956903;4441.156180325728;4441.222786012435;4445.244308467568;3552.4316109422884;3943.2704949583845;4072.226277007359;4084.2648323301496;4087.243859885871;3226.596675415573;3231.079142444392;3341.331733653279;3344.0970937846646;3374.814385208788;969.8469397936569;973.6592192732628;978.090375950373;985.3545927417409;989.1246247071393;748.3115533709001;764.5489161394804;766.3600893254195;775.3758224629228;778.3928535742131;5084.923726144111;5143.7685304161405;5173.586113110942;5333.386660534088;5529.806456773994;390.43192155413806;396.44101816438683;399.5964076282975;403.4492917168103;414.1117303384224;3650.0509867434657;3686;3701.2967536168044;3719.814009299578;3735.9813200933822;9414.764630884283;9944.35361701487;9971.152452041657;9995.550200241007;10005.099541041196;9633.229341652652;9715.854262186072;9721.513924303898;9850.408975461496;9874.160696340892;7459.925400746031;7525.698972041167;7527.887081693779;7528.435367347471;7534.623268836536;5021;5134.332536770196;5148.099082660445;5184.714840683648;5457.263269458573;8809.691660791841;8883.289336852908;8947.284217262733;9031.27749780029;9082.36423450352;9054.411463254868;9059.320550958573;9257.444553326823;9298.814023719622;9346.252299815862;5507.146392309199;6300.558960872695;6410.230772307353;6412.743490260337;6415.3263907289065;7131.786046418616;7330.523515971445;7391.8152046199275;7547.73582924595;7555.16893141743;6670;6744.0895479109695;6750.05499230118;6751.864962700817;6836.316368363124;6686.966565167143;6717.193936727624;6727.091842601186;6737.898931515933;6757.087793147862;6147.139400483847;6228.28374736893;6236.220472440945;6244.937550624436;6248.625082494883;4634;4668;4769.070031343994;4772.5227477252;4821.63837712166;4517.277235642281;4594.5864872161665;4714.740689262124;4720.362751028567;4950.257461380822 09:35:37 INFO - PROCESS | 4563 | |4;prototype.html;287.38356225895456;292.9340898297883;295.6216043464365;296.40126943573983;298.7639764585977;4828.541288577584;4881.682690625112;4896.951030489694;4898.559129678329;4898.779554920028;4545.522720114382;4702.788374523147;4710.128626204146;4711.9528804711945;4833.564979151875;3669.743117981742;3722.7207959403017;3737.6636102750813;3781.1681430085337;3800.2019575888958;3792.8672496462627;3802.2965751335955;3802.8098595070273;3810.8475660973527;3832.6742226910746;3692.13234889802;3779.5086638736925;3793.653253095139;3799.67702745267;3805.1248212911046;3610.718195040749;3709.7959612221316;3757.9248415031684;3769.6418840210135;3814.218085292536;3352.363051020323;3358.22760765023;3365.293288409437;3376.9831150844334;3378.4425569780956;4736.810527578893;4741.193997020515;4749.316636100592;4752.809887604491;4763.333133361298;4273.914521709579;4275.72152185363;4306.126834826829;4324.243257429968;4369.60673539383;4992.775325110342;5012.195609580548;5016.548510634024;5033.647644664875;5040.59675225981;3633.16437219441;3638.7634803737674;3642.579394036328;3643.890683279506;3662.230931504387;5248.81629142982;5276.92084618731;5280.3663560373;5283.762230699589;5291.206319052173;3635.690966267897;3684.9263014739554;3752.7560708553856;3777.206786574795;3777.7544459610035;3808.7143464240294;3816.9809150954625;3817.3701339279264;3823.9426408603895;3834.9041273968373;4308.332208507686;4313.460817397825;4332.545082766264;4337.327714204241;4348.260795664744;4954.430240522314;5012.245714000071;5022.42242142151;5091.821786237538;5097.133487307166;1311.7901135818224;1322.4247452358063;1325.4227469311488;1335.7929520924272;1337.6856438736888;837.4514692876176;860.7116615933733;871.4117970369975;873.6243415331342;878.3851304087037;4065.5121385433936;4071.75569465833;4073.918521629551;4084.4281800547947;4090.754554726726;4611.861644150681;4643.930341044887;4666.556677115668;4672.439307283148;4690.577847993629;4051.2505186540584;4070.4504891839815;4074.738520121302;4075.857344992911;4091.1408604193452;2410.614301711718;2448.484968884883;2481.3796550862285;2486.2292689266387;2496.750324967525;4433.689641725113;4433.689641725113;4433.733975961452;4436.378906953029;4468.4637843458995;4761.547652972962;4780.306855505932;4783;4792.808287668454;4802.447718512416;4222.451081359465;4365.5197928227235;4369.169857727022;4386.11397099244;4429.143202634283;4511.548845115462;4577;4586.541345865387;4618.584327410549;4619.812329492639;4511.616512596466;4518.36742856007;4541.569405637214;4546.4544254689645;4551;4041.2523683118716;4366.607005369532;4375;4376.892406391497;4430.800613972315;3428.4343083390963;3437.74216933726;3452.2405070884365;3456.3778519866664;3459.7924124552605;4598.6663867478055;4641.976790116028;4663.883402914954;4672.8551504881525;4678.438587369401;4289.077848262514;4523.23105072132;4537.933585607314;4547.40797745282;4580.213716650575;4458.375827384234;4461.776911154494;4476.641868650565;4495.887602809956;4506.774661266858;4416.22716024688;4417.447819022622;4428.867133985986;4447.73313601185;4478.880279930017;4512.435945506812;4524.705894116872;4534.480948882161;4834.854954351375;4852.75736213195;4972.129877271391;4985.277134815359;4986.227134794112;4990.50094990498;4992.8751781205765 09:35:37 INFO - PROCESS | 4563 | |5;yui.html;578.8321386797828;628.7327885648598;682.7951614515644;721.0626185958253;727.5889122645705;11641.12691548133;12092;12550.497980080809;12583.748325033494;12647.683807904807;12653.810192847115;12891.548795792149;12926.28905410202;12943.74112517749;12974.54589089382;620.7299824576302;762.6110683551387;778.3111945927866;780.7696729464822;781.3241546062643;761.8323968726899;783.8589053970312;784.3607459920175;786.3984052200071;787.7518581646763;826.7271800305884;828.353883970504;828.9792755181109;829.0465964141225;830.8255266394065;646.5118835279382;815.254042551065;816.7835523586225;816.9468984516017;817;569.857535616096;580.9709514524299;582.2343618142172;585.4964730331911;585.844751140948;12680.112392132554;12706.55527056558;12715;12725.363731813371;12733.36333183337;11533.769324613544;12008.219465734699;12066.939665301617;12146.149769516138;12595.24428534291;9466.763330916714;9712.70861874145;11459.949029210993;11479.13906457019;11535.307881527051;4055.2092341993325;4057.229126465962;4082.8571000015154;4100.507939047304;4266.168097221043;62270.14710585229;63145;63304.68347658232;64578.354216458174;64637.67681161611;9189.402688825205;9252.583633736498;9347.766305842408;9508.191803696625;9551.61793528265;17509.94940303586;17743.645127097385;17745.378911738284;17752;18151.636967260845;6198.318184999646;6364.522660800459;6373.968130159319;6452.290248072708;6557.606543607399;3574.821258937043;3583.928321433557;3670.6145854685406;3673.834677439522;3760.172761992357;2614.8038897082797;2708.011575774828;2709.214327844942;2709.794141606966;2718.646575945154;468.7000319795334;476.19523006119545;483.69043811960375;484.6268373352499;486.30701250717584;446.89721364086444;542.0270614247436;547.8904219156185;549.6839317392515;552.3787683149968;7346.449016323797;7543.622818859035;7675.53946763196;7675.692972281158;7676.501027433199;461.5107985535343;485.7255650557424;499.12901986034603;510.58132331487826;551.3246273315237;3630.6550877666577;3648.5609389940896;3653.2510835279236;3741.0834345585504;3757.793321367351;92891;96740.51629741806;100414.49792751136;104452.47773761082;105214.47392762988;49949.50050499449;50010.49989500131;50620;56286.718566407726;81185.78221326567;72576.63711681408;75490.62254688691;76430.6178469104;79294.60352698315;79322;7048;7148.392386647193;7207.891881621885;7230.13238411394;7428.368588670023;46214.227146371326;46216;47263.29105063358;47383.28925066058;48059.75970120127;62480;65829;66803.66598166978;66889.33110669025;68471.65764171147;8993.505357205417;9192.17270445663;9313.39462934907;9403.34176607631;9442.480663563296;9531.332806703464;9568.282378821477;9599.808003840024;9679.951600242235;9691.418514889128;9311.813763724553;9317.208037316905;9369;9401.623935042522;9437.480938548446;9183.816323673624;9353.298502612195;9432.151106400457;9540.761480963032;9558.187554057706;9190.724278271662;9196.494192819458;9252.444853308823;9303.302252331237;9345;8325.791855203426;8352.582370881553;8368.707095251637;8390;8479.279261262614;7999.800004999922;8055.234752698484;8271.13153118938;8556.144385561394;8634.09342019079 09:35:37 INFO - PROCESS | 4563 | __end_tp_report 09:35:37 INFO - PROCESS | 4563 | __start_cc_report 09:35:37 INFO - PROCESS | 4563 | _x_x_mozilla_cycle_collect,1156 09:35:37 INFO - PROCESS | 4563 | __end_cc_report 09:35:37 INFO - PROCESS | 4563 | __startTimestamp1469723737443__endTimestamp 09:35:37 INFO - PROCESS | 4563 | 09:35:37 INFO - PROCESS | 4563 | ------- Summary: start ------- 09:35:37 INFO - PROCESS | 4563 | Number of tests: 6 09:35:37 INFO - PROCESS | 4563 | 09:35:37 INFO - PROCESS | 4563 | [#0] dojo.html Cycles:165 Average:4725.15 Median:4892.68 stddev:501.28 (10.2%) stddev-sans-first:473.68 09:35:37 INFO - PROCESS | 4563 | Values: 2578.1 2620.2 2662.0 2675.8 2681.5 4579.2 4651.1 4750.1 4900.6 4915.0 4647.7 4649.3 4658.0 4752.8 4807.2 4360.3 4409.3 4410.6 4447.3 4451.9 4349.9 4454.3 4477.0 4501.9 4547.8 4482.9 4529.7 4535.2 4551.9 4553.5 4272.7 4287.0 4287.7 4363.8 4384.3 4316.1 4338.9 4349.6 4355.5 4356.0 4775.9 4780.6 4812.7 4821.0 4876.6 4957.1 5117.8 5159.9 5176.1 5182.2 5070.3 5117.3 5122.4 5138.5 5143.8 4780.3 4815.9 4825.6 4828.6 4829.2 5070.6 5151.1 5299.3 5302.0 5312.6 4988.9 5048.6 5052.6 5075.5 5095.4 5105.6 5110.0 5145.4 5148.0 5161.4 4936.2 4997.4 5007.6 5009.2 5056.4 4982.8 4983.1 5042.6 5086.5 5100.5 4307.0 4323.7 4325.1 4333.1 4360.3 3790.9 3792.6 3797.4 3819.4 3819.9 4231.7 4307.3 4356.2 4363.2 4395.4 5085.8 5089.5 5102.2 5122.7 5159.3 4371.3 4373.4 4383.8 4404.6 4428.2 4442.3 4565.5 4569.6 4591.5 4618.1 4847.5 4855.7 4876.6 4893.7 4903.3 5124.4 5137.3 5160.8 5162.5 5169.4 4689.7 4828.3 4867.5 4873.8 4893.1 5090.8 5105.3 5114.0 5117.7 5146.3 5171.5 5178.8 5199.1 5200.0 5245.7 4828.5 4924.8 4957.7 4970.7 5034.5 4960.6 4977.6 4984.7 4999.2 5029.9 4920.0 4935.9 4945.6 4956.9 4969.0 4865.1 4922.5 4926.2 4986.8 5023.7 4892.7 4894.0 4895.9 4916.3 4942.9 09:35:37 INFO - PROCESS | 4563 | 09:35:37 INFO - PROCESS | 4563 | [#1] ext.html Cycles:180 Average:48579.40 Median:35149.97 stddev:90871.47 (258.5%) stddev-sans-first:91054.92 09:35:37 INFO - PROCESS | 4563 | Values: 578.6 587.0 592.6 593.5 604.7 26907.9 41973.6 43256.8 43369.9 43410.1 40401.6 40793.8 40888.3 40896.2 40916.0 7730.1 7881.0 7881.5 7883.4 7887.9 7440.9 9488.8 9712.2 9716.2 9970.6 10137.1 10213.2 10237.9 10238.9 10247.5 9982.7 10052.0 10053.6 10062.9 10064.5 9648.5 9694.5 9701.8 9707.2 9713.7 38092.6 38347.2 38358.8 38415.6 38416.4 2773.2 2827.0 2845.5 2863.1 3178.7 28533.1 28576.3 28999.3 29163.4 29501.6 2725.9 2802.7 2820.8 2826.8 2837.6 249103.0 249120.0 250050.0 250744.0 251181.0 51018.7 51280.0 51310.5 51415.5 51558.7 32700.3 33677.0 33711.0 47929.8 47982.3 13524.1 13700.2 13700.7 13708.1 13714.7 9921.6 10536.6 10761.6 10936.8 10943.9 17354.6 17866.2 17880.7 17903.7 18096.4 6712.3 6742.8 6772.2 6864.5 7047.9 815.9 868.1 937.1 946.3 985.6 27934.3 28101.6 28146.9 28400.1 28603.4 926.7 962.8 975.5 1052.4 1077.3 14724.8 14928.7 15058.2 15089.2 15205.2 405639.0 410074.0 411082.0 412552.0 412756.0 48105.5 48675.5 48756.8 48758.5 48769.8 1072.2 1114.8 1123.2 1168.5 1197.9 20867.3 27312.0 28048.7 29560.1 30160.4 45275.5 45692.3 45735.0 45844.3 45909.3 349787.0 353160.0 354242.0 354497.0 355179.0 20062.7 21900.8 24585.0 24697.8 25036.9 39951.2 40249.0 40352.6 40446.0 40461.0 34332.8 34626.5 34718.3 35055.6 35593.5 35291.5 35365.6 35498.6 36109.1 36169.3 34557.5 34733.0 35244.3 35414.6 35810.0 30356.0 32269.4 32539.7 32566.3 32789.8 24721.4 25116.0 25214.6 25459.5 25643.2 09:35:37 INFO - PROCESS | 4563 | 09:35:37 INFO - PROCESS | 4563 | [#2] jquery.html Cycles:180 Average:25421.75 Median:4440.92 stddev:69348.09 (1561.6%) stddev-sans-first:69517.05 09:35:37 INFO - PROCESS | 4563 | Values: 339.3 347.0 349.5 355.7 365.5 12744.9 16023.4 16251.4 16749.1 16929.7 17102.7 17145.7 17171.7 17364.7 17399.3 4409.2 4986.9 5179.9 5192.1 5216.5 5139.6 5217.1 5220.4 5231.8 5232.9 4922.1 5035.6 5188.2 5190.6 5192.8 5031.8 5084.7 5096.7 5097.6 5100.5 4354.5 4472.7 4500.3 4522.8 4523.6 20519.6 20735.0 20783.9 20866.8 21038.7 1769.7 1787.6 1821.4 2024.1 2228.2 13003.3 13254.8 13463.9 13933.2 13995.3 1660.4 1669.2 1690.6 1700.4 1761.6 69772.0 70252.0 70916.0 71821.6 73485.0 9024.8 9082.7 9266.6 9298.3 9448.1 12189.5 12193.2 12206.9 12213.3 12220.9 7046.5 7135.1 7209.5 7292.4 7366.2 6991.2 7098.7 7173.4 7311.6 7338.2 6087.4 6209.9 6216.8 6226.8 6320.4 1651.8 1706.3 1720.9 1739.1 1758.6 887.3 898.0 946.4 947.4 969.5 16876.2 17555.8 18397.7 18565.5 18877.3 883.6 887.3 898.9 902.7 908.5 9545.8 10230.9 10478.1 10496.2 10535.7 403453.0 419405.0 425673.0 426960.0 428782.0 72046.0 72279.0 72364.6 73758.0 74390.6 876.3 885.9 894.4 916.0 928.2 14797.1 15193.7 15568.8 15666.6 15721.0 41087.2 41109.6 41115.6 41718.4 41986.8 54137.5 55570.0 55722.7 56444.7 57187.7 7536.0 7583.7 7611.0 7654.7 7756.0 10902.0 11527.2 11661.0 11910.4 12159.9 4983.3 10225.6 10263.0 10277.5 10513.5 9838.9 10090.3 10250.9 10258.3 10448.3 9383.5 10006.3 10160.1 10248.6 10527.2 7402.6 7592.7 7659.8 7732.2 7802.5 9363.5 9841.3 10437.5 10528.1 10769.7 09:35:37 INFO - PROCESS | 4563 | 09:35:37 INFO - PROCESS | 4563 | [#3] mootools.html Cycles:180 Average:5061.58 Median:5160.84 stddev:2934.35 (56.9%) stddev-sans-first:2927.88 09:35:37 INFO - PROCESS | 4563 | Values: 1153.4 1167.3 1261.3 1301.5 1621.7 6597.2 7455.3 7778.4 7782.6 8028.1 7828.1 7885.2 7889.1 7890.6 7903.0 2107.7 2139.4 2139.9 2141.1 2142.5 2051.9 2107.7 2113.2 2115.8 2118.8 2063.5 2084.3 2091.2 2093.7 2103.9 2055.4 2056.4 2061.5 2061.7 2062.7 2028.7 2040.0 2065.2 2071.8 2072.0 7677.5 7706.5 7780.5 7790.1 7790.1 4334.7 4488.9 4491.4 4491.7 4501.5 2695.4 2775.8 2840.4 2843.8 2850.7 887.3 896.8 909.2 912.6 913.8 10558.6 10722.8 10750.0 10761.9 10764.0 3776.5 3969.5 4080.5 4113.2 4118.6 8414.6 8426.0 8426.1 8432.9 8435.6 4438.0 4440.5 4441.2 4441.2 4445.2 3552.4 3943.3 4072.2 4084.3 4087.2 3226.6 3231.1 3341.3 3344.1 3374.8 969.8 973.7 978.1 985.4 989.1 748.3 764.5 766.4 775.4 778.4 5084.9 5143.8 5173.6 5333.4 5529.8 390.4 396.4 399.6 403.4 414.1 3650.1 3686.0 3701.3 3719.8 3736.0 9414.8 9944.4 9971.2 9995.6 10005.1 9633.2 9715.9 9721.5 9850.4 9874.2 7459.9 7525.7 7527.9 7528.4 7534.6 5021.0 5134.3 5148.1 5184.7 5457.3 8809.7 8883.3 8947.3 9031.3 9082.4 9054.4 9059.3 9257.4 9298.8 9346.3 5507.1 6300.6 6410.2 6412.7 6415.3 7131.8 7330.5 7391.8 7547.7 7555.2 6670.0 6744.1 6750.1 6751.9 6836.3 6687.0 6717.2 6727.1 6737.9 6757.1 6147.1 6228.3 6236.2 6244.9 6248.6 4634.0 4668.0 4769.1 4772.5 4821.6 4517.3 4594.6 4714.7 4720.4 4950.3 09:35:37 INFO - PROCESS | 4563 | 09:35:37 INFO - PROCESS | 4563 | [#4] prototype.html Cycles:180 Average:3995.35 Median:4423.16 stddev:1117.30 (25.3%) stddev-sans-first:1085.22 09:35:37 INFO - PROCESS | 4563 | Values: 287.4 292.9 295.6 296.4 298.8 4828.5 4881.7 4897.0 4898.6 4898.8 4545.5 4702.8 4710.1 4712.0 4833.6 3669.7 3722.7 3737.7 3781.2 3800.2 3792.9 3802.3 3802.8 3810.8 3832.7 3692.1 3779.5 3793.7 3799.7 3805.1 3610.7 3709.8 3757.9 3769.6 3814.2 3352.4 3358.2 3365.3 3377.0 3378.4 4736.8 4741.2 4749.3 4752.8 4763.3 4273.9 4275.7 4306.1 4324.2 4369.6 4992.8 5012.2 5016.5 5033.6 5040.6 3633.2 3638.8 3642.6 3643.9 3662.2 5248.8 5276.9 5280.4 5283.8 5291.2 3635.7 3684.9 3752.8 3777.2 3777.8 3808.7 3817.0 3817.4 3823.9 3834.9 4308.3 4313.5 4332.5 4337.3 4348.3 4954.4 5012.2 5022.4 5091.8 5097.1 1311.8 1322.4 1325.4 1335.8 1337.7 837.5 860.7 871.4 873.6 878.4 4065.5 4071.8 4073.9 4084.4 4090.8 4611.9 4643.9 4666.6 4672.4 4690.6 4051.3 4070.5 4074.7 4075.9 4091.1 2410.6 2448.5 2481.4 2486.2 2496.8 4433.7 4433.7 4433.7 4436.4 4468.5 4761.5 4780.3 4783.0 4792.8 4802.4 4222.5 4365.5 4369.2 4386.1 4429.1 4511.5 4577.0 4586.5 4618.6 4619.8 4511.6 4518.4 4541.6 4546.5 4551.0 4041.3 4366.6 4375.0 4376.9 4430.8 3428.4 3437.7 3452.2 3456.4 3459.8 4598.7 4642.0 4663.9 4672.9 4678.4 4289.1 4523.2 4537.9 4547.4 4580.2 4458.4 4461.8 4476.6 4495.9 4506.8 4416.2 4417.4 4428.9 4447.7 4478.9 4512.4 4524.7 4534.5 4834.9 4852.8 4972.1 4985.3 4986.2 4990.5 4992.9 09:35:37 INFO - PROCESS | 4563 | 09:35:37 INFO - PROCESS | 4563 | [#5] yui.html Cycles:180 Average:16765.60 Median:35515.32 stddev:24671.56 (69.5%) stddev-sans-first:24710.84 09:35:37 INFO - PROCESS | 4563 | Values: 578.8 628.7 682.8 721.1 727.6 11641.1 12092.0 12550.5 12583.7 12647.7 12653.8 12891.5 12926.3 12943.7 12974.5 620.7 762.6 778.3 780.8 781.3 761.8 783.9 784.4 786.4 787.8 826.7 828.4 829.0 829.0 830.8 646.5 815.3 816.8 816.9 817.0 569.9 581.0 582.2 585.5 585.8 12680.1 12706.6 12715.0 12725.4 12733.4 11533.8 12008.2 12066.9 12146.1 12595.2 9466.8 9712.7 11459.9 11479.1 11535.3 4055.2 4057.2 4082.9 4100.5 4266.2 62270.1 63145.0 63304.7 64578.4 64637.7 9189.4 9252.6 9347.8 9508.2 9551.6 17509.9 17743.6 17745.4 17752.0 18151.6 6198.3 6364.5 6374.0 6452.3 6557.6 3574.8 3583.9 3670.6 3673.8 3760.2 2614.8 2708.0 2709.2 2709.8 2718.6 468.7 476.2 483.7 484.6 486.3 446.9 542.0 547.9 549.7 552.4 7346.4 7543.6 7675.5 7675.7 7676.5 461.5 485.7 499.1 510.6 551.3 3630.7 3648.6 3653.3 3741.1 3757.8 92891.0 96740.5 100414.5 104452.5 105214.5 49949.5 50010.5 50620.0 56286.7 81185.8 72576.6 75490.6 76430.6 79294.6 79322.0 7048.0 7148.4 7207.9 7230.1 7428.4 46214.2 46216.0 47263.3 47383.3 48059.8 62480.0 65829.0 66803.7 66889.3 68471.7 8993.5 9192.2 9313.4 9403.3 9442.5 9531.3 9568.3 9599.8 9680.0 9691.4 9311.8 9317.2 9369.0 9401.6 9437.5 9183.8 9353.3 9432.2 9540.8 9558.2 9190.7 9196.5 9252.4 9303.3 9345.0 8325.8 8352.6 8368.7 8390.0 8479.3 7999.8 8055.2 8271.1 8556.1 8634.1 09:35:37 INFO - PROCESS | 4563 | -------- Summary: end -------- 09:35:37 INFO - PROCESS | 4563 | 09:35:38 INFO - TEST-INFO | 4563: exit 0 09:35:38 INFO - TEST-OK | dromaeo_css | took 1119558ms 09:35:38 INFO - TEST-START | kraken 09:35:38 INFO - operating with platform_type : linux_ 09:35:38 INFO - Initialising browser for kraken test... 09:35:38 INFO - TEST-INFO | started process 4755 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpumDIGS/profile http://localhost:46381/getInfo.html) 09:35:41 INFO - PROCESS | 4755 | JavaScript error: , line 0: uncaught exception: undefined 09:35:42 INFO - PROCESS | 4755 | __metrics Screen width/height:1600/1200 09:35:42 INFO - PROCESS | 4755 | colorDepth:24 09:35:42 INFO - PROCESS | 4755 | Browser inner width/height: 1024/697 09:35:42 INFO - PROCESS | 4755 | __metrics 09:35:43 INFO - PROCESS | 4755 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:35:43 INFO - PROCESS | 4755 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:35:44 INFO - TEST-INFO | 4755: exit 0 09:35:44 INFO - Browser initialized. 09:35:44 INFO - Running cycle 1/1 for kraken test... 09:35:44 INFO - TEST-INFO | started process 4834 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpumDIGS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:35:56 INFO - PROCESS | 4834 | RSS: Main: 159096832 09:35:56 INFO - PROCESS | 4834 | 09:35:59 INFO - PROCESS | 4834 | Cycle 1(1): loaded http://localhost:46381/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46381/tests/kraken/driver.html?testName=audio-beat-detection) 09:35:59 INFO - PROCESS | 4834 | RSS: Main: 215277568 09:35:59 INFO - PROCESS | 4834 | 09:36:02 INFO - PROCESS | 4834 | Cycle 1(1): loaded http://localhost:46381/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46381/tests/kraken/driver.html?testName=audio-dft) 09:36:03 INFO - PROCESS | 4834 | RSS: Main: 193200128 09:36:03 INFO - PROCESS | 4834 | 09:36:06 INFO - PROCESS | 4834 | Cycle 1(1): loaded http://localhost:46381/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46381/tests/kraken/driver.html?testName=audio-fft) 09:36:07 INFO - PROCESS | 4834 | RSS: Main: 273096704 09:36:07 INFO - PROCESS | 4834 | 09:36:09 INFO - PROCESS | 4834 | Cycle 1(1): loaded http://localhost:46381/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46381/tests/kraken/driver.html?testName=audio-oscillator) 09:36:09 INFO - PROCESS | 4834 | RSS: Main: 182431744 09:36:09 INFO - PROCESS | 4834 | 09:36:12 INFO - PROCESS | 4834 | Cycle 1(1): loaded http://localhost:46381/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46381/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:36:12 INFO - PROCESS | 4834 | RSS: Main: 186273792 09:36:12 INFO - PROCESS | 4834 | 09:36:15 INFO - PROCESS | 4834 | Cycle 1(1): loaded http://localhost:46381/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46381/tests/kraken/driver.html?testName=imaging-darkroom) 09:36:16 INFO - PROCESS | 4834 | RSS: Main: 223002624 09:36:16 INFO - PROCESS | 4834 | 09:36:20 INFO - PROCESS | 4834 | Cycle 1(1): loaded http://localhost:46381/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46381/tests/kraken/driver.html?testName=imaging-desaturate) 09:36:20 INFO - PROCESS | 4834 | RSS: Main: 216866816 09:36:20 INFO - PROCESS | 4834 | 09:36:23 INFO - PROCESS | 4834 | Cycle 1(1): loaded http://localhost:46381/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46381/tests/kraken/driver.html?testName=json-parse-financial) 09:36:24 INFO - PROCESS | 4834 | RSS: Main: 220422144 09:36:24 INFO - PROCESS | 4834 | 09:36:25 INFO - PROCESS | 4834 | Cycle 1(1): loaded http://localhost:46381/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46381/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:36:26 INFO - PROCESS | 4834 | RSS: Main: 185946112 09:36:26 INFO - PROCESS | 4834 | 09:36:28 INFO - PROCESS | 4834 | Cycle 1(1): loaded http://localhost:46381/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46381/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:36:29 INFO - PROCESS | 4834 | RSS: Main: 191139840 09:36:29 INFO - PROCESS | 4834 | 09:36:31 INFO - PROCESS | 4834 | Cycle 1(1): loaded http://localhost:46381/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46381/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:36:31 INFO - PROCESS | 4834 | RSS: Main: 195162112 09:36:31 INFO - PROCESS | 4834 | 09:36:34 INFO - PROCESS | 4834 | Cycle 1(1): loaded http://localhost:46381/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46381/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:36:35 INFO - PROCESS | 4834 | RSS: Main: 190496768 09:36:35 INFO - PROCESS | 4834 | 09:36:38 INFO - PROCESS | 4834 | Cycle 1(1): loaded http://localhost:46381/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46381/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:36:38 INFO - PROCESS | 4834 | RSS: Main: 193818624 09:36:38 INFO - PROCESS | 4834 | 09:36:40 INFO - PROCESS | 4834 | Cycle 1(1): loaded http://localhost:46381/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46381/tests/kraken/driver.html?testName=ai-astar) 09:36:40 INFO - PROCESS | 4834 | RSS: Main: 244740096 09:36:40 INFO - PROCESS | 4834 | 09:36:40 INFO - PROCESS | 4834 | __start_tp_report 09:36:40 INFO - PROCESS | 4834 | _x_x_mozilla_page_load 09:36:40 INFO - PROCESS | 4834 | _x_x_mozilla_page_load_details 09:36:40 INFO - PROCESS | 4834 | |i|pagename|runs| 09:36:40 INFO - PROCESS | 4834 | |0;ai-astar;105;115;114;113;112;113;113;114;114;114 09:36:40 INFO - PROCESS | 4834 | |1;audio-beat-detection;144;123;124;184;127;128;163;122;184;128 09:36:40 INFO - PROCESS | 4834 | |2;audio-dft;161;162;162;161;160;160;162;162;160;161 09:36:40 INFO - PROCESS | 4834 | |3;audio-fft;74;76;75;121;78;77;75;77;100;75 09:36:40 INFO - PROCESS | 4834 | |4;audio-oscillator;87;85;123;85;85;84;121;85;85;125 09:36:40 INFO - PROCESS | 4834 | |5;imaging-gaussian-blur;119;118;117;118;117;117;117;118;117;118 09:36:40 INFO - PROCESS | 4834 | |6;imaging-darkroom;147;147;146;146;147;146;148;146;147;146 09:36:40 INFO - PROCESS | 4834 | |7;imaging-desaturate;95;95;95;95;95;95;96;95;95;95 09:36:40 INFO - PROCESS | 4834 | |8;json-parse-financial;63;61;61;62;61;63;63;62;61;61 09:36:40 INFO - PROCESS | 4834 | |9;json-stringify-tinderbox;66;65;66;65;67;65;67;66;66;65 09:36:40 INFO - PROCESS | 4834 | |10;stanford-crypto-aes;81;78;80;83;85;80;79;79;78;84 09:36:40 INFO - PROCESS | 4834 | |11;stanford-crypto-ccm;134;135;130;131;139;133;132;136;171;130 09:36:40 INFO - PROCESS | 4834 | |12;stanford-crypto-pbkdf2;167;170;168;170;170;169;168;169;171;168 09:36:40 INFO - PROCESS | 4834 | |13;stanford-crypto-sha256-iterative;68;67;69;67;70;66;67;67;66;66 09:36:40 INFO - PROCESS | 4834 | __end_tp_report 09:36:40 INFO - PROCESS | 4834 | __start_cc_report 09:36:40 INFO - PROCESS | 4834 | _x_x_mozilla_cycle_collect,1936 09:36:40 INFO - PROCESS | 4834 | __end_cc_report 09:36:40 INFO - PROCESS | 4834 | __startTimestamp1469723800771__endTimestamp 09:36:40 INFO - PROCESS | 4834 | 09:36:40 INFO - PROCESS | 4834 | ------- Summary: start ------- 09:36:40 INFO - PROCESS | 4834 | Number of tests: 14 09:36:40 INFO - PROCESS | 4834 | 09:36:40 INFO - PROCESS | 4834 | [#0] ai-astar Cycles:10 Average:112.70 Median:114.00 stddev:2.83 (2.5%) stddev-sans-first:0.88 09:36:40 INFO - PROCESS | 4834 | Values: 105.0 115.0 114.0 113.0 112.0 113.0 113.0 114.0 114.0 114.0 09:36:40 INFO - PROCESS | 4834 | 09:36:40 INFO - PROCESS | 4834 | [#1] audio-beat-detection Cycles:10 Average:142.70 Median:136.00 stddev:25.10 (18.5%) stddev-sans-first:26.62 09:36:40 INFO - PROCESS | 4834 | Values: 144.0 123.0 124.0 184.0 127.0 128.0 163.0 122.0 184.0 128.0 09:36:40 INFO - PROCESS | 4834 | 09:36:40 INFO - PROCESS | 4834 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:0.88 (0.5%) stddev-sans-first:0.93 09:36:40 INFO - PROCESS | 4834 | Values: 161.0 162.0 162.0 161.0 160.0 160.0 162.0 162.0 160.0 161.0 09:36:40 INFO - PROCESS | 4834 | 09:36:40 INFO - PROCESS | 4834 | [#3] audio-fft Cycles:10 Average:82.80 Median:75.50 stddev:15.46 (20.5%) stddev-sans-first:16.07 09:36:40 INFO - PROCESS | 4834 | Values: 74.0 76.0 75.0 121.0 78.0 77.0 75.0 77.0 100.0 75.0 09:36:40 INFO - PROCESS | 4834 | 09:36:40 INFO - PROCESS | 4834 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:85.00 stddev:18.33 (21.6%) stddev-sans-first:19.11 09:36:40 INFO - PROCESS | 4834 | Values: 87.0 85.0 123.0 85.0 85.0 84.0 121.0 85.0 85.0 125.0 09:36:40 INFO - PROCESS | 4834 | 09:36:40 INFO - PROCESS | 4834 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.53 09:36:40 INFO - PROCESS | 4834 | Values: 119.0 118.0 117.0 118.0 117.0 117.0 117.0 118.0 117.0 118.0 09:36:40 INFO - PROCESS | 4834 | 09:36:40 INFO - PROCESS | 4834 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 09:36:40 INFO - PROCESS | 4834 | Values: 147.0 147.0 146.0 146.0 147.0 146.0 148.0 146.0 147.0 146.0 09:36:40 INFO - PROCESS | 4834 | 09:36:40 INFO - PROCESS | 4834 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 09:36:40 INFO - PROCESS | 4834 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 09:36:40 INFO - PROCESS | 4834 | 09:36:40 INFO - PROCESS | 4834 | [#8] json-parse-financial Cycles:10 Average:61.80 Median:62.00 stddev:0.92 (1.5%) stddev-sans-first:0.87 09:36:40 INFO - PROCESS | 4834 | Values: 63.0 61.0 61.0 62.0 61.0 63.0 63.0 62.0 61.0 61.0 09:36:40 INFO - PROCESS | 4834 | 09:36:40 INFO - PROCESS | 4834 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 09:36:40 INFO - PROCESS | 4834 | Values: 66.0 65.0 66.0 65.0 67.0 65.0 67.0 66.0 66.0 65.0 09:36:40 INFO - PROCESS | 4834 | 09:36:40 INFO - PROCESS | 4834 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:80.50 stddev:2.50 (3.1%) stddev-sans-first:2.65 09:36:40 INFO - PROCESS | 4834 | Values: 81.0 78.0 80.0 83.0 85.0 80.0 79.0 79.0 78.0 84.0 09:36:40 INFO - PROCESS | 4834 | 09:36:40 INFO - PROCESS | 4834 | [#11] stanford-crypto-ccm Cycles:10 Average:137.10 Median:134.50 stddev:12.24 (9.1%) stddev-sans-first:12.93 09:36:40 INFO - PROCESS | 4834 | Values: 134.0 135.0 130.0 131.0 139.0 133.0 132.0 136.0 171.0 130.0 09:36:40 INFO - PROCESS | 4834 | 09:36:40 INFO - PROCESS | 4834 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.00 Median:169.50 stddev:1.25 (0.7%) stddev-sans-first:1.09 09:36:40 INFO - PROCESS | 4834 | Values: 167.0 170.0 168.0 170.0 170.0 169.0 168.0 169.0 171.0 168.0 09:36:40 INFO - PROCESS | 4834 | 09:36:40 INFO - PROCESS | 4834 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:1.34 (2.0%) stddev-sans-first:1.39 09:36:40 INFO - PROCESS | 4834 | Values: 68.0 67.0 69.0 67.0 70.0 66.0 67.0 67.0 66.0 66.0 09:36:40 INFO - PROCESS | 4834 | -------- Summary: end -------- 09:36:40 INFO - PROCESS | 4834 | 09:36:41 INFO - TEST-INFO | 4834: exit 0 09:36:41 INFO - TEST-OK | kraken | took 63597ms 09:36:41 INFO - SUITE-END | took 1183s 09:36:42 INFO - Completed test suite (00:19:43) 09:36:42 INFO - javascript benchmark 09:36:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2578.149210760449, 2620.2270330252572, 2662.015054429861, 2675.7725593324567, 2681.503921774472, 4579.221532339502, 4651.069786042788, 4750.1428819919, 4900.583450406715, 4914.950850491494, 4647.674662773607, 4649.349091127245, 4657.953420465794, 4752.786124624392, 4807.23084306511, 4360.324149756792, 4409.29451287794, 4410.6030457259, 4447.288433850576, 4451.910961780763, 4349.934750978738, 4454.309582014793, 4476.955230447703, 4501.887452813673, 4547.772611369435, 4482.910341793162, 4529.660275479336, 4535.160995215879, 4551.863444096666, 4553.4991150973365, 4272.6795490338345, 4287.035417031174, 4287.656987440997, 4363.803628836678, 4384.320430333303, 4316.136772645452, 4338.891527711801, 4349.586789255016, 4355.477342718862, 4355.956440435587, 4775.880602984918, 4780.569748722597, 4812.663113582051, 4820.9634928490195, 4876.634252431082, 4957.132501812204, 5117.8464646060675, 5159.922601160985, 5176.120059589879, 5182.222666600002, 5070.264811602334, 5117.283580298761, 5122.359705036871, 5138.46046165151, 5143.8456846294675, 4780.282957556395, 4815.879603009917, 4825.565699087099, 4828.637852161031, 4829.154897892855, 5070.594352451795, 5151.07280689472, 5299.284596579412, 5302.045631786315, 5312.601554883399, 4988.925166122511, 5048.596112311006, 5052.621053421009, 5075.492450754969, 5095.414027386898, 5105.642605017613, 5109.978004399135, 5145.408278048072, 5147.97426012875, 5161.406438259648, 4936.234883593049, 4997.375328083989, 5007.599392048627, 5009.173486374781, 5056.393232812013, 4982.825601104017, 4983.103041452573, 5042.621803364762, 5086.4659210783075, 5100.464451232641, 4306.978465107717, 4323.6757243206885, 4325.070109926381, 4333.068390296102, 4360.345948107809, 3790.886273411802, 3792.563855156637, 3797.3924172132324, 3819.4461803038403, 3819.8663046793786, 4231.682623803165, 4307.332363483665, 4356.194104090753, 4363.192809330284, 4395.406620106309, 5085.847424577195, 5089.465606111305, 5102.234664800236, 5122.718250496258, 5159.25190847325, 4371.278739008092, 4373.387725718402, 4383.824647014084, 4404.647628189737, 4428.158649856517, 4442.311441726538, 4565.543445655474, 4569.611583015414, 4591.47198072226, 4618.122556714214, 4847.491013443538, 4855.708657480563, 4876.634252431011, 4893.657443978887, 4903.33804936329, 5124.359455068116, 5137.306463627362, 5160.845174644616, 5162.483751624807, 5169.379674439091, 4689.6717229793585, 4828.275758636232, 4867.537583929521, 4873.780679869344, 4893.070316639827, 5090.796368145233, 5105.336306280308, 5114.0, 5117.667351622282, 5146.25379320004, 5171.482851714798, 5178.844634660966, 5199.142141546602, 5199.974000129975, 5245.6852588844795, 4828.4688684244, 4924.778384972613, 4957.702537847741, 4970.726610036482, 5034.521720436553, 4960.627952903475, 4977.552020318189, 4984.675996060245, 4999.225120106389, 5029.874253143701, 4919.950800492093, 4935.851924442129, 4945.579625731853, 4956.876078097932, 4968.981358821506, 4865.051314993542, 4922.532359425992, 4926.211806111005, 4986.825461108844, 5023.748812559431, 4892.68197567157, 4893.975530122327, 4895.853124406273, 4916.262560615936, 4942.925856112233], "value": 4692.662693076338, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.5920925747347, 586.9559783016274, 592.6414519215874, 593.5162842283538, 604.6674329118983, 26907.865460672692, 41973.58026419735, 43256.78371608137, 43369.91575210625, 43410.13179736403, 40401.59598404022, 40793.7960310198, 40888.29784574775, 40896.182076358455, 40916.0, 7730.072391313036, 7880.960595197016, 7881.527108373516, 7883.408744344169, 7887.921120788805, 7440.888386674204, 9488.810223795519, 9712.22302215821, 9716.222702183844, 9970.551325190383, 10137.087662110409, 10213.182945364353, 10237.897621023769, 10238.948805255963, 10247.538860751283, 9982.700518984442, 10052.045055719695, 10053.648122315757, 10062.89937100627, 10064.49677516125, 9648.517574121266, 9694.466804325759, 9701.757456063584, 9707.223422126213, 9713.660021899199, 38092.61907380918, 38347.23305533874, 38358.808205959074, 38415.61584384176, 38416.42375364372, 2773.1541879726674, 2826.9575956360673, 2845.5447128459555, 2863.141057682687, 3178.666240044785, 28533.144005679864, 28576.28559286014, 28999.275018124717, 29163.41673166546, 29501.557476637867, 2725.8637068146713, 2802.677692065398, 2820.8307501549766, 2826.7738580913683, 2837.6305240758193, 249103.0, 249120.0, 250050.0, 250744.0, 251181.0, 51018.74490627523, 51280.0, 51310.48689513132, 51415.48584514182, 51558.74220628873, 32700.345993080005, 33677.0, 33711.0, 47929.76035119802, 47982.28026579604, 13524.12093213938, 13700.24648644334, 13700.65748356279, 13708.108972916729, 13714.65713357174, 9921.553530091163, 10536.631217907336, 10761.623343183108, 10936.835947460635, 10943.945280273547, 17354.566135846704, 17866.19602117908, 17880.731789023175, 17903.73144402835, 18096.366627167987, 6712.261651218362, 6742.83142921421, 6772.2211945625895, 6864.519483636098, 7047.89428158578, 815.8857759913617, 868.1101870582703, 937.0722984245684, 946.2808265717966, 985.6205360935948, 27934.3016424591, 28101.578476322873, 28146.85926570395, 28400.147995560168, 28603.427931441256, 926.6895589977433, 962.7881865989611, 975.4683697384942, 1052.4369462337613, 1077.3482043363651, 14724.779128313085, 14928.701425971636, 15058.171800551076, 15089.24553772307, 15205.239738013055, 405639.0, 410074.0, 411082.0, 412552.0, 412756.0, 48105.51894481081, 48675.513244867805, 48756.756216218695, 48758.5124148754, 48769.75615121973, 1072.1797824664138, 1114.793763153819, 1123.2137503747572, 1168.456667649547, 1197.9041676665845, 20867.304045202996, 27312.0, 28048.71951280461, 29560.122579774095, 30160.396792064475, 45275.54724452713, 45692.314615280135, 45735.0, 45844.31233531433, 45909.31136033029, 349787.0, 353160.0, 354242.0, 354497.0, 355179.0, 20062.699059514413, 21900.780992189873, 24585.0, 24697.753022469544, 25036.874815625804, 39951.20097597974, 40249.0, 40352.59647403606, 40446.0, 40461.0, 34332.82833585816, 34626.48060279148, 34718.30563388667, 35055.64944350524, 35593.46609800907, 35291.470627940085, 35365.64634353624, 35498.64501354953, 36109.0972725684, 36169.27661446704, 34557.481637775956, 34733.0, 35244.29511409809, 35414.64585354114, 35810.0, 30356.0, 32269.35461290714, 32539.674603253665, 32566.34867302688, 32789.83605081959, 24721.381965451008, 25116.0, 25214.62178067367, 25459.49081018332, 25643.230703078938], "value": 17614.63754816746, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.33490358896563, 347.0179392319735, 349.4932348095261, 355.6674509333773, 365.48466662006575, 12744.872551274497, 16023.359065637374, 16251.431199908006, 16749.078800665957, 16929.66140677186, 17102.657946841056, 17145.74281385777, 17171.742423863652, 17364.739528907077, 17399.34706202912, 4409.184300904327, 4986.925196122052, 5179.870503237412, 5192.091384007784, 5216.452272511388, 5139.640225184238, 5217.087009773293, 5220.373555173384, 5231.843044708646, 5232.92150617741, 4922.064807686528, 5035.647504674675, 5188.16989281715, 5190.636655434121, 5192.844214673566, 5031.823886163985, 5084.694918304895, 5096.694198348111, 5097.643164978453, 5100.464451232604, 4354.477462704464, 4472.664550158718, 4500.302453119772, 4522.796474158671, 4523.592876641118, 20519.5896082079, 20735.0, 20783.896080519502, 20866.79133208679, 21038.684419733716, 1769.6814573376787, 1787.6156626325273, 1821.4444594398703, 2024.1093918675735, 2228.2423975848287, 13003.284819334933, 13254.801177982337, 13463.932680336535, 13933.233672148028, 13995.30023498821, 1660.418853401312, 1669.190442635321, 1690.6196105876202, 1700.3538655311027, 1761.6212514309484, 69772.0, 70252.0, 70916.0, 71821.6408917952, 73485.0, 9024.819503609891, 9082.727518174466, 9266.629334826532, 9298.349115561845, 9448.149666529907, 12189.51241950312, 12193.207441516273, 12206.938965305117, 12213.267203967791, 12220.877791222152, 7046.506744527834, 7135.072440582795, 7209.531380460253, 7292.3801476874, 7366.189719130892, 6991.19601245853, 7098.716051357887, 7173.426125909915, 7311.597862117635, 7338.192798792129, 6087.391260873966, 6209.9068513972325, 6216.818804427145, 6226.844328891814, 6320.431161195423, 1651.7604947282578, 1706.2833609883878, 1720.9483715488554, 1739.1391261325725, 1758.5603599100225, 887.2502735188755, 897.9730608081637, 946.4368700623119, 947.3889341374775, 969.5055521683992, 16876.240569174417, 17555.82444175542, 18397.724034139497, 18565.535861603566, 18877.339293124674, 883.5979629268668, 887.2813021452644, 898.9056149104381, 902.6930843513237, 908.5139450394007, 9545.809083818285, 10230.897691022994, 10478.109360704273, 10496.212784041074, 10535.683929482127, 403453.0, 419405.0, 425673.0, 426960.0, 428782.0, 72046.0, 72279.0, 72364.63817680877, 73758.0, 74390.62804685942, 876.2814492116531, 885.9069797671281, 894.4499133033138, 916.0015583014413, 928.1831987850649, 14797.112173269637, 15193.696126077637, 15568.766468503209, 15666.608334791266, 15721.0, 41087.178256435305, 41109.58890411058, 41115.588844112375, 41718.374224386054, 41986.79006605069, 54137.458625413245, 55570.0, 55722.72138639281, 56444.71777641086, 57187.714061429426, 7535.962320188364, 7583.658735357032, 7611.010568626043, 7654.655540500802, 7756.0304961879765, 10902.0, 11527.193096483166, 11661.0, 11910.404479775803, 12159.939200304296, 4983.27742477346, 10225.59097636116, 10263.0, 10277.476901882423, 10513.474326283502, 9838.901610984085, 10090.344127631974, 10250.897491025293, 10258.333208341433, 10448.32085914413, 9383.483908385104, 10006.349587276804, 10160.08559229673, 10248.64129755455, 10527.210459215436, 7402.629868506661, 7592.658330375257, 7659.846803063796, 7732.188120247293, 7802.531848089133, 9363.531823408666, 9841.311108222355, 10437.530311136168, 10528.052475277262, 10769.676909692722], "value": 8290.33023631181, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1153.3771763247844, 1167.3112863410586, 1261.28106979022, 1301.4598941439303, 1621.7243068678324, 6597.175353080859, 7455.254474552542, 7778.377729781625, 7782.571958542278, 8028.076771171317, 7828.138904720477, 7885.172056934025, 7889.053313602361, 7890.605469726505, 7902.960485197566, 2107.704921311014, 2139.358192542239, 2139.935801925945, 2141.1328411993168, 2142.475093602062, 2051.866628669139, 2107.7365329333834, 2113.2497963223063, 2115.841311901606, 2118.766935637079, 2063.515073957619, 2084.2809230815346, 2091.1530830013867, 2093.675480300556, 2103.8737675739426, 2055.352563942361, 2056.352249041547, 2061.494933741243, 2061.701053347264, 2062.669972804359, 2028.7261219735442, 2040.0411806450945, 2065.215218217083, 2071.7721050684563, 2072.0365030261, 7677.500962437423, 7706.460547761659, 7780.533168009937, 7790.065192176919, 7790.143084260727, 4334.674899382528, 4488.8877778055485, 4491.416115904912, 4491.663125265585, 4501.549845015505, 2695.447433276174, 2775.777937764974, 2840.3751174741524, 2843.815152015133, 2850.686424493304, 887.3123279776601, 896.8116695493954, 909.1862782809415, 912.63494602159, 913.7943962608426, 10558.630447934285, 10722.839157412645, 10749.978752018624, 10761.946190268998, 10764.0, 3776.4712940188397, 3969.4839670842607, 4080.5307389649975, 4113.177364527107, 4118.567550407224, 8414.579271036424, 8425.95787021061, 8426.07313195548, 8432.873506897402, 8435.578221088921, 4438.023634800339, 4440.533743956903, 4441.156180325728, 4441.222786012435, 4445.244308467568, 3552.4316109422884, 3943.2704949583845, 4072.226277007359, 4084.2648323301496, 4087.243859885871, 3226.596675415573, 3231.079142444392, 3341.331733653279, 3344.0970937846646, 3374.814385208788, 969.8469397936569, 973.6592192732628, 978.090375950373, 985.3545927417409, 989.1246247071393, 748.3115533709001, 764.5489161394804, 766.3600893254195, 775.3758224629228, 778.3928535742131, 5084.923726144111, 5143.7685304161405, 5173.586113110942, 5333.386660534088, 5529.806456773994, 390.43192155413806, 396.44101816438683, 399.5964076282975, 403.4492917168103, 414.1117303384224, 3650.0509867434657, 3686.0, 3701.2967536168044, 3719.814009299578, 3735.9813200933822, 9414.764630884283, 9944.35361701487, 9971.152452041657, 9995.550200241007, 10005.099541041196, 9633.229341652652, 9715.854262186072, 9721.513924303898, 9850.408975461496, 9874.160696340892, 7459.925400746031, 7525.698972041167, 7527.887081693779, 7528.435367347471, 7534.623268836536, 5021.0, 5134.332536770196, 5148.099082660445, 5184.714840683648, 5457.263269458573, 8809.691660791841, 8883.289336852908, 8947.284217262733, 9031.27749780029, 9082.36423450352, 9054.411463254868, 9059.320550958573, 9257.444553326823, 9298.814023719622, 9346.252299815862, 5507.146392309199, 6300.558960872695, 6410.230772307353, 6412.743490260337, 6415.3263907289065, 7131.786046418616, 7330.523515971445, 7391.8152046199275, 7547.73582924595, 7555.16893141743, 6670.0, 6744.0895479109695, 6750.05499230118, 6751.864962700817, 6836.316368363124, 6686.966565167143, 6717.193936727624, 6727.091842601186, 6737.898931515933, 6757.087793147862, 6147.139400483847, 6228.28374736893, 6236.220472440945, 6244.937550624436, 6248.625082494883, 4634.0, 4668.0, 4769.070031343994, 4772.5227477252, 4821.63837712166, 4517.277235642281, 4594.5864872161665, 4714.740689262124, 4720.362751028567, 4950.257461380822], "value": 3947.7252927858362, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.38356225895456, 292.9340898297883, 295.6216043464365, 296.40126943573983, 298.7639764585977, 4828.541288577584, 4881.682690625112, 4896.951030489694, 4898.559129678329, 4898.779554920028, 4545.522720114382, 4702.788374523147, 4710.128626204146, 4711.9528804711945, 4833.564979151875, 3669.743117981742, 3722.7207959403017, 3737.6636102750813, 3781.1681430085337, 3800.2019575888958, 3792.8672496462627, 3802.2965751335955, 3802.8098595070273, 3810.8475660973527, 3832.6742226910746, 3692.13234889802, 3779.5086638736925, 3793.653253095139, 3799.67702745267, 3805.1248212911046, 3610.718195040749, 3709.7959612221316, 3757.9248415031684, 3769.6418840210135, 3814.218085292536, 3352.363051020323, 3358.22760765023, 3365.293288409437, 3376.9831150844334, 3378.4425569780956, 4736.810527578893, 4741.193997020515, 4749.316636100592, 4752.809887604491, 4763.333133361298, 4273.914521709579, 4275.72152185363, 4306.126834826829, 4324.243257429968, 4369.60673539383, 4992.775325110342, 5012.195609580548, 5016.548510634024, 5033.647644664875, 5040.59675225981, 3633.16437219441, 3638.7634803737674, 3642.579394036328, 3643.890683279506, 3662.230931504387, 5248.81629142982, 5276.92084618731, 5280.3663560373, 5283.762230699589, 5291.206319052173, 3635.690966267897, 3684.9263014739554, 3752.7560708553856, 3777.206786574795, 3777.7544459610035, 3808.7143464240294, 3816.9809150954625, 3817.3701339279264, 3823.9426408603895, 3834.9041273968373, 4308.332208507686, 4313.460817397825, 4332.545082766264, 4337.327714204241, 4348.260795664744, 4954.430240522314, 5012.245714000071, 5022.42242142151, 5091.821786237538, 5097.133487307166, 1311.7901135818224, 1322.4247452358063, 1325.4227469311488, 1335.7929520924272, 1337.6856438736888, 837.4514692876176, 860.7116615933733, 871.4117970369975, 873.6243415331342, 878.3851304087037, 4065.5121385433936, 4071.75569465833, 4073.918521629551, 4084.4281800547947, 4090.754554726726, 4611.861644150681, 4643.930341044887, 4666.556677115668, 4672.439307283148, 4690.577847993629, 4051.2505186540584, 4070.4504891839815, 4074.738520121302, 4075.857344992911, 4091.1408604193452, 2410.614301711718, 2448.484968884883, 2481.3796550862285, 2486.2292689266387, 2496.750324967525, 4433.689641725113, 4433.689641725113, 4433.733975961452, 4436.378906953029, 4468.4637843458995, 4761.547652972962, 4780.306855505932, 4783.0, 4792.808287668454, 4802.447718512416, 4222.451081359465, 4365.5197928227235, 4369.169857727022, 4386.11397099244, 4429.143202634283, 4511.548845115462, 4577.0, 4586.541345865387, 4618.584327410549, 4619.812329492639, 4511.616512596466, 4518.36742856007, 4541.569405637214, 4546.4544254689645, 4551.0, 4041.2523683118716, 4366.607005369532, 4375.0, 4376.892406391497, 4430.800613972315, 3428.4343083390963, 3437.74216933726, 3452.2405070884365, 3456.3778519866664, 3459.7924124552605, 4598.6663867478055, 4641.976790116028, 4663.883402914954, 4672.8551504881525, 4678.438587369401, 4289.077848262514, 4523.23105072132, 4537.933585607314, 4547.40797745282, 4580.213716650575, 4458.375827384234, 4461.776911154494, 4476.641868650565, 4495.887602809956, 4506.774661266858, 4416.22716024688, 4417.447819022622, 4428.867133985986, 4447.73313601185, 4478.880279930017, 4512.435945506812, 4524.705894116872, 4534.480948882161, 4834.854954351375, 4852.75736213195, 4972.129877271391, 4985.277134815359, 4986.227134794112, 4990.50094990498, 4992.8751781205765], "value": 3646.6140876483446, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.8321386797828, 628.7327885648598, 682.7951614515644, 721.0626185958253, 727.5889122645705, 11641.12691548133, 12092.0, 12550.497980080809, 12583.748325033494, 12647.683807904807, 12653.810192847115, 12891.548795792149, 12926.28905410202, 12943.74112517749, 12974.54589089382, 620.7299824576302, 762.6110683551387, 778.3111945927866, 780.7696729464822, 781.3241546062643, 761.8323968726899, 783.8589053970312, 784.3607459920175, 786.3984052200071, 787.7518581646763, 826.7271800305884, 828.353883970504, 828.9792755181109, 829.0465964141225, 830.8255266394065, 646.5118835279382, 815.254042551065, 816.7835523586225, 816.9468984516017, 817.0, 569.857535616096, 580.9709514524299, 582.2343618142172, 585.4964730331911, 585.844751140948, 12680.112392132554, 12706.55527056558, 12715.0, 12725.363731813371, 12733.36333183337, 11533.769324613544, 12008.219465734699, 12066.939665301617, 12146.149769516138, 12595.24428534291, 9466.763330916714, 9712.70861874145, 11459.949029210993, 11479.13906457019, 11535.307881527051, 4055.2092341993325, 4057.229126465962, 4082.8571000015154, 4100.507939047304, 4266.168097221043, 62270.14710585229, 63145.0, 63304.68347658232, 64578.354216458174, 64637.67681161611, 9189.402688825205, 9252.583633736498, 9347.766305842408, 9508.191803696625, 9551.61793528265, 17509.94940303586, 17743.645127097385, 17745.378911738284, 17752.0, 18151.636967260845, 6198.318184999646, 6364.522660800459, 6373.968130159319, 6452.290248072708, 6557.606543607399, 3574.821258937043, 3583.928321433557, 3670.6145854685406, 3673.834677439522, 3760.172761992357, 2614.8038897082797, 2708.011575774828, 2709.214327844942, 2709.794141606966, 2718.646575945154, 468.7000319795334, 476.19523006119545, 483.69043811960375, 484.6268373352499, 486.30701250717584, 446.89721364086444, 542.0270614247436, 547.8904219156185, 549.6839317392515, 552.3787683149968, 7346.449016323797, 7543.622818859035, 7675.53946763196, 7675.692972281158, 7676.501027433199, 461.5107985535343, 485.7255650557424, 499.12901986034603, 510.58132331487826, 551.3246273315237, 3630.6550877666577, 3648.5609389940896, 3653.2510835279236, 3741.0834345585504, 3757.793321367351, 92891.0, 96740.51629741806, 100414.49792751136, 104452.47773761082, 105214.47392762988, 49949.50050499449, 50010.49989500131, 50620.0, 56286.718566407726, 81185.78221326567, 72576.63711681408, 75490.62254688691, 76430.6178469104, 79294.60352698315, 79322.0, 7048.0, 7148.392386647193, 7207.891881621885, 7230.13238411394, 7428.368588670023, 46214.227146371326, 46216.0, 47263.29105063358, 47383.28925066058, 48059.75970120127, 62480.0, 65829.0, 66803.66598166978, 66889.33110669025, 68471.65764171147, 8993.505357205417, 9192.17270445663, 9313.39462934907, 9403.34176607631, 9442.480663563296, 9531.332806703464, 9568.282378821477, 9599.808003840024, 9679.951600242235, 9691.418514889128, 9311.813763724553, 9317.208037316905, 9369.0, 9401.623935042522, 9437.480938548446, 9183.816323673624, 9353.298502612195, 9432.151106400457, 9540.761480963032, 9558.187554057706, 9190.724278271662, 9196.494192819458, 9252.444853308823, 9303.302252331237, 9345.0, 8325.791855203426, 8352.582370881553, 8368.707095251637, 8390.0, 8479.279261262614, 7999.800004999922, 8055.234752698484, 8271.13153118938, 8556.144385561394, 8634.09342019079], "value": 6100.859693283401, "unit": "score"}], "name": "dromaeo_css", "value": 6260.240893071806, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 115.0, 114.0, 113.0, 112.0, 113.0, 113.0, 114.0, 114.0, 114.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 123.0, 124.0, 184.0, 127.0, 128.0, 163.0, 122.0, 184.0, 128.0], "value": 142.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 161.0, 160.0, 160.0, 162.0, 162.0, 160.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 121.0, 78.0, 77.0, 75.0, 77.0, 100.0, 75.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 123.0, 85.0, 85.0, 84.0, 121.0, 85.0, 85.0, 125.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 148.0, 146.0, 147.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 61.0, 62.0, 61.0, 63.0, 63.0, 62.0, 61.0, 61.0], "value": 61.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 65.0, 67.0, 65.0, 67.0, 66.0, 66.0, 65.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 78.0, 80.0, 83.0, 85.0, 80.0, 79.0, 79.0, 78.0, 84.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 135.0, 130.0, 131.0, 139.0, 133.0, 132.0, 136.0, 171.0, 130.0], "value": 137.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 170.0, 168.0, 170.0, 170.0, 169.0, 168.0, 169.0, 171.0, 168.0], "value": 169.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 69.0, 67.0, 70.0, 66.0, 67.0, 67.0, 66.0, 66.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1536.8, "alertThreshold": 2.0}]} 09:36:42 INFO - Return code: 0 09:36:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:36:42 INFO - # TBPL SUCCESS # 09:36:42 INFO - Running post-action listener: _resource_record_post_action 09:36:42 INFO - [mozharness: 2016-07-28 16:36:42.588524Z] Finished run-tests step (success) 09:36:42 INFO - Running post-run listener: _resource_record_post_run 09:36:42 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 553373696; Read time: 16; Write time: 564596 09:36:42 INFO - TinderboxPrint: CPU usage
13.1% 09:36:42 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 09:36:42 INFO - TinderboxPrint: I/O write bytes / time
553,373,696 / 564,596 09:36:42 INFO - TinderboxPrint: CPU idle
8,322.3 (86.9%) 09:36:42 INFO - TinderboxPrint: CPU user
1,207.7 (12.6%) 09:36:42 INFO - TinderboxPrint: Swap in / out
0 / 0 09:36:42 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 246648832; Read time: 0; Write time: 269164 09:36:42 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288899072; Read time: 16; Write time: 288884 09:36:43 INFO - Running post-run listener: _upload_blobber_files 09:36:43 INFO - Blob upload gear active. 09:36:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:36:43 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:36:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:36:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:36:43 INFO - (blobuploader) - INFO - Open directory for files ... 09:36:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:36:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:36:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:36:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:36:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:36:54 INFO - (blobuploader) - INFO - Done attempting. 09:36:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:36:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:36:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:36:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:36:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:36:55 INFO - (blobuploader) - INFO - Done attempting. 09:36:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:36:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:36:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:36:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:36:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:36:55 INFO - (blobuploader) - INFO - Done attempting. 09:36:55 INFO - (blobuploader) - INFO - Iteration through files over. 09:36:55 INFO - Return code: 0 09:36:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:36:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:36:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/08cad4b6f24a476e2b039725e24625db3e974de7924b2015a75eecf12fbd9dbd9754e775aa14e214713cb905703b71c3b333deba5773f130f2b2eaf0c89a3ca6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0d1ba512bd9133ec4a6aaf48b5dde865e973499b0f256fd97f3fe11f6eba427f26f167b1131e52ba596d38847c856077e2aa7b766f41a1ef4e68770c689b6b7c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3a303394298f3dec930a402250473731f721f1fafd0edce977ccd2b20ef4ebdbeef0e10fece6f2c671f539f2ff2ef21ca50e1851af4bd1e070cb0e1cc46135f5"} 09:36:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:36:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:36:55 INFO - Contents: 09:36:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/08cad4b6f24a476e2b039725e24625db3e974de7924b2015a75eecf12fbd9dbd9754e775aa14e214713cb905703b71c3b333deba5773f130f2b2eaf0c89a3ca6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0d1ba512bd9133ec4a6aaf48b5dde865e973499b0f256fd97f3fe11f6eba427f26f167b1131e52ba596d38847c856077e2aa7b766f41a1ef4e68770c689b6b7c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3a303394298f3dec930a402250473731f721f1fafd0edce977ccd2b20ef4ebdbeef0e10fece6f2c671f539f2ff2ef21ca50e1851af4bd1e070cb0e1cc46135f5"} 09:36:55 INFO - Running post-run listener: copy_logs_to_upload_dir 09:36:55 INFO - Copying logs to upload dir... 09:36:55 INFO - mkdir: /builds/slave/test/build/upload/logs 09:36:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.486545 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-07-28 09:36:55.876534) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 09:36:55.880704) ========= 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=5bd038846534b2fdfa68eeae000001e2-1469722103.606545-1003784098 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/08cad4b6f24a476e2b039725e24625db3e974de7924b2015a75eecf12fbd9dbd9754e775aa14e214713cb905703b71c3b333deba5773f130f2b2eaf0c89a3ca6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0d1ba512bd9133ec4a6aaf48b5dde865e973499b0f256fd97f3fe11f6eba427f26f167b1131e52ba596d38847c856077e2aa7b766f41a1ef4e68770c689b6b7c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3a303394298f3dec930a402250473731f721f1fafd0edce977ccd2b20ef4ebdbeef0e10fece6f2c671f539f2ff2ef21ca50e1851af4bd1e070cb0e1cc46135f5"} build_url:https://queue.taskcluster.net/v1/task/WJ4YQRL-S1W0MXW5E5IF2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011537 build_url: 'https://queue.taskcluster.net/v1/task/WJ4YQRL-S1W0MXW5E5IF2A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/08cad4b6f24a476e2b039725e24625db3e974de7924b2015a75eecf12fbd9dbd9754e775aa14e214713cb905703b71c3b333deba5773f130f2b2eaf0c89a3ca6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0d1ba512bd9133ec4a6aaf48b5dde865e973499b0f256fd97f3fe11f6eba427f26f167b1131e52ba596d38847c856077e2aa7b766f41a1ef4e68770c689b6b7c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3a303394298f3dec930a402250473731f721f1fafd0edce977ccd2b20ef4ebdbeef0e10fece6f2c671f539f2ff2ef21ca50e1851af4bd1e070cb0e1cc46135f5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 09:36:55.906530) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 09:36:55.906855) ========= 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=5bd038846534b2fdfa68eeae000001e2-1469722103.606545-1003784098 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004403 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 09:36:55.991603) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 09:36:55.991967) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 09:36:55.992312) ========= ========= Total master_lag: 1.46 =========