builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-037 starttime: 1461250305.65 results: success (0) buildid: 20160421053046 builduid: 3d06878b03a0458bb10104cb21000e64 revision: f789cf6c7a5564260a6427492999dbf8bc93e065 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 07:51:45.647439) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 07:51:45.647873) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 07:51:45.648163) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 07:51:45.665628) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 07:51:45.666003) ========= 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=aa08bb06ff6271ef470a76a4000001be-1461249832.993885-325210016 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-21 07:51:45-- 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% 225M=0s 2016-04-21 07:51:46 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085522 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 07:51:45.765367) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 07:51:45.765832) ========= 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=aa08bb06ff6271ef470a76a4000001be-1461249832.993885-325210016 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015817 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 07:51:45.816680) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 07:51:45.817178) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f789cf6c7a5564260a6427492999dbf8bc93e065 --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 f789cf6c7a5564260a6427492999dbf8bc93e065 --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=aa08bb06ff6271ef470a76a4000001be-1461249832.993885-325210016 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-21 07:51:46,150 truncating revision to first 12 chars 2016-04-21 07:51:46,151 Setting DEBUG logging. 2016-04-21 07:51:46,151 attempt 1/10 2016-04-21 07:51:46,151 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f789cf6c7a55?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-21 07:51:46,408 unpacking tar archive at: fx-team-f789cf6c7a55/testing/mozharness/ program finished with exit code 0 elapsedTime=0.548739 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 07:51:46.378943) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 07:51:46.379269) ========= script_repo_revision: f789cf6c7a5564260a6427492999dbf8bc93e065 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 07:51:46.379681) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 07:51:46.379985) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 07:51:46.391302) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-04-21 07:51:46.391572) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa08bb06ff6271ef470a76a4000001be-1461249832.993885-325210016 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:51:46 INFO - MultiFileLogger online at 20160421 07:51:46 in /builds/slave/test 07:51:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 07:51:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:51:46 INFO - {'append_to_log': False, 07:51:46 INFO - 'base_work_dir': '/builds/slave/test', 07:51:46 INFO - 'blob_upload_branch': 'Fx-Team', 07:51:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:51:46 INFO - 'branch': 'Fx-Team', 07:51:46 INFO - 'buildbot_json_path': 'buildprops.json', 07:51:46 INFO - 'config_files': ('talos/linux_config.py',), 07:51:46 INFO - 'default_actions': ('clobber', 07:51:46 INFO - 'read-buildbot-config', 07:51:46 INFO - 'download-and-extract', 07:51:46 INFO - 'populate-webroot', 07:51:46 INFO - 'create-virtualenv', 07:51:46 INFO - 'install', 07:51:46 INFO - 'run-tests'), 07:51:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:51:46 INFO - 'download_minidump_stackwalk': True, 07:51:46 INFO - 'download_symbols': 'ondemand', 07:51:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:51:46 INFO - 'tooltool.py': '/tools/tooltool.py', 07:51:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:51:46 INFO - '/tools/misc-python/virtualenv.py')}, 07:51:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:51:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:51:46 INFO - 'installer_path': 'installer.exe', 07:51:46 INFO - 'log_level': 'info', 07:51:46 INFO - 'log_name': 'talos', 07:51:46 INFO - 'log_to_console': True, 07:51:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:51:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:51:46 INFO - 'opt_config_files': (), 07:51:46 INFO - 'pip_index': False, 07:51:46 INFO - 'sps_profile': False, 07:51:46 INFO - 'sps_profile_interval': 0, 07:51:46 INFO - 'suite': 'dromaeojs', 07:51:46 INFO - 'system_bits': '32', 07:51:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:51:46 INFO - 'title': 'talos-linux64-ix-037', 07:51:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:51:46 INFO - 'use_talos_json': True, 07:51:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:51:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:51:46 INFO - 'work_dir': 'build'} 07:51:46 INFO - ##### 07:51:46 INFO - ##### Running clobber step. 07:51:46 INFO - ##### 07:51:46 INFO - Running pre-action listener: _resource_record_pre_action 07:51:46 INFO - Running main action method: clobber 07:51:46 INFO - rmtree: /builds/slave/test/build 07:51:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:51:47 INFO - Running post-action listener: _resource_record_post_action 07:51:47 INFO - ##### 07:51:47 INFO - ##### Running read-buildbot-config step. 07:51:47 INFO - ##### 07:51:47 INFO - Running pre-action listener: _resource_record_pre_action 07:51:47 INFO - Running main action method: read_buildbot_config 07:51:47 INFO - Using buildbot properties: 07:51:47 INFO - { 07:51:47 INFO - "project": "", 07:51:47 INFO - "product": "firefox", 07:51:47 INFO - "script_repo_revision": "production", 07:51:47 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:51:47 INFO - "repository": "", 07:51:47 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 07:51:47 INFO - "buildid": "20160421053046", 07:51:47 INFO - "pgo_build": "True", 07:51:47 INFO - "basedir": "/builds/slave/test", 07:51:47 INFO - "buildnumber": 591, 07:51:47 INFO - "slavename": "talos-linux64-ix-037", 07:51:47 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:51:47 INFO - "platform": "ubuntu64_hw", 07:51:47 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 07:51:47 INFO - "branch": "fx-team", 07:51:47 INFO - "repo_path": "integration/fx-team", 07:51:47 INFO - "revision": "f789cf6c7a5564260a6427492999dbf8bc93e065", 07:51:47 INFO - "stage_platform": "linux64-pgo", 07:51:47 INFO - "builduid": "3d06878b03a0458bb10104cb21000e64", 07:51:47 INFO - "slavebuilddir": "test" 07:51:47 INFO - } 07:51:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/ctClDZIwT5Sy0uJFFlv8rA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 07:51:47 INFO - Running post-action listener: _resource_record_post_action 07:51:47 INFO - ##### 07:51:47 INFO - ##### Running download-and-extract step. 07:51:47 INFO - ##### 07:51:47 INFO - Running pre-action listener: _resource_record_pre_action 07:51:47 INFO - Running main action method: download_and_extract 07:51:47 INFO - mkdir: /builds/slave/test/build/tests 07:51:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:51:47 INFO - https://queue.taskcluster.net/v1/task/ctClDZIwT5Sy0uJFFlv8rA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:51:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ctClDZIwT5Sy0uJFFlv8rA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:51:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ctClDZIwT5Sy0uJFFlv8rA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:51:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ctClDZIwT5Sy0uJFFlv8rA/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 07:51:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ctClDZIwT5Sy0uJFFlv8rA/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 07:51:49 INFO - Downloaded 1361 bytes. 07:51:49 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:51:49 INFO - Using the following test package requirements: 07:51:49 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:51:49 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:51:49 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:51:49 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:49 INFO - u'jsshell-linux-x86_64.zip'], 07:51:49 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:51:49 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:51:49 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:51:49 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:51:49 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:51:49 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:51:49 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:51:49 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')]} 07:51:49 INFO - https://queue.taskcluster.net/v1/task/ctClDZIwT5Sy0uJFFlv8rA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:51:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ctClDZIwT5Sy0uJFFlv8rA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:51:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ctClDZIwT5Sy0uJFFlv8rA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:51:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ctClDZIwT5Sy0uJFFlv8rA/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 07:51:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ctClDZIwT5Sy0uJFFlv8rA/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 07:51:50 INFO - Downloaded 23847783 bytes. 07:51:50 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'] 07:51:50 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 07:51:51 INFO - Return code: 0 07:51:51 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 07:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:51:51 INFO - https://queue.taskcluster.net/v1/task/ctClDZIwT5Sy0uJFFlv8rA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:51:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ctClDZIwT5Sy0uJFFlv8rA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:51:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ctClDZIwT5Sy0uJFFlv8rA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:51:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ctClDZIwT5Sy0uJFFlv8rA/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 07:51:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ctClDZIwT5Sy0uJFFlv8rA/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 07:51:53 INFO - Downloaded 23847783 bytes. 07:51:53 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'] 07:51:53 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 07:51:54 INFO - Return code: 0 07:51:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:51:54 INFO - https://queue.taskcluster.net/v1/task/ctClDZIwT5Sy0uJFFlv8rA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:51:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ctClDZIwT5Sy0uJFFlv8rA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:51:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ctClDZIwT5Sy0uJFFlv8rA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:51:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ctClDZIwT5Sy0uJFFlv8rA/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 07:51:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ctClDZIwT5Sy0uJFFlv8rA/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 07:51:55 INFO - Downloaded 10845952 bytes. 07:51:55 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'] 07:51:55 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 07:51:55 INFO - Return code: 0 07:51:55 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')]} 07:51:55 INFO - https://queue.taskcluster.net/v1/task/ctClDZIwT5Sy0uJFFlv8rA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:51:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ctClDZIwT5Sy0uJFFlv8rA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:51:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ctClDZIwT5Sy0uJFFlv8rA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:51:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ctClDZIwT5Sy0uJFFlv8rA/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 07:51:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ctClDZIwT5Sy0uJFFlv8rA/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 07:51:57 INFO - Downloaded 58302107 bytes. 07:51:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ctClDZIwT5Sy0uJFFlv8rA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:51:57 INFO - mkdir: /builds/slave/test/properties 07:51:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:51:57 INFO - Writing to file /builds/slave/test/properties/build_url 07:51:57 INFO - Contents: 07:51:57 INFO - build_url:https://queue.taskcluster.net/v1/task/ctClDZIwT5Sy0uJFFlv8rA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:51:58 INFO - Running post-action listener: _resource_record_post_action 07:51:58 INFO - Running post-action listener: set_extra_try_arguments 07:51:58 INFO - ##### 07:51:58 INFO - ##### Running populate-webroot step. 07:51:58 INFO - ##### 07:51:58 INFO - Running pre-action listener: _resource_record_pre_action 07:51:58 INFO - Running main action method: populate_webroot 07:51:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:51:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:51:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:51:58 INFO - '--tppagecycles', 07:51:58 INFO - '7'], 07:51:58 INFO - 'tests': ['tsvgm']}}, 07:51:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:51:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:51:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:51:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:51:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:51:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:51:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:58 INFO - 'talos_options': ['--disable-e10s'], 07:51:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:51:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:51:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:58 INFO - 'talos_options': ['--disable-e10s'], 07:51:58 INFO - 'tests': ['damp', 'tps']}, 07:51:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:58 INFO - 'tests': ['damp', 'tps']}, 07:51:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:51:58 INFO - 'tests': ['dromaeo_dom']}, 07:51:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:51:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:51:58 INFO - 'tests': ['a11yr', 07:51:58 INFO - 'ts_paint', 07:51:58 INFO - 'tpaint', 07:51:58 INFO - 'sessionrestore', 07:51:58 INFO - 'sessionrestore_no_auto_restore', 07:51:58 INFO - 'tabpaint']}, 07:51:58 INFO - 'other-e10s': {'tests': ['a11yr', 07:51:58 INFO - 'ts_paint', 07:51:58 INFO - 'tpaint', 07:51:58 INFO - 'sessionrestore', 07:51:58 INFO - 'sessionrestore_no_auto_restore', 07:51:58 INFO - 'tabpaint']}, 07:51:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:51:58 INFO - 'ts_paint', 07:51:58 INFO - 'tpaint', 07:51:58 INFO - 'sessionrestore', 07:51:58 INFO - 'sessionrestore_no_auto_restore', 07:51:58 INFO - 'tabpaint']}, 07:51:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:51:58 INFO - 'ts_paint', 07:51:58 INFO - 'tpaint', 07:51:58 INFO - 'sessionrestore', 07:51:58 INFO - 'sessionrestore_no_auto_restore', 07:51:58 INFO - 'tabpaint']}, 07:51:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:51:58 INFO - 'tests': ['a11yr', 07:51:58 INFO - 'ts_paint', 07:51:58 INFO - 'tpaint', 07:51:58 INFO - 'sessionrestore', 07:51:58 INFO - 'sessionrestore_no_auto_restore', 07:51:58 INFO - 'tabpaint']}, 07:51:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:51:58 INFO - 'tests': ['a11yr', 07:51:58 INFO - 'ts_paint', 07:51:58 INFO - 'tpaint', 07:51:58 INFO - 'sessionrestore', 07:51:58 INFO - 'sessionrestore_no_auto_restore', 07:51:58 INFO - 'tabpaint']}, 07:51:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:51:58 INFO - 'tests': ['tsvgx', 07:51:58 INFO - 'tsvgr_opacity', 07:51:58 INFO - 'tart', 07:51:58 INFO - 'tscrollx', 07:51:58 INFO - 'cart']}, 07:51:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:51:58 INFO - 'tsvgr_opacity', 07:51:58 INFO - 'tart', 07:51:58 INFO - 'tscrollx', 07:51:58 INFO - 'cart']}, 07:51:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:58 INFO - 'talos_options': ['--disable-e10s'], 07:51:58 INFO - 'tests': ['tp5o']}, 07:51:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:58 INFO - 'tests': ['tp5o']}, 07:51:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:58 INFO - 'talos_options': ['--disable-e10s', 07:51:58 INFO - '--xperf_path', 07:51:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:51:58 INFO - 'tests': ['tp5n']}, 07:51:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:58 INFO - 'talos_options': ['--xperf_path', 07:51:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:51:58 INFO - 'tests': ['tp5n']}}, 07:51:58 INFO - 'talos.zip': {'path': '', 07:51:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:51:58 INFO - Running post-action listener: _resource_record_post_action 07:51:58 INFO - ##### 07:51:58 INFO - ##### Running create-virtualenv step. 07:51:58 INFO - ##### 07:51:58 INFO - Running pre-action listener: _resource_record_pre_action 07:51:58 INFO - Running main action method: create_virtualenv 07:51:58 INFO - Creating virtualenv /builds/slave/test/build/venv 07:51:58 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 07:51:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:51:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:51:58 INFO - Using real prefix '/usr' 07:51:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:51:58 INFO - Installing distribute.............................................................................................................................................................................................done. 07:52:00 INFO - Installing pip.................done. 07:52:00 INFO - Return code: 0 07:52:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:52: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')]} 07:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52: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')]} 07:52:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:00 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 0x7fcc535fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19de9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6d810>, '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 0x1a6e710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a6eba0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1461249832.993885-325210016', '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 07:52:00 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 07:52:00 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 07:52:00 INFO - Using env: {'DISPLAY': ':0', 07:52:00 INFO - 'HOME': '/home/cltbld', 07:52:00 INFO - 'LANG': 'en_US.UTF-8', 07:52:00 INFO - 'LANGUAGE': 'en_US:en', 07:52:00 INFO - 'LOGNAME': 'cltbld', 07:52:00 INFO - 'MAIL': '/var/mail/cltbld', 07:52:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:00 INFO - 'MOZ_NO_REMOTE': '1', 07:52:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:00 INFO - 'NO_EM_RESTART': '1', 07:52:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:00 INFO - 'PWD': '/builds/slave/test', 07:52:00 INFO - 'SHELL': '/bin/bash', 07:52:00 INFO - 'SHLVL': '1', 07:52:00 INFO - 'TERM': 'linux', 07:52:00 INFO - 'TMOUT': '86400', 07:52:00 INFO - 'USER': 'cltbld', 07:52:00 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1461249832.993885-325210016', 07:52:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:00 INFO - '_': '/tools/buildbot/bin/python'} 07:52:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:00 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 07:52:00 INFO - Cleaning up... 07:52:00 INFO - Return code: 0 07:52:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:52: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')]} 07:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52: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')]} 07:52:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:00 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 0x7fcc535fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19de9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6d810>, '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 0x1a6e710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a6eba0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1461249832.993885-325210016', '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 07:52:00 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 07:52:00 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 07:52:00 INFO - Using env: {'DISPLAY': ':0', 07:52:00 INFO - 'HOME': '/home/cltbld', 07:52:00 INFO - 'LANG': 'en_US.UTF-8', 07:52:00 INFO - 'LANGUAGE': 'en_US:en', 07:52:00 INFO - 'LOGNAME': 'cltbld', 07:52:00 INFO - 'MAIL': '/var/mail/cltbld', 07:52:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:00 INFO - 'MOZ_NO_REMOTE': '1', 07:52:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:00 INFO - 'NO_EM_RESTART': '1', 07:52:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:00 INFO - 'PWD': '/builds/slave/test', 07:52:00 INFO - 'SHELL': '/bin/bash', 07:52:00 INFO - 'SHLVL': '1', 07:52:00 INFO - 'TERM': 'linux', 07:52:00 INFO - 'TMOUT': '86400', 07:52:00 INFO - 'USER': 'cltbld', 07:52:00 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1461249832.993885-325210016', 07:52:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:00 INFO - '_': '/tools/buildbot/bin/python'} 07:52:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:01 INFO - Downloading/unpacking psutil>=0.7.1 07:52:01 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 07:52:01 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 07:52:01 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 07:52:01 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 07:52:01 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 07:52:01 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 07:52:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:52:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:52:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:52:03 INFO - Installing collected packages: psutil 07:52:03 INFO - Running setup.py install for psutil 07:52:03 INFO - building 'psutil._psutil_linux' extension 07:52:03 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 07:52:03 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 07:52:03 INFO - building 'psutil._psutil_posix' extension 07:52:03 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 07:52:03 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 07:52:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:52:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:52:03 INFO - Successfully installed psutil 07:52:03 INFO - Cleaning up... 07:52:03 INFO - Return code: 0 07:52:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:52: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')]} 07:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52: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')]} 07:52:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:03 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 0x7fcc535fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19de9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6d810>, '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 0x1a6e710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a6eba0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1461249832.993885-325210016', '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 07:52:03 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 07:52:03 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 07:52:03 INFO - Using env: {'DISPLAY': ':0', 07:52:03 INFO - 'HOME': '/home/cltbld', 07:52:03 INFO - 'LANG': 'en_US.UTF-8', 07:52:03 INFO - 'LANGUAGE': 'en_US:en', 07:52:03 INFO - 'LOGNAME': 'cltbld', 07:52:03 INFO - 'MAIL': '/var/mail/cltbld', 07:52:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:03 INFO - 'MOZ_NO_REMOTE': '1', 07:52:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:03 INFO - 'NO_EM_RESTART': '1', 07:52:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:03 INFO - 'PWD': '/builds/slave/test', 07:52:03 INFO - 'SHELL': '/bin/bash', 07:52:03 INFO - 'SHLVL': '1', 07:52:03 INFO - 'TERM': 'linux', 07:52:03 INFO - 'TMOUT': '86400', 07:52:03 INFO - 'USER': 'cltbld', 07:52:03 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1461249832.993885-325210016', 07:52:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:03 INFO - '_': '/tools/buildbot/bin/python'} 07:52:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:52:03 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 07:52:03 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 07:52:03 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 07:52:03 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 07:52:03 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 07:52:03 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 07:52:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:52:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:52:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:52:05 INFO - Installing collected packages: mozsystemmonitor 07:52:05 INFO - Running setup.py install for mozsystemmonitor 07:52:05 INFO - Successfully installed mozsystemmonitor 07:52:05 INFO - Cleaning up... 07:52:05 INFO - Return code: 0 07:52:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:52:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:05 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 0x7fcc535fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19de9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6d810>, '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 0x1a6e710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a6eba0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1461249832.993885-325210016', '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 07:52:05 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 07:52:05 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 07:52:05 INFO - Using env: {'DISPLAY': ':0', 07:52:05 INFO - 'HOME': '/home/cltbld', 07:52:05 INFO - 'LANG': 'en_US.UTF-8', 07:52:05 INFO - 'LANGUAGE': 'en_US:en', 07:52:05 INFO - 'LOGNAME': 'cltbld', 07:52:05 INFO - 'MAIL': '/var/mail/cltbld', 07:52:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:05 INFO - 'MOZ_NO_REMOTE': '1', 07:52:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:05 INFO - 'NO_EM_RESTART': '1', 07:52:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:05 INFO - 'PWD': '/builds/slave/test', 07:52:05 INFO - 'SHELL': '/bin/bash', 07:52:05 INFO - 'SHLVL': '1', 07:52:05 INFO - 'TERM': 'linux', 07:52:05 INFO - 'TMOUT': '86400', 07:52:05 INFO - 'USER': 'cltbld', 07:52:05 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1461249832.993885-325210016', 07:52:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:05 INFO - '_': '/tools/buildbot/bin/python'} 07:52:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:06 INFO - Downloading/unpacking blobuploader==1.2.4 07:52:06 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 07:52:06 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 07:52:06 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 07:52:06 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 07:52:06 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 07:52:06 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 07:52:07 INFO - Downloading blobuploader-1.2.4.tar.gz 07:52:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:52:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:52:08 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 07:52:08 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 07:52:08 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 07:52:08 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 07:52:08 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 07:52:08 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 07:52:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:52:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:52:08 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 07:52:08 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 07:52:08 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 07:52:08 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 07:52:08 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 07:52:08 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 07:52:08 INFO - Downloading docopt-0.6.1.tar.gz 07:52:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:52:08 INFO - Installing collected packages: blobuploader, requests, docopt 07:52:08 INFO - Running setup.py install for blobuploader 07:52:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:52:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:52:08 INFO - Running setup.py install for requests 07:52:09 INFO - Running setup.py install for docopt 07:52:09 INFO - Successfully installed blobuploader requests docopt 07:52:09 INFO - Cleaning up... 07:52:09 INFO - Return code: 0 07:52:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:52: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')]} 07:52:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52: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')]} 07:52:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:09 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 0x7fcc535fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19de9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6d810>, '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 0x1a6e710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a6eba0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1461249832.993885-325210016', '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 07:52:09 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 07:52:09 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 07:52:09 INFO - Using env: {'DISPLAY': ':0', 07:52:09 INFO - 'HOME': '/home/cltbld', 07:52:09 INFO - 'LANG': 'en_US.UTF-8', 07:52:09 INFO - 'LANGUAGE': 'en_US:en', 07:52:09 INFO - 'LOGNAME': 'cltbld', 07:52:09 INFO - 'MAIL': '/var/mail/cltbld', 07:52:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:09 INFO - 'MOZ_NO_REMOTE': '1', 07:52:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:09 INFO - 'NO_EM_RESTART': '1', 07:52:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:09 INFO - 'PWD': '/builds/slave/test', 07:52:09 INFO - 'SHELL': '/bin/bash', 07:52:09 INFO - 'SHLVL': '1', 07:52:09 INFO - 'TERM': 'linux', 07:52:09 INFO - 'TMOUT': '86400', 07:52:09 INFO - 'USER': 'cltbld', 07:52:09 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1461249832.993885-325210016', 07:52:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:09 INFO - '_': '/tools/buildbot/bin/python'} 07:52:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:52:09 INFO - Running setup.py (path:/tmp/pip-5RweN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:52:09 INFO - Running setup.py (path:/tmp/pip-Acdr8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:52:09 INFO - Running setup.py (path:/tmp/pip-K9iVwj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:52:09 INFO - Running setup.py (path:/tmp/pip-iE478J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:52:09 INFO - Running setup.py (path:/tmp/pip-j9TNGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:52:09 INFO - Running setup.py (path:/tmp/pip-7JKKm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:52:09 INFO - Running setup.py (path:/tmp/pip-GXHop4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:52:10 INFO - Running setup.py (path:/tmp/pip-OZkndz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:52:10 INFO - Running setup.py (path:/tmp/pip-SrHOSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:52:10 INFO - Running setup.py (path:/tmp/pip-pa6pkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:52:10 INFO - Running setup.py (path:/tmp/pip-XG0Ajx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:52:10 INFO - Running setup.py (path:/tmp/pip-buTsbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:52:10 INFO - Running setup.py (path:/tmp/pip-JTWG6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:52:10 INFO - Running setup.py (path:/tmp/pip-W5KSPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:52:10 INFO - Running setup.py (path:/tmp/pip-cCjCKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:52:10 INFO - Running setup.py (path:/tmp/pip-wxJIpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:52:10 INFO - Running setup.py (path:/tmp/pip-zm56DA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:52:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:52:10 INFO - Running setup.py install for manifestparser 07:52:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:52:10 INFO - Running setup.py install for mozcrash 07:52:10 INFO - Running setup.py install for mozdebug 07:52:11 INFO - Running setup.py install for mozdevice 07:52:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:52:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:52:11 INFO - Running setup.py install for mozfile 07:52:11 INFO - Running setup.py install for mozhttpd 07:52:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:52:11 INFO - Running setup.py install for mozinfo 07:52:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:52:11 INFO - Running setup.py install for mozInstall 07:52:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:52:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:52:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:52:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:52:11 INFO - Running setup.py install for mozleak 07:52:11 INFO - Running setup.py install for mozlog 07:52:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:52:11 INFO - Running setup.py install for moznetwork 07:52:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:52:11 INFO - Running setup.py install for mozprocess 07:52:12 INFO - Running setup.py install for mozprofile 07:52:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:52:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:52:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:52:12 INFO - Running setup.py install for mozrunner 07:52:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:52:12 INFO - Running setup.py install for mozscreenshot 07:52:12 INFO - Running setup.py install for moztest 07:52:12 INFO - Running setup.py install for mozversion 07:52:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:52:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:52:12 INFO - Cleaning up... 07:52:12 INFO - Return code: 0 07:52:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:52: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')]} 07:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52: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')]} 07:52:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:12 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 0x7fcc535fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19de9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6d810>, '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 0x1a6e710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a6eba0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1461249832.993885-325210016', '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 07:52:12 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 07:52:12 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 07:52:12 INFO - Using env: {'DISPLAY': ':0', 07:52:12 INFO - 'HOME': '/home/cltbld', 07:52:12 INFO - 'LANG': 'en_US.UTF-8', 07:52:12 INFO - 'LANGUAGE': 'en_US:en', 07:52:12 INFO - 'LOGNAME': 'cltbld', 07:52:12 INFO - 'MAIL': '/var/mail/cltbld', 07:52:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:12 INFO - 'MOZ_NO_REMOTE': '1', 07:52:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:12 INFO - 'NO_EM_RESTART': '1', 07:52:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:12 INFO - 'PWD': '/builds/slave/test', 07:52:12 INFO - 'SHELL': '/bin/bash', 07:52:12 INFO - 'SHLVL': '1', 07:52:12 INFO - 'TERM': 'linux', 07:52:12 INFO - 'TMOUT': '86400', 07:52:12 INFO - 'USER': 'cltbld', 07:52:12 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1461249832.993885-325210016', 07:52:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:12 INFO - '_': '/tools/buildbot/bin/python'} 07:52:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:52:12 INFO - Running setup.py (path:/tmp/pip-AVVwGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:52:12 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)) 07:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:52:12 INFO - Running setup.py (path:/tmp/pip-Mx1qBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:52:12 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)) 07:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:52:12 INFO - Running setup.py (path:/tmp/pip-4x0ymk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:52:12 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)) 07:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:52:12 INFO - Running setup.py (path:/tmp/pip-Gjnftt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:52:13 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)) 07:52:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:52:13 INFO - Running setup.py (path:/tmp/pip-TKjnRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:52:13 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)) 07:52:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:52:13 INFO - Running setup.py (path:/tmp/pip-7cTFM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:52:13 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)) 07:52:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:52:13 INFO - Running setup.py (path:/tmp/pip-iyDwZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:52:13 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)) 07:52:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:52:13 INFO - Running setup.py (path:/tmp/pip-VKc_Pe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:52:13 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)) 07:52:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:52:13 INFO - Running setup.py (path:/tmp/pip-OADjIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:52:13 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)) 07:52:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:52:13 INFO - Running setup.py (path:/tmp/pip-2sCCUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:52:13 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)) 07:52:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:52:13 INFO - Running setup.py (path:/tmp/pip-7s20jx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:52:13 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)) 07:52:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:52:13 INFO - Running setup.py (path:/tmp/pip-NNY7co-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:52:13 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)) 07:52:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:52:13 INFO - Running setup.py (path:/tmp/pip-ohyfzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:52:13 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)) 07:52:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:52:13 INFO - Running setup.py (path:/tmp/pip-0ow5Jl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:52:13 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)) 07:52:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:52:13 INFO - Running setup.py (path:/tmp/pip-aork6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:52:13 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)) 07:52:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:52:13 INFO - Running setup.py (path:/tmp/pip-i7hr9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:52:13 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)) 07:52:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:52:13 INFO - Running setup.py (path:/tmp/pip-asjy9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:52:13 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)) 07:52:13 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)) 07:52:13 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)) 07:52:13 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)) 07:52:13 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)) 07:52:13 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)) 07:52:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:52: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 07:52: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 07:52: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 07:52: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 07:52: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 07:52: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 07:52:15 INFO - Downloading blessings-1.6.tar.gz 07:52:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:52:15 INFO - Installing collected packages: blessings 07:52:15 INFO - Running setup.py install for blessings 07:52:16 INFO - Successfully installed blessings 07:52:16 INFO - Cleaning up... 07:52:16 INFO - Return code: 0 07:52:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:52:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:52:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:52:16 INFO - Reading from file tmpfile_stdout 07:52:16 INFO - Current package versions: 07:52:16 INFO - argparse == 1.2.1 07:52:16 INFO - blessings == 1.6 07:52:16 INFO - blobuploader == 1.2.4 07:52:16 INFO - docopt == 0.6.1 07:52:16 INFO - manifestparser == 1.1 07:52:16 INFO - mozInstall == 1.12 07:52:16 INFO - mozcrash == 0.17 07:52:16 INFO - mozdebug == 0.1 07:52:16 INFO - mozdevice == 0.48 07:52:16 INFO - mozfile == 1.2 07:52:16 INFO - mozhttpd == 0.7 07:52:16 INFO - mozinfo == 0.9 07:52:16 INFO - mozleak == 0.1 07:52:16 INFO - mozlog == 3.1 07:52:16 INFO - moznetwork == 0.27 07:52:16 INFO - mozprocess == 0.22 07:52:16 INFO - mozprofile == 0.28 07:52:16 INFO - mozrunner == 6.11 07:52:16 INFO - mozscreenshot == 0.1 07:52:16 INFO - mozsystemmonitor == 0.0 07:52:16 INFO - moztest == 0.7 07:52:16 INFO - mozversion == 1.4 07:52:16 INFO - psutil == 3.1.1 07:52:16 INFO - requests == 1.2.3 07:52:16 INFO - wsgiref == 0.1.2 07:52:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:52:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:16 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 0x7fcc535fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19de9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6d810>, '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 0x1a6e710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a6eba0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1461249832.993885-325210016', '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 07:52:16 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 07:52:16 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 07:52:16 INFO - Using env: {'DISPLAY': ':0', 07:52:16 INFO - 'HOME': '/home/cltbld', 07:52:16 INFO - 'LANG': 'en_US.UTF-8', 07:52:16 INFO - 'LANGUAGE': 'en_US:en', 07:52:16 INFO - 'LOGNAME': 'cltbld', 07:52:16 INFO - 'MAIL': '/var/mail/cltbld', 07:52:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:16 INFO - 'MOZ_NO_REMOTE': '1', 07:52:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:16 INFO - 'NO_EM_RESTART': '1', 07:52:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:16 INFO - 'PWD': '/builds/slave/test', 07:52:16 INFO - 'SHELL': '/bin/bash', 07:52:16 INFO - 'SHLVL': '1', 07:52:16 INFO - 'TERM': 'linux', 07:52:16 INFO - 'TMOUT': '86400', 07:52:16 INFO - 'USER': 'cltbld', 07:52:16 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1461249832.993885-325210016', 07:52:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:16 INFO - '_': '/tools/buildbot/bin/python'} 07:52:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:16 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)) 07:52:16 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)) 07:52:16 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)) 07:52:16 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)) 07:52:16 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)) 07:52:16 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)) 07:52:16 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)) 07:52:16 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)) 07:52:16 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)) 07:52:16 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)) 07:52:16 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)) 07:52:16 INFO - Cleaning up... 07:52:16 INFO - Return code: 0 07:52:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:52:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:16 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 0x7fcc535fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19de9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6d810>, '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 0x1a6e710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a6eba0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1461249832.993885-325210016', '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 07:52:16 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 07:52:16 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 07:52:16 INFO - Using env: {'DISPLAY': ':0', 07:52:16 INFO - 'HOME': '/home/cltbld', 07:52:16 INFO - 'LANG': 'en_US.UTF-8', 07:52:16 INFO - 'LANGUAGE': 'en_US:en', 07:52:16 INFO - 'LOGNAME': 'cltbld', 07:52:16 INFO - 'MAIL': '/var/mail/cltbld', 07:52:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:16 INFO - 'MOZ_NO_REMOTE': '1', 07:52:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:16 INFO - 'NO_EM_RESTART': '1', 07:52:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:16 INFO - 'PWD': '/builds/slave/test', 07:52:16 INFO - 'SHELL': '/bin/bash', 07:52:16 INFO - 'SHLVL': '1', 07:52:16 INFO - 'TERM': 'linux', 07:52:16 INFO - 'TMOUT': '86400', 07:52:16 INFO - 'USER': 'cltbld', 07:52:16 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1461249832.993885-325210016', 07:52:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:16 INFO - '_': '/tools/buildbot/bin/python'} 07:52:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:16 INFO - Downloading/unpacking jsonschema 07:52: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 07:52: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 07:52: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 07:52: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 07:52: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 07:52: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 07:52:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:52:18 INFO - Downloading/unpacking functools32 (from jsonschema) 07:52:18 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 07:52:18 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 07:52:18 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 07:52:18 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 07:52:18 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 07:52:18 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 07:52:18 INFO - Downloading functools32-3.2.3-2.tar.gz 07:52:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:52:18 INFO - warning: no files found matching '*.txt' 07:52:18 INFO - no previously-included directories found matching 'build' 07:52:18 INFO - no previously-included directories found matching 'dist' 07:52:18 INFO - no previously-included directories found matching '.git*' 07:52:18 INFO - Installing collected packages: jsonschema, functools32 07:52:18 INFO - Running setup.py install for functools32 07:52:19 INFO - warning: no files found matching '*.txt' 07:52:19 INFO - no previously-included directories found matching 'build' 07:52:19 INFO - no previously-included directories found matching 'dist' 07:52:19 INFO - no previously-included directories found matching '.git*' 07:52:19 INFO - Successfully installed jsonschema functools32 07:52:19 INFO - Cleaning up... 07:52:19 INFO - Return code: 0 07:52:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:52:19 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')]} 07:52:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:19 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')]} 07:52:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:19 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 0x7fcc535fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19de9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6d810>, '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 0x1a6e710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a6eba0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1461249832.993885-325210016', '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 07:52:19 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 07:52:19 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 07:52:19 INFO - Using env: {'DISPLAY': ':0', 07:52:19 INFO - 'HOME': '/home/cltbld', 07:52:19 INFO - 'LANG': 'en_US.UTF-8', 07:52:19 INFO - 'LANGUAGE': 'en_US:en', 07:52:19 INFO - 'LOGNAME': 'cltbld', 07:52:19 INFO - 'MAIL': '/var/mail/cltbld', 07:52:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:19 INFO - 'MOZ_NO_REMOTE': '1', 07:52:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:19 INFO - 'NO_EM_RESTART': '1', 07:52:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:19 INFO - 'PWD': '/builds/slave/test', 07:52:19 INFO - 'SHELL': '/bin/bash', 07:52:19 INFO - 'SHLVL': '1', 07:52:19 INFO - 'TERM': 'linux', 07:52:19 INFO - 'TMOUT': '86400', 07:52:19 INFO - 'USER': 'cltbld', 07:52:19 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1461249832.993885-325210016', 07:52:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:19 INFO - '_': '/tools/buildbot/bin/python'} 07:52:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:19 INFO - Downloading/unpacking flake8 07:52:19 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 07:52:19 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 07:52:19 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 07:52:19 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 07:52:19 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 07:52:19 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 07:52:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:52:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:52:21 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 07:52:21 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 07:52:21 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 07:52:21 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 07:52:21 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 07:52:21 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 07:52:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:52:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:52:21 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 07:52:21 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 07:52:21 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 07:52:21 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 07:52:21 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 07:52:21 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 07:52:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:52:21 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 07:52:21 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 07:52:21 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 07:52:21 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 07:52:21 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 07:52:21 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 07:52:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:52:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:52:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:52:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:52:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:52:21 INFO - no previously-included directories found matching 'docs/_build' 07:52:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:52:21 INFO - Running setup.py install for pep8 07:52:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:52:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:52:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:52:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:52:22 INFO - no previously-included directories found matching 'docs/_build' 07:52:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:52:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:52:22 INFO - Cleaning up... 07:52:22 INFO - Return code: 0 07:52:22 INFO - Running post-action listener: _resource_record_post_action 07:52:22 INFO - Running post-action listener: _start_resource_monitoring 07:52:22 INFO - Starting resource monitoring. 07:52:22 INFO - ##### 07:52:22 INFO - ##### Running install step. 07:52:22 INFO - ##### 07:52:22 INFO - Running pre-action listener: _resource_record_pre_action 07:52:22 INFO - Running main action method: install 07:52:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:52:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:52:22 INFO - Reading from file tmpfile_stdout 07:52:22 INFO - Detecting whether we're running mozinstall >=1.0... 07:52:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:52:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:52:22 INFO - Reading from file tmpfile_stdout 07:52:22 INFO - Output received: 07:52:22 INFO - Usage: mozinstall [options] installer 07:52:22 INFO - Options: 07:52:22 INFO - -h, --help show this help message and exit 07:52:22 INFO - -d DEST, --destination=DEST 07:52:22 INFO - Directory to install application into. [default: 07:52:22 INFO - "/builds/slave/test"] 07:52:22 INFO - --app=APP Application being installed. [default: firefox] 07:52:22 INFO - mkdir: /builds/slave/test/build/application 07:52:22 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'] 07:52:22 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 07:52:38 INFO - Reading from file tmpfile_stdout 07:52:38 INFO - Output received: 07:52:38 INFO - /builds/slave/test/build/application/firefox/firefox 07:52:38 INFO - Running post-action listener: _resource_record_post_action 07:52:38 INFO - ##### 07:52:38 INFO - ##### Running run-tests step. 07:52:38 INFO - ##### 07:52:38 INFO - Running pre-action listener: _resource_record_pre_action 07:52:38 INFO - Running main action method: run_tests 07:52:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:52:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:52:39 INFO - Python 2.7.3 07:52:39 INFO - Return code: 0 07:52:39 INFO - grabbing minidump binary from tooltool 07:52:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:39 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 0x1a6d810>, '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 0x1a6e710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a6eba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:52:39 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 07:52:39 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 07:52:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:52:39 INFO - Return code: 0 07:52:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:52:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:52:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:52:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:52:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:52:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:52:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:52:40 INFO - Return code: 0 07:52:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ctClDZIwT5Sy0uJFFlv8rA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 07:52:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ctClDZIwT5Sy0uJFFlv8rA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 07:52:40 INFO - Using env: {'DISPLAY': ':0', 07:52:40 INFO - 'HOME': '/home/cltbld', 07:52:40 INFO - 'LANG': 'en_US.UTF-8', 07:52:40 INFO - 'LANGUAGE': 'en_US:en', 07:52:40 INFO - 'LOGNAME': 'cltbld', 07:52:40 INFO - 'MAIL': '/var/mail/cltbld', 07:52:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:52:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:52:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:40 INFO - 'MOZ_NO_REMOTE': '1', 07:52:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:52:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:40 INFO - 'NO_EM_RESTART': '1', 07:52:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:40 INFO - 'PWD': '/builds/slave/test', 07:52:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:52:40 INFO - 'SHELL': '/bin/bash', 07:52:40 INFO - 'SHLVL': '1', 07:52:40 INFO - 'TERM': 'linux', 07:52:40 INFO - 'TMOUT': '86400', 07:52:40 INFO - 'USER': 'cltbld', 07:52:40 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1461249832.993885-325210016', 07:52:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:40 INFO - '_': '/tools/buildbot/bin/python'} 07:52:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ctClDZIwT5Sy0uJFFlv8rA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 07:52:40 INFO - mozversion application_buildid: 20160421053046 07:52:40 INFO - mozversion application_changeset: f789cf6c7a5564260a6427492999dbf8bc93e065 07:52:40 INFO - mozversion application_display_name: Nightly 07:52:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:52:40 INFO - mozversion application_name: Firefox 07:52:40 INFO - mozversion application_remotingname: firefox 07:52:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:52:40 INFO - mozversion application_vendor: Mozilla 07:52:40 INFO - mozversion application_version: 48.0a1 07:52:40 INFO - mozversion platform_buildid: 20160421053046 07:52:40 INFO - mozversion platform_changeset: f789cf6c7a5564260a6427492999dbf8bc93e065 07:52:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:52:40 INFO - mozversion platform_version: 48.0a1 07:52:40 INFO - using testdate: 1461250360 07:52:40 INFO - actual date: 1461250360 07:52:40 INFO - starting webserver on 'localhost:56666' 07:52:40 INFO - SUITE-START | Running 2 tests 07:52:40 INFO - TEST-START | dromaeo_css 07:52:40 INFO - operating with platform_type : linux_ 07:52:40 INFO - Initialising browser for dromaeo_css test... 07:52:40 INFO - TEST-INFO | started process 4730 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYww6Tm/profile http://localhost:56666/getInfo.html) 07:52:44 INFO - PROCESS | 4730 | __metrics Screen width/height:1600/1200 07:52:44 INFO - PROCESS | 4730 | colorDepth:24 07:52:44 INFO - PROCESS | 4730 | Browser inner width/height: 1024/697 07:52:44 INFO - PROCESS | 4730 | __metrics 07:52:45 ERROR - PROCESS | 4730 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:52:46 INFO - TEST-INFO | 4730: exit 0 07:52:46 INFO - Browser initialized. 07:52:46 INFO - Running cycle 1/1 for dromaeo_css test... 07:52:46 INFO - TEST-INFO | started process 4810 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYww6Tm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:52:58 INFO - PROCESS | 4810 | RSS: Main: 153518080 07:52:58 INFO - PROCESS | 4810 | 07:53:49 INFO - PROCESS | 4810 | 1461250429215 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] 07:55:56 INFO - PROCESS | 4810 | Cycle 1(1): loaded http://localhost:56666/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56666/tests/dromaeo/cssquery-ext.html) 07:55:57 INFO - PROCESS | 4810 | RSS: Main: 254300160 07:55:57 INFO - PROCESS | 4810 | 07:59:00 INFO - PROCESS | 4810 | Cycle 1(1): loaded http://localhost:56666/tests/dromaeo/cssquery-ext.html (next: http://localhost:56666/tests/dromaeo/cssquery-jquery.html) 07:59:00 INFO - PROCESS | 4810 | RSS: Main: 230879232 07:59:00 INFO - PROCESS | 4810 | 08:02:02 INFO - PROCESS | 4810 | Cycle 1(1): loaded http://localhost:56666/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56666/tests/dromaeo/cssquery-mootools.html) 08:02:03 INFO - PROCESS | 4810 | RSS: Main: 227401728 08:02:03 INFO - PROCESS | 4810 | 08:05:05 INFO - PROCESS | 4810 | Cycle 1(1): loaded http://localhost:56666/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56666/tests/dromaeo/cssquery-prototype.html) 08:05:05 INFO - PROCESS | 4810 | RSS: Main: 226246656 08:05:05 INFO - PROCESS | 4810 | 08:08:08 INFO - PROCESS | 4810 | Cycle 1(1): loaded http://localhost:56666/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56666/tests/dromaeo/cssquery-yui.html) 08:08:08 INFO - PROCESS | 4810 | RSS: Main: 225132544 08:08:08 INFO - PROCESS | 4810 | 08:11:11 INFO - PROCESS | 4810 | Cycle 1(1): loaded http://localhost:56666/tests/dromaeo/cssquery-yui.html (next: http://localhost:56666/tests/dromaeo/cssquery-dojo.html) 08:11:11 INFO - PROCESS | 4810 | RSS: Main: 263192576 08:11:11 INFO - PROCESS | 4810 | 08:11:11 INFO - PROCESS | 4810 | __start_tp_report 08:11:11 INFO - PROCESS | 4810 | _x_x_mozilla_page_load 08:11:11 INFO - PROCESS | 4810 | _x_x_mozilla_page_load_details 08:11:11 INFO - PROCESS | 4810 | |i|pagename|runs| 08:11:11 INFO - PROCESS | 4810 | |0;dojo.html;3047.070643453747;3118.73490753286;3149.748020158386;3164.114048066541;3185.1240908750096;5018.071656743496;5188.8702782430455;5219.608529360304;5228.085085110105;5250.658707184035;5220.504052115043;5226.5557427618605;5253.947460525394;5258.526732594066;5262.23697563854;4690.296455531663;4726.952730472694;4767.1419144553965;4809.1343558159515;4901.901961960759;4791.2094504406905;4811.182099043153;4815.374001379833;4862.07620552094;4868.756562171895;4641.419822522184;4699.765011749416;4737.526247375269;4786.401699787544;4806.591439727627;4727.503612120712;4744.976275118637;4753.619710423158;4754.263089221176;4781.545753153445;4632.490426053131;4699.953000469985;4709.764511774431;4731.455882573514;4784.043191361741;5170.508801663836;5203.895922081537;5224.582033437354;5227.817026404057;5261.026710058652;5579.274694289757;5594.86012849682;5597.7201139943245;5597.74810133545;5598.272224610815;5564.638298510625;5605.299337582802;5632.295963004624;5635.239242702224;5640.153976903456;5261.368635763694;5277.920831187535;5329.173978033411;5359.732013399314;5363.222332761728;5825.883482330414;5847.619904706181;5849.795257165979;5852.063669812809;5854.912176317359;5338.199270109437;5538.141588053858;5602.803901863496;5615.326160860723;5623.550115990711;5494.340679118452;5496.148097044965;5500.4499550045475;5502.5597952163735;5559.388467268597;5479.643823151562;5479.890402191933;5480.040992826319;5504.4495550444635;5532.695701736363;5339.786408543615;5500.312460942382;5570.749316280777;5636;5677.886442271131;4283.764392958355;4293.034067334825;4296.548862369469;4299.462567179103;4321.373400856858;3828.578856325802;3849.3071247175776;3858.074062225046;3880.0881792778673;3882.650561449483;5166.948330516647;5281.39263984639;5319.228711836762;5365.222042803772;5373.140297552372;5636.126400407943;5642.85892852682;5663.631863928831;5669.206311116447;5673.574481913873;5082.771275292621;5284.445133261029;5292.92060619091;5299.6290259681455;5338.97330513345;4784.497627749036;4785.617150627942;4851.345068415719;4882.853514394574;4882.9755851221225;5735.541156707453;5753.683547404849;5757.798477053283;5764.625299355528;5771.509421699203;5467.043267428105;5621.80323688669;5624.887502250014;5642.069058605284;5686.573506987075;5692.772289108555;5710.37185909558;5718.971405143114;5722.284714410699;5779.508741756829;5468.781248750005;5492.231087647652;5497.642653227527;5505.064139096443;5523.337199536081;5497.120460726264;5611.523020543136;5613.354464236665;5638.379778224474;5732.742026608729;5424.620276580601;5425.755840987086;5425.755840987086;5429.809956651498;5473.726313684379;5402.432744561765;5404.432534583812;5404.675719456845;5422.5119739223655;5450.31871016123;5271.920921186109;5332.6000549958135;5405.405405405481;5482.890342193214;5484.972575137099;5474.260974768515;5476.315460567429;5481.643693159932;5482.39693633692;5488.506034456918;5363.624546281723;5370.221317908803;5372.435894231049;5374.11327131019;5375.946240537701 08:11:11 INFO - PROCESS | 4810 | |1;ext.html;590.8197999610122;598.0759726222985;626.2141013028648;651.9340877665019;665.3712241931377;30499.237519062033;37324.44013339802;38484;38484.42273365898;38520;41663.16673666533;42313.78843105788;42358.36462453058;42421;42543.57456425435;7421.109466863957;8663.523506207157;8912.287017038621;8912.598933048028;8913.376063675545;10014.699559013241;10463.058324750771;10473.26687131901;10476.633317833877;10477;10177.440240786755;10285.64000259991;10288.48557572122;10291.63979260726;10293.897061029369;7612.809679757995;9898.703038908772;10021.048000439947;10119.595216191381;10230.028147326066;9997.500124993721;10135.746606334827;10138.594456221743;10139.340942838691;10142.239332050125;37316.44025339595;37775.81112094422;37932.81033594815;38162.85511434662;38167.618323816685;3399.473081672345;3638.6361363863666;3827.9043023924346;4185;4233.767142807144;31745.841270793728;32206.677933220602;32557.51163732546;32698.509522357184;32864.17839554006;4178.206140833232;4344.1963236800975;4357.368181613649;4372.366006929009;4374.387585737999;306990;311503;312848;313564;313816;35361.46957795635;57504.424955749906;57800.71099644559;57816;57823.421765782645;29849.552256716168;29891.551626725617;30008.54987175194;30012.699873001427;30023.849880750895;14716;14981.101133932;15003.17482538449;15025;15034.548963531111;12561.87438125607;12633.178843375152;12634.684132896567;12635.93682031584;12639;8490.448120872246;8543.530105844115;8583.785405364915;8627.266682331947;8633.827323453495;3046.4211799757977;3301.5873015873017;3328.5839270091237;3355.765096443274;3363.209645733251;874.2175752701297;913.2967614936462;939.6241503398559;973.5667627905656;1063.8989296016866;28669.426611467654;29183.270418239714;29526.641883519205;29583;29713.702862971524;1105.182165197748;1126.1328776841785;1155.653304008794;1166.2710805746408;1175.6590588729173;16648.916755416147;17158.82841171597;17209.655806884042;17253.041289924673;17377.56556086083;461820;467525;469411;469489;471419;55644;56523;56741;56839.71580142073;56897;1248.9687757806128;1287.8068289756611;1300.9479620815061;1368.3090039529973;1406.0509156319647;25297.988080476574;25844.483110338064;26336;26518.867405662848;28247.858760706065;45778;46220.76889615665;46443.303350449096;46459.76770116263;46488;283624;284468;285559;285756;286043;24767.25698229056;27489.31276718098;28722.13833584996;29562.55656165202;29580.408391831614;34892;37200.81399592985;45227.77386113048;45594;46274.768626156656;37656.24687506289;37929.241415172095;38643.80678096592;38875.222495549366;39213.2157356857;36733.08167295839;37798;38582.61417385902;38927;38998;38902.22195556016;39874.92865473903;40387;40544.594554054085;40987.18025639411;31633.20916977094;34095.82952085224;34539;34719.305613888086;34750.304993900485;26999;27460.45079098447;27566.5865012029;27601.58597620997;27602.309942250802 08:11:11 INFO - PROCESS | 4810 | |2;jquery.html;398.6491887139317;400.1337105167313;402.9576894426085;406.80473372781086;412.8864562245382;13146.474141034347;15492.535223943272;17791.377301794422;18505.537361565952;18557.81442185578;14833.703325933502;16900.239489222982;17840.464786056407;18626.254949802027;18714.53213669659;5388.245645609628;5630.239917611111;5641.069223578125;5642.520385767215;5642.633228840133;3985.720999530034;5567.47109024644;5951.077582974624;6271.122042913996;6278.843028924291;6183.072539119124;6199.101130336121;6200.937990620104;6228.719707613168;6231.937680623181;5296.152615581508;5589.916151257735;5591.52472039873;5603.439656034384;5614.045612245907;5322.494363035506;5427.158790387496;5606.131049687305;5606.747696353674;5611.719414029323;11734.178607497479;11974.281543107441;12048.337341446217;12059.095567832448;12186.939065304618;2157.1155826111217;2430.526047420736;2449.6815413996064;2540.911068112607;2601.8959241630314;8979.19187273142;9373.671921482784;9399.201067909236;12201.145919785618;12649.241045537297;1796.9460916172536;1889.6126294109674;1903.6858918278467;1982.9504262393555;2022.7572691277142;78710;79343;80132;80324.59837700833;80621.19378806195;10449.84325235122;10619;10728.088112510368;10809.67570972872;10818.56725730962;14320.785188222186;14364.35360408784;14474.927625362016;14477.927610361881;14488.85511144875;7661.846763064819;7867.409944254204;7962.960185199037;7993.520388776692;8060.596970151469;6335.398137177053;6663.966680166665;7761.301482866569;7931.365490760725;8164.142765009708;4050.41269015991;4422.115576884636;4734.763261836894;4743.928841067318;4748.169070412733;1743.6774196773638;1788.6333301673126;1855;1896.7439395681406;1951.541387773872;953.699584630839;986.9605215791431;1018.6536577563664;1052.3528030261334;1079.5627770752858;16328.591785205464;18385.596518892668;18395.448136555926;18590.442286731148;18764.24943002292;858.3219256787069;916.9653524492287;964.0985678390728;1012.2256473797404;1013.2299452416216;7993.760187194393;10371.481425928674;10562.20783441245;10569.947150264199;10605.522751476203;468732;490486;491722;496372;500364;86721.56639216763;90383;90626;90851.09148908558;92702.53648731713;1040.6045702633103;1045.1429827541494;1047.5809676129609;1070.9250352475408;1079.222959469181;16201.67596648084;16509.91745041267;16557.254923528228;16740.24668889927;17223.827761722223;38268.42597360986;38568.228635427695;39413.21173576455;39692;40983.59016409798;50391.49608503868;51996.48003520068;52053;52652.736736316074;53652;5807.912881306699;7926.24700653437;7962.681492740226;8154.673813047411;8208.302294304813;12339.444724987217;12745.362731863184;12946.870531294944;13058.542950996669;13629.86370136286;11617.070634349062;11731.41342932833;11753.941230294136;11890.940545297219;12160.087993400708;11266.66200014001;11519.424028798694;11652;11677.474513647076;11870;11412.82880756806;12161.81757273624;12332.691682708004;12396.442160102637;12398.938005310276;8067.83864322722;8203.507789532647;8390.035145958293;11810.40947952616;12276.447559860006;7927.365810735243;7935.523868567904;8624.310055195694;11517.53929842797;13036.47854085826 08:11:11 INFO - PROCESS | 4810 | |3;mootools.html;1280.6798300424894;1298.0589072922128;1350.824392828932;1367.2206842100002;1532.5325775638432;7789.844203115934;8093.190680931903;8094.473859199148;8103.068147163078;8105.91894081059;7882.802929926755;8001;8003.239692229244;8007.63965621547;8017.3986950978615;1974.7334109895123;2225.810806081485;2230.297456301264;2261.434641339665;2308.134449581407;2271.046160612547;2292.2893902890073;2295.942601434969;2296.4603318220206;2298;2240.182333448296;2314.5139520700673;2318.6290193569034;2319.7216334039854;2322.1524143687516;1965.3317871923543;2252.8986195621237;2323.3030090972725;2324.9070037198494;2326.592846251916;2197.2968650031835;2219.2454565447824;2222.488827569668;2223.1552010236005;2225.5771403433296;8010;8019.398545109082;8043.638036288323;8055.7583272501915;8075.596220188967;4870.6103511718975;4991.425986011619;5034.320366750479;5037.924431133536;5114.232865070269;3181.44324743169;3184.6656101109284;3218.935621287561;3255.869765209389;3256.690614391629;1062.075993885317;1063.3832377221192;1078.6386560502242;1096.413418820935;1123.5393488669688;11242.49408776607;11258.380789056599;11260.268082574607;11288.0969522438;11305.208635395444;4392.472903251566;4448.55514448559;4627.120847039052;4635.95364046362;4640.419947506562;9581.377210481296;9629.085236902483;9629.903700962901;9636.084571965792;9639.421634701941;4504.324351347259;5157.303763991888;5174.353205849269;5195.454477279907;5201.479852014768;4542.341360502709;4639.489656137822;4652.837150699709;4656.67403281767;4668.696534725232;3870.8645197417954;3904.90237744053;3933.468981687493;3973.4238535412205;4016.718829681894;1267.8225048493218;1289.5164313382481;1294.741051789627;1300;1302.1666133674455;942.8255772682076;976.8632391465201;993.821112199811;1008.4655132779639;1008.9293749437469;5714.914276285859;5786.276715410574;5806.738696758656;5837.67892765902;5863.091220860773;922.239152699026;931.7996630724426;965.9951700241594;975.4001289207087;997.7356000659831;3914.373700207953;4027.8791636250958;4037.2127435149864;4046.615571520701;4057.9391309130388;10344.32761870476;10715.678529644123;10778.622748203776;10783.730406739738;10788.676339709822;10537.315074520131;10599.682009539727;10642.201834862262;10654.360738355723;10658.360498370123;7441.144268409203;7499.475036747375;7506.249375062559;7548.924510754932;7552.244775522514;5716.857078573069;5857.707114644166;5875.383084776037;5910.202122713378;5996.070609055603;9388.295877809054;9422.481763503074;9484.668036618685;9494.905050949403;9536.189423898768;9505.382150160218;9602.32783705134;9784.119429251401;10096.747581310527;10107.54516046765;6566.310537393696;6799.218089919525;7058.364747172779;7082.220955694766;7188.245234250328;7684.346830519245;7708.4218683600075;7777.1833957433655;7778.794286885542;7797.454178207471;7041.366277035091;7191.280871912767;7226.313500217471;7319.268073192638;7322.743703970335;7002.5448345859395;7112.288771122846;7127.501074924706;7224.494285399972;7244.203137654748;6428.164338635947;6630.53586248958;6630.7679231226675;6637;6646.966765166143;5030.974845125751;5068.797248110034;5071.822486212965;5083.796648134181;5090.567301779391;4969.776360063878;4995.725235111959;5072.746362681777;5107.897842043064;5148.665336753099 08:11:11 INFO - PROCESS | 4810 | |4;prototype.html;321.67671490152395;326.36684831427044;328.6089553431417;329.8070628682221;335.6576292181974;5614.0736778431565;5632.155176723489;5651.689157096358;5653.575981801361;5659.8585035374135;5557.416471270519;5569.610127291091;5588.944110558893;5626.493615574597;5634.887302253953;4080.714349995509;4171.541130475645;4320.4599425071865;4332.263515202408;4333.393324934512;4289.034967132386;4310.762908040057;4330.090680956987;4337.175936572041;4340.696151269412;4118.938215926763;4326.156399502099;4326.74039557626;4332.176886391576;4348.108637729274;4168.791560421967;4297.935530967038;4308.9784551077355;4330.437043184397;4335.284678028122;3791.6966642668795;3803.6006219347123;3823.5794062653085;3844.7116466265143;3866.709996750255;5277.12927366984;5400.702961337125;5414.91877621836;5431.972840135813;5437.356970829554;5017.49825017499;5028.253950806672;5028.7988480460735;5031.84904452867;5032;5810.1865738796605;5857.824265272048;5888.823335299948;5900.114982752579;5912.704364781744;4099.9180016399805;4237.809298581571;4263.381809637585;4264.530901600821;4279.786010699484;6115.327313995457;6134.9386506134815;6173.839156295261;6178.938210617881;6185;4335;4348.326009468537;4349.434573505424;4415.470143582791;4421.182081314967;4227.112306415625;4443.977780111143;4452.753229095793;4459.397981272552;4462.241418958784;5028.321176641107;5029.547340739351;5038.697678139323;5098.133317336062;5106.310648062538;5923.585349025527;6034.426729460694;6035.094735789667;6044.425779550936;6062.605930614496;1487.7354248888576;1511.579115631303;1545.8917875748814;1547.404249364003;1563.8670712989297;979.0894468144694;1044.5038606661926;1045.257866914484;1056.7675111475462;1077.2297807067985;5612.270404847343;5625.746841392147;5665.9716701417055;5704.771809127671;5711.172424824016;6088.665123418166;6096.451319381277;6098.390160983866;6100.206973093558;6104.938950610526;5547.833564993057;5704.11586204139;5851.239338885917;5864.882702345929;5883.823485295448;3315.751318651111;3332.1169889979174;3334.6165191003347;3337.5828021497314;3340.611462804107;6122.66325352101;6353.4599559038;6373.808785736435;6431.163948686641;6442.194725659293;6252.624002878877;6271.216097987752;6297.779577714758;6299.149614801943;6315.905261421082;6134.8159555213415;6308.526860485482;6334.746610135635;6339.524535659844;6341.429271365507;6069.119977603134;6144.324124346408;6170.352113028247;6172.722227499684;6186.783462578788;6022.789202378071;6080.452759251689;6086.087086936995;6133.754649813957;6137.539684523589;5982.760689572542;6301.842453938688;6331.353847999645;6359.523035772243;6373.904391434225;4213.115245798416;4213.7893105344;4228.78856057202;4242.490901091889;4249.532551419403;5900.793472228452;6140.416660417253;6143.477804386677;6169.938300616936;6174.938250617436;6001.639901605918;6022.337542870193;6027.397260273938;6032.819015429544;6035.36628653985;5971.104334349882;5978.880422391441;5991.940080599138;5993.220881285405;6002.819915402545;5696.174054762119;5873.148393483007;5874.882502349844;5881.676507791942;5899.911501327398;5997.130416089555;5998.670073146019;6025.939740602713;6026.789062382795;6043.7884674036195;5713.457221563945;5902.586818922806;5917.142014407973;5918.691710232926;5919.763209471573 08:11:11 INFO - PROCESS | 4810 | |5;yui.html;632.0771673356899;670.708241914767;672.0826072411157;679.4190966723452;688.831236347095;14389.568312950616;14649.707005859877;14709.558713238606;15753.763693544606;16184.35262589495;15066.698666026672;15120.395184192646;15120.848791512082;15152.772708409382;15169.469068582603;465.1952122827511;782.9921700782991;786.4848524216648;805.9879101813477;811.452269717941;801.6272433318505;806.395203597302;806.8023334283109;808.8867558541809;809.9433039687224;831.8752187171912;840.6889450903175;841.0244116824484;842.2588122452233;842.7261140129452;678.9355011273921;695.1692727191008;696.773548596703;801.639262331953;818.8444195602816;604.3986233697499;604.9183360246354;605.0742364182807;605.2041565341606;605.2162449627742;13611.591652250449;13661.453541858315;13740.725185496334;13749.175049496962;13751.106178098391;12898;13414.530491432753;14040.85959140416;14376.137431754023;14504;11666.591669291534;11924.165308428413;11995.64013079609;12114.333711645855;12125.696857578543;3849.788261645608;3938.684905207605;3950.348192548226;4054.432379466877;4055;65099.3490065098;66038.00942985907;67251;67581.66209168972;67648.32351676519;10339.224558158168;10428.739281517872;10455.320404173704;10497.685069447929;10531.368117912949;20544.691829622567;20638.690419643717;21151.153953841982;21209.89395053015;21259.149634014775;7943.4042446815565;7959.880601790977;8274.793130171794;8309.418340716213;8315.459495132796;4691.366665500113;4746.406699162605;4809.2064809306075;4891.364122664031;4999.02519008797;3443.5867695876655;3523.823808809549;3524.400851855191;3524.400851855191;3528.0826984984087;597.3697748874891;608.5435923057706;616.3959319866556;622.9034499652561;624.3787431505681;700.394159052416;707.7204504220907;719.8776208044645;724.7861880745193;738.896554482373;9368.812623747486;9380.671676491427;9407;9519.58492616085;9614.230861531061;548.8051741631743;625.5277265664395;668.3416834418094;691.7475121580587;719.3094629155964;4221.860097773584;4243.8090285937205;4245.405643209953;4396.164728701537;4397.780110994438;66303.33696663068;66900.33099668942;67243.32756672468;67606;69482.30517694859;58736;59638.70180649069;60141.69929150326;60911.69544152251;61428;54805.72597136989;54908;55430.44569554253;55461.44538554644;56061.15908261379;8168.877466837884;8252.133525979925;8293.668253269801;8430.6206220719;8574.82850343002;34911.476327854594;34971;35055.29889402249;36068.63931360653;36202.45696314505;45721.31418028799;47975.28037079516;48078.5192148088;48310.75844620895;48764.2685359727;10715.303505272444;10917.344959302467;12001.219920705125;12055.397230138633;12254.4485498151;13264.15497542477;13293.20240785556;13427.19436833793;13675.24786136772;13782;12537.498500059895;12751.107422480338;12949.028822838512;13034.4134513949;13143.905771589687;12552.623421297376;12780.744385112432;12812.487500500249;13083.803742943674;13445.731085378433;12972.28652424088;13159.210447373189;13258.801117983045;13288.202707837561;13560.796588051384;10542.892996235592;10614.203934704774;10833.349999000086;11229.10941374656;11431.828522572001;9946.701598952042;9951.402915825074;10060.346077504939;10139.239557033105;10157.796844063225 08:11:11 INFO - PROCESS | 4810 | __end_tp_report 08:11:11 INFO - PROCESS | 4810 | __start_cc_report 08:11:11 INFO - PROCESS | 4810 | _x_x_mozilla_cycle_collect,806 08:11:11 INFO - PROCESS | 4810 | __end_cc_report 08:11:11 INFO - PROCESS | 4810 | __startTimestamp1461251471703__endTimestamp 08:11:11 INFO - PROCESS | 4810 | 08:11:11 INFO - PROCESS | 4810 | ------- Summary: start ------- 08:11:11 INFO - PROCESS | 4810 | Number of tests: 6 08:11:11 INFO - PROCESS | 4810 | 08:11:11 INFO - PROCESS | 4810 | [#0] dojo.html Cycles:165 Average:5199.13 Median:5374.11 stddev:572.26 (10.6%) stddev-sans-first:548.55 08:11:11 INFO - PROCESS | 4810 | Values: 3047.1 3118.7 3149.7 3164.1 3185.1 5018.1 5188.9 5219.6 5228.1 5250.7 5220.5 5226.6 5253.9 5258.5 5262.2 4690.3 4727.0 4767.1 4809.1 4901.9 4791.2 4811.2 4815.4 4862.1 4868.8 4641.4 4699.8 4737.5 4786.4 4806.6 4727.5 4745.0 4753.6 4754.3 4781.5 4632.5 4700.0 4709.8 4731.5 4784.0 5170.5 5203.9 5224.6 5227.8 5261.0 5579.3 5594.9 5597.7 5597.7 5598.3 5564.6 5605.3 5632.3 5635.2 5640.2 5261.4 5277.9 5329.2 5359.7 5363.2 5825.9 5847.6 5849.8 5852.1 5854.9 5338.2 5538.1 5602.8 5615.3 5623.6 5494.3 5496.1 5500.4 5502.6 5559.4 5479.6 5479.9 5480.0 5504.4 5532.7 5339.8 5500.3 5570.7 5636.0 5677.9 4283.8 4293.0 4296.5 4299.5 4321.4 3828.6 3849.3 3858.1 3880.1 3882.7 5166.9 5281.4 5319.2 5365.2 5373.1 5636.1 5642.9 5663.6 5669.2 5673.6 5082.8 5284.4 5292.9 5299.6 5339.0 4784.5 4785.6 4851.3 4882.9 4883.0 5735.5 5753.7 5757.8 5764.6 5771.5 5467.0 5621.8 5624.9 5642.1 5686.6 5692.8 5710.4 5719.0 5722.3 5779.5 5468.8 5492.2 5497.6 5505.1 5523.3 5497.1 5611.5 5613.4 5638.4 5732.7 5424.6 5425.8 5425.8 5429.8 5473.7 5402.4 5404.4 5404.7 5422.5 5450.3 5271.9 5332.6 5405.4 5482.9 5485.0 5474.3 5476.3 5481.6 5482.4 5488.5 5363.6 5370.2 5372.4 5374.1 5375.9 08:11:11 INFO - PROCESS | 4810 | 08:11:11 INFO - PROCESS | 4810 | [#1] ext.html Cycles:180 Average:50598.28 Median:18747.65 stddev:96287.64 (513.6%) stddev-sans-first:96484.55 08:11:11 INFO - PROCESS | 4810 | Values: 590.8 598.1 626.2 651.9 665.4 30499.2 37324.4 38484.0 38484.4 38520.0 41663.2 42313.8 42358.4 42421.0 42543.6 7421.1 8663.5 8912.3 8912.6 8913.4 10014.7 10463.1 10473.3 10476.6 10477.0 10177.4 10285.6 10288.5 10291.6 10293.9 7612.8 9898.7 10021.0 10119.6 10230.0 9997.5 10135.7 10138.6 10139.3 10142.2 37316.4 37775.8 37932.8 38162.9 38167.6 3399.5 3638.6 3827.9 4185.0 4233.8 31745.8 32206.7 32557.5 32698.5 32864.2 4178.2 4344.2 4357.4 4372.4 4374.4 306990.0 311503.0 312848.0 313564.0 313816.0 35361.5 57504.4 57800.7 57816.0 57823.4 29849.6 29891.6 30008.5 30012.7 30023.8 14716.0 14981.1 15003.2 15025.0 15034.5 12561.9 12633.2 12634.7 12635.9 12639.0 8490.4 8543.5 8583.8 8627.3 8633.8 3046.4 3301.6 3328.6 3355.8 3363.2 874.2 913.3 939.6 973.6 1063.9 28669.4 29183.3 29526.6 29583.0 29713.7 1105.2 1126.1 1155.7 1166.3 1175.7 16648.9 17158.8 17209.7 17253.0 17377.6 461820.0 467525.0 469411.0 469489.0 471419.0 55644.0 56523.0 56741.0 56839.7 56897.0 1249.0 1287.8 1300.9 1368.3 1406.1 25298.0 25844.5 26336.0 26518.9 28247.9 45778.0 46220.8 46443.3 46459.8 46488.0 283624.0 284468.0 285559.0 285756.0 286043.0 24767.3 27489.3 28722.1 29562.6 29580.4 34892.0 37200.8 45227.8 45594.0 46274.8 37656.2 37929.2 38643.8 38875.2 39213.2 36733.1 37798.0 38582.6 38927.0 38998.0 38902.2 39874.9 40387.0 40544.6 40987.2 31633.2 34095.8 34539.0 34719.3 34750.3 26999.0 27460.5 27566.6 27601.6 27602.3 08:11:11 INFO - PROCESS | 4810 | 08:11:11 INFO - PROCESS | 4810 | [#2] jquery.html Cycles:180 Average:28089.59 Median:38418.33 stddev:80708.26 (210.1%) stddev-sans-first:80907.89 08:11:11 INFO - PROCESS | 4810 | Values: 398.6 400.1 403.0 406.8 412.9 13146.5 15492.5 17791.4 18505.5 18557.8 14833.7 16900.2 17840.5 18626.3 18714.5 5388.2 5630.2 5641.1 5642.5 5642.6 3985.7 5567.5 5951.1 6271.1 6278.8 6183.1 6199.1 6200.9 6228.7 6231.9 5296.2 5589.9 5591.5 5603.4 5614.0 5322.5 5427.2 5606.1 5606.7 5611.7 11734.2 11974.3 12048.3 12059.1 12186.9 2157.1 2430.5 2449.7 2540.9 2601.9 8979.2 9373.7 9399.2 12201.1 12649.2 1796.9 1889.6 1903.7 1983.0 2022.8 78710.0 79343.0 80132.0 80324.6 80621.2 10449.8 10619.0 10728.1 10809.7 10818.6 14320.8 14364.4 14474.9 14477.9 14488.9 7661.8 7867.4 7963.0 7993.5 8060.6 6335.4 6664.0 7761.3 7931.4 8164.1 4050.4 4422.1 4734.8 4743.9 4748.2 1743.7 1788.6 1855.0 1896.7 1951.5 953.7 987.0 1018.7 1052.4 1079.6 16328.6 18385.6 18395.4 18590.4 18764.2 858.3 917.0 964.1 1012.2 1013.2 7993.8 10371.5 10562.2 10569.9 10605.5 468732.0 490486.0 491722.0 496372.0 500364.0 86721.6 90383.0 90626.0 90851.1 92702.5 1040.6 1045.1 1047.6 1070.9 1079.2 16201.7 16509.9 16557.3 16740.2 17223.8 38268.4 38568.2 39413.2 39692.0 40983.6 50391.5 51996.5 52053.0 52652.7 53652.0 5807.9 7926.2 7962.7 8154.7 8208.3 12339.4 12745.4 12946.9 13058.5 13629.9 11617.1 11731.4 11753.9 11890.9 12160.1 11266.7 11519.4 11652.0 11677.5 11870.0 11412.8 12161.8 12332.7 12396.4 12398.9 8067.8 8203.5 8390.0 11810.4 12276.4 7927.4 7935.5 8624.3 11517.5 13036.5 08:11:11 INFO - PROCESS | 4810 | 08:11:11 INFO - PROCESS | 4810 | [#3] mootools.html Cycles:180 Average:5495.71 Median:5036.12 stddev:3062.83 (60.8%) stddev-sans-first:3055.04 08:11:11 INFO - PROCESS | 4810 | Values: 1280.7 1298.1 1350.8 1367.2 1532.5 7789.8 8093.2 8094.5 8103.1 8105.9 7882.8 8001.0 8003.2 8007.6 8017.4 1974.7 2225.8 2230.3 2261.4 2308.1 2271.0 2292.3 2295.9 2296.5 2298.0 2240.2 2314.5 2318.6 2319.7 2322.2 1965.3 2252.9 2323.3 2324.9 2326.6 2197.3 2219.2 2222.5 2223.2 2225.6 8010.0 8019.4 8043.6 8055.8 8075.6 4870.6 4991.4 5034.3 5037.9 5114.2 3181.4 3184.7 3218.9 3255.9 3256.7 1062.1 1063.4 1078.6 1096.4 1123.5 11242.5 11258.4 11260.3 11288.1 11305.2 4392.5 4448.6 4627.1 4636.0 4640.4 9581.4 9629.1 9629.9 9636.1 9639.4 4504.3 5157.3 5174.4 5195.5 5201.5 4542.3 4639.5 4652.8 4656.7 4668.7 3870.9 3904.9 3933.5 3973.4 4016.7 1267.8 1289.5 1294.7 1300.0 1302.2 942.8 976.9 993.8 1008.5 1008.9 5714.9 5786.3 5806.7 5837.7 5863.1 922.2 931.8 966.0 975.4 997.7 3914.4 4027.9 4037.2 4046.6 4057.9 10344.3 10715.7 10778.6 10783.7 10788.7 10537.3 10599.7 10642.2 10654.4 10658.4 7441.1 7499.5 7506.2 7548.9 7552.2 5716.9 5857.7 5875.4 5910.2 5996.1 9388.3 9422.5 9484.7 9494.9 9536.2 9505.4 9602.3 9784.1 10096.7 10107.5 6566.3 6799.2 7058.4 7082.2 7188.2 7684.3 7708.4 7777.2 7778.8 7797.5 7041.4 7191.3 7226.3 7319.3 7322.7 7002.5 7112.3 7127.5 7224.5 7244.2 6428.2 6630.5 6630.8 6637.0 6647.0 5031.0 5068.8 5071.8 5083.8 5090.6 4969.8 4995.7 5072.7 5107.9 5148.7 08:11:11 INFO - PROCESS | 4810 | 08:11:11 INFO - PROCESS | 4810 | [#4] prototype.html Cycles:180 Average:5001.10 Median:5656.72 stddev:1486.67 (26.3%) stddev-sans-first:1448.76 08:11:11 INFO - PROCESS | 4810 | Values: 321.7 326.4 328.6 329.8 335.7 5614.1 5632.2 5651.7 5653.6 5659.9 5557.4 5569.6 5588.9 5626.5 5634.9 4080.7 4171.5 4320.5 4332.3 4333.4 4289.0 4310.8 4330.1 4337.2 4340.7 4118.9 4326.2 4326.7 4332.2 4348.1 4168.8 4297.9 4309.0 4330.4 4335.3 3791.7 3803.6 3823.6 3844.7 3866.7 5277.1 5400.7 5414.9 5432.0 5437.4 5017.5 5028.3 5028.8 5031.8 5032.0 5810.2 5857.8 5888.8 5900.1 5912.7 4099.9 4237.8 4263.4 4264.5 4279.8 6115.3 6134.9 6173.8 6178.9 6185.0 4335.0 4348.3 4349.4 4415.5 4421.2 4227.1 4444.0 4452.8 4459.4 4462.2 5028.3 5029.5 5038.7 5098.1 5106.3 5923.6 6034.4 6035.1 6044.4 6062.6 1487.7 1511.6 1545.9 1547.4 1563.9 979.1 1044.5 1045.3 1056.8 1077.2 5612.3 5625.7 5666.0 5704.8 5711.2 6088.7 6096.5 6098.4 6100.2 6104.9 5547.8 5704.1 5851.2 5864.9 5883.8 3315.8 3332.1 3334.6 3337.6 3340.6 6122.7 6353.5 6373.8 6431.2 6442.2 6252.6 6271.2 6297.8 6299.1 6315.9 6134.8 6308.5 6334.7 6339.5 6341.4 6069.1 6144.3 6170.4 6172.7 6186.8 6022.8 6080.5 6086.1 6133.8 6137.5 5982.8 6301.8 6331.4 6359.5 6373.9 4213.1 4213.8 4228.8 4242.5 4249.5 5900.8 6140.4 6143.5 6169.9 6174.9 6001.6 6022.3 6027.4 6032.8 6035.4 5971.1 5978.9 5991.9 5993.2 6002.8 5696.2 5873.1 5874.9 5881.7 5899.9 5997.1 5998.7 6025.9 6026.8 6043.8 5713.5 5902.6 5917.1 5918.7 5919.8 08:11:11 INFO - PROCESS | 4810 | 08:11:11 INFO - PROCESS | 4810 | [#5] yui.html Cycles:180 Average:15783.40 Median:4718.89 stddev:19160.37 (406.0%) stddev-sans-first:19180.34 08:11:11 INFO - PROCESS | 4810 | Values: 632.1 670.7 672.1 679.4 688.8 14389.6 14649.7 14709.6 15753.8 16184.4 15066.7 15120.4 15120.8 15152.8 15169.5 465.2 783.0 786.5 806.0 811.5 801.6 806.4 806.8 808.9 809.9 831.9 840.7 841.0 842.3 842.7 678.9 695.2 696.8 801.6 818.8 604.4 604.9 605.1 605.2 605.2 13611.6 13661.5 13740.7 13749.2 13751.1 12898.0 13414.5 14040.9 14376.1 14504.0 11666.6 11924.2 11995.6 12114.3 12125.7 3849.8 3938.7 3950.3 4054.4 4055.0 65099.3 66038.0 67251.0 67581.7 67648.3 10339.2 10428.7 10455.3 10497.7 10531.4 20544.7 20638.7 21151.2 21209.9 21259.1 7943.4 7959.9 8274.8 8309.4 8315.5 4691.4 4746.4 4809.2 4891.4 4999.0 3443.6 3523.8 3524.4 3524.4 3528.1 597.4 608.5 616.4 622.9 624.4 700.4 707.7 719.9 724.8 738.9 9368.8 9380.7 9407.0 9519.6 9614.2 548.8 625.5 668.3 691.7 719.3 4221.9 4243.8 4245.4 4396.2 4397.8 66303.3 66900.3 67243.3 67606.0 69482.3 58736.0 59638.7 60141.7 60911.7 61428.0 54805.7 54908.0 55430.4 55461.4 56061.2 8168.9 8252.1 8293.7 8430.6 8574.8 34911.5 34971.0 35055.3 36068.6 36202.5 45721.3 47975.3 48078.5 48310.8 48764.3 10715.3 10917.3 12001.2 12055.4 12254.4 13264.2 13293.2 13427.2 13675.2 13782.0 12537.5 12751.1 12949.0 13034.4 13143.9 12552.6 12780.7 12812.5 13083.8 13445.7 12972.3 13159.2 13258.8 13288.2 13560.8 10542.9 10614.2 10833.3 11229.1 11431.8 9946.7 9951.4 10060.3 10139.2 10157.8 08:11:11 INFO - PROCESS | 4810 | -------- Summary: end -------- 08:11:11 INFO - PROCESS | 4810 | 08:11:12 INFO - TEST-INFO | 4810: exit 0 08:11:12 INFO - TEST-OK | dromaeo_css | took 1112151ms 08:11:12 INFO - TEST-START | kraken 08:11:12 INFO - operating with platform_type : linux_ 08:11:12 INFO - Initialising browser for kraken test... 08:11:12 INFO - TEST-INFO | started process 5003 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6b1XkZ/profile http://localhost:56666/getInfo.html) 08:11:16 INFO - PROCESS | 5003 | __metrics Screen width/height:1600/1200 08:11:16 INFO - PROCESS | 5003 | colorDepth:24 08:11:16 INFO - PROCESS | 5003 | Browser inner width/height: 1024/697 08:11:16 INFO - PROCESS | 5003 | __metrics 08:11:17 ERROR - PROCESS | 5003 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:11:18 INFO - TEST-INFO | 5003: exit 0 08:11:18 INFO - Browser initialized. 08:11:18 INFO - Running cycle 1/1 for kraken test... 08:11:18 INFO - TEST-INFO | started process 5084 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6b1XkZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:11:30 INFO - PROCESS | 5084 | RSS: Main: 153534464 08:11:30 INFO - PROCESS | 5084 | 08:11:32 INFO - PROCESS | 5084 | Cycle 1(1): loaded http://localhost:56666/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56666/tests/kraken/driver.html?testName=audio-beat-detection) 08:11:33 INFO - PROCESS | 5084 | RSS: Main: 208769024 08:11:33 INFO - PROCESS | 5084 | 08:11:36 INFO - PROCESS | 5084 | Cycle 1(1): loaded http://localhost:56666/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56666/tests/kraken/driver.html?testName=audio-dft) 08:11:36 INFO - PROCESS | 5084 | RSS: Main: 194519040 08:11:36 INFO - PROCESS | 5084 | 08:11:39 INFO - PROCESS | 5084 | Cycle 1(1): loaded http://localhost:56666/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56666/tests/kraken/driver.html?testName=audio-fft) 08:11:40 INFO - PROCESS | 5084 | RSS: Main: 264404992 08:11:40 INFO - PROCESS | 5084 | 08:11:42 INFO - PROCESS | 5084 | Cycle 1(1): loaded http://localhost:56666/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56666/tests/kraken/driver.html?testName=audio-oscillator) 08:11:43 INFO - PROCESS | 5084 | RSS: Main: 172531712 08:11:43 INFO - PROCESS | 5084 | 08:11:45 INFO - PROCESS | 5084 | Cycle 1(1): loaded http://localhost:56666/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56666/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:11:45 INFO - PROCESS | 5084 | RSS: Main: 177250304 08:11:45 INFO - PROCESS | 5084 | 08:11:48 INFO - PROCESS | 5084 | Cycle 1(1): loaded http://localhost:56666/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56666/tests/kraken/driver.html?testName=imaging-darkroom) 08:11:49 INFO - PROCESS | 5084 | RSS: Main: 213577728 08:11:49 INFO - PROCESS | 5084 | 08:11:52 INFO - PROCESS | 5084 | Cycle 1(1): loaded http://localhost:56666/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56666/tests/kraken/driver.html?testName=imaging-desaturate) 08:11:53 INFO - PROCESS | 5084 | RSS: Main: 214441984 08:11:53 INFO - PROCESS | 5084 | 08:11:56 INFO - PROCESS | 5084 | Cycle 1(1): loaded http://localhost:56666/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56666/tests/kraken/driver.html?testName=json-parse-financial) 08:11:56 INFO - PROCESS | 5084 | RSS: Main: 214040576 08:11:56 INFO - PROCESS | 5084 | 08:11:58 INFO - PROCESS | 5084 | Cycle 1(1): loaded http://localhost:56666/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56666/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:11:58 INFO - PROCESS | 5084 | RSS: Main: 203042816 08:11:58 INFO - PROCESS | 5084 | 08:12:00 INFO - PROCESS | 5084 | Cycle 1(1): loaded http://localhost:56666/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56666/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:12:01 INFO - PROCESS | 5084 | RSS: Main: 203763712 08:12:01 INFO - PROCESS | 5084 | 08:12:03 INFO - PROCESS | 5084 | Cycle 1(1): loaded http://localhost:56666/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56666/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:12:03 INFO - PROCESS | 5084 | RSS: Main: 217329664 08:12:03 INFO - PROCESS | 5084 | 08:12:06 INFO - PROCESS | 5084 | Cycle 1(1): loaded http://localhost:56666/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56666/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:12:07 INFO - PROCESS | 5084 | RSS: Main: 223911936 08:12:07 INFO - PROCESS | 5084 | 08:12:09 INFO - PROCESS | 5084 | Cycle 1(1): loaded http://localhost:56666/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56666/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:12:10 INFO - PROCESS | 5084 | RSS: Main: 217362432 08:12:10 INFO - PROCESS | 5084 | 08:12:12 INFO - PROCESS | 5084 | Cycle 1(1): loaded http://localhost:56666/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56666/tests/kraken/driver.html?testName=ai-astar) 08:12:12 INFO - PROCESS | 5084 | RSS: Main: 281051136 08:12:12 INFO - PROCESS | 5084 | 08:12:12 INFO - PROCESS | 5084 | __start_tp_report 08:12:12 INFO - PROCESS | 5084 | _x_x_mozilla_page_load 08:12:12 INFO - PROCESS | 5084 | _x_x_mozilla_page_load_details 08:12:12 INFO - PROCESS | 5084 | |i|pagename|runs| 08:12:12 INFO - PROCESS | 5084 | |0;ai-astar;112;111;104;111;111;112;100;114;111;111 08:12:12 INFO - PROCESS | 5084 | |1;audio-beat-detection;160;132;157;183;130;153;154;137;188;134 08:12:12 INFO - PROCESS | 5084 | |2;audio-dft;162;161;163;162;163;160;160;161;161;161 08:12:12 INFO - PROCESS | 5084 | |3;audio-fft;76;77;101;111;74;76;76;117;106;72 08:12:12 INFO - PROCESS | 5084 | |4;audio-oscillator;93;92;146;94;92;92;148;92;92;140 08:12:12 INFO - PROCESS | 5084 | |5;imaging-gaussian-blur;116;117;116;117;117;117;117;117;116;117 08:12:12 INFO - PROCESS | 5084 | |6;imaging-darkroom;146;145;145;146;146;145;145;147;145;146 08:12:12 INFO - PROCESS | 5084 | |7;imaging-desaturate;94;94;94;95;95;95;95;94;94;94 08:12:12 INFO - PROCESS | 5084 | |8;json-parse-financial;58;58;56;57;56;57;60;80;56;56 08:12:12 INFO - PROCESS | 5084 | |9;json-stringify-tinderbox;60;61;61;61;60;61;59;60;60;61 08:12:12 INFO - PROCESS | 5084 | |10;stanford-crypto-aes;75;77;76;74;77;77;81;77;78;77 08:12:12 INFO - PROCESS | 5084 | |11;stanford-crypto-ccm;127;125;124;135;135;126;123;133;159;128 08:12:12 INFO - PROCESS | 5084 | |12;stanford-crypto-pbkdf2;169;170;169;164;166;164;165;161;171;165 08:12:12 INFO - PROCESS | 5084 | |13;stanford-crypto-sha256-iterative;69;68;67;67;69;68;68;71;66;65 08:12:12 INFO - PROCESS | 5084 | __end_tp_report 08:12:12 INFO - PROCESS | 5084 | __start_cc_report 08:12:12 INFO - PROCESS | 5084 | _x_x_mozilla_cycle_collect,1625 08:12:12 INFO - PROCESS | 5084 | __end_cc_report 08:12:12 INFO - PROCESS | 5084 | __startTimestamp1461251532453__endTimestamp 08:12:12 INFO - PROCESS | 5084 | 08:12:12 INFO - PROCESS | 5084 | ------- Summary: start ------- 08:12:12 INFO - PROCESS | 5084 | Number of tests: 14 08:12:12 INFO - PROCESS | 5084 | 08:12:12 INFO - PROCESS | 5084 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:4.27 (3.8%) stddev-sans-first:4.45 08:12:12 INFO - PROCESS | 5084 | Values: 112.0 111.0 104.0 111.0 111.0 112.0 100.0 114.0 111.0 111.0 08:12:12 INFO - PROCESS | 5084 | 08:12:12 INFO - PROCESS | 5084 | [#1] audio-beat-detection Cycles:10 Average:152.80 Median:155.50 stddev:20.49 (13.2%) stddev-sans-first:21.56 08:12:12 INFO - PROCESS | 5084 | Values: 160.0 132.0 157.0 183.0 130.0 153.0 154.0 137.0 188.0 134.0 08:12:12 INFO - PROCESS | 5084 | 08:12:12 INFO - PROCESS | 5084 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.07 (0.7%) stddev-sans-first:1.12 08:12:12 INFO - PROCESS | 5084 | Values: 162.0 161.0 163.0 162.0 163.0 160.0 160.0 161.0 161.0 161.0 08:12:12 INFO - PROCESS | 5084 | 08:12:12 INFO - PROCESS | 5084 | [#3] audio-fft Cycles:10 Average:88.60 Median:75.00 stddev:17.84 (23.8%) stddev-sans-first:18.33 08:12:12 INFO - PROCESS | 5084 | Values: 76.0 77.0 101.0 111.0 74.0 76.0 76.0 117.0 106.0 72.0 08:12:12 INFO - PROCESS | 5084 | 08:12:12 INFO - PROCESS | 5084 | [#4] audio-oscillator Cycles:10 Average:108.10 Median:92.00 stddev:25.32 (27.5%) stddev-sans-first:26.26 08:12:12 INFO - PROCESS | 5084 | Values: 93.0 92.0 146.0 94.0 92.0 92.0 148.0 92.0 92.0 140.0 08:12:12 INFO - PROCESS | 5084 | 08:12:12 INFO - PROCESS | 5084 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 08:12:12 INFO - PROCESS | 5084 | Values: 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 08:12:12 INFO - PROCESS | 5084 | 08:12:12 INFO - PROCESS | 5084 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 08:12:12 INFO - PROCESS | 5084 | Values: 146.0 145.0 145.0 146.0 146.0 145.0 145.0 147.0 145.0 146.0 08:12:12 INFO - PROCESS | 5084 | 08:12:12 INFO - PROCESS | 5084 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 08:12:12 INFO - PROCESS | 5084 | Values: 94.0 94.0 94.0 95.0 95.0 95.0 95.0 94.0 94.0 94.0 08:12:12 INFO - PROCESS | 5084 | 08:12:12 INFO - PROCESS | 5084 | [#8] json-parse-financial Cycles:10 Average:59.40 Median:57.50 stddev:7.35 (12.8%) stddev-sans-first:7.78 08:12:12 INFO - PROCESS | 5084 | Values: 58.0 58.0 56.0 57.0 56.0 57.0 60.0 80.0 56.0 56.0 08:12:12 INFO - PROCESS | 5084 | 08:12:12 INFO - PROCESS | 5084 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:61.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 08:12:12 INFO - PROCESS | 5084 | Values: 60.0 61.0 61.0 61.0 60.0 61.0 59.0 60.0 60.0 61.0 08:12:12 INFO - PROCESS | 5084 | 08:12:12 INFO - PROCESS | 5084 | [#10] stanford-crypto-aes Cycles:10 Average:76.90 Median:77.00 stddev:1.85 (2.4%) stddev-sans-first:1.83 08:12:12 INFO - PROCESS | 5084 | Values: 75.0 77.0 76.0 74.0 77.0 77.0 81.0 77.0 78.0 77.0 08:12:12 INFO - PROCESS | 5084 | 08:12:12 INFO - PROCESS | 5084 | [#11] stanford-crypto-ccm Cycles:10 Average:131.50 Median:130.50 stddev:10.63 (8.1%) stddev-sans-first:11.15 08:12:12 INFO - PROCESS | 5084 | Values: 127.0 125.0 124.0 135.0 135.0 126.0 123.0 133.0 159.0 128.0 08:12:12 INFO - PROCESS | 5084 | 08:12:12 INFO - PROCESS | 5084 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.40 Median:167.50 stddev:3.20 (1.9%) stddev-sans-first:3.26 08:12:12 INFO - PROCESS | 5084 | Values: 169.0 170.0 169.0 164.0 166.0 164.0 165.0 161.0 171.0 165.0 08:12:12 INFO - PROCESS | 5084 | 08:12:12 INFO - PROCESS | 5084 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:1.69 (2.5%) stddev-sans-first:1.73 08:12:12 INFO - PROCESS | 5084 | Values: 69.0 68.0 67.0 67.0 69.0 68.0 68.0 71.0 66.0 65.0 08:12:12 INFO - PROCESS | 5084 | -------- Summary: end -------- 08:12:12 INFO - PROCESS | 5084 | 08:12:13 INFO - TEST-INFO | 5084: exit 0 08:12:13 INFO - TEST-OK | kraken | took 61005ms 08:12:13 INFO - SUITE-END | took 1173s 08:12:13 INFO - Completed test suite (00:19:33) 08:12:13 INFO - javascript benchmark 08:12:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3047.070643453747, 3118.73490753286, 3149.748020158386, 3164.114048066541, 3185.1240908750096, 5018.071656743496, 5188.8702782430455, 5219.608529360304, 5228.085085110105, 5250.658707184035, 5220.504052115043, 5226.5557427618605, 5253.947460525394, 5258.526732594066, 5262.23697563854, 4690.296455531663, 4726.952730472694, 4767.1419144553965, 4809.1343558159515, 4901.901961960759, 4791.2094504406905, 4811.182099043153, 4815.374001379833, 4862.07620552094, 4868.756562171895, 4641.419822522184, 4699.765011749416, 4737.526247375269, 4786.401699787544, 4806.591439727627, 4727.503612120712, 4744.976275118637, 4753.619710423158, 4754.263089221176, 4781.545753153445, 4632.490426053131, 4699.953000469985, 4709.764511774431, 4731.455882573514, 4784.043191361741, 5170.508801663836, 5203.895922081537, 5224.582033437354, 5227.817026404057, 5261.026710058652, 5579.274694289757, 5594.86012849682, 5597.7201139943245, 5597.74810133545, 5598.272224610815, 5564.638298510625, 5605.299337582802, 5632.295963004624, 5635.239242702224, 5640.153976903456, 5261.368635763694, 5277.920831187535, 5329.173978033411, 5359.732013399314, 5363.222332761728, 5825.883482330414, 5847.619904706181, 5849.795257165979, 5852.063669812809, 5854.912176317359, 5338.199270109437, 5538.141588053858, 5602.803901863496, 5615.326160860723, 5623.550115990711, 5494.340679118452, 5496.148097044965, 5500.4499550045475, 5502.5597952163735, 5559.388467268597, 5479.643823151562, 5479.890402191933, 5480.040992826319, 5504.4495550444635, 5532.695701736363, 5339.786408543615, 5500.312460942382, 5570.749316280777, 5636.0, 5677.886442271131, 4283.764392958355, 4293.034067334825, 4296.548862369469, 4299.462567179103, 4321.373400856858, 3828.578856325802, 3849.3071247175776, 3858.074062225046, 3880.0881792778673, 3882.650561449483, 5166.948330516647, 5281.39263984639, 5319.228711836762, 5365.222042803772, 5373.140297552372, 5636.126400407943, 5642.85892852682, 5663.631863928831, 5669.206311116447, 5673.574481913873, 5082.771275292621, 5284.445133261029, 5292.92060619091, 5299.6290259681455, 5338.97330513345, 4784.497627749036, 4785.617150627942, 4851.345068415719, 4882.853514394574, 4882.9755851221225, 5735.541156707453, 5753.683547404849, 5757.798477053283, 5764.625299355528, 5771.509421699203, 5467.043267428105, 5621.80323688669, 5624.887502250014, 5642.069058605284, 5686.573506987075, 5692.772289108555, 5710.37185909558, 5718.971405143114, 5722.284714410699, 5779.508741756829, 5468.781248750005, 5492.231087647652, 5497.642653227527, 5505.064139096443, 5523.337199536081, 5497.120460726264, 5611.523020543136, 5613.354464236665, 5638.379778224474, 5732.742026608729, 5424.620276580601, 5425.755840987086, 5425.755840987086, 5429.809956651498, 5473.726313684379, 5402.432744561765, 5404.432534583812, 5404.675719456845, 5422.5119739223655, 5450.31871016123, 5271.920921186109, 5332.6000549958135, 5405.405405405481, 5482.890342193214, 5484.972575137099, 5474.260974768515, 5476.315460567429, 5481.643693159932, 5482.39693633692, 5488.506034456918, 5363.624546281723, 5370.221317908803, 5372.435894231049, 5374.11327131019, 5375.946240537701], "value": 5162.267462026596, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.8197999610122, 598.0759726222985, 626.2141013028648, 651.9340877665019, 665.3712241931377, 30499.237519062033, 37324.44013339802, 38484.0, 38484.42273365898, 38520.0, 41663.16673666533, 42313.78843105788, 42358.36462453058, 42421.0, 42543.57456425435, 7421.109466863957, 8663.523506207157, 8912.287017038621, 8912.598933048028, 8913.376063675545, 10014.699559013241, 10463.058324750771, 10473.26687131901, 10476.633317833877, 10477.0, 10177.440240786755, 10285.64000259991, 10288.48557572122, 10291.63979260726, 10293.897061029369, 7612.809679757995, 9898.703038908772, 10021.048000439947, 10119.595216191381, 10230.028147326066, 9997.500124993721, 10135.746606334827, 10138.594456221743, 10139.340942838691, 10142.239332050125, 37316.44025339595, 37775.81112094422, 37932.81033594815, 38162.85511434662, 38167.618323816685, 3399.473081672345, 3638.6361363863666, 3827.9043023924346, 4185.0, 4233.767142807144, 31745.841270793728, 32206.677933220602, 32557.51163732546, 32698.509522357184, 32864.17839554006, 4178.206140833232, 4344.1963236800975, 4357.368181613649, 4372.366006929009, 4374.387585737999, 306990.0, 311503.0, 312848.0, 313564.0, 313816.0, 35361.46957795635, 57504.424955749906, 57800.71099644559, 57816.0, 57823.421765782645, 29849.552256716168, 29891.551626725617, 30008.54987175194, 30012.699873001427, 30023.849880750895, 14716.0, 14981.101133932, 15003.17482538449, 15025.0, 15034.548963531111, 12561.87438125607, 12633.178843375152, 12634.684132896567, 12635.93682031584, 12639.0, 8490.448120872246, 8543.530105844115, 8583.785405364915, 8627.266682331947, 8633.827323453495, 3046.4211799757977, 3301.5873015873017, 3328.5839270091237, 3355.765096443274, 3363.209645733251, 874.2175752701297, 913.2967614936462, 939.6241503398559, 973.5667627905656, 1063.8989296016866, 28669.426611467654, 29183.270418239714, 29526.641883519205, 29583.0, 29713.702862971524, 1105.182165197748, 1126.1328776841785, 1155.653304008794, 1166.2710805746408, 1175.6590588729173, 16648.916755416147, 17158.82841171597, 17209.655806884042, 17253.041289924673, 17377.56556086083, 461820.0, 467525.0, 469411.0, 469489.0, 471419.0, 55644.0, 56523.0, 56741.0, 56839.71580142073, 56897.0, 1248.9687757806128, 1287.8068289756611, 1300.9479620815061, 1368.3090039529973, 1406.0509156319647, 25297.988080476574, 25844.483110338064, 26336.0, 26518.867405662848, 28247.858760706065, 45778.0, 46220.76889615665, 46443.303350449096, 46459.76770116263, 46488.0, 283624.0, 284468.0, 285559.0, 285756.0, 286043.0, 24767.25698229056, 27489.31276718098, 28722.13833584996, 29562.55656165202, 29580.408391831614, 34892.0, 37200.81399592985, 45227.77386113048, 45594.0, 46274.768626156656, 37656.24687506289, 37929.241415172095, 38643.80678096592, 38875.222495549366, 39213.2157356857, 36733.08167295839, 37798.0, 38582.61417385902, 38927.0, 38998.0, 38902.22195556016, 39874.92865473903, 40387.0, 40544.594554054085, 40987.18025639411, 31633.20916977094, 34095.82952085224, 34539.0, 34719.305613888086, 34750.304993900485, 26999.0, 27460.45079098447, 27566.5865012029, 27601.58597620997, 27602.309942250802], "value": 18131.069284702546, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.6491887139317, 400.1337105167313, 402.9576894426085, 406.80473372781086, 412.8864562245382, 13146.474141034347, 15492.535223943272, 17791.377301794422, 18505.537361565952, 18557.81442185578, 14833.703325933502, 16900.239489222982, 17840.464786056407, 18626.254949802027, 18714.53213669659, 5388.245645609628, 5630.239917611111, 5641.069223578125, 5642.520385767215, 5642.633228840133, 3985.720999530034, 5567.47109024644, 5951.077582974624, 6271.122042913996, 6278.843028924291, 6183.072539119124, 6199.101130336121, 6200.937990620104, 6228.719707613168, 6231.937680623181, 5296.152615581508, 5589.916151257735, 5591.52472039873, 5603.439656034384, 5614.045612245907, 5322.494363035506, 5427.158790387496, 5606.131049687305, 5606.747696353674, 5611.719414029323, 11734.178607497479, 11974.281543107441, 12048.337341446217, 12059.095567832448, 12186.939065304618, 2157.1155826111217, 2430.526047420736, 2449.6815413996064, 2540.911068112607, 2601.8959241630314, 8979.19187273142, 9373.671921482784, 9399.201067909236, 12201.145919785618, 12649.241045537297, 1796.9460916172536, 1889.6126294109674, 1903.6858918278467, 1982.9504262393555, 2022.7572691277142, 78710.0, 79343.0, 80132.0, 80324.59837700833, 80621.19378806195, 10449.84325235122, 10619.0, 10728.088112510368, 10809.67570972872, 10818.56725730962, 14320.785188222186, 14364.35360408784, 14474.927625362016, 14477.927610361881, 14488.85511144875, 7661.846763064819, 7867.409944254204, 7962.960185199037, 7993.520388776692, 8060.596970151469, 6335.398137177053, 6663.966680166665, 7761.301482866569, 7931.365490760725, 8164.142765009708, 4050.41269015991, 4422.115576884636, 4734.763261836894, 4743.928841067318, 4748.169070412733, 1743.6774196773638, 1788.6333301673126, 1855.0, 1896.7439395681406, 1951.541387773872, 953.699584630839, 986.9605215791431, 1018.6536577563664, 1052.3528030261334, 1079.5627770752858, 16328.591785205464, 18385.596518892668, 18395.448136555926, 18590.442286731148, 18764.24943002292, 858.3219256787069, 916.9653524492287, 964.0985678390728, 1012.2256473797404, 1013.2299452416216, 7993.760187194393, 10371.481425928674, 10562.20783441245, 10569.947150264199, 10605.522751476203, 468732.0, 490486.0, 491722.0, 496372.0, 500364.0, 86721.56639216763, 90383.0, 90626.0, 90851.09148908558, 92702.53648731713, 1040.6045702633103, 1045.1429827541494, 1047.5809676129609, 1070.9250352475408, 1079.222959469181, 16201.67596648084, 16509.91745041267, 16557.254923528228, 16740.24668889927, 17223.827761722223, 38268.42597360986, 38568.228635427695, 39413.21173576455, 39692.0, 40983.59016409798, 50391.49608503868, 51996.48003520068, 52053.0, 52652.736736316074, 53652.0, 5807.912881306699, 7926.24700653437, 7962.681492740226, 8154.673813047411, 8208.302294304813, 12339.444724987217, 12745.362731863184, 12946.870531294944, 13058.542950996669, 13629.86370136286, 11617.070634349062, 11731.41342932833, 11753.941230294136, 11890.940545297219, 12160.087993400708, 11266.66200014001, 11519.424028798694, 11652.0, 11677.474513647076, 11870.0, 11412.82880756806, 12161.81757273624, 12332.691682708004, 12396.442160102637, 12398.938005310276, 8067.83864322722, 8203.507789532647, 8390.035145958293, 11810.40947952616, 12276.447559860006, 7927.365810735243, 7935.523868567904, 8624.310055195694, 11517.53929842797, 13036.47854085826], "value": 8822.194972741232, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1280.6798300424894, 1298.0589072922128, 1350.824392828932, 1367.2206842100002, 1532.5325775638432, 7789.844203115934, 8093.190680931903, 8094.473859199148, 8103.068147163078, 8105.91894081059, 7882.802929926755, 8001.0, 8003.239692229244, 8007.63965621547, 8017.3986950978615, 1974.7334109895123, 2225.810806081485, 2230.297456301264, 2261.434641339665, 2308.134449581407, 2271.046160612547, 2292.2893902890073, 2295.942601434969, 2296.4603318220206, 2298.0, 2240.182333448296, 2314.5139520700673, 2318.6290193569034, 2319.7216334039854, 2322.1524143687516, 1965.3317871923543, 2252.8986195621237, 2323.3030090972725, 2324.9070037198494, 2326.592846251916, 2197.2968650031835, 2219.2454565447824, 2222.488827569668, 2223.1552010236005, 2225.5771403433296, 8010.0, 8019.398545109082, 8043.638036288323, 8055.7583272501915, 8075.596220188967, 4870.6103511718975, 4991.425986011619, 5034.320366750479, 5037.924431133536, 5114.232865070269, 3181.44324743169, 3184.6656101109284, 3218.935621287561, 3255.869765209389, 3256.690614391629, 1062.075993885317, 1063.3832377221192, 1078.6386560502242, 1096.413418820935, 1123.5393488669688, 11242.49408776607, 11258.380789056599, 11260.268082574607, 11288.0969522438, 11305.208635395444, 4392.472903251566, 4448.55514448559, 4627.120847039052, 4635.95364046362, 4640.419947506562, 9581.377210481296, 9629.085236902483, 9629.903700962901, 9636.084571965792, 9639.421634701941, 4504.324351347259, 5157.303763991888, 5174.353205849269, 5195.454477279907, 5201.479852014768, 4542.341360502709, 4639.489656137822, 4652.837150699709, 4656.67403281767, 4668.696534725232, 3870.8645197417954, 3904.90237744053, 3933.468981687493, 3973.4238535412205, 4016.718829681894, 1267.8225048493218, 1289.5164313382481, 1294.741051789627, 1300.0, 1302.1666133674455, 942.8255772682076, 976.8632391465201, 993.821112199811, 1008.4655132779639, 1008.9293749437469, 5714.914276285859, 5786.276715410574, 5806.738696758656, 5837.67892765902, 5863.091220860773, 922.239152699026, 931.7996630724426, 965.9951700241594, 975.4001289207087, 997.7356000659831, 3914.373700207953, 4027.8791636250958, 4037.2127435149864, 4046.615571520701, 4057.9391309130388, 10344.32761870476, 10715.678529644123, 10778.622748203776, 10783.730406739738, 10788.676339709822, 10537.315074520131, 10599.682009539727, 10642.201834862262, 10654.360738355723, 10658.360498370123, 7441.144268409203, 7499.475036747375, 7506.249375062559, 7548.924510754932, 7552.244775522514, 5716.857078573069, 5857.707114644166, 5875.383084776037, 5910.202122713378, 5996.070609055603, 9388.295877809054, 9422.481763503074, 9484.668036618685, 9494.905050949403, 9536.189423898768, 9505.382150160218, 9602.32783705134, 9784.119429251401, 10096.747581310527, 10107.54516046765, 6566.310537393696, 6799.218089919525, 7058.364747172779, 7082.220955694766, 7188.245234250328, 7684.346830519245, 7708.4218683600075, 7777.1833957433655, 7778.794286885542, 7797.454178207471, 7041.366277035091, 7191.280871912767, 7226.313500217471, 7319.268073192638, 7322.743703970335, 7002.5448345859395, 7112.288771122846, 7127.501074924706, 7224.494285399972, 7244.203137654748, 6428.164338635947, 6630.53586248958, 6630.7679231226675, 6637.0, 6646.966765166143, 5030.974845125751, 5068.797248110034, 5071.822486212965, 5083.796648134181, 5090.567301779391, 4969.776360063878, 4995.725235111959, 5072.746362681777, 5107.897842043064, 5148.665336753099], "value": 4439.051788716077, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.67671490152395, 326.36684831427044, 328.6089553431417, 329.8070628682221, 335.6576292181974, 5614.0736778431565, 5632.155176723489, 5651.689157096358, 5653.575981801361, 5659.8585035374135, 5557.416471270519, 5569.610127291091, 5588.944110558893, 5626.493615574597, 5634.887302253953, 4080.714349995509, 4171.541130475645, 4320.4599425071865, 4332.263515202408, 4333.393324934512, 4289.034967132386, 4310.762908040057, 4330.090680956987, 4337.175936572041, 4340.696151269412, 4118.938215926763, 4326.156399502099, 4326.74039557626, 4332.176886391576, 4348.108637729274, 4168.791560421967, 4297.935530967038, 4308.9784551077355, 4330.437043184397, 4335.284678028122, 3791.6966642668795, 3803.6006219347123, 3823.5794062653085, 3844.7116466265143, 3866.709996750255, 5277.12927366984, 5400.702961337125, 5414.91877621836, 5431.972840135813, 5437.356970829554, 5017.49825017499, 5028.253950806672, 5028.7988480460735, 5031.84904452867, 5032.0, 5810.1865738796605, 5857.824265272048, 5888.823335299948, 5900.114982752579, 5912.704364781744, 4099.9180016399805, 4237.809298581571, 4263.381809637585, 4264.530901600821, 4279.786010699484, 6115.327313995457, 6134.9386506134815, 6173.839156295261, 6178.938210617881, 6185.0, 4335.0, 4348.326009468537, 4349.434573505424, 4415.470143582791, 4421.182081314967, 4227.112306415625, 4443.977780111143, 4452.753229095793, 4459.397981272552, 4462.241418958784, 5028.321176641107, 5029.547340739351, 5038.697678139323, 5098.133317336062, 5106.310648062538, 5923.585349025527, 6034.426729460694, 6035.094735789667, 6044.425779550936, 6062.605930614496, 1487.7354248888576, 1511.579115631303, 1545.8917875748814, 1547.404249364003, 1563.8670712989297, 979.0894468144694, 1044.5038606661926, 1045.257866914484, 1056.7675111475462, 1077.2297807067985, 5612.270404847343, 5625.746841392147, 5665.9716701417055, 5704.771809127671, 5711.172424824016, 6088.665123418166, 6096.451319381277, 6098.390160983866, 6100.206973093558, 6104.938950610526, 5547.833564993057, 5704.11586204139, 5851.239338885917, 5864.882702345929, 5883.823485295448, 3315.751318651111, 3332.1169889979174, 3334.6165191003347, 3337.5828021497314, 3340.611462804107, 6122.66325352101, 6353.4599559038, 6373.808785736435, 6431.163948686641, 6442.194725659293, 6252.624002878877, 6271.216097987752, 6297.779577714758, 6299.149614801943, 6315.905261421082, 6134.8159555213415, 6308.526860485482, 6334.746610135635, 6339.524535659844, 6341.429271365507, 6069.119977603134, 6144.324124346408, 6170.352113028247, 6172.722227499684, 6186.783462578788, 6022.789202378071, 6080.452759251689, 6086.087086936995, 6133.754649813957, 6137.539684523589, 5982.760689572542, 6301.842453938688, 6331.353847999645, 6359.523035772243, 6373.904391434225, 4213.115245798416, 4213.7893105344, 4228.78856057202, 4242.490901091889, 4249.532551419403, 5900.793472228452, 6140.416660417253, 6143.477804386677, 6169.938300616936, 6174.938250617436, 6001.639901605918, 6022.337542870193, 6027.397260273938, 6032.819015429544, 6035.36628653985, 5971.104334349882, 5978.880422391441, 5991.940080599138, 5993.220881285405, 6002.819915402545, 5696.174054762119, 5873.148393483007, 5874.882502349844, 5881.676507791942, 5899.911501327398, 5997.130416089555, 5998.670073146019, 6025.939740602713, 6026.789062382795, 6043.7884674036195, 5713.457221563945, 5902.586818922806, 5917.142014407973, 5918.691710232926, 5919.763209471573], "value": 4522.75540161344, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [632.0771673356899, 670.708241914767, 672.0826072411157, 679.4190966723452, 688.831236347095, 14389.568312950616, 14649.707005859877, 14709.558713238606, 15753.763693544606, 16184.35262589495, 15066.698666026672, 15120.395184192646, 15120.848791512082, 15152.772708409382, 15169.469068582603, 465.1952122827511, 782.9921700782991, 786.4848524216648, 805.9879101813477, 811.452269717941, 801.6272433318505, 806.395203597302, 806.8023334283109, 808.8867558541809, 809.9433039687224, 831.8752187171912, 840.6889450903175, 841.0244116824484, 842.2588122452233, 842.7261140129452, 678.9355011273921, 695.1692727191008, 696.773548596703, 801.639262331953, 818.8444195602816, 604.3986233697499, 604.9183360246354, 605.0742364182807, 605.2041565341606, 605.2162449627742, 13611.591652250449, 13661.453541858315, 13740.725185496334, 13749.175049496962, 13751.106178098391, 12898.0, 13414.530491432753, 14040.85959140416, 14376.137431754023, 14504.0, 11666.591669291534, 11924.165308428413, 11995.64013079609, 12114.333711645855, 12125.696857578543, 3849.788261645608, 3938.684905207605, 3950.348192548226, 4054.432379466877, 4055.0, 65099.3490065098, 66038.00942985907, 67251.0, 67581.66209168972, 67648.32351676519, 10339.224558158168, 10428.739281517872, 10455.320404173704, 10497.685069447929, 10531.368117912949, 20544.691829622567, 20638.690419643717, 21151.153953841982, 21209.89395053015, 21259.149634014775, 7943.4042446815565, 7959.880601790977, 8274.793130171794, 8309.418340716213, 8315.459495132796, 4691.366665500113, 4746.406699162605, 4809.2064809306075, 4891.364122664031, 4999.02519008797, 3443.5867695876655, 3523.823808809549, 3524.400851855191, 3524.400851855191, 3528.0826984984087, 597.3697748874891, 608.5435923057706, 616.3959319866556, 622.9034499652561, 624.3787431505681, 700.394159052416, 707.7204504220907, 719.8776208044645, 724.7861880745193, 738.896554482373, 9368.812623747486, 9380.671676491427, 9407.0, 9519.58492616085, 9614.230861531061, 548.8051741631743, 625.5277265664395, 668.3416834418094, 691.7475121580587, 719.3094629155964, 4221.860097773584, 4243.8090285937205, 4245.405643209953, 4396.164728701537, 4397.780110994438, 66303.33696663068, 66900.33099668942, 67243.32756672468, 67606.0, 69482.30517694859, 58736.0, 59638.70180649069, 60141.69929150326, 60911.69544152251, 61428.0, 54805.72597136989, 54908.0, 55430.44569554253, 55461.44538554644, 56061.15908261379, 8168.877466837884, 8252.133525979925, 8293.668253269801, 8430.6206220719, 8574.82850343002, 34911.476327854594, 34971.0, 35055.29889402249, 36068.63931360653, 36202.45696314505, 45721.31418028799, 47975.28037079516, 48078.5192148088, 48310.75844620895, 48764.2685359727, 10715.303505272444, 10917.344959302467, 12001.219920705125, 12055.397230138633, 12254.4485498151, 13264.15497542477, 13293.20240785556, 13427.19436833793, 13675.24786136772, 13782.0, 12537.498500059895, 12751.107422480338, 12949.028822838512, 13034.4134513949, 13143.905771589687, 12552.623421297376, 12780.744385112432, 12812.487500500249, 13083.803742943674, 13445.731085378433, 12972.28652424088, 13159.210447373189, 13258.801117983045, 13288.202707837561, 13560.796588051384, 10542.892996235592, 10614.203934704774, 10833.349999000086, 11229.10941374656, 11431.828522572001, 9946.701598952042, 9951.402915825074, 10060.346077504939, 10139.239557033105, 10157.796844063225], "value": 6787.582118111156, "unit": "score"}], "name": "dromaeo_css", "value": 6948.347289227686, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 104.0, 111.0, 111.0, 112.0, 100.0, 114.0, 111.0, 111.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 132.0, 157.0, 183.0, 130.0, 153.0, 154.0, 137.0, 188.0, 134.0], "value": 152.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 162.0, 163.0, 160.0, 160.0, 161.0, 161.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 101.0, 111.0, 74.0, 76.0, 76.0, 117.0, 106.0, 72.0], "value": 88.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 146.0, 94.0, 92.0, 92.0, 148.0, 92.0, 92.0, 140.0], "value": 108.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0, 147.0, 145.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 56.0, 57.0, 56.0, 57.0, 60.0, 80.0, 56.0, 56.0], "value": 59.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 61.0, 60.0, 61.0, 59.0, 60.0, 60.0, 61.0], "value": 60.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 74.0, 77.0, 77.0, 81.0, 77.0, 78.0, 77.0], "value": 76.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 125.0, 124.0, 135.0, 135.0, 126.0, 123.0, 133.0, 159.0, 128.0], "value": 131.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 170.0, 169.0, 164.0, 166.0, 164.0, 165.0, 161.0, 171.0, 165.0], "value": 166.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 67.0, 67.0, 69.0, 68.0, 68.0, 71.0, 66.0, 65.0], "value": 67.8, "unit": "score"}], "name": "kraken", "value": 1539.7000000000003, "alertThreshold": 2.0}]} 08:12:13 INFO - Return code: 0 08:12:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:12:13 ERROR - # TBPL SUCCESS # 08:12:13 INFO - Running post-action listener: _resource_record_post_action 08:12:13 INFO - Running post-run listener: _resource_record_post_run 08:12:14 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 534765568; Read time: 148; Write time: 386892 08:12:14 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244715520; Read time: 0; Write time: 235700 08:12:14 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290050048; Read time: 148; Write time: 151192 08:12:14 INFO - Running post-run listener: _upload_blobber_files 08:12:14 INFO - Blob upload gear active. 08:12:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:12:14 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 08:12:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:12:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:12:15 INFO - (blobuploader) - INFO - Open directory for files ... 08:12:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:12:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:12:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:12:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:12:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:12:16 INFO - (blobuploader) - INFO - Done attempting. 08:12:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:12:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:12:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:12:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:12:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:12:16 INFO - (blobuploader) - INFO - Done attempting. 08:12:16 INFO - (blobuploader) - INFO - Iteration through files over. 08:12:16 INFO - Return code: 0 08:12:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:12:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:12:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3707089afda3425a0e2a29ca4262c5fd907802d14f8cc60f7a0e1cdf4b243d12cb542baa313f329d1e3567ca6f691d7f4117479de5e56d55916f7a01f3410ee1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f776a08423a829f01b11c7ba8d59a78450c8e8b7b760e4b4071f01557538abc09d46c5f0426098e51e50a1b6f75b1c83ac273a0dee7a72510dd6f46e4b600e8"} 08:12:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:12:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:12:16 INFO - Contents: 08:12:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3707089afda3425a0e2a29ca4262c5fd907802d14f8cc60f7a0e1cdf4b243d12cb542baa313f329d1e3567ca6f691d7f4117479de5e56d55916f7a01f3410ee1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f776a08423a829f01b11c7ba8d59a78450c8e8b7b760e4b4071f01557538abc09d46c5f0426098e51e50a1b6f75b1c83ac273a0dee7a72510dd6f46e4b600e8"} 08:12:16 INFO - Running post-run listener: copy_logs_to_upload_dir 08:12:16 INFO - Copying logs to upload dir... 08:12:16 INFO - mkdir: /builds/slave/test/build/upload/logs 08:12:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.165334 ========= master_lag: 0.88 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-04-21 08:12:17.434271) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 4 secs) (at 2016-04-21 08:12:17.441504) ========= 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=aa08bb06ff6271ef470a76a4000001be-1461249832.993885-325210016 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3707089afda3425a0e2a29ca4262c5fd907802d14f8cc60f7a0e1cdf4b243d12cb542baa313f329d1e3567ca6f691d7f4117479de5e56d55916f7a01f3410ee1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f776a08423a829f01b11c7ba8d59a78450c8e8b7b760e4b4071f01557538abc09d46c5f0426098e51e50a1b6f75b1c83ac273a0dee7a72510dd6f46e4b600e8"} build_url:https://queue.taskcluster.net/v1/task/ctClDZIwT5Sy0uJFFlv8rA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011379 build_url: 'https://queue.taskcluster.net/v1/task/ctClDZIwT5Sy0uJFFlv8rA/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/sha512/3707089afda3425a0e2a29ca4262c5fd907802d14f8cc60f7a0e1cdf4b243d12cb542baa313f329d1e3567ca6f691d7f4117479de5e56d55916f7a01f3410ee1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f776a08423a829f01b11c7ba8d59a78450c8e8b7b760e4b4071f01557538abc09d46c5f0426098e51e50a1b6f75b1c83ac273a0dee7a72510dd6f46e4b600e8"}' ========= master_lag: 4.06 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 4 secs) (at 2016-04-21 08:12:21.515546) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2016-04-21 08:12:21.515874) ========= 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=aa08bb06ff6271ef470a76a4000001be-1461249832.993885-325210016 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004651 ========= master_lag: 2.79 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2016-04-21 08:12:24.309537) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 08:12:24.309863) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 08:12:24.321002) ========= ========= Total master_lag: 7.79 =========