builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-065 starttime: 1461584801.01 results: success (0) buildid: 20160422035709 builduid: 3af33a9a7de54ba3986a82f34ab86caa revision: 80598be5d80e695727ff74e712faa623b02f3c70 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:41.014326) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:41.014672) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:41.015173) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:41.489055) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:41.489334) ========= 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=523ca41ca1e0623de333ad52000001bf-1461584361.115146-403547558 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-25 04:46:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-04-25 04:46:41 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125178 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:41.628885) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:41.629177) ========= 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=523ca41ca1e0623de333ad52000001bf-1461584361.115146-403547558 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019853 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:41.681354) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:41.681646) ========= 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=523ca41ca1e0623de333ad52000001bf-1461584361.115146-403547558 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-25 04:46:41,771 truncating revision to first 12 chars 2016-04-25 04:46:41,771 Setting DEBUG logging. 2016-04-25 04:46:41,771 attempt 1/10 2016-04-25 04:46:41,771 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:46:41,999 unpacking tar archive at: fx-team-80598be5d80e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.510606 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:42.204534) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:42.204825) ========= script_repo_revision: 80598be5d80e695727ff74e712faa623b02f3c70 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:42.205192) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:42.205519) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:42.218418) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-04-25 04:46:42.218689) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1461584361.115146-403547558 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:46:42 INFO - MultiFileLogger online at 20160425 04:46:42 in /builds/slave/test 04:46:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 04:46:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:46:42 INFO - {'append_to_log': False, 04:46:42 INFO - 'base_work_dir': '/builds/slave/test', 04:46:42 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:46:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:46:42 INFO - 'branch': 'Fx-Team-Non-PGO', 04:46:42 INFO - 'buildbot_json_path': 'buildprops.json', 04:46:42 INFO - 'config_files': ('talos/linux_config.py',), 04:46:42 INFO - 'default_actions': ('clobber', 04:46:42 INFO - 'read-buildbot-config', 04:46:42 INFO - 'download-and-extract', 04:46:42 INFO - 'populate-webroot', 04:46:42 INFO - 'create-virtualenv', 04:46:42 INFO - 'install', 04:46:42 INFO - 'run-tests'), 04:46:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:46:42 INFO - 'download_minidump_stackwalk': True, 04:46:42 INFO - 'download_symbols': 'ondemand', 04:46:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:46:42 INFO - 'tooltool.py': '/tools/tooltool.py', 04:46:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:46:42 INFO - '/tools/misc-python/virtualenv.py')}, 04:46:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:46:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:46:42 INFO - 'installer_path': 'installer.exe', 04:46:42 INFO - 'log_level': 'info', 04:46:42 INFO - 'log_name': 'talos', 04:46:42 INFO - 'log_to_console': True, 04:46:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:46:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:46:42 INFO - 'opt_config_files': (), 04:46:42 INFO - 'pip_index': False, 04:46:42 INFO - 'sps_profile': False, 04:46:42 INFO - 'sps_profile_interval': 0, 04:46:42 INFO - 'suite': 'dromaeojs', 04:46:42 INFO - 'system_bits': '32', 04:46:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:46:42 INFO - 'title': 'talos-linux64-ix-065', 04:46:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:46:42 INFO - 'use_talos_json': True, 04:46:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:46:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:46:42 INFO - 'work_dir': 'build'} 04:46:42 INFO - ##### 04:46:42 INFO - ##### Running clobber step. 04:46:42 INFO - ##### 04:46:42 INFO - Running pre-action listener: _resource_record_pre_action 04:46:42 INFO - Running main action method: clobber 04:46:42 INFO - rmtree: /builds/slave/test/build 04:46:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:46:43 INFO - Running post-action listener: _resource_record_post_action 04:46:43 INFO - ##### 04:46:43 INFO - ##### Running read-buildbot-config step. 04:46:43 INFO - ##### 04:46:43 INFO - Running pre-action listener: _resource_record_pre_action 04:46:43 INFO - Running main action method: read_buildbot_config 04:46:43 INFO - Using buildbot properties: 04:46:43 INFO - { 04:46:43 INFO - "project": "", 04:46:43 INFO - "product": "firefox", 04:46:43 INFO - "script_repo_revision": "production", 04:46:43 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:46:43 INFO - "repository": "", 04:46:43 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:46:43 INFO - "buildid": "20160422035709", 04:46:43 INFO - "pgo_build": "False", 04:46:43 INFO - "basedir": "/builds/slave/test", 04:46:43 INFO - "buildnumber": 2880, 04:46:43 INFO - "slavename": "talos-linux64-ix-065", 04:46:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:46:43 INFO - "platform": "ubuntu64_hw", 04:46:43 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:46:43 INFO - "branch": "fx-team", 04:46:43 INFO - "repo_path": "integration/fx-team", 04:46:43 INFO - "revision": "80598be5d80e695727ff74e712faa623b02f3c70", 04:46:43 INFO - "stage_platform": "linux64", 04:46:43 INFO - "builduid": "3af33a9a7de54ba3986a82f34ab86caa", 04:46:43 INFO - "slavebuilddir": "test" 04:46:43 INFO - } 04:46:43 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:46:43 INFO - Running post-action listener: _resource_record_post_action 04:46:43 INFO - ##### 04:46:43 INFO - ##### Running download-and-extract step. 04:46:43 INFO - ##### 04:46:43 INFO - Running pre-action listener: _resource_record_pre_action 04:46:43 INFO - Running main action method: download_and_extract 04:46:43 INFO - mkdir: /builds/slave/test/build/tests 04:46: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:46:43 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:46:43 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:46:43 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:46:43 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:46:43 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:46:52 INFO - Downloaded 1361 bytes. 04:46:52 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:46:52 INFO - Using the following test package requirements: 04:46:52 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:46:52 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:52 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:46:52 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:52 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:46:52 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:52 INFO - u'jsshell-linux-x86_64.zip'], 04:46:52 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:52 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:46:52 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:46:52 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:52 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:46:52 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:52 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:46:52 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:52 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:46:52 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:52 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:46:52 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:46:52 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:46:52 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:46:52 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:46:52 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:46:52 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:46:52 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:46:59 INFO - Downloaded 22281373 bytes. 04:46:59 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:46:59 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:47:00 INFO - Return code: 0 04:47:00 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:47:00 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:47:00 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:47:00 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:47:00 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:47:00 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:47:00 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:47:01 INFO - Downloaded 22281373 bytes. 04:47:01 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:47:01 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:47:02 INFO - Return code: 0 04:47: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:47:02 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:47:02 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:47:02 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:47:02 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:47:02 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:47:03 INFO - Downloaded 10845952 bytes. 04:47:03 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:47:03 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:47:03 INFO - Return code: 0 04:47:03 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:47:03 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:47:03 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:47:03 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:47:03 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:47:03 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:47:06 INFO - Downloaded 54650321 bytes. 04:47:06 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:47:06 INFO - mkdir: /builds/slave/test/properties 04:47:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:47:06 INFO - Writing to file /builds/slave/test/properties/build_url 04:47:06 INFO - Contents: 04:47:06 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:47:06 INFO - Running post-action listener: _resource_record_post_action 04:47:06 INFO - Running post-action listener: set_extra_try_arguments 04:47:06 INFO - ##### 04:47:06 INFO - ##### Running populate-webroot step. 04:47:06 INFO - ##### 04:47:06 INFO - Running pre-action listener: _resource_record_pre_action 04:47:06 INFO - Running main action method: populate_webroot 04:47:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:47:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:47:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:47:06 INFO - '--tppagecycles', 04:47:06 INFO - '7'], 04:47:06 INFO - 'tests': ['tsvgm']}}, 04:47:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:47:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:47:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:47:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:47:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:47:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:47:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:06 INFO - 'talos_options': ['--disable-e10s'], 04:47:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:47:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:47:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:06 INFO - 'talos_options': ['--disable-e10s'], 04:47:06 INFO - 'tests': ['damp', 'tps']}, 04:47:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:06 INFO - 'tests': ['damp', 'tps']}, 04:47:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:47:06 INFO - 'tests': ['dromaeo_dom']}, 04:47:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:47:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:47:06 INFO - 'tests': ['a11yr', 04:47:06 INFO - 'ts_paint', 04:47:06 INFO - 'tpaint', 04:47:06 INFO - 'sessionrestore', 04:47:06 INFO - 'sessionrestore_no_auto_restore', 04:47:06 INFO - 'tabpaint']}, 04:47:06 INFO - 'other-e10s': {'tests': ['a11yr', 04:47:06 INFO - 'ts_paint', 04:47:06 INFO - 'tpaint', 04:47:06 INFO - 'sessionrestore', 04:47:06 INFO - 'sessionrestore_no_auto_restore', 04:47:06 INFO - 'tabpaint']}, 04:47:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:47:06 INFO - 'ts_paint', 04:47:06 INFO - 'tpaint', 04:47:06 INFO - 'sessionrestore', 04:47:06 INFO - 'sessionrestore_no_auto_restore', 04:47:06 INFO - 'tabpaint']}, 04:47:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:47:06 INFO - 'ts_paint', 04:47:06 INFO - 'tpaint', 04:47:06 INFO - 'sessionrestore', 04:47:06 INFO - 'sessionrestore_no_auto_restore', 04:47:06 INFO - 'tabpaint']}, 04:47:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:47:06 INFO - 'tests': ['a11yr', 04:47:06 INFO - 'ts_paint', 04:47:06 INFO - 'tpaint', 04:47:06 INFO - 'sessionrestore', 04:47:06 INFO - 'sessionrestore_no_auto_restore', 04:47:06 INFO - 'tabpaint']}, 04:47:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:47:06 INFO - 'tests': ['a11yr', 04:47:06 INFO - 'ts_paint', 04:47:06 INFO - 'tpaint', 04:47:06 INFO - 'sessionrestore', 04:47:06 INFO - 'sessionrestore_no_auto_restore', 04:47:06 INFO - 'tabpaint']}, 04:47:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:47:06 INFO - 'tests': ['tsvgx', 04:47:06 INFO - 'tsvgr_opacity', 04:47:06 INFO - 'tart', 04:47:06 INFO - 'tscrollx', 04:47:06 INFO - 'cart']}, 04:47:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:47:06 INFO - 'tsvgr_opacity', 04:47:06 INFO - 'tart', 04:47:06 INFO - 'tscrollx', 04:47:06 INFO - 'cart']}, 04:47:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:06 INFO - 'talos_options': ['--disable-e10s'], 04:47:06 INFO - 'tests': ['tp5o']}, 04:47:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:06 INFO - 'tests': ['tp5o']}, 04:47:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:06 INFO - 'talos_options': ['--disable-e10s', 04:47:06 INFO - '--xperf_path', 04:47:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:47:06 INFO - 'tests': ['tp5n']}, 04:47:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:06 INFO - 'talos_options': ['--xperf_path', 04:47:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:47:06 INFO - 'tests': ['tp5n']}}, 04:47:06 INFO - 'talos.zip': {'path': '', 04:47:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:47:06 INFO - Running post-action listener: _resource_record_post_action 04:47:06 INFO - ##### 04:47:06 INFO - ##### Running create-virtualenv step. 04:47:06 INFO - ##### 04:47:06 INFO - Running pre-action listener: _resource_record_pre_action 04:47:06 INFO - Running main action method: create_virtualenv 04:47:06 INFO - Creating virtualenv /builds/slave/test/build/venv 04:47:06 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:47:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:47:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:47:06 INFO - Using real prefix '/usr' 04:47:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:47:07 INFO - Installing distribute.............................................................................................................................................................................................done. 04:47:09 INFO - Installing pip.................done. 04:47:09 INFO - Return code: 0 04:47:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:47:09 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:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:09 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:47:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:09 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 0x7f75f52baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21585a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e7410>, '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 0x21e8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e87a0>, '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': '523ca41ca1e0623de333ad52000001bf-1461584361.115146-403547558', '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:47:09 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:47:09 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:47:09 INFO - Using env: {'DISPLAY': ':0', 04:47:09 INFO - 'HOME': '/home/cltbld', 04:47:09 INFO - 'LANG': 'en_US.UTF-8', 04:47:09 INFO - 'LANGUAGE': 'en_US:en', 04:47:09 INFO - 'LOGNAME': 'cltbld', 04:47:09 INFO - 'MAIL': '/var/mail/cltbld', 04:47:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:09 INFO - 'MOZ_NO_REMOTE': '1', 04:47:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:09 INFO - 'NO_EM_RESTART': '1', 04:47:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:09 INFO - 'PWD': '/builds/slave/test', 04:47:09 INFO - 'SHELL': '/bin/bash', 04:47:09 INFO - 'SHLVL': '1', 04:47:09 INFO - 'TERM': 'linux', 04:47:09 INFO - 'TMOUT': '86400', 04:47:09 INFO - 'USER': 'cltbld', 04:47:09 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461584361.115146-403547558', 04:47:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:09 INFO - '_': '/tools/buildbot/bin/python'} 04:47:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:09 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:47:09 INFO - Cleaning up... 04:47:09 INFO - Return code: 0 04:47:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:47:09 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:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:09 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:47:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:09 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 0x7f75f52baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21585a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e7410>, '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 0x21e8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e87a0>, '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': '523ca41ca1e0623de333ad52000001bf-1461584361.115146-403547558', '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:47:09 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:47:09 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:47:09 INFO - Using env: {'DISPLAY': ':0', 04:47:09 INFO - 'HOME': '/home/cltbld', 04:47:09 INFO - 'LANG': 'en_US.UTF-8', 04:47:09 INFO - 'LANGUAGE': 'en_US:en', 04:47:09 INFO - 'LOGNAME': 'cltbld', 04:47:09 INFO - 'MAIL': '/var/mail/cltbld', 04:47:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:09 INFO - 'MOZ_NO_REMOTE': '1', 04:47:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:09 INFO - 'NO_EM_RESTART': '1', 04:47:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:09 INFO - 'PWD': '/builds/slave/test', 04:47:09 INFO - 'SHELL': '/bin/bash', 04:47:09 INFO - 'SHLVL': '1', 04:47:09 INFO - 'TERM': 'linux', 04:47:09 INFO - 'TMOUT': '86400', 04:47:09 INFO - 'USER': 'cltbld', 04:47:09 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461584361.115146-403547558', 04:47:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:09 INFO - '_': '/tools/buildbot/bin/python'} 04:47:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:09 INFO - Downloading/unpacking psutil>=0.7.1 04:47:09 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:47:09 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:47:09 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:47:09 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:47:09 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:47:09 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:47:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:47:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:47:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:47:11 INFO - Installing collected packages: psutil 04:47:11 INFO - Running setup.py install for psutil 04:47:11 INFO - building 'psutil._psutil_linux' extension 04:47:11 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:47:12 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:47:12 INFO - building 'psutil._psutil_posix' extension 04:47:12 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:47:12 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:47:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:47:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:47:12 INFO - Successfully installed psutil 04:47:12 INFO - Cleaning up... 04:47:12 INFO - Return code: 0 04:47:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:47:12 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:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:12 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:47:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:12 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 0x7f75f52baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21585a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e7410>, '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 0x21e8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e87a0>, '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': '523ca41ca1e0623de333ad52000001bf-1461584361.115146-403547558', '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:47:12 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:47:12 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:47:12 INFO - Using env: {'DISPLAY': ':0', 04:47:12 INFO - 'HOME': '/home/cltbld', 04:47:12 INFO - 'LANG': 'en_US.UTF-8', 04:47:12 INFO - 'LANGUAGE': 'en_US:en', 04:47:12 INFO - 'LOGNAME': 'cltbld', 04:47:12 INFO - 'MAIL': '/var/mail/cltbld', 04:47:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:12 INFO - 'MOZ_NO_REMOTE': '1', 04:47:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:12 INFO - 'NO_EM_RESTART': '1', 04:47:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:12 INFO - 'PWD': '/builds/slave/test', 04:47:12 INFO - 'SHELL': '/bin/bash', 04:47:12 INFO - 'SHLVL': '1', 04:47:12 INFO - 'TERM': 'linux', 04:47:12 INFO - 'TMOUT': '86400', 04:47:12 INFO - 'USER': 'cltbld', 04:47:12 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461584361.115146-403547558', 04:47:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:12 INFO - '_': '/tools/buildbot/bin/python'} 04:47:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:47:12 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:47:12 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:47:12 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:47:12 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:47:12 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:47:12 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:47:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:47:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:47:14 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:47:14 INFO - Installing collected packages: mozsystemmonitor 04:47:14 INFO - Running setup.py install for mozsystemmonitor 04:47:14 INFO - Successfully installed mozsystemmonitor 04:47:14 INFO - Cleaning up... 04:47:14 INFO - Return code: 0 04:47:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:47:14 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:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:14 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:47:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:14 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 0x7f75f52baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21585a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e7410>, '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 0x21e8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e87a0>, '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': '523ca41ca1e0623de333ad52000001bf-1461584361.115146-403547558', '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:47:14 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:47:14 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:47:14 INFO - Using env: {'DISPLAY': ':0', 04:47:14 INFO - 'HOME': '/home/cltbld', 04:47:14 INFO - 'LANG': 'en_US.UTF-8', 04:47:14 INFO - 'LANGUAGE': 'en_US:en', 04:47:14 INFO - 'LOGNAME': 'cltbld', 04:47:14 INFO - 'MAIL': '/var/mail/cltbld', 04:47:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:14 INFO - 'MOZ_NO_REMOTE': '1', 04:47:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:14 INFO - 'NO_EM_RESTART': '1', 04:47:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:14 INFO - 'PWD': '/builds/slave/test', 04:47:14 INFO - 'SHELL': '/bin/bash', 04:47:14 INFO - 'SHLVL': '1', 04:47:14 INFO - 'TERM': 'linux', 04:47:14 INFO - 'TMOUT': '86400', 04:47:14 INFO - 'USER': 'cltbld', 04:47:14 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461584361.115146-403547558', 04:47:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:14 INFO - '_': '/tools/buildbot/bin/python'} 04:47:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:14 INFO - Downloading/unpacking blobuploader==1.2.4 04:47:14 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:47:14 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:47:14 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:47:14 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:47:14 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:47:14 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:47:16 INFO - Downloading blobuploader-1.2.4.tar.gz 04:47:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:47:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:47:16 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:47:16 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:47:16 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:47:16 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:47:16 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:47:16 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:47:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:47:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:47:17 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:47:17 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:47:17 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:47:17 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:47:17 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:47:17 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:47:17 INFO - Downloading docopt-0.6.1.tar.gz 04:47:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:47:17 INFO - Installing collected packages: blobuploader, requests, docopt 04:47:17 INFO - Running setup.py install for blobuploader 04:47:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:47:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:47:17 INFO - Running setup.py install for requests 04:47:17 INFO - Running setup.py install for docopt 04:47:18 INFO - Successfully installed blobuploader requests docopt 04:47:18 INFO - Cleaning up... 04:47:18 INFO - Return code: 0 04:47:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:47: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:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47: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:47:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:18 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 0x7f75f52baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21585a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e7410>, '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 0x21e8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e87a0>, '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': '523ca41ca1e0623de333ad52000001bf-1461584361.115146-403547558', '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:47:18 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:47:18 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:47:18 INFO - Using env: {'DISPLAY': ':0', 04:47:18 INFO - 'HOME': '/home/cltbld', 04:47:18 INFO - 'LANG': 'en_US.UTF-8', 04:47:18 INFO - 'LANGUAGE': 'en_US:en', 04:47:18 INFO - 'LOGNAME': 'cltbld', 04:47:18 INFO - 'MAIL': '/var/mail/cltbld', 04:47:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:18 INFO - 'MOZ_NO_REMOTE': '1', 04:47:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:18 INFO - 'NO_EM_RESTART': '1', 04:47:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:18 INFO - 'PWD': '/builds/slave/test', 04:47:18 INFO - 'SHELL': '/bin/bash', 04:47:18 INFO - 'SHLVL': '1', 04:47:18 INFO - 'TERM': 'linux', 04:47:18 INFO - 'TMOUT': '86400', 04:47:18 INFO - 'USER': 'cltbld', 04:47:18 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461584361.115146-403547558', 04:47:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:18 INFO - '_': '/tools/buildbot/bin/python'} 04:47:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:47:18 INFO - Running setup.py (path:/tmp/pip-GSPzgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:47:18 INFO - Running setup.py (path:/tmp/pip-WB1YFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:47:18 INFO - Running setup.py (path:/tmp/pip-2blSW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:47:18 INFO - Running setup.py (path:/tmp/pip-1jRAL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:47:18 INFO - Running setup.py (path:/tmp/pip-U3TKOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:47:18 INFO - Running setup.py (path:/tmp/pip-iAZiOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:47:18 INFO - Running setup.py (path:/tmp/pip-d11cC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:47:18 INFO - Running setup.py (path:/tmp/pip-drbzmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:47:18 INFO - Running setup.py (path:/tmp/pip-61XNjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:47:18 INFO - Running setup.py (path:/tmp/pip-BJ9M1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:47:19 INFO - Running setup.py (path:/tmp/pip-39c7cq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:47:19 INFO - Running setup.py (path:/tmp/pip-bnPZE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:47:19 INFO - Running setup.py (path:/tmp/pip-XNCpez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:47:19 INFO - Running setup.py (path:/tmp/pip-yxq2nH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:19 INFO - Running setup.py (path:/tmp/pip-YFbBmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:47:19 INFO - Running setup.py (path:/tmp/pip-SEzz39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:47:19 INFO - Running setup.py (path:/tmp/pip-YmF4zx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:47:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:47:19 INFO - Running setup.py install for manifestparser 04:47:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:47:19 INFO - Running setup.py install for mozcrash 04:47:19 INFO - Running setup.py install for mozdebug 04:47:19 INFO - Running setup.py install for mozdevice 04:47:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:47:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:47:19 INFO - Running setup.py install for mozfile 04:47:20 INFO - Running setup.py install for mozhttpd 04:47:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:47:20 INFO - Running setup.py install for mozinfo 04:47:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:47:20 INFO - Running setup.py install for mozInstall 04:47:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:47:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:47:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:47:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:47:20 INFO - Running setup.py install for mozleak 04:47:20 INFO - Running setup.py install for mozlog 04:47:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:47:20 INFO - Running setup.py install for moznetwork 04:47:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:47:20 INFO - Running setup.py install for mozprocess 04:47:20 INFO - Running setup.py install for mozprofile 04:47:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:47:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:47:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:47:20 INFO - Running setup.py install for mozrunner 04:47:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:47:20 INFO - Running setup.py install for mozscreenshot 04:47:21 INFO - Running setup.py install for moztest 04:47:21 INFO - Running setup.py install for mozversion 04:47:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:47:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:47:21 INFO - Cleaning up... 04:47:21 INFO - Return code: 0 04:47:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:47:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:21 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 0x7f75f52baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21585a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e7410>, '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 0x21e8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e87a0>, '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': '523ca41ca1e0623de333ad52000001bf-1461584361.115146-403547558', '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:47:21 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:47:21 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:47:21 INFO - Using env: {'DISPLAY': ':0', 04:47:21 INFO - 'HOME': '/home/cltbld', 04:47:21 INFO - 'LANG': 'en_US.UTF-8', 04:47:21 INFO - 'LANGUAGE': 'en_US:en', 04:47:21 INFO - 'LOGNAME': 'cltbld', 04:47:21 INFO - 'MAIL': '/var/mail/cltbld', 04:47:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:21 INFO - 'MOZ_NO_REMOTE': '1', 04:47:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:21 INFO - 'NO_EM_RESTART': '1', 04:47:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:21 INFO - 'PWD': '/builds/slave/test', 04:47:21 INFO - 'SHELL': '/bin/bash', 04:47:21 INFO - 'SHLVL': '1', 04:47:21 INFO - 'TERM': 'linux', 04:47:21 INFO - 'TMOUT': '86400', 04:47:21 INFO - 'USER': 'cltbld', 04:47:21 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461584361.115146-403547558', 04:47:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:21 INFO - '_': '/tools/buildbot/bin/python'} 04:47:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:47:21 INFO - Running setup.py (path:/tmp/pip-lCWc9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:47:21 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:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:47:21 INFO - Running setup.py (path:/tmp/pip-wiOhgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:47:21 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:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:47:21 INFO - Running setup.py (path:/tmp/pip-5IKLvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:47:21 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:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:47:21 INFO - Running setup.py (path:/tmp/pip-2jx41G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:47:21 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:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:47:21 INFO - Running setup.py (path:/tmp/pip-uvZ8ZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:47:21 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:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:47:21 INFO - Running setup.py (path:/tmp/pip-kd19jg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:47:21 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:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:47:21 INFO - Running setup.py (path:/tmp/pip-0QAsKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:47:22 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:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:47:22 INFO - Running setup.py (path:/tmp/pip-Y7RYZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:47:22 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:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:47:22 INFO - Running setup.py (path:/tmp/pip-M30b_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:47:22 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:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:47:22 INFO - Running setup.py (path:/tmp/pip-IwRzcc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:47:22 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:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:47:22 INFO - Running setup.py (path:/tmp/pip-1rgWkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:47:22 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:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:47:22 INFO - Running setup.py (path:/tmp/pip-vO00AT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:47:22 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:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:47:22 INFO - Running setup.py (path:/tmp/pip-Owl4g4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:47:22 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:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:47:22 INFO - Running setup.py (path:/tmp/pip-qLry6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:47:22 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:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:22 INFO - Running setup.py (path:/tmp/pip-hUkytg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:22 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:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:47:22 INFO - Running setup.py (path:/tmp/pip-d4gT1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:47:22 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:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:47:22 INFO - Running setup.py (path:/tmp/pip-X0a0uU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:47:22 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:47:22 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:47:22 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:47:22 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:47:22 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:47:22 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:47:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:47:22 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:47:22 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:47:22 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:47:22 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:47:22 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:47:22 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:47:24 INFO - Downloading blessings-1.6.tar.gz 04:47:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:47:24 INFO - Installing collected packages: blessings 04:47:24 INFO - Running setup.py install for blessings 04:47:24 INFO - Successfully installed blessings 04:47:24 INFO - Cleaning up... 04:47:24 INFO - Return code: 0 04:47:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:47:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:47:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:47:25 INFO - Reading from file tmpfile_stdout 04:47:25 INFO - Current package versions: 04:47:25 INFO - argparse == 1.2.1 04:47:25 INFO - blessings == 1.6 04:47:25 INFO - blobuploader == 1.2.4 04:47:25 INFO - docopt == 0.6.1 04:47:25 INFO - manifestparser == 1.1 04:47:25 INFO - mozInstall == 1.12 04:47:25 INFO - mozcrash == 0.17 04:47:25 INFO - mozdebug == 0.1 04:47:25 INFO - mozdevice == 0.48 04:47:25 INFO - mozfile == 1.2 04:47:25 INFO - mozhttpd == 0.7 04:47:25 INFO - mozinfo == 0.9 04:47:25 INFO - mozleak == 0.1 04:47:25 INFO - mozlog == 3.1 04:47:25 INFO - moznetwork == 0.27 04:47:25 INFO - mozprocess == 0.22 04:47:25 INFO - mozprofile == 0.28 04:47:25 INFO - mozrunner == 6.11 04:47:25 INFO - mozscreenshot == 0.1 04:47:25 INFO - mozsystemmonitor == 0.0 04:47:25 INFO - moztest == 0.7 04:47:25 INFO - mozversion == 1.4 04:47:25 INFO - psutil == 3.1.1 04:47:25 INFO - requests == 1.2.3 04:47:25 INFO - wsgiref == 0.1.2 04:47:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:47:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:25 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 0x7f75f52baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21585a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e7410>, '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 0x21e8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e87a0>, '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': '523ca41ca1e0623de333ad52000001bf-1461584361.115146-403547558', '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:47:25 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:47:25 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:47:25 INFO - Using env: {'DISPLAY': ':0', 04:47:25 INFO - 'HOME': '/home/cltbld', 04:47:25 INFO - 'LANG': 'en_US.UTF-8', 04:47:25 INFO - 'LANGUAGE': 'en_US:en', 04:47:25 INFO - 'LOGNAME': 'cltbld', 04:47:25 INFO - 'MAIL': '/var/mail/cltbld', 04:47:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:25 INFO - 'MOZ_NO_REMOTE': '1', 04:47:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:25 INFO - 'NO_EM_RESTART': '1', 04:47:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:25 INFO - 'PWD': '/builds/slave/test', 04:47:25 INFO - 'SHELL': '/bin/bash', 04:47:25 INFO - 'SHLVL': '1', 04:47:25 INFO - 'TERM': 'linux', 04:47:25 INFO - 'TMOUT': '86400', 04:47:25 INFO - 'USER': 'cltbld', 04:47:25 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461584361.115146-403547558', 04:47:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:25 INFO - '_': '/tools/buildbot/bin/python'} 04:47:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:25 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:47:25 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:47:25 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:47:25 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:47:25 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:47:25 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:47:25 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:47:25 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:47:25 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:47:25 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:47:25 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:47:25 INFO - Cleaning up... 04:47:25 INFO - Return code: 0 04:47:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:47:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f75f52baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21585a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e7410>, '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 0x21e8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e87a0>, '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': '523ca41ca1e0623de333ad52000001bf-1461584361.115146-403547558', '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:47: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', 'jsonschema'] in /builds/slave/test/build 04:47: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 jsonschema 04:47:25 INFO - Using env: {'DISPLAY': ':0', 04:47:25 INFO - 'HOME': '/home/cltbld', 04:47:25 INFO - 'LANG': 'en_US.UTF-8', 04:47:25 INFO - 'LANGUAGE': 'en_US:en', 04:47:25 INFO - 'LOGNAME': 'cltbld', 04:47:25 INFO - 'MAIL': '/var/mail/cltbld', 04:47:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:25 INFO - 'MOZ_NO_REMOTE': '1', 04:47:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:25 INFO - 'NO_EM_RESTART': '1', 04:47:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:25 INFO - 'PWD': '/builds/slave/test', 04:47:25 INFO - 'SHELL': '/bin/bash', 04:47:25 INFO - 'SHLVL': '1', 04:47:25 INFO - 'TERM': 'linux', 04:47:25 INFO - 'TMOUT': '86400', 04:47:25 INFO - 'USER': 'cltbld', 04:47:25 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461584361.115146-403547558', 04:47:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:25 INFO - '_': '/tools/buildbot/bin/python'} 04:47:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:25 INFO - Downloading/unpacking jsonschema 04:47: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:47: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:47: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:47: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:47: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:47: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:47:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:47:27 INFO - Downloading/unpacking functools32 (from jsonschema) 04:47:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:27 INFO - Downloading functools32-3.2.3-2.tar.gz 04:47:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:47:27 INFO - warning: no files found matching '*.txt' 04:47:27 INFO - no previously-included directories found matching 'build' 04:47:27 INFO - no previously-included directories found matching 'dist' 04:47:27 INFO - no previously-included directories found matching '.git*' 04:47:27 INFO - Installing collected packages: jsonschema, functools32 04:47:27 INFO - Running setup.py install for functools32 04:47:27 INFO - warning: no files found matching '*.txt' 04:47:27 INFO - no previously-included directories found matching 'build' 04:47:27 INFO - no previously-included directories found matching 'dist' 04:47:27 INFO - no previously-included directories found matching '.git*' 04:47:27 INFO - Successfully installed jsonschema functools32 04:47:27 INFO - Cleaning up... 04:47:27 INFO - Return code: 0 04:47:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:47: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:47:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47: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:47:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f75f52baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21585a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e7410>, '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 0x21e8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e87a0>, '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': '523ca41ca1e0623de333ad52000001bf-1461584361.115146-403547558', '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:47: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', 'flake8'] in /builds/slave/test/build 04:47: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 flake8 04:47:27 INFO - Using env: {'DISPLAY': ':0', 04:47:27 INFO - 'HOME': '/home/cltbld', 04:47:27 INFO - 'LANG': 'en_US.UTF-8', 04:47:27 INFO - 'LANGUAGE': 'en_US:en', 04:47:27 INFO - 'LOGNAME': 'cltbld', 04:47:27 INFO - 'MAIL': '/var/mail/cltbld', 04:47:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:27 INFO - 'MOZ_NO_REMOTE': '1', 04:47:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:27 INFO - 'NO_EM_RESTART': '1', 04:47:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:27 INFO - 'PWD': '/builds/slave/test', 04:47:27 INFO - 'SHELL': '/bin/bash', 04:47:27 INFO - 'SHLVL': '1', 04:47:27 INFO - 'TERM': 'linux', 04:47:27 INFO - 'TMOUT': '86400', 04:47:27 INFO - 'USER': 'cltbld', 04:47:27 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461584361.115146-403547558', 04:47:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:27 INFO - '_': '/tools/buildbot/bin/python'} 04:47:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:28 INFO - Downloading/unpacking flake8 04:47: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:47: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:47: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:47: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:47: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:47: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:47:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:47:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:47:29 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:47:29 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:47:29 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:47:29 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:47:29 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:47:29 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:47:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:47:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:47: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:47: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:47: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:47: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:47: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:47: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:47:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:47: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:47: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:47: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:47: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:47: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:47: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:47:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:47:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:47:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:47:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:47:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:47:30 INFO - no previously-included directories found matching 'docs/_build' 04:47:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:47:30 INFO - Running setup.py install for pep8 04:47:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:47:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:47:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:47:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:47:30 INFO - no previously-included directories found matching 'docs/_build' 04:47:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:47:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:47:30 INFO - Cleaning up... 04:47:30 INFO - Return code: 0 04:47:30 INFO - Running post-action listener: _resource_record_post_action 04:47:30 INFO - Running post-action listener: _start_resource_monitoring 04:47:30 INFO - Starting resource monitoring. 04:47:30 INFO - ##### 04:47:30 INFO - ##### Running install step. 04:47:30 INFO - ##### 04:47:30 INFO - Running pre-action listener: _resource_record_pre_action 04:47:30 INFO - Running main action method: install 04:47:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:47:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:47:31 INFO - Reading from file tmpfile_stdout 04:47:31 INFO - Detecting whether we're running mozinstall >=1.0... 04:47:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:47:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:47:31 INFO - Reading from file tmpfile_stdout 04:47:31 INFO - Output received: 04:47:31 INFO - Usage: mozinstall [options] installer 04:47:31 INFO - Options: 04:47:31 INFO - -h, --help show this help message and exit 04:47:31 INFO - -d DEST, --destination=DEST 04:47:31 INFO - Directory to install application into. [default: 04:47:31 INFO - "/builds/slave/test"] 04:47:31 INFO - --app=APP Application being installed. [default: firefox] 04:47:31 INFO - mkdir: /builds/slave/test/build/application 04:47:31 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:47:31 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:47:46 INFO - Reading from file tmpfile_stdout 04:47:46 INFO - Output received: 04:47:46 INFO - /builds/slave/test/build/application/firefox/firefox 04:47:46 INFO - Running post-action listener: _resource_record_post_action 04:47:46 INFO - ##### 04:47:46 INFO - ##### Running run-tests step. 04:47:46 INFO - ##### 04:47:46 INFO - Running pre-action listener: _resource_record_pre_action 04:47:46 INFO - Running main action method: run_tests 04:47:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:47:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:47:46 INFO - Python 2.7.3 04:47:46 INFO - Return code: 0 04:47:46 INFO - grabbing minidump binary from tooltool 04:47:46 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:47:46 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 0x21e7410>, '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 0x21e8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e87a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:47:46 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:47:46 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:47:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:47:46 INFO - Return code: 0 04:47:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:47:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:47:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:47:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:47:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:47:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:47:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:47:48 INFO - Return code: 0 04:47:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:47:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:47:48 INFO - Using env: {'DISPLAY': ':0', 04:47:48 INFO - 'HOME': '/home/cltbld', 04:47:48 INFO - 'LANG': 'en_US.UTF-8', 04:47:48 INFO - 'LANGUAGE': 'en_US:en', 04:47:48 INFO - 'LOGNAME': 'cltbld', 04:47:48 INFO - 'MAIL': '/var/mail/cltbld', 04:47:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:47:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:47:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:48 INFO - 'MOZ_NO_REMOTE': '1', 04:47:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:47:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:48 INFO - 'NO_EM_RESTART': '1', 04:47:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:48 INFO - 'PWD': '/builds/slave/test', 04:47:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:47:48 INFO - 'SHELL': '/bin/bash', 04:47:48 INFO - 'SHLVL': '1', 04:47:48 INFO - 'TERM': 'linux', 04:47:48 INFO - 'TMOUT': '86400', 04:47:48 INFO - 'USER': 'cltbld', 04:47:48 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461584361.115146-403547558', 04:47:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:48 INFO - '_': '/tools/buildbot/bin/python'} 04:47:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:47:48 INFO - mozversion application_buildid: 20160422035709 04:47:48 INFO - mozversion application_changeset: 80598be5d80e695727ff74e712faa623b02f3c70 04:47:48 INFO - mozversion application_display_name: Nightly 04:47:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:47:48 INFO - mozversion application_name: Firefox 04:47:48 INFO - mozversion application_remotingname: firefox 04:47:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:47:48 INFO - mozversion application_vendor: Mozilla 04:47:48 INFO - mozversion application_version: 48.0a1 04:47:48 INFO - mozversion platform_buildid: 20160422035709 04:47:48 INFO - mozversion platform_changeset: 80598be5d80e695727ff74e712faa623b02f3c70 04:47:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:47:48 INFO - mozversion platform_version: 48.0a1 04:47:48 INFO - using testdate: 1461584868 04:47:48 INFO - actual date: 1461584868 04:47:48 INFO - starting webserver on 'localhost:56446' 04:47:48 INFO - SUITE-START | Running 2 tests 04:47:48 INFO - TEST-START | dromaeo_css 04:47:48 INFO - operating with platform_type : linux_ 04:47:48 INFO - Initialising browser for dromaeo_css test... 04:47:48 INFO - TEST-INFO | started process 12762 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_nO1w7/profile http://localhost:56446/getInfo.html) 04:47:52 INFO - PROCESS | 12762 | __metrics Screen width/height:1600/1200 04:47:52 INFO - PROCESS | 12762 | colorDepth:24 04:47:52 INFO - PROCESS | 12762 | Browser inner width/height: 1024/697 04:47:52 INFO - PROCESS | 12762 | __metrics 04:47:53 ERROR - PROCESS | 12762 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:47:54 INFO - TEST-INFO | 12762: exit 0 04:47:54 INFO - Browser initialized. 04:47:54 INFO - Running cycle 1/1 for dromaeo_css test... 04:47:54 INFO - TEST-INFO | started process 12843 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_nO1w7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:48:06 INFO - PROCESS | 12843 | RSS: Main: 155639808 04:48:06 INFO - PROCESS | 12843 | 04:48:57 INFO - PROCESS | 12843 | 1461584937933 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:51:09 INFO - PROCESS | 12843 | Cycle 1(1): loaded http://localhost:56446/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56446/tests/dromaeo/cssquery-ext.html) 04:51:10 INFO - PROCESS | 12843 | RSS: Main: 266932224 04:51:10 INFO - PROCESS | 12843 | 04:54:13 INFO - PROCESS | 12843 | Cycle 1(1): loaded http://localhost:56446/tests/dromaeo/cssquery-ext.html (next: http://localhost:56446/tests/dromaeo/cssquery-jquery.html) 04:54:13 INFO - PROCESS | 12843 | RSS: Main: 244236288 04:54:13 INFO - PROCESS | 12843 | 04:57:15 INFO - PROCESS | 12843 | Cycle 1(1): loaded http://localhost:56446/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56446/tests/dromaeo/cssquery-mootools.html) 04:57:16 INFO - PROCESS | 12843 | RSS: Main: 243650560 04:57:16 INFO - PROCESS | 12843 | 05:00:18 INFO - PROCESS | 12843 | Cycle 1(1): loaded http://localhost:56446/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56446/tests/dromaeo/cssquery-prototype.html) 05:00:19 INFO - PROCESS | 12843 | RSS: Main: 233988096 05:00:19 INFO - PROCESS | 12843 | 05:03:22 INFO - PROCESS | 12843 | Cycle 1(1): loaded http://localhost:56446/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56446/tests/dromaeo/cssquery-yui.html) 05:03:22 INFO - PROCESS | 12843 | RSS: Main: 215203840 05:03:22 INFO - PROCESS | 12843 | 05:06:25 INFO - PROCESS | 12843 | Cycle 1(1): loaded http://localhost:56446/tests/dromaeo/cssquery-yui.html (next: http://localhost:56446/tests/dromaeo/cssquery-dojo.html) 05:06:25 INFO - PROCESS | 12843 | RSS: Main: 244248576 05:06:25 INFO - PROCESS | 12843 | 05:06:25 INFO - PROCESS | 12843 | __start_tp_report 05:06:25 INFO - PROCESS | 12843 | _x_x_mozilla_page_load 05:06:25 INFO - PROCESS | 12843 | _x_x_mozilla_page_load_details 05:06:25 INFO - PROCESS | 12843 | |i|pagename|runs| 05:06:25 INFO - PROCESS | 12843 | |0;dojo.html;2579.200447861163;2663.493936152131;2668.57302831547;2684.7986401019916;2706.499297629938;4492.505824359326;4599.586037256646;4641.767911604419;4642.419697537808;4654.743989080599;4697.1075495655805;4719.952800471994;4732.029933863559;4815.614750819935;4831.323614693937;4247.171801498709;4251.638610718092;4310.913781724364;4380.3210502372185;4412.470503539564;4332.06860524987;4384.320430333303;4394.956050439487;4408.515063343029;4450.020995381027;4193.622573968358;4273.166732487166;4299.806508707115;4299.849505267301;4378.956210437918;4320.6327462165755;4346.15250026245;4359.128174365108;4361.563843615613;4404.14119246747;4293.29160688486;4298.054428025861;4305.50486694031;4332.025294308787;4357.542458041891;4496.190685676577;4550.158220729176;4576.977115114437;4608.976955115237;4638.9536104638855;5023.79904803811;5025.14572522672;5026.949730502722;5034.723090230036;5060.2662613920775;5031.597472202252;5044.445111037783;5051.292819005343;5061.139606266944;5097.133487307166;4592.265237562007;4685.226937555333;4771.5228477152;4772.95227047732;4778.259369797617;5204.479552044765;5205;5208.114620514521;5211.088059589557;5217.686938783685;4983.501649834988;4997.650164488524;4999.65002449825;5006.949930500648;5051.090803655377;4907.484714104968;5008;5060.468650791688;5100.923486147711;5103.387593488805;5004;5029.069622119846;5040.344755181803;5040.59675225981;5093.796248150033;5007.824726134568;5010.949890501121;5011.498850114959;5020.096382651085;5024.824131155392;4139.4204811326435;4206.621404073648;4208.705390622688;4228.1966426378885;4301.0537681709975;3668.3580373434543;3672.8530858765885;3679.8528058877346;3716.7955762433326;3736.925261494755;4297.699161058696;4300.139972005549;4301.827926882952;4339.804708788112;4348.717333373321;4962.652614316963;4976.253561965734;5014.949850501448;5054.241863720398;5086.694798312114;4289.335153051282;4292.399064131024;4295.82816687329;4331.740095594275;4346.043870348518;4474.105178964221;4474.664400170001;4476.888077798016;4480.081583275486;4515.187266292033;4557.407537020233;4719.268513380432;4772.761361931959;4792.640551958547;4807.543283388072;5051.924221136613;5074.340335756328;5084.135696931605;5085.796568137233;5135.204043373283;4774.40319960005;4787.688800227974;4792.400949881265;4794.089123066607;4838.153323168361;4809.807607695653;4862.246351815475;4940.975295123645;4941.555260026615;4949.430815456269;5048.368953880765;5054.82308119214;5070.721110338966;5078.21287700407;5123.462036486264;4905.043516514245;4909.926351104665;4912.8771780705765;4926.310316555613;4928.901421971469;4740.928886066781;4885.926711099408;4896.11869863428;4950.579200767975;4975;4830.6135509159885;4848.0788650156355;4852.296417019583;4864;4880.951190488192;4785.641076919175;4971.453140154653;4971.676841005323;4978.228374601942;5034.521720436553;4738.502457242078;4785.138675038387;4790.5448982346625;4816.34979277807;4831.661783675109 05:06:25 INFO - PROCESS | 12843 | |1;ext.html;557.6115472473542;589.6020186374196;589.7788329376483;603.3785201242722;605.7334772700015;32802;33099;33372.164530950846;33395.83302083489;33423.66576334242;36578;37785;37809.62190378096;37845.810770946104;37896.05259868505;7144.0712707347975;7653.043369578817;7856.607169641524;9451.621935122586;9811.411315321104;9613.615455381776;9779.55991980359;9785.168260697848;9789.608415663364;9794.265430092735;9711.805763884753;9829.65596204133;9836.557354919047;9837.950810245939;9840.3603765755;9763.121319081281;9971.950140249324;9972.301938864282;9977.151942084894;9993.80012399748;10022.448765317904;10085.294029417944;10088.344257623305;10089.243306751949;10091.545880435324;36524.0868978275;36895.631043689486;36937.63062369369;36971.4454283186;37046.44430333547;2713.66079240095;2767.2805070681766;2852.6719427265716;3383.9323213535836;3529.8764543240864;28107.718922810716;28652;28892.277693057633;29518.409631807244;29817.552736708967;3506.9123271918406;3541.203229273419;3547.4324108142573;3605.387084195693;3656.780593164419;240976;241228;241264;241448;241728;52973.47026529763;53876.46123538793;54054.729726351114;54159.458405416226;54201.728991354794;55300;55596.722016389656;55673;55813.72093139508;55828.720856395455;12537.247765134121;13830.515931942535;14122.435102595986;14128.788068178985;14155.787663185061;9378.5310734463;9431.151196392357;9511.524423778921;9516.429014259029;9749.561269742879;17256;17332.65334693299;17544.736828947574;17575.0333731646;17579.20893559793;5921.911171332434;5999.520038396918;6144.262688477322;6226.875462490725;6229.501639868799;820.9860821884968;916.6287653500343;928.9734842998389;975.1613612293422;998.2962011781676;26404.471910561682;26438.47123057528;26985.86507067452;27037;27159.456810864067;1001.0519021481812;1028.4857571214393;1029.4749677664445;1051.153821173947;1067.5089458849016;13652.522161724291;14140.15159090458;14174.503892363718;14441.711165776836;14518.346674399678;343438;343882;347677;349928;350337;49313.50686493089;49650.255246171335;49717.50282497201;49775.75112124416;49831.25253121206;1090.3893819461127;1112.2714621922653;1134.8638163420442;1180.0795379603924;1219.451246938881;23363.532729345658;24895.128670496444;25086.874565627786;25139.371515712253;25220;34830.65169348376;35099;35203.471947921316;35234.29531409409;35360.64639353574;230180;231266;231977;232610;233352;25134.24597262085;26099;26371.4725705481;26375.20874373772;34253.48619770656;36061.81969090138;36206.637933620324;36570;36740.63259367372;37167;32375.190620234684;32718.50922236216;34775.65224347724;35546.28907421786;35933.28133437369;34073;34144.317113658086;34352.65647343595;34548.136296592784;34613.78851740177;33357.33285334231;34084.488732668535;34259.14352141217;34451.82774086113;34484.482732759534;30080.54879176858;31139.377212455172;31357.8432107838;31497.685023149475;31540.684593154692;23674.673198530192;23763.1682891098;24098.15656452016;24299.149529766375;24400.87799560991 05:06:25 INFO - PROCESS | 12843 | |2;jquery.html;380.5091432052652;383.8809968909637;384.3984164782116;385.80709645177427;401.11554023378454;15560.455384061546;16890.577735556602;17037.914810425962;17046.5738356541;17072.82927170728;11675.941620291887;15340.769888451681;16031.957922735013;16058.27737751801;16065.759013614805;4634.884127896804;4774.73738944358;4820.301056346828;4830.106430310386;4834.951650483503;3488.6685764852427;6317.74729010839;6934.618595977219;6946.374826265635;6954.4436445084275;6474.902876456857;6852.451803855704;6929.792106236821;6947.027416161742;6947.513674042819;6783.118194634715;6808.148981377328;6829.863402731918;6837.042814006043;6853.862922741567;6457.547971641987;6831.795046148623;6833.726650933957;6839.658017099175;6847.965760171167;20827.37517874451;21213.5757284855;21296.25463108784;21581.46046348838;21746.238881639223;1947.3865732294282;2000.3598848368529;2025.767036790773;2086.9165233390645;2157.8273738100916;6503.219613646345;12994.245776820197;13706.862931370659;13881;14040.648983775385;1878.1078987480837;1923.4037448390905;1931.7199006144172;1977.7330060441943;1990.0547240061;79206.20793792047;79226.60386698088;79311.603441983;79453;80346.79479807866;16015.119168445613;16221.837781622033;16308.75536866948;16316.42892498757;16753.748693769605;28643.14070577886;28779.424411511653;28836.567451488245;28968.855155724086;29008.27479312992;7722.7297044603165;8215;8397.454165479225;8423.663053477792;8559.786005349915;6717.1267735194115;6730.966345168243;6766.830829229309;6840.760573379908;6936.965315173392;7084.681189346492;8069.515829050159;8318.459300145592;8341.499510029296;8412.705555305534;2920.518114511082;3327.441405274789;3406.710429613461;3448.069081314472;3621.764585301947;823.5100115431309;834.8246868157634;872.1583671756786;872.9519876406731;878.446578655443;15690.607734806721;16404.179791010403;16515.91742041306;16703.16484175786;16897.915510422616;870.6082262981557;898.9820203596022;901.2069378946616;925.833349997007;929.986314916744;8895.043090520076;9013;9123.042080581576;9460.432374057578;9475.620975160917;299228;302675;302897;302983;306059;81026.59486702646;85938;86334;86908.56545717358;88374;942.2085448223388;953.609020301673;974.0648976982035;979.133466881829;979.2117345536911;15014.024088434217;15245.16151611672;15419.460318889234;15446.0732356059;15534.922325388752;35950.460743089396;36162.638373615926;36198.27603447969;36464.635353646125;37294.81352593219;45180.548194517636;46170.307445387676;46653.76673116613;52028.47971520388;53424.465755341946;7467.477276590804;7899.921000789918;7903.407244456574;8044.1955804419085;8068.556229407204;10105.545250463894;11388.829167562659;11690;12073.094517911368;12190.57332993341;10007.499625018865;10561.471926403496;10615.203859710708;10624.256302058782;10688.946555267174;10018.849717254101;10136.898631013595;10324.638637647646;10375.429351385746;10461.790764184825;10325.586976520855;10328.586856525655;10443.68668939933;10665.306755060896;10810.621628242974;7414.740484083031;7506.924930750841;7508.474406791691;7554.395648348229;7573;9284.675036373694;9554.426734395958;9677.22582193437;9720;9807.970163133054 05:06:25 INFO - PROCESS | 12843 | |3;mootools.html;1241.4475558376514;1408.2677007955863;1424.736423761604;1535.8080239970004;1752.1939907642484;6756.594604323744;7606.239376062391;7814.531128132316;7819.296263336299;7846.411519136066;7443.181250062489;7610.353119984794;7613.505122167056;7613.809654758634;7615.733449329275;1936.806319368066;2218;2266.150193677371;2293.0713061210236;2306.573283942476;2331;2355.8233132515043;2357.7288611809604;2358.3396648938324;2361.9055237790467;2264.3320220534983;2311.6879221305076;2315.7568455312203;2316;2317.084751523147;1930.691089425692;2211.823054155672;2281.863088214712;2282.2354511238755;2285.6228722260807;2183.661532462455;2190.485235969546;2196.0556960506974;2198.527316626933;2250.707408036961;7651.770446886547;7767.300942915164;7773.650185741655;7774.416918731118;7785.3771698264;4425.690201685883;4607.17070927233;4607.654425918036;4621.930671039937;4622.884427889296;2821.308779349052;2852.6006359109742;2865.957010644842;2880.625518682579;2893.14652177606;915.9954200228956;927.2720914082413;932.5057719408725;934.5654270764128;948.7390967483997;10244.28290019699;10270.537825797783;10283.742906427324;10287.228457865614;10294.69115926516;4197.223513649923;4371.125774845043;4399.5380485049245;4472.865814025585;4477.529859364785;8703.43427677199;8766;8766.780830479162;8783.385163038525;8790.824183516293;4110.260153172398;4610.239310513728;4620.330052142421;4634.837780677727;4640.303954406866;3826.827792749333;3828.48315477407;3829;4203.600657937491;4354.782260886943;3713.313037088147;3724.4413337998976;3837.808109594509;3849.4995650565247;3883.689304855605;1240.497598472602;1255.554278231233;1257.7295881385546;1268.8413948256468;1279.3922886628964;709.1348554763181;714.4070421550101;748.8202831320444;782.6595430987538;816.0859836982618;5227.111391063529;5355.491228333302;5368.543673787772;5405.486478784588;5413.783448662089;837.4263629413871;857.438377862501;869.2133619074748;891.5542228885557;900.7252787899622;3314.6519615440516;3342.598888133391;3400.4049291373913;3441.913952151216;3456.498807672873;9287;9613.134817866425;9736.367136136128;9741.172000380047;9741.659041933499;9613.951930240444;9818.656347027963;9917.900820991843;9935;9941.45322007282;7405.740799072114;7511.812204694817;7535.886961695579;7537;7540.396768258526;5120.897582048413;5222.97388513055;5308.309919710413;5319.228711836685;5359.812406565751;8602.827943441222;8752.51861147643;8867.467951922905;9056.728298151065;9149.954250228706;8719.258862996716;8796.692115775917;8979.685711000084;9050.456972581404;9095.454272743656;6114.419130182626;6429.58207716497;6469.676516174267;6546.378094081055;6632;7266.273372662691;7285.453590980592;7313.707451701873;7328.963355183403;7339.045924029842;6422.743090276524;6470.838229044311;6563.212414510289;6563.343665633399;6699.631520266237;6346.238451385863;6499.350064993463;6517.120188774455;6531.11829902957;6550.312217217123;6058.5153187745755;6188.752449901954;6190.907136392868;6192.040233763774;6199.225096862892;4341.978290108529;4436.6228870546365;4498.370228168124;4509.909801804011;4529.297958816389;4386.166628340605;4415.227335216388;4449;4461.04087621163;4475.7985890635655 05:06:25 INFO - PROCESS | 12843 | |4;prototype.html;316.7735069425361;318.1910836892268;323.1372236129534;326.7418739196035;329.6818570079872;5082.974585127074;5149.433562308148;5158.793648254065;5163.612729045322;5195.636305458619;5104.617153713468;5125.487451254882;5127.1027570175165;5128.743562821863;5132.640715149941;3808.5048943637357;3859.4210868369687;3998.1403998140395;4007.9599204007877;4041.7574945503216;3948.348522493785;4014.5985401459766;4026.5570787213383;4036.656884164835;4053.3717273822604;3803.0302272920367;3998.52017757868;4005.1388951375448;4007.158496715693;4007.759534427929;3841.886962170795;3985.8405663773415;4002.6597739192202;4002.9199416011515;4004.619561141716;3510.7717998330027;3523.8061906595126;3525.3207562252614;3531.6468353164737;3538.5576802899636;4892.706437613754;4914.778834952435;4915.606751459874;4922.901541969176;4936;4253.29820579604;4511.345854851061;4519.887002824923;4530.546945305476;4572.702774319659;5348.572114230852;5361.2226227197225;5361.731913404353;5364.812231571916;5365.114756065244;3770.8491660333552;3770.924581508382;3776.490173826553;3778.3199024175638;3787.867424640152;5556.388048071437;5602.075657516505;5617.887642247173;5641.661500309953;5654.688992105433;3846.788426636506;3872.593377695358;3877.5540812806325;3880.6507414332846;3889.4749208857006;3922.058705910561;3924.5682974872743;3929.0766669832565;3930.0960779020984;3934.6655534279334;4232.915341693149;4519.0961807638605;4526.162659907927;4531.229690952546;4537.137943790735;5336.599755018389;5349.358077030781;5384.219288203189;5407.242985981966;5413.783448662089;1341.1684755451683;1364.3451143451;1366.1393322206945;1367.0089185340748;1368.8562700916261;854.769212312672;894.3113802372267;916.5142474488532;922.7554698005034;943.8867335919596;4688.601468875116;4690.226112691436;4702.27114797207;4719.150552900443;4727.385439892861;5465.562754979592;5465.726713664301;5473.507384335429;5488.725563721798;5504.311961004874;4540.591346778806;4712.387389639393;4728.007118505084;4732.763361831895;4817.710937343771;2974.568687540338;2980.8360540170497;2988.342564635777;2999.3701322722036;3002.6546947101365;5267.525922666979;5285.814996475105;5287.41838397776;5299.5230429261555;5299.629025968223;5573.523016400657;5754.4533269339345;5755;5773.855653608609;5777.133429985452;5262.236975638511;5269.762860671202;5270.604704647167;5273.182656688219;5281.973590132102;5487.5609951203005;5619.747111380079;5624.943750562606;5626.2967129108865;5638.154276858504;5426.7829286829665;5435.592330575144;5483.643563168382;5488.4237155098135;5514.145307477187;5220.269162317354;5234.738263086907;5242.082635538842;5257.369115706139;5274.285857096535;3782.829772660182;3851.480050193188;3858.2090671411734;3866.8259928303855;3882.689384849262;5526.778928842801;5566.916496252478;5568.359638641608;5576.358718747234;5595.440455954372;5387.622866399314;5388.865278368072;5396.892062158657;5401.270828438111;5403.8108666196495;5264.78940842362;5346.716787970937;5389.218563308376;5396.46035396473;5398.892022159614;5016.347874776256;5270.736463176902;5312.309399778159;5312.62811603184;5319.627626066138;5233.476652334736;5311.9468805313;5320.52115309624;5333.093374126485;5349.903269829598;5297.629165958346;5299.231611416246;5300.70846103468;5312.203169524448;5318.813841515528 05:06:25 INFO - PROCESS | 12843 | |5;yui.html;617.8486270863638;683.8666460040295;740.1155619035253;745.4479405632163;763.3778470546507;11389.373584452851;11619.419029048535;11655.650330490098;11667;11708.004819590335;11743.47154378053;13155.868441315584;13403.46386144553;13477.05660603758;13477.123986940842;626.4549841637781;792.8969233999572;794.0114557376074;799.4124318625805;799.7920540659442;753.9773806785778;761.3984951888002;763.7097902796929;764.9388048956098;769.8768197088467;806.189779271831;807.7495976247382;808.514891065359;810.6514198894473;828.2131974624101;650.0931200974613;668.2548957911941;805.5126648377735;810.5460941872541;826.983460330793;490.24257522128397;577.1804038265673;580.115324130704;581.5028150930935;586.8650210451577;12830.16603920742;12832.679183020498;12861;12864.29246391448;12950.740985180244;10581.735456613646;11145.944270278678;11212.775744485147;11303.321800691985;11466.885331146748;9270.30472714549;9287.58205880737;9365.297602679826;9428.387154834982;9511.66709165176;3279.9016029519153;3285.3593549257903;3343.3814744272386;3374.5950485941844;3395.422778127724;48083;48223.5177648226;48274.03451930977;48598.514014860106;48636.75681621569;9571.242313283268;9702.660406885867;9746.512674366253;9754.804903901882;9910.80178396428;17598;17604.471865844047;17627.118644067745;17628.823711762976;17647.38234161798;6577.80266592003;6657.068010478537;6700.329967003261;6729.899051514231;6840.657967101625;3802.9809850951124;3823.388257878726;3871.8644847430205;3885.0287428142965;3999.4000899864673;2944.573036909679;3007.173027417434;3011.9397612047637;3013.3220025494525;3014.050574069161;494.97030178189425;503.9395272567242;504.20839282327125;507.974601269935;525.6714553404122;395.82583663188103;406.2747994829216;454.45919355966294;480.4450859257563;525.7975679363473;6601.141851559267;6973.755918542826;7102.431805455654;7131.429485641136;7354.154272258652;452.53615044579567;519.2341296587579;574.9511291540182;579.7478097027806;589.8938191125553;3325.9501107483406;3366.141633883393;3374.5275661407422;3388.1698983748647;3474.062003259106;53277;54276.72861635667;54395;54403;54661.72669136629;45330;46525.30212046822;46815.531844681114;47493;47621.28568071482;42627.573724262984;42706;42806.357904631455;43262.56737432585;43410.78294608507;6442.838929026624;6504.642244676588;6584.50616203777;6629.834254143685;6687.465002799861;28720.138395848157;28938.565921510773;29877.701222987493;30125.69874301229;30221.395572088873;36233.45649815308;36671;39083.80458097691;39330.410043848795;39682;9069.410488318239;9122.908770912207;9147.542622868963;9206.907930920604;9331.486768227542;11023.83464248021;11241.775164496828;11324.660260192208;11486.770264594494;11669.124815638692;8429.747107586782;10742.677719668422;10745.140388768723;11008.669739907815;11205.327680339205;10196.592136314464;10221.182305415698;10277.74305642365;10352.223583231138;10491.527881245209;10391.948040259751;10409.739756506147;10427.061564459234;10582.788344233226;10658.307210031324;8825.161609647073;9006.684766033157;9017.774555636162;9239.39943903644;9318.301127415336;8945.37382383253;8999.37004409685;9060.682876099305;9066.727998160066;9137.838429250854 05:06:25 INFO - PROCESS | 12843 | __end_tp_report 05:06:25 INFO - PROCESS | 12843 | __start_cc_report 05:06:25 INFO - PROCESS | 12843 | _x_x_mozilla_cycle_collect,1059 05:06:25 INFO - PROCESS | 12843 | __end_cc_report 05:06:25 INFO - PROCESS | 12843 | __startTimestamp1461585985704__endTimestamp 05:06:25 INFO - PROCESS | 12843 | 05:06:25 INFO - PROCESS | 12843 | ------- Summary: start ------- 05:06:25 INFO - PROCESS | 12843 | Number of tests: 6 05:06:25 INFO - PROCESS | 12843 | 05:06:25 INFO - PROCESS | 12843 | [#0] dojo.html Cycles:165 Average:4649.57 Median:4790.54 stddev:493.02 (10.3%) stddev-sans-first:467.02 05:06:25 INFO - PROCESS | 12843 | Values: 2579.2 2663.5 2668.6 2684.8 2706.5 4492.5 4599.6 4641.8 4642.4 4654.7 4697.1 4720.0 4732.0 4815.6 4831.3 4247.2 4251.6 4310.9 4380.3 4412.5 4332.1 4384.3 4395.0 4408.5 4450.0 4193.6 4273.2 4299.8 4299.8 4379.0 4320.6 4346.2 4359.1 4361.6 4404.1 4293.3 4298.1 4305.5 4332.0 4357.5 4496.2 4550.2 4577.0 4609.0 4639.0 5023.8 5025.1 5026.9 5034.7 5060.3 5031.6 5044.4 5051.3 5061.1 5097.1 4592.3 4685.2 4771.5 4773.0 4778.3 5204.5 5205.0 5208.1 5211.1 5217.7 4983.5 4997.7 4999.7 5006.9 5051.1 4907.5 5008.0 5060.5 5100.9 5103.4 5004.0 5029.1 5040.3 5040.6 5093.8 5007.8 5010.9 5011.5 5020.1 5024.8 4139.4 4206.6 4208.7 4228.2 4301.1 3668.4 3672.9 3679.9 3716.8 3736.9 4297.7 4300.1 4301.8 4339.8 4348.7 4962.7 4976.3 5014.9 5054.2 5086.7 4289.3 4292.4 4295.8 4331.7 4346.0 4474.1 4474.7 4476.9 4480.1 4515.2 4557.4 4719.3 4772.8 4792.6 4807.5 5051.9 5074.3 5084.1 5085.8 5135.2 4774.4 4787.7 4792.4 4794.1 4838.2 4809.8 4862.2 4941.0 4941.6 4949.4 5048.4 5054.8 5070.7 5078.2 5123.5 4905.0 4909.9 4912.9 4926.3 4928.9 4740.9 4885.9 4896.1 4950.6 4975.0 4830.6 4848.1 4852.3 4864.0 4881.0 4785.6 4971.5 4971.7 4978.2 5034.5 4738.5 4785.1 4790.5 4816.3 4831.7 05:06:25 INFO - PROCESS | 12843 | 05:06:25 INFO - PROCESS | 12843 | [#1] ext.html Cycles:180 Average:42894.06 Median:34516.31 stddev:72939.79 (211.3%) stddev-sans-first:73075.14 05:06:25 INFO - PROCESS | 12843 | Values: 557.6 589.6 589.8 603.4 605.7 32802.0 33099.0 33372.2 33395.8 33423.7 36578.0 37785.0 37809.6 37845.8 37896.1 7144.1 7653.0 7856.6 9451.6 9811.4 9613.6 9779.6 9785.2 9789.6 9794.3 9711.8 9829.7 9836.6 9838.0 9840.4 9763.1 9972.0 9972.3 9977.2 9993.8 10022.4 10085.3 10088.3 10089.2 10091.5 36524.1 36895.6 36937.6 36971.4 37046.4 2713.7 2767.3 2852.7 3383.9 3529.9 28107.7 28652.0 28892.3 29518.4 29817.6 3506.9 3541.2 3547.4 3605.4 3656.8 240976.0 241228.0 241264.0 241448.0 241728.0 52973.5 53876.5 54054.7 54159.5 54201.7 55300.0 55596.7 55673.0 55813.7 55828.7 12537.2 13830.5 14122.4 14128.8 14155.8 9378.5 9431.2 9511.5 9516.4 9749.6 17256.0 17332.7 17544.7 17575.0 17579.2 5921.9 5999.5 6144.3 6226.9 6229.5 821.0 916.6 929.0 975.2 998.3 26404.5 26438.5 26985.9 27037.0 27159.5 1001.1 1028.5 1029.5 1051.2 1067.5 13652.5 14140.2 14174.5 14441.7 14518.3 343438.0 343882.0 347677.0 349928.0 350337.0 49313.5 49650.3 49717.5 49775.8 49831.3 1090.4 1112.3 1134.9 1180.1 1219.5 23363.5 24895.1 25086.9 25139.4 25220.0 34830.7 35099.0 35203.5 35234.3 35360.6 230180.0 231266.0 231977.0 232610.0 233352.0 25134.2 26099.0 26371.5 26375.2 34253.5 36061.8 36206.6 36570.0 36740.6 37167.0 32375.2 32718.5 34775.7 35546.3 35933.3 34073.0 34144.3 34352.7 34548.1 34613.8 33357.3 34084.5 34259.1 34451.8 34484.5 30080.5 31139.4 31357.8 31497.7 31540.7 23674.7 23763.2 24098.2 24299.1 24400.9 05:06:25 INFO - PROCESS | 12843 | 05:06:25 INFO - PROCESS | 12843 | [#2] jquery.html Cycles:180 Average:23255.26 Median:45675.43 stddev:51097.18 (111.9%) stddev-sans-first:51211.66 05:06:25 INFO - PROCESS | 12843 | Values: 380.5 383.9 384.4 385.8 401.1 15560.5 16890.6 17037.9 17046.6 17072.8 11675.9 15340.8 16032.0 16058.3 16065.8 4634.9 4774.7 4820.3 4830.1 4835.0 3488.7 6317.7 6934.6 6946.4 6954.4 6474.9 6852.5 6929.8 6947.0 6947.5 6783.1 6808.1 6829.9 6837.0 6853.9 6457.5 6831.8 6833.7 6839.7 6848.0 20827.4 21213.6 21296.3 21581.5 21746.2 1947.4 2000.4 2025.8 2086.9 2157.8 6503.2 12994.2 13706.9 13881.0 14040.6 1878.1 1923.4 1931.7 1977.7 1990.1 79206.2 79226.6 79311.6 79453.0 80346.8 16015.1 16221.8 16308.8 16316.4 16753.7 28643.1 28779.4 28836.6 28968.9 29008.3 7722.7 8215.0 8397.5 8423.7 8559.8 6717.1 6731.0 6766.8 6840.8 6937.0 7084.7 8069.5 8318.5 8341.5 8412.7 2920.5 3327.4 3406.7 3448.1 3621.8 823.5 834.8 872.2 873.0 878.4 15690.6 16404.2 16515.9 16703.2 16897.9 870.6 899.0 901.2 925.8 930.0 8895.0 9013.0 9123.0 9460.4 9475.6 299228.0 302675.0 302897.0 302983.0 306059.0 81026.6 85938.0 86334.0 86908.6 88374.0 942.2 953.6 974.1 979.1 979.2 15014.0 15245.2 15419.5 15446.1 15534.9 35950.5 36162.6 36198.3 36464.6 37294.8 45180.5 46170.3 46653.8 52028.5 53424.5 7467.5 7899.9 7903.4 8044.2 8068.6 10105.5 11388.8 11690.0 12073.1 12190.6 10007.5 10561.5 10615.2 10624.3 10688.9 10018.8 10136.9 10324.6 10375.4 10461.8 10325.6 10328.6 10443.7 10665.3 10810.6 7414.7 7506.9 7508.5 7554.4 7573.0 9284.7 9554.4 9677.2 9720.0 9808.0 05:06:25 INFO - PROCESS | 12843 | 05:06:25 INFO - PROCESS | 12843 | [#3] mootools.html Cycles:180 Average:5091.49 Median:5357.65 stddev:2821.69 (52.7%) stddev-sans-first:2814.77 05:06:25 INFO - PROCESS | 12843 | Values: 1241.4 1408.3 1424.7 1535.8 1752.2 6756.6 7606.2 7814.5 7819.3 7846.4 7443.2 7610.4 7613.5 7613.8 7615.7 1936.8 2218.0 2266.2 2293.1 2306.6 2331.0 2355.8 2357.7 2358.3 2361.9 2264.3 2311.7 2315.8 2316.0 2317.1 1930.7 2211.8 2281.9 2282.2 2285.6 2183.7 2190.5 2196.1 2198.5 2250.7 7651.8 7767.3 7773.7 7774.4 7785.4 4425.7 4607.2 4607.7 4621.9 4622.9 2821.3 2852.6 2866.0 2880.6 2893.1 916.0 927.3 932.5 934.6 948.7 10244.3 10270.5 10283.7 10287.2 10294.7 4197.2 4371.1 4399.5 4472.9 4477.5 8703.4 8766.0 8766.8 8783.4 8790.8 4110.3 4610.2 4620.3 4634.8 4640.3 3826.8 3828.5 3829.0 4203.6 4354.8 3713.3 3724.4 3837.8 3849.5 3883.7 1240.5 1255.6 1257.7 1268.8 1279.4 709.1 714.4 748.8 782.7 816.1 5227.1 5355.5 5368.5 5405.5 5413.8 837.4 857.4 869.2 891.6 900.7 3314.7 3342.6 3400.4 3441.9 3456.5 9287.0 9613.1 9736.4 9741.2 9741.7 9614.0 9818.7 9917.9 9935.0 9941.5 7405.7 7511.8 7535.9 7537.0 7540.4 5120.9 5223.0 5308.3 5319.2 5359.8 8602.8 8752.5 8867.5 9056.7 9150.0 8719.3 8796.7 8979.7 9050.5 9095.5 6114.4 6429.6 6469.7 6546.4 6632.0 7266.3 7285.5 7313.7 7329.0 7339.0 6422.7 6470.8 6563.2 6563.3 6699.6 6346.2 6499.4 6517.1 6531.1 6550.3 6058.5 6188.8 6190.9 6192.0 6199.2 4342.0 4436.6 4498.4 4509.9 4529.3 4386.2 4415.2 4449.0 4461.0 4475.8 05:06:25 INFO - PROCESS | 12843 | 05:06:25 INFO - PROCESS | 12843 | [#4] prototype.html Cycles:180 Average:4460.83 Median:5130.69 stddev:1305.47 (25.4%) stddev-sans-first:1271.54 05:06:25 INFO - PROCESS | 12843 | Values: 316.8 318.2 323.1 326.7 329.7 5083.0 5149.4 5158.8 5163.6 5195.6 5104.6 5125.5 5127.1 5128.7 5132.6 3808.5 3859.4 3998.1 4008.0 4041.8 3948.3 4014.6 4026.6 4036.7 4053.4 3803.0 3998.5 4005.1 4007.2 4007.8 3841.9 3985.8 4002.7 4002.9 4004.6 3510.8 3523.8 3525.3 3531.6 3538.6 4892.7 4914.8 4915.6 4922.9 4936.0 4253.3 4511.3 4519.9 4530.5 4572.7 5348.6 5361.2 5361.7 5364.8 5365.1 3770.8 3770.9 3776.5 3778.3 3787.9 5556.4 5602.1 5617.9 5641.7 5654.7 3846.8 3872.6 3877.6 3880.7 3889.5 3922.1 3924.6 3929.1 3930.1 3934.7 4232.9 4519.1 4526.2 4531.2 4537.1 5336.6 5349.4 5384.2 5407.2 5413.8 1341.2 1364.3 1366.1 1367.0 1368.9 854.8 894.3 916.5 922.8 943.9 4688.6 4690.2 4702.3 4719.2 4727.4 5465.6 5465.7 5473.5 5488.7 5504.3 4540.6 4712.4 4728.0 4732.8 4817.7 2974.6 2980.8 2988.3 2999.4 3002.7 5267.5 5285.8 5287.4 5299.5 5299.6 5573.5 5754.5 5755.0 5773.9 5777.1 5262.2 5269.8 5270.6 5273.2 5282.0 5487.6 5619.7 5624.9 5626.3 5638.2 5426.8 5435.6 5483.6 5488.4 5514.1 5220.3 5234.7 5242.1 5257.4 5274.3 3782.8 3851.5 3858.2 3866.8 3882.7 5526.8 5566.9 5568.4 5576.4 5595.4 5387.6 5388.9 5396.9 5401.3 5403.8 5264.8 5346.7 5389.2 5396.5 5398.9 5016.3 5270.7 5312.3 5312.6 5319.6 5233.5 5311.9 5320.5 5333.1 5349.9 5297.6 5299.2 5300.7 5312.2 5318.8 05:06:25 INFO - PROCESS | 12843 | 05:06:25 INFO - PROCESS | 12843 | [#5] yui.html Cycles:180 Average:12641.81 Median:48248.78 stddev:14829.90 (30.7%) stddev-sans-first:14844.01 05:06:25 INFO - PROCESS | 12843 | Values: 617.8 683.9 740.1 745.4 763.4 11389.4 11619.4 11655.7 11667.0 11708.0 11743.5 13155.9 13403.5 13477.1 13477.1 626.5 792.9 794.0 799.4 799.8 754.0 761.4 763.7 764.9 769.9 806.2 807.7 808.5 810.7 828.2 650.1 668.3 805.5 810.5 827.0 490.2 577.2 580.1 581.5 586.9 12830.2 12832.7 12861.0 12864.3 12950.7 10581.7 11145.9 11212.8 11303.3 11466.9 9270.3 9287.6 9365.3 9428.4 9511.7 3279.9 3285.4 3343.4 3374.6 3395.4 48083.0 48223.5 48274.0 48598.5 48636.8 9571.2 9702.7 9746.5 9754.8 9910.8 17598.0 17604.5 17627.1 17628.8 17647.4 6577.8 6657.1 6700.3 6729.9 6840.7 3803.0 3823.4 3871.9 3885.0 3999.4 2944.6 3007.2 3011.9 3013.3 3014.1 495.0 503.9 504.2 508.0 525.7 395.8 406.3 454.5 480.4 525.8 6601.1 6973.8 7102.4 7131.4 7354.2 452.5 519.2 575.0 579.7 589.9 3326.0 3366.1 3374.5 3388.2 3474.1 53277.0 54276.7 54395.0 54403.0 54661.7 45330.0 46525.3 46815.5 47493.0 47621.3 42627.6 42706.0 42806.4 43262.6 43410.8 6442.8 6504.6 6584.5 6629.8 6687.5 28720.1 28938.6 29877.7 30125.7 30221.4 36233.5 36671.0 39083.8 39330.4 39682.0 9069.4 9122.9 9147.5 9206.9 9331.5 11023.8 11241.8 11324.7 11486.8 11669.1 8429.7 10742.7 10745.1 11008.7 11205.3 10196.6 10221.2 10277.7 10352.2 10491.5 10391.9 10409.7 10427.1 10582.8 10658.3 8825.2 9006.7 9017.8 9239.4 9318.3 8945.4 8999.4 9060.7 9066.7 9137.8 05:06:25 INFO - PROCESS | 12843 | -------- Summary: end -------- 05:06:25 INFO - PROCESS | 12843 | 05:06:26 INFO - TEST-INFO | 12843: exit 0 05:06:26 INFO - TEST-OK | dromaeo_css | took 1118211ms 05:06:26 INFO - TEST-START | kraken 05:06:26 INFO - operating with platform_type : linux_ 05:06:26 INFO - Initialising browser for kraken test... 05:06:26 INFO - TEST-INFO | started process 13020 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5wGJsH/profile http://localhost:56446/getInfo.html) 05:06:30 INFO - PROCESS | 13020 | __metrics Screen width/height:1600/1200 05:06:30 INFO - PROCESS | 13020 | colorDepth:24 05:06:30 INFO - PROCESS | 13020 | Browser inner width/height: 1024/697 05:06:30 INFO - PROCESS | 13020 | __metrics 05:06:31 ERROR - PROCESS | 13020 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:06:32 INFO - TEST-INFO | 13020: exit 0 05:06:32 INFO - Browser initialized. 05:06:32 INFO - Running cycle 1/1 for kraken test... 05:06:32 INFO - TEST-INFO | started process 13100 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5wGJsH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:06:44 INFO - PROCESS | 13100 | RSS: Main: 155631616 05:06:44 INFO - PROCESS | 13100 | 05:06:46 INFO - PROCESS | 13100 | Cycle 1(1): loaded http://localhost:56446/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56446/tests/kraken/driver.html?testName=audio-beat-detection) 05:06:47 INFO - PROCESS | 13100 | RSS: Main: 210169856 05:06:47 INFO - PROCESS | 13100 | 05:06:50 INFO - PROCESS | 13100 | Cycle 1(1): loaded http://localhost:56446/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56446/tests/kraken/driver.html?testName=audio-dft) 05:06:51 INFO - PROCESS | 13100 | RSS: Main: 196141056 05:06:51 INFO - PROCESS | 13100 | 05:06:54 INFO - PROCESS | 13100 | Cycle 1(1): loaded http://localhost:56446/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56446/tests/kraken/driver.html?testName=audio-fft) 05:06:55 INFO - PROCESS | 13100 | RSS: Main: 266534912 05:06:55 INFO - PROCESS | 13100 | 05:06:57 INFO - PROCESS | 13100 | Cycle 1(1): loaded http://localhost:56446/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56446/tests/kraken/driver.html?testName=audio-oscillator) 05:06:57 INFO - PROCESS | 13100 | RSS: Main: 174612480 05:06:57 INFO - PROCESS | 13100 | 05:07:00 INFO - PROCESS | 13100 | Cycle 1(1): loaded http://localhost:56446/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56446/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:07:00 INFO - PROCESS | 13100 | RSS: Main: 179003392 05:07:00 INFO - PROCESS | 13100 | 05:07:03 INFO - PROCESS | 13100 | Cycle 1(1): loaded http://localhost:56446/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56446/tests/kraken/driver.html?testName=imaging-darkroom) 05:07:04 INFO - PROCESS | 13100 | RSS: Main: 215080960 05:07:04 INFO - PROCESS | 13100 | 05:07:07 INFO - PROCESS | 13100 | Cycle 1(1): loaded http://localhost:56446/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56446/tests/kraken/driver.html?testName=imaging-desaturate) 05:07:08 INFO - PROCESS | 13100 | RSS: Main: 215633920 05:07:08 INFO - PROCESS | 13100 | 05:07:11 INFO - PROCESS | 13100 | Cycle 1(1): loaded http://localhost:56446/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56446/tests/kraken/driver.html?testName=json-parse-financial) 05:07:12 INFO - PROCESS | 13100 | RSS: Main: 215752704 05:07:12 INFO - PROCESS | 13100 | 05:07:13 INFO - PROCESS | 13100 | Cycle 1(1): loaded http://localhost:56446/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56446/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:07:14 INFO - PROCESS | 13100 | RSS: Main: 201322496 05:07:14 INFO - PROCESS | 13100 | 05:07:16 INFO - PROCESS | 13100 | Cycle 1(1): loaded http://localhost:56446/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56446/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:07:16 INFO - PROCESS | 13100 | RSS: Main: 204787712 05:07:16 INFO - PROCESS | 13100 | 05:07:18 INFO - PROCESS | 13100 | Cycle 1(1): loaded http://localhost:56446/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56446/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:07:19 INFO - PROCESS | 13100 | RSS: Main: 218267648 05:07:19 INFO - PROCESS | 13100 | 05:07:22 INFO - PROCESS | 13100 | Cycle 1(1): loaded http://localhost:56446/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56446/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:07:22 INFO - PROCESS | 13100 | RSS: Main: 224030720 05:07:22 INFO - PROCESS | 13100 | 05:07:25 INFO - PROCESS | 13100 | Cycle 1(1): loaded http://localhost:56446/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56446/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:07:26 INFO - PROCESS | 13100 | RSS: Main: 218374144 05:07:26 INFO - PROCESS | 13100 | 05:07:28 INFO - PROCESS | 13100 | Cycle 1(1): loaded http://localhost:56446/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56446/tests/kraken/driver.html?testName=ai-astar) 05:07:28 INFO - PROCESS | 13100 | RSS: Main: 282656768 05:07:28 INFO - PROCESS | 13100 | 05:07:28 INFO - PROCESS | 13100 | __start_tp_report 05:07:28 INFO - PROCESS | 13100 | _x_x_mozilla_page_load 05:07:28 INFO - PROCESS | 13100 | _x_x_mozilla_page_load_details 05:07:28 INFO - PROCESS | 13100 | |i|pagename|runs| 05:07:28 INFO - PROCESS | 13100 | |0;ai-astar;110;114;108;112;113;113;102;113;113;113 05:07:28 INFO - PROCESS | 13100 | |1;audio-beat-detection;161;132;164;184;132;160;158;136;181;132 05:07:28 INFO - PROCESS | 13100 | |2;audio-dft;161;160;162;160;166;161;160;161;161;162 05:07:28 INFO - PROCESS | 13100 | |3;audio-fft;75;74;119;120;75;73;73;115;104;77 05:07:28 INFO - PROCESS | 13100 | |4;audio-oscillator;96;95;147;93;94;94;149;93;93;155 05:07:28 INFO - PROCESS | 13100 | |5;imaging-gaussian-blur;117;116;118;118;118;117;117;117;116;117 05:07:28 INFO - PROCESS | 13100 | |6;imaging-darkroom;146;147;146;146;145;146;147;146;145;146 05:07:28 INFO - PROCESS | 13100 | |7;imaging-desaturate;95;95;95;96;96;95;94;94;95;95 05:07:28 INFO - PROCESS | 13100 | |8;json-parse-financial;64;65;64;65;63;65;63;88;62;63 05:07:28 INFO - PROCESS | 13100 | |9;json-stringify-tinderbox;64;65;65;64;66;65;65;65;64;65 05:07:28 INFO - PROCESS | 13100 | |10;stanford-crypto-aes;80;77;80;77;80;79;79;82;80;79 05:07:28 INFO - PROCESS | 13100 | |11;stanford-crypto-ccm;134;135;135;135;132;132;133;131;165;137 05:07:28 INFO - PROCESS | 13100 | |12;stanford-crypto-pbkdf2;175;176;175;177;178;179;173;177;178;173 05:07:28 INFO - PROCESS | 13100 | |13;stanford-crypto-sha256-iterative;75;72;72;72;71;72;74;72;71;71 05:07:28 INFO - PROCESS | 13100 | __end_tp_report 05:07:28 INFO - PROCESS | 13100 | __start_cc_report 05:07:28 INFO - PROCESS | 13100 | _x_x_mozilla_cycle_collect,1905 05:07:28 INFO - PROCESS | 13100 | __end_cc_report 05:07:28 INFO - PROCESS | 13100 | __startTimestamp1461586048607__endTimestamp 05:07:28 INFO - PROCESS | 13100 | 05:07:28 INFO - PROCESS | 13100 | ------- Summary: start ------- 05:07:28 INFO - PROCESS | 13100 | Number of tests: 14 05:07:28 INFO - PROCESS | 13100 | 05:07:28 INFO - PROCESS | 13100 | [#0] ai-astar Cycles:10 Average:111.10 Median:113.00 stddev:3.67 (3.2%) stddev-sans-first:3.87 05:07:28 INFO - PROCESS | 13100 | Values: 110.0 114.0 108.0 112.0 113.0 113.0 102.0 113.0 113.0 113.0 05:07:28 INFO - PROCESS | 13100 | 05:07:28 INFO - PROCESS | 13100 | [#1] audio-beat-detection Cycles:10 Average:154.00 Median:160.50 stddev:20.02 (12.5%) stddev-sans-first:21.07 05:07:28 INFO - PROCESS | 13100 | Values: 161.0 132.0 164.0 184.0 132.0 160.0 158.0 136.0 181.0 132.0 05:07:28 INFO - PROCESS | 13100 | 05:07:28 INFO - PROCESS | 13100 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.00 stddev:1.78 (1.1%) stddev-sans-first:1.88 05:07:28 INFO - PROCESS | 13100 | Values: 161.0 160.0 162.0 160.0 166.0 161.0 160.0 161.0 161.0 162.0 05:07:28 INFO - PROCESS | 13100 | 05:07:28 INFO - PROCESS | 13100 | [#3] audio-fft Cycles:10 Average:90.50 Median:73.50 stddev:21.11 (28.7%) stddev-sans-first:21.64 05:07:28 INFO - PROCESS | 13100 | Values: 75.0 74.0 119.0 120.0 75.0 73.0 73.0 115.0 104.0 77.0 05:07:28 INFO - PROCESS | 13100 | 05:07:28 INFO - PROCESS | 13100 | [#4] audio-oscillator Cycles:10 Average:110.90 Median:93.50 stddev:27.30 (29.2%) stddev-sans-first:28.42 05:07:28 INFO - PROCESS | 13100 | Values: 96.0 95.0 147.0 93.0 94.0 94.0 149.0 93.0 93.0 155.0 05:07:28 INFO - PROCESS | 13100 | 05:07:28 INFO - PROCESS | 13100 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 05:07:28 INFO - PROCESS | 13100 | Values: 117.0 116.0 118.0 118.0 118.0 117.0 117.0 117.0 116.0 117.0 05:07:28 INFO - PROCESS | 13100 | 05:07:28 INFO - PROCESS | 13100 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 05:07:28 INFO - PROCESS | 13100 | Values: 146.0 147.0 146.0 146.0 145.0 146.0 147.0 146.0 145.0 146.0 05:07:28 INFO - PROCESS | 13100 | 05:07:28 INFO - PROCESS | 13100 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 05:07:28 INFO - PROCESS | 13100 | Values: 95.0 95.0 95.0 96.0 96.0 95.0 94.0 94.0 95.0 95.0 05:07:28 INFO - PROCESS | 13100 | 05:07:28 INFO - PROCESS | 13100 | [#8] json-parse-financial Cycles:10 Average:66.20 Median:64.50 stddev:7.73 (12.0%) stddev-sans-first:8.16 05:07:28 INFO - PROCESS | 13100 | Values: 64.0 65.0 64.0 65.0 63.0 65.0 63.0 88.0 62.0 63.0 05:07:28 INFO - PROCESS | 13100 | 05:07:28 INFO - PROCESS | 13100 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 05:07:28 INFO - PROCESS | 13100 | Values: 64.0 65.0 65.0 64.0 66.0 65.0 65.0 65.0 64.0 65.0 05:07:28 INFO - PROCESS | 13100 | 05:07:28 INFO - PROCESS | 13100 | [#10] stanford-crypto-aes Cycles:10 Average:79.30 Median:80.00 stddev:1.49 (1.9%) stddev-sans-first:1.56 05:07:28 INFO - PROCESS | 13100 | Values: 80.0 77.0 80.0 77.0 80.0 79.0 79.0 82.0 80.0 79.0 05:07:28 INFO - PROCESS | 13100 | 05:07:28 INFO - PROCESS | 13100 | [#11] stanford-crypto-ccm Cycles:10 Average:136.90 Median:135.00 stddev:10.04 (7.4%) stddev-sans-first:10.59 05:07:28 INFO - PROCESS | 13100 | Values: 134.0 135.0 135.0 135.0 132.0 132.0 133.0 131.0 165.0 137.0 05:07:28 INFO - PROCESS | 13100 | 05:07:28 INFO - PROCESS | 13100 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.10 Median:177.00 stddev:2.08 (1.2%) stddev-sans-first:2.17 05:07:28 INFO - PROCESS | 13100 | Values: 175.0 176.0 175.0 177.0 178.0 179.0 173.0 177.0 178.0 173.0 05:07:28 INFO - PROCESS | 13100 | 05:07:28 INFO - PROCESS | 13100 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.20 Median:72.00 stddev:1.32 (1.8%) stddev-sans-first:0.93 05:07:28 INFO - PROCESS | 13100 | Values: 75.0 72.0 72.0 72.0 71.0 72.0 74.0 72.0 71.0 71.0 05:07:28 INFO - PROCESS | 13100 | -------- Summary: end -------- 05:07:28 INFO - PROCESS | 13100 | 05:07:29 INFO - TEST-INFO | 13100: exit 0 05:07:29 INFO - TEST-OK | kraken | took 63202ms 05:07:29 INFO - SUITE-END | took 1181s 05:07:29 INFO - Completed test suite (00:19:41) 05:07:29 INFO - javascript benchmark 05:07:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2579.200447861163, 2663.493936152131, 2668.57302831547, 2684.7986401019916, 2706.499297629938, 4492.505824359326, 4599.586037256646, 4641.767911604419, 4642.419697537808, 4654.743989080599, 4697.1075495655805, 4719.952800471994, 4732.029933863559, 4815.614750819935, 4831.323614693937, 4247.171801498709, 4251.638610718092, 4310.913781724364, 4380.3210502372185, 4412.470503539564, 4332.06860524987, 4384.320430333303, 4394.956050439487, 4408.515063343029, 4450.020995381027, 4193.622573968358, 4273.166732487166, 4299.806508707115, 4299.849505267301, 4378.956210437918, 4320.6327462165755, 4346.15250026245, 4359.128174365108, 4361.563843615613, 4404.14119246747, 4293.29160688486, 4298.054428025861, 4305.50486694031, 4332.025294308787, 4357.542458041891, 4496.190685676577, 4550.158220729176, 4576.977115114437, 4608.976955115237, 4638.9536104638855, 5023.79904803811, 5025.14572522672, 5026.949730502722, 5034.723090230036, 5060.2662613920775, 5031.597472202252, 5044.445111037783, 5051.292819005343, 5061.139606266944, 5097.133487307166, 4592.265237562007, 4685.226937555333, 4771.5228477152, 4772.95227047732, 4778.259369797617, 5204.479552044765, 5205.0, 5208.114620514521, 5211.088059589557, 5217.686938783685, 4983.501649834988, 4997.650164488524, 4999.65002449825, 5006.949930500648, 5051.090803655377, 4907.484714104968, 5008.0, 5060.468650791688, 5100.923486147711, 5103.387593488805, 5004.0, 5029.069622119846, 5040.344755181803, 5040.59675225981, 5093.796248150033, 5007.824726134568, 5010.949890501121, 5011.498850114959, 5020.096382651085, 5024.824131155392, 4139.4204811326435, 4206.621404073648, 4208.705390622688, 4228.1966426378885, 4301.0537681709975, 3668.3580373434543, 3672.8530858765885, 3679.8528058877346, 3716.7955762433326, 3736.925261494755, 4297.699161058696, 4300.139972005549, 4301.827926882952, 4339.804708788112, 4348.717333373321, 4962.652614316963, 4976.253561965734, 5014.949850501448, 5054.241863720398, 5086.694798312114, 4289.335153051282, 4292.399064131024, 4295.82816687329, 4331.740095594275, 4346.043870348518, 4474.105178964221, 4474.664400170001, 4476.888077798016, 4480.081583275486, 4515.187266292033, 4557.407537020233, 4719.268513380432, 4772.761361931959, 4792.640551958547, 4807.543283388072, 5051.924221136613, 5074.340335756328, 5084.135696931605, 5085.796568137233, 5135.204043373283, 4774.40319960005, 4787.688800227974, 4792.400949881265, 4794.089123066607, 4838.153323168361, 4809.807607695653, 4862.246351815475, 4940.975295123645, 4941.555260026615, 4949.430815456269, 5048.368953880765, 5054.82308119214, 5070.721110338966, 5078.21287700407, 5123.462036486264, 4905.043516514245, 4909.926351104665, 4912.8771780705765, 4926.310316555613, 4928.901421971469, 4740.928886066781, 4885.926711099408, 4896.11869863428, 4950.579200767975, 4975.0, 4830.6135509159885, 4848.0788650156355, 4852.296417019583, 4864.0, 4880.951190488192, 4785.641076919175, 4971.453140154653, 4971.676841005323, 4978.228374601942, 5034.521720436553, 4738.502457242078, 4785.138675038387, 4790.5448982346625, 4816.34979277807, 4831.661783675109], "value": 4618.155737922113, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.6115472473542, 589.6020186374196, 589.7788329376483, 603.3785201242722, 605.7334772700015, 32802.0, 33099.0, 33372.164530950846, 33395.83302083489, 33423.66576334242, 36578.0, 37785.0, 37809.62190378096, 37845.810770946104, 37896.05259868505, 7144.0712707347975, 7653.043369578817, 7856.607169641524, 9451.621935122586, 9811.411315321104, 9613.615455381776, 9779.55991980359, 9785.168260697848, 9789.608415663364, 9794.265430092735, 9711.805763884753, 9829.65596204133, 9836.557354919047, 9837.950810245939, 9840.3603765755, 9763.121319081281, 9971.950140249324, 9972.301938864282, 9977.151942084894, 9993.80012399748, 10022.448765317904, 10085.294029417944, 10088.344257623305, 10089.243306751949, 10091.545880435324, 36524.0868978275, 36895.631043689486, 36937.63062369369, 36971.4454283186, 37046.44430333547, 2713.66079240095, 2767.2805070681766, 2852.6719427265716, 3383.9323213535836, 3529.8764543240864, 28107.718922810716, 28652.0, 28892.277693057633, 29518.409631807244, 29817.552736708967, 3506.9123271918406, 3541.203229273419, 3547.4324108142573, 3605.387084195693, 3656.780593164419, 240976.0, 241228.0, 241264.0, 241448.0, 241728.0, 52973.47026529763, 53876.46123538793, 54054.729726351114, 54159.458405416226, 54201.728991354794, 55300.0, 55596.722016389656, 55673.0, 55813.72093139508, 55828.720856395455, 12537.247765134121, 13830.515931942535, 14122.435102595986, 14128.788068178985, 14155.787663185061, 9378.5310734463, 9431.151196392357, 9511.524423778921, 9516.429014259029, 9749.561269742879, 17256.0, 17332.65334693299, 17544.736828947574, 17575.0333731646, 17579.20893559793, 5921.911171332434, 5999.520038396918, 6144.262688477322, 6226.875462490725, 6229.501639868799, 820.9860821884968, 916.6287653500343, 928.9734842998389, 975.1613612293422, 998.2962011781676, 26404.471910561682, 26438.47123057528, 26985.86507067452, 27037.0, 27159.456810864067, 1001.0519021481812, 1028.4857571214393, 1029.4749677664445, 1051.153821173947, 1067.5089458849016, 13652.522161724291, 14140.15159090458, 14174.503892363718, 14441.711165776836, 14518.346674399678, 343438.0, 343882.0, 347677.0, 349928.0, 350337.0, 49313.50686493089, 49650.255246171335, 49717.50282497201, 49775.75112124416, 49831.25253121206, 1090.3893819461127, 1112.2714621922653, 1134.8638163420442, 1180.0795379603924, 1219.451246938881, 23363.532729345658, 24895.128670496444, 25086.874565627786, 25139.371515712253, 25220.0, 34830.65169348376, 35099.0, 35203.471947921316, 35234.29531409409, 35360.64639353574, 230180.0, 231266.0, 231977.0, 232610.0, 233352.0, 25134.24597262085, 26099.0, 26371.4725705481, 26375.20874373772, 34253.48619770656, 36061.81969090138, 36206.637933620324, 36570.0, 36740.63259367372, 37167.0, 32375.190620234684, 32718.50922236216, 34775.65224347724, 35546.28907421786, 35933.28133437369, 34073.0, 34144.317113658086, 34352.65647343595, 34548.136296592784, 34613.78851740177, 33357.33285334231, 34084.488732668535, 34259.14352141217, 34451.82774086113, 34484.482732759534, 30080.54879176858, 31139.377212455172, 31357.8432107838, 31497.685023149475, 31540.684593154692, 23674.673198530192, 23763.1682891098, 24098.15656452016, 24299.149529766375, 24400.87799560991], "value": 17211.391208047287, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.5091432052652, 383.8809968909637, 384.3984164782116, 385.80709645177427, 401.11554023378454, 15560.455384061546, 16890.577735556602, 17037.914810425962, 17046.5738356541, 17072.82927170728, 11675.941620291887, 15340.769888451681, 16031.957922735013, 16058.27737751801, 16065.759013614805, 4634.884127896804, 4774.73738944358, 4820.301056346828, 4830.106430310386, 4834.951650483503, 3488.6685764852427, 6317.74729010839, 6934.618595977219, 6946.374826265635, 6954.4436445084275, 6474.902876456857, 6852.451803855704, 6929.792106236821, 6947.027416161742, 6947.513674042819, 6783.118194634715, 6808.148981377328, 6829.863402731918, 6837.042814006043, 6853.862922741567, 6457.547971641987, 6831.795046148623, 6833.726650933957, 6839.658017099175, 6847.965760171167, 20827.37517874451, 21213.5757284855, 21296.25463108784, 21581.46046348838, 21746.238881639223, 1947.3865732294282, 2000.3598848368529, 2025.767036790773, 2086.9165233390645, 2157.8273738100916, 6503.219613646345, 12994.245776820197, 13706.862931370659, 13881.0, 14040.648983775385, 1878.1078987480837, 1923.4037448390905, 1931.7199006144172, 1977.7330060441943, 1990.0547240061, 79206.20793792047, 79226.60386698088, 79311.603441983, 79453.0, 80346.79479807866, 16015.119168445613, 16221.837781622033, 16308.75536866948, 16316.42892498757, 16753.748693769605, 28643.14070577886, 28779.424411511653, 28836.567451488245, 28968.855155724086, 29008.27479312992, 7722.7297044603165, 8215.0, 8397.454165479225, 8423.663053477792, 8559.786005349915, 6717.1267735194115, 6730.966345168243, 6766.830829229309, 6840.760573379908, 6936.965315173392, 7084.681189346492, 8069.515829050159, 8318.459300145592, 8341.499510029296, 8412.705555305534, 2920.518114511082, 3327.441405274789, 3406.710429613461, 3448.069081314472, 3621.764585301947, 823.5100115431309, 834.8246868157634, 872.1583671756786, 872.9519876406731, 878.446578655443, 15690.607734806721, 16404.179791010403, 16515.91742041306, 16703.16484175786, 16897.915510422616, 870.6082262981557, 898.9820203596022, 901.2069378946616, 925.833349997007, 929.986314916744, 8895.043090520076, 9013.0, 9123.042080581576, 9460.432374057578, 9475.620975160917, 299228.0, 302675.0, 302897.0, 302983.0, 306059.0, 81026.59486702646, 85938.0, 86334.0, 86908.56545717358, 88374.0, 942.2085448223388, 953.609020301673, 974.0648976982035, 979.133466881829, 979.2117345536911, 15014.024088434217, 15245.16151611672, 15419.460318889234, 15446.0732356059, 15534.922325388752, 35950.460743089396, 36162.638373615926, 36198.27603447969, 36464.635353646125, 37294.81352593219, 45180.548194517636, 46170.307445387676, 46653.76673116613, 52028.47971520388, 53424.465755341946, 7467.477276590804, 7899.921000789918, 7903.407244456574, 8044.1955804419085, 8068.556229407204, 10105.545250463894, 11388.829167562659, 11690.0, 12073.094517911368, 12190.57332993341, 10007.499625018865, 10561.471926403496, 10615.203859710708, 10624.256302058782, 10688.946555267174, 10018.849717254101, 10136.898631013595, 10324.638637647646, 10375.429351385746, 10461.790764184825, 10325.586976520855, 10328.586856525655, 10443.68668939933, 10665.306755060896, 10810.621628242974, 7414.740484083031, 7506.924930750841, 7508.474406791691, 7554.395648348229, 7573.0, 9284.675036373694, 9554.426734395958, 9677.22582193437, 9720.0, 9807.970163133054], "value": 9082.18944776098, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1241.4475558376514, 1408.2677007955863, 1424.736423761604, 1535.8080239970004, 1752.1939907642484, 6756.594604323744, 7606.239376062391, 7814.531128132316, 7819.296263336299, 7846.411519136066, 7443.181250062489, 7610.353119984794, 7613.505122167056, 7613.809654758634, 7615.733449329275, 1936.806319368066, 2218.0, 2266.150193677371, 2293.0713061210236, 2306.573283942476, 2331.0, 2355.8233132515043, 2357.7288611809604, 2358.3396648938324, 2361.9055237790467, 2264.3320220534983, 2311.6879221305076, 2315.7568455312203, 2316.0, 2317.084751523147, 1930.691089425692, 2211.823054155672, 2281.863088214712, 2282.2354511238755, 2285.6228722260807, 2183.661532462455, 2190.485235969546, 2196.0556960506974, 2198.527316626933, 2250.707408036961, 7651.770446886547, 7767.300942915164, 7773.650185741655, 7774.416918731118, 7785.3771698264, 4425.690201685883, 4607.17070927233, 4607.654425918036, 4621.930671039937, 4622.884427889296, 2821.308779349052, 2852.6006359109742, 2865.957010644842, 2880.625518682579, 2893.14652177606, 915.9954200228956, 927.2720914082413, 932.5057719408725, 934.5654270764128, 948.7390967483997, 10244.28290019699, 10270.537825797783, 10283.742906427324, 10287.228457865614, 10294.69115926516, 4197.223513649923, 4371.125774845043, 4399.5380485049245, 4472.865814025585, 4477.529859364785, 8703.43427677199, 8766.0, 8766.780830479162, 8783.385163038525, 8790.824183516293, 4110.260153172398, 4610.239310513728, 4620.330052142421, 4634.837780677727, 4640.303954406866, 3826.827792749333, 3828.48315477407, 3829.0, 4203.600657937491, 4354.782260886943, 3713.313037088147, 3724.4413337998976, 3837.808109594509, 3849.4995650565247, 3883.689304855605, 1240.497598472602, 1255.554278231233, 1257.7295881385546, 1268.8413948256468, 1279.3922886628964, 709.1348554763181, 714.4070421550101, 748.8202831320444, 782.6595430987538, 816.0859836982618, 5227.111391063529, 5355.491228333302, 5368.543673787772, 5405.486478784588, 5413.783448662089, 837.4263629413871, 857.438377862501, 869.2133619074748, 891.5542228885557, 900.7252787899622, 3314.6519615440516, 3342.598888133391, 3400.4049291373913, 3441.913952151216, 3456.498807672873, 9287.0, 9613.134817866425, 9736.367136136128, 9741.172000380047, 9741.659041933499, 9613.951930240444, 9818.656347027963, 9917.900820991843, 9935.0, 9941.45322007282, 7405.740799072114, 7511.812204694817, 7535.886961695579, 7537.0, 7540.396768258526, 5120.897582048413, 5222.97388513055, 5308.309919710413, 5319.228711836685, 5359.812406565751, 8602.827943441222, 8752.51861147643, 8867.467951922905, 9056.728298151065, 9149.954250228706, 8719.258862996716, 8796.692115775917, 8979.685711000084, 9050.456972581404, 9095.454272743656, 6114.419130182626, 6429.58207716497, 6469.676516174267, 6546.378094081055, 6632.0, 7266.273372662691, 7285.453590980592, 7313.707451701873, 7328.963355183403, 7339.045924029842, 6422.743090276524, 6470.838229044311, 6563.212414510289, 6563.343665633399, 6699.631520266237, 6346.238451385863, 6499.350064993463, 6517.120188774455, 6531.11829902957, 6550.312217217123, 6058.5153187745755, 6188.752449901954, 6190.907136392868, 6192.040233763774, 6199.225096862892, 4341.978290108529, 4436.6228870546365, 4498.370228168124, 4509.909801804011, 4529.297958816389, 4386.166628340605, 4415.227335216388, 4449.0, 4461.04087621163, 4475.7985890635655], "value": 4120.719848580006, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.7735069425361, 318.1910836892268, 323.1372236129534, 326.7418739196035, 329.6818570079872, 5082.974585127074, 5149.433562308148, 5158.793648254065, 5163.612729045322, 5195.636305458619, 5104.617153713468, 5125.487451254882, 5127.1027570175165, 5128.743562821863, 5132.640715149941, 3808.5048943637357, 3859.4210868369687, 3998.1403998140395, 4007.9599204007877, 4041.7574945503216, 3948.348522493785, 4014.5985401459766, 4026.5570787213383, 4036.656884164835, 4053.3717273822604, 3803.0302272920367, 3998.52017757868, 4005.1388951375448, 4007.158496715693, 4007.759534427929, 3841.886962170795, 3985.8405663773415, 4002.6597739192202, 4002.9199416011515, 4004.619561141716, 3510.7717998330027, 3523.8061906595126, 3525.3207562252614, 3531.6468353164737, 3538.5576802899636, 4892.706437613754, 4914.778834952435, 4915.606751459874, 4922.901541969176, 4936.0, 4253.29820579604, 4511.345854851061, 4519.887002824923, 4530.546945305476, 4572.702774319659, 5348.572114230852, 5361.2226227197225, 5361.731913404353, 5364.812231571916, 5365.114756065244, 3770.8491660333552, 3770.924581508382, 3776.490173826553, 3778.3199024175638, 3787.867424640152, 5556.388048071437, 5602.075657516505, 5617.887642247173, 5641.661500309953, 5654.688992105433, 3846.788426636506, 3872.593377695358, 3877.5540812806325, 3880.6507414332846, 3889.4749208857006, 3922.058705910561, 3924.5682974872743, 3929.0766669832565, 3930.0960779020984, 3934.6655534279334, 4232.915341693149, 4519.0961807638605, 4526.162659907927, 4531.229690952546, 4537.137943790735, 5336.599755018389, 5349.358077030781, 5384.219288203189, 5407.242985981966, 5413.783448662089, 1341.1684755451683, 1364.3451143451, 1366.1393322206945, 1367.0089185340748, 1368.8562700916261, 854.769212312672, 894.3113802372267, 916.5142474488532, 922.7554698005034, 943.8867335919596, 4688.601468875116, 4690.226112691436, 4702.27114797207, 4719.150552900443, 4727.385439892861, 5465.562754979592, 5465.726713664301, 5473.507384335429, 5488.725563721798, 5504.311961004874, 4540.591346778806, 4712.387389639393, 4728.007118505084, 4732.763361831895, 4817.710937343771, 2974.568687540338, 2980.8360540170497, 2988.342564635777, 2999.3701322722036, 3002.6546947101365, 5267.525922666979, 5285.814996475105, 5287.41838397776, 5299.5230429261555, 5299.629025968223, 5573.523016400657, 5754.4533269339345, 5755.0, 5773.855653608609, 5777.133429985452, 5262.236975638511, 5269.762860671202, 5270.604704647167, 5273.182656688219, 5281.973590132102, 5487.5609951203005, 5619.747111380079, 5624.943750562606, 5626.2967129108865, 5638.154276858504, 5426.7829286829665, 5435.592330575144, 5483.643563168382, 5488.4237155098135, 5514.145307477187, 5220.269162317354, 5234.738263086907, 5242.082635538842, 5257.369115706139, 5274.285857096535, 3782.829772660182, 3851.480050193188, 3858.2090671411734, 3866.8259928303855, 3882.689384849262, 5526.778928842801, 5566.916496252478, 5568.359638641608, 5576.358718747234, 5595.440455954372, 5387.622866399314, 5388.865278368072, 5396.892062158657, 5401.270828438111, 5403.8108666196495, 5264.78940842362, 5346.716787970937, 5389.218563308376, 5396.46035396473, 5398.892022159614, 5016.347874776256, 5270.736463176902, 5312.309399778159, 5312.62811603184, 5319.627626066138, 5233.476652334736, 5311.9468805313, 5320.52115309624, 5333.093374126485, 5349.903269829598, 5297.629165958346, 5299.231611416246, 5300.70846103468, 5312.203169524448, 5318.813841515528], "value": 4047.4724881998604, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [617.8486270863638, 683.8666460040295, 740.1155619035253, 745.4479405632163, 763.3778470546507, 11389.373584452851, 11619.419029048535, 11655.650330490098, 11667.0, 11708.004819590335, 11743.47154378053, 13155.868441315584, 13403.46386144553, 13477.05660603758, 13477.123986940842, 626.4549841637781, 792.8969233999572, 794.0114557376074, 799.4124318625805, 799.7920540659442, 753.9773806785778, 761.3984951888002, 763.7097902796929, 764.9388048956098, 769.8768197088467, 806.189779271831, 807.7495976247382, 808.514891065359, 810.6514198894473, 828.2131974624101, 650.0931200974613, 668.2548957911941, 805.5126648377735, 810.5460941872541, 826.983460330793, 490.24257522128397, 577.1804038265673, 580.115324130704, 581.5028150930935, 586.8650210451577, 12830.16603920742, 12832.679183020498, 12861.0, 12864.29246391448, 12950.740985180244, 10581.735456613646, 11145.944270278678, 11212.775744485147, 11303.321800691985, 11466.885331146748, 9270.30472714549, 9287.58205880737, 9365.297602679826, 9428.387154834982, 9511.66709165176, 3279.9016029519153, 3285.3593549257903, 3343.3814744272386, 3374.5950485941844, 3395.422778127724, 48083.0, 48223.5177648226, 48274.03451930977, 48598.514014860106, 48636.75681621569, 9571.242313283268, 9702.660406885867, 9746.512674366253, 9754.804903901882, 9910.80178396428, 17598.0, 17604.471865844047, 17627.118644067745, 17628.823711762976, 17647.38234161798, 6577.80266592003, 6657.068010478537, 6700.329967003261, 6729.899051514231, 6840.657967101625, 3802.9809850951124, 3823.388257878726, 3871.8644847430205, 3885.0287428142965, 3999.4000899864673, 2944.573036909679, 3007.173027417434, 3011.9397612047637, 3013.3220025494525, 3014.050574069161, 494.97030178189425, 503.9395272567242, 504.20839282327125, 507.974601269935, 525.6714553404122, 395.82583663188103, 406.2747994829216, 454.45919355966294, 480.4450859257563, 525.7975679363473, 6601.141851559267, 6973.755918542826, 7102.431805455654, 7131.429485641136, 7354.154272258652, 452.53615044579567, 519.2341296587579, 574.9511291540182, 579.7478097027806, 589.8938191125553, 3325.9501107483406, 3366.141633883393, 3374.5275661407422, 3388.1698983748647, 3474.062003259106, 53277.0, 54276.72861635667, 54395.0, 54403.0, 54661.72669136629, 45330.0, 46525.30212046822, 46815.531844681114, 47493.0, 47621.28568071482, 42627.573724262984, 42706.0, 42806.357904631455, 43262.56737432585, 43410.78294608507, 6442.838929026624, 6504.642244676588, 6584.50616203777, 6629.834254143685, 6687.465002799861, 28720.138395848157, 28938.565921510773, 29877.701222987493, 30125.69874301229, 30221.395572088873, 36233.45649815308, 36671.0, 39083.80458097691, 39330.410043848795, 39682.0, 9069.410488318239, 9122.908770912207, 9147.542622868963, 9206.907930920604, 9331.486768227542, 11023.83464248021, 11241.775164496828, 11324.660260192208, 11486.770264594494, 11669.124815638692, 8429.747107586782, 10742.677719668422, 10745.140388768723, 11008.669739907815, 11205.327680339205, 10196.592136314464, 10221.182305415698, 10277.74305642365, 10352.223583231138, 10491.527881245209, 10391.948040259751, 10409.739756506147, 10427.061564459234, 10582.788344233226, 10658.307210031324, 8825.161609647073, 9006.684766033157, 9017.774555636162, 9239.39943903644, 9318.301127415336, 8945.37382383253, 8999.37004409685, 9060.682876099305, 9066.727998160066, 9137.838429250854], "value": 5682.885542599207, "unit": "score"}], "name": "dromaeo_css", "value": 6395.5067411843165, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 114.0, 108.0, 112.0, 113.0, 113.0, 102.0, 113.0, 113.0, 113.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 132.0, 164.0, 184.0, 132.0, 160.0, 158.0, 136.0, 181.0, 132.0], "value": 154.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 160.0, 166.0, 161.0, 160.0, 161.0, 161.0, 162.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 119.0, 120.0, 75.0, 73.0, 73.0, 115.0, 104.0, 77.0], "value": 90.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 147.0, 93.0, 94.0, 94.0, 149.0, 93.0, 93.0, 155.0], "value": 110.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 145.0, 146.0, 147.0, 146.0, 145.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 94.0, 94.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 65.0, 63.0, 65.0, 63.0, 88.0, 62.0, 63.0], "value": 66.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 64.0, 66.0, 65.0, 65.0, 65.0, 64.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 77.0, 80.0, 77.0, 80.0, 79.0, 79.0, 82.0, 80.0, 79.0], "value": 79.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 135.0, 135.0, 135.0, 132.0, 132.0, 133.0, 131.0, 165.0, 137.0], "value": 136.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 176.0, 175.0, 177.0, 178.0, 179.0, 173.0, 177.0, 178.0, 173.0], "value": 176.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 72.0, 72.0, 72.0, 71.0, 72.0, 74.0, 72.0, 71.0, 71.0], "value": 72.2, "unit": "score"}], "name": "kraken", "value": 1581.5, "alertThreshold": 2.0}]} 05:07:29 INFO - Return code: 0 05:07:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:07:29 ERROR - # TBPL SUCCESS # 05:07:29 INFO - Running post-action listener: _resource_record_post_action 05:07:29 INFO - Running post-run listener: _resource_record_post_run 05:07:30 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 518033408; Read time: 108; Write time: 508992 05:07:30 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234385408; Read time: 0; Write time: 281468 05:07:31 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283398144; Read time: 108; Write time: 227524 05:07:31 INFO - Running post-run listener: _upload_blobber_files 05:07:31 INFO - Blob upload gear active. 05:07:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:07:31 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:07:31 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:07:31 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:07:31 INFO - (blobuploader) - INFO - Open directory for files ... 05:07:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:07:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:07:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:32 INFO - (blobuploader) - INFO - Done attempting. 05:07:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:07:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:07:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:33 INFO - (blobuploader) - INFO - Done attempting. 05:07:33 INFO - (blobuploader) - INFO - Iteration through files over. 05:07:33 INFO - Return code: 0 05:07:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:07:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:07:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c1cbc563a3cd5a6299f62cf6cf3cf8b380f3331ab2d0b2fed7fcfdd18d8ffe18904320aa68e5f0134a7ef3f310bb097150f649c69265bcc62925c1afe5166f50", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/30a681186bad48542f4309513307d78cc69102eb277daff9e53c35597824c237784b46faa7ddf4acbd8b5b3afe845e0fd1422cc9db1796c70da5665c81dee681"} 05:07:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:07:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:07:33 INFO - Contents: 05:07:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c1cbc563a3cd5a6299f62cf6cf3cf8b380f3331ab2d0b2fed7fcfdd18d8ffe18904320aa68e5f0134a7ef3f310bb097150f649c69265bcc62925c1afe5166f50", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/30a681186bad48542f4309513307d78cc69102eb277daff9e53c35597824c237784b46faa7ddf4acbd8b5b3afe845e0fd1422cc9db1796c70da5665c81dee681"} 05:07:33 INFO - Running post-run listener: copy_logs_to_upload_dir 05:07:33 INFO - Copying logs to upload dir... 05:07:33 INFO - mkdir: /builds/slave/test/build/upload/logs 05:07:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.923607 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-04-25 05:07:33.179111) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:33.188101) ========= 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=523ca41ca1e0623de333ad52000001bf-1461584361.115146-403547558 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c1cbc563a3cd5a6299f62cf6cf3cf8b380f3331ab2d0b2fed7fcfdd18d8ffe18904320aa68e5f0134a7ef3f310bb097150f649c69265bcc62925c1afe5166f50", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/30a681186bad48542f4309513307d78cc69102eb277daff9e53c35597824c237784b46faa7ddf4acbd8b5b3afe845e0fd1422cc9db1796c70da5665c81dee681"} 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.011249 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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c1cbc563a3cd5a6299f62cf6cf3cf8b380f3331ab2d0b2fed7fcfdd18d8ffe18904320aa68e5f0134a7ef3f310bb097150f649c69265bcc62925c1afe5166f50", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/30a681186bad48542f4309513307d78cc69102eb277daff9e53c35597824c237784b46faa7ddf4acbd8b5b3afe845e0fd1422cc9db1796c70da5665c81dee681"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:33.212415) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:33.214751) ========= 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=523ca41ca1e0623de333ad52000001bf-1461584361.115146-403547558 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004378 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:33.295443) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 05:07:33.295795) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 05:07:33.296076) ========= ========= Total master_lag: 0.19 =========