builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-064 starttime: 1461584885.73 results: success (0) buildid: 20160422035709 builduid: 3af33a9a7de54ba3986a82f34ab86caa revision: 80598be5d80e695727ff74e712faa623b02f3c70 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 04:48:05.732106) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 04:48:05.732583) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 04:48:05.732911) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 04:48:05.824910) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:48:05.825299) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1461584307.689261-1327563180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-25 04:48:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-04-25 04:48:06 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096330 ========= master_lag: 0.26 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:48:06.182449) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:48:06.182775) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1461584307.689261-1327563180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020926 ========= master_lag: 0.12 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:48:06.324773) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:48:06.325131) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 80598be5d80e695727ff74e712faa623b02f3c70 --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 80598be5d80e695727ff74e712faa623b02f3c70 --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=a12cd81e0ef515edd9e0d800000001bb-1461584307.689261-1327563180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-25 04:48:06,868 truncating revision to first 12 chars 2016-04-25 04:48:06,868 Setting DEBUG logging. 2016-04-25 04:48:06,868 attempt 1/10 2016-04-25 04:48:06,868 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/80598be5d80e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 04:48:07,394 unpacking tar archive at: fx-team-80598be5d80e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.791571 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:48:07.154563) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 04:48:07.154884) ========= script_repo_revision: 80598be5d80e695727ff74e712faa623b02f3c70 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 04:48:07.155256) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 04:48:07.155522) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 04:48:07.170527) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-04-25 04:48:07.170872) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1461584307.689261-1327563180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:48:07 INFO - MultiFileLogger online at 20160425 04:48:07 in /builds/slave/test 04:48:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 04:48:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:48:07 INFO - {'append_to_log': False, 04:48:07 INFO - 'base_work_dir': '/builds/slave/test', 04:48:07 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:48:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:48:07 INFO - 'branch': 'Fx-Team-Non-PGO', 04:48:07 INFO - 'buildbot_json_path': 'buildprops.json', 04:48:07 INFO - 'config_files': ('talos/linux_config.py',), 04:48:07 INFO - 'default_actions': ('clobber', 04:48:07 INFO - 'read-buildbot-config', 04:48:07 INFO - 'download-and-extract', 04:48:07 INFO - 'populate-webroot', 04:48:07 INFO - 'create-virtualenv', 04:48:07 INFO - 'install', 04:48:07 INFO - 'run-tests'), 04:48:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:48:07 INFO - 'download_minidump_stackwalk': True, 04:48:07 INFO - 'download_symbols': 'ondemand', 04:48:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:48:07 INFO - 'tooltool.py': '/tools/tooltool.py', 04:48:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:48:07 INFO - '/tools/misc-python/virtualenv.py')}, 04:48:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:48:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:48:07 INFO - 'installer_path': 'installer.exe', 04:48:07 INFO - 'log_level': 'info', 04:48:07 INFO - 'log_name': 'talos', 04:48:07 INFO - 'log_to_console': True, 04:48:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:48:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:48:07 INFO - 'opt_config_files': (), 04:48:07 INFO - 'pip_index': False, 04:48:07 INFO - 'sps_profile': False, 04:48:07 INFO - 'sps_profile_interval': 0, 04:48:07 INFO - 'suite': 'dromaeojs-e10s', 04:48:07 INFO - 'system_bits': '32', 04:48:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:48:07 INFO - 'title': 'talos-linux64-ix-064', 04:48:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:48:07 INFO - 'use_talos_json': True, 04:48:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:48:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:48:07 INFO - 'work_dir': 'build'} 04:48:07 INFO - ##### 04:48:07 INFO - ##### Running clobber step. 04:48:07 INFO - ##### 04:48:07 INFO - Running pre-action listener: _resource_record_pre_action 04:48:07 INFO - Running main action method: clobber 04:48:07 INFO - rmtree: /builds/slave/test/build 04:48:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:48:08 INFO - Running post-action listener: _resource_record_post_action 04:48:08 INFO - ##### 04:48:08 INFO - ##### Running read-buildbot-config step. 04:48:08 INFO - ##### 04:48:08 INFO - Running pre-action listener: _resource_record_pre_action 04:48:08 INFO - Running main action method: read_buildbot_config 04:48:08 INFO - Using buildbot properties: 04:48:08 INFO - { 04:48:08 INFO - "project": "", 04:48:08 INFO - "product": "firefox", 04:48:08 INFO - "script_repo_revision": "production", 04:48:08 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 04:48:08 INFO - "repository": "", 04:48:08 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 04:48:08 INFO - "buildid": "20160422035709", 04:48:08 INFO - "pgo_build": "False", 04:48:08 INFO - "basedir": "/builds/slave/test", 04:48:08 INFO - "buildnumber": 1202, 04:48:08 INFO - "slavename": "talos-linux64-ix-064", 04:48:08 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:48:08 INFO - "platform": "ubuntu64_hw", 04:48:08 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:48:08 INFO - "branch": "fx-team", 04:48:08 INFO - "repo_path": "integration/fx-team", 04:48:08 INFO - "revision": "80598be5d80e695727ff74e712faa623b02f3c70", 04:48:08 INFO - "stage_platform": "linux64", 04:48:08 INFO - "builduid": "3af33a9a7de54ba3986a82f34ab86caa", 04:48:08 INFO - "slavebuilddir": "test" 04:48:08 INFO - } 04:48:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 04:48:08 INFO - Running post-action listener: _resource_record_post_action 04:48:08 INFO - ##### 04:48:08 INFO - ##### Running download-and-extract step. 04:48:08 INFO - ##### 04:48:08 INFO - Running pre-action listener: _resource_record_pre_action 04:48:08 INFO - Running main action method: download_and_extract 04:48:08 INFO - mkdir: /builds/slave/test/build/tests 04:48:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:48:08 INFO - https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:48:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:48:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:48:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:48:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:48:10 INFO - Downloaded 1361 bytes. 04:48:10 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:48:10 INFO - Using the following test package requirements: 04:48:10 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:48:10 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:48:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:48:10 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:48:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:48:10 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:48:10 INFO - u'jsshell-linux-x86_64.zip'], 04:48:10 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:48:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:48:10 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:48:10 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:48:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:48:10 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:48:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:48:10 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:48:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:48:10 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:48:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:48:10 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:48:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:48:10 INFO - https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:48:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:48:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:48:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:48:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:48:12 INFO - Downloaded 22281373 bytes. 04:48:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:48:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:48:13 INFO - Return code: 0 04:48:13 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:48:13 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')]} 04:48:13 INFO - https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:48:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:48:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:48:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:48:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:48:16 INFO - Downloaded 22281373 bytes. 04:48:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:48:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:48:18 INFO - Return code: 0 04:48:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:48:18 INFO - https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:48:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:48:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:48:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:48:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:48:20 INFO - Downloaded 10845952 bytes. 04:48:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:48:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:48:20 INFO - Return code: 0 04:48:20 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')]} 04:48:20 INFO - https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:48:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:48:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:48:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:48:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:48:23 INFO - Downloaded 54650321 bytes. 04:48:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:48:23 INFO - mkdir: /builds/slave/test/properties 04:48:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:48:23 INFO - Writing to file /builds/slave/test/properties/build_url 04:48:23 INFO - Contents: 04:48:23 INFO - build_url:https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:48:24 INFO - Running post-action listener: _resource_record_post_action 04:48:24 INFO - Running post-action listener: set_extra_try_arguments 04:48:24 INFO - ##### 04:48:24 INFO - ##### Running populate-webroot step. 04:48:24 INFO - ##### 04:48:24 INFO - Running pre-action listener: _resource_record_pre_action 04:48:24 INFO - Running main action method: populate_webroot 04:48:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:48:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:48:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:48:24 INFO - '--tppagecycles', 04:48:24 INFO - '7'], 04:48:24 INFO - 'tests': ['tsvgm']}}, 04:48:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:48:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:48:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:48:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:48:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:48:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:48:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:48:24 INFO - 'talos_options': ['--disable-e10s'], 04:48:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:48:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:48:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:48:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:48:24 INFO - 'talos_options': ['--disable-e10s'], 04:48:24 INFO - 'tests': ['damp', 'tps']}, 04:48:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:48:24 INFO - 'tests': ['damp', 'tps']}, 04:48:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:48:24 INFO - 'tests': ['dromaeo_dom']}, 04:48:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:48:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:48:24 INFO - 'tests': ['a11yr', 04:48:24 INFO - 'ts_paint', 04:48:24 INFO - 'tpaint', 04:48:24 INFO - 'sessionrestore', 04:48:24 INFO - 'sessionrestore_no_auto_restore', 04:48:24 INFO - 'tabpaint']}, 04:48:24 INFO - 'other-e10s': {'tests': ['a11yr', 04:48:24 INFO - 'ts_paint', 04:48:24 INFO - 'tpaint', 04:48:24 INFO - 'sessionrestore', 04:48:24 INFO - 'sessionrestore_no_auto_restore', 04:48:24 INFO - 'tabpaint']}, 04:48:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:48:24 INFO - 'ts_paint', 04:48:24 INFO - 'tpaint', 04:48:24 INFO - 'sessionrestore', 04:48:24 INFO - 'sessionrestore_no_auto_restore', 04:48:24 INFO - 'tabpaint']}, 04:48:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:48:24 INFO - 'ts_paint', 04:48:24 INFO - 'tpaint', 04:48:24 INFO - 'sessionrestore', 04:48:24 INFO - 'sessionrestore_no_auto_restore', 04:48:24 INFO - 'tabpaint']}, 04:48:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:48:24 INFO - 'tests': ['a11yr', 04:48:24 INFO - 'ts_paint', 04:48:24 INFO - 'tpaint', 04:48:24 INFO - 'sessionrestore', 04:48:24 INFO - 'sessionrestore_no_auto_restore', 04:48:24 INFO - 'tabpaint']}, 04:48:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:48:24 INFO - 'tests': ['a11yr', 04:48:24 INFO - 'ts_paint', 04:48:24 INFO - 'tpaint', 04:48:24 INFO - 'sessionrestore', 04:48:24 INFO - 'sessionrestore_no_auto_restore', 04:48:24 INFO - 'tabpaint']}, 04:48:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:48:24 INFO - 'tests': ['tsvgx', 04:48:24 INFO - 'tsvgr_opacity', 04:48:24 INFO - 'tart', 04:48:24 INFO - 'tscrollx', 04:48:24 INFO - 'cart']}, 04:48:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:48:24 INFO - 'tsvgr_opacity', 04:48:24 INFO - 'tart', 04:48:24 INFO - 'tscrollx', 04:48:24 INFO - 'cart']}, 04:48:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:48:24 INFO - 'talos_options': ['--disable-e10s'], 04:48:24 INFO - 'tests': ['tp5o']}, 04:48:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:48:24 INFO - 'tests': ['tp5o']}, 04:48:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:48:24 INFO - 'talos_options': ['--disable-e10s', 04:48:24 INFO - '--xperf_path', 04:48:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:48:24 INFO - 'tests': ['tp5n']}, 04:48:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:48:24 INFO - 'talos_options': ['--xperf_path', 04:48:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:48:24 INFO - 'tests': ['tp5n']}}, 04:48:24 INFO - 'talos.zip': {'path': '', 04:48:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:48:24 INFO - Running post-action listener: _resource_record_post_action 04:48:24 INFO - ##### 04:48:24 INFO - ##### Running create-virtualenv step. 04:48:24 INFO - ##### 04:48:24 INFO - Running pre-action listener: _resource_record_pre_action 04:48:24 INFO - Running main action method: create_virtualenv 04:48:24 INFO - Creating virtualenv /builds/slave/test/build/venv 04:48:24 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 04:48:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:48:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:48:24 INFO - Using real prefix '/usr' 04:48:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:48:25 INFO - Installing distribute.............................................................................................................................................................................................done. 04:48:27 INFO - Installing pip.................done. 04:48:27 INFO - Return code: 0 04:48:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:48:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:48:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:48:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f661a08ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cf410>, '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 0x12d0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d07a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1461584307.689261-1327563180', '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 04:48:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:48:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:48:27 INFO - Using env: {'DISPLAY': ':0', 04:48:27 INFO - 'HOME': '/home/cltbld', 04:48:27 INFO - 'LANG': 'en_US.UTF-8', 04:48:27 INFO - 'LANGUAGE': 'en_US:en', 04:48:27 INFO - 'LOGNAME': 'cltbld', 04:48:27 INFO - 'MAIL': '/var/mail/cltbld', 04:48:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:27 INFO - 'MOZ_NO_REMOTE': '1', 04:48:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:48:27 INFO - 'NO_EM_RESTART': '1', 04:48:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:48:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:27 INFO - 'PWD': '/builds/slave/test', 04:48:27 INFO - 'SHELL': '/bin/bash', 04:48:27 INFO - 'SHLVL': '1', 04:48:27 INFO - 'TERM': 'linux', 04:48:27 INFO - 'TMOUT': '86400', 04:48:27 INFO - 'USER': 'cltbld', 04:48:27 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461584307.689261-1327563180', 04:48:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:27 INFO - '_': '/tools/buildbot/bin/python'} 04:48:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:48:27 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 04:48:27 INFO - Cleaning up... 04:48:27 INFO - Return code: 0 04:48:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:48:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:48:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:48:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f661a08ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cf410>, '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 0x12d0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d07a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1461584307.689261-1327563180', '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 04:48:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:48:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:48:27 INFO - Using env: {'DISPLAY': ':0', 04:48:27 INFO - 'HOME': '/home/cltbld', 04:48:27 INFO - 'LANG': 'en_US.UTF-8', 04:48:27 INFO - 'LANGUAGE': 'en_US:en', 04:48:27 INFO - 'LOGNAME': 'cltbld', 04:48:27 INFO - 'MAIL': '/var/mail/cltbld', 04:48:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:27 INFO - 'MOZ_NO_REMOTE': '1', 04:48:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:48:27 INFO - 'NO_EM_RESTART': '1', 04:48:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:48:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:27 INFO - 'PWD': '/builds/slave/test', 04:48:27 INFO - 'SHELL': '/bin/bash', 04:48:27 INFO - 'SHLVL': '1', 04:48:27 INFO - 'TERM': 'linux', 04:48:27 INFO - 'TMOUT': '86400', 04:48:27 INFO - 'USER': 'cltbld', 04:48:27 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461584307.689261-1327563180', 04:48:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:27 INFO - '_': '/tools/buildbot/bin/python'} 04:48:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:48:27 INFO - Downloading/unpacking psutil>=0.7.1 04:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:48:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:48:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:48:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:48:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:48:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:48:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:48:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:48:29 INFO - Installing collected packages: psutil 04:48:29 INFO - Running setup.py install for psutil 04:48:29 INFO - building 'psutil._psutil_linux' extension 04:48:29 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 04:48:29 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 04:48:29 INFO - building 'psutil._psutil_posix' extension 04:48:29 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 04:48:30 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 04:48:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:48:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:48:30 INFO - Successfully installed psutil 04:48:30 INFO - Cleaning up... 04:48:30 INFO - Return code: 0 04:48:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:48:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:48:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:48:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:48:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f661a08ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cf410>, '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 0x12d0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d07a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1461584307.689261-1327563180', '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 04:48:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:48:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:48:30 INFO - Using env: {'DISPLAY': ':0', 04:48:30 INFO - 'HOME': '/home/cltbld', 04:48:30 INFO - 'LANG': 'en_US.UTF-8', 04:48:30 INFO - 'LANGUAGE': 'en_US:en', 04:48:30 INFO - 'LOGNAME': 'cltbld', 04:48:30 INFO - 'MAIL': '/var/mail/cltbld', 04:48:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:30 INFO - 'MOZ_NO_REMOTE': '1', 04:48:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:48:30 INFO - 'NO_EM_RESTART': '1', 04:48:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:48:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:30 INFO - 'PWD': '/builds/slave/test', 04:48:30 INFO - 'SHELL': '/bin/bash', 04:48:30 INFO - 'SHLVL': '1', 04:48:30 INFO - 'TERM': 'linux', 04:48:30 INFO - 'TMOUT': '86400', 04:48:30 INFO - 'USER': 'cltbld', 04:48:30 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461584307.689261-1327563180', 04:48:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:30 INFO - '_': '/tools/buildbot/bin/python'} 04:48:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:48:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:48:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:48:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:48:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:48:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:48:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:48:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:48:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:48:32 INFO - Installing collected packages: mozsystemmonitor 04:48:32 INFO - Running setup.py install for mozsystemmonitor 04:48:32 INFO - Successfully installed mozsystemmonitor 04:48:32 INFO - Cleaning up... 04:48:32 INFO - Return code: 0 04:48:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:48:32 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')]} 04:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:48:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:32 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')]} 04:48:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:48:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:32 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 0x7f661a08ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cf410>, '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 0x12d0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d07a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1461584307.689261-1327563180', '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 04:48:32 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 04:48:32 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 04:48:32 INFO - Using env: {'DISPLAY': ':0', 04:48:32 INFO - 'HOME': '/home/cltbld', 04:48:32 INFO - 'LANG': 'en_US.UTF-8', 04:48:32 INFO - 'LANGUAGE': 'en_US:en', 04:48:32 INFO - 'LOGNAME': 'cltbld', 04:48:32 INFO - 'MAIL': '/var/mail/cltbld', 04:48:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:32 INFO - 'MOZ_NO_REMOTE': '1', 04:48:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:48:32 INFO - 'NO_EM_RESTART': '1', 04:48:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:48:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:32 INFO - 'PWD': '/builds/slave/test', 04:48:32 INFO - 'SHELL': '/bin/bash', 04:48:32 INFO - 'SHLVL': '1', 04:48:32 INFO - 'TERM': 'linux', 04:48:32 INFO - 'TMOUT': '86400', 04:48:32 INFO - 'USER': 'cltbld', 04:48:32 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461584307.689261-1327563180', 04:48:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:32 INFO - '_': '/tools/buildbot/bin/python'} 04:48:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:48:32 INFO - Downloading/unpacking blobuploader==1.2.4 04:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:48:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:48:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:48:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:48:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:48:34 INFO - Downloading blobuploader-1.2.4.tar.gz 04:48:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:48:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:48:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:48:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:48:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:48:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:48:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:48:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:48:35 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 04:48:35 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 04:48:35 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 04:48:35 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 04:48:35 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 04:48:35 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 04:48:35 INFO - Downloading docopt-0.6.1.tar.gz 04:48:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:48:35 INFO - Installing collected packages: blobuploader, requests, docopt 04:48:35 INFO - Running setup.py install for blobuploader 04:48:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:48:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:48:35 INFO - Running setup.py install for requests 04:48:35 INFO - Running setup.py install for docopt 04:48:35 INFO - Successfully installed blobuploader requests docopt 04:48:35 INFO - Cleaning up... 04:48:35 INFO - Return code: 0 04:48:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:48:35 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')]} 04:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:48:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:35 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')]} 04:48:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:48:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:35 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 0x7f661a08ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cf410>, '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 0x12d0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d07a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1461584307.689261-1327563180', '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 04:48:35 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 04:48:35 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 04:48:35 INFO - Using env: {'DISPLAY': ':0', 04:48:35 INFO - 'HOME': '/home/cltbld', 04:48:35 INFO - 'LANG': 'en_US.UTF-8', 04:48:35 INFO - 'LANGUAGE': 'en_US:en', 04:48:35 INFO - 'LOGNAME': 'cltbld', 04:48:35 INFO - 'MAIL': '/var/mail/cltbld', 04:48:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:35 INFO - 'MOZ_NO_REMOTE': '1', 04:48:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:48:35 INFO - 'NO_EM_RESTART': '1', 04:48:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:48:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:35 INFO - 'PWD': '/builds/slave/test', 04:48:35 INFO - 'SHELL': '/bin/bash', 04:48:35 INFO - 'SHLVL': '1', 04:48:35 INFO - 'TERM': 'linux', 04:48:35 INFO - 'TMOUT': '86400', 04:48:35 INFO - 'USER': 'cltbld', 04:48:35 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461584307.689261-1327563180', 04:48:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:35 INFO - '_': '/tools/buildbot/bin/python'} 04:48:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:48:36 INFO - Running setup.py (path:/tmp/pip-TnxbHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:48:36 INFO - Running setup.py (path:/tmp/pip-SnZ6id-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:48:36 INFO - Running setup.py (path:/tmp/pip-QCyPPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:48:36 INFO - Running setup.py (path:/tmp/pip-52GuxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:48:36 INFO - Running setup.py (path:/tmp/pip-MQbZXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:48:36 INFO - Running setup.py (path:/tmp/pip-42mkQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:48:36 INFO - Running setup.py (path:/tmp/pip-92NM5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:48:36 INFO - Running setup.py (path:/tmp/pip-i18fmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:48:36 INFO - Running setup.py (path:/tmp/pip-nn2Thi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:48:36 INFO - Running setup.py (path:/tmp/pip-45QCt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:48:36 INFO - Running setup.py (path:/tmp/pip-5Vgfej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:48:36 INFO - Running setup.py (path:/tmp/pip-CFKAzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:48:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:48:37 INFO - Running setup.py (path:/tmp/pip-BhOlXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:48:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:48:37 INFO - Running setup.py (path:/tmp/pip-94ZTNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:48:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:48:37 INFO - Running setup.py (path:/tmp/pip-wN0KBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:48:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:48:37 INFO - Running setup.py (path:/tmp/pip-olIeT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:48:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:48:37 INFO - Running setup.py (path:/tmp/pip-1ez0ix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:48:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:48:37 INFO - Running setup.py install for manifestparser 04:48:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:48:37 INFO - Running setup.py install for mozcrash 04:48:37 INFO - Running setup.py install for mozdebug 04:48:37 INFO - Running setup.py install for mozdevice 04:48:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:48:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:48:37 INFO - Running setup.py install for mozfile 04:48:37 INFO - Running setup.py install for mozhttpd 04:48:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:48:38 INFO - Running setup.py install for mozinfo 04:48:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:48:38 INFO - Running setup.py install for mozInstall 04:48:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:48:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:48:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:48:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:48:38 INFO - Running setup.py install for mozleak 04:48:38 INFO - Running setup.py install for mozlog 04:48:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:48:38 INFO - Running setup.py install for moznetwork 04:48:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:48:38 INFO - Running setup.py install for mozprocess 04:48:38 INFO - Running setup.py install for mozprofile 04:48:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:48:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:48:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:48:38 INFO - Running setup.py install for mozrunner 04:48:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:48:38 INFO - Running setup.py install for mozscreenshot 04:48:38 INFO - Running setup.py install for moztest 04:48:39 INFO - Running setup.py install for mozversion 04:48:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:48:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:48:39 INFO - Cleaning up... 04:48:39 INFO - Return code: 0 04:48:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:48: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')]} 04:48:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:48:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48: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')]} 04:48:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:48:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:39 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 0x7f661a08ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cf410>, '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 0x12d0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d07a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1461584307.689261-1327563180', '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 04:48:39 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 04:48:39 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 04:48:39 INFO - Using env: {'DISPLAY': ':0', 04:48:39 INFO - 'HOME': '/home/cltbld', 04:48:39 INFO - 'LANG': 'en_US.UTF-8', 04:48:39 INFO - 'LANGUAGE': 'en_US:en', 04:48:39 INFO - 'LOGNAME': 'cltbld', 04:48:39 INFO - 'MAIL': '/var/mail/cltbld', 04:48:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:39 INFO - 'MOZ_NO_REMOTE': '1', 04:48:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:48:39 INFO - 'NO_EM_RESTART': '1', 04:48:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:48:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:39 INFO - 'PWD': '/builds/slave/test', 04:48:39 INFO - 'SHELL': '/bin/bash', 04:48:39 INFO - 'SHLVL': '1', 04:48:39 INFO - 'TERM': 'linux', 04:48:39 INFO - 'TMOUT': '86400', 04:48:39 INFO - 'USER': 'cltbld', 04:48:39 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461584307.689261-1327563180', 04:48:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:39 INFO - '_': '/tools/buildbot/bin/python'} 04:48:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:48:39 INFO - Running setup.py (path:/tmp/pip-jAmN49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:48:39 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)) 04:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:48:39 INFO - Running setup.py (path:/tmp/pip-xKrpqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:48:39 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)) 04:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:48:39 INFO - Running setup.py (path:/tmp/pip-kAzT2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:48:39 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)) 04:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:48:39 INFO - Running setup.py (path:/tmp/pip-N_QL3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:48:39 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)) 04:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:48:39 INFO - Running setup.py (path:/tmp/pip-HG3f0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:48:39 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)) 04:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:48:39 INFO - Running setup.py (path:/tmp/pip-y_S89F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:48:39 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)) 04:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:48:39 INFO - Running setup.py (path:/tmp/pip-9ggoJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:48:39 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)) 04:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:48:39 INFO - Running setup.py (path:/tmp/pip-osBbRu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:48:40 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)) 04:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:48:40 INFO - Running setup.py (path:/tmp/pip-KcAmtU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:48:40 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)) 04:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:48:40 INFO - Running setup.py (path:/tmp/pip-1ilcYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:48:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 04:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:48:40 INFO - Running setup.py (path:/tmp/pip-YTiOy6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:48:40 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)) 04:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:48:40 INFO - Running setup.py (path:/tmp/pip-OcOJk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:48:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:48:40 INFO - Running setup.py (path:/tmp/pip-DioJMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:48:40 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)) 04:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:48:40 INFO - Running setup.py (path:/tmp/pip-33ZUPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:48:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:48:40 INFO - Running setup.py (path:/tmp/pip-DBTaeO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:48:40 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)) 04:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:48:40 INFO - Running setup.py (path:/tmp/pip-XcA0oF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:48:40 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)) 04:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:48:40 INFO - Running setup.py (path:/tmp/pip-JEPYbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:48:40 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)) 04:48:40 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)) 04:48:40 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)) 04:48:40 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)) 04:48:40 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)) 04:48:40 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)) 04:48:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:48:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:48:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:48:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:48:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:48:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:48:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:48:42 INFO - Downloading blessings-1.6.tar.gz 04:48:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:48:42 INFO - Installing collected packages: blessings 04:48:42 INFO - Running setup.py install for blessings 04:48:42 INFO - Successfully installed blessings 04:48:42 INFO - Cleaning up... 04:48:42 INFO - Return code: 0 04:48:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:48:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:48:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:48:42 INFO - Reading from file tmpfile_stdout 04:48:42 INFO - Current package versions: 04:48:42 INFO - argparse == 1.2.1 04:48:42 INFO - blessings == 1.6 04:48:42 INFO - blobuploader == 1.2.4 04:48:42 INFO - docopt == 0.6.1 04:48:42 INFO - manifestparser == 1.1 04:48:42 INFO - mozInstall == 1.12 04:48:42 INFO - mozcrash == 0.17 04:48:42 INFO - mozdebug == 0.1 04:48:42 INFO - mozdevice == 0.48 04:48:42 INFO - mozfile == 1.2 04:48:42 INFO - mozhttpd == 0.7 04:48:42 INFO - mozinfo == 0.9 04:48:42 INFO - mozleak == 0.1 04:48:42 INFO - mozlog == 3.1 04:48:42 INFO - moznetwork == 0.27 04:48:42 INFO - mozprocess == 0.22 04:48:42 INFO - mozprofile == 0.28 04:48:42 INFO - mozrunner == 6.11 04:48:42 INFO - mozscreenshot == 0.1 04:48:42 INFO - mozsystemmonitor == 0.0 04:48:42 INFO - moztest == 0.7 04:48:42 INFO - mozversion == 1.4 04:48:42 INFO - psutil == 3.1.1 04:48:42 INFO - requests == 1.2.3 04:48:42 INFO - wsgiref == 0.1.2 04:48:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:48: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')]} 04:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:48:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48: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')]} 04:48:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:48:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:42 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 0x7f661a08ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cf410>, '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 0x12d0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d07a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1461584307.689261-1327563180', '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 04:48:42 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 04:48:42 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 04:48:43 INFO - Using env: {'DISPLAY': ':0', 04:48:43 INFO - 'HOME': '/home/cltbld', 04:48:43 INFO - 'LANG': 'en_US.UTF-8', 04:48:43 INFO - 'LANGUAGE': 'en_US:en', 04:48:43 INFO - 'LOGNAME': 'cltbld', 04:48:43 INFO - 'MAIL': '/var/mail/cltbld', 04:48:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:43 INFO - 'MOZ_NO_REMOTE': '1', 04:48:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:48:43 INFO - 'NO_EM_RESTART': '1', 04:48:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:48:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:43 INFO - 'PWD': '/builds/slave/test', 04:48:43 INFO - 'SHELL': '/bin/bash', 04:48:43 INFO - 'SHLVL': '1', 04:48:43 INFO - 'TERM': 'linux', 04:48:43 INFO - 'TMOUT': '86400', 04:48:43 INFO - 'USER': 'cltbld', 04:48:43 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461584307.689261-1327563180', 04:48:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:43 INFO - '_': '/tools/buildbot/bin/python'} 04:48:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:48:43 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)) 04:48:43 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)) 04:48:43 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)) 04:48:43 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)) 04:48:43 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)) 04:48:43 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)) 04:48:43 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)) 04:48:43 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)) 04:48:43 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)) 04:48:43 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)) 04:48:43 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)) 04:48:43 INFO - Cleaning up... 04:48:43 INFO - Return code: 0 04:48:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:48:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:48:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:48:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:43 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 0x7f661a08ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cf410>, '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 0x12d0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d07a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1461584307.689261-1327563180', '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 04:48:43 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 04:48:43 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 04:48:43 INFO - Using env: {'DISPLAY': ':0', 04:48:43 INFO - 'HOME': '/home/cltbld', 04:48:43 INFO - 'LANG': 'en_US.UTF-8', 04:48:43 INFO - 'LANGUAGE': 'en_US:en', 04:48:43 INFO - 'LOGNAME': 'cltbld', 04:48:43 INFO - 'MAIL': '/var/mail/cltbld', 04:48:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:43 INFO - 'MOZ_NO_REMOTE': '1', 04:48:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:48:43 INFO - 'NO_EM_RESTART': '1', 04:48:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:48:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:43 INFO - 'PWD': '/builds/slave/test', 04:48:43 INFO - 'SHELL': '/bin/bash', 04:48:43 INFO - 'SHLVL': '1', 04:48:43 INFO - 'TERM': 'linux', 04:48:43 INFO - 'TMOUT': '86400', 04:48:43 INFO - 'USER': 'cltbld', 04:48:43 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461584307.689261-1327563180', 04:48:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:43 INFO - '_': '/tools/buildbot/bin/python'} 04:48:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:48:43 INFO - Downloading/unpacking jsonschema 04:48:43 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 04:48:43 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 04:48:43 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 04:48:43 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 04:48:43 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 04:48:43 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 04:48:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:48:45 INFO - Downloading/unpacking functools32 (from jsonschema) 04:48:45 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 04:48:45 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 04:48:45 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 04:48:45 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 04:48:45 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 04:48:45 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 04:48:45 INFO - Downloading functools32-3.2.3-2.tar.gz 04:48:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:48:45 INFO - warning: no files found matching '*.txt' 04:48:45 INFO - no previously-included directories found matching 'build' 04:48:45 INFO - no previously-included directories found matching 'dist' 04:48:45 INFO - no previously-included directories found matching '.git*' 04:48:45 INFO - Installing collected packages: jsonschema, functools32 04:48:45 INFO - Running setup.py install for functools32 04:48:45 INFO - warning: no files found matching '*.txt' 04:48:45 INFO - no previously-included directories found matching 'build' 04:48:45 INFO - no previously-included directories found matching 'dist' 04:48:45 INFO - no previously-included directories found matching '.git*' 04:48:45 INFO - Successfully installed jsonschema functools32 04:48:45 INFO - Cleaning up... 04:48:45 INFO - Return code: 0 04:48:45 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:48:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:48:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:48:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:48:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f661a08ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cf410>, '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 0x12d0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d07a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1461584307.689261-1327563180', '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 04:48:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:48:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:48:45 INFO - Using env: {'DISPLAY': ':0', 04:48:45 INFO - 'HOME': '/home/cltbld', 04:48:45 INFO - 'LANG': 'en_US.UTF-8', 04:48:45 INFO - 'LANGUAGE': 'en_US:en', 04:48:45 INFO - 'LOGNAME': 'cltbld', 04:48:45 INFO - 'MAIL': '/var/mail/cltbld', 04:48:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:45 INFO - 'MOZ_NO_REMOTE': '1', 04:48:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:48:45 INFO - 'NO_EM_RESTART': '1', 04:48:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:48:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:45 INFO - 'PWD': '/builds/slave/test', 04:48:45 INFO - 'SHELL': '/bin/bash', 04:48:45 INFO - 'SHLVL': '1', 04:48:45 INFO - 'TERM': 'linux', 04:48:45 INFO - 'TMOUT': '86400', 04:48:45 INFO - 'USER': 'cltbld', 04:48:45 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461584307.689261-1327563180', 04:48:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:45 INFO - '_': '/tools/buildbot/bin/python'} 04:48:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:48:46 INFO - Downloading/unpacking flake8 04:48: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 04:48: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 04:48: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 04:48: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 04:48: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 04:48: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 04:48:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:48:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:48: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 04:48: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 04:48: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 04:48: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 04:48: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 04:48: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 04:48:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:48:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:48:48 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 04:48:48 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 04:48:48 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 04:48:48 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 04:48:48 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 04:48:48 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 04:48:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:48:48 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 04:48:48 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 04:48:48 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 04:48:48 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 04:48:48 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 04:48:48 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 04:48:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:48:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:48:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:48:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:48:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:48:48 INFO - no previously-included directories found matching 'docs/_build' 04:48:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:48:48 INFO - Running setup.py install for pep8 04:48:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:48:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:48:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:48:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:48:48 INFO - no previously-included directories found matching 'docs/_build' 04:48:48 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:48:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:48:48 INFO - Cleaning up... 04:48:48 INFO - Return code: 0 04:48:48 INFO - Running post-action listener: _resource_record_post_action 04:48:48 INFO - Running post-action listener: _start_resource_monitoring 04:48:48 INFO - Starting resource monitoring. 04:48:48 INFO - ##### 04:48:48 INFO - ##### Running install step. 04:48:48 INFO - ##### 04:48:48 INFO - Running pre-action listener: _resource_record_pre_action 04:48:48 INFO - Running main action method: install 04:48:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:48:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:48:49 INFO - Reading from file tmpfile_stdout 04:48:49 INFO - Detecting whether we're running mozinstall >=1.0... 04:48:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:48:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:48:49 INFO - Reading from file tmpfile_stdout 04:48:49 INFO - Output received: 04:48:49 INFO - Usage: mozinstall [options] installer 04:48:49 INFO - Options: 04:48:49 INFO - -h, --help show this help message and exit 04:48:49 INFO - -d DEST, --destination=DEST 04:48:49 INFO - Directory to install application into. [default: 04:48:49 INFO - "/builds/slave/test"] 04:48:49 INFO - --app=APP Application being installed. [default: firefox] 04:48:49 INFO - mkdir: /builds/slave/test/build/application 04:48:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:48:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:49:04 INFO - Reading from file tmpfile_stdout 04:49:04 INFO - Output received: 04:49:04 INFO - /builds/slave/test/build/application/firefox/firefox 04:49:04 INFO - Running post-action listener: _resource_record_post_action 04:49:04 INFO - ##### 04:49:04 INFO - ##### Running run-tests step. 04:49:04 INFO - ##### 04:49:04 INFO - Running pre-action listener: _resource_record_pre_action 04:49:04 INFO - Running main action method: run_tests 04:49:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:49:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:49:04 INFO - Python 2.7.3 04:49:04 INFO - Return code: 0 04:49:04 INFO - grabbing minidump binary from tooltool 04:49:04 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')]} 04:49:04 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cf410>, '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 0x12d0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d07a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:49:04 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 04:49:04 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 04:49:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:49:04 INFO - Return code: 0 04:49:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:49:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:49:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:49:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:49:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:49:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:49:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:49:05 INFO - Return code: 0 04:49:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:49:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:49:05 INFO - Using env: {'DISPLAY': ':0', 04:49:05 INFO - 'HOME': '/home/cltbld', 04:49:05 INFO - 'LANG': 'en_US.UTF-8', 04:49:05 INFO - 'LANGUAGE': 'en_US:en', 04:49:05 INFO - 'LOGNAME': 'cltbld', 04:49:05 INFO - 'MAIL': '/var/mail/cltbld', 04:49:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:49:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:49:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:05 INFO - 'MOZ_NO_REMOTE': '1', 04:49:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:49:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:05 INFO - 'NO_EM_RESTART': '1', 04:49:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:05 INFO - 'PWD': '/builds/slave/test', 04:49:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:49:05 INFO - 'SHELL': '/bin/bash', 04:49:05 INFO - 'SHLVL': '1', 04:49:05 INFO - 'TERM': 'linux', 04:49:05 INFO - 'TMOUT': '86400', 04:49:05 INFO - 'USER': 'cltbld', 04:49:05 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461584307.689261-1327563180', 04:49:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:05 INFO - '_': '/tools/buildbot/bin/python'} 04:49:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:49:06 INFO - mozversion application_buildid: 20160422035709 04:49:06 INFO - mozversion application_changeset: 80598be5d80e695727ff74e712faa623b02f3c70 04:49:06 INFO - mozversion application_display_name: Nightly 04:49:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:49:06 INFO - mozversion application_name: Firefox 04:49:06 INFO - mozversion application_remotingname: firefox 04:49:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:49:06 INFO - mozversion application_vendor: Mozilla 04:49:06 INFO - mozversion application_version: 48.0a1 04:49:06 INFO - mozversion platform_buildid: 20160422035709 04:49:06 INFO - mozversion platform_changeset: 80598be5d80e695727ff74e712faa623b02f3c70 04:49:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:49:06 INFO - mozversion platform_version: 48.0a1 04:49:06 INFO - using testdate: 1461584946 04:49:06 INFO - actual date: 1461584946 04:49:06 INFO - starting webserver on 'localhost:50007' 04:49:06 INFO - SUITE-START | Running 2 tests 04:49:06 INFO - TEST-START | dromaeo_css 04:49:06 INFO - operating with platform_type : linux_ 04:49:06 INFO - Initialising browser for dromaeo_css test... 04:49:06 INFO - TEST-INFO | started process 7009 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTCsvFm/profile http://localhost:50007/getInfo.html) 04:49:10 INFO - PROCESS | 7009 | 04:49:10 INFO - PROCESS | 7009 | (process:7074): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:49:11 INFO - PROCESS | 7009 | __metrics Screen width/height:1600/1200 04:49:11 INFO - PROCESS | 7009 | colorDepth:24 04:49:11 INFO - PROCESS | 7009 | Browser inner width/height: 1024/697 04:49:11 INFO - PROCESS | 7009 | __metrics 04:49:12 ERROR - PROCESS | 7009 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 04:49:13 INFO - TEST-INFO | 7009: exit 0 04:49:13 INFO - Browser initialized. 04:49:13 INFO - Running cycle 1/1 for dromaeo_css test... 04:49:13 INFO - TEST-INFO | started process 7125 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTCsvFm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:49:14 INFO - PROCESS | 7125 | 04:49:14 INFO - PROCESS | 7125 | (process:7185): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:49:24 INFO - PROCESS | 7125 | RSS: Main: 165081088 04:49:24 INFO - PROCESS | 7125 | 04:50:14 INFO - PROCESS | 7125 | 1461585014575 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] 04:52:26 INFO - PROCESS | 7125 | Cycle 1(1): loaded http://localhost:50007/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50007/tests/dromaeo/cssquery-ext.html) 04:52:27 INFO - PROCESS | 7125 | RSS: Main: 167305216 04:52:27 INFO - PROCESS | 7125 | 04:55:29 INFO - PROCESS | 7125 | Cycle 1(1): loaded http://localhost:50007/tests/dromaeo/cssquery-ext.html (next: http://localhost:50007/tests/dromaeo/cssquery-jquery.html) 04:55:29 INFO - PROCESS | 7125 | RSS: Main: 165912576 04:55:29 INFO - PROCESS | 7125 | 04:58:31 INFO - PROCESS | 7125 | Cycle 1(1): loaded http://localhost:50007/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50007/tests/dromaeo/cssquery-mootools.html) 04:58:32 INFO - PROCESS | 7125 | RSS: Main: 167288832 04:58:32 INFO - PROCESS | 7125 | 05:01:34 INFO - PROCESS | 7125 | Cycle 1(1): loaded http://localhost:50007/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50007/tests/dromaeo/cssquery-prototype.html) 05:01:34 INFO - PROCESS | 7125 | RSS: Main: 164888576 05:01:34 INFO - PROCESS | 7125 | 05:04:37 INFO - PROCESS | 7125 | Cycle 1(1): loaded http://localhost:50007/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50007/tests/dromaeo/cssquery-yui.html) 05:04:38 INFO - PROCESS | 7125 | RSS: Main: 166305792 05:04:38 INFO - PROCESS | 7125 | 05:07:40 INFO - PROCESS | 7125 | Cycle 1(1): loaded http://localhost:50007/tests/dromaeo/cssquery-yui.html (next: http://localhost:50007/tests/dromaeo/cssquery-dojo.html) 05:07:40 INFO - PROCESS | 7125 | RSS: Main: 168488960 05:07:40 INFO - PROCESS | 7125 | 05:07:40 INFO - PROCESS | 7125 | __start_tp_report 05:07:40 INFO - PROCESS | 7125 | _x_x_mozilla_page_load 05:07:40 INFO - PROCESS | 7125 | _x_x_mozilla_page_load_details 05:07:40 INFO - PROCESS | 7125 | |i|pagename|runs| 05:07:40 INFO - PROCESS | 7125 | |0;dojo.html;2602.284371797756;2683.221865658959;2717.782577393809;2720.6735191776966;2729.877155528001;4679.344891715158;4747.335373047776;4756.191447453933;4757.64317676174;4762.928341123245;4686.9296960545535;4767.856964291077;4844.20070688336;4889.731064791435;4895.363602731649;4456.376107344982;4486.57377549134;4541.795619197128;4542.091581683677;4592.311153326994;4468.307412351074;4536.092781443725;4561.521040290771;4586.4725556560925;4590.081983603276;4315.43899293093;4320.65434765218;4388.5830846069575;4465.821367145294;4522.525134860858;4348.130373925196;4373.978130109329;4388.868333949987;4391.3193455014525;4432.15789000089;4364.781760911942;4366.170427618742;4372.497162826252;4377.9781101094295;4404.471463424377;4655.930161047587;4711.458182309044;4728.929066064012;4751.287306903958;4760.166970780099;5136.794528218867;5146.897062058775;5157.4584668610005;5160.741962901878;5179.663321884103;5080.8221712240265;5155.175171972466;5164.767585458663;5172.27588137661;5180.989707007135;4786.497417771154;4831.73425461596;4836.177849765478;4864.173090574611;4870.9269360959615;5293.550048245866;5310.6813591184655;5314.415414304423;5340.546053585411;5373.35519737634;4932.53140951609;5064;5097.566706829887;5099.158638824552;5104.3109180260935;5186.662866913639;5202.063628546823;5204.34945631796;5232.712200828915;5284.233786100994;4847.103285892122;5065.645404821627;5158.664686795421;5191.558717508979;5197.870053248699;5002.57478114357;5100.948990510122;5115.667481613683;5119.59043276537;5121.411037730634;4268.786560671954;4289.399484072233;4290.785460726951;4300.268954277781;4338.522762496123;3750.1749615084636;3756.5492140942715;3762.0030691866677;3779.8866034019024;3794.9241015180096;4356.172327257811;4404.207242696345;4405.625521830681;4440.289553671397;4465.084657645175;5150.381954165449;5179.22311653255;5183.2743415921805;5191.428942816287;5207.739613019409;4394.670399720034;4439.311906654474;4444.82220711168;4455.477496710784;4476.26141686618;4495;4549.135664223787;4586.816527338936;4607.562281583244;4645.72125672454;4796.544328288807;4805.927911081267;4821.686590371684;4844.733539655353;4847.903041939212;5116.1046816806165;5134.9743251285;5140.537351638371;5146.639735218649;5149.279100925798;4767.642426818072;4804.95195048045;4847.3698419205275;4863.440704319049;4920.237363208708;5154.5103215194495;5165.793368265227;5178.119719647744;5183.870403239949;5186.092433824141;5265.052290587731;5266.947330526646;5271.288376069181;5273.683578985273;5313.990341835039;4923.384576927884;4971.776270067783;5045.621578381562;5089.847304580869;5131.384233891957;4868.172410690262;4931.852044438672;4944.085344211332;4948.455669876239;4988.501149885127;4923.679960802537;4945.085159245551;4978.30303757467;4986.800527978985;5030.144875371123;4955.157623204136;5071.721055341992;5090.618203634816;5114.539691427789;5127.3847138343635;4947.554720075211;4955.876103097451;4956.479569645136;4962.379702537183;4969.35398398206 05:07:40 INFO - PROCESS | 7125 | |1;ext.html;570.167555369161;587.1369087441461;597.7130977130977;608.57095747498;632.8417895526119;33667.66332336676;34478.48282275768;34649;34740.131496712595;34781.47827782579;35483.82258088712;35533.2893342133;35845.82077089617;35852.282954340895;36196.45705314422;7418.1839997600355;7588.317051465367;7589.430792690543;7589.772306830776;7612.961935190317;7545.54726716396;7561.62191890406;7635.198304178065;7635.541867487968;7660.731874384398;7675.69297228113;7716.498427602216;7717.768466946;7759.262870027366;7763.728269510569;7631.465797394185;7658.770236892902;7686.53880767153;7691.384689224877;7745.457817952745;7671.079470463525;7715.729949451798;7748.457607967444;7769.10655274645;7790.883136752953;29839;35504.289914201574;35859;36021.27957440836;36056.63943360585;2746.6978632350424;2829.1795379339965;2894.2474956511246;3278.9016329510155;3600.531930848999;25801.61297580538;26409.3397665058;26705.960113507146;26865.462690746077;27047;3371.5279860819505;3380.121168496184;3433.918315730537;3549.7337699672626;3571.5178450909057;244828;248941;248954;249520;250398.74800626063;57665.71167144137;57907;58163.4183658158;58253.417465825645;58298.12552811711;61108.69445652743;62443.6877815608;62733;63011.36988630055;63034.36965630377;13843.377048032662;14007.509737159151;14039.438422462987;14052.929735351463;14056.367463464168;10540.367577945348;10587;10601.787964240671;10615.89384106149;10669.46652667379;18470.261189552268;18550.257989680533;18628.906855465906;19410.2235910562;19560;7296.379807716297;7299.744508942162;7479.252074792477;7556.65995030214;7614.200508946592;905.7463910105181;920.8756817829508;1000.5197505197546;1003.4481035430484;1078.8166011778017;27703.30741731473;28017.439651206863;28022.458764768133;28642.85678571594;28680.569791453145;974;989.6140505202976;1013.1337706261188;1079.2822772855964;1111.8776934537195;13123.146995445266;13587;13806.309684515734;13818.101823381448;13920.37358318878;341004;343311;346678;346971;347063;48329.27506087411;49289.75355123202;49329.260061099114;49402.258966115536;49408.25887611689;1184.2953442701578;1223.7674841780033;1251.2742609286593;1265.3293754310414;1274.5857596281246;25668.871655641604;26112.477750444505;26156.215313540622;26297.21108366752;26449.60325595079;40369.39445908255;41200.38199426951;41217.1756564873;41249.79375103105;41253.38119928144;314535;316681;317073;317241;320101;25346.873265633552;38689.61310386973;39717.404238937015;39862.40206396965;40499;35979.28041439209;37109.81445092757;37358;37372.62627373692;37970.81014594909;31846;31862.203444914063;31866.522002169524;32758.672413275563;35218.47172292366;34031.48952765661;34628.65371346254;34720.479192811625;35019.64980350164;35115.473267901514;34787;35136.29727405489;35262.11844703903;38349;40287;30008.69991300059;31551;31893.8405307972;31966;32141.196470088435;24268;24542.263732088068;24598;25053.373665658506;25067.74932250654 05:07:40 INFO - PROCESS | 7125 | |2;jquery.html;371.10378436076877;373.5797228118367;381.942708593711;384.2487936084954;390.040500369092;14994.77507837382;15540.922295388522;15961;15961.760573591406;16011.439599614001;15377.84622153778;16216.75674864878;16846.915765421185;16877.493675189733;16884.915575422136;5081.847544573659;5184.196449550326;5210.348706411699;5240.240165176047;5255.185446255837;4917.82787602434;5087.872803179913;5124.4875512448825;5152.252923326116;5160.896782064357;5106.821261255856;5121.180611102224;5129.461406552315;5139.640225184238;5177.275181474596;4906.607471402279;5053.242013697938;5065.721385323787;5111.08000559899;5133.1786914093755;4550.795214215368;4566.315052742082;4595.678302518825;4599.356090147382;4605.861824145281;19330.903345483322;19885.900570497055;20328;20574;20710.068046937922;1946.13397038318;1953.7167110769;2215.2578886073184;2225.4436390902274;2411.1922505960524;13172.209667419986;13218.933905330508;13352.666183345396;13396.196228226338;13673.863261367358;1767.646470705864;1795.6857549928711;1837.0263760206979;1862.087577087231;1880.548668319607;51698;60173.6991315045;64445.67777161084;66141;69540.65229673819;9243.722688319362;9433.339666223299;9566.091221333962;9687.225021998223;9869;13276.468941242436;13425.798613020812;13443.529476468277;13453.596392108253;13473.865261347457;6915.51591388608;6950.54821436605;7114.964425177841;7273.309035641606;7312.305330993547;6763.864722705518;6797.150356205474;6858.862822743517;6972;7013.26360732126;5981.641101533922;5990.7903223386975;6013.368596297413;6075.362086980892;6075.756969721162;1757.9296828126733;1787.2672204396395;1794.7666803315747;1794.8564114870778;1822.125379817695;866.7789713623112;868.9565521723888;887.1040249348205;901.4456109492614;903.5798353765531;16157.757633635505;16363.181840907908;16396.508104756875;16678;16817.747733784003;858.7552547523926;909.6406919266852;910.6539514984264;963.5519483440233;991.9851202231972;9452.385594936308;9570.186534144537;9609.567569459392;9776.413415195111;9943.15483183923;308587;309616;311387;312293;414912;67851;73288.63355683294;83666;83727;84326.57836710777;848.9787755306044;925.4909799610188;951.6764300137986;957.5403806173076;969.3166317746113;14942.545970720392;15073.623159421102;15172.165530895907;15316.540503784905;15528.689426211187;33351.49972750362;33869.83065084659;34140.658593414744;34253.828730856185;35482.29035419329;47588;49537.75231123821;49575;49599.50400496093;49742.25386619276;7792.493487923267;7836.882446763189;7892.644830982505;7912.0901096374655;8043.436959413019;10652;10844.566217351217;11441.084713223088;11446.42767861587;11807.291562506278;5962.761489540369;9232.169104780602;10348.689539313833;10572.84140737874;10574.206934480098;9802.705918822447;10106.696799096038;10114.6459873907;10148.54331555067;10469.738256543647;10157.187425005834;10355.94822025885;10430.739231519272;10558.736031599272;10645.787084258427;7392.44556658242;7602.581857997642;7806.648700808364;7841.019872515935;8039.196080391914;9867.40795552269;10201.846972295272;10270.794584108127;10376.429296388469;10444.529996150039 05:07:40 INFO - PROCESS | 7125 | |3;mootools.html;1444.393354790988;1444.8338441079275;1562.5546719185033;1723.1901006526928;1725.4651058171967;6969.372756451931;7611.314981651651;7712.383009359251;7837.098733645633;7858.214178582146;7755.1469338372735;7811.218878112186;7833.37333013359;7845.137034926153;7867.960660196705;2286.6912966749524;2299.8620082795087;2301.9884900575476;2303.9308820735323;2305.7002589663402;2259.367377134397;2268.421552504109;2306.8615883046987;2310.722713274409;2320.6983092197993;2267.3424706835;2310.9075636974585;2321.2688003279;2322.6516022596575;2328.860268383894;2218.7226596675414;2244.0350649220827;2255.751867294596;2255.7631448697816;2258.9322320330334;2246.595612789697;2264.2641141628874;2267.3424706835;2268.65970104484;2277.567262220173;7956.2441568050945;7979.321757650607;8007.1992800720045;8014.719484818003;8024.43828931975;4723.598494128003;4878.365812444359;4899.534544218293;4908.828191013333;4915.262710593403;2849.487092323381;2898.521743912252;2966.3622321201046;3001.294695746498;3016.909492715222;969.5152423788106;977.7702239973601;991.7966816802539;1008.2589296866797;1013.3869009249445;10819.242653014293;10955.945220273848;11001.0099091083;11011;11024.834627480594;4333.609975102256;4337.240982827992;4563.133004729091;4568.862934111982;4604;9184.494852783027;9262.351635385457;9266.768330791785;9267.25861931044;9269.026752190923;4891.877703057452;4911.214205727067;4914.213725803926;4919.2375181846155;4951.861071953399;3911.6283953024417;4136.627703506699;4245.511766146871;4518.412606361152;4538.704984176018;3694.685951694082;3727.5713292971654;3772.132409545765;3814.5231846019246;3816.713746469026;1236.771197328497;1280.430208557183;1286.620446968128;1290.748304080714;1291.819145319656;682.6450245872218;781.6795114003231;802.0575823407473;804.4368941740805;809.4253080313043;5242.816501422432;5260.579153667697;5295.841124766186;5378.704171270618;5403.648762830403;427.6044658690699;437.6476936066433;439.2335374771045;441.4415764058469;443.17348145708024;3544.8404821783083;3590.730695197871;3631.291898079902;3634.3639863023864;3662.6520480554304;9683.41899486033;9924;9945.651902183388;10012.54943527543;10031.097201251923;9852.50737463124;9897.109260166619;9903.306768526278;9932.503374831229;9939.204863610894;7499.475036747484;7601.3918886490055;7621;7628.656710448043;7671.2712292332135;4984.00319936007;4996.625253105959;5007.89826238227;5096.184610462308;5367.141257398954;8786.297096232414;8828.602712878064;8833.072527384533;8855.690050848447;9007.864882026644;9005.594748236213;9040.954795226246;9259.35184537076;9314.813703726024;9405.106514881076;6696.430803381572;7123.287671232835;7287.380572651384;7330.6701198445135;7459.850802984019;7359.190489046307;7416;7433.851322973618;7461.477696561188;7463.402927765657;6602.1747281589805;6610.504212184202;6744.22441419243;6784.559003664746;6797.796066118024;6601.636909969806;6627.204735431779;6639.834004149741;6753.459723222032;6769.1876974763345;6285.371462853678;6292.244930608356;6353.428191462791;6355.269144048493;6394.616323020634;4311.374850646702;4420.049689316812;4453;4493.662975276802;4510.0528888933695;4624.28323609841;4654.325122857099;4677.812887484462;4712.340272361804;4740 05:07:40 INFO - PROCESS | 7125 | |4;prototype.html;309.7057795094661;317.16901717500144;318.3505648477107;319.61805642257497;324.4597744754983;5218.512723873697;5253.395859476162;5401.920905084104;5430.0768869292215;5448.6185966982275;5389.487998640133;5396.1905714142895;5399.352077750676;5413.918791218125;5427.918581221275;4164.750114993095;4191.434156388879;4199.664026877843;4200.831966721343;4203.558626344236;3860.6680695160267;4106.67146628269;4195.098053918407;4209.326507758759;4209.810558524874;4053.29067413203;4063.1873625274916;4067.4102255172984;4081.571434999327;4087.3255912774357;4061.6141466560775;4077.8368865245357;4080.06158583526;4083.183363327317;4088.6729061674996;3563.0914116900285;3563.964360356389;3575.2313252650806;3576.7317451191007;3589.3898037333715;5120.18077107661;5123.801059511393;5160.767765450564;5177.249298851683;5192.428832828386;4707.905841883143;4728.267118596623;4749.168895443284;4757.833475828329;4759.785809638574;5636.464535869086;5643.520300774439;5657.868426314712;5657.886842263131;5665.773369065274;3742.644448777362;3942.8028598570245;3944.5660977292473;3945.0926286953872;3948.6446219840354;5902.380250073767;5986.551008674367;5992.520598352121;5995.880082398327;5996.730147143346;4007.3788562772816;4007.6593489553134;4031.113155105872;4031.1333063390925;4033.798310084484;3867.400552914303;4086.0806318578084;4086.4891888513935;4096.631303182728;4098.918021639551;4692.81228750853;4718.174319494075;4718.905621887543;4727.369057675097;4741.2888066789565;5352.732363381815;5686.886262274731;5699.487046165865;5704.8859022819315;5730.627509211888;1389.5483967710534;1425.4725751472022;1427.635952832042;1429.2353590828857;1431.9498817541337;929.4051806843626;942.3450701762209;958.075457183821;958.1041725986225;958.2286259561121;4839.201531747222;4840.394950631171;4844.612431005511;4854.5873600744335;4871.8294859679745;5691.77232910679;5726.942730572724;5743.827685169368;5753.108268218432;5759.827205183851;4705.576498115186;4822.204336284544;4832.8791780205775;4839.685420447659;4849.4908034656555;3086.90739277822;3111.439940810676;3112.618846582366;3118.5322201669933;3124.5938028056207;5281.709505977208;5309.8938021239355;5327.413984461706;5336.893262134813;5349.545288650431;5622.634528755618;5830.329512106077;5879.147523609053;5893.823185304448;5894.174815525744;5306.734663266821;5317.867053323698;5353.491418315254;5355.384130825005;5372.973135134299;5527.668339899619;5684.914726279192;5749.367569567428;5751.511121554715;5763.913541296968;5619.775208991595;5655.4344565543115;5658.151277308437;5665.665765689168;5672.319321681424;5295.3116094908955;5325.121354976385;5358;5359.3032905722;5360;3792.6586607205486;3907.804609769557;3929.646331830149;3934.7048971327836;3935.960640393674;5606.411326810626;5717.914231286617;5823.970880145742;5886.411358864079;5890.4698577128265;5705.172749951151;5708.971455142698;5717.571182161438;5720.799772007959;5728.742206600797;5707.4577915098;5713.371529131875;5718.51392631631;5718.685472299064;5724.370319264961;5363.41002489718;5628.465295796893;5655.1517272409465;5664.631798933056;5671.6597004179885;5757.107648314518;5766.3368712598585;5770.105633626795;5779.913301300568;5788.160716696139;5501.174823776466;5583.609147359808;5587.022271102622;5587.681112338497;5594.888102238014 05:07:40 INFO - PROCESS | 7125 | |5;yui.html;693.5491930245344;720.6901032556001;749.9137599176096;753.0323534258479;782.6204290918903;11970.76058478831;11971.281723096621;11991.940040299787;12199.451024703887;12269.141160118796;12106.27362358259;12115;12115.454804533794;12121.696957576065;12157.939210303959;620.035844262171;760.6386966191043;783.4124406694979;784.3333166808225;784.9489783164076;777.3353782515952;777.9844403111935;780.1145699630903;780.7228433905967;785.6346798738614;816.4856140631424;820.1388542030874;820.819419727662;821.5563595658338;825.4015838517087;818.3862103422433;819.0130892274854;820.335528222142;822.6832669422256;823.3248736036483;596.8865915476089;598.5241732822417;599.5862854630335;602.8733965867173;605.9969700151471;12546.435410406553;12550.309732964775;12566.05754568411;12593.496260149583;12656.050796190231;12693.301868397235;12963.22220666763;13020.674483137902;13036.934815325958;13171.538996135088;9532.618695252182;9660.516974151264;9784.461854597994;9806.754831129207;9838;3300.2574420755377;3333.849976751052;3354.209952018656;3387.6442973487674;3412.9146771330666;44892;44973.32540011902;45243;45576.544234557565;46731.76634116842;8502.872456913152;8639.654413823502;8693.695720649746;8752.956235218911;8861.601227944759;16682.165891705365;16718.49844504667;16757;17065.82934170667;18241.361552345603;6695.899561506581;6794.218664853506;6811.284815094344;6827.590344579341;6984.685689144001;3688.3545379559005;3693.2059607184583;3723.497327860758;3750.512433383697;3797.031756901972;3096.4116817804547;3218.8229647369153;3230.499272612749;3238.7732858699665;3238.951415728766;539.1831375466094;559.4768891086846;561.6461629173594;562;562.8817948230835;440.5132328776656;459.6920063557425;533.9641096273217;588.6615196262081;589.1692713274263;6760.715464061813;7338.889916651255;7423.62881855905;7504;7956.443048986631;450.988725281864;470.10210497948754;517.8627663669131;529.3330403691376;575.7150210645674;3219.1791093271067;3533.5583052118486;3535.2399234164263;3560.3413368526903;3653.762505437138;44429.55570444319;45881.7705911475;46389;46742;48506.27240591394;40126;40652.59347406547;40691.7965410171;42012;42597.57402425936;40707.38938915919;40809.79595102065;41270.38094428586;42062.57937420648;43017.354739679555;7444.441666874898;7859.331956783737;7921.167897794034;8104.189581041848;8278.793030174294;25381.238562843144;25481.61777573375;25665.358366040997;28383.574246385906;28635.42729145447;33751;33893.66106338905;36048.639513604525;36391.818040909624;36732.26535469222;10189;10197.745056373353;10211.744706382102;10303.536340864828;10434.739131521772;11055.170862185529;11057.889421106007;11072.723181920517;11072.778544429228;11097.112231021338;10449.216308777024;10546.419946902994;10576.259661823598;10600.643368622372;11152.107831373309;10742.516586753458;10781.191410644076;10827.187960903122;10837.187210959051;11120.721981950515;9242.399244049115;9376.57805398745;9927.751806204902;9949.253805964438;9969.601215951281;8347.58262086881;8516.446430981967;8773.780655483664;8937.419067760575;9138.268938484773;8671;8671.132886711279;8747.16901894319;8755.168259015383;9012.54937253148 05:07:40 INFO - PROCESS | 7125 | __end_tp_report 05:07:40 INFO - PROCESS | 7125 | __start_cc_report 05:07:40 INFO - PROCESS | 7125 | _x_x_mozilla_cycle_collect,371 05:07:40 INFO - PROCESS | 7125 | __end_cc_report 05:07:40 INFO - PROCESS | 7125 | __startTimestamp1461586060863__endTimestamp 05:07:40 INFO - PROCESS | 7125 | 05:07:40 INFO - PROCESS | 7125 | ------- Summary: start ------- 05:07:40 INFO - PROCESS | 7125 | Number of tests: 6 05:07:40 INFO - PROCESS | 7125 | 05:07:40 INFO - PROCESS | 7125 | [#0] dojo.html Cycles:165 Average:4759.18 Median:4868.17 stddev:510.34 (10.5%) stddev-sans-first:483.05 05:07:40 INFO - PROCESS | 7125 | Values: 2602.3 2683.2 2717.8 2720.7 2729.9 4679.3 4747.3 4756.2 4757.6 4762.9 4686.9 4767.9 4844.2 4889.7 4895.4 4456.4 4486.6 4541.8 4542.1 4592.3 4468.3 4536.1 4561.5 4586.5 4590.1 4315.4 4320.7 4388.6 4465.8 4522.5 4348.1 4374.0 4388.9 4391.3 4432.2 4364.8 4366.2 4372.5 4378.0 4404.5 4655.9 4711.5 4728.9 4751.3 4760.2 5136.8 5146.9 5157.5 5160.7 5179.7 5080.8 5155.2 5164.8 5172.3 5181.0 4786.5 4831.7 4836.2 4864.2 4870.9 5293.6 5310.7 5314.4 5340.5 5373.4 4932.5 5064.0 5097.6 5099.2 5104.3 5186.7 5202.1 5204.3 5232.7 5284.2 4847.1 5065.6 5158.7 5191.6 5197.9 5002.6 5100.9 5115.7 5119.6 5121.4 4268.8 4289.4 4290.8 4300.3 4338.5 3750.2 3756.5 3762.0 3779.9 3794.9 4356.2 4404.2 4405.6 4440.3 4465.1 5150.4 5179.2 5183.3 5191.4 5207.7 4394.7 4439.3 4444.8 4455.5 4476.3 4495.0 4549.1 4586.8 4607.6 4645.7 4796.5 4805.9 4821.7 4844.7 4847.9 5116.1 5135.0 5140.5 5146.6 5149.3 4767.6 4805.0 4847.4 4863.4 4920.2 5154.5 5165.8 5178.1 5183.9 5186.1 5265.1 5266.9 5271.3 5273.7 5314.0 4923.4 4971.8 5045.6 5089.8 5131.4 4868.2 4931.9 4944.1 4948.5 4988.5 4923.7 4945.1 4978.3 4986.8 5030.1 4955.2 5071.7 5090.6 5114.5 5127.4 4947.6 4955.9 4956.5 4962.4 4969.4 05:07:40 INFO - PROCESS | 7125 | 05:07:40 INFO - PROCESS | 7125 | [#1] ext.html Cycles:180 Average:45969.92 Median:34760.80 stddev:80461.48 (231.5%) stddev-sans-first:80614.99 05:07:40 INFO - PROCESS | 7125 | Values: 570.2 587.1 597.7 608.6 632.8 33667.7 34478.5 34649.0 34740.1 34781.5 35483.8 35533.3 35845.8 35852.3 36196.5 7418.2 7588.3 7589.4 7589.8 7613.0 7545.5 7561.6 7635.2 7635.5 7660.7 7675.7 7716.5 7717.8 7759.3 7763.7 7631.5 7658.8 7686.5 7691.4 7745.5 7671.1 7715.7 7748.5 7769.1 7790.9 29839.0 35504.3 35859.0 36021.3 36056.6 2746.7 2829.2 2894.2 3278.9 3600.5 25801.6 26409.3 26706.0 26865.5 27047.0 3371.5 3380.1 3433.9 3549.7 3571.5 244828.0 248941.0 248954.0 249520.0 250398.7 57665.7 57907.0 58163.4 58253.4 58298.1 61108.7 62443.7 62733.0 63011.4 63034.4 13843.4 14007.5 14039.4 14052.9 14056.4 10540.4 10587.0 10601.8 10615.9 10669.5 18470.3 18550.3 18628.9 19410.2 19560.0 7296.4 7299.7 7479.3 7556.7 7614.2 905.7 920.9 1000.5 1003.4 1078.8 27703.3 28017.4 28022.5 28642.9 28680.6 974.0 989.6 1013.1 1079.3 1111.9 13123.1 13587.0 13806.3 13818.1 13920.4 341004.0 343311.0 346678.0 346971.0 347063.0 48329.3 49289.8 49329.3 49402.3 49408.3 1184.3 1223.8 1251.3 1265.3 1274.6 25668.9 26112.5 26156.2 26297.2 26449.6 40369.4 41200.4 41217.2 41249.8 41253.4 314535.0 316681.0 317073.0 317241.0 320101.0 25346.9 38689.6 39717.4 39862.4 40499.0 35979.3 37109.8 37358.0 37372.6 37970.8 31846.0 31862.2 31866.5 32758.7 35218.5 34031.5 34628.7 34720.5 35019.6 35115.5 34787.0 35136.3 35262.1 38349.0 40287.0 30008.7 31551.0 31893.8 31966.0 32141.2 24268.0 24542.3 24598.0 25053.4 25067.7 05:07:40 INFO - PROCESS | 7125 | 05:07:40 INFO - PROCESS | 7125 | [#2] jquery.html Cycles:180 Average:22409.05 Median:26096.93 stddev:55459.45 (212.5%) stddev-sans-first:55590.34 05:07:40 INFO - PROCESS | 7125 | Values: 371.1 373.6 381.9 384.2 390.0 14994.8 15540.9 15961.0 15961.8 16011.4 15377.8 16216.8 16846.9 16877.5 16884.9 5081.8 5184.2 5210.3 5240.2 5255.2 4917.8 5087.9 5124.5 5152.3 5160.9 5106.8 5121.2 5129.5 5139.6 5177.3 4906.6 5053.2 5065.7 5111.1 5133.2 4550.8 4566.3 4595.7 4599.4 4605.9 19330.9 19885.9 20328.0 20574.0 20710.1 1946.1 1953.7 2215.3 2225.4 2411.2 13172.2 13218.9 13352.7 13396.2 13673.9 1767.6 1795.7 1837.0 1862.1 1880.5 51698.0 60173.7 64445.7 66141.0 69540.7 9243.7 9433.3 9566.1 9687.2 9869.0 13276.5 13425.8 13443.5 13453.6 13473.9 6915.5 6950.5 7115.0 7273.3 7312.3 6763.9 6797.2 6858.9 6972.0 7013.3 5981.6 5990.8 6013.4 6075.4 6075.8 1757.9 1787.3 1794.8 1794.9 1822.1 866.8 869.0 887.1 901.4 903.6 16157.8 16363.2 16396.5 16678.0 16817.7 858.8 909.6 910.7 963.6 992.0 9452.4 9570.2 9609.6 9776.4 9943.2 308587.0 309616.0 311387.0 312293.0 414912.0 67851.0 73288.6 83666.0 83727.0 84326.6 849.0 925.5 951.7 957.5 969.3 14942.5 15073.6 15172.2 15316.5 15528.7 33351.5 33869.8 34140.7 34253.8 35482.3 47588.0 49537.8 49575.0 49599.5 49742.3 7792.5 7836.9 7892.6 7912.1 8043.4 10652.0 10844.6 11441.1 11446.4 11807.3 5962.8 9232.2 10348.7 10572.8 10574.2 9802.7 10106.7 10114.6 10148.5 10469.7 10157.2 10355.9 10430.7 10558.7 10645.8 7392.4 7602.6 7806.6 7841.0 8039.2 9867.4 10201.8 10270.8 10376.4 10444.5 05:07:40 INFO - PROCESS | 7125 | 05:07:40 INFO - PROCESS | 7125 | [#3] mootools.html Cycles:180 Average:5231.01 Median:4914.74 stddev:2932.09 (59.7%) stddev-sans-first:2926.50 05:07:40 INFO - PROCESS | 7125 | Values: 1444.4 1444.8 1562.6 1723.2 1725.5 6969.4 7611.3 7712.4 7837.1 7858.2 7755.1 7811.2 7833.4 7845.1 7868.0 2286.7 2299.9 2302.0 2303.9 2305.7 2259.4 2268.4 2306.9 2310.7 2320.7 2267.3 2310.9 2321.3 2322.7 2328.9 2218.7 2244.0 2255.8 2255.8 2258.9 2246.6 2264.3 2267.3 2268.7 2277.6 7956.2 7979.3 8007.2 8014.7 8024.4 4723.6 4878.4 4899.5 4908.8 4915.3 2849.5 2898.5 2966.4 3001.3 3016.9 969.5 977.8 991.8 1008.3 1013.4 10819.2 10955.9 11001.0 11011.0 11024.8 4333.6 4337.2 4563.1 4568.9 4604.0 9184.5 9262.4 9266.8 9267.3 9269.0 4891.9 4911.2 4914.2 4919.2 4951.9 3911.6 4136.6 4245.5 4518.4 4538.7 3694.7 3727.6 3772.1 3814.5 3816.7 1236.8 1280.4 1286.6 1290.7 1291.8 682.6 781.7 802.1 804.4 809.4 5242.8 5260.6 5295.8 5378.7 5403.6 427.6 437.6 439.2 441.4 443.2 3544.8 3590.7 3631.3 3634.4 3662.7 9683.4 9924.0 9945.7 10012.5 10031.1 9852.5 9897.1 9903.3 9932.5 9939.2 7499.5 7601.4 7621.0 7628.7 7671.3 4984.0 4996.6 5007.9 5096.2 5367.1 8786.3 8828.6 8833.1 8855.7 9007.9 9005.6 9041.0 9259.4 9314.8 9405.1 6696.4 7123.3 7287.4 7330.7 7459.9 7359.2 7416.0 7433.9 7461.5 7463.4 6602.2 6610.5 6744.2 6784.6 6797.8 6601.6 6627.2 6639.8 6753.5 6769.2 6285.4 6292.2 6353.4 6355.3 6394.6 4311.4 4420.0 4453.0 4493.7 4510.1 4624.3 4654.3 4677.8 4712.3 4740.0 05:07:40 INFO - PROCESS | 7125 | 05:07:40 INFO - PROCESS | 7125 | [#4] prototype.html Cycles:180 Average:4640.71 Median:5313.88 stddev:1371.30 (25.8%) stddev-sans-first:1336.06 05:07:40 INFO - PROCESS | 7125 | Values: 309.7 317.2 318.4 319.6 324.5 5218.5 5253.4 5401.9 5430.1 5448.6 5389.5 5396.2 5399.4 5413.9 5427.9 4164.8 4191.4 4199.7 4200.8 4203.6 3860.7 4106.7 4195.1 4209.3 4209.8 4053.3 4063.2 4067.4 4081.6 4087.3 4061.6 4077.8 4080.1 4083.2 4088.7 3563.1 3564.0 3575.2 3576.7 3589.4 5120.2 5123.8 5160.8 5177.2 5192.4 4707.9 4728.3 4749.2 4757.8 4759.8 5636.5 5643.5 5657.9 5657.9 5665.8 3742.6 3942.8 3944.6 3945.1 3948.6 5902.4 5986.6 5992.5 5995.9 5996.7 4007.4 4007.7 4031.1 4031.1 4033.8 3867.4 4086.1 4086.5 4096.6 4098.9 4692.8 4718.2 4718.9 4727.4 4741.3 5352.7 5686.9 5699.5 5704.9 5730.6 1389.5 1425.5 1427.6 1429.2 1431.9 929.4 942.3 958.1 958.1 958.2 4839.2 4840.4 4844.6 4854.6 4871.8 5691.8 5726.9 5743.8 5753.1 5759.8 4705.6 4822.2 4832.9 4839.7 4849.5 3086.9 3111.4 3112.6 3118.5 3124.6 5281.7 5309.9 5327.4 5336.9 5349.5 5622.6 5830.3 5879.1 5893.8 5894.2 5306.7 5317.9 5353.5 5355.4 5373.0 5527.7 5684.9 5749.4 5751.5 5763.9 5619.8 5655.4 5658.2 5665.7 5672.3 5295.3 5325.1 5358.0 5359.3 5360.0 3792.7 3907.8 3929.6 3934.7 3936.0 5606.4 5717.9 5824.0 5886.4 5890.5 5705.2 5709.0 5717.6 5720.8 5728.7 5707.5 5713.4 5718.5 5718.7 5724.4 5363.4 5628.5 5655.2 5664.6 5671.7 5757.1 5766.3 5770.1 5779.9 5788.2 5501.2 5583.6 5587.0 5587.7 5594.9 05:07:40 INFO - PROCESS | 7125 | 05:07:40 INFO - PROCESS | 7125 | [#5] yui.html Cycles:180 Average:12058.64 Median:45409.77 stddev:13360.64 (29.4%) stddev-sans-first:13370.86 05:07:40 INFO - PROCESS | 7125 | Values: 693.5 720.7 749.9 753.0 782.6 11970.8 11971.3 11991.9 12199.5 12269.1 12106.3 12115.0 12115.5 12121.7 12157.9 620.0 760.6 783.4 784.3 784.9 777.3 778.0 780.1 780.7 785.6 816.5 820.1 820.8 821.6 825.4 818.4 819.0 820.3 822.7 823.3 596.9 598.5 599.6 602.9 606.0 12546.4 12550.3 12566.1 12593.5 12656.1 12693.3 12963.2 13020.7 13036.9 13171.5 9532.6 9660.5 9784.5 9806.8 9838.0 3300.3 3333.8 3354.2 3387.6 3412.9 44892.0 44973.3 45243.0 45576.5 46731.8 8502.9 8639.7 8693.7 8753.0 8861.6 16682.2 16718.5 16757.0 17065.8 18241.4 6695.9 6794.2 6811.3 6827.6 6984.7 3688.4 3693.2 3723.5 3750.5 3797.0 3096.4 3218.8 3230.5 3238.8 3239.0 539.2 559.5 561.6 562.0 562.9 440.5 459.7 534.0 588.7 589.2 6760.7 7338.9 7423.6 7504.0 7956.4 451.0 470.1 517.9 529.3 575.7 3219.2 3533.6 3535.2 3560.3 3653.8 44429.6 45881.8 46389.0 46742.0 48506.3 40126.0 40652.6 40691.8 42012.0 42597.6 40707.4 40809.8 41270.4 42062.6 43017.4 7444.4 7859.3 7921.2 8104.2 8278.8 25381.2 25481.6 25665.4 28383.6 28635.4 33751.0 33893.7 36048.6 36391.8 36732.3 10189.0 10197.7 10211.7 10303.5 10434.7 11055.2 11057.9 11072.7 11072.8 11097.1 10449.2 10546.4 10576.3 10600.6 11152.1 10742.5 10781.2 10827.2 10837.2 11120.7 9242.4 9376.6 9927.8 9949.3 9969.6 8347.6 8516.4 8773.8 8937.4 9138.3 8671.0 8671.1 8747.2 8755.2 9012.5 05:07:40 INFO - PROCESS | 7125 | -------- Summary: end -------- 05:07:40 INFO - PROCESS | 7125 | 05:07:41 INFO - TEST-INFO | 7125: exit 0 05:07:41 INFO - TEST-OK | dromaeo_css | took 1115438ms 05:07:41 INFO - TEST-START | kraken 05:07:41 INFO - operating with platform_type : linux_ 05:07:41 INFO - Initialising browser for kraken test... 05:07:41 INFO - TEST-INFO | started process 7355 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQzcyCN/profile http://localhost:50007/getInfo.html) 05:07:45 INFO - PROCESS | 7355 | 05:07:45 INFO - PROCESS | 7355 | (process:7422): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:07:46 INFO - PROCESS | 7355 | __metrics Screen width/height:1600/1200 05:07:46 INFO - PROCESS | 7355 | colorDepth:24 05:07:46 INFO - PROCESS | 7355 | Browser inner width/height: 1024/697 05:07:46 INFO - PROCESS | 7355 | __metrics 05:07:47 ERROR - PROCESS | 7355 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:07:48 INFO - TEST-INFO | 7355: exit 0 05:07:48 INFO - Browser initialized. 05:07:48 INFO - Running cycle 1/1 for kraken test... 05:07:48 INFO - TEST-INFO | started process 7473 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQzcyCN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:07:50 INFO - PROCESS | 7473 | 05:07:50 INFO - PROCESS | 7473 | (process:7533): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:08:00 INFO - PROCESS | 7473 | RSS: Main: 164823040 05:08:00 INFO - PROCESS | 7473 | 05:08:02 INFO - PROCESS | 7473 | Cycle 1(1): loaded http://localhost:50007/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50007/tests/kraken/driver.html?testName=audio-beat-detection) 05:08:03 INFO - PROCESS | 7473 | RSS: Main: 169672704 05:08:03 INFO - PROCESS | 7473 | 05:08:06 INFO - PROCESS | 7473 | Cycle 1(1): loaded http://localhost:50007/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50007/tests/kraken/driver.html?testName=audio-dft) 05:08:07 INFO - PROCESS | 7473 | RSS: Main: 173142016 05:08:07 INFO - PROCESS | 7473 | 05:08:10 INFO - PROCESS | 7473 | Cycle 1(1): loaded http://localhost:50007/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50007/tests/kraken/driver.html?testName=audio-fft) 05:08:10 INFO - PROCESS | 7473 | RSS: Main: 165158912 05:08:10 INFO - PROCESS | 7473 | 05:08:12 INFO - PROCESS | 7473 | Cycle 1(1): loaded http://localhost:50007/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50007/tests/kraken/driver.html?testName=audio-oscillator) 05:08:13 INFO - PROCESS | 7473 | RSS: Main: 164806656 05:08:13 INFO - PROCESS | 7473 | 05:08:15 INFO - PROCESS | 7473 | Cycle 1(1): loaded http://localhost:50007/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50007/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:08:16 INFO - PROCESS | 7473 | RSS: Main: 165851136 05:08:16 INFO - PROCESS | 7473 | 05:08:19 INFO - PROCESS | 7473 | Cycle 1(1): loaded http://localhost:50007/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50007/tests/kraken/driver.html?testName=imaging-darkroom) 05:08:20 INFO - PROCESS | 7473 | RSS: Main: 165593088 05:08:20 INFO - PROCESS | 7473 | 05:08:23 INFO - PROCESS | 7473 | Cycle 1(1): loaded http://localhost:50007/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50007/tests/kraken/driver.html?testName=imaging-desaturate) 05:08:24 INFO - PROCESS | 7473 | RSS: Main: 165339136 05:08:24 INFO - PROCESS | 7473 | 05:08:27 INFO - PROCESS | 7473 | Cycle 1(1): loaded http://localhost:50007/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50007/tests/kraken/driver.html?testName=json-parse-financial) 05:08:27 INFO - PROCESS | 7473 | RSS: Main: 165691392 05:08:27 INFO - PROCESS | 7473 | 05:08:29 INFO - PROCESS | 7473 | Cycle 1(1): loaded http://localhost:50007/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50007/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:08:30 INFO - PROCESS | 7473 | RSS: Main: 165908480 05:08:30 INFO - PROCESS | 7473 | 05:08:32 INFO - PROCESS | 7473 | Cycle 1(1): loaded http://localhost:50007/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50007/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:08:32 INFO - PROCESS | 7473 | RSS: Main: 165982208 05:08:32 INFO - PROCESS | 7473 | 05:08:34 INFO - PROCESS | 7473 | Cycle 1(1): loaded http://localhost:50007/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50007/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:08:35 INFO - PROCESS | 7473 | RSS: Main: 167190528 05:08:35 INFO - PROCESS | 7473 | 05:08:38 INFO - PROCESS | 7473 | Cycle 1(1): loaded http://localhost:50007/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50007/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:08:39 INFO - PROCESS | 7473 | RSS: Main: 166723584 05:08:39 INFO - PROCESS | 7473 | 05:08:42 INFO - PROCESS | 7473 | Cycle 1(1): loaded http://localhost:50007/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50007/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:08:42 INFO - PROCESS | 7473 | RSS: Main: 166703104 05:08:42 INFO - PROCESS | 7473 | 05:08:44 INFO - PROCESS | 7473 | Cycle 1(1): loaded http://localhost:50007/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50007/tests/kraken/driver.html?testName=ai-astar) 05:08:44 INFO - PROCESS | 7473 | RSS: Main: 168226816 05:08:44 INFO - PROCESS | 7473 | 05:08:44 INFO - PROCESS | 7473 | __start_tp_report 05:08:44 INFO - PROCESS | 7473 | _x_x_mozilla_page_load 05:08:44 INFO - PROCESS | 7473 | _x_x_mozilla_page_load_details 05:08:44 INFO - PROCESS | 7473 | |i|pagename|runs| 05:08:44 INFO - PROCESS | 7473 | |0;ai-astar;114;107;112;115;115;128;114;114;112;113 05:08:44 INFO - PROCESS | 7473 | |1;audio-beat-detection;167;136;156;182;138;153;168;135;206;132 05:08:44 INFO - PROCESS | 7473 | |2;audio-dft;162;165;164;167;167;165;161;162;166;162 05:08:44 INFO - PROCESS | 7473 | |3;audio-fft;78;75;74;158;75;74;72;73;158;75 05:08:44 INFO - PROCESS | 7473 | |4;audio-oscillator;94;94;155;93;94;93;143;97;93;145 05:08:44 INFO - PROCESS | 7473 | |5;imaging-gaussian-blur;117;117;118;117;117;117;118;117;118;118 05:08:44 INFO - PROCESS | 7473 | |6;imaging-darkroom;148;148;147;147;146;148;147;149;147;149 05:08:44 INFO - PROCESS | 7473 | |7;imaging-desaturate;96;95;96;95;95;95;97;96;96;96 05:08:44 INFO - PROCESS | 7473 | |8;json-parse-financial;66;66;65;65;69;66;66;83;63;64 05:08:44 INFO - PROCESS | 7473 | |9;json-stringify-tinderbox;65;66;66;65;65;64;64;65;65;65 05:08:44 INFO - PROCESS | 7473 | |10;stanford-crypto-aes;80;80;81;79;89;89;81;82;89;80 05:08:44 INFO - PROCESS | 7473 | |11;stanford-crypto-ccm;135;135;144;142;131;145;134;143;167;139 05:08:44 INFO - PROCESS | 7473 | |12;stanford-crypto-pbkdf2;180;181;182;184;180;184;180;178;179;174 05:08:44 INFO - PROCESS | 7473 | |13;stanford-crypto-sha256-iterative;73;72;72;72;72;75;74;74;71;73 05:08:44 INFO - PROCESS | 7473 | __end_tp_report 05:08:44 INFO - PROCESS | 7473 | __start_cc_report 05:08:44 INFO - PROCESS | 7473 | _x_x_mozilla_cycle_collect,910 05:08:44 INFO - PROCESS | 7473 | __end_cc_report 05:08:44 INFO - PROCESS | 7473 | __startTimestamp1461586124832__endTimestamp 05:08:44 INFO - PROCESS | 7473 | 05:08:44 INFO - PROCESS | 7473 | ------- Summary: start ------- 05:08:44 INFO - PROCESS | 7473 | Number of tests: 14 05:08:44 INFO - PROCESS | 7473 | 05:08:44 INFO - PROCESS | 7473 | [#0] ai-astar Cycles:10 Average:114.40 Median:114.00 stddev:5.32 (4.7%) stddev-sans-first:5.64 05:08:44 INFO - PROCESS | 7473 | Values: 114.0 107.0 112.0 115.0 115.0 128.0 114.0 114.0 112.0 113.0 05:08:44 INFO - PROCESS | 7473 | 05:08:44 INFO - PROCESS | 7473 | [#1] audio-beat-detection Cycles:10 Average:157.30 Median:161.50 stddev:23.98 (14.8%) stddev-sans-first:25.17 05:08:44 INFO - PROCESS | 7473 | Values: 167.0 136.0 156.0 182.0 138.0 153.0 168.0 135.0 206.0 132.0 05:08:44 INFO - PROCESS | 7473 | 05:08:44 INFO - PROCESS | 7473 | [#2] audio-dft Cycles:10 Average:164.10 Median:165.00 stddev:2.23 (1.4%) stddev-sans-first:2.24 05:08:44 INFO - PROCESS | 7473 | Values: 162.0 165.0 164.0 167.0 167.0 165.0 161.0 162.0 166.0 162.0 05:08:44 INFO - PROCESS | 7473 | 05:08:44 INFO - PROCESS | 7473 | [#3] audio-fft Cycles:10 Average:91.20 Median:74.50 stddev:35.24 (47.3%) stddev-sans-first:37.05 05:08:44 INFO - PROCESS | 7473 | Values: 78.0 75.0 74.0 158.0 75.0 74.0 72.0 73.0 158.0 75.0 05:08:44 INFO - PROCESS | 7473 | 05:08:44 INFO - PROCESS | 7473 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:93.50 stddev:26.13 (27.9%) stddev-sans-first:27.05 05:08:44 INFO - PROCESS | 7473 | Values: 94.0 94.0 155.0 93.0 94.0 93.0 143.0 97.0 93.0 145.0 05:08:44 INFO - PROCESS | 7473 | 05:08:44 INFO - PROCESS | 7473 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 05:08:44 INFO - PROCESS | 7473 | Values: 117.0 117.0 118.0 117.0 117.0 117.0 118.0 117.0 118.0 118.0 05:08:44 INFO - PROCESS | 7473 | 05:08:44 INFO - PROCESS | 7473 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 05:08:44 INFO - PROCESS | 7473 | Values: 148.0 148.0 147.0 147.0 146.0 148.0 147.0 149.0 147.0 149.0 05:08:44 INFO - PROCESS | 7473 | 05:08:44 INFO - PROCESS | 7473 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 05:08:44 INFO - PROCESS | 7473 | Values: 96.0 95.0 96.0 95.0 95.0 95.0 97.0 96.0 96.0 96.0 05:08:44 INFO - PROCESS | 7473 | 05:08:44 INFO - PROCESS | 7473 | [#8] json-parse-financial Cycles:10 Average:67.30 Median:66.00 stddev:5.74 (8.7%) stddev-sans-first:6.06 05:08:44 INFO - PROCESS | 7473 | Values: 66.0 66.0 65.0 65.0 69.0 66.0 66.0 83.0 63.0 64.0 05:08:44 INFO - PROCESS | 7473 | 05:08:44 INFO - PROCESS | 7473 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 05:08:44 INFO - PROCESS | 7473 | Values: 65.0 66.0 66.0 65.0 65.0 64.0 64.0 65.0 65.0 65.0 05:08:44 INFO - PROCESS | 7473 | 05:08:44 INFO - PROCESS | 7473 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:81.50 stddev:4.22 (5.2%) stddev-sans-first:4.33 05:08:44 INFO - PROCESS | 7473 | Values: 80.0 80.0 81.0 79.0 89.0 89.0 81.0 82.0 89.0 80.0 05:08:44 INFO - PROCESS | 7473 | 05:08:44 INFO - PROCESS | 7473 | [#11] stanford-crypto-ccm Cycles:10 Average:141.50 Median:142.50 stddev:10.16 (7.1%) stddev-sans-first:10.50 05:08:44 INFO - PROCESS | 7473 | Values: 135.0 135.0 144.0 142.0 131.0 145.0 134.0 143.0 167.0 139.0 05:08:44 INFO - PROCESS | 7473 | 05:08:44 INFO - PROCESS | 7473 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.20 Median:180.50 stddev:2.94 (1.6%) stddev-sans-first:3.11 05:08:44 INFO - PROCESS | 7473 | Values: 180.0 181.0 182.0 184.0 180.0 184.0 180.0 178.0 179.0 174.0 05:08:44 INFO - PROCESS | 7473 | 05:08:44 INFO - PROCESS | 7473 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.80 Median:73.00 stddev:1.23 (1.7%) stddev-sans-first:1.30 05:08:44 INFO - PROCESS | 7473 | Values: 73.0 72.0 72.0 72.0 72.0 75.0 74.0 74.0 71.0 73.0 05:08:44 INFO - PROCESS | 7473 | -------- Summary: end -------- 05:08:44 INFO - PROCESS | 7473 | 05:08:45 INFO - TEST-INFO | 7473: exit 0 05:08:45 INFO - TEST-OK | kraken | took 64257ms 05:08:45 INFO - SUITE-END | took 1179s 05:08:45 INFO - Completed test suite (00:19:39) 05:08:45 INFO - javascript benchmark 05:08:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2602.284371797756, 2683.221865658959, 2717.782577393809, 2720.6735191776966, 2729.877155528001, 4679.344891715158, 4747.335373047776, 4756.191447453933, 4757.64317676174, 4762.928341123245, 4686.9296960545535, 4767.856964291077, 4844.20070688336, 4889.731064791435, 4895.363602731649, 4456.376107344982, 4486.57377549134, 4541.795619197128, 4542.091581683677, 4592.311153326994, 4468.307412351074, 4536.092781443725, 4561.521040290771, 4586.4725556560925, 4590.081983603276, 4315.43899293093, 4320.65434765218, 4388.5830846069575, 4465.821367145294, 4522.525134860858, 4348.130373925196, 4373.978130109329, 4388.868333949987, 4391.3193455014525, 4432.15789000089, 4364.781760911942, 4366.170427618742, 4372.497162826252, 4377.9781101094295, 4404.471463424377, 4655.930161047587, 4711.458182309044, 4728.929066064012, 4751.287306903958, 4760.166970780099, 5136.794528218867, 5146.897062058775, 5157.4584668610005, 5160.741962901878, 5179.663321884103, 5080.8221712240265, 5155.175171972466, 5164.767585458663, 5172.27588137661, 5180.989707007135, 4786.497417771154, 4831.73425461596, 4836.177849765478, 4864.173090574611, 4870.9269360959615, 5293.550048245866, 5310.6813591184655, 5314.415414304423, 5340.546053585411, 5373.35519737634, 4932.53140951609, 5064.0, 5097.566706829887, 5099.158638824552, 5104.3109180260935, 5186.662866913639, 5202.063628546823, 5204.34945631796, 5232.712200828915, 5284.233786100994, 4847.103285892122, 5065.645404821627, 5158.664686795421, 5191.558717508979, 5197.870053248699, 5002.57478114357, 5100.948990510122, 5115.667481613683, 5119.59043276537, 5121.411037730634, 4268.786560671954, 4289.399484072233, 4290.785460726951, 4300.268954277781, 4338.522762496123, 3750.1749615084636, 3756.5492140942715, 3762.0030691866677, 3779.8866034019024, 3794.9241015180096, 4356.172327257811, 4404.207242696345, 4405.625521830681, 4440.289553671397, 4465.084657645175, 5150.381954165449, 5179.22311653255, 5183.2743415921805, 5191.428942816287, 5207.739613019409, 4394.670399720034, 4439.311906654474, 4444.82220711168, 4455.477496710784, 4476.26141686618, 4495.0, 4549.135664223787, 4586.816527338936, 4607.562281583244, 4645.72125672454, 4796.544328288807, 4805.927911081267, 4821.686590371684, 4844.733539655353, 4847.903041939212, 5116.1046816806165, 5134.9743251285, 5140.537351638371, 5146.639735218649, 5149.279100925798, 4767.642426818072, 4804.95195048045, 4847.3698419205275, 4863.440704319049, 4920.237363208708, 5154.5103215194495, 5165.793368265227, 5178.119719647744, 5183.870403239949, 5186.092433824141, 5265.052290587731, 5266.947330526646, 5271.288376069181, 5273.683578985273, 5313.990341835039, 4923.384576927884, 4971.776270067783, 5045.621578381562, 5089.847304580869, 5131.384233891957, 4868.172410690262, 4931.852044438672, 4944.085344211332, 4948.455669876239, 4988.501149885127, 4923.679960802537, 4945.085159245551, 4978.30303757467, 4986.800527978985, 5030.144875371123, 4955.157623204136, 5071.721055341992, 5090.618203634816, 5114.539691427789, 5127.3847138343635, 4947.554720075211, 4955.876103097451, 4956.479569645136, 4962.379702537183, 4969.35398398206], "value": 4726.105309325702, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.167555369161, 587.1369087441461, 597.7130977130977, 608.57095747498, 632.8417895526119, 33667.66332336676, 34478.48282275768, 34649.0, 34740.131496712595, 34781.47827782579, 35483.82258088712, 35533.2893342133, 35845.82077089617, 35852.282954340895, 36196.45705314422, 7418.1839997600355, 7588.317051465367, 7589.430792690543, 7589.772306830776, 7612.961935190317, 7545.54726716396, 7561.62191890406, 7635.198304178065, 7635.541867487968, 7660.731874384398, 7675.69297228113, 7716.498427602216, 7717.768466946, 7759.262870027366, 7763.728269510569, 7631.465797394185, 7658.770236892902, 7686.53880767153, 7691.384689224877, 7745.457817952745, 7671.079470463525, 7715.729949451798, 7748.457607967444, 7769.10655274645, 7790.883136752953, 29839.0, 35504.289914201574, 35859.0, 36021.27957440836, 36056.63943360585, 2746.6978632350424, 2829.1795379339965, 2894.2474956511246, 3278.9016329510155, 3600.531930848999, 25801.61297580538, 26409.3397665058, 26705.960113507146, 26865.462690746077, 27047.0, 3371.5279860819505, 3380.121168496184, 3433.918315730537, 3549.7337699672626, 3571.5178450909057, 244828.0, 248941.0, 248954.0, 249520.0, 250398.74800626063, 57665.71167144137, 57907.0, 58163.4183658158, 58253.417465825645, 58298.12552811711, 61108.69445652743, 62443.6877815608, 62733.0, 63011.36988630055, 63034.36965630377, 13843.377048032662, 14007.509737159151, 14039.438422462987, 14052.929735351463, 14056.367463464168, 10540.367577945348, 10587.0, 10601.787964240671, 10615.89384106149, 10669.46652667379, 18470.261189552268, 18550.257989680533, 18628.906855465906, 19410.2235910562, 19560.0, 7296.379807716297, 7299.744508942162, 7479.252074792477, 7556.65995030214, 7614.200508946592, 905.7463910105181, 920.8756817829508, 1000.5197505197546, 1003.4481035430484, 1078.8166011778017, 27703.30741731473, 28017.439651206863, 28022.458764768133, 28642.85678571594, 28680.569791453145, 974.0, 989.6140505202976, 1013.1337706261188, 1079.2822772855964, 1111.8776934537195, 13123.146995445266, 13587.0, 13806.309684515734, 13818.101823381448, 13920.37358318878, 341004.0, 343311.0, 346678.0, 346971.0, 347063.0, 48329.27506087411, 49289.75355123202, 49329.260061099114, 49402.258966115536, 49408.25887611689, 1184.2953442701578, 1223.7674841780033, 1251.2742609286593, 1265.3293754310414, 1274.5857596281246, 25668.871655641604, 26112.477750444505, 26156.215313540622, 26297.21108366752, 26449.60325595079, 40369.39445908255, 41200.38199426951, 41217.1756564873, 41249.79375103105, 41253.38119928144, 314535.0, 316681.0, 317073.0, 317241.0, 320101.0, 25346.873265633552, 38689.61310386973, 39717.404238937015, 39862.40206396965, 40499.0, 35979.28041439209, 37109.81445092757, 37358.0, 37372.62627373692, 37970.81014594909, 31846.0, 31862.203444914063, 31866.522002169524, 32758.672413275563, 35218.47172292366, 34031.48952765661, 34628.65371346254, 34720.479192811625, 35019.64980350164, 35115.473267901514, 34787.0, 35136.29727405489, 35262.11844703903, 38349.0, 40287.0, 30008.69991300059, 31551.0, 31893.8405307972, 31966.0, 32141.196470088435, 24268.0, 24542.263732088068, 24598.0, 25053.373665658506, 25067.74932250654], "value": 17392.69113059525, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.10378436076877, 373.5797228118367, 381.942708593711, 384.2487936084954, 390.040500369092, 14994.77507837382, 15540.922295388522, 15961.0, 15961.760573591406, 16011.439599614001, 15377.84622153778, 16216.75674864878, 16846.915765421185, 16877.493675189733, 16884.915575422136, 5081.847544573659, 5184.196449550326, 5210.348706411699, 5240.240165176047, 5255.185446255837, 4917.82787602434, 5087.872803179913, 5124.4875512448825, 5152.252923326116, 5160.896782064357, 5106.821261255856, 5121.180611102224, 5129.461406552315, 5139.640225184238, 5177.275181474596, 4906.607471402279, 5053.242013697938, 5065.721385323787, 5111.08000559899, 5133.1786914093755, 4550.795214215368, 4566.315052742082, 4595.678302518825, 4599.356090147382, 4605.861824145281, 19330.903345483322, 19885.900570497055, 20328.0, 20574.0, 20710.068046937922, 1946.13397038318, 1953.7167110769, 2215.2578886073184, 2225.4436390902274, 2411.1922505960524, 13172.209667419986, 13218.933905330508, 13352.666183345396, 13396.196228226338, 13673.863261367358, 1767.646470705864, 1795.6857549928711, 1837.0263760206979, 1862.087577087231, 1880.548668319607, 51698.0, 60173.6991315045, 64445.67777161084, 66141.0, 69540.65229673819, 9243.722688319362, 9433.339666223299, 9566.091221333962, 9687.225021998223, 9869.0, 13276.468941242436, 13425.798613020812, 13443.529476468277, 13453.596392108253, 13473.865261347457, 6915.51591388608, 6950.54821436605, 7114.964425177841, 7273.309035641606, 7312.305330993547, 6763.864722705518, 6797.150356205474, 6858.862822743517, 6972.0, 7013.26360732126, 5981.641101533922, 5990.7903223386975, 6013.368596297413, 6075.362086980892, 6075.756969721162, 1757.9296828126733, 1787.2672204396395, 1794.7666803315747, 1794.8564114870778, 1822.125379817695, 866.7789713623112, 868.9565521723888, 887.1040249348205, 901.4456109492614, 903.5798353765531, 16157.757633635505, 16363.181840907908, 16396.508104756875, 16678.0, 16817.747733784003, 858.7552547523926, 909.6406919266852, 910.6539514984264, 963.5519483440233, 991.9851202231972, 9452.385594936308, 9570.186534144537, 9609.567569459392, 9776.413415195111, 9943.15483183923, 308587.0, 309616.0, 311387.0, 312293.0, 414912.0, 67851.0, 73288.63355683294, 83666.0, 83727.0, 84326.57836710777, 848.9787755306044, 925.4909799610188, 951.6764300137986, 957.5403806173076, 969.3166317746113, 14942.545970720392, 15073.623159421102, 15172.165530895907, 15316.540503784905, 15528.689426211187, 33351.49972750362, 33869.83065084659, 34140.658593414744, 34253.828730856185, 35482.29035419329, 47588.0, 49537.75231123821, 49575.0, 49599.50400496093, 49742.25386619276, 7792.493487923267, 7836.882446763189, 7892.644830982505, 7912.0901096374655, 8043.436959413019, 10652.0, 10844.566217351217, 11441.084713223088, 11446.42767861587, 11807.291562506278, 5962.761489540369, 9232.169104780602, 10348.689539313833, 10572.84140737874, 10574.206934480098, 9802.705918822447, 10106.696799096038, 10114.6459873907, 10148.54331555067, 10469.738256543647, 10157.187425005834, 10355.94822025885, 10430.739231519272, 10558.736031599272, 10645.787084258427, 7392.44556658242, 7602.581857997642, 7806.648700808364, 7841.019872515935, 8039.196080391914, 9867.40795552269, 10201.846972295272, 10270.794584108127, 10376.429296388469, 10444.529996150039], "value": 8197.873062589008, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1444.393354790988, 1444.8338441079275, 1562.5546719185033, 1723.1901006526928, 1725.4651058171967, 6969.372756451931, 7611.314981651651, 7712.383009359251, 7837.098733645633, 7858.214178582146, 7755.1469338372735, 7811.218878112186, 7833.37333013359, 7845.137034926153, 7867.960660196705, 2286.6912966749524, 2299.8620082795087, 2301.9884900575476, 2303.9308820735323, 2305.7002589663402, 2259.367377134397, 2268.421552504109, 2306.8615883046987, 2310.722713274409, 2320.6983092197993, 2267.3424706835, 2310.9075636974585, 2321.2688003279, 2322.6516022596575, 2328.860268383894, 2218.7226596675414, 2244.0350649220827, 2255.751867294596, 2255.7631448697816, 2258.9322320330334, 2246.595612789697, 2264.2641141628874, 2267.3424706835, 2268.65970104484, 2277.567262220173, 7956.2441568050945, 7979.321757650607, 8007.1992800720045, 8014.719484818003, 8024.43828931975, 4723.598494128003, 4878.365812444359, 4899.534544218293, 4908.828191013333, 4915.262710593403, 2849.487092323381, 2898.521743912252, 2966.3622321201046, 3001.294695746498, 3016.909492715222, 969.5152423788106, 977.7702239973601, 991.7966816802539, 1008.2589296866797, 1013.3869009249445, 10819.242653014293, 10955.945220273848, 11001.0099091083, 11011.0, 11024.834627480594, 4333.609975102256, 4337.240982827992, 4563.133004729091, 4568.862934111982, 4604.0, 9184.494852783027, 9262.351635385457, 9266.768330791785, 9267.25861931044, 9269.026752190923, 4891.877703057452, 4911.214205727067, 4914.213725803926, 4919.2375181846155, 4951.861071953399, 3911.6283953024417, 4136.627703506699, 4245.511766146871, 4518.412606361152, 4538.704984176018, 3694.685951694082, 3727.5713292971654, 3772.132409545765, 3814.5231846019246, 3816.713746469026, 1236.771197328497, 1280.430208557183, 1286.620446968128, 1290.748304080714, 1291.819145319656, 682.6450245872218, 781.6795114003231, 802.0575823407473, 804.4368941740805, 809.4253080313043, 5242.816501422432, 5260.579153667697, 5295.841124766186, 5378.704171270618, 5403.648762830403, 427.6044658690699, 437.6476936066433, 439.2335374771045, 441.4415764058469, 443.17348145708024, 3544.8404821783083, 3590.730695197871, 3631.291898079902, 3634.3639863023864, 3662.6520480554304, 9683.41899486033, 9924.0, 9945.651902183388, 10012.54943527543, 10031.097201251923, 9852.50737463124, 9897.109260166619, 9903.306768526278, 9932.503374831229, 9939.204863610894, 7499.475036747484, 7601.3918886490055, 7621.0, 7628.656710448043, 7671.2712292332135, 4984.00319936007, 4996.625253105959, 5007.89826238227, 5096.184610462308, 5367.141257398954, 8786.297096232414, 8828.602712878064, 8833.072527384533, 8855.690050848447, 9007.864882026644, 9005.594748236213, 9040.954795226246, 9259.35184537076, 9314.813703726024, 9405.106514881076, 6696.430803381572, 7123.287671232835, 7287.380572651384, 7330.6701198445135, 7459.850802984019, 7359.190489046307, 7416.0, 7433.851322973618, 7461.477696561188, 7463.402927765657, 6602.1747281589805, 6610.504212184202, 6744.22441419243, 6784.559003664746, 6797.796066118024, 6601.636909969806, 6627.204735431779, 6639.834004149741, 6753.459723222032, 6769.1876974763345, 6285.371462853678, 6292.244930608356, 6353.428191462791, 6355.269144048493, 6394.616323020634, 4311.374850646702, 4420.049689316812, 4453.0, 4493.662975276802, 4510.0528888933695, 4624.28323609841, 4654.325122857099, 4677.812887484462, 4712.340272361804, 4740.0], "value": 4160.239793533414, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.7057795094661, 317.16901717500144, 318.3505648477107, 319.61805642257497, 324.4597744754983, 5218.512723873697, 5253.395859476162, 5401.920905084104, 5430.0768869292215, 5448.6185966982275, 5389.487998640133, 5396.1905714142895, 5399.352077750676, 5413.918791218125, 5427.918581221275, 4164.750114993095, 4191.434156388879, 4199.664026877843, 4200.831966721343, 4203.558626344236, 3860.6680695160267, 4106.67146628269, 4195.098053918407, 4209.326507758759, 4209.810558524874, 4053.29067413203, 4063.1873625274916, 4067.4102255172984, 4081.571434999327, 4087.3255912774357, 4061.6141466560775, 4077.8368865245357, 4080.06158583526, 4083.183363327317, 4088.6729061674996, 3563.0914116900285, 3563.964360356389, 3575.2313252650806, 3576.7317451191007, 3589.3898037333715, 5120.18077107661, 5123.801059511393, 5160.767765450564, 5177.249298851683, 5192.428832828386, 4707.905841883143, 4728.267118596623, 4749.168895443284, 4757.833475828329, 4759.785809638574, 5636.464535869086, 5643.520300774439, 5657.868426314712, 5657.886842263131, 5665.773369065274, 3742.644448777362, 3942.8028598570245, 3944.5660977292473, 3945.0926286953872, 3948.6446219840354, 5902.380250073767, 5986.551008674367, 5992.520598352121, 5995.880082398327, 5996.730147143346, 4007.3788562772816, 4007.6593489553134, 4031.113155105872, 4031.1333063390925, 4033.798310084484, 3867.400552914303, 4086.0806318578084, 4086.4891888513935, 4096.631303182728, 4098.918021639551, 4692.81228750853, 4718.174319494075, 4718.905621887543, 4727.369057675097, 4741.2888066789565, 5352.732363381815, 5686.886262274731, 5699.487046165865, 5704.8859022819315, 5730.627509211888, 1389.5483967710534, 1425.4725751472022, 1427.635952832042, 1429.2353590828857, 1431.9498817541337, 929.4051806843626, 942.3450701762209, 958.075457183821, 958.1041725986225, 958.2286259561121, 4839.201531747222, 4840.394950631171, 4844.612431005511, 4854.5873600744335, 4871.8294859679745, 5691.77232910679, 5726.942730572724, 5743.827685169368, 5753.108268218432, 5759.827205183851, 4705.576498115186, 4822.204336284544, 4832.8791780205775, 4839.685420447659, 4849.4908034656555, 3086.90739277822, 3111.439940810676, 3112.618846582366, 3118.5322201669933, 3124.5938028056207, 5281.709505977208, 5309.8938021239355, 5327.413984461706, 5336.893262134813, 5349.545288650431, 5622.634528755618, 5830.329512106077, 5879.147523609053, 5893.823185304448, 5894.174815525744, 5306.734663266821, 5317.867053323698, 5353.491418315254, 5355.384130825005, 5372.973135134299, 5527.668339899619, 5684.914726279192, 5749.367569567428, 5751.511121554715, 5763.913541296968, 5619.775208991595, 5655.4344565543115, 5658.151277308437, 5665.665765689168, 5672.319321681424, 5295.3116094908955, 5325.121354976385, 5358.0, 5359.3032905722, 5360.0, 3792.6586607205486, 3907.804609769557, 3929.646331830149, 3934.7048971327836, 3935.960640393674, 5606.411326810626, 5717.914231286617, 5823.970880145742, 5886.411358864079, 5890.4698577128265, 5705.172749951151, 5708.971455142698, 5717.571182161438, 5720.799772007959, 5728.742206600797, 5707.4577915098, 5713.371529131875, 5718.51392631631, 5718.685472299064, 5724.370319264961, 5363.41002489718, 5628.465295796893, 5655.1517272409465, 5664.631798933056, 5671.6597004179885, 5757.107648314518, 5766.3368712598585, 5770.105633626795, 5779.913301300568, 5788.160716696139, 5501.174823776466, 5583.609147359808, 5587.022271102622, 5587.681112338497, 5594.888102238014], "value": 4202.407302366241, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.5491930245344, 720.6901032556001, 749.9137599176096, 753.0323534258479, 782.6204290918903, 11970.76058478831, 11971.281723096621, 11991.940040299787, 12199.451024703887, 12269.141160118796, 12106.27362358259, 12115.0, 12115.454804533794, 12121.696957576065, 12157.939210303959, 620.035844262171, 760.6386966191043, 783.4124406694979, 784.3333166808225, 784.9489783164076, 777.3353782515952, 777.9844403111935, 780.1145699630903, 780.7228433905967, 785.6346798738614, 816.4856140631424, 820.1388542030874, 820.819419727662, 821.5563595658338, 825.4015838517087, 818.3862103422433, 819.0130892274854, 820.335528222142, 822.6832669422256, 823.3248736036483, 596.8865915476089, 598.5241732822417, 599.5862854630335, 602.8733965867173, 605.9969700151471, 12546.435410406553, 12550.309732964775, 12566.05754568411, 12593.496260149583, 12656.050796190231, 12693.301868397235, 12963.22220666763, 13020.674483137902, 13036.934815325958, 13171.538996135088, 9532.618695252182, 9660.516974151264, 9784.461854597994, 9806.754831129207, 9838.0, 3300.2574420755377, 3333.849976751052, 3354.209952018656, 3387.6442973487674, 3412.9146771330666, 44892.0, 44973.32540011902, 45243.0, 45576.544234557565, 46731.76634116842, 8502.872456913152, 8639.654413823502, 8693.695720649746, 8752.956235218911, 8861.601227944759, 16682.165891705365, 16718.49844504667, 16757.0, 17065.82934170667, 18241.361552345603, 6695.899561506581, 6794.218664853506, 6811.284815094344, 6827.590344579341, 6984.685689144001, 3688.3545379559005, 3693.2059607184583, 3723.497327860758, 3750.512433383697, 3797.031756901972, 3096.4116817804547, 3218.8229647369153, 3230.499272612749, 3238.7732858699665, 3238.951415728766, 539.1831375466094, 559.4768891086846, 561.6461629173594, 562.0, 562.8817948230835, 440.5132328776656, 459.6920063557425, 533.9641096273217, 588.6615196262081, 589.1692713274263, 6760.715464061813, 7338.889916651255, 7423.62881855905, 7504.0, 7956.443048986631, 450.988725281864, 470.10210497948754, 517.8627663669131, 529.3330403691376, 575.7150210645674, 3219.1791093271067, 3533.5583052118486, 3535.2399234164263, 3560.3413368526903, 3653.762505437138, 44429.55570444319, 45881.7705911475, 46389.0, 46742.0, 48506.27240591394, 40126.0, 40652.59347406547, 40691.7965410171, 42012.0, 42597.57402425936, 40707.38938915919, 40809.79595102065, 41270.38094428586, 42062.57937420648, 43017.354739679555, 7444.441666874898, 7859.331956783737, 7921.167897794034, 8104.189581041848, 8278.793030174294, 25381.238562843144, 25481.61777573375, 25665.358366040997, 28383.574246385906, 28635.42729145447, 33751.0, 33893.66106338905, 36048.639513604525, 36391.818040909624, 36732.26535469222, 10189.0, 10197.745056373353, 10211.744706382102, 10303.536340864828, 10434.739131521772, 11055.170862185529, 11057.889421106007, 11072.723181920517, 11072.778544429228, 11097.112231021338, 10449.216308777024, 10546.419946902994, 10576.259661823598, 10600.643368622372, 11152.107831373309, 10742.516586753458, 10781.191410644076, 10827.187960903122, 10837.187210959051, 11120.721981950515, 9242.399244049115, 9376.57805398745, 9927.751806204902, 9949.253805964438, 9969.601215951281, 8347.58262086881, 8516.446430981967, 8773.780655483664, 8937.419067760575, 9138.268938484773, 8671.0, 8671.132886711279, 8747.16901894319, 8755.168259015383, 9012.54937253148], "value": 5706.303437987419, "unit": "score"}], "name": "dromaeo_css", "value": 6376.729014215339, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 107.0, 112.0, 115.0, 115.0, 128.0, 114.0, 114.0, 112.0, 113.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 136.0, 156.0, 182.0, 138.0, 153.0, 168.0, 135.0, 206.0, 132.0], "value": 157.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 164.0, 167.0, 167.0, 165.0, 161.0, 162.0, 166.0, 162.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 74.0, 158.0, 75.0, 74.0, 72.0, 73.0, 158.0, 75.0], "value": 91.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 155.0, 93.0, 94.0, 93.0, 143.0, 97.0, 93.0, 145.0], "value": 110.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 147.0, 146.0, 148.0, 147.0, 149.0, 147.0, 149.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 97.0, 96.0, 96.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 65.0, 69.0, 66.0, 66.0, 83.0, 63.0, 64.0], "value": 67.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 65.0, 65.0, 64.0, 64.0, 65.0, 65.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 81.0, 79.0, 89.0, 89.0, 81.0, 82.0, 89.0, 80.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 135.0, 144.0, 142.0, 131.0, 145.0, 134.0, 143.0, 167.0, 139.0], "value": 141.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 181.0, 182.0, 184.0, 180.0, 184.0, 180.0, 178.0, 179.0, 174.0], "value": 180.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 72.0, 72.0, 72.0, 75.0, 74.0, 74.0, 71.0, 73.0], "value": 72.8, "unit": "score"}], "name": "kraken", "value": 1607.6000000000001, "alertThreshold": 2.0}]} 05:08:46 INFO - Return code: 0 05:08:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:08:46 ERROR - # TBPL SUCCESS # 05:08:46 INFO - Running post-action listener: _resource_record_post_action 05:08:46 INFO - Running post-run listener: _resource_record_post_run 05:08:47 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 530038784; Read time: 0; Write time: 539988 05:08:47 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 234409984; Read time: 0; Write time: 339552 05:08:47 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 295628800; Read time: 0; Write time: 200436 05:08:47 INFO - Running post-run listener: _upload_blobber_files 05:08:47 INFO - Blob upload gear active. 05:08:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:08:47 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 05:08:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:08:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:08:47 INFO - (blobuploader) - INFO - Open directory for files ... 05:08:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:08:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:08:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:08:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:08:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:08:48 INFO - (blobuploader) - INFO - Done attempting. 05:08:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:08:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:08:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:08:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:08:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:08:49 INFO - (blobuploader) - INFO - Done attempting. 05:08:49 INFO - (blobuploader) - INFO - Iteration through files over. 05:08:49 INFO - Return code: 0 05:08:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:08:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:08:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0bba7d7aaf1090a59e7677783ece007a2b8fc8d26ad572b4286ae0a8be9b89381a29731fe3cba96ff32ace154a03f8a86ed737aa721abda4813a961c9cd2f31f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/23575de3aba0f836960d50f4c884ecdd7ab76e8ed775f1a0bb72b9ab5ea7e05d858f7c96ee47af2e2a0bbaeb2a4b14ad57ac1f7c11ae11de8aacebc11cfa1c5c"} 05:08:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:08:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:08:49 INFO - Contents: 05:08:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0bba7d7aaf1090a59e7677783ece007a2b8fc8d26ad572b4286ae0a8be9b89381a29731fe3cba96ff32ace154a03f8a86ed737aa721abda4813a961c9cd2f31f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/23575de3aba0f836960d50f4c884ecdd7ab76e8ed775f1a0bb72b9ab5ea7e05d858f7c96ee47af2e2a0bbaeb2a4b14ad57ac1f7c11ae11de8aacebc11cfa1c5c"} 05:08:49 INFO - Running post-run listener: copy_logs_to_upload_dir 05:08:49 INFO - Copying logs to upload dir... 05:08:49 INFO - mkdir: /builds/slave/test/build/upload/logs 05:08:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.517636 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-04-25 05:08:48.687489) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 05:08:48.691315) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1461584307.689261-1327563180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0bba7d7aaf1090a59e7677783ece007a2b8fc8d26ad572b4286ae0a8be9b89381a29731fe3cba96ff32ace154a03f8a86ed737aa721abda4813a961c9cd2f31f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/23575de3aba0f836960d50f4c884ecdd7ab76e8ed775f1a0bb72b9ab5ea7e05d858f7c96ee47af2e2a0bbaeb2a4b14ad57ac1f7c11ae11de8aacebc11cfa1c5c"} build_url:https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011353 build_url: 'https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0bba7d7aaf1090a59e7677783ece007a2b8fc8d26ad572b4286ae0a8be9b89381a29731fe3cba96ff32ace154a03f8a86ed737aa721abda4813a961c9cd2f31f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/23575de3aba0f836960d50f4c884ecdd7ab76e8ed775f1a0bb72b9ab5ea7e05d858f7c96ee47af2e2a0bbaeb2a4b14ad57ac1f7c11ae11de8aacebc11cfa1c5c"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 05:08:48.738589) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:08:48.739112) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1461584307.689261-1327563180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004444 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:08:48.820117) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 05:08:48.820630) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 05:08:48.821147) ========= ========= Total master_lag: 0.53 =========