builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-036 starttime: 1461584885.74 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.741974) ========= 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.742474) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 04:48:05.747064) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 04:48:05.826738) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:48:05.827038) ========= 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=14ef55db36f7623abb31b9cf000001d5-1461584624.908616-1104941731 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% 221M=0s 2016-04-25 04:48:06 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.180590 ========= master_lag: 0.18 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:48:06.188527) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:48:06.188871) ========= 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=14ef55db36f7623abb31b9cf000001d5-1461584624.908616-1104941731 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013829 ========= master_lag: 0.13 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:48:06.330609) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:48:06.331031) ========= 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=14ef55db36f7623abb31b9cf000001d5-1461584624.908616-1104941731 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-25 04:48:06,581 truncating revision to first 12 chars 2016-04-25 04:48:06,581 Setting DEBUG logging. 2016-04-25 04:48:06,581 attempt 1/10 2016-04-25 04:48:06,581 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:06,938 unpacking tar archive at: fx-team-80598be5d80e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.638292 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:48:07.010074) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 04:48:07.010573) ========= script_repo_revision: 80598be5d80e695727ff74e712faa623b02f3c70 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 04:48:07.011139) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 04:48:07.011449) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 04:48:07.032106) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-04-25 04:48:07.032436) ========= /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=14ef55db36f7623abb31b9cf000001d5-1461584624.908616-1104941731 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-036', 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:07 INFO - Running post-action listener: _resource_record_post_action 04:48:07 INFO - ##### 04:48:07 INFO - ##### Running read-buildbot-config 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: read_buildbot_config 04:48:07 INFO - Using buildbot properties: 04:48:07 INFO - { 04:48:07 INFO - "project": "", 04:48:07 INFO - "product": "firefox", 04:48:07 INFO - "script_repo_revision": "production", 04:48:07 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 04:48:07 INFO - "repository": "", 04:48:07 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 04:48:07 INFO - "buildid": "20160422035709", 04:48:07 INFO - "pgo_build": "False", 04:48:07 INFO - "basedir": "/builds/slave/test", 04:48:07 INFO - "buildnumber": 1203, 04:48:07 INFO - "slavename": "talos-linux64-ix-036", 04:48:07 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:48:07 INFO - "platform": "ubuntu64_hw", 04:48:07 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:48:07 INFO - "branch": "fx-team", 04:48:07 INFO - "repo_path": "integration/fx-team", 04:48:07 INFO - "revision": "80598be5d80e695727ff74e712faa623b02f3c70", 04:48:07 INFO - "stage_platform": "linux64", 04:48:07 INFO - "builduid": "3af33a9a7de54ba3986a82f34ab86caa", 04:48:07 INFO - "slavebuilddir": "test" 04:48:07 INFO - } 04:48:07 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:07 INFO - Running post-action listener: _resource_record_post_action 04:48:07 INFO - ##### 04:48:07 INFO - ##### Running download-and-extract 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: download_and_extract 04:48:07 INFO - mkdir: /builds/slave/test/build/tests 04:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:48:07 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:07 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:07 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:07 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:07 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:08 INFO - Downloaded 1361 bytes. 04:48:08 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:48:08 INFO - Using the following test package requirements: 04:48:08 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:48:08 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:48:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:48:08 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:48:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:48:08 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:48:08 INFO - u'jsshell-linux-x86_64.zip'], 04:48:08 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:48:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:48:08 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:48:08 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:48:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:48:08 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:48:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:48:08 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:48:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:48:08 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:48:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:48:08 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 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.common.tests.zip 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.common.tests.zip 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.common.tests.zip 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.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:48:08 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:09 INFO - Downloaded 22281373 bytes. 04:48:09 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:09 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:11 INFO - Return code: 0 04:48:11 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:11 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:11 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:11 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:11 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:11 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:11 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:15 INFO - Downloaded 22281373 bytes. 04:48:15 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:15 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:17 INFO - Return code: 0 04:48:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:48:17 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:17 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:17 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:17 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:17 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:18 INFO - Downloaded 10845952 bytes. 04:48:18 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:18 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: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.tar.bz2 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.tar.bz2 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.tar.bz2 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.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:48:18 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:21 INFO - Downloaded 54650321 bytes. 04:48:21 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:21 INFO - mkdir: /builds/slave/test/properties 04:48:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:48:21 INFO - Writing to file /builds/slave/test/properties/build_url 04:48:21 INFO - Contents: 04:48:21 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:22 INFO - Running post-action listener: _resource_record_post_action 04:48:22 INFO - Running post-action listener: set_extra_try_arguments 04:48:22 INFO - ##### 04:48:22 INFO - ##### Running populate-webroot step. 04:48:22 INFO - ##### 04:48:22 INFO - Running pre-action listener: _resource_record_pre_action 04:48:22 INFO - Running main action method: populate_webroot 04:48:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:48:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:48:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:48:22 INFO - '--tppagecycles', 04:48:22 INFO - '7'], 04:48:22 INFO - 'tests': ['tsvgm']}}, 04:48:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:48:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:48:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:48:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:48:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:48:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:48:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:48:22 INFO - 'talos_options': ['--disable-e10s'], 04:48:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:48:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:48:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:48:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:48:22 INFO - 'talos_options': ['--disable-e10s'], 04:48:22 INFO - 'tests': ['damp', 'tps']}, 04:48:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:48:22 INFO - 'tests': ['damp', 'tps']}, 04:48:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:48:22 INFO - 'tests': ['dromaeo_dom']}, 04:48:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:48:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:48:22 INFO - 'tests': ['a11yr', 04:48:22 INFO - 'ts_paint', 04:48:22 INFO - 'tpaint', 04:48:22 INFO - 'sessionrestore', 04:48:22 INFO - 'sessionrestore_no_auto_restore', 04:48:22 INFO - 'tabpaint']}, 04:48:22 INFO - 'other-e10s': {'tests': ['a11yr', 04:48:22 INFO - 'ts_paint', 04:48:22 INFO - 'tpaint', 04:48:22 INFO - 'sessionrestore', 04:48:22 INFO - 'sessionrestore_no_auto_restore', 04:48:22 INFO - 'tabpaint']}, 04:48:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:48:22 INFO - 'ts_paint', 04:48:22 INFO - 'tpaint', 04:48:22 INFO - 'sessionrestore', 04:48:22 INFO - 'sessionrestore_no_auto_restore', 04:48:22 INFO - 'tabpaint']}, 04:48:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:48:22 INFO - 'ts_paint', 04:48:22 INFO - 'tpaint', 04:48:22 INFO - 'sessionrestore', 04:48:22 INFO - 'sessionrestore_no_auto_restore', 04:48:22 INFO - 'tabpaint']}, 04:48:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:48:22 INFO - 'tests': ['a11yr', 04:48:22 INFO - 'ts_paint', 04:48:22 INFO - 'tpaint', 04:48:22 INFO - 'sessionrestore', 04:48:22 INFO - 'sessionrestore_no_auto_restore', 04:48:22 INFO - 'tabpaint']}, 04:48:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:48:22 INFO - 'tests': ['a11yr', 04:48:22 INFO - 'ts_paint', 04:48:22 INFO - 'tpaint', 04:48:22 INFO - 'sessionrestore', 04:48:22 INFO - 'sessionrestore_no_auto_restore', 04:48:22 INFO - 'tabpaint']}, 04:48:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:48:22 INFO - 'tests': ['tsvgx', 04:48:22 INFO - 'tsvgr_opacity', 04:48:22 INFO - 'tart', 04:48:22 INFO - 'tscrollx', 04:48:22 INFO - 'cart']}, 04:48:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:48:22 INFO - 'tsvgr_opacity', 04:48:22 INFO - 'tart', 04:48:22 INFO - 'tscrollx', 04:48:22 INFO - 'cart']}, 04:48:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:48:22 INFO - 'talos_options': ['--disable-e10s'], 04:48:22 INFO - 'tests': ['tp5o']}, 04:48:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:48:22 INFO - 'tests': ['tp5o']}, 04:48:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:48:22 INFO - 'talos_options': ['--disable-e10s', 04:48:22 INFO - '--xperf_path', 04:48:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:48:22 INFO - 'tests': ['tp5n']}, 04:48:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:48:22 INFO - 'talos_options': ['--xperf_path', 04:48:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:48:22 INFO - 'tests': ['tp5n']}}, 04:48:22 INFO - 'talos.zip': {'path': '', 04:48:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:48:22 INFO - Running post-action listener: _resource_record_post_action 04:48:22 INFO - ##### 04:48:22 INFO - ##### Running create-virtualenv step. 04:48:22 INFO - ##### 04:48:22 INFO - Running pre-action listener: _resource_record_pre_action 04:48:22 INFO - Running main action method: create_virtualenv 04:48:22 INFO - Creating virtualenv /builds/slave/test/build/venv 04:48:22 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:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:48:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:48:22 INFO - Using real prefix '/usr' 04:48:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:48:23 INFO - Installing distribute.............................................................................................................................................................................................done. 04:48:25 INFO - Installing pip.................done. 04:48:25 INFO - Return code: 0 04:48:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:48:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:48:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:48:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:48:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:48:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd5a8b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17f85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1887410>, '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 0x1888310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18887a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1461584624.908616-1104941731', '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:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:48:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:48:25 INFO - Using env: {'DISPLAY': ':0', 04:48:25 INFO - 'HOME': '/home/cltbld', 04:48:25 INFO - 'LANG': 'en_US.UTF-8', 04:48:25 INFO - 'LANGUAGE': 'en_US:en', 04:48:25 INFO - 'LOGNAME': 'cltbld', 04:48:25 INFO - 'MAIL': '/var/mail/cltbld', 04:48:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:25 INFO - 'MOZ_NO_REMOTE': '1', 04:48:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:48:25 INFO - 'NO_EM_RESTART': '1', 04:48:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:48:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:25 INFO - 'PWD': '/builds/slave/test', 04:48:25 INFO - 'SHELL': '/bin/bash', 04:48:25 INFO - 'SHLVL': '1', 04:48:25 INFO - 'TERM': 'linux', 04:48:25 INFO - 'TMOUT': '86400', 04:48:25 INFO - 'USER': 'cltbld', 04:48:25 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1461584624.908616-1104941731', 04:48:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:25 INFO - '_': '/tools/buildbot/bin/python'} 04:48:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:48:25 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:25 INFO - Cleaning up... 04:48:25 INFO - Return code: 0 04:48:25 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:48:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:48:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:48:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:48:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:48:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fdd5a8b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17f85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1887410>, '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 0x1888310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18887a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1461584624.908616-1104941731', '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:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:48:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:48:25 INFO - Using env: {'DISPLAY': ':0', 04:48:25 INFO - 'HOME': '/home/cltbld', 04:48:25 INFO - 'LANG': 'en_US.UTF-8', 04:48:25 INFO - 'LANGUAGE': 'en_US:en', 04:48:25 INFO - 'LOGNAME': 'cltbld', 04:48:25 INFO - 'MAIL': '/var/mail/cltbld', 04:48:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:25 INFO - 'MOZ_NO_REMOTE': '1', 04:48:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:48:25 INFO - 'NO_EM_RESTART': '1', 04:48:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:48:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:25 INFO - 'PWD': '/builds/slave/test', 04:48:25 INFO - 'SHELL': '/bin/bash', 04:48:25 INFO - 'SHLVL': '1', 04:48:25 INFO - 'TERM': 'linux', 04:48:25 INFO - 'TMOUT': '86400', 04:48:25 INFO - 'USER': 'cltbld', 04:48:25 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1461584624.908616-1104941731', 04:48:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:25 INFO - '_': '/tools/buildbot/bin/python'} 04:48:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:48:25 INFO - Downloading/unpacking psutil>=0.7.1 04:48:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:48:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:48:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:48:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:48:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:48:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:48:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:48:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:48:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:48:27 INFO - Installing collected packages: psutil 04:48:27 INFO - Running setup.py install for psutil 04:48:27 INFO - building 'psutil._psutil_linux' extension 04:48:27 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:27 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:27 INFO - building 'psutil._psutil_posix' extension 04:48:27 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:27 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:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:48:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:48:27 INFO - Successfully installed psutil 04:48:27 INFO - Cleaning up... 04:48:27 INFO - Return code: 0 04:48:27 INFO - Installing mozsystemmonitor==0.0.0 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', '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 0x7fdd5a8b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17f85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1887410>, '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 0x1888310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18887a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1461584624.908616-1104941731', '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', 'mozsystemmonitor==0.0.0'] 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 mozsystemmonitor==0.0.0 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': '14ef55db36f7623abb31b9cf000001d5-1461584624.908616-1104941731', 04:48:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:27 INFO - '_': '/tools/buildbot/bin/python'} 04:48:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:48:28 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:48:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:48:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:48:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:48:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:48:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:48:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:48:30 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:48:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:48:30 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:30 INFO - Installing collected packages: mozsystemmonitor 04:48:30 INFO - Running setup.py install for mozsystemmonitor 04:48:30 INFO - Successfully installed mozsystemmonitor 04:48:30 INFO - Cleaning up... 04:48:30 INFO - Return code: 0 04:48:30 INFO - Installing blobuploader==1.2.4 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', '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 0x7fdd5a8b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17f85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1887410>, '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 0x1888310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18887a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1461584624.908616-1104941731', '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', 'blobuploader==1.2.4'] 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 blobuploader==1.2.4 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': '14ef55db36f7623abb31b9cf000001d5-1461584624.908616-1104941731', 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 blobuploader==1.2.4 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 blobuploader-1.2.4.tar.gz 04:48:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:48:32 INFO - Downloading/unpacking requests==1.2.3. (from 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:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:48:32 INFO - Downloading/unpacking docopt==0.6.1 (from 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:33 INFO - Downloading docopt-0.6.1.tar.gz 04:48:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:48:33 INFO - Installing collected packages: blobuploader, requests, docopt 04:48:33 INFO - Running setup.py install for blobuploader 04:48:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:48:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:48:33 INFO - Running setup.py install for requests 04:48:33 INFO - Running setup.py install for docopt 04:48:33 INFO - Successfully installed blobuploader requests docopt 04:48:33 INFO - Cleaning up... 04:48:33 INFO - Return code: 0 04:48:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:48:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:48:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:48:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:48:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:33 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 0x7fdd5a8b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17f85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1887410>, '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 0x1888310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18887a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1461584624.908616-1104941731', '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:33 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:33 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:33 INFO - Using env: {'DISPLAY': ':0', 04:48:33 INFO - 'HOME': '/home/cltbld', 04:48:33 INFO - 'LANG': 'en_US.UTF-8', 04:48:33 INFO - 'LANGUAGE': 'en_US:en', 04:48:33 INFO - 'LOGNAME': 'cltbld', 04:48:33 INFO - 'MAIL': '/var/mail/cltbld', 04:48:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:33 INFO - 'MOZ_NO_REMOTE': '1', 04:48:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:48:33 INFO - 'NO_EM_RESTART': '1', 04:48:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:48:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:33 INFO - 'PWD': '/builds/slave/test', 04:48:33 INFO - 'SHELL': '/bin/bash', 04:48:33 INFO - 'SHLVL': '1', 04:48:33 INFO - 'TERM': 'linux', 04:48:33 INFO - 'TMOUT': '86400', 04:48:33 INFO - 'USER': 'cltbld', 04:48:33 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1461584624.908616-1104941731', 04:48:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:33 INFO - '_': '/tools/buildbot/bin/python'} 04:48:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:48:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:48:33 INFO - Running setup.py (path:/tmp/pip-dWIWa8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:48:34 INFO - Running setup.py (path:/tmp/pip-a0InI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:48:34 INFO - Running setup.py (path:/tmp/pip-RFvpiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:48:34 INFO - Running setup.py (path:/tmp/pip-eF_zyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:48:34 INFO - Running setup.py (path:/tmp/pip-UsOXcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:48:34 INFO - Running setup.py (path:/tmp/pip-0LXhin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:48:34 INFO - Running setup.py (path:/tmp/pip-jM2kI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:48:34 INFO - Running setup.py (path:/tmp/pip-aXvjXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:48:34 INFO - Running setup.py (path:/tmp/pip-Nh6fIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:48:34 INFO - Running setup.py (path:/tmp/pip-AaoYPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:48:34 INFO - Running setup.py (path:/tmp/pip-M1WFvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:48:34 INFO - Running setup.py (path:/tmp/pip-UKUmH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:48:34 INFO - Running setup.py (path:/tmp/pip-Hm_d1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:48:34 INFO - Running setup.py (path:/tmp/pip-qTFb8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:48:34 INFO - Running setup.py (path:/tmp/pip-cAmFeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:48:35 INFO - Running setup.py (path:/tmp/pip-mOW_jc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:48:35 INFO - Running setup.py (path:/tmp/pip-HTGjNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:48:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:48:35 INFO - Running setup.py install for manifestparser 04:48:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:48:35 INFO - Running setup.py install for mozcrash 04:48:35 INFO - Running setup.py install for mozdebug 04:48:35 INFO - Running setup.py install for mozdevice 04:48:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:48:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:48:35 INFO - Running setup.py install for mozfile 04:48:35 INFO - Running setup.py install for mozhttpd 04:48:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:48:35 INFO - Running setup.py install for mozinfo 04:48:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:48:35 INFO - Running setup.py install for mozInstall 04:48:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:48:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:48:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:48:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:48:35 INFO - Running setup.py install for mozleak 04:48:36 INFO - Running setup.py install for mozlog 04:48:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:48:36 INFO - Running setup.py install for moznetwork 04:48:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:48:36 INFO - Running setup.py install for mozprocess 04:48:36 INFO - Running setup.py install for mozprofile 04:48:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:48:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:48:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:48:36 INFO - Running setup.py install for mozrunner 04:48:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:48:36 INFO - Running setup.py install for mozscreenshot 04:48:36 INFO - Running setup.py install for moztest 04:48:36 INFO - Running setup.py install for mozversion 04:48:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:48:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:48:36 INFO - Cleaning up... 04:48:36 INFO - Return code: 0 04:48:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:48:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:48:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:48:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:48:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:36 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 0x7fdd5a8b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17f85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1887410>, '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 0x1888310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18887a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1461584624.908616-1104941731', '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:36 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:36 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:36 INFO - Using env: {'DISPLAY': ':0', 04:48:36 INFO - 'HOME': '/home/cltbld', 04:48:36 INFO - 'LANG': 'en_US.UTF-8', 04:48:36 INFO - 'LANGUAGE': 'en_US:en', 04:48:36 INFO - 'LOGNAME': 'cltbld', 04:48:36 INFO - 'MAIL': '/var/mail/cltbld', 04:48:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:36 INFO - 'MOZ_NO_REMOTE': '1', 04:48:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:48:36 INFO - 'NO_EM_RESTART': '1', 04:48:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:48:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:36 INFO - 'PWD': '/builds/slave/test', 04:48:36 INFO - 'SHELL': '/bin/bash', 04:48:36 INFO - 'SHLVL': '1', 04:48:36 INFO - 'TERM': 'linux', 04:48:36 INFO - 'TMOUT': '86400', 04:48:36 INFO - 'USER': 'cltbld', 04:48:36 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1461584624.908616-1104941731', 04:48:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:36 INFO - '_': '/tools/buildbot/bin/python'} 04:48:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:48:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:48:37 INFO - Running setup.py (path:/tmp/pip-pM3pjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:48:37 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:48:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:48:37 INFO - Running setup.py (path:/tmp/pip-0JMoIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:48:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:48:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:48:37 INFO - Running setup.py (path:/tmp/pip-NQkpBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:48:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:48:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:48:37 INFO - Running setup.py (path:/tmp/pip-96oQgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:48:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:48:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:48:37 INFO - Running setup.py (path:/tmp/pip-lRDfye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:48:37 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:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:48:37 INFO - Running setup.py (path:/tmp/pip-BfFUoW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:48:37 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:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:48:37 INFO - Running setup.py (path:/tmp/pip-1LqJqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:48:37 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:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:48:37 INFO - Running setup.py (path:/tmp/pip-wDBHfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:48:37 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:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:48:37 INFO - Running setup.py (path:/tmp/pip-KCZUp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:48:37 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:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:48:37 INFO - Running setup.py (path:/tmp/pip-wRy0AP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:48:37 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:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:48:37 INFO - Running setup.py (path:/tmp/pip-bFW47t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:48:37 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:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:48:37 INFO - Running setup.py (path:/tmp/pip-CcT0bM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:48:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:48:38 INFO - Running setup.py (path:/tmp/pip-1yzYzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:48:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:48:38 INFO - Running setup.py (path:/tmp/pip-b6J3K1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:48:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:48:38 INFO - Running setup.py (path:/tmp/pip-iFHfUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:48:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:48:38 INFO - Running setup.py (path:/tmp/pip-of9zbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:48:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:48:38 INFO - Running setup.py (path:/tmp/pip-8yYR2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:48:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:48:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:48:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:48:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:48:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:48:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:48:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:48:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:48:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:48:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:48:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:48:40 INFO - Downloading blessings-1.6.tar.gz 04:48:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:48:40 INFO - Installing collected packages: blessings 04:48:40 INFO - Running setup.py install for blessings 04:48:40 INFO - Successfully installed blessings 04:48:40 INFO - Cleaning up... 04:48:40 INFO - Return code: 0 04:48:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:48:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:48:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:48:40 INFO - Reading from file tmpfile_stdout 04:48:40 INFO - Current package versions: 04:48:40 INFO - argparse == 1.2.1 04:48:40 INFO - blessings == 1.6 04:48:40 INFO - blobuploader == 1.2.4 04:48:40 INFO - docopt == 0.6.1 04:48:40 INFO - manifestparser == 1.1 04:48:40 INFO - mozInstall == 1.12 04:48:40 INFO - mozcrash == 0.17 04:48:40 INFO - mozdebug == 0.1 04:48:40 INFO - mozdevice == 0.48 04:48:40 INFO - mozfile == 1.2 04:48:40 INFO - mozhttpd == 0.7 04:48:40 INFO - mozinfo == 0.9 04:48:40 INFO - mozleak == 0.1 04:48:40 INFO - mozlog == 3.1 04:48:40 INFO - moznetwork == 0.27 04:48:40 INFO - mozprocess == 0.22 04:48:40 INFO - mozprofile == 0.28 04:48:40 INFO - mozrunner == 6.11 04:48:40 INFO - mozscreenshot == 0.1 04:48:40 INFO - mozsystemmonitor == 0.0 04:48:40 INFO - moztest == 0.7 04:48:40 INFO - mozversion == 1.4 04:48:40 INFO - psutil == 3.1.1 04:48:40 INFO - requests == 1.2.3 04:48:40 INFO - wsgiref == 0.1.2 04:48:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:48:40 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:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:48:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:40 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:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:48:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:40 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 0x7fdd5a8b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17f85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1887410>, '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 0x1888310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18887a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1461584624.908616-1104941731', '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:40 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:40 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:40 INFO - Using env: {'DISPLAY': ':0', 04:48:40 INFO - 'HOME': '/home/cltbld', 04:48:40 INFO - 'LANG': 'en_US.UTF-8', 04:48:40 INFO - 'LANGUAGE': 'en_US:en', 04:48:40 INFO - 'LOGNAME': 'cltbld', 04:48:40 INFO - 'MAIL': '/var/mail/cltbld', 04:48:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:40 INFO - 'MOZ_NO_REMOTE': '1', 04:48:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:48:40 INFO - 'NO_EM_RESTART': '1', 04:48:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:48:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:40 INFO - 'PWD': '/builds/slave/test', 04:48:40 INFO - 'SHELL': '/bin/bash', 04:48:40 INFO - 'SHLVL': '1', 04:48:40 INFO - 'TERM': 'linux', 04:48:40 INFO - 'TMOUT': '86400', 04:48:40 INFO - 'USER': 'cltbld', 04:48:40 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1461584624.908616-1104941731', 04:48:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:40 INFO - '_': '/tools/buildbot/bin/python'} 04:48:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:48:40 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:40 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:40 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:40 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:40 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:40 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:40 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:40 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:40 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:40 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:40 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:40 INFO - Cleaning up... 04:48:40 INFO - Return code: 0 04:48:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:48:40 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:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:48:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:40 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:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:48:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:40 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 0x7fdd5a8b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17f85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1887410>, '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 0x1888310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18887a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1461584624.908616-1104941731', '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:40 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:40 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:40 INFO - Using env: {'DISPLAY': ':0', 04:48:40 INFO - 'HOME': '/home/cltbld', 04:48:40 INFO - 'LANG': 'en_US.UTF-8', 04:48:40 INFO - 'LANGUAGE': 'en_US:en', 04:48:40 INFO - 'LOGNAME': 'cltbld', 04:48:40 INFO - 'MAIL': '/var/mail/cltbld', 04:48:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:40 INFO - 'MOZ_NO_REMOTE': '1', 04:48:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:48:40 INFO - 'NO_EM_RESTART': '1', 04:48:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:48:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:40 INFO - 'PWD': '/builds/slave/test', 04:48:40 INFO - 'SHELL': '/bin/bash', 04:48:40 INFO - 'SHLVL': '1', 04:48:40 INFO - 'TERM': 'linux', 04:48:40 INFO - 'TMOUT': '86400', 04:48:40 INFO - 'USER': 'cltbld', 04:48:40 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1461584624.908616-1104941731', 04:48:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:40 INFO - '_': '/tools/buildbot/bin/python'} 04:48:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:48:41 INFO - Downloading/unpacking jsonschema 04:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:48:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:48:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:48:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:48:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:48:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:48:43 INFO - Downloading/unpacking functools32 (from 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:43 INFO - Downloading functools32-3.2.3-2.tar.gz 04:48:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:48:43 INFO - warning: no files found matching '*.txt' 04:48:43 INFO - no previously-included directories found matching 'build' 04:48:43 INFO - no previously-included directories found matching 'dist' 04:48:43 INFO - no previously-included directories found matching '.git*' 04:48:43 INFO - Installing collected packages: jsonschema, functools32 04:48:43 INFO - Running setup.py install for functools32 04:48:43 INFO - warning: no files found matching '*.txt' 04:48:43 INFO - no previously-included directories found matching 'build' 04:48:43 INFO - no previously-included directories found matching 'dist' 04:48:43 INFO - no previously-included directories found matching '.git*' 04:48:43 INFO - Successfully installed jsonschema functools32 04:48:43 INFO - Cleaning up... 04:48:43 INFO - Return code: 0 04:48:43 INFO - Installing flake8 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd5a8b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17f85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1887410>, '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 0x1888310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18887a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1461584624.908616-1104941731', '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', 'flake8'] 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 flake8 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': '14ef55db36f7623abb31b9cf000001d5-1461584624.908616-1104941731', 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 flake8 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 flake8-2.5.0-py2.py3-none-any.whl 04:48:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 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 mccabe-0.3.1-py2.py3-none-any.whl 04:48:45 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 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:46 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from 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:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:48:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:48:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:48:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:48:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:48:46 INFO - no previously-included directories found matching 'docs/_build' 04:48:46 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:48:46 INFO - Running setup.py install for pep8 04:48:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:48:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:48:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:48:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:48:46 INFO - no previously-included directories found matching 'docs/_build' 04:48:46 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:48:46 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:48:46 INFO - Cleaning up... 04:48:46 INFO - Return code: 0 04:48:46 INFO - Running post-action listener: _resource_record_post_action 04:48:46 INFO - Running post-action listener: _start_resource_monitoring 04:48:46 INFO - Starting resource monitoring. 04:48:46 INFO - ##### 04:48:46 INFO - ##### Running install step. 04:48:46 INFO - ##### 04:48:46 INFO - Running pre-action listener: _resource_record_pre_action 04:48:46 INFO - Running main action method: install 04:48:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:48:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:48:46 INFO - Reading from file tmpfile_stdout 04:48:46 INFO - Detecting whether we're running mozinstall >=1.0... 04:48:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:48:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:48:46 INFO - Reading from file tmpfile_stdout 04:48:46 INFO - Output received: 04:48:46 INFO - Usage: mozinstall [options] installer 04:48:46 INFO - Options: 04:48:46 INFO - -h, --help show this help message and exit 04:48:46 INFO - -d DEST, --destination=DEST 04:48:46 INFO - Directory to install application into. [default: 04:48:46 INFO - "/builds/slave/test"] 04:48:46 INFO - --app=APP Application being installed. [default: firefox] 04:48:46 INFO - mkdir: /builds/slave/test/build/application 04:48:46 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:46 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:02 INFO - Reading from file tmpfile_stdout 04:49:02 INFO - Output received: 04:49:02 INFO - /builds/slave/test/build/application/firefox/firefox 04:49:02 INFO - Running post-action listener: _resource_record_post_action 04:49:02 INFO - ##### 04:49:02 INFO - ##### Running run-tests step. 04:49:02 INFO - ##### 04:49:02 INFO - Running pre-action listener: _resource_record_pre_action 04:49:02 INFO - Running main action method: run_tests 04:49:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:49:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:49:02 INFO - Python 2.7.3 04:49:02 INFO - Return code: 0 04:49:02 INFO - grabbing minidump binary from tooltool 04:49:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:02 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 0x1887410>, '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 0x1888310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18887a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:49:02 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:02 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:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:49:02 INFO - Return code: 0 04:49:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:49:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:49:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:49:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:49:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:49:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:49:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:49:03 INFO - Return code: 0 04:49:03 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-036', '--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:03 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-036 --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:03 INFO - Using env: {'DISPLAY': ':0', 04:49:03 INFO - 'HOME': '/home/cltbld', 04:49:03 INFO - 'LANG': 'en_US.UTF-8', 04:49:03 INFO - 'LANGUAGE': 'en_US:en', 04:49:03 INFO - 'LOGNAME': 'cltbld', 04:49:03 INFO - 'MAIL': '/var/mail/cltbld', 04:49:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:49:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:49:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:03 INFO - 'MOZ_NO_REMOTE': '1', 04:49:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:49:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:03 INFO - 'NO_EM_RESTART': '1', 04:49:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:03 INFO - 'PWD': '/builds/slave/test', 04:49:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:49:03 INFO - 'SHELL': '/bin/bash', 04:49:03 INFO - 'SHLVL': '1', 04:49:03 INFO - 'TERM': 'linux', 04:49:03 INFO - 'TMOUT': '86400', 04:49:03 INFO - 'USER': 'cltbld', 04:49:03 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1461584624.908616-1104941731', 04:49:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:03 INFO - '_': '/tools/buildbot/bin/python'} 04:49:03 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-036', '--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:03 INFO - mozversion application_buildid: 20160422035709 04:49:03 INFO - mozversion application_changeset: 80598be5d80e695727ff74e712faa623b02f3c70 04:49:03 INFO - mozversion application_display_name: Nightly 04:49:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:49:03 INFO - mozversion application_name: Firefox 04:49:03 INFO - mozversion application_remotingname: firefox 04:49:03 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:49:03 INFO - mozversion application_vendor: Mozilla 04:49:03 INFO - mozversion application_version: 48.0a1 04:49:03 INFO - mozversion platform_buildid: 20160422035709 04:49:03 INFO - mozversion platform_changeset: 80598be5d80e695727ff74e712faa623b02f3c70 04:49:03 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:49:03 INFO - mozversion platform_version: 48.0a1 04:49:03 INFO - using testdate: 1461584943 04:49:03 INFO - actual date: 1461584943 04:49:03 INFO - starting webserver on 'localhost:53169' 04:49:03 INFO - SUITE-START | Running 2 tests 04:49:03 INFO - TEST-START | dromaeo_css 04:49:03 INFO - operating with platform_type : linux_ 04:49:03 INFO - Initialising browser for dromaeo_css test... 04:49:03 INFO - TEST-INFO | started process 19036 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpInilna/profile http://localhost:53169/getInfo.html) 04:49:08 INFO - PROCESS | 19036 | 04:49:08 INFO - PROCESS | 19036 | (process:19103): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:49:09 INFO - PROCESS | 19036 | __metrics Screen width/height:1600/1200 04:49:09 INFO - PROCESS | 19036 | colorDepth:24 04:49:09 INFO - PROCESS | 19036 | Browser inner width/height: 1024/697 04:49:09 INFO - PROCESS | 19036 | __metrics 04:49:10 ERROR - PROCESS | 19036 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 04:49:10 INFO - TEST-INFO | 19036: exit 0 04:49:10 INFO - Browser initialized. 04:49:10 INFO - Running cycle 1/1 for dromaeo_css test... 04:49:10 INFO - TEST-INFO | started process 19154 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpInilna/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:49:12 INFO - PROCESS | 19154 | 04:49:12 INFO - PROCESS | 19154 | (process:19215): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:49:22 INFO - PROCESS | 19154 | RSS: Main: 165236736 04:49:22 INFO - PROCESS | 19154 | 04:50:12 INFO - PROCESS | 19154 | 1461585012464 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:24 INFO - PROCESS | 19154 | Cycle 1(1): loaded http://localhost:53169/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53169/tests/dromaeo/cssquery-ext.html) 04:52:25 INFO - PROCESS | 19154 | RSS: Main: 169230336 04:52:25 INFO - PROCESS | 19154 | 04:55:27 INFO - PROCESS | 19154 | Cycle 1(1): loaded http://localhost:53169/tests/dromaeo/cssquery-ext.html (next: http://localhost:53169/tests/dromaeo/cssquery-jquery.html) 04:55:27 INFO - PROCESS | 19154 | RSS: Main: 165695488 04:55:27 INFO - PROCESS | 19154 | 04:58:29 INFO - PROCESS | 19154 | Cycle 1(1): loaded http://localhost:53169/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53169/tests/dromaeo/cssquery-mootools.html) 04:58:30 INFO - PROCESS | 19154 | RSS: Main: 166850560 04:58:30 INFO - PROCESS | 19154 | 05:01:32 INFO - PROCESS | 19154 | Cycle 1(1): loaded http://localhost:53169/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53169/tests/dromaeo/cssquery-prototype.html) 05:01:32 INFO - PROCESS | 19154 | RSS: Main: 164753408 05:01:32 INFO - PROCESS | 19154 | 05:04:35 INFO - PROCESS | 19154 | Cycle 1(1): loaded http://localhost:53169/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53169/tests/dromaeo/cssquery-yui.html) 05:04:36 INFO - PROCESS | 19154 | RSS: Main: 166023168 05:04:36 INFO - PROCESS | 19154 | 05:07:38 INFO - PROCESS | 19154 | Cycle 1(1): loaded http://localhost:53169/tests/dromaeo/cssquery-yui.html (next: http://localhost:53169/tests/dromaeo/cssquery-dojo.html) 05:07:38 INFO - PROCESS | 19154 | RSS: Main: 168034304 05:07:38 INFO - PROCESS | 19154 | 05:07:38 INFO - PROCESS | 19154 | __start_tp_report 05:07:38 INFO - PROCESS | 19154 | _x_x_mozilla_page_load 05:07:38 INFO - PROCESS | 19154 | _x_x_mozilla_page_load_details 05:07:38 INFO - PROCESS | 19154 | |i|pagename|runs| 05:07:38 INFO - PROCESS | 19154 | |0;dojo.html;2619.7380261973803;2667.573188289874;2683.8523881186534;2705.9458810823785;2716.022231996481;4661.0677864427125;4708.152532544141;4719.740414277213;4738.857834264978;4747.928781068283;4664.067186562684;4793.257045157998;4805.831795887145;4827.348307978422;4872.07430588188;4375.124975005004;4412.130127523382;4419.668524860632;4449.955500444987;4515.593596576307;534.3871422836944;4117.609528904237;4298.634616057639;4344.391785150082;4401.845935392262;4445.955540444586;4446.888827779299;4449.844255451044;4467.463904331468;4468.039371535119;4433.534478879736;4462.486814016397;4467.843625473125;4471.6199123074575;4490.8877278067985;4297.484301883763;4363.5418281080665;4402.449693788277;4439.64482841372;4440.467143942716;4699.906001879977;4719.764011799431;4757.643176761722;4770.284457331393;4776.379070720784;4963.950360496385;5176.482351764794;5196.870078248036;5197.090509160919;5243.449437809013;5127.6154288428515;5129.358830146231;5133.050385678662;5164.6384753067305;5169.017886601571;4696.990147118352;4728.6453515986095;4763.118823017753;4796.848756298463;4816.54242846929;5154.974225128851;5187.06632806091;5223.764930578133;5260.789568417221;5266.368035835648;5029.949700503022;5032.270320803463;5036.294918711384;5060.569851562658;5078.238264260391;5112.233165025276;5113.028524580318;5125.1287281162295;5139.563137133386;5164.354455693038;4985.002999400134;5054.696718196847;5069.9746501267255;5079.949200508022;5135.97432012845;5025.824096156617;5031.270465782441;5032.622553308516;5078.5175408336145;5122.334096567422;4289.378040184219;4290.806913688892;4307.65538756905;4319.805608747614;4330.848420305274;3648.908777280589;3756.8121593920196;3770;3836.0985168485386;3876.786776727307;4288.24955632763;4415.337699345059;4441.267190913463;4444.400005999213;4466.196084704719;5210.088234558937;5227.294315267466;5241.868953276198;5243.397009343898;5248.160294352885;4295.978520107379;4389.1660584488845;4437.334399839985;4465.59809617136;4508.346289787963;4611.216093264153;4614.238650622677;4629.51390104041;4668.836590719308;4677.906441871143;4768.642351823558;4846.39420072498;4858.684185528071;4879;4915.238138088602;5058.1654027085115;5132.409772876167;5189.532942035235;5201.323827902348;5201.895962080813;4834.274858771212;4841.031793641216;4859.95140048595;4862.173430516891;4910.459849416633;5093.0577843099145;5099.260607212008;5104.2088476286235;5120.25756265332;5156.535911767959;4954.851354459372;5029.597632189343;5128.410232823273;5189.481051894781;5238.895222095613;4908.754562271801;4915.1644220481885;4917.041176970456;4920.950790492049;4952.2819191217795;4902.975485122552;4918.188498897642;4921.384826896638;4927.482614325444;4970.676906001098;4704.411948506437;4871.318015477765;4880;4935;4949.9257511138085;5011.799528018839;5025.221090730943;5041.092603331289;5061.772220250171;5079.492050794891;4884.9741554274;4917.311576379238;4935.62982776286;4940.6788558743565;4987.675801072919 05:07:38 INFO - PROCESS | 19154 | |1;ext.html;582.1326223926349;590.0352922970942;603.6891001134413;616.4267231474729;625.1997443272606;34031;34742.30515389697;34851.47722784157;34885.476717849255;35095;35578.644213557855;36266;36382.8180859096;36466.45300320497;36504.63495365046;7552;7723.304902558769;7726.922730772704;7729.149793522708;7733.149353571102;7605.581693006882;7838.333741631968;7899.052113746358;7902.24928631779;7909.090454597737;7851.489653172525;7914.089879663855;7915.643796029164;7933.968584084061;7944.563049032301;7823.8826417603495;7849.5682737449415;7858.174891636381;7869.48848324857;7882.448228623999;7805.219478052206;7887.132415434297;7897.644605992744;7916;7943.24539168778;29822.25444363908;36479.4528082079;36738.44892326617;37068.25863482742;37111.81444092789;2705.3912869604183;2775.2506823157632;2819.703931087227;3030.030390275113;3263.3147039121577;25487.49025019508;25837.612435813477;25900.481990360087;26172.476550469073;26392.340191495176;3355.144438168276;3384.3569721752788;3419.9316013679586;3427.246005878703;3450.292689998544;174628;175016;175461;175547.99999999872;176424;47181.29228061582;47245.29132063022;47308.763456182496;47343;47461.288080678816;47371;51111;55549.722251388484;58174;58545.414545854845;13574.93212533931;13650.198665567093;13744.65638359029;13750.243736594583;13773.655658608415;10111.342762720547;10168.847467287997;10217.284790064772;10231.744206394751;10236.48817559119;17334.47996560105;17556.473305800846;17563.824361756473;17581.208845601977;17720.379786707403;6922.169339679271;7032.769265378538;7052.33002864727;7070.469714771412;7087;846.8221673448645;901.9143181397757;905.8822353094188;973.3478569358547;989.5125605379569;27217.183484495497;27543.449131017267;27787.58318625222;28292.575611365846;28520;972.154225823538;996.6611352140308;1035.3701597941144;1041.5677493840124;1054.7152268887357;14288.785668214985;14827.555173344817;14856.554303370916;14977.101373917381;15002.774958375632;340230;347966;348653;348715;348779;47816;48806.75596621994;49125.754371227915;49226.75386623044;49420.258696119585;1203.584763256675;1215.6924161152663;1218.9268643881396;1245.7321675839737;1248.300951467163;26717.198484045508;27549.12755805543;28035.71964280331;28254;28385;42732.14535709331;49743.25385119298;51993.48006519886;52493.637786300475;52641.7367913158;310220;314014;316856;316918;316998;37653;37790.62209377871;38082.42876356912;38190.42714359342;38348.42477362786;42004.36993445162;42504.57495425006;42518.362224567274;42859.7857010713;43147.784261078494;36411.27177456383;36437;36759.08102297464;37170;37180.25639487249;36095;36516.63483365239;36599.26801464009;36616.81691591525;36872.63127368692;34236.48645270273;34742.305153896275;34809.12977175591;35175.296494070484;35512.28975420529;32023.679763202068;32405;32421.675783241866;33200.1699957503;33661.663383365856;24384.878075609508;24410.87794561016;24475.877620611784;24508.6323705141;24989.250322490356 05:07:38 INFO - PROCESS | 19154 | |2;jquery.html;381.3821608993431;381.67748252726443;386.8471953578338;387.6375588824449;406.43302592882947;15538.689226215469;16757.748633770505;17341.826581734178;17362.652746945052;17399.652006959885;16097.436589719362;16508.339666413358;16696.415625453083;16846.32614695414;16882.746758798596;5040.470750571201;5178.974105129488;5230.058589453897;5236.188390799432;5236.92144617831;3722.3485889969284;5724.284464441945;6047.546434017467;6054.455099041085;6056.394360563952;5012.147934851084;5954.315253745832;5977.85055373617;5993.940060599403;6012.248468941382;4773.761311934407;4777.880552986168;4783.234682450791;4797.688150270239;4800.399950006249;4674.275487299474;4740;5439.945600544023;5441.401445840955;5481.862953426156;12214.694632634166;12399.566015189424;12580;12636.05229607783;12701.301428421433;1871.812818718131;2040.6326861164985;2055.290924631;2167.902444390006;2364.5861974154454;8608.870866937;9164.725058248263;9451.810963780754;9462.479563623998;9546.856797148048;1756.8858024228384;1807.8011418743927;1832.248778001013;1872.1762424533163;1894.1476335649013;66490.66754666244;68156;69798;70618.94071588879;71074;10075.899241007643;10121.898781012243;10301;10358.274920755626;10555.366677999345;14409.711805763825;14532.854671453362;14557.708845823025;14562.490312839212;14597;7006;7011.474139439562;7044.968840135752;7070.257622949619;7078.398336141486;6481.48148148147;6503.902441463287;6519.598286368454;6591.83520411984;6645.102911107036;4425.955740442619;4440.711353761995;4441.511433742286;4445.399871017371;4600.907981840412;1722.6468573942311;1838.8620853435777;1900.9239630414904;1903.3623736048578;1928.1419768203016;810.793247721839;877.1579283887412;891.6611687558686;908.6365453818394;958.0802429667597;15516.069035857885;16067.116308602905;16198.919005404898;16227.350905963629;16667.33330666784;873.1661263493348;873.4584557574344;889.675268526983;906.8413027720122;923.930705197113;9281.860772088425;9528.761780955532;9619.855702164474;9668.70993870185;9778.804423911482;395362;397931;422097;422247;424020;74831.62584187044;77594;77726.6113669428;77752.61123694346;78097.60951195208;936.3258453913172;948.2414068744977;977.0913050862624;993.2699465892563;996.0189213624574;14876.925615371854;14925.850741492446;14987.775183372476;15120.243987800786;15445.382184712485;34592.308153837286;34737;35551;35738.463923041694;35816.82091589525;47230;47458.76270618625;48439.75780121077;49698.254526181416;49716;7951.165127661744;8093.595320233847;8135.75592732219;11074;11343.376114313793;11664.94167529157;11997.580084696994;12148.574799882315;12603.18079324841;12838.614841554769;4927.679700819435;6499.6750162492635;10801.947629950284;10897;10981.505832237728;10710.839337409789;10860.67417977462;10892.509837057192;11445.542178312775;11602.593909213138;11020.44897755125;11054.889451105386;11065.889341106486;11070.501827417947;11325.773484530098;11922.701932451759;11940.701482463008;12058.939705301767;12095.092868035108;12168.939155304166;10997.505112269808;10998.945005274922;11032.338059716443;11365.602203922823;11638.35989020612 05:07:38 INFO - PROCESS | 19154 | |3;mootools.html;1413.258039529247;1457.9271036448179;1591.156686955913;1758.1912320332647;1797.6224992751513;7049;7675.15573286938;7714;7953.920460795391;7964.283214510693;7826.882596761039;7858.410619203554;7917.168697286774;7923.484973476734;7928.484648497858;2284.6230371988604;2290.198430549303;2318.246569864792;2318.675385446039;2319.814414846808;2254.0532976150057;2278.943026424344;2315.270689732737;2316.073570571768;2320.872352020638;2296.770322967698;2326.534693061386;2327.197116994634;2354.234873666057;2358.174638876397;2239.2498512998163;2254.4476603232233;2266.218154736613;2280.578093052774;2284.4517315844078;2239.921602743896;2271.46620544172;2284.200529814568;2304.331743794314;2320.071971211512;7945.48354356965;7958.721444749406;8004.879926801103;8012.5192488450875;8020.077691065544;4494.16857881293;4599.310103484504;4603.49361570227;4617.699849509771;4622.052479241747;2849.33040735427;2878.8560571971316;2936.324645331564;2953.276447270411;2981.925451863721;966.9371490853142;968.3076600230798;979.4417182206146;987.8666380038675;1011.610529945976;10810.081143102845;10865.40240286784;10929.836052459219;10956.726081848017;10966.122710183246;4290.806913688892;4332.328489084197;4470.195364834296;4496.977515112403;4502.774861256924;9238.076192380708;9249.352545321763;9249.953750231205;9266.536673166314;9274.165325120772;4520.88697782558;4533.54664533544;4538.546145385435;4560.065186636732;4561.635069194456;3865.8067096645054;4167.374893765959;4250;4370;4400.229959757094;3776.4146557283666;3793.9241215176094;3883.1457079442475;3904.7657140571087;3912.1784425270444;1262.9242245465302;1280.8206851040861;1291.2704322058007;1298.6623477895814;1313.5796545105475;721.4336745654635;791.6516732637621;807.6527093349798;814.0191069760924;820.4953953318666;5042.218456139304;5187.403448603383;5195.766190521435;5200.843974680765;5206.73966301691;890.1143362354499;905.4929239625831;907.4419232172166;914.9496777677158;915.4919019943995;3521.7182625389905;3527.7883327000463;3550.680438760524;3590.335787879251;3628.056705256652;9395.90604093964;10064.44645544502;10086.495675216356;10104.848427273597;10153.593856245667;9728.464934428534;9964.750881227883;9978.301518893608;10033;10068.949655251823;7302.123745150509;7406.666799976056;7427.442941779388;7435.851282974419;7437.442191835634;5016.573591244639;5207.531322181022;5257.106291930305;5300.9734951325;5336.706481143575;9034.186923176945;9055.456672599665;9118.179363857285;9148.405353651991;9157.725268241964;8957.59690813902;8972.955135224282;9124.908750912406;9129.5891684873;9157.587908543997;5750.6262092963825;6105.603135796159;6299.519612890876;6342.936570634419;6367.363263673596;7396.445266605134;7446.851062978819;7449.366803821519;7469.551826890404;7520.210377910241;6630.53586248958;6896.413804826646;6908.3091690832525;6908.654567271717;6983.057287266154;6738.764143254963;6761.661916904233;6766.5263431559315;6864.897026544506;6873.278305778022;6078.118672792332;6176.104464852661;6215.96892015537;6276.466500347522;6292.811215663537;4193.895152621087;4312.5903039211225;4385.912281754411;4450.332450132506;4473.485549161758;4459.531749166291;4467.865964021084;4607.930881036854;4611.33135695329;4651.976740116278 05:07:38 INFO - PROCESS | 19154 | |4;prototype.html;317.26869565651174;318.43636762929617;321.9822909739966;323.5858101629913;327.36001117814675;5427.91858122128;5485.753141108649;5486.807961721341;5492.450754924505;5506.889862202754;5379.919301210485;5400.702961337125;5423.430539793324;5430.402655707869;5434.3207099112615;3922.293987082324;4050.453188819516;4168.353905144708;4178.415021896922;4181;4152.086540960984;4173.812178451962;4176.644985176264;4188.099558594901;4198.8320467181275;4154.252234597771;4158.97920510397;4169.437125987984;4170.541240463546;4182.33082706767;4076.7961601920083;4146.91706165875;4166.854160104382;4168.145530166309;4170.520390155126;3632.3643362411735;3647.8176091195332;3649.708023358125;3660.176460296412;3661.6887564557046;5193.2989046479;5198.272241886101;5204.479552044765;5209;5216.843494695166;4716.080364328957;4789.185838407444;4806.375171227753;4825.565699087064;4834.033193361307;5650.067738823089;5677.347105082927;5680.829575112753;5683.829485115453;5704.600677952545;3993.5008123984503;3995.4606128172904;4006.0585762345827;4018.799060046986;4025.2754504189234;5808.3030036395485;5978.910316345215;6013.969930150365;6022.78920237794;6029.969850150765;4094.385842123705;4117.485314335708;4130.54563997966;4133.23535145999;4150.813213405404;4179.477565304337;4181.60274773896;4199.328107502846;4202.117555313418;4202.2646036943415;4696.66145148631;4802.567768900815;4811.4707382187935;4814.807407703653;4825.95174048262;5726;5740.196372507852;5742.483176514133;5776.364599894092;5778.855528611818;1456.9635759106106;1465.824101107874;1474.3733913086894;1474.6681996550906;1475.9040662356913;928.1971095002909;977.5698692575244;987.8863930648067;1009.4851625670814;1029.7580068683853;4876.780544875489;4904.092742842514;4908.730019848943;4915.886168947387;4930.802767889244;5869.559783016291;5873.060310350409;5878.206442130343;5879.617824841372;5903.232579764689;4812.374391329105;4888.633352498506;4921.908189019652;4928.334674818853;4937.728424936663;3143.874245030219;3144.8427578621436;3157.463231250693;3161.1148878314107;3173.571567838312;5471.480209380103;5484.7531861066345;5491.780328786884;5498.560115190855;5512.062949298549;5772.163036359704;5986.940130598726;5991.820245392645;5993.801239752067;6009.338972712998;5366.731663416892;5425.810096646598;5433.483819037185;5487.5884308677805;5511.944880551143;5775.237489882108;5804.361520232856;5845.152452894222;5873.618214816023;5895;5726.198332233574;5730.484256416942;5744.827655170351;5757.625754325955;5759.078547432391;5459.426760190282;5461.098918678374;5461.657981904475;5479.671219726829;5506.531944784578;3832.5400951885954;4006.5192176938954;4047.777372244437;4066.0648050947857;4171.687123465692;5893.764249429974;5919.171316015847;5919.763209471573;5929.703514824155;5941.851453713692;5626.2685850839125;5696.743646535999;5728.369879313355;5736.4550367715;5752.597318187854;5686.834198989114;5722.227499287543;5729.3984131665575;5734.655920644775;5744.655320680772;5369.6509726867625;5612.045952188057;5627.071533196977;5640.097584386478;5677.77288908439;5498.560115190855;5634.295713035871;5723.055695810312;5727.255456790591;5729.369769325288;5532.640378375393;5537.224788529528;5547.750351234124;5552.944470555242;5580.107182850725 05:07:38 INFO - PROCESS | 19154 | |5;yui.html;643.6749441532025;654.1496055128333;655.1384928818604;681.5876394781158;721.1742554774786;11778.823317650242;12077.275363478186;12114;12232.20490668107;12440.25358478492;11813.350265735382;11882;11898.405079746022;11945.940270298657;11962.760744785099;628.4783629587431;765.7817522006229;769.6536558548662;778.622368151446;794.7059587952466;786.6460092958163;787.9724209652663;788.2590365056857;790.7034861926777;791.0862953288961;811.2739098506833;813.1461964936822;816.3591580609223;822.5393779483509;823.2138307915926;814.4339683919678;815.388458656008;815.4617952151581;815.9061707903548;816.5957850863861;593.0718425663822;594.7502049139372;598.0282041682266;600.5285850607253;600.9489193418565;12803.871961280362;12819.487220511168;12827.166234194841;12880.484780608764;12902.612921612366;12775.61673149807;12847.486100555967;12868.613941581767;12991;13335.666608334772;9411.811763764686;10013.299069065168;10119.848202276971;10336.431496267702;10354.068133867913;3233.062411900546;3243.8053716777067;3309.7186739127205;3333.6999670029813;3411.9488207676904;42969.785151074044;44723.55276447226;45984;46661.53338466606;46732.5326746735;9622.422654640744;9720.659776907916;9837.409755414697;9980.550875210633;10051.949740251252;16398.508044758677;16405.1797410129;16420.507384778237;16450.848440609043;16962.49112526626;6667.333266673294;6678.465722742169;6812.761553345609;6866.725330986705;6882.311768823178;3674.3386190485435;3715.331240376758;3717.386631205821;3834.444005619225;3870.2066076454257;3039.285767844555;3239.5464634951127;3267.9346413071607;3270.2478429960765;3275.3449310138067;563.6871536297313;563.8477611044995;568.2186992884783;570.492261886921;575.5625724449364;506.29624821498146;551.737924485866;554.9139883318093;556.7522452508595;562.7355143082744;7023.438124949992;7181.13826340832;7257.346838784535;7275.818104547428;7452.627368631655;434.7022289731544;509.80882169186555;537.3390729402856;546.5709418106767;557.2031994248183;3479;3539.132912436418;3607.8917632471066;3754.9812250939117;3783.754055986352;50444.20780025892;50779.49220507748;51923.48076519262;52539.53413959856;52731.472685273424;45843.54156458459;46345.30482042772;46623.30065049027;46840.7657961708;46884.7655761719;40738.38892416616;40892.18215635671;42387.364189537184;42521.36217956733;42878.57121428808;6852.794416167523;6951.478639101986;6986.580805151707;7010.824729381806;7070.328318809705;29137.7086229135;29475.410491790473;29593;30169.547456787728;30784.53823192699;39183.80408097941;39342.803285983384;39364.803175985086;39873.806940618546;39929.40105898356;8823.250023748053;8847.159519845862;9075;9151.679691210775;9153.86269205949;9934.801303973736;9934.850977235203;10088.344257623232;10124.291299609251;10409.219308551737;8830.602622882114;8882.067382924959;9147.77130571741;9205.355625106178;9528.61885524599;9636.71089867305;9649.662261820802;9766.169875560658;9841.114299713061;9844.212463003087;9250.861237081584;9317.813643727222;9329.440233586007;9504.47725375111;9535.904640953779;7452;7482.962585187257;7495.325420711944;7506.28343909419;7565.205653406313;7473.140588832136;7553.131389890233;7582.924170758442;7677.923220767944;7715.1513333534385 05:07:38 INFO - PROCESS | 19154 | __end_tp_report 05:07:38 INFO - PROCESS | 19154 | __start_cc_report 05:07:38 INFO - PROCESS | 19154 | _x_x_mozilla_cycle_collect,375 05:07:38 INFO - PROCESS | 19154 | __end_cc_report 05:07:38 INFO - PROCESS | 19154 | __startTimestamp1461586058628__endTimestamp 05:07:38 INFO - PROCESS | 19154 | 05:07:38 INFO - PROCESS | 19154 | ------- Summary: start ------- 05:07:38 INFO - PROCESS | 19154 | Number of tests: 6 05:07:38 INFO - PROCESS | 19154 | 05:07:38 INFO - PROCESS | 19154 | [#0] dojo.html Cycles:165 Average:4708.39 Median:4872.07 stddev:596.40 (12.2%) stddev-sans-first:575.29 05:07:38 INFO - PROCESS | 19154 | Values: 2619.7 2667.6 2683.9 2705.9 2716.0 4661.1 4708.2 4719.7 4738.9 4747.9 4664.1 4793.3 4805.8 4827.3 4872.1 4375.1 4412.1 4419.7 4450.0 4515.6 534.4 4117.6 4298.6 4344.4 4401.8 4446.0 4446.9 4449.8 4467.5 4468.0 4433.5 4462.5 4467.8 4471.6 4490.9 4297.5 4363.5 4402.4 4439.6 4440.5 4699.9 4719.8 4757.6 4770.3 4776.4 4964.0 5176.5 5196.9 5197.1 5243.4 5127.6 5129.4 5133.1 5164.6 5169.0 4697.0 4728.6 4763.1 4796.8 4816.5 5155.0 5187.1 5223.8 5260.8 5266.4 5029.9 5032.3 5036.3 5060.6 5078.2 5112.2 5113.0 5125.1 5139.6 5164.4 4985.0 5054.7 5070.0 5079.9 5136.0 5025.8 5031.3 5032.6 5078.5 5122.3 4289.4 4290.8 4307.7 4319.8 4330.8 3648.9 3756.8 3770.0 3836.1 3876.8 4288.2 4415.3 4441.3 4444.4 4466.2 5210.1 5227.3 5241.9 5243.4 5248.2 4296.0 4389.2 4437.3 4465.6 4508.3 4611.2 4614.2 4629.5 4668.8 4677.9 4768.6 4846.4 4858.7 4879.0 4915.2 5058.2 5132.4 5189.5 5201.3 5201.9 4834.3 4841.0 4860.0 4862.2 4910.5 5093.1 5099.3 5104.2 5120.3 5156.5 4954.9 5029.6 5128.4 5189.5 5238.9 4908.8 4915.2 4917.0 4921.0 4952.3 4903.0 4918.2 4921.4 4927.5 4970.7 4704.4 4871.3 4880.0 4935.0 4949.9 5011.8 5025.2 5041.1 5061.8 5079.5 4885.0 4917.3 4935.6 4940.7 4987.7 05:07:38 INFO - PROCESS | 19154 | 05:07:38 INFO - PROCESS | 19154 | [#1] ext.html Cycles:180 Average:44007.17 Median:36180.50 stddev:75993.77 (210.0%) stddev-sans-first:76137.01 05:07:38 INFO - PROCESS | 19154 | Values: 582.1 590.0 603.7 616.4 625.2 34031.0 34742.3 34851.5 34885.5 35095.0 35578.6 36266.0 36382.8 36466.5 36504.6 7552.0 7723.3 7726.9 7729.1 7733.1 7605.6 7838.3 7899.1 7902.2 7909.1 7851.5 7914.1 7915.6 7934.0 7944.6 7823.9 7849.6 7858.2 7869.5 7882.4 7805.2 7887.1 7897.6 7916.0 7943.2 29822.3 36479.5 36738.4 37068.3 37111.8 2705.4 2775.3 2819.7 3030.0 3263.3 25487.5 25837.6 25900.5 26172.5 26392.3 3355.1 3384.4 3419.9 3427.2 3450.3 174628.0 175016.0 175461.0 175548.0 176424.0 47181.3 47245.3 47308.8 47343.0 47461.3 47371.0 51111.0 55549.7 58174.0 58545.4 13574.9 13650.2 13744.7 13750.2 13773.7 10111.3 10168.8 10217.3 10231.7 10236.5 17334.5 17556.5 17563.8 17581.2 17720.4 6922.2 7032.8 7052.3 7070.5 7087.0 846.8 901.9 905.9 973.3 989.5 27217.2 27543.4 27787.6 28292.6 28520.0 972.2 996.7 1035.4 1041.6 1054.7 14288.8 14827.6 14856.6 14977.1 15002.8 340230.0 347966.0 348653.0 348715.0 348779.0 47816.0 48806.8 49125.8 49226.8 49420.3 1203.6 1215.7 1218.9 1245.7 1248.3 26717.2 27549.1 28035.7 28254.0 28385.0 42732.1 49743.3 51993.5 52493.6 52641.7 310220.0 314014.0 316856.0 316918.0 316998.0 37653.0 37790.6 38082.4 38190.4 38348.4 42004.4 42504.6 42518.4 42859.8 43147.8 36411.3 36437.0 36759.1 37170.0 37180.3 36095.0 36516.6 36599.3 36616.8 36872.6 34236.5 34742.3 34809.1 35175.3 35512.3 32023.7 32405.0 32421.7 33200.2 33661.7 24384.9 24410.9 24475.9 24508.6 24989.3 05:07:38 INFO - PROCESS | 19154 | 05:07:38 INFO - PROCESS | 19154 | [#2] jquery.html Cycles:180 Average:24796.37 Median:396646.50 stddev:67932.89 (17.1%) stddev-sans-first:68098.72 05:07:38 INFO - PROCESS | 19154 | Values: 381.4 381.7 386.8 387.6 406.4 15538.7 16757.7 17341.8 17362.7 17399.7 16097.4 16508.3 16696.4 16846.3 16882.7 5040.5 5179.0 5230.1 5236.2 5236.9 3722.3 5724.3 6047.5 6054.5 6056.4 5012.1 5954.3 5977.9 5993.9 6012.2 4773.8 4777.9 4783.2 4797.7 4800.4 4674.3 4740.0 5439.9 5441.4 5481.9 12214.7 12399.6 12580.0 12636.1 12701.3 1871.8 2040.6 2055.3 2167.9 2364.6 8608.9 9164.7 9451.8 9462.5 9546.9 1756.9 1807.8 1832.2 1872.2 1894.1 66490.7 68156.0 69798.0 70618.9 71074.0 10075.9 10121.9 10301.0 10358.3 10555.4 14409.7 14532.9 14557.7 14562.5 14597.0 7006.0 7011.5 7045.0 7070.3 7078.4 6481.5 6503.9 6519.6 6591.8 6645.1 4426.0 4440.7 4441.5 4445.4 4600.9 1722.6 1838.9 1900.9 1903.4 1928.1 810.8 877.2 891.7 908.6 958.1 15516.1 16067.1 16198.9 16227.4 16667.3 873.2 873.5 889.7 906.8 923.9 9281.9 9528.8 9619.9 9668.7 9778.8 395362.0 397931.0 422097.0 422247.0 424020.0 74831.6 77594.0 77726.6 77752.6 78097.6 936.3 948.2 977.1 993.3 996.0 14876.9 14925.9 14987.8 15120.2 15445.4 34592.3 34737.0 35551.0 35738.5 35816.8 47230.0 47458.8 48439.8 49698.3 49716.0 7951.2 8093.6 8135.8 11074.0 11343.4 11664.9 11997.6 12148.6 12603.2 12838.6 4927.7 6499.7 10801.9 10897.0 10981.5 10710.8 10860.7 10892.5 11445.5 11602.6 11020.4 11054.9 11065.9 11070.5 11325.8 11922.7 11940.7 12058.9 12095.1 12168.9 10997.5 10998.9 11032.3 11365.6 11638.4 05:07:38 INFO - PROCESS | 19154 | 05:07:38 INFO - PROCESS | 19154 | [#3] mootools.html Cycles:180 Average:5199.28 Median:4637.01 stddev:2906.71 (62.7%) stddev-sans-first:2900.94 05:07:38 INFO - PROCESS | 19154 | Values: 1413.3 1457.9 1591.2 1758.2 1797.6 7049.0 7675.2 7714.0 7953.9 7964.3 7826.9 7858.4 7917.2 7923.5 7928.5 2284.6 2290.2 2318.2 2318.7 2319.8 2254.1 2278.9 2315.3 2316.1 2320.9 2296.8 2326.5 2327.2 2354.2 2358.2 2239.2 2254.4 2266.2 2280.6 2284.5 2239.9 2271.5 2284.2 2304.3 2320.1 7945.5 7958.7 8004.9 8012.5 8020.1 4494.2 4599.3 4603.5 4617.7 4622.1 2849.3 2878.9 2936.3 2953.3 2981.9 966.9 968.3 979.4 987.9 1011.6 10810.1 10865.4 10929.8 10956.7 10966.1 4290.8 4332.3 4470.2 4497.0 4502.8 9238.1 9249.4 9250.0 9266.5 9274.2 4520.9 4533.5 4538.5 4560.1 4561.6 3865.8 4167.4 4250.0 4370.0 4400.2 3776.4 3793.9 3883.1 3904.8 3912.2 1262.9 1280.8 1291.3 1298.7 1313.6 721.4 791.7 807.7 814.0 820.5 5042.2 5187.4 5195.8 5200.8 5206.7 890.1 905.5 907.4 914.9 915.5 3521.7 3527.8 3550.7 3590.3 3628.1 9395.9 10064.4 10086.5 10104.8 10153.6 9728.5 9964.8 9978.3 10033.0 10068.9 7302.1 7406.7 7427.4 7435.9 7437.4 5016.6 5207.5 5257.1 5301.0 5336.7 9034.2 9055.5 9118.2 9148.4 9157.7 8957.6 8973.0 9124.9 9129.6 9157.6 5750.6 6105.6 6299.5 6342.9 6367.4 7396.4 7446.9 7449.4 7469.6 7520.2 6630.5 6896.4 6908.3 6908.7 6983.1 6738.8 6761.7 6766.5 6864.9 6873.3 6078.1 6176.1 6216.0 6276.5 6292.8 4193.9 4312.6 4385.9 4450.3 4473.5 4459.5 4467.9 4607.9 4611.3 4652.0 05:07:38 INFO - PROCESS | 19154 | 05:07:38 INFO - PROCESS | 19154 | [#4] prototype.html Cycles:180 Average:4705.33 Median:5412.07 stddev:1377.88 (25.5%) stddev-sans-first:1341.81 05:07:38 INFO - PROCESS | 19154 | Values: 317.3 318.4 322.0 323.6 327.4 5427.9 5485.8 5486.8 5492.5 5506.9 5379.9 5400.7 5423.4 5430.4 5434.3 3922.3 4050.5 4168.4 4178.4 4181.0 4152.1 4173.8 4176.6 4188.1 4198.8 4154.3 4159.0 4169.4 4170.5 4182.3 4076.8 4146.9 4166.9 4168.1 4170.5 3632.4 3647.8 3649.7 3660.2 3661.7 5193.3 5198.3 5204.5 5209.0 5216.8 4716.1 4789.2 4806.4 4825.6 4834.0 5650.1 5677.3 5680.8 5683.8 5704.6 3993.5 3995.5 4006.1 4018.8 4025.3 5808.3 5978.9 6014.0 6022.8 6030.0 4094.4 4117.5 4130.5 4133.2 4150.8 4179.5 4181.6 4199.3 4202.1 4202.3 4696.7 4802.6 4811.5 4814.8 4826.0 5726.0 5740.2 5742.5 5776.4 5778.9 1457.0 1465.8 1474.4 1474.7 1475.9 928.2 977.6 987.9 1009.5 1029.8 4876.8 4904.1 4908.7 4915.9 4930.8 5869.6 5873.1 5878.2 5879.6 5903.2 4812.4 4888.6 4921.9 4928.3 4937.7 3143.9 3144.8 3157.5 3161.1 3173.6 5471.5 5484.8 5491.8 5498.6 5512.1 5772.2 5986.9 5991.8 5993.8 6009.3 5366.7 5425.8 5433.5 5487.6 5511.9 5775.2 5804.4 5845.2 5873.6 5895.0 5726.2 5730.5 5744.8 5757.6 5759.1 5459.4 5461.1 5461.7 5479.7 5506.5 3832.5 4006.5 4047.8 4066.1 4171.7 5893.8 5919.2 5919.8 5929.7 5941.9 5626.3 5696.7 5728.4 5736.5 5752.6 5686.8 5722.2 5729.4 5734.7 5744.7 5369.7 5612.0 5627.1 5640.1 5677.8 5498.6 5634.3 5723.1 5727.3 5729.4 5532.6 5537.2 5547.8 5552.9 5580.1 05:07:38 INFO - PROCESS | 19154 | 05:07:38 INFO - PROCESS | 19154 | [#5] yui.html Cycles:180 Average:12349.00 Median:556.98 stddev:14449.94 (2594.3%) stddev-sans-first:14463.74 05:07:38 INFO - PROCESS | 19154 | Values: 643.7 654.1 655.1 681.6 721.2 11778.8 12077.3 12114.0 12232.2 12440.3 11813.4 11882.0 11898.4 11945.9 11962.8 628.5 765.8 769.7 778.6 794.7 786.6 788.0 788.3 790.7 791.1 811.3 813.1 816.4 822.5 823.2 814.4 815.4 815.5 815.9 816.6 593.1 594.8 598.0 600.5 600.9 12803.9 12819.5 12827.2 12880.5 12902.6 12775.6 12847.5 12868.6 12991.0 13335.7 9411.8 10013.3 10119.8 10336.4 10354.1 3233.1 3243.8 3309.7 3333.7 3411.9 42969.8 44723.6 45984.0 46661.5 46732.5 9622.4 9720.7 9837.4 9980.6 10051.9 16398.5 16405.2 16420.5 16450.8 16962.5 6667.3 6678.5 6812.8 6866.7 6882.3 3674.3 3715.3 3717.4 3834.4 3870.2 3039.3 3239.5 3267.9 3270.2 3275.3 563.7 563.8 568.2 570.5 575.6 506.3 551.7 554.9 556.8 562.7 7023.4 7181.1 7257.3 7275.8 7452.6 434.7 509.8 537.3 546.6 557.2 3479.0 3539.1 3607.9 3755.0 3783.8 50444.2 50779.5 51923.5 52539.5 52731.5 45843.5 46345.3 46623.3 46840.8 46884.8 40738.4 40892.2 42387.4 42521.4 42878.6 6852.8 6951.5 6986.6 7010.8 7070.3 29137.7 29475.4 29593.0 30169.5 30784.5 39183.8 39342.8 39364.8 39873.8 39929.4 8823.3 8847.2 9075.0 9151.7 9153.9 9934.8 9934.9 10088.3 10124.3 10409.2 8830.6 8882.1 9147.8 9205.4 9528.6 9636.7 9649.7 9766.2 9841.1 9844.2 9250.9 9317.8 9329.4 9504.5 9535.9 7452.0 7483.0 7495.3 7506.3 7565.2 7473.1 7553.1 7582.9 7677.9 7715.2 05:07:38 INFO - PROCESS | 19154 | -------- Summary: end -------- 05:07:38 INFO - PROCESS | 19154 | 05:07:39 INFO - TEST-INFO | 19154: exit 0 05:07:39 INFO - TEST-OK | dromaeo_css | took 1115443ms 05:07:39 INFO - TEST-START | kraken 05:07:39 INFO - operating with platform_type : linux_ 05:07:39 INFO - Initialising browser for kraken test... 05:07:39 INFO - TEST-INFO | started process 19389 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiA6GbP/profile http://localhost:53169/getInfo.html) 05:07:43 INFO - PROCESS | 19389 | 05:07:43 INFO - PROCESS | 19389 | (process:19457): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:07:44 INFO - PROCESS | 19389 | __metrics Screen width/height:1600/1200 05:07:44 INFO - PROCESS | 19389 | colorDepth:24 05:07:44 INFO - PROCESS | 19389 | Browser inner width/height: 1024/697 05:07:44 INFO - PROCESS | 19389 | __metrics 05:07:45 ERROR - PROCESS | 19389 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:07:46 INFO - TEST-INFO | 19389: exit 0 05:07:46 INFO - Browser initialized. 05:07:46 INFO - Running cycle 1/1 for kraken test... 05:07:46 INFO - TEST-INFO | started process 19509 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiA6GbP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:07:48 INFO - PROCESS | 19509 | 05:07:48 INFO - PROCESS | 19509 | (process:19570): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:07:58 INFO - PROCESS | 19509 | RSS: Main: 165453824 05:07:58 INFO - PROCESS | 19509 | 05:08:00 INFO - PROCESS | 19509 | Cycle 1(1): loaded http://localhost:53169/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53169/tests/kraken/driver.html?testName=audio-beat-detection) 05:08:01 INFO - PROCESS | 19509 | RSS: Main: 169369600 05:08:01 INFO - PROCESS | 19509 | 05:08:04 INFO - PROCESS | 19509 | Cycle 1(1): loaded http://localhost:53169/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53169/tests/kraken/driver.html?testName=audio-dft) 05:08:05 INFO - PROCESS | 19509 | RSS: Main: 172789760 05:08:05 INFO - PROCESS | 19509 | 05:08:08 INFO - PROCESS | 19509 | Cycle 1(1): loaded http://localhost:53169/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53169/tests/kraken/driver.html?testName=audio-fft) 05:08:08 INFO - PROCESS | 19509 | RSS: Main: 163315712 05:08:08 INFO - PROCESS | 19509 | 05:08:10 INFO - PROCESS | 19509 | Cycle 1(1): loaded http://localhost:53169/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53169/tests/kraken/driver.html?testName=audio-oscillator) 05:08:11 INFO - PROCESS | 19509 | RSS: Main: 163708928 05:08:11 INFO - PROCESS | 19509 | 05:08:13 INFO - PROCESS | 19509 | Cycle 1(1): loaded http://localhost:53169/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53169/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:08:14 INFO - PROCESS | 19509 | RSS: Main: 165281792 05:08:14 INFO - PROCESS | 19509 | 05:08:17 INFO - PROCESS | 19509 | Cycle 1(1): loaded http://localhost:53169/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53169/tests/kraken/driver.html?testName=imaging-darkroom) 05:08:18 INFO - PROCESS | 19509 | RSS: Main: 166264832 05:08:18 INFO - PROCESS | 19509 | 05:08:21 INFO - PROCESS | 19509 | Cycle 1(1): loaded http://localhost:53169/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53169/tests/kraken/driver.html?testName=imaging-desaturate) 05:08:22 INFO - PROCESS | 19509 | RSS: Main: 164913152 05:08:22 INFO - PROCESS | 19509 | 05:08:25 INFO - PROCESS | 19509 | Cycle 1(1): loaded http://localhost:53169/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53169/tests/kraken/driver.html?testName=json-parse-financial) 05:08:26 INFO - PROCESS | 19509 | RSS: Main: 165429248 05:08:26 INFO - PROCESS | 19509 | 05:08:27 INFO - PROCESS | 19509 | Cycle 1(1): loaded http://localhost:53169/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53169/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:08:28 INFO - PROCESS | 19509 | RSS: Main: 165642240 05:08:28 INFO - PROCESS | 19509 | 05:08:30 INFO - PROCESS | 19509 | Cycle 1(1): loaded http://localhost:53169/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53169/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:08:31 INFO - PROCESS | 19509 | RSS: Main: 165576704 05:08:31 INFO - PROCESS | 19509 | 05:08:33 INFO - PROCESS | 19509 | Cycle 1(1): loaded http://localhost:53169/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53169/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:08:33 INFO - PROCESS | 19509 | RSS: Main: 165826560 05:08:33 INFO - PROCESS | 19509 | 05:08:36 INFO - PROCESS | 19509 | Cycle 1(1): loaded http://localhost:53169/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53169/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:08:37 INFO - PROCESS | 19509 | RSS: Main: 166240256 05:08:37 INFO - PROCESS | 19509 | 05:08:40 INFO - PROCESS | 19509 | Cycle 1(1): loaded http://localhost:53169/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53169/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:08:40 INFO - PROCESS | 19509 | RSS: Main: 166043648 05:08:40 INFO - PROCESS | 19509 | 05:08:42 INFO - PROCESS | 19509 | Cycle 1(1): loaded http://localhost:53169/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53169/tests/kraken/driver.html?testName=ai-astar) 05:08:42 INFO - PROCESS | 19509 | RSS: Main: 167948288 05:08:42 INFO - PROCESS | 19509 | 05:08:42 INFO - PROCESS | 19509 | __start_tp_report 05:08:42 INFO - PROCESS | 19509 | _x_x_mozilla_page_load 05:08:42 INFO - PROCESS | 19509 | _x_x_mozilla_page_load_details 05:08:42 INFO - PROCESS | 19509 | |i|pagename|runs| 05:08:42 INFO - PROCESS | 19509 | |0;ai-astar;113;107;113;113;113;125;113;112;112;114 05:08:42 INFO - PROCESS | 19509 | |1;audio-beat-detection;166;140;168;184;139;164;163;140;190;134 05:08:42 INFO - PROCESS | 19509 | |2;audio-dft;164;163;165;171;165;165;162;164;166;163 05:08:42 INFO - PROCESS | 19509 | |3;audio-fft;77;73;73;161;76;74;74;76;155;80 05:08:42 INFO - PROCESS | 19509 | |4;audio-oscillator;93;94;152;94;95;94;144;95;94;148 05:08:42 INFO - PROCESS | 19509 | |5;imaging-gaussian-blur;117;118;118;120;118;118;119;118;117;118 05:08:42 INFO - PROCESS | 19509 | |6;imaging-darkroom;147;148;147;147;148;148;148;148;150;147 05:08:42 INFO - PROCESS | 19509 | |7;imaging-desaturate;95;96;95;101;99;96;96;95;96;96 05:08:42 INFO - PROCESS | 19509 | |8;json-parse-financial;66;67;64;66;67;64;65;90;63;65 05:08:42 INFO - PROCESS | 19509 | |9;json-stringify-tinderbox;64;65;65;64;65;65;64;65;65;64 05:08:42 INFO - PROCESS | 19509 | |10;stanford-crypto-aes;83;80;81;79;79;79;78;82;81;81 05:08:42 INFO - PROCESS | 19509 | |11;stanford-crypto-ccm;145;135;135;136;133;133;141;136;174;137 05:08:42 INFO - PROCESS | 19509 | |12;stanford-crypto-pbkdf2;178;180;187;176;177;176;175;177;180;176 05:08:42 INFO - PROCESS | 19509 | |13;stanford-crypto-sha256-iterative;75;70;81;72;72;72;71;75;74;77 05:08:42 INFO - PROCESS | 19509 | __end_tp_report 05:08:42 INFO - PROCESS | 19509 | __start_cc_report 05:08:42 INFO - PROCESS | 19509 | _x_x_mozilla_cycle_collect,938 05:08:42 INFO - PROCESS | 19509 | __end_cc_report 05:08:42 INFO - PROCESS | 19509 | __startTimestamp1461586122978__endTimestamp 05:08:42 INFO - PROCESS | 19509 | 05:08:42 INFO - PROCESS | 19509 | ------- Summary: start ------- 05:08:42 INFO - PROCESS | 19509 | Number of tests: 14 05:08:42 INFO - PROCESS | 19509 | 05:08:42 INFO - PROCESS | 19509 | [#0] ai-astar Cycles:10 Average:113.50 Median:113.00 stddev:4.48 (4.0%) stddev-sans-first:4.75 05:08:42 INFO - PROCESS | 19509 | Values: 113.0 107.0 113.0 113.0 113.0 125.0 113.0 112.0 112.0 114.0 05:08:42 INFO - PROCESS | 19509 | 05:08:42 INFO - PROCESS | 19509 | [#1] audio-beat-detection Cycles:10 Average:158.80 Median:165.00 stddev:19.73 (12.0%) stddev-sans-first:20.75 05:08:42 INFO - PROCESS | 19509 | Values: 166.0 140.0 168.0 184.0 139.0 164.0 163.0 140.0 190.0 134.0 05:08:42 INFO - PROCESS | 19509 | 05:08:42 INFO - PROCESS | 19509 | [#2] audio-dft Cycles:10 Average:164.80 Median:165.00 stddev:2.49 (1.5%) stddev-sans-first:2.62 05:08:42 INFO - PROCESS | 19509 | Values: 164.0 163.0 165.0 171.0 165.0 165.0 162.0 164.0 166.0 163.0 05:08:42 INFO - PROCESS | 19509 | 05:08:42 INFO - PROCESS | 19509 | [#3] audio-fft Cycles:10 Average:91.90 Median:75.00 stddev:34.93 (46.6%) stddev-sans-first:36.63 05:08:42 INFO - PROCESS | 19509 | Values: 77.0 73.0 73.0 161.0 76.0 74.0 74.0 76.0 155.0 80.0 05:08:42 INFO - PROCESS | 19509 | 05:08:42 INFO - PROCESS | 19509 | [#4] audio-oscillator Cycles:10 Average:110.30 Median:94.00 stddev:26.09 (27.8%) stddev-sans-first:26.91 05:08:42 INFO - PROCESS | 19509 | Values: 93.0 94.0 152.0 94.0 95.0 94.0 144.0 95.0 94.0 148.0 05:08:42 INFO - PROCESS | 19509 | 05:08:42 INFO - PROCESS | 19509 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.88 (0.7%) stddev-sans-first:0.83 05:08:42 INFO - PROCESS | 19509 | Values: 117.0 118.0 118.0 120.0 118.0 118.0 119.0 118.0 117.0 118.0 05:08:42 INFO - PROCESS | 19509 | 05:08:42 INFO - PROCESS | 19509 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 05:08:42 INFO - PROCESS | 19509 | Values: 147.0 148.0 147.0 147.0 148.0 148.0 148.0 148.0 150.0 147.0 05:08:42 INFO - PROCESS | 19509 | 05:08:42 INFO - PROCESS | 19509 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.00 stddev:1.96 (2.0%) stddev-sans-first:2.00 05:08:42 INFO - PROCESS | 19509 | Values: 95.0 96.0 95.0 101.0 99.0 96.0 96.0 95.0 96.0 96.0 05:08:42 INFO - PROCESS | 19509 | 05:08:42 INFO - PROCESS | 19509 | [#8] json-parse-financial Cycles:10 Average:67.70 Median:66.00 stddev:7.94 (12.0%) stddev-sans-first:8.40 05:08:42 INFO - PROCESS | 19509 | Values: 66.0 67.0 64.0 66.0 67.0 64.0 65.0 90.0 63.0 65.0 05:08:42 INFO - PROCESS | 19509 | 05:08:42 INFO - PROCESS | 19509 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 05:08:42 INFO - PROCESS | 19509 | Values: 64.0 65.0 65.0 64.0 65.0 65.0 64.0 65.0 65.0 64.0 05:08:42 INFO - PROCESS | 19509 | 05:08:42 INFO - PROCESS | 19509 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:81.00 stddev:1.57 (1.9%) stddev-sans-first:1.32 05:08:42 INFO - PROCESS | 19509 | Values: 83.0 80.0 81.0 79.0 79.0 79.0 78.0 82.0 81.0 81.0 05:08:42 INFO - PROCESS | 19509 | 05:08:42 INFO - PROCESS | 19509 | [#11] stanford-crypto-ccm Cycles:10 Average:140.50 Median:136.50 stddev:12.33 (9.0%) stddev-sans-first:12.97 05:08:42 INFO - PROCESS | 19509 | Values: 145.0 135.0 135.0 136.0 133.0 133.0 141.0 136.0 174.0 137.0 05:08:42 INFO - PROCESS | 19509 | 05:08:42 INFO - PROCESS | 19509 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.20 Median:177.50 stddev:3.52 (2.0%) stddev-sans-first:3.73 05:08:42 INFO - PROCESS | 19509 | Values: 178.0 180.0 187.0 176.0 177.0 176.0 175.0 177.0 180.0 176.0 05:08:42 INFO - PROCESS | 19509 | 05:08:42 INFO - PROCESS | 19509 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.90 Median:74.50 stddev:3.28 (4.4%) stddev-sans-first:3.46 05:08:42 INFO - PROCESS | 19509 | Values: 75.0 70.0 81.0 72.0 72.0 72.0 71.0 75.0 74.0 77.0 05:08:42 INFO - PROCESS | 19509 | -------- Summary: end -------- 05:08:42 INFO - PROCESS | 19509 | 05:08:44 INFO - TEST-INFO | 19509: exit 0 05:08:44 INFO - TEST-OK | kraken | took 64880ms 05:08:44 INFO - SUITE-END | took 1180s 05:08:44 INFO - Completed test suite (00:19:40) 05:08:44 INFO - javascript benchmark 05:08:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2619.7380261973803, 2667.573188289874, 2683.8523881186534, 2705.9458810823785, 2716.022231996481, 4661.0677864427125, 4708.152532544141, 4719.740414277213, 4738.857834264978, 4747.928781068283, 4664.067186562684, 4793.257045157998, 4805.831795887145, 4827.348307978422, 4872.07430588188, 4375.124975005004, 4412.130127523382, 4419.668524860632, 4449.955500444987, 4515.593596576307, 534.3871422836944, 4117.609528904237, 4298.634616057639, 4344.391785150082, 4401.845935392262, 4445.955540444586, 4446.888827779299, 4449.844255451044, 4467.463904331468, 4468.039371535119, 4433.534478879736, 4462.486814016397, 4467.843625473125, 4471.6199123074575, 4490.8877278067985, 4297.484301883763, 4363.5418281080665, 4402.449693788277, 4439.64482841372, 4440.467143942716, 4699.906001879977, 4719.764011799431, 4757.643176761722, 4770.284457331393, 4776.379070720784, 4963.950360496385, 5176.482351764794, 5196.870078248036, 5197.090509160919, 5243.449437809013, 5127.6154288428515, 5129.358830146231, 5133.050385678662, 5164.6384753067305, 5169.017886601571, 4696.990147118352, 4728.6453515986095, 4763.118823017753, 4796.848756298463, 4816.54242846929, 5154.974225128851, 5187.06632806091, 5223.764930578133, 5260.789568417221, 5266.368035835648, 5029.949700503022, 5032.270320803463, 5036.294918711384, 5060.569851562658, 5078.238264260391, 5112.233165025276, 5113.028524580318, 5125.1287281162295, 5139.563137133386, 5164.354455693038, 4985.002999400134, 5054.696718196847, 5069.9746501267255, 5079.949200508022, 5135.97432012845, 5025.824096156617, 5031.270465782441, 5032.622553308516, 5078.5175408336145, 5122.334096567422, 4289.378040184219, 4290.806913688892, 4307.65538756905, 4319.805608747614, 4330.848420305274, 3648.908777280589, 3756.8121593920196, 3770.0, 3836.0985168485386, 3876.786776727307, 4288.24955632763, 4415.337699345059, 4441.267190913463, 4444.400005999213, 4466.196084704719, 5210.088234558937, 5227.294315267466, 5241.868953276198, 5243.397009343898, 5248.160294352885, 4295.978520107379, 4389.1660584488845, 4437.334399839985, 4465.59809617136, 4508.346289787963, 4611.216093264153, 4614.238650622677, 4629.51390104041, 4668.836590719308, 4677.906441871143, 4768.642351823558, 4846.39420072498, 4858.684185528071, 4879.0, 4915.238138088602, 5058.1654027085115, 5132.409772876167, 5189.532942035235, 5201.323827902348, 5201.895962080813, 4834.274858771212, 4841.031793641216, 4859.95140048595, 4862.173430516891, 4910.459849416633, 5093.0577843099145, 5099.260607212008, 5104.2088476286235, 5120.25756265332, 5156.535911767959, 4954.851354459372, 5029.597632189343, 5128.410232823273, 5189.481051894781, 5238.895222095613, 4908.754562271801, 4915.1644220481885, 4917.041176970456, 4920.950790492049, 4952.2819191217795, 4902.975485122552, 4918.188498897642, 4921.384826896638, 4927.482614325444, 4970.676906001098, 4704.411948506437, 4871.318015477765, 4880.0, 4935.0, 4949.9257511138085, 5011.799528018839, 5025.221090730943, 5041.092603331289, 5061.772220250171, 5079.492050794891, 4884.9741554274, 4917.311576379238, 4935.62982776286, 4940.6788558743565, 4987.675801072919], "value": 4671.804500518496, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.1326223926349, 590.0352922970942, 603.6891001134413, 616.4267231474729, 625.1997443272606, 34031.0, 34742.30515389697, 34851.47722784157, 34885.476717849255, 35095.0, 35578.644213557855, 36266.0, 36382.8180859096, 36466.45300320497, 36504.63495365046, 7552.0, 7723.304902558769, 7726.922730772704, 7729.149793522708, 7733.149353571102, 7605.581693006882, 7838.333741631968, 7899.052113746358, 7902.24928631779, 7909.090454597737, 7851.489653172525, 7914.089879663855, 7915.643796029164, 7933.968584084061, 7944.563049032301, 7823.8826417603495, 7849.5682737449415, 7858.174891636381, 7869.48848324857, 7882.448228623999, 7805.219478052206, 7887.132415434297, 7897.644605992744, 7916.0, 7943.24539168778, 29822.25444363908, 36479.4528082079, 36738.44892326617, 37068.25863482742, 37111.81444092789, 2705.3912869604183, 2775.2506823157632, 2819.703931087227, 3030.030390275113, 3263.3147039121577, 25487.49025019508, 25837.612435813477, 25900.481990360087, 26172.476550469073, 26392.340191495176, 3355.144438168276, 3384.3569721752788, 3419.9316013679586, 3427.246005878703, 3450.292689998544, 174628.0, 175016.0, 175461.0, 175547.99999999872, 176424.0, 47181.29228061582, 47245.29132063022, 47308.763456182496, 47343.0, 47461.288080678816, 47371.0, 51111.0, 55549.722251388484, 58174.0, 58545.414545854845, 13574.93212533931, 13650.198665567093, 13744.65638359029, 13750.243736594583, 13773.655658608415, 10111.342762720547, 10168.847467287997, 10217.284790064772, 10231.744206394751, 10236.48817559119, 17334.47996560105, 17556.473305800846, 17563.824361756473, 17581.208845601977, 17720.379786707403, 6922.169339679271, 7032.769265378538, 7052.33002864727, 7070.469714771412, 7087.0, 846.8221673448645, 901.9143181397757, 905.8822353094188, 973.3478569358547, 989.5125605379569, 27217.183484495497, 27543.449131017267, 27787.58318625222, 28292.575611365846, 28520.0, 972.154225823538, 996.6611352140308, 1035.3701597941144, 1041.5677493840124, 1054.7152268887357, 14288.785668214985, 14827.555173344817, 14856.554303370916, 14977.101373917381, 15002.774958375632, 340230.0, 347966.0, 348653.0, 348715.0, 348779.0, 47816.0, 48806.75596621994, 49125.754371227915, 49226.75386623044, 49420.258696119585, 1203.584763256675, 1215.6924161152663, 1218.9268643881396, 1245.7321675839737, 1248.300951467163, 26717.198484045508, 27549.12755805543, 28035.71964280331, 28254.0, 28385.0, 42732.14535709331, 49743.25385119298, 51993.48006519886, 52493.637786300475, 52641.7367913158, 310220.0, 314014.0, 316856.0, 316918.0, 316998.0, 37653.0, 37790.62209377871, 38082.42876356912, 38190.42714359342, 38348.42477362786, 42004.36993445162, 42504.57495425006, 42518.362224567274, 42859.7857010713, 43147.784261078494, 36411.27177456383, 36437.0, 36759.08102297464, 37170.0, 37180.25639487249, 36095.0, 36516.63483365239, 36599.26801464009, 36616.81691591525, 36872.63127368692, 34236.48645270273, 34742.305153896275, 34809.12977175591, 35175.296494070484, 35512.28975420529, 32023.679763202068, 32405.0, 32421.675783241866, 33200.1699957503, 33661.663383365856, 24384.878075609508, 24410.87794561016, 24475.877620611784, 24508.6323705141, 24989.250322490356], "value": 17263.88020039064, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.3821608993431, 381.67748252726443, 386.8471953578338, 387.6375588824449, 406.43302592882947, 15538.689226215469, 16757.748633770505, 17341.826581734178, 17362.652746945052, 17399.652006959885, 16097.436589719362, 16508.339666413358, 16696.415625453083, 16846.32614695414, 16882.746758798596, 5040.470750571201, 5178.974105129488, 5230.058589453897, 5236.188390799432, 5236.92144617831, 3722.3485889969284, 5724.284464441945, 6047.546434017467, 6054.455099041085, 6056.394360563952, 5012.147934851084, 5954.315253745832, 5977.85055373617, 5993.940060599403, 6012.248468941382, 4773.761311934407, 4777.880552986168, 4783.234682450791, 4797.688150270239, 4800.399950006249, 4674.275487299474, 4740.0, 5439.945600544023, 5441.401445840955, 5481.862953426156, 12214.694632634166, 12399.566015189424, 12580.0, 12636.05229607783, 12701.301428421433, 1871.812818718131, 2040.6326861164985, 2055.290924631, 2167.902444390006, 2364.5861974154454, 8608.870866937, 9164.725058248263, 9451.810963780754, 9462.479563623998, 9546.856797148048, 1756.8858024228384, 1807.8011418743927, 1832.248778001013, 1872.1762424533163, 1894.1476335649013, 66490.66754666244, 68156.0, 69798.0, 70618.94071588879, 71074.0, 10075.899241007643, 10121.898781012243, 10301.0, 10358.274920755626, 10555.366677999345, 14409.711805763825, 14532.854671453362, 14557.708845823025, 14562.490312839212, 14597.0, 7006.0, 7011.474139439562, 7044.968840135752, 7070.257622949619, 7078.398336141486, 6481.48148148147, 6503.902441463287, 6519.598286368454, 6591.83520411984, 6645.102911107036, 4425.955740442619, 4440.711353761995, 4441.511433742286, 4445.399871017371, 4600.907981840412, 1722.6468573942311, 1838.8620853435777, 1900.9239630414904, 1903.3623736048578, 1928.1419768203016, 810.793247721839, 877.1579283887412, 891.6611687558686, 908.6365453818394, 958.0802429667597, 15516.069035857885, 16067.116308602905, 16198.919005404898, 16227.350905963629, 16667.33330666784, 873.1661263493348, 873.4584557574344, 889.675268526983, 906.8413027720122, 923.930705197113, 9281.860772088425, 9528.761780955532, 9619.855702164474, 9668.70993870185, 9778.804423911482, 395362.0, 397931.0, 422097.0, 422247.0, 424020.0, 74831.62584187044, 77594.0, 77726.6113669428, 77752.61123694346, 78097.60951195208, 936.3258453913172, 948.2414068744977, 977.0913050862624, 993.2699465892563, 996.0189213624574, 14876.925615371854, 14925.850741492446, 14987.775183372476, 15120.243987800786, 15445.382184712485, 34592.308153837286, 34737.0, 35551.0, 35738.463923041694, 35816.82091589525, 47230.0, 47458.76270618625, 48439.75780121077, 49698.254526181416, 49716.0, 7951.165127661744, 8093.595320233847, 8135.75592732219, 11074.0, 11343.376114313793, 11664.94167529157, 11997.580084696994, 12148.574799882315, 12603.18079324841, 12838.614841554769, 4927.679700819435, 6499.6750162492635, 10801.947629950284, 10897.0, 10981.505832237728, 10710.839337409789, 10860.67417977462, 10892.509837057192, 11445.542178312775, 11602.593909213138, 11020.44897755125, 11054.889451105386, 11065.889341106486, 11070.501827417947, 11325.773484530098, 11922.701932451759, 11940.701482463008, 12058.939705301767, 12095.092868035108, 12168.939155304166, 10997.505112269808, 10998.945005274922, 11032.338059716443, 11365.602203922823, 11638.35989020612], "value": 8313.781094622675, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1413.258039529247, 1457.9271036448179, 1591.156686955913, 1758.1912320332647, 1797.6224992751513, 7049.0, 7675.15573286938, 7714.0, 7953.920460795391, 7964.283214510693, 7826.882596761039, 7858.410619203554, 7917.168697286774, 7923.484973476734, 7928.484648497858, 2284.6230371988604, 2290.198430549303, 2318.246569864792, 2318.675385446039, 2319.814414846808, 2254.0532976150057, 2278.943026424344, 2315.270689732737, 2316.073570571768, 2320.872352020638, 2296.770322967698, 2326.534693061386, 2327.197116994634, 2354.234873666057, 2358.174638876397, 2239.2498512998163, 2254.4476603232233, 2266.218154736613, 2280.578093052774, 2284.4517315844078, 2239.921602743896, 2271.46620544172, 2284.200529814568, 2304.331743794314, 2320.071971211512, 7945.48354356965, 7958.721444749406, 8004.879926801103, 8012.5192488450875, 8020.077691065544, 4494.16857881293, 4599.310103484504, 4603.49361570227, 4617.699849509771, 4622.052479241747, 2849.33040735427, 2878.8560571971316, 2936.324645331564, 2953.276447270411, 2981.925451863721, 966.9371490853142, 968.3076600230798, 979.4417182206146, 987.8666380038675, 1011.610529945976, 10810.081143102845, 10865.40240286784, 10929.836052459219, 10956.726081848017, 10966.122710183246, 4290.806913688892, 4332.328489084197, 4470.195364834296, 4496.977515112403, 4502.774861256924, 9238.076192380708, 9249.352545321763, 9249.953750231205, 9266.536673166314, 9274.165325120772, 4520.88697782558, 4533.54664533544, 4538.546145385435, 4560.065186636732, 4561.635069194456, 3865.8067096645054, 4167.374893765959, 4250.0, 4370.0, 4400.229959757094, 3776.4146557283666, 3793.9241215176094, 3883.1457079442475, 3904.7657140571087, 3912.1784425270444, 1262.9242245465302, 1280.8206851040861, 1291.2704322058007, 1298.6623477895814, 1313.5796545105475, 721.4336745654635, 791.6516732637621, 807.6527093349798, 814.0191069760924, 820.4953953318666, 5042.218456139304, 5187.403448603383, 5195.766190521435, 5200.843974680765, 5206.73966301691, 890.1143362354499, 905.4929239625831, 907.4419232172166, 914.9496777677158, 915.4919019943995, 3521.7182625389905, 3527.7883327000463, 3550.680438760524, 3590.335787879251, 3628.056705256652, 9395.90604093964, 10064.44645544502, 10086.495675216356, 10104.848427273597, 10153.593856245667, 9728.464934428534, 9964.750881227883, 9978.301518893608, 10033.0, 10068.949655251823, 7302.123745150509, 7406.666799976056, 7427.442941779388, 7435.851282974419, 7437.442191835634, 5016.573591244639, 5207.531322181022, 5257.106291930305, 5300.9734951325, 5336.706481143575, 9034.186923176945, 9055.456672599665, 9118.179363857285, 9148.405353651991, 9157.725268241964, 8957.59690813902, 8972.955135224282, 9124.908750912406, 9129.5891684873, 9157.587908543997, 5750.6262092963825, 6105.603135796159, 6299.519612890876, 6342.936570634419, 6367.363263673596, 7396.445266605134, 7446.851062978819, 7449.366803821519, 7469.551826890404, 7520.210377910241, 6630.53586248958, 6896.413804826646, 6908.3091690832525, 6908.654567271717, 6983.057287266154, 6738.764143254963, 6761.661916904233, 6766.5263431559315, 6864.897026544506, 6873.278305778022, 6078.118672792332, 6176.104464852661, 6215.96892015537, 6276.466500347522, 6292.811215663537, 4193.895152621087, 4312.5903039211225, 4385.912281754411, 4450.332450132506, 4473.485549161758, 4459.531749166291, 4467.865964021084, 4607.930881036854, 4611.33135695329, 4651.976740116278], "value": 4213.839278317761, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.26869565651174, 318.43636762929617, 321.9822909739966, 323.5858101629913, 327.36001117814675, 5427.91858122128, 5485.753141108649, 5486.807961721341, 5492.450754924505, 5506.889862202754, 5379.919301210485, 5400.702961337125, 5423.430539793324, 5430.402655707869, 5434.3207099112615, 3922.293987082324, 4050.453188819516, 4168.353905144708, 4178.415021896922, 4181.0, 4152.086540960984, 4173.812178451962, 4176.644985176264, 4188.099558594901, 4198.8320467181275, 4154.252234597771, 4158.97920510397, 4169.437125987984, 4170.541240463546, 4182.33082706767, 4076.7961601920083, 4146.91706165875, 4166.854160104382, 4168.145530166309, 4170.520390155126, 3632.3643362411735, 3647.8176091195332, 3649.708023358125, 3660.176460296412, 3661.6887564557046, 5193.2989046479, 5198.272241886101, 5204.479552044765, 5209.0, 5216.843494695166, 4716.080364328957, 4789.185838407444, 4806.375171227753, 4825.565699087064, 4834.033193361307, 5650.067738823089, 5677.347105082927, 5680.829575112753, 5683.829485115453, 5704.600677952545, 3993.5008123984503, 3995.4606128172904, 4006.0585762345827, 4018.799060046986, 4025.2754504189234, 5808.3030036395485, 5978.910316345215, 6013.969930150365, 6022.78920237794, 6029.969850150765, 4094.385842123705, 4117.485314335708, 4130.54563997966, 4133.23535145999, 4150.813213405404, 4179.477565304337, 4181.60274773896, 4199.328107502846, 4202.117555313418, 4202.2646036943415, 4696.66145148631, 4802.567768900815, 4811.4707382187935, 4814.807407703653, 4825.95174048262, 5726.0, 5740.196372507852, 5742.483176514133, 5776.364599894092, 5778.855528611818, 1456.9635759106106, 1465.824101107874, 1474.3733913086894, 1474.6681996550906, 1475.9040662356913, 928.1971095002909, 977.5698692575244, 987.8863930648067, 1009.4851625670814, 1029.7580068683853, 4876.780544875489, 4904.092742842514, 4908.730019848943, 4915.886168947387, 4930.802767889244, 5869.559783016291, 5873.060310350409, 5878.206442130343, 5879.617824841372, 5903.232579764689, 4812.374391329105, 4888.633352498506, 4921.908189019652, 4928.334674818853, 4937.728424936663, 3143.874245030219, 3144.8427578621436, 3157.463231250693, 3161.1148878314107, 3173.571567838312, 5471.480209380103, 5484.7531861066345, 5491.780328786884, 5498.560115190855, 5512.062949298549, 5772.163036359704, 5986.940130598726, 5991.820245392645, 5993.801239752067, 6009.338972712998, 5366.731663416892, 5425.810096646598, 5433.483819037185, 5487.5884308677805, 5511.944880551143, 5775.237489882108, 5804.361520232856, 5845.152452894222, 5873.618214816023, 5895.0, 5726.198332233574, 5730.484256416942, 5744.827655170351, 5757.625754325955, 5759.078547432391, 5459.426760190282, 5461.098918678374, 5461.657981904475, 5479.671219726829, 5506.531944784578, 3832.5400951885954, 4006.5192176938954, 4047.777372244437, 4066.0648050947857, 4171.687123465692, 5893.764249429974, 5919.171316015847, 5919.763209471573, 5929.703514824155, 5941.851453713692, 5626.2685850839125, 5696.743646535999, 5728.369879313355, 5736.4550367715, 5752.597318187854, 5686.834198989114, 5722.227499287543, 5729.3984131665575, 5734.655920644775, 5744.655320680772, 5369.6509726867625, 5612.045952188057, 5627.071533196977, 5640.097584386478, 5677.77288908439, 5498.560115190855, 5634.295713035871, 5723.055695810312, 5727.255456790591, 5729.369769325288, 5532.640378375393, 5537.224788529528, 5547.750351234124, 5552.944470555242, 5580.107182850725], "value": 4266.7932116229695, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [643.6749441532025, 654.1496055128333, 655.1384928818604, 681.5876394781158, 721.1742554774786, 11778.823317650242, 12077.275363478186, 12114.0, 12232.20490668107, 12440.25358478492, 11813.350265735382, 11882.0, 11898.405079746022, 11945.940270298657, 11962.760744785099, 628.4783629587431, 765.7817522006229, 769.6536558548662, 778.622368151446, 794.7059587952466, 786.6460092958163, 787.9724209652663, 788.2590365056857, 790.7034861926777, 791.0862953288961, 811.2739098506833, 813.1461964936822, 816.3591580609223, 822.5393779483509, 823.2138307915926, 814.4339683919678, 815.388458656008, 815.4617952151581, 815.9061707903548, 816.5957850863861, 593.0718425663822, 594.7502049139372, 598.0282041682266, 600.5285850607253, 600.9489193418565, 12803.871961280362, 12819.487220511168, 12827.166234194841, 12880.484780608764, 12902.612921612366, 12775.61673149807, 12847.486100555967, 12868.613941581767, 12991.0, 13335.666608334772, 9411.811763764686, 10013.299069065168, 10119.848202276971, 10336.431496267702, 10354.068133867913, 3233.062411900546, 3243.8053716777067, 3309.7186739127205, 3333.6999670029813, 3411.9488207676904, 42969.785151074044, 44723.55276447226, 45984.0, 46661.53338466606, 46732.5326746735, 9622.422654640744, 9720.659776907916, 9837.409755414697, 9980.550875210633, 10051.949740251252, 16398.508044758677, 16405.1797410129, 16420.507384778237, 16450.848440609043, 16962.49112526626, 6667.333266673294, 6678.465722742169, 6812.761553345609, 6866.725330986705, 6882.311768823178, 3674.3386190485435, 3715.331240376758, 3717.386631205821, 3834.444005619225, 3870.2066076454257, 3039.285767844555, 3239.5464634951127, 3267.9346413071607, 3270.2478429960765, 3275.3449310138067, 563.6871536297313, 563.8477611044995, 568.2186992884783, 570.492261886921, 575.5625724449364, 506.29624821498146, 551.737924485866, 554.9139883318093, 556.7522452508595, 562.7355143082744, 7023.438124949992, 7181.13826340832, 7257.346838784535, 7275.818104547428, 7452.627368631655, 434.7022289731544, 509.80882169186555, 537.3390729402856, 546.5709418106767, 557.2031994248183, 3479.0, 3539.132912436418, 3607.8917632471066, 3754.9812250939117, 3783.754055986352, 50444.20780025892, 50779.49220507748, 51923.48076519262, 52539.53413959856, 52731.472685273424, 45843.54156458459, 46345.30482042772, 46623.30065049027, 46840.7657961708, 46884.7655761719, 40738.38892416616, 40892.18215635671, 42387.364189537184, 42521.36217956733, 42878.57121428808, 6852.794416167523, 6951.478639101986, 6986.580805151707, 7010.824729381806, 7070.328318809705, 29137.7086229135, 29475.410491790473, 29593.0, 30169.547456787728, 30784.53823192699, 39183.80408097941, 39342.803285983384, 39364.803175985086, 39873.806940618546, 39929.40105898356, 8823.250023748053, 8847.159519845862, 9075.0, 9151.679691210775, 9153.86269205949, 9934.801303973736, 9934.850977235203, 10088.344257623232, 10124.291299609251, 10409.219308551737, 8830.602622882114, 8882.067382924959, 9147.77130571741, 9205.355625106178, 9528.61885524599, 9636.71089867305, 9649.662261820802, 9766.169875560658, 9841.114299713061, 9844.212463003087, 9250.861237081584, 9317.813643727222, 9329.440233586007, 9504.47725375111, 9535.904640953779, 7452.0, 7482.962585187257, 7495.325420711944, 7506.28343909419, 7565.205653406313, 7473.140588832136, 7553.131389890233, 7582.924170758442, 7677.923220767944, 7715.1513333534385], "value": 5647.741195997705, "unit": "score"}], "name": "dromaeo_css", "value": 6390.282451092267, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 107.0, 113.0, 113.0, 113.0, 125.0, 113.0, 112.0, 112.0, 114.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 140.0, 168.0, 184.0, 139.0, 164.0, 163.0, 140.0, 190.0, 134.0], "value": 158.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 165.0, 171.0, 165.0, 165.0, 162.0, 164.0, 166.0, 163.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 73.0, 73.0, 161.0, 76.0, 74.0, 74.0, 76.0, 155.0, 80.0], "value": 91.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 152.0, 94.0, 95.0, 94.0, 144.0, 95.0, 94.0, 148.0], "value": 110.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 120.0, 118.0, 118.0, 119.0, 118.0, 117.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 147.0, 148.0, 148.0, 148.0, 148.0, 150.0, 147.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 101.0, 99.0, 96.0, 96.0, 95.0, 96.0, 96.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 64.0, 66.0, 67.0, 64.0, 65.0, 90.0, 63.0, 65.0], "value": 67.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 64.0, 65.0, 65.0, 64.0, 65.0, 65.0, 64.0], "value": 64.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 81.0, 79.0, 79.0, 79.0, 78.0, 82.0, 81.0, 81.0], "value": 80.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 135.0, 135.0, 136.0, 133.0, 133.0, 141.0, 136.0, 174.0, 137.0], "value": 140.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 180.0, 187.0, 176.0, 177.0, 176.0, 175.0, 177.0, 180.0, 176.0], "value": 178.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 70.0, 81.0, 72.0, 72.0, 72.0, 71.0, 75.0, 74.0, 77.0], "value": 73.9, "unit": "score"}], "name": "kraken", "value": 1606.9, "alertThreshold": 2.0}]} 05:08:44 INFO - Return code: 0 05:08:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:08:44 ERROR - # TBPL SUCCESS # 05:08:44 INFO - Running post-action listener: _resource_record_post_action 05:08:44 INFO - Running post-run listener: _resource_record_post_run 05:08:45 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 517373952; Read time: 0; Write time: 955480 05:08:45 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 223236096; Read time: 0; Write time: 430780 05:08:45 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 294023168; Read time: 0; Write time: 524700 05:08:45 INFO - Running post-run listener: _upload_blobber_files 05:08:45 INFO - Blob upload gear active. 05:08:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:08:45 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:45 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:45 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:46 INFO - (blobuploader) - INFO - Open directory for files ... 05:08:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:08:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:08:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:08:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:08:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:08:47 INFO - (blobuploader) - INFO - Done attempting. 05:08:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.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_raw.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 - Iteration through files over. 05:08:48 INFO - Return code: 0 05:08:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:08:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:08:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7a9d908daae122c9b2a1b2fed47645f7f2451de3cfd4cc65e10ffaa023edc9110a03aff2d5a21655543f5953f3ffd9ab3b65acbcf92a6d07d65e0487475b9dc7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3df38c3abb51a9b8906afdf88a6a8892fcda97863a870f226edb18bf7b2433e5f1604bc593661ebc72e68c3f99e07cd2a2a07096f40ac8f37f44d4a64967361c"} 05:08:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:08:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:08:48 INFO - Contents: 05:08:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7a9d908daae122c9b2a1b2fed47645f7f2451de3cfd4cc65e10ffaa023edc9110a03aff2d5a21655543f5953f3ffd9ab3b65acbcf92a6d07d65e0487475b9dc7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3df38c3abb51a9b8906afdf88a6a8892fcda97863a870f226edb18bf7b2433e5f1604bc593661ebc72e68c3f99e07cd2a2a07096f40ac8f37f44d4a64967361c"} 05:08:48 INFO - Running post-run listener: copy_logs_to_upload_dir 05:08:48 INFO - Copying logs to upload dir... 05:08:48 INFO - mkdir: /builds/slave/test/build/upload/logs 05:08:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.629648 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-04-25 05:08:48.722004) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 05:08:48.725101) ========= 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=14ef55db36f7623abb31b9cf000001d5-1461584624.908616-1104941731 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/7a9d908daae122c9b2a1b2fed47645f7f2451de3cfd4cc65e10ffaa023edc9110a03aff2d5a21655543f5953f3ffd9ab3b65acbcf92a6d07d65e0487475b9dc7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3df38c3abb51a9b8906afdf88a6a8892fcda97863a870f226edb18bf7b2433e5f1604bc593661ebc72e68c3f99e07cd2a2a07096f40ac8f37f44d4a64967361c"} 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.011286 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/7a9d908daae122c9b2a1b2fed47645f7f2451de3cfd4cc65e10ffaa023edc9110a03aff2d5a21655543f5953f3ffd9ab3b65acbcf92a6d07d65e0487475b9dc7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3df38c3abb51a9b8906afdf88a6a8892fcda97863a870f226edb18bf7b2433e5f1604bc593661ebc72e68c3f99e07cd2a2a07096f40ac8f37f44d4a64967361c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 05:08:48.751616) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:08:48.751980) ========= 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=14ef55db36f7623abb31b9cf000001d5-1461584624.908616-1104941731 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004419 ========= master_lag: 0.45 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:08:49.209908) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 05:08:49.210207) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 05:08:49.210722) ========= ========= Total master_lag: 0.88 =========