builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-045 starttime: 1469654895.61 results: success (0) buildid: 20160727113025 builduid: 2e3cc821614546c0aef00acc97ce3af7 revision: 581ee0750f81067c33090c5d3958d757ff5f331b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 14:28:15.612059) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 14:28:15.612649) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 14:28:15.613465) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 14:28:15.637502) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 14:28:15.638216) ========= 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=4300f881736b422476174874000001bc-1469653058.743731-1773540073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-27 14:28:15-- 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% 42.0M=0s 2016-07-27 14:28:15 (42.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.090114 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 14:28:15.753002) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 14:28:15.753376) ========= 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=4300f881736b422476174874000001bc-1469653058.743731-1773540073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022966 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 14:28:15.813041) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 14:28:15.813466) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 581ee0750f81067c33090c5d3958d757ff5f331b --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 581ee0750f81067c33090c5d3958d757ff5f331b --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=4300f881736b422476174874000001bc-1469653058.743731-1773540073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-27 14:28:15,992 truncating revision to first 12 chars 2016-07-27 14:28:15,992 Setting DEBUG logging. 2016-07-27 14:28:15,993 attempt 1/10 2016-07-27 14:28:15,993 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/581ee0750f81?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-27 14:28:16,284 unpacking tar archive at: fx-team-581ee0750f81/testing/mozharness/ program finished with exit code 0 elapsedTime=0.629571 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 14:28:16.461589) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 14:28:16.461948) ========= script_repo_revision: 581ee0750f81067c33090c5d3958d757ff5f331b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 14:28:16.462380) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 14:28:16.462679) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 14:28:16.473629) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-07-27 14:28:16.473935) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4300f881736b422476174874000001bc-1469653058.743731-1773540073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:28:16 INFO - MultiFileLogger online at 20160727 14:28:16 in /builds/slave/test 14:28:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:28:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:28:16 INFO - {'append_to_log': False, 14:28:16 INFO - 'base_work_dir': '/builds/slave/test', 14:28:16 INFO - 'blob_upload_branch': 'Fx-Team', 14:28:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:28:16 INFO - 'branch': 'Fx-Team', 14:28:16 INFO - 'buildbot_json_path': 'buildprops.json', 14:28:16 INFO - 'config_files': ('talos/linux_config.py',), 14:28:16 INFO - 'default_actions': ('clobber', 14:28:16 INFO - 'read-buildbot-config', 14:28:16 INFO - 'download-and-extract', 14:28:16 INFO - 'populate-webroot', 14:28:16 INFO - 'create-virtualenv', 14:28:16 INFO - 'install', 14:28:16 INFO - 'run-tests'), 14:28:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:28:16 INFO - 'download_minidump_stackwalk': True, 14:28:16 INFO - 'download_symbols': 'ondemand', 14:28:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:28:16 INFO - 'tooltool.py': '/tools/tooltool.py', 14:28:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:28:16 INFO - '/tools/misc-python/virtualenv.py')}, 14:28:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:28:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:28:16 INFO - 'installer_path': 'installer.exe', 14:28:16 INFO - 'log_level': 'info', 14:28:16 INFO - 'log_name': 'talos', 14:28:16 INFO - 'log_to_console': True, 14:28:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:28:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:28:16 INFO - 'opt_config_files': (), 14:28:16 INFO - 'pip_index': False, 14:28:16 INFO - 'sps_profile': False, 14:28:16 INFO - 'sps_profile_interval': 0, 14:28:16 INFO - 'suite': 'dromaeojs', 14:28:16 INFO - 'system_bits': '32', 14:28:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:28:16 INFO - 'title': 'talos-linux64-ix-045', 14:28:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:28:16 INFO - 'use_talos_json': True, 14:28:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:28:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:28:16 INFO - 'work_dir': 'build'} 14:28:16 INFO - [mozharness: 2016-07-27 21:28:16.747475Z] Running clobber step. 14:28:16 INFO - Running pre-action listener: _resource_record_pre_action 14:28:16 INFO - Running main action method: clobber 14:28:16 INFO - rmtree: /builds/slave/test/build 14:28:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:28:17 INFO - Running post-action listener: _resource_record_post_action 14:28:17 INFO - [mozharness: 2016-07-27 21:28:17.220305Z] Finished clobber step (success) 14:28:17 INFO - [mozharness: 2016-07-27 21:28:17.220407Z] Running read-buildbot-config step. 14:28:17 INFO - Running pre-action listener: _resource_record_pre_action 14:28:17 INFO - Running main action method: read_buildbot_config 14:28:17 INFO - Using buildbot properties: 14:28:17 INFO - { 14:28:17 INFO - "project": "", 14:28:17 INFO - "product": "firefox", 14:28:17 INFO - "script_repo_revision": "production", 14:28:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:28:17 INFO - "repository": "", 14:28:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:28:17 INFO - "buildid": "20160727113025", 14:28:17 INFO - "pgo_build": "True", 14:28:17 INFO - "basedir": "/builds/slave/test", 14:28:17 INFO - "buildnumber": 935, 14:28:17 INFO - "slavename": "talos-linux64-ix-045", 14:28:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:28:17 INFO - "platform": "ubuntu64_hw", 14:28:17 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:28:17 INFO - "branch": "fx-team", 14:28:17 INFO - "repo_path": "integration/fx-team", 14:28:17 INFO - "revision": "581ee0750f81067c33090c5d3958d757ff5f331b", 14:28:17 INFO - "stage_platform": "linux64-pgo", 14:28:17 INFO - "builduid": "2e3cc821614546c0aef00acc97ce3af7", 14:28:17 INFO - "slavebuilddir": "test" 14:28:17 INFO - } 14:28:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/AtUPkPwIThiOCsD2S2pnHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 14:28:17 INFO - Running post-action listener: _resource_record_post_action 14:28:17 INFO - [mozharness: 2016-07-27 21:28:17.222810Z] Finished read-buildbot-config step (success) 14:28:17 INFO - [mozharness: 2016-07-27 21:28:17.222899Z] Running download-and-extract step. 14:28:17 INFO - Running pre-action listener: _resource_record_pre_action 14:28:17 INFO - Running main action method: download_and_extract 14:28:17 INFO - mkdir: /builds/slave/test/build/tests 14:28: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')]} 14:28:17 INFO - https://queue.taskcluster.net/v1/task/AtUPkPwIThiOCsD2S2pnHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:28:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtUPkPwIThiOCsD2S2pnHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:28:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtUPkPwIThiOCsD2S2pnHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:28:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtUPkPwIThiOCsD2S2pnHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:28:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtUPkPwIThiOCsD2S2pnHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:28:25 INFO - Downloaded 1361 bytes. 14:28:25 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:28:25 INFO - Using the following test package requirements: 14:28:25 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:28:25 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:28:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:28:25 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:28:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:28:25 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:28:25 INFO - u'jsshell-linux-x86_64.zip'], 14:28:25 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:28:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:28:25 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:28:25 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:28:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:28:25 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:28:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:28:25 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:28:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:28:25 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:28:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:28:25 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:28:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:25 INFO - https://queue.taskcluster.net/v1/task/AtUPkPwIThiOCsD2S2pnHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:28:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtUPkPwIThiOCsD2S2pnHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:28:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtUPkPwIThiOCsD2S2pnHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:28:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtUPkPwIThiOCsD2S2pnHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:28:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtUPkPwIThiOCsD2S2pnHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:28:27 INFO - Downloaded 24318440 bytes. 14:28:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:28:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:28:29 INFO - Return code: 0 14:28:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:28:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:29 INFO - https://queue.taskcluster.net/v1/task/AtUPkPwIThiOCsD2S2pnHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:28:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtUPkPwIThiOCsD2S2pnHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:28:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtUPkPwIThiOCsD2S2pnHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:28:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtUPkPwIThiOCsD2S2pnHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:28:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtUPkPwIThiOCsD2S2pnHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:28:31 INFO - Downloaded 24318440 bytes. 14:28:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:28:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:28:33 INFO - Return code: 0 14:28:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:33 INFO - https://queue.taskcluster.net/v1/task/AtUPkPwIThiOCsD2S2pnHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:28:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtUPkPwIThiOCsD2S2pnHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:28:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtUPkPwIThiOCsD2S2pnHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:28:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtUPkPwIThiOCsD2S2pnHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:28:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtUPkPwIThiOCsD2S2pnHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:28:33 INFO - Downloaded 14413725 bytes. 14:28:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:28:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:28:34 INFO - Return code: 0 14:28: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')]} 14:28:34 INFO - https://queue.taskcluster.net/v1/task/AtUPkPwIThiOCsD2S2pnHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:28:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtUPkPwIThiOCsD2S2pnHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:28:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtUPkPwIThiOCsD2S2pnHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:28:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtUPkPwIThiOCsD2S2pnHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:28:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtUPkPwIThiOCsD2S2pnHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:28:35 INFO - Downloaded 60984732 bytes. 14:28:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AtUPkPwIThiOCsD2S2pnHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:28:35 INFO - mkdir: /builds/slave/test/properties 14:28:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:28:35 INFO - Writing to file /builds/slave/test/properties/build_url 14:28:35 INFO - Contents: 14:28:35 INFO - build_url:https://queue.taskcluster.net/v1/task/AtUPkPwIThiOCsD2S2pnHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:28:36 INFO - Running post-action listener: _resource_record_post_action 14:28:36 INFO - Running post-action listener: set_extra_try_arguments 14:28:36 INFO - [mozharness: 2016-07-27 21:28:36.666674Z] Finished download-and-extract step (success) 14:28:36 INFO - [mozharness: 2016-07-27 21:28:36.666999Z] Running populate-webroot step. 14:28:36 INFO - Running pre-action listener: _resource_record_pre_action 14:28:36 INFO - Running main action method: populate_webroot 14:28:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:28:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:28:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:28:36 INFO - '--tppagecycles', 14:28:36 INFO - '7'], 14:28:36 INFO - 'tests': ['tsvgm']}}, 14:28:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:28:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:28:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:28:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:28:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:28:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:28:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:36 INFO - 'talos_options': ['--disable-e10s'], 14:28:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:28:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:28:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:36 INFO - 'talos_options': ['--disable-e10s'], 14:28:36 INFO - 'tests': ['damp', 'tps']}, 14:28:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:36 INFO - 'tests': ['damp', 'tps']}, 14:28:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:28:36 INFO - 'tests': ['dromaeo_dom']}, 14:28:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:28:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:28:36 INFO - 'tests': ['basic_compositor_video']}, 14:28:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:28:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:28:36 INFO - 'tests': ['a11yr', 14:28:36 INFO - 'ts_paint', 14:28:36 INFO - 'tpaint', 14:28:36 INFO - 'sessionrestore', 14:28:36 INFO - 'sessionrestore_no_auto_restore', 14:28:36 INFO - 'tabpaint']}, 14:28:36 INFO - 'other-e10s': {'tests': ['a11yr', 14:28:36 INFO - 'ts_paint', 14:28:36 INFO - 'tpaint', 14:28:36 INFO - 'sessionrestore', 14:28:36 INFO - 'sessionrestore_no_auto_restore', 14:28:36 INFO - 'tabpaint']}, 14:28:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:28:36 INFO - 'ts_paint', 14:28:36 INFO - 'tpaint', 14:28:36 INFO - 'sessionrestore', 14:28:36 INFO - 'sessionrestore_no_auto_restore', 14:28:36 INFO - 'tabpaint']}, 14:28:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:28:36 INFO - 'ts_paint', 14:28:36 INFO - 'tpaint', 14:28:36 INFO - 'sessionrestore', 14:28:36 INFO - 'sessionrestore_no_auto_restore', 14:28:36 INFO - 'tabpaint']}, 14:28:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:28:36 INFO - 'tests': ['a11yr', 14:28:36 INFO - 'ts_paint', 14:28:36 INFO - 'tpaint', 14:28:36 INFO - 'sessionrestore', 14:28:36 INFO - 'sessionrestore_no_auto_restore', 14:28:36 INFO - 'tabpaint']}, 14:28:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:28:36 INFO - 'tests': ['a11yr', 14:28:36 INFO - 'ts_paint', 14:28:36 INFO - 'tpaint', 14:28:36 INFO - 'sessionrestore', 14:28:36 INFO - 'sessionrestore_no_auto_restore', 14:28:36 INFO - 'tabpaint']}, 14:28:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:28:36 INFO - 'tests': ['tsvgx', 14:28:36 INFO - 'tsvgr_opacity', 14:28:36 INFO - 'tart', 14:28:36 INFO - 'tscrollx', 14:28:36 INFO - 'cart']}, 14:28:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:28:36 INFO - 'tsvgr_opacity', 14:28:36 INFO - 'tart', 14:28:36 INFO - 'tscrollx', 14:28:36 INFO - 'cart']}, 14:28:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:36 INFO - 'talos_options': ['--disable-e10s'], 14:28:36 INFO - 'tests': ['tp5o']}, 14:28:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:36 INFO - 'tests': ['tp5o']}, 14:28:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:36 INFO - 'talos_options': ['--disable-e10s', 14:28:36 INFO - '--xperf_path', 14:28:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:28:36 INFO - 'tests': ['tp5n']}, 14:28:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:36 INFO - 'talos_options': ['--xperf_path', 14:28:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:28:36 INFO - 'tests': ['tp5n']}}, 14:28:36 INFO - 'talos.zip': {'path': '', 14:28:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:28:36 INFO - Running post-action listener: _resource_record_post_action 14:28:36 INFO - [mozharness: 2016-07-27 21:28:36.689585Z] Finished populate-webroot step (success) 14:28:36 INFO - [mozharness: 2016-07-27 21:28:36.689674Z] Running create-virtualenv step. 14:28:36 INFO - Running pre-action listener: _resource_record_pre_action 14:28:36 INFO - Running main action method: create_virtualenv 14:28:36 INFO - Creating virtualenv /builds/slave/test/build/venv 14:28:36 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:28:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:28:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:28:36 INFO - Using real prefix '/usr' 14:28:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:28:37 INFO - Installing distribute.............................................................................................................................................................................................done. 14:28:39 INFO - Installing pip.................done. 14:28:39 INFO - Return code: 0 14:28:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:28:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:39 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 0x2886030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b47180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b453b0>, '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 0x2b462b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b46740>, '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': '4300f881736b422476174874000001bc-1469653058.743731-1773540073', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:28:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:28:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:28:39 INFO - Using env: {'DISPLAY': ':0', 14:28:39 INFO - 'HOME': '/home/cltbld', 14:28:39 INFO - 'LANG': 'en_US.UTF-8', 14:28:39 INFO - 'LANGUAGE': 'en_US:en', 14:28:39 INFO - 'LOGNAME': 'cltbld', 14:28:39 INFO - 'MAIL': '/var/mail/cltbld', 14:28:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:39 INFO - 'MOZ_NO_REMOTE': '1', 14:28:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:39 INFO - 'NO_EM_RESTART': '1', 14:28:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:39 INFO - 'PWD': '/builds/slave/test', 14:28:39 INFO - 'SHELL': '/bin/bash', 14:28:39 INFO - 'SHLVL': '1', 14:28:39 INFO - 'TERM': 'linux', 14:28:39 INFO - 'TMOUT': '86400', 14:28:39 INFO - 'USER': 'cltbld', 14:28:39 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1469653058.743731-1773540073', 14:28:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:39 INFO - '_': '/tools/buildbot/bin/python'} 14:28:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:39 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:28:39 INFO - Cleaning up... 14:28:39 INFO - Return code: 0 14:28:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:28:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:39 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 0x2886030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b47180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b453b0>, '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 0x2b462b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b46740>, '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': '4300f881736b422476174874000001bc-1469653058.743731-1773540073', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:28:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:28:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:28:39 INFO - Using env: {'DISPLAY': ':0', 14:28:39 INFO - 'HOME': '/home/cltbld', 14:28:39 INFO - 'LANG': 'en_US.UTF-8', 14:28:39 INFO - 'LANGUAGE': 'en_US:en', 14:28:39 INFO - 'LOGNAME': 'cltbld', 14:28:39 INFO - 'MAIL': '/var/mail/cltbld', 14:28:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:39 INFO - 'MOZ_NO_REMOTE': '1', 14:28:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:39 INFO - 'NO_EM_RESTART': '1', 14:28:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:39 INFO - 'PWD': '/builds/slave/test', 14:28:39 INFO - 'SHELL': '/bin/bash', 14:28:39 INFO - 'SHLVL': '1', 14:28:39 INFO - 'TERM': 'linux', 14:28:39 INFO - 'TMOUT': '86400', 14:28:39 INFO - 'USER': 'cltbld', 14:28:39 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1469653058.743731-1773540073', 14:28:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:39 INFO - '_': '/tools/buildbot/bin/python'} 14:28:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:39 INFO - Downloading/unpacking psutil>=3.1.1 14:28:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:28:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:28:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:28:41 INFO - Installing collected packages: psutil 14:28:41 INFO - Running setup.py install for psutil 14:28:41 INFO - building 'psutil._psutil_linux' extension 14:28:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:28:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:28:41 INFO - building 'psutil._psutil_posix' extension 14:28:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:28:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:28:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:28:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:28:42 INFO - Successfully installed psutil 14:28:42 INFO - Cleaning up... 14:28:42 INFO - Return code: 0 14:28:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:28:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:42 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 0x2886030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b47180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b453b0>, '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 0x2b462b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b46740>, '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': '4300f881736b422476174874000001bc-1469653058.743731-1773540073', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:28:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:28:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:28:42 INFO - Using env: {'DISPLAY': ':0', 14:28:42 INFO - 'HOME': '/home/cltbld', 14:28:42 INFO - 'LANG': 'en_US.UTF-8', 14:28:42 INFO - 'LANGUAGE': 'en_US:en', 14:28:42 INFO - 'LOGNAME': 'cltbld', 14:28:42 INFO - 'MAIL': '/var/mail/cltbld', 14:28:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:42 INFO - 'MOZ_NO_REMOTE': '1', 14:28:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:42 INFO - 'NO_EM_RESTART': '1', 14:28:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:42 INFO - 'PWD': '/builds/slave/test', 14:28:42 INFO - 'SHELL': '/bin/bash', 14:28:42 INFO - 'SHLVL': '1', 14:28:42 INFO - 'TERM': 'linux', 14:28:42 INFO - 'TMOUT': '86400', 14:28:42 INFO - 'USER': 'cltbld', 14:28:42 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1469653058.743731-1773540073', 14:28:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:42 INFO - '_': '/tools/buildbot/bin/python'} 14:28:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:28:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:28:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:28:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:28:44 INFO - Installing collected packages: mozsystemmonitor 14:28:44 INFO - Running setup.py install for mozsystemmonitor 14:28:44 INFO - Successfully installed mozsystemmonitor 14:28:44 INFO - Cleaning up... 14:28:44 INFO - Return code: 0 14:28:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:28:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2886030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b47180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b453b0>, '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 0x2b462b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b46740>, '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': '4300f881736b422476174874000001bc-1469653058.743731-1773540073', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:28:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:28:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:28:44 INFO - Using env: {'DISPLAY': ':0', 14:28:44 INFO - 'HOME': '/home/cltbld', 14:28:44 INFO - 'LANG': 'en_US.UTF-8', 14:28:44 INFO - 'LANGUAGE': 'en_US:en', 14:28:44 INFO - 'LOGNAME': 'cltbld', 14:28:44 INFO - 'MAIL': '/var/mail/cltbld', 14:28:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:44 INFO - 'MOZ_NO_REMOTE': '1', 14:28:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:44 INFO - 'NO_EM_RESTART': '1', 14:28:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:44 INFO - 'PWD': '/builds/slave/test', 14:28:44 INFO - 'SHELL': '/bin/bash', 14:28:44 INFO - 'SHLVL': '1', 14:28:44 INFO - 'TERM': 'linux', 14:28:44 INFO - 'TMOUT': '86400', 14:28:44 INFO - 'USER': 'cltbld', 14:28:44 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1469653058.743731-1773540073', 14:28:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:44 INFO - '_': '/tools/buildbot/bin/python'} 14:28:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:44 INFO - Downloading/unpacking jsonschema==2.5.1 14:28:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:28:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:28:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:46 INFO - Downloading functools32-3.2.3-2.tar.gz 14:28:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:28:46 INFO - warning: no files found matching '*.txt' 14:28:46 INFO - no previously-included directories found matching 'build' 14:28:46 INFO - no previously-included directories found matching 'dist' 14:28:46 INFO - no previously-included directories found matching '.git*' 14:28:46 INFO - Installing collected packages: jsonschema, functools32 14:28:47 INFO - Running setup.py install for functools32 14:28:47 INFO - warning: no files found matching '*.txt' 14:28:47 INFO - no previously-included directories found matching 'build' 14:28:47 INFO - no previously-included directories found matching 'dist' 14:28:47 INFO - no previously-included directories found matching '.git*' 14:28:47 INFO - Successfully installed jsonschema functools32 14:28:47 INFO - Cleaning up... 14:28:47 INFO - Return code: 0 14:28:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:47 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 0x2886030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b47180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b453b0>, '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 0x2b462b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b46740>, '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': '4300f881736b422476174874000001bc-1469653058.743731-1773540073', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:28:47 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 14:28:47 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 14:28:47 INFO - Using env: {'DISPLAY': ':0', 14:28:47 INFO - 'HOME': '/home/cltbld', 14:28:47 INFO - 'LANG': 'en_US.UTF-8', 14:28:47 INFO - 'LANGUAGE': 'en_US:en', 14:28:47 INFO - 'LOGNAME': 'cltbld', 14:28:47 INFO - 'MAIL': '/var/mail/cltbld', 14:28:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:47 INFO - 'MOZ_NO_REMOTE': '1', 14:28:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:47 INFO - 'NO_EM_RESTART': '1', 14:28:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:47 INFO - 'PWD': '/builds/slave/test', 14:28:47 INFO - 'SHELL': '/bin/bash', 14:28:47 INFO - 'SHLVL': '1', 14:28:47 INFO - 'TERM': 'linux', 14:28:47 INFO - 'TMOUT': '86400', 14:28:47 INFO - 'USER': 'cltbld', 14:28:47 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1469653058.743731-1773540073', 14:28:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:47 INFO - '_': '/tools/buildbot/bin/python'} 14:28:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:28:47 INFO - Cleaning up... 14:28:47 INFO - Return code: 0 14:28:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:47 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 0x2886030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b47180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b453b0>, '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 0x2b462b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b46740>, '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': '4300f881736b422476174874000001bc-1469653058.743731-1773540073', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:28:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:28:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:28:47 INFO - Using env: {'DISPLAY': ':0', 14:28:47 INFO - 'HOME': '/home/cltbld', 14:28:47 INFO - 'LANG': 'en_US.UTF-8', 14:28:47 INFO - 'LANGUAGE': 'en_US:en', 14:28:47 INFO - 'LOGNAME': 'cltbld', 14:28:47 INFO - 'MAIL': '/var/mail/cltbld', 14:28:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:47 INFO - 'MOZ_NO_REMOTE': '1', 14:28:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:47 INFO - 'NO_EM_RESTART': '1', 14:28:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:47 INFO - 'PWD': '/builds/slave/test', 14:28:47 INFO - 'SHELL': '/bin/bash', 14:28:47 INFO - 'SHLVL': '1', 14:28:47 INFO - 'TERM': 'linux', 14:28:47 INFO - 'TMOUT': '86400', 14:28:47 INFO - 'USER': 'cltbld', 14:28:47 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1469653058.743731-1773540073', 14:28:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:47 INFO - '_': '/tools/buildbot/bin/python'} 14:28:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:47 INFO - Downloading/unpacking blobuploader==1.2.4 14:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:49 INFO - Downloading blobuploader-1.2.4.tar.gz 14:28:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:28:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:28:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:28:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:28:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:50 INFO - Downloading docopt-0.6.1.tar.gz 14:28:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:28:50 INFO - Installing collected packages: blobuploader, requests, docopt 14:28:50 INFO - Running setup.py install for blobuploader 14:28:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:28:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:28:50 INFO - Running setup.py install for requests 14:28:50 INFO - Running setup.py install for docopt 14:28:51 INFO - Successfully installed blobuploader requests docopt 14:28:51 INFO - Cleaning up... 14:28:51 INFO - Return code: 0 14:28:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:28:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:51 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 0x2886030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b47180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b453b0>, '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 0x2b462b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b46740>, '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': '4300f881736b422476174874000001bc-1469653058.743731-1773540073', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:28:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:28:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:28:51 INFO - Using env: {'DISPLAY': ':0', 14:28:51 INFO - 'HOME': '/home/cltbld', 14:28:51 INFO - 'LANG': 'en_US.UTF-8', 14:28:51 INFO - 'LANGUAGE': 'en_US:en', 14:28:51 INFO - 'LOGNAME': 'cltbld', 14:28:51 INFO - 'MAIL': '/var/mail/cltbld', 14:28:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:51 INFO - 'MOZ_NO_REMOTE': '1', 14:28:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:51 INFO - 'NO_EM_RESTART': '1', 14:28:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:51 INFO - 'PWD': '/builds/slave/test', 14:28:51 INFO - 'SHELL': '/bin/bash', 14:28:51 INFO - 'SHLVL': '1', 14:28:51 INFO - 'TERM': 'linux', 14:28:51 INFO - 'TMOUT': '86400', 14:28:51 INFO - 'USER': 'cltbld', 14:28:51 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1469653058.743731-1773540073', 14:28:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:51 INFO - '_': '/tools/buildbot/bin/python'} 14:28:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:28:51 INFO - Running setup.py (path:/tmp/pip-0yvsDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:28:51 INFO - Running setup.py (path:/tmp/pip-htBR1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:28:51 INFO - Running setup.py (path:/tmp/pip-jNjQlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:28:51 INFO - Running setup.py (path:/tmp/pip-zRZeb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:28:51 INFO - Running setup.py (path:/tmp/pip-yAMeVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:28:51 INFO - Running setup.py (path:/tmp/pip-6uN_75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:28:51 INFO - Running setup.py (path:/tmp/pip-hvvE3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:28:51 INFO - Running setup.py (path:/tmp/pip-iQ72__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:28:51 INFO - Running setup.py (path:/tmp/pip-joCQog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:28:51 INFO - Running setup.py (path:/tmp/pip-VVFs7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:28:52 INFO - Running setup.py (path:/tmp/pip-Q9iOBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:28:52 INFO - Running setup.py (path:/tmp/pip-L1cDZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:28:52 INFO - Running setup.py (path:/tmp/pip-zqEKwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:28:52 INFO - Running setup.py (path:/tmp/pip-6SX2ac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:28:52 INFO - Running setup.py (path:/tmp/pip-vvSgIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:28:52 INFO - Running setup.py (path:/tmp/pip-Q4dPpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:28:52 INFO - Running setup.py (path:/tmp/pip-T5VK1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:28:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:28:52 INFO - Running setup.py install for manifestparser 14:28:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:28:52 INFO - Running setup.py install for mozcrash 14:28:52 INFO - Running setup.py install for mozdebug 14:28:52 INFO - Running setup.py install for mozdevice 14:28:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:28:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:28:52 INFO - Running setup.py install for mozfile 14:28:53 INFO - Running setup.py install for mozhttpd 14:28:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:28:53 INFO - Running setup.py install for mozinfo 14:28:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:28:53 INFO - Running setup.py install for mozInstall 14:28:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:28:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:28:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:28:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:28:53 INFO - Running setup.py install for mozleak 14:28:53 INFO - Running setup.py install for mozlog 14:28:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:28:53 INFO - Running setup.py install for moznetwork 14:28:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:28:53 INFO - Running setup.py install for mozprocess 14:28:53 INFO - Running setup.py install for mozprofile 14:28:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:28:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:28:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:28:53 INFO - Running setup.py install for mozrunner 14:28:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:28:54 INFO - Running setup.py install for mozscreenshot 14:28:54 INFO - Running setup.py install for moztest 14:28:54 INFO - Running setup.py install for mozversion 14:28:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:28:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:28:54 INFO - Cleaning up... 14:28:54 INFO - Return code: 0 14:28:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:28:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:54 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 0x2886030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b47180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b453b0>, '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 0x2b462b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b46740>, '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': '4300f881736b422476174874000001bc-1469653058.743731-1773540073', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:28:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:28:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:28:54 INFO - Using env: {'DISPLAY': ':0', 14:28:54 INFO - 'HOME': '/home/cltbld', 14:28:54 INFO - 'LANG': 'en_US.UTF-8', 14:28:54 INFO - 'LANGUAGE': 'en_US:en', 14:28:54 INFO - 'LOGNAME': 'cltbld', 14:28:54 INFO - 'MAIL': '/var/mail/cltbld', 14:28:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:54 INFO - 'MOZ_NO_REMOTE': '1', 14:28:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:54 INFO - 'NO_EM_RESTART': '1', 14:28:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:54 INFO - 'PWD': '/builds/slave/test', 14:28:54 INFO - 'SHELL': '/bin/bash', 14:28:54 INFO - 'SHLVL': '1', 14:28:54 INFO - 'TERM': 'linux', 14:28:54 INFO - 'TMOUT': '86400', 14:28:54 INFO - 'USER': 'cltbld', 14:28:54 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1469653058.743731-1773540073', 14:28:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:54 INFO - '_': '/tools/buildbot/bin/python'} 14:28:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:28:54 INFO - Running setup.py (path:/tmp/pip-qjmx8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:28:54 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:28:54 INFO - Running setup.py (path:/tmp/pip-lvgwqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:28:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:28:54 INFO - Running setup.py (path:/tmp/pip-lfiUjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:28:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:28:54 INFO - Running setup.py (path:/tmp/pip-CnA9mH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:28:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:28:54 INFO - Running setup.py (path:/tmp/pip-ytIOuz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:28:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:28:54 INFO - Running setup.py (path:/tmp/pip-POyIPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:28:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:28:54 INFO - Running setup.py (path:/tmp/pip-qVlXeM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:28:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:28:55 INFO - Running setup.py (path:/tmp/pip-eZ4ABW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:28:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:28:55 INFO - Running setup.py (path:/tmp/pip-UcMGh6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:28:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:28:55 INFO - Running setup.py (path:/tmp/pip-WYgXmq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:28:55 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)) 14:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:28:55 INFO - Running setup.py (path:/tmp/pip-gMwuUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:28:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:28:55 INFO - Running setup.py (path:/tmp/pip-pNSkql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:28:55 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)) 14:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:28:55 INFO - Running setup.py (path:/tmp/pip-Rvn6BO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:28:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:28:55 INFO - Running setup.py (path:/tmp/pip-bSbYkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:28:55 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)) 14:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:28:55 INFO - Running setup.py (path:/tmp/pip-StzgfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:28:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:28:55 INFO - Running setup.py (path:/tmp/pip-8Agwa9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:28:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:28:55 INFO - Running setup.py (path:/tmp/pip-mPl7oH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:28:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:28:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:28:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:28:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:28:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:28:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:28:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:28:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:57 INFO - Downloading blessings-1.6.tar.gz 14:28:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:28:57 INFO - Installing collected packages: blessings 14:28:57 INFO - Running setup.py install for blessings 14:28:57 INFO - Successfully installed blessings 14:28:57 INFO - Cleaning up... 14:28:57 INFO - Return code: 0 14:28:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:28:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:28:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:28:58 INFO - Reading from file tmpfile_stdout 14:28:58 INFO - Current package versions: 14:28:58 INFO - argparse == 1.2.1 14:28:58 INFO - blessings == 1.6 14:28:58 INFO - blobuploader == 1.2.4 14:28:58 INFO - docopt == 0.6.1 14:28:58 INFO - functools32 == 3.2.3-2 14:28:58 INFO - jsonschema == 2.5.1 14:28:58 INFO - manifestparser == 1.1 14:28:58 INFO - mozInstall == 1.12 14:28:58 INFO - mozcrash == 0.17 14:28:58 INFO - mozdebug == 0.1 14:28:58 INFO - mozdevice == 0.48 14:28:58 INFO - mozfile == 1.2 14:28:58 INFO - mozhttpd == 0.7 14:28:58 INFO - mozinfo == 0.9 14:28:58 INFO - mozleak == 0.1 14:28:58 INFO - mozlog == 3.3 14:28:58 INFO - moznetwork == 0.27 14:28:58 INFO - mozprocess == 0.23 14:28:58 INFO - mozprofile == 0.28 14:28:58 INFO - mozrunner == 6.12 14:28:58 INFO - mozscreenshot == 0.1 14:28:58 INFO - mozsystemmonitor == 0.3 14:28:58 INFO - moztest == 0.7 14:28:58 INFO - mozversion == 1.4 14:28:58 INFO - psutil == 3.1.1 14:28:58 INFO - requests == 1.2.3 14:28:58 INFO - wsgiref == 0.1.2 14:28:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:28:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:58 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 0x2886030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b47180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b453b0>, '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 0x2b462b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b46740>, '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': '4300f881736b422476174874000001bc-1469653058.743731-1773540073', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:28:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:28:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:28:58 INFO - Using env: {'DISPLAY': ':0', 14:28:58 INFO - 'HOME': '/home/cltbld', 14:28:58 INFO - 'LANG': 'en_US.UTF-8', 14:28:58 INFO - 'LANGUAGE': 'en_US:en', 14:28:58 INFO - 'LOGNAME': 'cltbld', 14:28:58 INFO - 'MAIL': '/var/mail/cltbld', 14:28:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:58 INFO - 'MOZ_NO_REMOTE': '1', 14:28:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:58 INFO - 'NO_EM_RESTART': '1', 14:28:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:58 INFO - 'PWD': '/builds/slave/test', 14:28:58 INFO - 'SHELL': '/bin/bash', 14:28:58 INFO - 'SHLVL': '1', 14:28:58 INFO - 'TERM': 'linux', 14:28:58 INFO - 'TMOUT': '86400', 14:28:58 INFO - 'USER': 'cltbld', 14:28:58 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1469653058.743731-1773540073', 14:28:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:58 INFO - '_': '/tools/buildbot/bin/python'} 14:28:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:28:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:28:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:28:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:28:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:28:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:28:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:28:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:28:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:28:58 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:28:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:28:58 INFO - Cleaning up... 14:28:58 INFO - Return code: 0 14:28:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:28:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:58 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 0x2886030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b47180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b453b0>, '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 0x2b462b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b46740>, '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': '4300f881736b422476174874000001bc-1469653058.743731-1773540073', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:28:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:28:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:28:58 INFO - Using env: {'DISPLAY': ':0', 14:28:58 INFO - 'HOME': '/home/cltbld', 14:28:58 INFO - 'LANG': 'en_US.UTF-8', 14:28:58 INFO - 'LANGUAGE': 'en_US:en', 14:28:58 INFO - 'LOGNAME': 'cltbld', 14:28:58 INFO - 'MAIL': '/var/mail/cltbld', 14:28:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:58 INFO - 'MOZ_NO_REMOTE': '1', 14:28:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:58 INFO - 'NO_EM_RESTART': '1', 14:28:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:58 INFO - 'PWD': '/builds/slave/test', 14:28:58 INFO - 'SHELL': '/bin/bash', 14:28:58 INFO - 'SHLVL': '1', 14:28:58 INFO - 'TERM': 'linux', 14:28:58 INFO - 'TMOUT': '86400', 14:28:58 INFO - 'USER': 'cltbld', 14:28:58 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1469653058.743731-1773540073', 14:28:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:58 INFO - '_': '/tools/buildbot/bin/python'} 14:28:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:28:58 INFO - Cleaning up... 14:28:58 INFO - Return code: 0 14:28:58 INFO - Running post-action listener: _resource_record_post_action 14:28:58 INFO - Running post-action listener: _start_resource_monitoring 14:28:58 INFO - Starting resource monitoring. 14:28:58 INFO - [mozharness: 2016-07-27 21:28:58.607521Z] Finished create-virtualenv step (success) 14:28:58 INFO - [mozharness: 2016-07-27 21:28:58.608039Z] Running install step. 14:28:58 INFO - Running pre-action listener: _resource_record_pre_action 14:28:58 INFO - Running main action method: install 14:28:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:28:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:28:58 INFO - Reading from file tmpfile_stdout 14:28:58 INFO - Detecting whether we're running mozinstall >=1.0... 14:28:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:28:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:28:58 INFO - Reading from file tmpfile_stdout 14:28:58 INFO - Output received: 14:28:58 INFO - Usage: mozinstall [options] installer 14:28:58 INFO - Options: 14:28:58 INFO - -h, --help show this help message and exit 14:28:58 INFO - -d DEST, --destination=DEST 14:28:58 INFO - Directory to install application into. [default: 14:28:58 INFO - "/builds/slave/test"] 14:28:58 INFO - --app=APP Application being installed. [default: firefox] 14:28:58 INFO - mkdir: /builds/slave/test/build/application 14:28:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:28:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:29:16 INFO - Reading from file tmpfile_stdout 14:29:16 INFO - Output received: 14:29:16 INFO - /builds/slave/test/build/application/firefox/firefox 14:29:16 INFO - Running post-action listener: _resource_record_post_action 14:29:16 INFO - [mozharness: 2016-07-27 21:29:16.223892Z] Finished install step (success) 14:29:16 INFO - [mozharness: 2016-07-27 21:29:16.224224Z] Running run-tests step. 14:29:16 INFO - Running pre-action listener: _resource_record_pre_action 14:29:16 INFO - Running main action method: run_tests 14:29:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:29:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:29:16 INFO - Python 2.7.3 14:29:16 INFO - Return code: 0 14:29:16 INFO - grabbing minidump binary from tooltool 14:29: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')]} 14:29:16 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 0x2b453b0>, '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 0x2b462b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b46740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:29:16 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:29:16 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:29:16 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:29:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:29:16 INFO - Return code: 0 14:29:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:29:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:29:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:29:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:29:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:29:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AtUPkPwIThiOCsD2S2pnHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:29:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AtUPkPwIThiOCsD2S2pnHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:29:16 INFO - Using env: {'DISPLAY': ':0', 14:29:16 INFO - 'HOME': '/home/cltbld', 14:29:16 INFO - 'LANG': 'en_US.UTF-8', 14:29:16 INFO - 'LANGUAGE': 'en_US:en', 14:29:16 INFO - 'LOGNAME': 'cltbld', 14:29:16 INFO - 'MAIL': '/var/mail/cltbld', 14:29:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:29:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:29:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:29:16 INFO - 'MOZ_NO_REMOTE': '1', 14:29:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:29:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:29:16 INFO - 'NO_EM_RESTART': '1', 14:29:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:29:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:29:16 INFO - 'PWD': '/builds/slave/test', 14:29:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:29:16 INFO - 'SHELL': '/bin/bash', 14:29:16 INFO - 'SHLVL': '1', 14:29:16 INFO - 'TERM': 'linux', 14:29:16 INFO - 'TMOUT': '86400', 14:29:16 INFO - 'USER': 'cltbld', 14:29:16 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1469653058.743731-1773540073', 14:29:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:29:16 INFO - '_': '/tools/buildbot/bin/python'} 14:29:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AtUPkPwIThiOCsD2S2pnHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:29:16 INFO - mozversion application_buildid: 20160727113025 14:29:16 INFO - mozversion application_changeset: 581ee0750f81067c33090c5d3958d757ff5f331b 14:29:16 INFO - mozversion application_display_name: Nightly 14:29:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:29:16 INFO - mozversion application_name: Firefox 14:29:16 INFO - mozversion application_remotingname: firefox 14:29:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:29:16 INFO - mozversion application_vendor: Mozilla 14:29:16 INFO - mozversion application_version: 50.0a1 14:29:16 INFO - mozversion platform_buildid: 20160727113025 14:29:16 INFO - mozversion platform_changeset: 581ee0750f81067c33090c5d3958d757ff5f331b 14:29:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:29:16 INFO - mozversion platform_version: 50.0a1 14:29:16 INFO - using testdate: 1469654956 14:29:16 INFO - actual date: 1469654956 14:29:16 INFO - starting webserver on 'localhost:59720' 14:29:16 INFO - SUITE-START | Running 2 tests 14:29:16 INFO - TEST-START | dromaeo_css 14:29:16 INFO - operating with platform_type : linux_ 14:29:16 INFO - Initialising browser for dromaeo_css test... 14:29:16 INFO - TEST-INFO | started process 9941 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTzvGIn/profile http://localhost:59720/getInfo.html) 14:29:19 INFO - PROCESS | 9941 | JavaScript error: , line 0: uncaught exception: undefined 14:29:20 INFO - PROCESS | 9941 | __metrics Screen width/height:1600/1200 14:29:20 INFO - PROCESS | 9941 | colorDepth:24 14:29:20 INFO - PROCESS | 9941 | Browser inner width/height: 1024/697 14:29:20 INFO - PROCESS | 9941 | __metrics 14:29:21 INFO - PROCESS | 9941 | 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" 14:29:21 INFO - PROCESS | 9941 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:29:22 INFO - TEST-INFO | 9941: exit 0 14:29:22 INFO - Browser initialized. 14:29:22 INFO - Running cycle 1/1 for dromaeo_css test... 14:29:22 INFO - TEST-INFO | started process 10022 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTzvGIn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:29:34 INFO - PROCESS | 10022 | RSS: Main: 157696000 14:29:34 INFO - PROCESS | 10022 | 14:30:25 INFO - PROCESS | 10022 | 1469655025393 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:32:33 INFO - PROCESS | 10022 | Cycle 1(1): loaded http://localhost:59720/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59720/tests/dromaeo/cssquery-ext.html) 14:32:34 INFO - PROCESS | 10022 | RSS: Main: 291778560 14:32:34 INFO - PROCESS | 10022 | 14:35:37 INFO - PROCESS | 10022 | Cycle 1(1): loaded http://localhost:59720/tests/dromaeo/cssquery-ext.html (next: http://localhost:59720/tests/dromaeo/cssquery-jquery.html) 14:35:37 INFO - PROCESS | 10022 | RSS: Main: 246059008 14:35:37 INFO - PROCESS | 10022 | 14:38:39 INFO - PROCESS | 10022 | Cycle 1(1): loaded http://localhost:59720/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59720/tests/dromaeo/cssquery-mootools.html) 14:38:40 INFO - PROCESS | 10022 | RSS: Main: 186990592 14:38:40 INFO - PROCESS | 10022 | 14:41:42 INFO - PROCESS | 10022 | Cycle 1(1): loaded http://localhost:59720/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59720/tests/dromaeo/cssquery-prototype.html) 14:41:42 INFO - PROCESS | 10022 | RSS: Main: 185536512 14:41:42 INFO - PROCESS | 10022 | 14:44:45 INFO - PROCESS | 10022 | Cycle 1(1): loaded http://localhost:59720/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59720/tests/dromaeo/cssquery-yui.html) 14:44:46 INFO - PROCESS | 10022 | RSS: Main: 186195968 14:44:46 INFO - PROCESS | 10022 | 14:47:48 INFO - PROCESS | 10022 | Cycle 1(1): loaded http://localhost:59720/tests/dromaeo/cssquery-yui.html (next: http://localhost:59720/tests/dromaeo/cssquery-dojo.html) 14:47:49 INFO - PROCESS | 10022 | RSS: Main: 280141824 14:47:49 INFO - PROCESS | 10022 | 14:47:49 INFO - PROCESS | 10022 | __start_tp_report 14:47:49 INFO - PROCESS | 10022 | _x_x_mozilla_page_load 14:47:49 INFO - PROCESS | 10022 | _x_x_mozilla_page_load_details 14:47:49 INFO - PROCESS | 10022 | |i|pagename|runs| 14:47:49 INFO - PROCESS | 10022 | |0;dojo.html;2960.7187317204857;2983.4629766641997;2995.400919816036;3075.5079187330025;3120.329129237214;5262.236975638531;5345.893082138355;5362.4637536246355;5444;5478.91781623276;5286.497782710637;5328.520433161015;5389.110796718537;5476.945230547693;5485.780568777254;4858.101251268509;4881.560659540641;4884.73133977632;4903.9754801225945;4930.580900623451;4954.331165292693;5019.121653710605;5021.924671129936;5023.6985780853265;5028.396592408916;4977.576905962997;4999.200127979524;5000.799968001275;5009.57418619416;5061;4515.006698526319;4784.856454306341;4827.51724827518;4878.121938051149;4948.430930443009;4900.558949694545;4910.558049775537;4915.361003069614;4957.033378491195;4966.180580204262;5419.674819510803;5445.591580631469;5451.964126815932;5476.561875049986;5483.588730845163;5656.85857853557;5681.914771278392;5733.598648094635;5792.942070579283;5857.297124345063;5811.0411782056335;5831.620944638585;5855.238818953551;5862.149988251722;5868.207791948075;5436.91844622331;5442.428545002796;5443.891122177534;5444.50999410051;5444.809431669913;5722.77108915647;5825.679587622722;5827.533797296206;5899.262592175978;5918.7928422505;5692.48767610917;5693.971530142406;5696.11710184922;5698.601097923189;5704.058830293038;5739.971300143473;5757.769689212385;5767.423257674283;5783.190353350535;5785.768569257182;5585.832425027255;5663.631863928914;5675.914861277001;5707.486326230659;5719.571032172604;5762.9135562966585;5764.106563482667;5766.192733017297;5828.5337173026055;5834.095715164156;4410.448693913261;4410.647148228134;4415.271480205794;4426.690131690815;4450.1989641864775;3897.863574774926;3908.0620651044114;3925.568187499373;3944.1717239379477;3955.3275943089743;5459.344878614592;5475.370332411744;5486.698231597221;5566.749496272678;5568.387477377485;5774.94225057744;5828.475437210672;5835.649861008353;5836.9124463133085;5886.05823068307;5366.168243922199;5474.042042642522;5519.503244707916;5564.27664403633;5568;4997.350344455271;5062.265971434122;5081.568066714371;5105.2086926526445;5125.436202017775;6024.518038556905;6054.485368743706;6064.272287325461;6064.605800622945;6068.059450785136;5658.20785090096;5721.485066344049;5766.538676905921;5799.594028417971;5809.954208242557;5921.259842519685;6098.481629061579;6110.144579758926;6120.112583675431;6125.050617154348;5636.661800291996;5689.573282003949;5703.686297253525;5709.314882214161;5751.1085781703905;5770.740316685843;5796.76812927495;5822.592418530831;5834.912476312944;5843.094320380348;5513.448655134454;5567.164925261081;5573.219749235192;5616.129499927518;5629.802956896489;5629.88740225185;5630.352509461464;5635.436456354496;5636.3799982002765;5674.4892959633835;5567.582431317586;5572.247746554325;5573.804916827891;5582.804601838916;5583.525400341016;5495.5878309127775;5647.6893770843;5651.237082993907;5696.088625820014;5697.829065128053;5558.360788509373;5594.13290939905;5598.300212473441;5602.803901863415;5637.041702910597 14:47:49 INFO - PROCESS | 10022 | |1;ext.html;587.6503480429143;608.0484042473529;625.7872323410039;630.4704048599177;651.160003595362;31145.532817007763;44056.118877622466;45162.32256516147;45260;45282;45883.31175032377;46253.306200406936;46264.76867615666;46314;46355.536444635545;8105.837883242331;9073.637054517827;9282.860757088616;9291.163795258426;10734.946325268364;10594;11143.498542565563;11146.331220126818;11157.609483668073;11166.441677916071;11140.220184587082;11193.552257909674;11203.663890083311;11234.10127189827;11245.325280483155;11128.944355278172;11156.944215278912;11202.21584489078;11207.159463040263;11231.831522527169;10853.837192442119;10929;10930.56277748889;10932.945335273273;10935.617253396173;43263;43502.56497435017;43611.34582981258;43618.909527261756;43669.126617467475;3531.5408996830506;3574.3566158091535;3622.0039489140436;3786.9431958520645;3823.770573765555;32905.50641740352;33031.50452743211;33432.33135337304;33837.6616233837;34583.4812477813;4345.543717909637;4347.30443129101;4390.16586848501;4390.582894625038;4419.756913369763;369663;370366;370542;370611;372839;34935;35911.28177436489;60078.098828517606;60224.39775602276;60256.39743602595;37182.44226336607;37188.81405592955;37370;37436.25127497435;37536;14504.419823206954;14600.707985840223;14614.196219207834;14617.488387906373;14618.853811461962;11000.339979601249;11705.765884682258;11916;11964.88035119655;11979.041676665845;8196.303314218358;8283.917160828436;8326.583670816435;8356.665733370597;8368.665253389918;3243.9675603243663;3274.705276525124;3281.4749640057476;3283.441814891474;3300.224447254893;1005.0251256281396;1055.9419231942163;1092.5575142067316;1103.536514663843;1145.2841973766397;33667.787061685165;34059.82970085134;34490.48264276038;34507;34778.652213477544;1122.2144498850837;1123.797716411054;1140.520981187903;1160.6924165096257;1184.248002518407;17628.823711762976;17787.110644467724;18039.458816235532;18043.368482103062;18064.909675451538;143817;144104.27947860403;144165.27917360346;144394;144859;61570.38429615736;62053;62150.378496215366;62184;62218.377816222164;1241.813727940816;1343.40890008396;1370.5477192526441;1387.2647496826698;1393.2546087842954;33350.332993339514;35204.647953520136;35362.29275414529;35375.11562210965;35387.2227249318;52109.47890521046;52718.47281527289;52820.471795281555;52822;52831.47168528265;376003;376056;376777;377545;377636;28070.298242543282;29358;29503.704962950094;29604.555931661474;30240.546391803702;46796.724229304986;46973.85627439481;47453.52546474629;47724.284135737296;48321.5167848317;39510.40734389044;39773;40300.596994029685;40368;41626.375604365356;39977;41001.58998410097;41150.38274425826;41546.58453415427;41746.37380439357;39491.2101757969;40365.39451908165;41116;41268.587314126475;41302.38046429246;33040.50439243461;35866.82066589651;35990;36576.81711591425;37303.76177429363;27618;27631.723682762917;27790.861045695452;27967.86016069988;28067.859660701564 14:47:49 INFO - PROCESS | 10022 | |2;jquery.html;374.9943750843739;380.39327272999554;392.63288824948677;396.5083296712077;406.42085028833907;16891;19143.138558764855;19179.424617261488;19460.248577628012;19939.800601993975;18898.52753681155;19119.330823421184;19363.4190974271;19464.318748843794;19806.90096549515;5087.643864929457;5573.637713548626;5723.742431590588;5797.681127537984;5803.6517808931385;5700.7719691212305;5736.827895163131;5780.971095144519;5785.421457854202;5792.391798861122;5524.558035357182;5611.270534830466;5644.01229784788;5769.105788602773;5769.567282453832;5602.467765562265;5623.353314368859;5631.7184140793;5631.943680563224;5639.464250896158;4901.656884018084;4975.875603109951;5110.693358398508;5134.281200631877;5145.562627176694;19692.90153549223;19730.605387892305;21640.134394624198;22927.541449170923;23027.654585181237;2475.9298420201517;2919.6934321896106;2985.4924662807375;3058.342456371891;3131.874725010997;14291;14330.35513401889;14439.927800361036;14525.346359413747;14579.708405831823;1942.8445724342018;1968.3209292793963;1988.920443182271;1998.1607724755493;2006.2576846566717;81449.18550814476;83011;83915.58042209811;84166;84170.57914710387;8713.651453941771;9012.504312262889;9151.084891510929;9269.44383337002;10342.37945723259;11784.764304713857;11835.644930651923;11849.585264515701;11854.170208085523;11857.644270671894;7288.453365997465;7404.444666650023;7438.888416673754;7493.552965635759;7601.505902116345;7534.321911028033;7585.431092668072;7668.233176682399;7764.417668674872;7784.532928024223;3663.4871118043493;3677.8712745053795;3768.924621507609;3772.9434058489146;3817.3319669057805;1800.216905646022;1827.6801559726994;1832.3495159218553;1847.4550007747746;1855.7030875060195;849.6516428264382;955.9378640388353;960.7598100474881;987.2003677021636;1018.6027449294781;18013.7297940531;18917.90541047286;18968.620627587647;19707.901460492605;19709.211631534865;955.9713208603614;972.8929817720045;978.3885071830106;983.4577616860353;990.9950450247702;10620.787584248272;10960.978796697736;11032.417459010321;11067.72330691739;11101.222914396076;525205;528200;537383;537787;539551;93491.53254233685;94329.5283523578;94805;96663;100977;969.060011788564;1001.6694490818013;1005.4620777883944;1017.1151098544166;1019.7603563162651;16443.835561644708;16680.24938877778;16867.325306987583;17344.392946246822;17986.190621421807;44200.55799441964;45304.54695453003;45430.545694542634;45562.544374557154;46186.30720539128;56754.60831221027;59957.40042599693;61938;62745.68627156835;63164;7808;7898.526088434713;7968;8191.098979112174;8200.671973121009;12570.62288131321;12857.678558036125;12911.160774549624;12970.610881673565;13160.736785264433;10748.301360411548;11549.133814963743;11635.709107272385;11648.184627076023;11771.764564708486;6404.679766011587;9689.612415503301;9722.9027709722;9748.756281093029;9932.304738668225;11394.316341019565;11555.653330400102;11661.35862527569;11883.346415947206;11978.58074967372;7822.100458447351;7920.287174154354;7967.601619918865;8119.106898241071;8476.406651534333;10255.282130250811;10727.624533141303;10937.453127343442;11103.888961110286;11364.943175284401 14:47:49 INFO - PROCESS | 10022 | |3;mootools.html;1348.7100273441208;1438.050886414966;1487.7470829958907;1622.9837701622987;1789.4899953513243;8348.582570871455;8695.304375649948;8714.782130446742;8950.149735775107;8952.060033696449;8737.737867863958;8834.293256539477;8844.823103537925;8846.071162527938;8846.867296990535;2328.16186172978;2345.777151170636;2349.318697577709;2354.1878052072007;2355.1756885090253;2282.3837563857746;2329.3827135809024;2366.0299277296313;2366.9171578994738;2371.95256094878;2213.756486786452;2247.1011595361824;2273.7271527416733;2295.5064661097863;2296.0586159674535;2261.378121016717;2268.296827983322;2281.498070424504;2282.9543409131725;2284.3375421127853;2201.25157446469;2209.458682622768;2216.601011817872;2217.933461996143;2222.6443768996883;8671.956640216758;8818.86771698425;8888.244499217575;8932.196102350754;8960.641574337084;4826.276058591205;4969.378827646544;4989.57588604969;4992.301077849104;4996.100701873661;3182.9681703182905;3312.5528053712683;3345.7323414126813;3368.461046232591;3373.190434295776;1039.8388249821214;1045.9738506537321;1047.8847326794046;1058.4972138234355;1067.6209945469325;12123.211991220542;12124.515019399214;12213.267203967791;12224.327661978588;12233.571824986082;4207.747535147901;4311.331743579687;4379.912401751947;4454.844080457168;4455.1312494064;9608;9609.183219426288;9629.759256018515;9634;9698.321117521706;5051.318072060299;5097.6941383517105;5098.821541246113;5099.36257967754;5101.8724531887;4170.35359519275;4255.5744425557195;4286.485621725413;4760.262159365304;4768.094062128184;3722.218334149805;3751.5498140222803;3813.961860381416;3859.073822282688;3865.8840234793;1129.5368898751472;1146.463738590293;1159.1769843411105;1169.859616845984;1172.6364826903687;911.4258017449097;949.3639261694681;1012.0790081026378;1012.3976234140674;1035.3684252605904;6057.878842423127;6183.412575805291;6230.688465576703;6254.718537665816;6344.49244060474;395.8594698881856;395.9564447910727;401.18158955730564;404.34496116291206;405.6714061610105;4160.667146628262;4191.7484950903045;4198.517170525368;4230.830766769294;4296.162248361602;10601.522931468102;10888.945555272174;10938.507767150497;10952.178586606036;10958.561657533768;10898.509567069501;10901.672949811518;10903.127749779998;10905.727356816144;10925.508352124014;7614.352780013761;7896.289333959971;7905.288524032865;8037.397195210266;8072.313853322534;5988.550858685703;5989.460948514655;6100.481459076028;6220.160278362544;6330.778422755181;9897.158741507052;10016.248781341283;10173.745656358355;10204.642837500653;10238.385696858213;9875.456849873326;9951.751206219613;10162.39025658463;10172.28793984414;10190.082892539707;7784.338331241682;7847.686092556234;7913.208679132271;7928.682852685828;7933.127355990951;8575.442596231225;8582.227599516074;8615.095414981588;8620.698275560326;8621;7527.585982771;7667.693292268247;7703.537787732754;7715.112762032438;7969.960150199212;7362.3741981932135;7376.704931802882;7435.925640743523;7610.429217808576;7673.117591477052;7165.3551180394015;7178.748743793943;7210.206877243604;7220.675069621774;7230.060092188192;5283.2254853160775;5295.099833028471;5412.702301373462;5497.45025497447;5563.109902415594;5373.946260537345;5536.058869992031;5546.473085056913;5552.833414997395;5568.443155684399 14:47:49 INFO - PROCESS | 10022 | |4;prototype.html;296.6321761016339;301.9124453908367;303.57347926163743;304.71509138955076;309.13904775201064;5350.2777125088105;5366.865828354293;5392.759665276979;5413.702246376452;5442.619016668835;5295.735213239342;5318.734063296839;5323.973380133104;5332;5335.439778823216;3942.8619998300064;4022.275990321741;4136.869512201219;4177.7284476509085;4192.853250136246;4140.937885931713;4148.357004664267;4149.3775933609895;4173.707840451169;4195.2238835815315;4144.171165766844;4147.440095587087;4147.979260103695;4157.230912281238;4165.916681666365;3947.723659343847;3953.6639385652397;4071.5724848890736;4104.753714777123;4136.875893723193;3574.249407624402;3581.6418358163974;3594.903554415902;3607.5851277103206;3609.3683605368956;5165.173572228426;5194.480551944813;5200.583953283728;5271.815486457994;5279.155335146396;4498.167838949772;4701.623870090384;4708.835190768341;4746.810127594892;4749.810007599692;5548.723793527471;5552.278203833475;5553.527950124244;5559.805406810783;5576.717355008371;4030.879073627796;4033.838646454138;4046;4050.602542122963;4054.9594504054876;5486.780528778844;5747.942520574783;5783.942160578383;5789.218455508494;5852.970735146339;3956.723029387973;3969.940450893239;3972;3985.322495175827;3993.101552150743;4052.0477687743355;4059.2693315202955;4059.512858457004;4063.2889244382113;4064.8170832312617;4519.322101684774;4698.577128058491;4705.976470117627;4709.95290047102;4749.881252968635;5595.916061259084;5618.91571626426;5626.85932851682;5637.830865074055;5638.295213098363;1430.29915341484;1452.3827373366278;1458.6790906000663;1461.2328527522923;1462.3419461242484;895.9287941559724;908.7864351877304;919.060781750506;937.7514958535993;956.4118067388506;5347.893042139135;5448.56411487088;5528.009916430082;5529.861753456195;5537.363203231599;5758.3665796762325;5782.624129431573;5788.797392091256;5800.694843660227;5818.592698511148;5196.168613021899;5394.62237643369;5414.7021913795115;5432.402435732066;5488.56091512678;3033.635963684372;3039.1034644779843;3049.35963447674;3049.92375190622;3050.100220434977;5858.5898987070495;5926.762929482772;5974.61165024272;5987.491063259585;6026.7890623828835;5802.854928626818;5838.511179649162;5851.795187168429;5876.823695289148;5879.176915231871;5978.461938425476;6004.648953985318;6006.15913772081;6015.729292181863;6030.939690603038;5522.558195344443;5677.801276955287;5736.397678243724;5777.422257774357;5789.56578256624;5548.750306236148;5652.943470565242;5656.830295091154;5679.630823996427;5688.800891968761;5770.942290577208;5935.436133567304;5987.221661184019;6007.249093863267;6010.398960103955;4026.3155263605845;4066.755994640331;4078.143589846047;4095.0376661485125;4096.971998860464;5765.221695071112;5768.356018534698;5778.855528611818;5801.245838041028;5816.796412125555;5463.371712252982;5491.872802035783;5632.605717599728;5641.435856414326;5644;5528.567430330641;5529.585281103853;5547.528460080938;5552.250446189874;5561.388247292875;5332.30680011596;5533.972330138324;5541.196526503715;5585.720713964204;5599.524040456607;5437.564994800327;5584.218209450599;5606.990741666539;5616.550675945996;5617.354004289559;5444.401115877329;5459.2902922619805;5495.203195536705;5512.310961129859;5513.476219759116 14:47:49 INFO - PROCESS | 10022 | |5;yui.html;744.0364727677656;770.1952355364502;786.3237615650536;789.4907784479011;827.6192951242429;14736.557903262907;16342.346306147769;16352.018878867277;16356;16359.918200408996;14703.33834977426;14925.77611335828;14929.77605335918;14944.476943306987;14950.177740224284;646.8479907221787;784.8822676598498;813.093400858042;816.2123550773503;821.4906757810136;820.3970081989733;820.8112134209106;822.2147848804377;823.6417158536026;824.1799409587469;870.9042005379404;872.7250915961451;872.7992561710811;872.9476231426103;874.1564390363299;681.519528732245;834.1075049696827;859.2824991132443;859.5831021954347;864.0927026622022;620.2278163686194;620.6772478311298;620.7237779188263;621.5121129913042;621.6767281013847;14685.55943321702;14727.55817325482;14729.263536823117;14759;14760.114393136339;13789.172649641054;13915.860841391557;14286.357113929898;14295.57113286603;14347.56957291283;13330.333483325892;13338.399772010283;13388.665283367896;13446.596602101952;13484.39320230592;4463.509014008457;4484.282514797616;4498;4573.908521829578;4584;77450.6127469359;78076.60961695155;78343.21656783416;79907.20092799056;80278.59860700718;11452.656420307405;11516;11606;11720.120990925714;11912.463939122761;21773;21837.454063648536;21879.890600546896;21888.45278868041;22418;8155.388345874083;8189.467684600601;8456.8731469028;8670.176333248332;8736.301095912311;4620.907581848344;4700.7179569225955;4707.529247075334;4738.384010078667;4748.406449193851;3405.880794172192;3535.62875898027;3554.431290993429;3554.5734511858227;3560.074380660995;699.2168770976539;721.3435773446244;721.4949535325293;723.6526467295622;738.903942487484;679.6024325769381;713.3223437734069;734.2070563791093;762.954222746637;770.5800338815359;9984.400935943866;10377.221708371902;10415.68752937413;10540.420276884844;10584.735381615521;604.5586721693188;637.576011952056;651.713246171683;692.2454524568245;728.5155371677774;4708.835190768306;5038.420581633086;5050.116229659795;5051;5083.38999320084;125321;127961;128192.35903820422;130702;132472;114457.4277128609;116542;116670;118345;119653;92100.53949730343;93724.53137734268;99271.50364248133;99626.5018674902;100255.49872250739;9213.76965575866;9562.474063926551;9583.856242156513;9598.66404675861;9662.227021838376;48229.75885120552;53043.734781325846;53092.20361694655;53874.461255386945;55520.72239638776;77757;82191.17808821835;83308;84833;85926;12354.629361119181;12361.814572781235;12388;12723.172993755376;12819.807702884651;13976.580702578938;14061.929690351892;14359.712805744035;15105.536649279637;15393.69212615719;12308.753824923631;12738.490460381852;12956.805647915477;13211.735765284448;13820.930895345458;13273.601791946257;13538.59384218475;13803.792943106062;14173.787393188904;14354.425822966965;12332.568360107713;12589;12819.359032048547;12901.483940642269;13227.338633068115;10851.782964340511;10960.780784384107;11084.556617735201;11460.426978651201;11578.247413918069;10271.897281027093;10742.325841239288;10813.080888124598;10814.29707069038;10858.185636077167 14:47:49 INFO - PROCESS | 10022 | __end_tp_report 14:47:49 INFO - PROCESS | 10022 | __start_cc_report 14:47:49 INFO - PROCESS | 10022 | _x_x_mozilla_cycle_collect,1229 14:47:49 INFO - PROCESS | 10022 | __end_cc_report 14:47:49 INFO - PROCESS | 10022 | __startTimestamp1469656069130__endTimestamp 14:47:49 INFO - PROCESS | 10022 | 14:47:49 INFO - PROCESS | 10022 | ------- Summary: start ------- 14:47:49 INFO - PROCESS | 10022 | Number of tests: 6 14:47:49 INFO - PROCESS | 10022 | 14:47:49 INFO - PROCESS | 10022 | [#0] dojo.html Cycles:165 Average:5374.99 Median:5573.80 stddev:623.32 (11.2%) stddev-sans-first:595.77 14:47:49 INFO - PROCESS | 10022 | Values: 2960.7 2983.5 2995.4 3075.5 3120.3 5262.2 5345.9 5362.5 5444.0 5478.9 5286.5 5328.5 5389.1 5476.9 5485.8 4858.1 4881.6 4884.7 4904.0 4930.6 4954.3 5019.1 5021.9 5023.7 5028.4 4977.6 4999.2 5000.8 5009.6 5061.0 4515.0 4784.9 4827.5 4878.1 4948.4 4900.6 4910.6 4915.4 4957.0 4966.2 5419.7 5445.6 5452.0 5476.6 5483.6 5656.9 5681.9 5733.6 5792.9 5857.3 5811.0 5831.6 5855.2 5862.1 5868.2 5436.9 5442.4 5443.9 5444.5 5444.8 5722.8 5825.7 5827.5 5899.3 5918.8 5692.5 5694.0 5696.1 5698.6 5704.1 5740.0 5757.8 5767.4 5783.2 5785.8 5585.8 5663.6 5675.9 5707.5 5719.6 5762.9 5764.1 5766.2 5828.5 5834.1 4410.4 4410.6 4415.3 4426.7 4450.2 3897.9 3908.1 3925.6 3944.2 3955.3 5459.3 5475.4 5486.7 5566.7 5568.4 5774.9 5828.5 5835.6 5836.9 5886.1 5366.2 5474.0 5519.5 5564.3 5568.0 4997.4 5062.3 5081.6 5105.2 5125.4 6024.5 6054.5 6064.3 6064.6 6068.1 5658.2 5721.5 5766.5 5799.6 5810.0 5921.3 6098.5 6110.1 6120.1 6125.1 5636.7 5689.6 5703.7 5709.3 5751.1 5770.7 5796.8 5822.6 5834.9 5843.1 5513.4 5567.2 5573.2 5616.1 5629.8 5629.9 5630.4 5635.4 5636.4 5674.5 5567.6 5572.2 5573.8 5582.8 5583.5 5495.6 5647.7 5651.2 5696.1 5697.8 5558.4 5594.1 5598.3 5602.8 5637.0 14:47:49 INFO - PROCESS | 10022 | 14:47:49 INFO - PROCESS | 10022 | [#1] ext.html Cycles:180 Average:47585.91 Median:19720.59 stddev:83622.08 (424.0%) stddev-sans-first:83782.21 14:47:49 INFO - PROCESS | 10022 | Values: 587.7 608.0 625.8 630.5 651.2 31145.5 44056.1 45162.3 45260.0 45282.0 45883.3 46253.3 46264.8 46314.0 46355.5 8105.8 9073.6 9282.9 9291.2 10734.9 10594.0 11143.5 11146.3 11157.6 11166.4 11140.2 11193.6 11203.7 11234.1 11245.3 11128.9 11156.9 11202.2 11207.2 11231.8 10853.8 10929.0 10930.6 10932.9 10935.6 43263.0 43502.6 43611.3 43618.9 43669.1 3531.5 3574.4 3622.0 3786.9 3823.8 32905.5 33031.5 33432.3 33837.7 34583.5 4345.5 4347.3 4390.2 4390.6 4419.8 369663.0 370366.0 370542.0 370611.0 372839.0 34935.0 35911.3 60078.1 60224.4 60256.4 37182.4 37188.8 37370.0 37436.3 37536.0 14504.4 14600.7 14614.2 14617.5 14618.9 11000.3 11705.8 11916.0 11964.9 11979.0 8196.3 8283.9 8326.6 8356.7 8368.7 3244.0 3274.7 3281.5 3283.4 3300.2 1005.0 1055.9 1092.6 1103.5 1145.3 33667.8 34059.8 34490.5 34507.0 34778.7 1122.2 1123.8 1140.5 1160.7 1184.2 17628.8 17787.1 18039.5 18043.4 18064.9 143817.0 144104.3 144165.3 144394.0 144859.0 61570.4 62053.0 62150.4 62184.0 62218.4 1241.8 1343.4 1370.5 1387.3 1393.3 33350.3 35204.6 35362.3 35375.1 35387.2 52109.5 52718.5 52820.5 52822.0 52831.5 376003.0 376056.0 376777.0 377545.0 377636.0 28070.3 29358.0 29503.7 29604.6 30240.5 46796.7 46973.9 47453.5 47724.3 48321.5 39510.4 39773.0 40300.6 40368.0 41626.4 39977.0 41001.6 41150.4 41546.6 41746.4 39491.2 40365.4 41116.0 41268.6 41302.4 33040.5 35866.8 35990.0 36576.8 37303.8 27618.0 27631.7 27790.9 27967.9 28067.9 14:47:49 INFO - PROCESS | 10022 | 14:47:49 INFO - PROCESS | 10022 | [#2] jquery.html Cycles:180 Average:30285.94 Median:401.46 stddev:87993.24 (21918.1%) stddev-sans-first:88211.42 14:47:49 INFO - PROCESS | 10022 | Values: 375.0 380.4 392.6 396.5 406.4 16891.0 19143.1 19179.4 19460.2 19939.8 18898.5 19119.3 19363.4 19464.3 19806.9 5087.6 5573.6 5723.7 5797.7 5803.7 5700.8 5736.8 5781.0 5785.4 5792.4 5524.6 5611.3 5644.0 5769.1 5769.6 5602.5 5623.4 5631.7 5631.9 5639.5 4901.7 4975.9 5110.7 5134.3 5145.6 19692.9 19730.6 21640.1 22927.5 23027.7 2475.9 2919.7 2985.5 3058.3 3131.9 14291.0 14330.4 14439.9 14525.3 14579.7 1942.8 1968.3 1988.9 1998.2 2006.3 81449.2 83011.0 83915.6 84166.0 84170.6 8713.7 9012.5 9151.1 9269.4 10342.4 11784.8 11835.6 11849.6 11854.2 11857.6 7288.5 7404.4 7438.9 7493.6 7601.5 7534.3 7585.4 7668.2 7764.4 7784.5 3663.5 3677.9 3768.9 3772.9 3817.3 1800.2 1827.7 1832.3 1847.5 1855.7 849.7 955.9 960.8 987.2 1018.6 18013.7 18917.9 18968.6 19707.9 19709.2 956.0 972.9 978.4 983.5 991.0 10620.8 10961.0 11032.4 11067.7 11101.2 525205.0 528200.0 537383.0 537787.0 539551.0 93491.5 94329.5 94805.0 96663.0 100977.0 969.1 1001.7 1005.5 1017.1 1019.8 16443.8 16680.2 16867.3 17344.4 17986.2 44200.6 45304.5 45430.5 45562.5 46186.3 56754.6 59957.4 61938.0 62745.7 63164.0 7808.0 7898.5 7968.0 8191.1 8200.7 12570.6 12857.7 12911.2 12970.6 13160.7 10748.3 11549.1 11635.7 11648.2 11771.8 6404.7 9689.6 9722.9 9748.8 9932.3 11394.3 11555.7 11661.4 11883.3 11978.6 7822.1 7920.3 7967.6 8119.1 8476.4 10255.3 10727.6 10937.5 11103.9 11364.9 14:47:49 INFO - PROCESS | 10022 | 14:47:49 INFO - PROCESS | 10022 | [#3] mootools.html Cycles:180 Average:5750.21 Median:4417.38 stddev:3304.91 (74.8%) stddev-sans-first:3297.63 14:47:49 INFO - PROCESS | 10022 | Values: 1348.7 1438.1 1487.7 1623.0 1789.5 8348.6 8695.3 8714.8 8950.1 8952.1 8737.7 8834.3 8844.8 8846.1 8846.9 2328.2 2345.8 2349.3 2354.2 2355.2 2282.4 2329.4 2366.0 2366.9 2372.0 2213.8 2247.1 2273.7 2295.5 2296.1 2261.4 2268.3 2281.5 2283.0 2284.3 2201.3 2209.5 2216.6 2217.9 2222.6 8672.0 8818.9 8888.2 8932.2 8960.6 4826.3 4969.4 4989.6 4992.3 4996.1 3183.0 3312.6 3345.7 3368.5 3373.2 1039.8 1046.0 1047.9 1058.5 1067.6 12123.2 12124.5 12213.3 12224.3 12233.6 4207.7 4311.3 4379.9 4454.8 4455.1 9608.0 9609.2 9629.8 9634.0 9698.3 5051.3 5097.7 5098.8 5099.4 5101.9 4170.4 4255.6 4286.5 4760.3 4768.1 3722.2 3751.5 3814.0 3859.1 3865.9 1129.5 1146.5 1159.2 1169.9 1172.6 911.4 949.4 1012.1 1012.4 1035.4 6057.9 6183.4 6230.7 6254.7 6344.5 395.9 396.0 401.2 404.3 405.7 4160.7 4191.7 4198.5 4230.8 4296.2 10601.5 10888.9 10938.5 10952.2 10958.6 10898.5 10901.7 10903.1 10905.7 10925.5 7614.4 7896.3 7905.3 8037.4 8072.3 5988.6 5989.5 6100.5 6220.2 6330.8 9897.2 10016.2 10173.7 10204.6 10238.4 9875.5 9951.8 10162.4 10172.3 10190.1 7784.3 7847.7 7913.2 7928.7 7933.1 8575.4 8582.2 8615.1 8620.7 8621.0 7527.6 7667.7 7703.5 7715.1 7970.0 7362.4 7376.7 7435.9 7610.4 7673.1 7165.4 7178.7 7210.2 7220.7 7230.1 5283.2 5295.1 5412.7 5497.5 5563.1 5373.9 5536.1 5546.5 5552.8 5568.4 14:47:49 INFO - PROCESS | 10022 | 14:47:49 INFO - PROCESS | 10022 | [#4] prototype.html Cycles:180 Average:4704.53 Median:5440.09 stddev:1400.01 (25.7%) stddev-sans-first:1364.29 14:47:49 INFO - PROCESS | 10022 | Values: 296.6 301.9 303.6 304.7 309.1 5350.3 5366.9 5392.8 5413.7 5442.6 5295.7 5318.7 5324.0 5332.0 5335.4 3942.9 4022.3 4136.9 4177.7 4192.9 4140.9 4148.4 4149.4 4173.7 4195.2 4144.2 4147.4 4148.0 4157.2 4165.9 3947.7 3953.7 4071.6 4104.8 4136.9 3574.2 3581.6 3594.9 3607.6 3609.4 5165.2 5194.5 5200.6 5271.8 5279.2 4498.2 4701.6 4708.8 4746.8 4749.8 5548.7 5552.3 5553.5 5559.8 5576.7 4030.9 4033.8 4046.0 4050.6 4055.0 5486.8 5747.9 5783.9 5789.2 5853.0 3956.7 3969.9 3972.0 3985.3 3993.1 4052.0 4059.3 4059.5 4063.3 4064.8 4519.3 4698.6 4706.0 4710.0 4749.9 5595.9 5618.9 5626.9 5637.8 5638.3 1430.3 1452.4 1458.7 1461.2 1462.3 895.9 908.8 919.1 937.8 956.4 5347.9 5448.6 5528.0 5529.9 5537.4 5758.4 5782.6 5788.8 5800.7 5818.6 5196.2 5394.6 5414.7 5432.4 5488.6 3033.6 3039.1 3049.4 3049.9 3050.1 5858.6 5926.8 5974.6 5987.5 6026.8 5802.9 5838.5 5851.8 5876.8 5879.2 5978.5 6004.6 6006.2 6015.7 6030.9 5522.6 5677.8 5736.4 5777.4 5789.6 5548.8 5652.9 5656.8 5679.6 5688.8 5770.9 5935.4 5987.2 6007.2 6010.4 4026.3 4066.8 4078.1 4095.0 4097.0 5765.2 5768.4 5778.9 5801.2 5816.8 5463.4 5491.9 5632.6 5641.4 5644.0 5528.6 5529.6 5547.5 5552.3 5561.4 5332.3 5534.0 5541.2 5585.7 5599.5 5437.6 5584.2 5607.0 5616.6 5617.4 5444.4 5459.3 5495.2 5512.3 5513.5 14:47:49 INFO - PROCESS | 10022 | 14:47:49 INFO - PROCESS | 10022 | [#5] yui.html Cycles:180 Average:22380.55 Median:4473.90 stddev:33753.61 (754.5%) stddev-sans-first:33809.20 14:47:49 INFO - PROCESS | 10022 | Values: 744.0 770.2 786.3 789.5 827.6 14736.6 16342.3 16352.0 16356.0 16359.9 14703.3 14925.8 14929.8 14944.5 14950.2 646.8 784.9 813.1 816.2 821.5 820.4 820.8 822.2 823.6 824.2 870.9 872.7 872.8 872.9 874.2 681.5 834.1 859.3 859.6 864.1 620.2 620.7 620.7 621.5 621.7 14685.6 14727.6 14729.3 14759.0 14760.1 13789.2 13915.9 14286.4 14295.6 14347.6 13330.3 13338.4 13388.7 13446.6 13484.4 4463.5 4484.3 4498.0 4573.9 4584.0 77450.6 78076.6 78343.2 79907.2 80278.6 11452.7 11516.0 11606.0 11720.1 11912.5 21773.0 21837.5 21879.9 21888.5 22418.0 8155.4 8189.5 8456.9 8670.2 8736.3 4620.9 4700.7 4707.5 4738.4 4748.4 3405.9 3535.6 3554.4 3554.6 3560.1 699.2 721.3 721.5 723.7 738.9 679.6 713.3 734.2 763.0 770.6 9984.4 10377.2 10415.7 10540.4 10584.7 604.6 637.6 651.7 692.2 728.5 4708.8 5038.4 5050.1 5051.0 5083.4 125321.0 127961.0 128192.4 130702.0 132472.0 114457.4 116542.0 116670.0 118345.0 119653.0 92100.5 93724.5 99271.5 99626.5 100255.5 9213.8 9562.5 9583.9 9598.7 9662.2 48229.8 53043.7 53092.2 53874.5 55520.7 77757.0 82191.2 83308.0 84833.0 85926.0 12354.6 12361.8 12388.0 12723.2 12819.8 13976.6 14061.9 14359.7 15105.5 15393.7 12308.8 12738.5 12956.8 13211.7 13820.9 13273.6 13538.6 13803.8 14173.8 14354.4 12332.6 12589.0 12819.4 12901.5 13227.3 10851.8 10960.8 11084.6 11460.4 11578.2 10271.9 10742.3 10813.1 10814.3 10858.2 14:47:49 INFO - PROCESS | 10022 | -------- Summary: end -------- 14:47:49 INFO - PROCESS | 10022 | 14:47:49 INFO - TEST-INFO | 10022: exit 0 14:47:49 INFO - TEST-OK | dromaeo_css | took 1113441ms 14:47:49 INFO - TEST-START | kraken 14:47:49 INFO - operating with platform_type : linux_ 14:47:49 INFO - Initialising browser for kraken test... 14:47:49 INFO - TEST-INFO | started process 10211 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqH0QoW/profile http://localhost:59720/getInfo.html) 14:47:53 INFO - PROCESS | 10211 | JavaScript error: , line 0: uncaught exception: undefined 14:47:54 INFO - PROCESS | 10211 | __metrics Screen width/height:1600/1200 14:47:54 INFO - PROCESS | 10211 | colorDepth:24 14:47:54 INFO - PROCESS | 10211 | Browser inner width/height: 1024/697 14:47:54 INFO - PROCESS | 10211 | __metrics 14:47:54 INFO - PROCESS | 10211 | 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" 14:47:54 INFO - PROCESS | 10211 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:47:55 INFO - PROCESS | 10211 | console.error: PushService: 14:47:55 INFO - PROCESS | 10211 | stateChangeProcessEnqueue: Error transitioning state 14:47:55 INFO - PROCESS | 10211 | UnknownError 14:47:55 INFO - TEST-INFO | 10211: exit 0 14:47:55 INFO - Browser initialized. 14:47:55 INFO - Running cycle 1/1 for kraken test... 14:47:55 INFO - TEST-INFO | started process 10290 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqH0QoW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:48:07 INFO - PROCESS | 10290 | RSS: Main: 157917184 14:48:07 INFO - PROCESS | 10290 | 14:48:10 INFO - PROCESS | 10290 | Cycle 1(1): loaded http://localhost:59720/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59720/tests/kraken/driver.html?testName=audio-beat-detection) 14:48:11 INFO - PROCESS | 10290 | RSS: Main: 214253568 14:48:11 INFO - PROCESS | 10290 | 14:48:13 INFO - PROCESS | 10290 | Cycle 1(1): loaded http://localhost:59720/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59720/tests/kraken/driver.html?testName=audio-dft) 14:48:14 INFO - PROCESS | 10290 | RSS: Main: 192876544 14:48:14 INFO - PROCESS | 10290 | 14:48:17 INFO - PROCESS | 10290 | Cycle 1(1): loaded http://localhost:59720/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59720/tests/kraken/driver.html?testName=audio-fft) 14:48:17 INFO - PROCESS | 10290 | RSS: Main: 269721600 14:48:17 INFO - PROCESS | 10290 | 14:48:19 INFO - PROCESS | 10290 | Cycle 1(1): loaded http://localhost:59720/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59720/tests/kraken/driver.html?testName=audio-oscillator) 14:48:20 INFO - PROCESS | 10290 | RSS: Main: 181293056 14:48:20 INFO - PROCESS | 10290 | 14:48:22 INFO - PROCESS | 10290 | Cycle 1(1): loaded http://localhost:59720/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59720/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:48:23 INFO - PROCESS | 10290 | RSS: Main: 185032704 14:48:23 INFO - PROCESS | 10290 | 14:48:26 INFO - PROCESS | 10290 | Cycle 1(1): loaded http://localhost:59720/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59720/tests/kraken/driver.html?testName=imaging-darkroom) 14:48:26 INFO - PROCESS | 10290 | RSS: Main: 221691904 14:48:26 INFO - PROCESS | 10290 | 14:48:30 INFO - PROCESS | 10290 | Cycle 1(1): loaded http://localhost:59720/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59720/tests/kraken/driver.html?testName=imaging-desaturate) 14:48:30 INFO - PROCESS | 10290 | RSS: Main: 220426240 14:48:30 INFO - PROCESS | 10290 | 14:48:33 INFO - PROCESS | 10290 | Cycle 1(1): loaded http://localhost:59720/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59720/tests/kraken/driver.html?testName=json-parse-financial) 14:48:34 INFO - PROCESS | 10290 | RSS: Main: 221016064 14:48:34 INFO - PROCESS | 10290 | 14:48:35 INFO - PROCESS | 10290 | Cycle 1(1): loaded http://localhost:59720/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59720/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:48:36 INFO - PROCESS | 10290 | RSS: Main: 185028608 14:48:36 INFO - PROCESS | 10290 | 14:48:38 INFO - PROCESS | 10290 | Cycle 1(1): loaded http://localhost:59720/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59720/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:48:38 INFO - PROCESS | 10290 | RSS: Main: 190316544 14:48:38 INFO - PROCESS | 10290 | 14:48:40 INFO - PROCESS | 10290 | Cycle 1(1): loaded http://localhost:59720/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59720/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:48:41 INFO - PROCESS | 10290 | RSS: Main: 195268608 14:48:41 INFO - PROCESS | 10290 | 14:48:43 INFO - PROCESS | 10290 | Cycle 1(1): loaded http://localhost:59720/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59720/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:48:44 INFO - PROCESS | 10290 | RSS: Main: 188592128 14:48:44 INFO - PROCESS | 10290 | 14:48:47 INFO - PROCESS | 10290 | Cycle 1(1): loaded http://localhost:59720/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59720/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:48:47 INFO - PROCESS | 10290 | RSS: Main: 193949696 14:48:47 INFO - PROCESS | 10290 | 14:48:49 INFO - PROCESS | 10290 | Cycle 1(1): loaded http://localhost:59720/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59720/tests/kraken/driver.html?testName=ai-astar) 14:48:49 INFO - PROCESS | 10290 | RSS: Main: 244490240 14:48:49 INFO - PROCESS | 10290 | 14:48:49 INFO - PROCESS | 10290 | __start_tp_report 14:48:49 INFO - PROCESS | 10290 | _x_x_mozilla_page_load 14:48:49 INFO - PROCESS | 10290 | _x_x_mozilla_page_load_details 14:48:49 INFO - PROCESS | 10290 | |i|pagename|runs| 14:48:49 INFO - PROCESS | 10290 | |0;ai-astar;102;112;111;111;112;111;112;112;111;109 14:48:49 INFO - PROCESS | 10290 | |1;audio-beat-detection;141;116;118;186;118;119;146;118;147;117 14:48:49 INFO - PROCESS | 10290 | |2;audio-dft;160;160;161;161;159;161;161;161;159;160 14:48:49 INFO - PROCESS | 10290 | |3;audio-fft;75;74;74;125;75;76;75;74;103;76 14:48:49 INFO - PROCESS | 10290 | |4;audio-oscillator;84;84;113;84;85;85;120;84;85;136 14:48:49 INFO - PROCESS | 10290 | |5;imaging-gaussian-blur;117;117;117;118;117;117;117;117;117;117 14:48:49 INFO - PROCESS | 10290 | |6;imaging-darkroom;147;145;146;146;146;145;145;146;145;146 14:48:49 INFO - PROCESS | 10290 | |7;imaging-desaturate;94;95;94;94;95;95;94;95;95;94 14:48:49 INFO - PROCESS | 10290 | |8;json-parse-financial;53;55;54;52;51;54;51;52;52;52 14:48:49 INFO - PROCESS | 10290 | |9;json-stringify-tinderbox;61;61;61;61;61;61;61;60;61;61 14:48:49 INFO - PROCESS | 10290 | |10;stanford-crypto-aes;80;76;78;81;77;86;76;76;77;76 14:48:49 INFO - PROCESS | 10290 | |11;stanford-crypto-ccm;130;129;120;119;123;121;133;129;170;135 14:48:49 INFO - PROCESS | 10290 | |12;stanford-crypto-pbkdf2;159;159;156;161;162;157;156;158;158;158 14:48:49 INFO - PROCESS | 10290 | |13;stanford-crypto-sha256-iterative;64;63;64;64;63;62;62;65;61;65 14:48:49 INFO - PROCESS | 10290 | __end_tp_report 14:48:49 INFO - PROCESS | 10290 | __start_cc_report 14:48:49 INFO - PROCESS | 10290 | _x_x_mozilla_cycle_collect,1674 14:48:49 INFO - PROCESS | 10290 | __end_cc_report 14:48:49 INFO - PROCESS | 10290 | __startTimestamp1469656129703__endTimestamp 14:48:49 INFO - PROCESS | 10290 | 14:48:49 INFO - PROCESS | 10290 | ------- Summary: start ------- 14:48:49 INFO - PROCESS | 10290 | Number of tests: 14 14:48:49 INFO - PROCESS | 10290 | 14:48:49 INFO - PROCESS | 10290 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.50 stddev:3.06 (2.7%) stddev-sans-first:0.97 14:48:49 INFO - PROCESS | 10290 | Values: 102.0 112.0 111.0 111.0 112.0 111.0 112.0 112.0 111.0 109.0 14:48:49 INFO - PROCESS | 10290 | 14:48:49 INFO - PROCESS | 10290 | [#1] audio-beat-detection Cycles:10 Average:132.60 Median:130.00 stddev:22.74 (17.5%) stddev-sans-first:23.91 14:48:49 INFO - PROCESS | 10290 | Values: 141.0 116.0 118.0 186.0 118.0 119.0 146.0 118.0 147.0 117.0 14:48:49 INFO - PROCESS | 10290 | 14:48:49 INFO - PROCESS | 10290 | [#2] audio-dft Cycles:10 Average:160.30 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 14:48:49 INFO - PROCESS | 10290 | Values: 160.0 160.0 161.0 161.0 159.0 161.0 161.0 161.0 159.0 160.0 14:48:49 INFO - PROCESS | 10290 | 14:48:49 INFO - PROCESS | 10290 | [#3] audio-fft Cycles:10 Average:82.70 Median:75.00 stddev:17.31 (23.1%) stddev-sans-first:18.13 14:48:49 INFO - PROCESS | 10290 | Values: 75.0 74.0 74.0 125.0 75.0 76.0 75.0 74.0 103.0 76.0 14:48:49 INFO - PROCESS | 10290 | 14:48:49 INFO - PROCESS | 10290 | [#4] audio-oscillator Cycles:10 Average:96.00 Median:84.00 stddev:19.45 (23.2%) stddev-sans-first:20.14 14:48:49 INFO - PROCESS | 10290 | Values: 84.0 84.0 113.0 84.0 85.0 85.0 120.0 84.0 85.0 136.0 14:48:49 INFO - PROCESS | 10290 | 14:48:49 INFO - PROCESS | 10290 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 14:48:49 INFO - PROCESS | 10290 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 14:48:49 INFO - PROCESS | 10290 | 14:48:49 INFO - PROCESS | 10290 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.53 14:48:49 INFO - PROCESS | 10290 | Values: 147.0 145.0 146.0 146.0 146.0 145.0 145.0 146.0 145.0 146.0 14:48:49 INFO - PROCESS | 10290 | 14:48:49 INFO - PROCESS | 10290 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 14:48:49 INFO - PROCESS | 10290 | Values: 94.0 95.0 94.0 94.0 95.0 95.0 94.0 95.0 95.0 94.0 14:48:49 INFO - PROCESS | 10290 | 14:48:49 INFO - PROCESS | 10290 | [#8] json-parse-financial Cycles:10 Average:52.60 Median:52.50 stddev:1.35 (2.6%) stddev-sans-first:1.42 14:48:49 INFO - PROCESS | 10290 | Values: 53.0 55.0 54.0 52.0 51.0 54.0 51.0 52.0 52.0 52.0 14:48:49 INFO - PROCESS | 10290 | 14:48:49 INFO - PROCESS | 10290 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 14:48:49 INFO - PROCESS | 10290 | Values: 61.0 61.0 61.0 61.0 61.0 61.0 61.0 60.0 61.0 61.0 14:48:49 INFO - PROCESS | 10290 | 14:48:49 INFO - PROCESS | 10290 | [#10] stanford-crypto-aes Cycles:10 Average:78.30 Median:77.50 stddev:3.23 (4.2%) stddev-sans-first:3.37 14:48:49 INFO - PROCESS | 10290 | Values: 80.0 76.0 78.0 81.0 77.0 86.0 76.0 76.0 77.0 76.0 14:48:49 INFO - PROCESS | 10290 | 14:48:49 INFO - PROCESS | 10290 | [#11] stanford-crypto-ccm Cycles:10 Average:130.90 Median:129.50 stddev:14.83 (11.5%) stddev-sans-first:15.72 14:48:49 INFO - PROCESS | 10290 | Values: 130.0 129.0 120.0 119.0 123.0 121.0 133.0 129.0 170.0 135.0 14:48:49 INFO - PROCESS | 10290 | 14:48:49 INFO - PROCESS | 10290 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.40 Median:158.50 stddev:1.96 (1.2%) stddev-sans-first:2.06 14:48:49 INFO - PROCESS | 10290 | Values: 159.0 159.0 156.0 161.0 162.0 157.0 156.0 158.0 158.0 158.0 14:48:49 INFO - PROCESS | 10290 | 14:48:49 INFO - PROCESS | 10290 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:64.00 stddev:1.34 (2.1%) stddev-sans-first:1.39 14:48:49 INFO - PROCESS | 10290 | Values: 64.0 63.0 64.0 64.0 63.0 62.0 62.0 65.0 61.0 65.0 14:48:49 INFO - PROCESS | 10290 | -------- Summary: end -------- 14:48:49 INFO - PROCESS | 10290 | 14:48:50 INFO - TEST-INFO | 10290: exit 0 14:48:50 INFO - TEST-OK | kraken | took 60838ms 14:48:50 INFO - SUITE-END | took 1174s 14:48:50 INFO - Completed test suite (00:19:34) 14:48:50 INFO - javascript benchmark 14:48:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2960.7187317204857, 2983.4629766641997, 2995.400919816036, 3075.5079187330025, 3120.329129237214, 5262.236975638531, 5345.893082138355, 5362.4637536246355, 5444.0, 5478.91781623276, 5286.497782710637, 5328.520433161015, 5389.110796718537, 5476.945230547693, 5485.780568777254, 4858.101251268509, 4881.560659540641, 4884.73133977632, 4903.9754801225945, 4930.580900623451, 4954.331165292693, 5019.121653710605, 5021.924671129936, 5023.6985780853265, 5028.396592408916, 4977.576905962997, 4999.200127979524, 5000.799968001275, 5009.57418619416, 5061.0, 4515.006698526319, 4784.856454306341, 4827.51724827518, 4878.121938051149, 4948.430930443009, 4900.558949694545, 4910.558049775537, 4915.361003069614, 4957.033378491195, 4966.180580204262, 5419.674819510803, 5445.591580631469, 5451.964126815932, 5476.561875049986, 5483.588730845163, 5656.85857853557, 5681.914771278392, 5733.598648094635, 5792.942070579283, 5857.297124345063, 5811.0411782056335, 5831.620944638585, 5855.238818953551, 5862.149988251722, 5868.207791948075, 5436.91844622331, 5442.428545002796, 5443.891122177534, 5444.50999410051, 5444.809431669913, 5722.77108915647, 5825.679587622722, 5827.533797296206, 5899.262592175978, 5918.7928422505, 5692.48767610917, 5693.971530142406, 5696.11710184922, 5698.601097923189, 5704.058830293038, 5739.971300143473, 5757.769689212385, 5767.423257674283, 5783.190353350535, 5785.768569257182, 5585.832425027255, 5663.631863928914, 5675.914861277001, 5707.486326230659, 5719.571032172604, 5762.9135562966585, 5764.106563482667, 5766.192733017297, 5828.5337173026055, 5834.095715164156, 4410.448693913261, 4410.647148228134, 4415.271480205794, 4426.690131690815, 4450.1989641864775, 3897.863574774926, 3908.0620651044114, 3925.568187499373, 3944.1717239379477, 3955.3275943089743, 5459.344878614592, 5475.370332411744, 5486.698231597221, 5566.749496272678, 5568.387477377485, 5774.94225057744, 5828.475437210672, 5835.649861008353, 5836.9124463133085, 5886.05823068307, 5366.168243922199, 5474.042042642522, 5519.503244707916, 5564.27664403633, 5568.0, 4997.350344455271, 5062.265971434122, 5081.568066714371, 5105.2086926526445, 5125.436202017775, 6024.518038556905, 6054.485368743706, 6064.272287325461, 6064.605800622945, 6068.059450785136, 5658.20785090096, 5721.485066344049, 5766.538676905921, 5799.594028417971, 5809.954208242557, 5921.259842519685, 6098.481629061579, 6110.144579758926, 6120.112583675431, 6125.050617154348, 5636.661800291996, 5689.573282003949, 5703.686297253525, 5709.314882214161, 5751.1085781703905, 5770.740316685843, 5796.76812927495, 5822.592418530831, 5834.912476312944, 5843.094320380348, 5513.448655134454, 5567.164925261081, 5573.219749235192, 5616.129499927518, 5629.802956896489, 5629.88740225185, 5630.352509461464, 5635.436456354496, 5636.3799982002765, 5674.4892959633835, 5567.582431317586, 5572.247746554325, 5573.804916827891, 5582.804601838916, 5583.525400341016, 5495.5878309127775, 5647.6893770843, 5651.237082993907, 5696.088625820014, 5697.829065128053, 5558.360788509373, 5594.13290939905, 5598.300212473441, 5602.803901863415, 5637.041702910597], "value": 5331.257311785517, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.6503480429143, 608.0484042473529, 625.7872323410039, 630.4704048599177, 651.160003595362, 31145.532817007763, 44056.118877622466, 45162.32256516147, 45260.0, 45282.0, 45883.31175032377, 46253.306200406936, 46264.76867615666, 46314.0, 46355.536444635545, 8105.837883242331, 9073.637054517827, 9282.860757088616, 9291.163795258426, 10734.946325268364, 10594.0, 11143.498542565563, 11146.331220126818, 11157.609483668073, 11166.441677916071, 11140.220184587082, 11193.552257909674, 11203.663890083311, 11234.10127189827, 11245.325280483155, 11128.944355278172, 11156.944215278912, 11202.21584489078, 11207.159463040263, 11231.831522527169, 10853.837192442119, 10929.0, 10930.56277748889, 10932.945335273273, 10935.617253396173, 43263.0, 43502.56497435017, 43611.34582981258, 43618.909527261756, 43669.126617467475, 3531.5408996830506, 3574.3566158091535, 3622.0039489140436, 3786.9431958520645, 3823.770573765555, 32905.50641740352, 33031.50452743211, 33432.33135337304, 33837.6616233837, 34583.4812477813, 4345.543717909637, 4347.30443129101, 4390.16586848501, 4390.582894625038, 4419.756913369763, 369663.0, 370366.0, 370542.0, 370611.0, 372839.0, 34935.0, 35911.28177436489, 60078.098828517606, 60224.39775602276, 60256.39743602595, 37182.44226336607, 37188.81405592955, 37370.0, 37436.25127497435, 37536.0, 14504.419823206954, 14600.707985840223, 14614.196219207834, 14617.488387906373, 14618.853811461962, 11000.339979601249, 11705.765884682258, 11916.0, 11964.88035119655, 11979.041676665845, 8196.303314218358, 8283.917160828436, 8326.583670816435, 8356.665733370597, 8368.665253389918, 3243.9675603243663, 3274.705276525124, 3281.4749640057476, 3283.441814891474, 3300.224447254893, 1005.0251256281396, 1055.9419231942163, 1092.5575142067316, 1103.536514663843, 1145.2841973766397, 33667.787061685165, 34059.82970085134, 34490.48264276038, 34507.0, 34778.652213477544, 1122.2144498850837, 1123.797716411054, 1140.520981187903, 1160.6924165096257, 1184.248002518407, 17628.823711762976, 17787.110644467724, 18039.458816235532, 18043.368482103062, 18064.909675451538, 143817.0, 144104.27947860403, 144165.27917360346, 144394.0, 144859.0, 61570.38429615736, 62053.0, 62150.378496215366, 62184.0, 62218.377816222164, 1241.813727940816, 1343.40890008396, 1370.5477192526441, 1387.2647496826698, 1393.2546087842954, 33350.332993339514, 35204.647953520136, 35362.29275414529, 35375.11562210965, 35387.2227249318, 52109.47890521046, 52718.47281527289, 52820.471795281555, 52822.0, 52831.47168528265, 376003.0, 376056.0, 376777.0, 377545.0, 377636.0, 28070.298242543282, 29358.0, 29503.704962950094, 29604.555931661474, 30240.546391803702, 46796.724229304986, 46973.85627439481, 47453.52546474629, 47724.284135737296, 48321.5167848317, 39510.40734389044, 39773.0, 40300.596994029685, 40368.0, 41626.375604365356, 39977.0, 41001.58998410097, 41150.38274425826, 41546.58453415427, 41746.37380439357, 39491.2101757969, 40365.39451908165, 41116.0, 41268.587314126475, 41302.38046429246, 33040.50439243461, 35866.82066589651, 35990.0, 36576.81711591425, 37303.76177429363, 27618.0, 27631.723682762917, 27790.861045695452, 27967.86016069988, 28067.859660701564], "value": 18820.512725819463, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.9943750843739, 380.39327272999554, 392.63288824948677, 396.5083296712077, 406.42085028833907, 16891.0, 19143.138558764855, 19179.424617261488, 19460.248577628012, 19939.800601993975, 18898.52753681155, 19119.330823421184, 19363.4190974271, 19464.318748843794, 19806.90096549515, 5087.643864929457, 5573.637713548626, 5723.742431590588, 5797.681127537984, 5803.6517808931385, 5700.7719691212305, 5736.827895163131, 5780.971095144519, 5785.421457854202, 5792.391798861122, 5524.558035357182, 5611.270534830466, 5644.01229784788, 5769.105788602773, 5769.567282453832, 5602.467765562265, 5623.353314368859, 5631.7184140793, 5631.943680563224, 5639.464250896158, 4901.656884018084, 4975.875603109951, 5110.693358398508, 5134.281200631877, 5145.562627176694, 19692.90153549223, 19730.605387892305, 21640.134394624198, 22927.541449170923, 23027.654585181237, 2475.9298420201517, 2919.6934321896106, 2985.4924662807375, 3058.342456371891, 3131.874725010997, 14291.0, 14330.35513401889, 14439.927800361036, 14525.346359413747, 14579.708405831823, 1942.8445724342018, 1968.3209292793963, 1988.920443182271, 1998.1607724755493, 2006.2576846566717, 81449.18550814476, 83011.0, 83915.58042209811, 84166.0, 84170.57914710387, 8713.651453941771, 9012.504312262889, 9151.084891510929, 9269.44383337002, 10342.37945723259, 11784.764304713857, 11835.644930651923, 11849.585264515701, 11854.170208085523, 11857.644270671894, 7288.453365997465, 7404.444666650023, 7438.888416673754, 7493.552965635759, 7601.505902116345, 7534.321911028033, 7585.431092668072, 7668.233176682399, 7764.417668674872, 7784.532928024223, 3663.4871118043493, 3677.8712745053795, 3768.924621507609, 3772.9434058489146, 3817.3319669057805, 1800.216905646022, 1827.6801559726994, 1832.3495159218553, 1847.4550007747746, 1855.7030875060195, 849.6516428264382, 955.9378640388353, 960.7598100474881, 987.2003677021636, 1018.6027449294781, 18013.7297940531, 18917.90541047286, 18968.620627587647, 19707.901460492605, 19709.211631534865, 955.9713208603614, 972.8929817720045, 978.3885071830106, 983.4577616860353, 990.9950450247702, 10620.787584248272, 10960.978796697736, 11032.417459010321, 11067.72330691739, 11101.222914396076, 525205.0, 528200.0, 537383.0, 537787.0, 539551.0, 93491.53254233685, 94329.5283523578, 94805.0, 96663.0, 100977.0, 969.060011788564, 1001.6694490818013, 1005.4620777883944, 1017.1151098544166, 1019.7603563162651, 16443.835561644708, 16680.24938877778, 16867.325306987583, 17344.392946246822, 17986.190621421807, 44200.55799441964, 45304.54695453003, 45430.545694542634, 45562.544374557154, 46186.30720539128, 56754.60831221027, 59957.40042599693, 61938.0, 62745.68627156835, 63164.0, 7808.0, 7898.526088434713, 7968.0, 8191.098979112174, 8200.671973121009, 12570.62288131321, 12857.678558036125, 12911.160774549624, 12970.610881673565, 13160.736785264433, 10748.301360411548, 11549.133814963743, 11635.709107272385, 11648.184627076023, 11771.764564708486, 6404.679766011587, 9689.612415503301, 9722.9027709722, 9748.756281093029, 9932.304738668225, 11394.316341019565, 11555.653330400102, 11661.35862527569, 11883.346415947206, 11978.58074967372, 7822.100458447351, 7920.287174154354, 7967.601619918865, 8119.106898241071, 8476.406651534333, 10255.282130250811, 10727.624533141303, 10937.453127343442, 11103.888961110286, 11364.943175284401], "value": 9024.699819151096, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1348.7100273441208, 1438.050886414966, 1487.7470829958907, 1622.9837701622987, 1789.4899953513243, 8348.582570871455, 8695.304375649948, 8714.782130446742, 8950.149735775107, 8952.060033696449, 8737.737867863958, 8834.293256539477, 8844.823103537925, 8846.071162527938, 8846.867296990535, 2328.16186172978, 2345.777151170636, 2349.318697577709, 2354.1878052072007, 2355.1756885090253, 2282.3837563857746, 2329.3827135809024, 2366.0299277296313, 2366.9171578994738, 2371.95256094878, 2213.756486786452, 2247.1011595361824, 2273.7271527416733, 2295.5064661097863, 2296.0586159674535, 2261.378121016717, 2268.296827983322, 2281.498070424504, 2282.9543409131725, 2284.3375421127853, 2201.25157446469, 2209.458682622768, 2216.601011817872, 2217.933461996143, 2222.6443768996883, 8671.956640216758, 8818.86771698425, 8888.244499217575, 8932.196102350754, 8960.641574337084, 4826.276058591205, 4969.378827646544, 4989.57588604969, 4992.301077849104, 4996.100701873661, 3182.9681703182905, 3312.5528053712683, 3345.7323414126813, 3368.461046232591, 3373.190434295776, 1039.8388249821214, 1045.9738506537321, 1047.8847326794046, 1058.4972138234355, 1067.6209945469325, 12123.211991220542, 12124.515019399214, 12213.267203967791, 12224.327661978588, 12233.571824986082, 4207.747535147901, 4311.331743579687, 4379.912401751947, 4454.844080457168, 4455.1312494064, 9608.0, 9609.183219426288, 9629.759256018515, 9634.0, 9698.321117521706, 5051.318072060299, 5097.6941383517105, 5098.821541246113, 5099.36257967754, 5101.8724531887, 4170.35359519275, 4255.5744425557195, 4286.485621725413, 4760.262159365304, 4768.094062128184, 3722.218334149805, 3751.5498140222803, 3813.961860381416, 3859.073822282688, 3865.8840234793, 1129.5368898751472, 1146.463738590293, 1159.1769843411105, 1169.859616845984, 1172.6364826903687, 911.4258017449097, 949.3639261694681, 1012.0790081026378, 1012.3976234140674, 1035.3684252605904, 6057.878842423127, 6183.412575805291, 6230.688465576703, 6254.718537665816, 6344.49244060474, 395.8594698881856, 395.9564447910727, 401.18158955730564, 404.34496116291206, 405.6714061610105, 4160.667146628262, 4191.7484950903045, 4198.517170525368, 4230.830766769294, 4296.162248361602, 10601.522931468102, 10888.945555272174, 10938.507767150497, 10952.178586606036, 10958.561657533768, 10898.509567069501, 10901.672949811518, 10903.127749779998, 10905.727356816144, 10925.508352124014, 7614.352780013761, 7896.289333959971, 7905.288524032865, 8037.397195210266, 8072.313853322534, 5988.550858685703, 5989.460948514655, 6100.481459076028, 6220.160278362544, 6330.778422755181, 9897.158741507052, 10016.248781341283, 10173.745656358355, 10204.642837500653, 10238.385696858213, 9875.456849873326, 9951.751206219613, 10162.39025658463, 10172.28793984414, 10190.082892539707, 7784.338331241682, 7847.686092556234, 7913.208679132271, 7928.682852685828, 7933.127355990951, 8575.442596231225, 8582.227599516074, 8615.095414981588, 8620.698275560326, 8621.0, 7527.585982771, 7667.693292268247, 7703.537787732754, 7715.112762032438, 7969.960150199212, 7362.3741981932135, 7376.704931802882, 7435.925640743523, 7610.429217808576, 7673.117591477052, 7165.3551180394015, 7178.748743793943, 7210.206877243604, 7220.675069621774, 7230.060092188192, 5283.2254853160775, 5295.099833028471, 5412.702301373462, 5497.45025497447, 5563.109902415594, 5373.946260537345, 5536.058869992031, 5546.473085056913, 5552.833414997395, 5568.443155684399], "value": 4487.12107817223, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.6321761016339, 301.9124453908367, 303.57347926163743, 304.71509138955076, 309.13904775201064, 5350.2777125088105, 5366.865828354293, 5392.759665276979, 5413.702246376452, 5442.619016668835, 5295.735213239342, 5318.734063296839, 5323.973380133104, 5332.0, 5335.439778823216, 3942.8619998300064, 4022.275990321741, 4136.869512201219, 4177.7284476509085, 4192.853250136246, 4140.937885931713, 4148.357004664267, 4149.3775933609895, 4173.707840451169, 4195.2238835815315, 4144.171165766844, 4147.440095587087, 4147.979260103695, 4157.230912281238, 4165.916681666365, 3947.723659343847, 3953.6639385652397, 4071.5724848890736, 4104.753714777123, 4136.875893723193, 3574.249407624402, 3581.6418358163974, 3594.903554415902, 3607.5851277103206, 3609.3683605368956, 5165.173572228426, 5194.480551944813, 5200.583953283728, 5271.815486457994, 5279.155335146396, 4498.167838949772, 4701.623870090384, 4708.835190768341, 4746.810127594892, 4749.810007599692, 5548.723793527471, 5552.278203833475, 5553.527950124244, 5559.805406810783, 5576.717355008371, 4030.879073627796, 4033.838646454138, 4046.0, 4050.602542122963, 4054.9594504054876, 5486.780528778844, 5747.942520574783, 5783.942160578383, 5789.218455508494, 5852.970735146339, 3956.723029387973, 3969.940450893239, 3972.0, 3985.322495175827, 3993.101552150743, 4052.0477687743355, 4059.2693315202955, 4059.512858457004, 4063.2889244382113, 4064.8170832312617, 4519.322101684774, 4698.577128058491, 4705.976470117627, 4709.95290047102, 4749.881252968635, 5595.916061259084, 5618.91571626426, 5626.85932851682, 5637.830865074055, 5638.295213098363, 1430.29915341484, 1452.3827373366278, 1458.6790906000663, 1461.2328527522923, 1462.3419461242484, 895.9287941559724, 908.7864351877304, 919.060781750506, 937.7514958535993, 956.4118067388506, 5347.893042139135, 5448.56411487088, 5528.009916430082, 5529.861753456195, 5537.363203231599, 5758.3665796762325, 5782.624129431573, 5788.797392091256, 5800.694843660227, 5818.592698511148, 5196.168613021899, 5394.62237643369, 5414.7021913795115, 5432.402435732066, 5488.56091512678, 3033.635963684372, 3039.1034644779843, 3049.35963447674, 3049.92375190622, 3050.100220434977, 5858.5898987070495, 5926.762929482772, 5974.61165024272, 5987.491063259585, 6026.7890623828835, 5802.854928626818, 5838.511179649162, 5851.795187168429, 5876.823695289148, 5879.176915231871, 5978.461938425476, 6004.648953985318, 6006.15913772081, 6015.729292181863, 6030.939690603038, 5522.558195344443, 5677.801276955287, 5736.397678243724, 5777.422257774357, 5789.56578256624, 5548.750306236148, 5652.943470565242, 5656.830295091154, 5679.630823996427, 5688.800891968761, 5770.942290577208, 5935.436133567304, 5987.221661184019, 6007.249093863267, 6010.398960103955, 4026.3155263605845, 4066.755994640331, 4078.143589846047, 4095.0376661485125, 4096.971998860464, 5765.221695071112, 5768.356018534698, 5778.855528611818, 5801.245838041028, 5816.796412125555, 5463.371712252982, 5491.872802035783, 5632.605717599728, 5641.435856414326, 5644.0, 5528.567430330641, 5529.585281103853, 5547.528460080938, 5552.250446189874, 5561.388247292875, 5332.30680011596, 5533.972330138324, 5541.196526503715, 5585.720713964204, 5599.524040456607, 5437.564994800327, 5584.218209450599, 5606.990741666539, 5616.550675945996, 5617.354004289559, 5444.401115877329, 5459.2902922619805, 5495.203195536705, 5512.310961129859, 5513.476219759116], "value": 4247.936910336946, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.0364727677656, 770.1952355364502, 786.3237615650536, 789.4907784479011, 827.6192951242429, 14736.557903262907, 16342.346306147769, 16352.018878867277, 16356.0, 16359.918200408996, 14703.33834977426, 14925.77611335828, 14929.77605335918, 14944.476943306987, 14950.177740224284, 646.8479907221787, 784.8822676598498, 813.093400858042, 816.2123550773503, 821.4906757810136, 820.3970081989733, 820.8112134209106, 822.2147848804377, 823.6417158536026, 824.1799409587469, 870.9042005379404, 872.7250915961451, 872.7992561710811, 872.9476231426103, 874.1564390363299, 681.519528732245, 834.1075049696827, 859.2824991132443, 859.5831021954347, 864.0927026622022, 620.2278163686194, 620.6772478311298, 620.7237779188263, 621.5121129913042, 621.6767281013847, 14685.55943321702, 14727.55817325482, 14729.263536823117, 14759.0, 14760.114393136339, 13789.172649641054, 13915.860841391557, 14286.357113929898, 14295.57113286603, 14347.56957291283, 13330.333483325892, 13338.399772010283, 13388.665283367896, 13446.596602101952, 13484.39320230592, 4463.509014008457, 4484.282514797616, 4498.0, 4573.908521829578, 4584.0, 77450.6127469359, 78076.60961695155, 78343.21656783416, 79907.20092799056, 80278.59860700718, 11452.656420307405, 11516.0, 11606.0, 11720.120990925714, 11912.463939122761, 21773.0, 21837.454063648536, 21879.890600546896, 21888.45278868041, 22418.0, 8155.388345874083, 8189.467684600601, 8456.8731469028, 8670.176333248332, 8736.301095912311, 4620.907581848344, 4700.7179569225955, 4707.529247075334, 4738.384010078667, 4748.406449193851, 3405.880794172192, 3535.62875898027, 3554.431290993429, 3554.5734511858227, 3560.074380660995, 699.2168770976539, 721.3435773446244, 721.4949535325293, 723.6526467295622, 738.903942487484, 679.6024325769381, 713.3223437734069, 734.2070563791093, 762.954222746637, 770.5800338815359, 9984.400935943866, 10377.221708371902, 10415.68752937413, 10540.420276884844, 10584.735381615521, 604.5586721693188, 637.576011952056, 651.713246171683, 692.2454524568245, 728.5155371677774, 4708.835190768306, 5038.420581633086, 5050.116229659795, 5051.0, 5083.38999320084, 125321.0, 127961.0, 128192.35903820422, 130702.0, 132472.0, 114457.4277128609, 116542.0, 116670.0, 118345.0, 119653.0, 92100.53949730343, 93724.53137734268, 99271.50364248133, 99626.5018674902, 100255.49872250739, 9213.76965575866, 9562.474063926551, 9583.856242156513, 9598.66404675861, 9662.227021838376, 48229.75885120552, 53043.734781325846, 53092.20361694655, 53874.461255386945, 55520.72239638776, 77757.0, 82191.17808821835, 83308.0, 84833.0, 85926.0, 12354.629361119181, 12361.814572781235, 12388.0, 12723.172993755376, 12819.807702884651, 13976.580702578938, 14061.929690351892, 14359.712805744035, 15105.536649279637, 15393.69212615719, 12308.753824923631, 12738.490460381852, 12956.805647915477, 13211.735765284448, 13820.930895345458, 13273.601791946257, 13538.59384218475, 13803.792943106062, 14173.787393188904, 14354.425822966965, 12332.568360107713, 12589.0, 12819.359032048547, 12901.483940642269, 13227.338633068115, 10851.782964340511, 10960.780784384107, 11084.556617735201, 11460.426978651201, 11578.247413918069, 10271.897281027093, 10742.325841239288, 10813.080888124598, 10814.29707069038, 10858.185636077167], "value": 7754.118087809117, "unit": "score"}], "name": "dromaeo_css", "value": 7152.1384122028885, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 111.0, 111.0, 112.0, 111.0, 112.0, 112.0, 111.0, 109.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 116.0, 118.0, 186.0, 118.0, 119.0, 146.0, 118.0, 147.0, 117.0], "value": 132.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 161.0, 159.0, 161.0, 161.0, 161.0, 159.0, 160.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 125.0, 75.0, 76.0, 75.0, 74.0, 103.0, 76.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 113.0, 84.0, 85.0, 85.0, 120.0, 84.0, 85.0, 136.0], "value": 96.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 54.0, 52.0, 51.0, 54.0, 51.0, 52.0, 52.0, 52.0], "value": 52.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 60.0, 61.0, 61.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 76.0, 78.0, 81.0, 77.0, 86.0, 76.0, 76.0, 77.0, 76.0], "value": 78.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 129.0, 120.0, 119.0, 123.0, 121.0, 133.0, 129.0, 170.0, 135.0], "value": 130.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 159.0, 156.0, 161.0, 162.0, 157.0, 156.0, 158.0, 158.0, 158.0], "value": 158.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 64.0, 63.0, 62.0, 62.0, 65.0, 61.0, 65.0], "value": 63.3, "unit": "score"}], "name": "kraken", "value": 1483.6000000000001, "alertThreshold": 2.0}]} 14:48:50 INFO - Return code: 0 14:48:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:48:51 INFO - # TBPL SUCCESS # 14:48:51 INFO - Running post-action listener: _resource_record_post_action 14:48:51 INFO - [mozharness: 2016-07-27 21:48:51.005658Z] Finished run-tests step (success) 14:48:51 INFO - Running post-run listener: _resource_record_post_run 14:48:51 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 554090496; Read time: 8; Write time: 505116 14:48:51 INFO - TinderboxPrint: CPU usage
13.0% 14:48:51 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 14:48:51 INFO - TinderboxPrint: I/O write bytes / time
554,090,496 / 505,116 14:48:51 INFO - TinderboxPrint: CPU idle
8,276.7 (87.0%) 14:48:51 INFO - TinderboxPrint: CPU user
1,192.7 (12.5%) 14:48:51 INFO - TinderboxPrint: Swap in / out
0 / 0 14:48:51 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 257290240; Read time: 0; Write time: 281824 14:48:51 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 296611840; Read time: 0; Write time: 223264 14:48:51 INFO - Running post-run listener: _upload_blobber_files 14:48:51 INFO - Blob upload gear active. 14:48:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:48:51 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:48:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:48:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:48:52 INFO - (blobuploader) - INFO - Open directory for files ... 14:48:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:48:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:48:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:48:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:48:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:48:53 INFO - (blobuploader) - INFO - Done attempting. 14:48:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:48:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:48:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:48:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:48:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:48:59 INFO - (blobuploader) - INFO - Done attempting. 14:48:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:48:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:48:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:48:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:48:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:48:59 INFO - (blobuploader) - INFO - Done attempting. 14:48:59 INFO - (blobuploader) - INFO - Iteration through files over. 14:48:59 INFO - Return code: 0 14:48:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:48:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:48:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/26360739145863e0f1324b09e3c5bbde709fb0bf8ab92def59020b726c95eb33125b2075b51068feaf7c2c3c5b2c814b1d90e7fc136e4d42e4352644f11dd72c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4f235933d5db7b00a71f1d7893a4db48e1b06ea2ca5dea60b6d5786f7b9910b59d47117bede8235df8f28197efa88778f83bc229fb3a2af793f8cbb626ac3757", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9ed20cd310a390befadce88beff20eb47dbaafa177aca3441f852f5ddaa83db6b7ef83586629b2787f7121f9ed4a57cdb88197c7d42229752d565df1a6135d61"} 14:48:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:48:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:48:59 INFO - Contents: 14:48:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/26360739145863e0f1324b09e3c5bbde709fb0bf8ab92def59020b726c95eb33125b2075b51068feaf7c2c3c5b2c814b1d90e7fc136e4d42e4352644f11dd72c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4f235933d5db7b00a71f1d7893a4db48e1b06ea2ca5dea60b6d5786f7b9910b59d47117bede8235df8f28197efa88778f83bc229fb3a2af793f8cbb626ac3757", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9ed20cd310a390befadce88beff20eb47dbaafa177aca3441f852f5ddaa83db6b7ef83586629b2787f7121f9ed4a57cdb88197c7d42229752d565df1a6135d61"} 14:48:59 INFO - Running post-run listener: copy_logs_to_upload_dir 14:48:59 INFO - Copying logs to upload dir... 14:48:59 INFO - mkdir: /builds/slave/test/build/upload/logs 14:48:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.290949 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-07-27 14:48:59.786583) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 14:48:59.790518) ========= 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=4300f881736b422476174874000001bc-1469653058.743731-1773540073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/26360739145863e0f1324b09e3c5bbde709fb0bf8ab92def59020b726c95eb33125b2075b51068feaf7c2c3c5b2c814b1d90e7fc136e4d42e4352644f11dd72c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4f235933d5db7b00a71f1d7893a4db48e1b06ea2ca5dea60b6d5786f7b9910b59d47117bede8235df8f28197efa88778f83bc229fb3a2af793f8cbb626ac3757", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9ed20cd310a390befadce88beff20eb47dbaafa177aca3441f852f5ddaa83db6b7ef83586629b2787f7121f9ed4a57cdb88197c7d42229752d565df1a6135d61"} build_url:https://queue.taskcluster.net/v1/task/AtUPkPwIThiOCsD2S2pnHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011440 build_url: 'https://queue.taskcluster.net/v1/task/AtUPkPwIThiOCsD2S2pnHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/26360739145863e0f1324b09e3c5bbde709fb0bf8ab92def59020b726c95eb33125b2075b51068feaf7c2c3c5b2c814b1d90e7fc136e4d42e4352644f11dd72c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4f235933d5db7b00a71f1d7893a4db48e1b06ea2ca5dea60b6d5786f7b9910b59d47117bede8235df8f28197efa88778f83bc229fb3a2af793f8cbb626ac3757", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9ed20cd310a390befadce88beff20eb47dbaafa177aca3441f852f5ddaa83db6b7ef83586629b2787f7121f9ed4a57cdb88197c7d42229752d565df1a6135d61"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 14:48:59.816692) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 14:48:59.817122) ========= 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=4300f881736b422476174874000001bc-1469653058.743731-1773540073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004479 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 14:48:59.900412) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 14:48:59.900786) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 14:48:59.901160) ========= ========= Total master_lag: 0.20 =========