builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-042 starttime: 1461928067.06 results: success (0) buildid: 20160429024841 builduid: dacd43d705b647c4b4cd567123664053 revision: 8c3fd523d75bd30f691ca2d6cfdad18d576392a1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 04:07:47.060667) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 04:07:47.061083) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 04:07:47.061577) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 04:07:47.088925) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 04:07:47.089275) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1461914341.137192-1479835385 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-29 04:07:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-04-29 04:07:48 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126700 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 04:07:47.235424) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 04:07:47.235780) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1461914341.137192-1479835385 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023015 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 04:07:47.294800) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-29 04:07:47.295462) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8c3fd523d75bd30f691ca2d6cfdad18d576392a1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 8c3fd523d75bd30f691ca2d6cfdad18d576392a1 --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=74d6aec007b0fa31a864ebd7000001f8-1461914341.137192-1479835385 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-29 04:07:48,617 truncating revision to first 12 chars 2016-04-29 04:07:48,617 Setting DEBUG logging. 2016-04-29 04:07:48,617 attempt 1/10 2016-04-29 04:07:48,617 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8c3fd523d75b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-29 04:07:49,907 unpacking tar archive at: mozilla-central-8c3fd523d75b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.579394 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-29 04:07:48.891753) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 04:07:48.892516) ========= script_repo_revision: 8c3fd523d75bd30f691ca2d6cfdad18d576392a1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 04:07:48.893477) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 04:07:48.894019) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 04:07:48.904846) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-04-29 04:07:48.905243) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1461914341.137192-1479835385 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:07:50 INFO - MultiFileLogger online at 20160429 04:07:50 in /builds/slave/test 04:07:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:07:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:07:50 INFO - {'append_to_log': False, 04:07:50 INFO - 'base_work_dir': '/builds/slave/test', 04:07:50 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:07:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:07:50 INFO - 'branch': 'Firefox-Non-PGO', 04:07:50 INFO - 'buildbot_json_path': 'buildprops.json', 04:07:50 INFO - 'config_files': ('talos/linux_config.py',), 04:07:50 INFO - 'default_actions': ('clobber', 04:07:50 INFO - 'read-buildbot-config', 04:07:50 INFO - 'download-and-extract', 04:07:50 INFO - 'populate-webroot', 04:07:50 INFO - 'create-virtualenv', 04:07:50 INFO - 'install', 04:07:50 INFO - 'run-tests'), 04:07:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:07:50 INFO - 'download_minidump_stackwalk': True, 04:07:50 INFO - 'download_symbols': 'ondemand', 04:07:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:07:50 INFO - 'tooltool.py': '/tools/tooltool.py', 04:07:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:07:50 INFO - '/tools/misc-python/virtualenv.py')}, 04:07:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:07:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:07:50 INFO - 'installer_path': 'installer.exe', 04:07:50 INFO - 'log_level': 'info', 04:07:50 INFO - 'log_name': 'talos', 04:07:50 INFO - 'log_to_console': True, 04:07:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:07:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:07:50 INFO - 'opt_config_files': (), 04:07:50 INFO - 'pip_index': False, 04:07:50 INFO - 'sps_profile': False, 04:07:50 INFO - 'sps_profile_interval': 0, 04:07:50 INFO - 'suite': 'dromaeojs', 04:07:50 INFO - 'system_bits': '32', 04:07:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:07:50 INFO - 'title': 'talos-linux64-ix-042', 04:07:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:07:50 INFO - 'use_talos_json': True, 04:07:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:07:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:07:50 INFO - 'work_dir': 'build'} 04:07:50 INFO - ##### 04:07:50 INFO - ##### Running clobber step. 04:07:50 INFO - ##### 04:07:50 INFO - Running pre-action listener: _resource_record_pre_action 04:07:50 INFO - Running main action method: clobber 04:07:50 INFO - rmtree: /builds/slave/test/build 04:07:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:07:50 INFO - Running post-action listener: _resource_record_post_action 04:07:50 INFO - ##### 04:07:50 INFO - ##### Running read-buildbot-config step. 04:07:50 INFO - ##### 04:07:50 INFO - Running pre-action listener: _resource_record_pre_action 04:07:50 INFO - Running main action method: read_buildbot_config 04:07:50 INFO - Using buildbot properties: 04:07:50 INFO - { 04:07:50 INFO - "project": "", 04:07:50 INFO - "product": "firefox", 04:07:50 INFO - "script_repo_revision": "production", 04:07:50 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:07:50 INFO - "repository": "", 04:07:50 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:07:50 INFO - "buildid": "20160429024841", 04:07:50 INFO - "pgo_build": "False", 04:07:50 INFO - "basedir": "/builds/slave/test", 04:07:50 INFO - "buildnumber": 561, 04:07:50 INFO - "slavename": "talos-linux64-ix-042", 04:07:50 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:07:50 INFO - "platform": "ubuntu64_hw", 04:07:50 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:07:50 INFO - "branch": "mozilla-central", 04:07:50 INFO - "repo_path": "mozilla-central", 04:07:50 INFO - "revision": "8c3fd523d75bd30f691ca2d6cfdad18d576392a1", 04:07:50 INFO - "stage_platform": "linux64", 04:07:50 INFO - "builduid": "dacd43d705b647c4b4cd567123664053", 04:07:50 INFO - "slavebuilddir": "test" 04:07:50 INFO - } 04:07:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/TpZeID42Qki-J0DFAi3dCw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 04:07:50 INFO - Running post-action listener: _resource_record_post_action 04:07:50 INFO - ##### 04:07:50 INFO - ##### Running download-and-extract step. 04:07:50 INFO - ##### 04:07:50 INFO - Running pre-action listener: _resource_record_pre_action 04:07:50 INFO - Running main action method: download_and_extract 04:07:50 INFO - mkdir: /builds/slave/test/build/tests 04:07:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:50 INFO - https://queue.taskcluster.net/v1/task/TpZeID42Qki-J0DFAi3dCw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:07:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TpZeID42Qki-J0DFAi3dCw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:07:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TpZeID42Qki-J0DFAi3dCw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:07:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TpZeID42Qki-J0DFAi3dCw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:07:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TpZeID42Qki-J0DFAi3dCw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:07:56 INFO - Downloaded 1361 bytes. 04:07:56 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:07:56 INFO - Using the following test package requirements: 04:07:56 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:07:56 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:07:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:07:56 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:07:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:07:56 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:07:56 INFO - u'jsshell-linux-x86_64.zip'], 04:07:56 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:07:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:07:56 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:07:56 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:07:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:07:56 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:07:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:07:56 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:07:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:07:56 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:07:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:07:56 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:07:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:56 INFO - https://queue.taskcluster.net/v1/task/TpZeID42Qki-J0DFAi3dCw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:07:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TpZeID42Qki-J0DFAi3dCw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:07:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TpZeID42Qki-J0DFAi3dCw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:07:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TpZeID42Qki-J0DFAi3dCw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:07:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TpZeID42Qki-J0DFAi3dCw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:07:58 INFO - Downloaded 22301045 bytes. 04:07:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:07:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:07:59 INFO - Return code: 0 04:07:59 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:59 INFO - https://queue.taskcluster.net/v1/task/TpZeID42Qki-J0DFAi3dCw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:07:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TpZeID42Qki-J0DFAi3dCw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:07:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TpZeID42Qki-J0DFAi3dCw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:07:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TpZeID42Qki-J0DFAi3dCw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:07:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TpZeID42Qki-J0DFAi3dCw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:08:04 INFO - Downloaded 22301045 bytes. 04:08:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:08:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:08:05 INFO - Return code: 0 04:08: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')]} 04:08:05 INFO - https://queue.taskcluster.net/v1/task/TpZeID42Qki-J0DFAi3dCw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:08:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TpZeID42Qki-J0DFAi3dCw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:08:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TpZeID42Qki-J0DFAi3dCw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:08:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TpZeID42Qki-J0DFAi3dCw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:08:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TpZeID42Qki-J0DFAi3dCw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:08:08 INFO - Downloaded 10840145 bytes. 04:08:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:08:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:08:08 INFO - Return code: 0 04:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:08 INFO - https://queue.taskcluster.net/v1/task/TpZeID42Qki-J0DFAi3dCw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:08:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TpZeID42Qki-J0DFAi3dCw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:08:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TpZeID42Qki-J0DFAi3dCw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:08:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TpZeID42Qki-J0DFAi3dCw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:08:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TpZeID42Qki-J0DFAi3dCw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:08:10 INFO - Downloaded 54842749 bytes. 04:08:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TpZeID42Qki-J0DFAi3dCw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:08:10 INFO - mkdir: /builds/slave/test/properties 04:08:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:08:10 INFO - Writing to file /builds/slave/test/properties/build_url 04:08:10 INFO - Contents: 04:08:10 INFO - build_url:https://queue.taskcluster.net/v1/task/TpZeID42Qki-J0DFAi3dCw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:08:11 INFO - Running post-action listener: _resource_record_post_action 04:08:11 INFO - Running post-action listener: set_extra_try_arguments 04:08:11 INFO - ##### 04:08:11 INFO - ##### Running populate-webroot step. 04:08:11 INFO - ##### 04:08:11 INFO - Running pre-action listener: _resource_record_pre_action 04:08:11 INFO - Running main action method: populate_webroot 04:08:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:08:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:08:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:08:11 INFO - '--tppagecycles', 04:08:11 INFO - '7'], 04:08:11 INFO - 'tests': ['tsvgm']}}, 04:08:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:08:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:08:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:08:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:08:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:08:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:08:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:11 INFO - 'talos_options': ['--disable-e10s'], 04:08:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:08:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:08:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:11 INFO - 'talos_options': ['--disable-e10s'], 04:08:11 INFO - 'tests': ['damp', 'tps']}, 04:08:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:11 INFO - 'tests': ['damp', 'tps']}, 04:08:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:08:11 INFO - 'tests': ['dromaeo_dom']}, 04:08:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:08:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:08:11 INFO - 'tests': ['a11yr', 04:08:11 INFO - 'ts_paint', 04:08:11 INFO - 'tpaint', 04:08:11 INFO - 'sessionrestore', 04:08:11 INFO - 'sessionrestore_no_auto_restore', 04:08:11 INFO - 'tabpaint']}, 04:08:11 INFO - 'other-e10s': {'tests': ['a11yr', 04:08:11 INFO - 'ts_paint', 04:08:11 INFO - 'tpaint', 04:08:11 INFO - 'sessionrestore', 04:08:11 INFO - 'sessionrestore_no_auto_restore', 04:08:11 INFO - 'tabpaint']}, 04:08:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:08:11 INFO - 'ts_paint', 04:08:11 INFO - 'tpaint', 04:08:11 INFO - 'sessionrestore', 04:08:11 INFO - 'sessionrestore_no_auto_restore', 04:08:11 INFO - 'tabpaint']}, 04:08:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:08:11 INFO - 'ts_paint', 04:08:11 INFO - 'tpaint', 04:08:11 INFO - 'sessionrestore', 04:08:11 INFO - 'sessionrestore_no_auto_restore', 04:08:11 INFO - 'tabpaint']}, 04:08:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:08:11 INFO - 'tests': ['a11yr', 04:08:11 INFO - 'ts_paint', 04:08:11 INFO - 'tpaint', 04:08:11 INFO - 'sessionrestore', 04:08:11 INFO - 'sessionrestore_no_auto_restore', 04:08:11 INFO - 'tabpaint']}, 04:08:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:08:11 INFO - 'tests': ['a11yr', 04:08:11 INFO - 'ts_paint', 04:08:11 INFO - 'tpaint', 04:08:11 INFO - 'sessionrestore', 04:08:11 INFO - 'sessionrestore_no_auto_restore', 04:08:11 INFO - 'tabpaint']}, 04:08:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:08:11 INFO - 'tests': ['tsvgx', 04:08:11 INFO - 'tsvgr_opacity', 04:08:11 INFO - 'tart', 04:08:11 INFO - 'tscrollx', 04:08:11 INFO - 'cart']}, 04:08:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:08:11 INFO - 'tsvgr_opacity', 04:08:11 INFO - 'tart', 04:08:11 INFO - 'tscrollx', 04:08:11 INFO - 'cart']}, 04:08:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:11 INFO - 'talos_options': ['--disable-e10s'], 04:08:11 INFO - 'tests': ['tp5o']}, 04:08:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:11 INFO - 'tests': ['tp5o']}, 04:08:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:11 INFO - 'talos_options': ['--disable-e10s', 04:08:11 INFO - '--xperf_path', 04:08:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:08:11 INFO - 'tests': ['tp5n']}, 04:08:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:11 INFO - 'talos_options': ['--xperf_path', 04:08:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:08:11 INFO - 'tests': ['tp5n']}}, 04:08:11 INFO - 'talos.zip': {'path': '', 04:08:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:08:11 INFO - Running post-action listener: _resource_record_post_action 04:08:11 INFO - ##### 04:08:11 INFO - ##### Running create-virtualenv step. 04:08:11 INFO - ##### 04:08:11 INFO - Running pre-action listener: _resource_record_pre_action 04:08:11 INFO - Running main action method: create_virtualenv 04:08:11 INFO - Creating virtualenv /builds/slave/test/build/venv 04:08:11 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:08:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:08:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:08:11 INFO - Using real prefix '/usr' 04:08:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:08:11 INFO - Installing distribute.............................................................................................................................................................................................done. 04:08:13 INFO - Installing pip.................done. 04:08:13 INFO - Return code: 0 04:08:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:08:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:13 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 0x7fb0eef84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14305a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bf410>, '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 0x14c0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c07a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461914341.137192-1479835385', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:08:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:08:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:08:13 INFO - Using env: {'DISPLAY': ':0', 04:08:13 INFO - 'HOME': '/home/cltbld', 04:08:13 INFO - 'LANG': 'en_US.UTF-8', 04:08:13 INFO - 'LANGUAGE': 'en_US:en', 04:08:13 INFO - 'LOGNAME': 'cltbld', 04:08:13 INFO - 'MAIL': '/var/mail/cltbld', 04:08:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:13 INFO - 'MOZ_NO_REMOTE': '1', 04:08:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:13 INFO - 'NO_EM_RESTART': '1', 04:08:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:13 INFO - 'PWD': '/builds/slave/test', 04:08:13 INFO - 'SHELL': '/bin/bash', 04:08:13 INFO - 'SHLVL': '1', 04:08:13 INFO - 'TERM': 'linux', 04:08:13 INFO - 'TMOUT': '86400', 04:08:13 INFO - 'USER': 'cltbld', 04:08:13 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461914341.137192-1479835385', 04:08:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:13 INFO - '_': '/tools/buildbot/bin/python'} 04:08:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:14 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:08:14 INFO - Cleaning up... 04:08:14 INFO - Return code: 0 04:08:14 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:08:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb0eef84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14305a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bf410>, '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 0x14c0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c07a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461914341.137192-1479835385', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:08:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:08:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:08:14 INFO - Using env: {'DISPLAY': ':0', 04:08:14 INFO - 'HOME': '/home/cltbld', 04:08:14 INFO - 'LANG': 'en_US.UTF-8', 04:08:14 INFO - 'LANGUAGE': 'en_US:en', 04:08:14 INFO - 'LOGNAME': 'cltbld', 04:08:14 INFO - 'MAIL': '/var/mail/cltbld', 04:08:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:14 INFO - 'MOZ_NO_REMOTE': '1', 04:08:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:14 INFO - 'NO_EM_RESTART': '1', 04:08:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:14 INFO - 'PWD': '/builds/slave/test', 04:08:14 INFO - 'SHELL': '/bin/bash', 04:08:14 INFO - 'SHLVL': '1', 04:08:14 INFO - 'TERM': 'linux', 04:08:14 INFO - 'TMOUT': '86400', 04:08:14 INFO - 'USER': 'cltbld', 04:08:14 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461914341.137192-1479835385', 04:08:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:14 INFO - '_': '/tools/buildbot/bin/python'} 04:08:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:14 INFO - Downloading/unpacking psutil>=0.7.1 04:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:08:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:08:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:08:16 INFO - Installing collected packages: psutil 04:08:16 INFO - Running setup.py install for psutil 04:08:16 INFO - building 'psutil._psutil_linux' extension 04:08:16 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:08:16 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:08:16 INFO - building 'psutil._psutil_posix' extension 04:08:16 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:08:16 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:08:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:08:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:08:16 INFO - Successfully installed psutil 04:08:16 INFO - Cleaning up... 04:08:16 INFO - Return code: 0 04:08:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:08: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')]} 04:08:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08: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')]} 04:08:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08: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', '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 0x7fb0eef84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14305a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bf410>, '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 0x14c0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c07a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461914341.137192-1479835385', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:08: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:08: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 mozsystemmonitor==0.0.0 04:08:16 INFO - Using env: {'DISPLAY': ':0', 04:08:16 INFO - 'HOME': '/home/cltbld', 04:08:16 INFO - 'LANG': 'en_US.UTF-8', 04:08:16 INFO - 'LANGUAGE': 'en_US:en', 04:08:16 INFO - 'LOGNAME': 'cltbld', 04:08:16 INFO - 'MAIL': '/var/mail/cltbld', 04:08:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:16 INFO - 'MOZ_NO_REMOTE': '1', 04:08:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:16 INFO - 'NO_EM_RESTART': '1', 04:08:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:16 INFO - 'PWD': '/builds/slave/test', 04:08:16 INFO - 'SHELL': '/bin/bash', 04:08:16 INFO - 'SHLVL': '1', 04:08:16 INFO - 'TERM': 'linux', 04:08:16 INFO - 'TMOUT': '86400', 04:08:16 INFO - 'USER': 'cltbld', 04:08:16 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461914341.137192-1479835385', 04:08:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:16 INFO - '_': '/tools/buildbot/bin/python'} 04:08:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:17 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:08:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:08:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:08:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:08:19 INFO - Installing collected packages: mozsystemmonitor 04:08:19 INFO - Running setup.py install for mozsystemmonitor 04:08:19 INFO - Successfully installed mozsystemmonitor 04:08:19 INFO - Cleaning up... 04:08:19 INFO - Return code: 0 04:08:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:08: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')]} 04:08:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08: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')]} 04:08:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08: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', '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 0x7fb0eef84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14305a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bf410>, '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 0x14c0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c07a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461914341.137192-1479835385', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:08: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:08: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 blobuploader==1.2.4 04:08:19 INFO - Using env: {'DISPLAY': ':0', 04:08:19 INFO - 'HOME': '/home/cltbld', 04:08:19 INFO - 'LANG': 'en_US.UTF-8', 04:08:19 INFO - 'LANGUAGE': 'en_US:en', 04:08:19 INFO - 'LOGNAME': 'cltbld', 04:08:19 INFO - 'MAIL': '/var/mail/cltbld', 04:08:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:19 INFO - 'MOZ_NO_REMOTE': '1', 04:08:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:19 INFO - 'NO_EM_RESTART': '1', 04:08:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:19 INFO - 'PWD': '/builds/slave/test', 04:08:19 INFO - 'SHELL': '/bin/bash', 04:08:19 INFO - 'SHLVL': '1', 04:08:19 INFO - 'TERM': 'linux', 04:08:19 INFO - 'TMOUT': '86400', 04:08:19 INFO - 'USER': 'cltbld', 04:08:19 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461914341.137192-1479835385', 04:08:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:19 INFO - '_': '/tools/buildbot/bin/python'} 04:08:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:19 INFO - Downloading/unpacking blobuploader==1.2.4 04:08: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 04:08: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 04:08: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 04:08: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 04:08: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 04:08: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 04:08:21 INFO - Downloading blobuploader-1.2.4.tar.gz 04:08:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:08:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:08: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 04:08: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 04:08: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 04:08: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 04:08: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 04:08: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 04:08:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:08:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:08: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 04:08: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 04:08: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 04:08: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 04:08: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 04:08: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 04:08:21 INFO - Downloading docopt-0.6.1.tar.gz 04:08:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:08:22 INFO - Installing collected packages: blobuploader, requests, docopt 04:08:22 INFO - Running setup.py install for blobuploader 04:08:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:08:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:08:22 INFO - Running setup.py install for requests 04:08:22 INFO - Running setup.py install for docopt 04:08:22 INFO - Successfully installed blobuploader requests docopt 04:08:22 INFO - Cleaning up... 04:08:22 INFO - Return code: 0 04:08:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:22 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 0x7fb0eef84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14305a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bf410>, '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 0x14c0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c07a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461914341.137192-1479835385', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:08:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:08:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:08:22 INFO - Using env: {'DISPLAY': ':0', 04:08:22 INFO - 'HOME': '/home/cltbld', 04:08:22 INFO - 'LANG': 'en_US.UTF-8', 04:08:22 INFO - 'LANGUAGE': 'en_US:en', 04:08:22 INFO - 'LOGNAME': 'cltbld', 04:08:22 INFO - 'MAIL': '/var/mail/cltbld', 04:08:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:22 INFO - 'MOZ_NO_REMOTE': '1', 04:08:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:22 INFO - 'NO_EM_RESTART': '1', 04:08:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:22 INFO - 'PWD': '/builds/slave/test', 04:08:22 INFO - 'SHELL': '/bin/bash', 04:08:22 INFO - 'SHLVL': '1', 04:08:22 INFO - 'TERM': 'linux', 04:08:22 INFO - 'TMOUT': '86400', 04:08:22 INFO - 'USER': 'cltbld', 04:08:22 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461914341.137192-1479835385', 04:08:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:22 INFO - '_': '/tools/buildbot/bin/python'} 04:08:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:08:22 INFO - Running setup.py (path:/tmp/pip-Pv281j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:08:22 INFO - Running setup.py (path:/tmp/pip-SwsuDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:08:23 INFO - Running setup.py (path:/tmp/pip-ZAbOjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:08:23 INFO - Running setup.py (path:/tmp/pip-ZFU_f0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:08:23 INFO - Running setup.py (path:/tmp/pip-qRKV9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:08:23 INFO - Running setup.py (path:/tmp/pip-zB4MYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:08:23 INFO - Running setup.py (path:/tmp/pip-d8cB18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:08:23 INFO - Running setup.py (path:/tmp/pip-gGdRXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:08:23 INFO - Running setup.py (path:/tmp/pip-9n8pVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:08:23 INFO - Running setup.py (path:/tmp/pip-6DY6lI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:08:23 INFO - Running setup.py (path:/tmp/pip-2VKMvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:08:23 INFO - Running setup.py (path:/tmp/pip-vhVIOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:08:23 INFO - Running setup.py (path:/tmp/pip-RKQRTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:08:23 INFO - Running setup.py (path:/tmp/pip-7SYbNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:08:23 INFO - Running setup.py (path:/tmp/pip-lNWrse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:08:23 INFO - Running setup.py (path:/tmp/pip-XMlVyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:08:24 INFO - Running setup.py (path:/tmp/pip-938E7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:08:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:08:24 INFO - Running setup.py install for manifestparser 04:08:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:08:24 INFO - Running setup.py install for mozcrash 04:08:24 INFO - Running setup.py install for mozdebug 04:08:24 INFO - Running setup.py install for mozdevice 04:08:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:08:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:08:24 INFO - Running setup.py install for mozfile 04:08:24 INFO - Running setup.py install for mozhttpd 04:08:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:08:24 INFO - Running setup.py install for mozinfo 04:08:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:08:24 INFO - Running setup.py install for mozInstall 04:08:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:08:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:08:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:08:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:08:24 INFO - Running setup.py install for mozleak 04:08:24 INFO - Running setup.py install for mozlog 04:08:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:08:25 INFO - Running setup.py install for moznetwork 04:08:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:08:25 INFO - Running setup.py install for mozprocess 04:08:25 INFO - Running setup.py install for mozprofile 04:08:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:08:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:08:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:08:25 INFO - Running setup.py install for mozrunner 04:08:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:08:25 INFO - Running setup.py install for mozscreenshot 04:08:25 INFO - Running setup.py install for moztest 04:08:25 INFO - Running setup.py install for mozversion 04:08:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:08:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:08:25 INFO - Cleaning up... 04:08:25 INFO - Return code: 0 04:08:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:08:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:25 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 0x7fb0eef84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14305a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bf410>, '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 0x14c0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c07a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461914341.137192-1479835385', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:08:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:08:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:08:25 INFO - Using env: {'DISPLAY': ':0', 04:08:25 INFO - 'HOME': '/home/cltbld', 04:08:25 INFO - 'LANG': 'en_US.UTF-8', 04:08:25 INFO - 'LANGUAGE': 'en_US:en', 04:08:25 INFO - 'LOGNAME': 'cltbld', 04:08:25 INFO - 'MAIL': '/var/mail/cltbld', 04:08:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:25 INFO - 'MOZ_NO_REMOTE': '1', 04:08:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:25 INFO - 'NO_EM_RESTART': '1', 04:08:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:25 INFO - 'PWD': '/builds/slave/test', 04:08:25 INFO - 'SHELL': '/bin/bash', 04:08:25 INFO - 'SHLVL': '1', 04:08:25 INFO - 'TERM': 'linux', 04:08:25 INFO - 'TMOUT': '86400', 04:08:25 INFO - 'USER': 'cltbld', 04:08:25 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461914341.137192-1479835385', 04:08:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:25 INFO - '_': '/tools/buildbot/bin/python'} 04:08:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:08:26 INFO - Running setup.py (path:/tmp/pip-IGEUiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:08:26 INFO - Running setup.py (path:/tmp/pip-eyZ7RC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:08:26 INFO - Running setup.py (path:/tmp/pip-b4q9P3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:08:26 INFO - Running setup.py (path:/tmp/pip-4wLoWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:08:26 INFO - Running setup.py (path:/tmp/pip-JLqZFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:08:26 INFO - Running setup.py (path:/tmp/pip-QnNTTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:08:26 INFO - Running setup.py (path:/tmp/pip-aYMPC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:08:26 INFO - Running setup.py (path:/tmp/pip-7Ut1xH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:08:26 INFO - Running setup.py (path:/tmp/pip-yjQmYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:08:26 INFO - Running setup.py (path:/tmp/pip-1GsaOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:08:26 INFO - Running setup.py (path:/tmp/pip-HIbaNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:08:26 INFO - Running setup.py (path:/tmp/pip-73QQSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:08:26 INFO - Running setup.py (path:/tmp/pip-NfPyhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:08:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:08:27 INFO - Running setup.py (path:/tmp/pip-YJy3U2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:08:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:08:27 INFO - Running setup.py (path:/tmp/pip-EIiF2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:08:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:08:27 INFO - Running setup.py (path:/tmp/pip-giy5_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:08:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:08:27 INFO - Running setup.py (path:/tmp/pip-a9P6j9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:08:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:08:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:08:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:08:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:08:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:08:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:08:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:08:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:29 INFO - Downloading blessings-1.6.tar.gz 04:08:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:08:29 INFO - Installing collected packages: blessings 04:08:29 INFO - Running setup.py install for blessings 04:08:29 INFO - Successfully installed blessings 04:08:29 INFO - Cleaning up... 04:08:29 INFO - Return code: 0 04:08:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:08:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:08:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:08:29 INFO - Reading from file tmpfile_stdout 04:08:29 INFO - Current package versions: 04:08:29 INFO - argparse == 1.2.1 04:08:29 INFO - blessings == 1.6 04:08:29 INFO - blobuploader == 1.2.4 04:08:29 INFO - docopt == 0.6.1 04:08:29 INFO - manifestparser == 1.1 04:08:29 INFO - mozInstall == 1.12 04:08:29 INFO - mozcrash == 0.17 04:08:29 INFO - mozdebug == 0.1 04:08:29 INFO - mozdevice == 0.48 04:08:29 INFO - mozfile == 1.2 04:08:29 INFO - mozhttpd == 0.7 04:08:29 INFO - mozinfo == 0.9 04:08:29 INFO - mozleak == 0.1 04:08:29 INFO - mozlog == 3.1 04:08:29 INFO - moznetwork == 0.27 04:08:29 INFO - mozprocess == 0.22 04:08:29 INFO - mozprofile == 0.28 04:08:29 INFO - mozrunner == 6.11 04:08:29 INFO - mozscreenshot == 0.1 04:08:29 INFO - mozsystemmonitor == 0.0 04:08:29 INFO - moztest == 0.7 04:08:29 INFO - mozversion == 1.4 04:08:29 INFO - psutil == 3.1.1 04:08:29 INFO - requests == 1.2.3 04:08:29 INFO - wsgiref == 0.1.2 04:08:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:29 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 0x7fb0eef84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14305a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bf410>, '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 0x14c0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c07a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461914341.137192-1479835385', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:08:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:08:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:08:29 INFO - Using env: {'DISPLAY': ':0', 04:08:29 INFO - 'HOME': '/home/cltbld', 04:08:29 INFO - 'LANG': 'en_US.UTF-8', 04:08:29 INFO - 'LANGUAGE': 'en_US:en', 04:08:29 INFO - 'LOGNAME': 'cltbld', 04:08:29 INFO - 'MAIL': '/var/mail/cltbld', 04:08:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:29 INFO - 'MOZ_NO_REMOTE': '1', 04:08:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:29 INFO - 'NO_EM_RESTART': '1', 04:08:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:29 INFO - 'PWD': '/builds/slave/test', 04:08:29 INFO - 'SHELL': '/bin/bash', 04:08:29 INFO - 'SHLVL': '1', 04:08:29 INFO - 'TERM': 'linux', 04:08:29 INFO - 'TMOUT': '86400', 04:08:29 INFO - 'USER': 'cltbld', 04:08:29 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461914341.137192-1479835385', 04:08:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:29 INFO - '_': '/tools/buildbot/bin/python'} 04:08:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:08:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:08:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:08:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:08:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:08:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:08:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:08:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:08:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:08:29 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:08:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:08:29 INFO - Cleaning up... 04:08:29 INFO - Return code: 0 04:08:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:29 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 0x7fb0eef84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14305a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bf410>, '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 0x14c0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c07a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461914341.137192-1479835385', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:08:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:08:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:08:29 INFO - Using env: {'DISPLAY': ':0', 04:08:29 INFO - 'HOME': '/home/cltbld', 04:08:29 INFO - 'LANG': 'en_US.UTF-8', 04:08:29 INFO - 'LANGUAGE': 'en_US:en', 04:08:29 INFO - 'LOGNAME': 'cltbld', 04:08:29 INFO - 'MAIL': '/var/mail/cltbld', 04:08:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:29 INFO - 'MOZ_NO_REMOTE': '1', 04:08:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:29 INFO - 'NO_EM_RESTART': '1', 04:08:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:29 INFO - 'PWD': '/builds/slave/test', 04:08:29 INFO - 'SHELL': '/bin/bash', 04:08:29 INFO - 'SHLVL': '1', 04:08:29 INFO - 'TERM': 'linux', 04:08:29 INFO - 'TMOUT': '86400', 04:08:29 INFO - 'USER': 'cltbld', 04:08:29 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461914341.137192-1479835385', 04:08:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:29 INFO - '_': '/tools/buildbot/bin/python'} 04:08:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:30 INFO - Downloading/unpacking jsonschema 04:08:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:08:32 INFO - Downloading/unpacking functools32 (from jsonschema) 04:08:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:32 INFO - Downloading functools32-3.2.3-2.tar.gz 04:08:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:08:32 INFO - warning: no files found matching '*.txt' 04:08:32 INFO - no previously-included directories found matching 'build' 04:08:32 INFO - no previously-included directories found matching 'dist' 04:08:32 INFO - no previously-included directories found matching '.git*' 04:08:32 INFO - Installing collected packages: jsonschema, functools32 04:08:32 INFO - Running setup.py install for functools32 04:08:32 INFO - warning: no files found matching '*.txt' 04:08:32 INFO - no previously-included directories found matching 'build' 04:08:32 INFO - no previously-included directories found matching 'dist' 04:08:32 INFO - no previously-included directories found matching '.git*' 04:08:32 INFO - Successfully installed jsonschema functools32 04:08:32 INFO - Cleaning up... 04:08:32 INFO - Return code: 0 04:08:32 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:08:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0eef84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14305a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bf410>, '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 0x14c0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c07a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461914341.137192-1479835385', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:08:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:08:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:08:32 INFO - Using env: {'DISPLAY': ':0', 04:08:32 INFO - 'HOME': '/home/cltbld', 04:08:32 INFO - 'LANG': 'en_US.UTF-8', 04:08:32 INFO - 'LANGUAGE': 'en_US:en', 04:08:32 INFO - 'LOGNAME': 'cltbld', 04:08:32 INFO - 'MAIL': '/var/mail/cltbld', 04:08:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:32 INFO - 'MOZ_NO_REMOTE': '1', 04:08:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:32 INFO - 'NO_EM_RESTART': '1', 04:08:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:32 INFO - 'PWD': '/builds/slave/test', 04:08:32 INFO - 'SHELL': '/bin/bash', 04:08:32 INFO - 'SHLVL': '1', 04:08:32 INFO - 'TERM': 'linux', 04:08:32 INFO - 'TMOUT': '86400', 04:08:32 INFO - 'USER': 'cltbld', 04:08:32 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461914341.137192-1479835385', 04:08:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:32 INFO - '_': '/tools/buildbot/bin/python'} 04:08:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:32 INFO - Downloading/unpacking flake8 04:08:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:08:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:08:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:08:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:08:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:08:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:08:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:08:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:08:35 INFO - no previously-included directories found matching 'docs/_build' 04:08:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:08:35 INFO - Running setup.py install for pep8 04:08:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:08:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:08:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:08:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:08:35 INFO - no previously-included directories found matching 'docs/_build' 04:08:35 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:08:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:08:35 INFO - Cleaning up... 04:08:35 INFO - Return code: 0 04:08:35 INFO - Running post-action listener: _resource_record_post_action 04:08:35 INFO - Running post-action listener: _start_resource_monitoring 04:08:35 INFO - Starting resource monitoring. 04:08:35 INFO - ##### 04:08:35 INFO - ##### Running install step. 04:08:35 INFO - ##### 04:08:35 INFO - Running pre-action listener: _resource_record_pre_action 04:08:35 INFO - Running main action method: install 04:08:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:08:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:08:35 INFO - Reading from file tmpfile_stdout 04:08:35 INFO - Detecting whether we're running mozinstall >=1.0... 04:08:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:08:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:08:35 INFO - Reading from file tmpfile_stdout 04:08:35 INFO - Output received: 04:08:35 INFO - Usage: mozinstall [options] installer 04:08:35 INFO - Options: 04:08:35 INFO - -h, --help show this help message and exit 04:08:35 INFO - -d DEST, --destination=DEST 04:08:35 INFO - Directory to install application into. [default: 04:08:35 INFO - "/builds/slave/test"] 04:08:35 INFO - --app=APP Application being installed. [default: firefox] 04:08:35 INFO - mkdir: /builds/slave/test/build/application 04:08:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:08:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:08:51 INFO - Reading from file tmpfile_stdout 04:08:51 INFO - Output received: 04:08:51 INFO - /builds/slave/test/build/application/firefox/firefox 04:08:51 INFO - Running post-action listener: _resource_record_post_action 04:08:51 INFO - ##### 04:08:51 INFO - ##### Running run-tests step. 04:08:51 INFO - ##### 04:08:51 INFO - Running pre-action listener: _resource_record_pre_action 04:08:51 INFO - Running main action method: run_tests 04:08:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:08:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:08:51 INFO - Python 2.7.3 04:08:51 INFO - Return code: 0 04:08:51 INFO - grabbing minidump binary from tooltool 04:08: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')]} 04:08:51 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 0x14bf410>, '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 0x14c0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c07a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:08:51 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:08:51 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:08:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:08:51 INFO - Return code: 0 04:08:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:08:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:08:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:08:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:08:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:08:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:08:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:08:52 INFO - Return code: 0 04:08:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TpZeID42Qki-J0DFAi3dCw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:08:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TpZeID42Qki-J0DFAi3dCw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:08:52 INFO - Using env: {'DISPLAY': ':0', 04:08:52 INFO - 'HOME': '/home/cltbld', 04:08:52 INFO - 'LANG': 'en_US.UTF-8', 04:08:52 INFO - 'LANGUAGE': 'en_US:en', 04:08:52 INFO - 'LOGNAME': 'cltbld', 04:08:52 INFO - 'MAIL': '/var/mail/cltbld', 04:08:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:08:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:08:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:52 INFO - 'MOZ_NO_REMOTE': '1', 04:08:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:08:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:52 INFO - 'NO_EM_RESTART': '1', 04:08:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:52 INFO - 'PWD': '/builds/slave/test', 04:08:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:08:52 INFO - 'SHELL': '/bin/bash', 04:08:52 INFO - 'SHLVL': '1', 04:08:52 INFO - 'TERM': 'linux', 04:08:52 INFO - 'TMOUT': '86400', 04:08:52 INFO - 'USER': 'cltbld', 04:08:52 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461914341.137192-1479835385', 04:08:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:52 INFO - '_': '/tools/buildbot/bin/python'} 04:08:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TpZeID42Qki-J0DFAi3dCw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:08:52 INFO - mozversion application_buildid: 20160429024841 04:08:52 INFO - mozversion application_changeset: 8c3fd523d75bd30f691ca2d6cfdad18d576392a1 04:08:52 INFO - mozversion application_display_name: Nightly 04:08:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:08:52 INFO - mozversion application_name: Firefox 04:08:52 INFO - mozversion application_remotingname: firefox 04:08:52 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:08:52 INFO - mozversion application_vendor: Mozilla 04:08:52 INFO - mozversion application_version: 49.0a1 04:08:52 INFO - mozversion platform_buildid: 20160429024841 04:08:52 INFO - mozversion platform_changeset: 8c3fd523d75bd30f691ca2d6cfdad18d576392a1 04:08:52 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:08:52 INFO - mozversion platform_version: 49.0a1 04:08:52 INFO - using testdate: 1461928132 04:08:52 INFO - actual date: 1461928132 04:08:52 INFO - starting webserver on 'localhost:34761' 04:08:52 INFO - SUITE-START | Running 2 tests 04:08:52 INFO - TEST-START | dromaeo_css 04:08:52 INFO - operating with platform_type : linux_ 04:08:52 INFO - Initialising browser for dromaeo_css test... 04:08:52 INFO - TEST-INFO | started process 32061 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEEwZ9Y/profile http://localhost:34761/getInfo.html) 04:08:57 INFO - PROCESS | 32061 | __metrics Screen width/height:1600/1200 04:08:57 INFO - PROCESS | 32061 | colorDepth:24 04:08:57 INFO - PROCESS | 32061 | Browser inner width/height: 1024/697 04:08:57 INFO - PROCESS | 32061 | __metrics 04:08:58 ERROR - PROCESS | 32061 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:08:58 INFO - TEST-INFO | 32061: exit 0 04:08:58 INFO - Browser initialized. 04:08:58 INFO - Running cycle 1/1 for dromaeo_css test... 04:08:58 INFO - TEST-INFO | started process 32141 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEEwZ9Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:09:11 INFO - PROCESS | 32141 | RSS: Main: 156143616 04:09:11 INFO - PROCESS | 32141 | 04:10:02 INFO - PROCESS | 32141 | 1461928202286 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:12:15 INFO - PROCESS | 32141 | Cycle 1(1): loaded http://localhost:34761/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34761/tests/dromaeo/cssquery-ext.html) 04:12:16 INFO - PROCESS | 32141 | RSS: Main: 265142272 04:12:16 INFO - PROCESS | 32141 | 04:15:18 INFO - PROCESS | 32141 | Cycle 1(1): loaded http://localhost:34761/tests/dromaeo/cssquery-ext.html (next: http://localhost:34761/tests/dromaeo/cssquery-jquery.html) 04:15:19 INFO - PROCESS | 32141 | RSS: Main: 233971712 04:15:19 INFO - PROCESS | 32141 | 04:18:21 INFO - PROCESS | 32141 | Cycle 1(1): loaded http://localhost:34761/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34761/tests/dromaeo/cssquery-mootools.html) 04:18:22 INFO - PROCESS | 32141 | RSS: Main: 225042432 04:18:22 INFO - PROCESS | 32141 | 04:21:24 INFO - PROCESS | 32141 | Cycle 1(1): loaded http://localhost:34761/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34761/tests/dromaeo/cssquery-prototype.html) 04:21:24 INFO - PROCESS | 32141 | RSS: Main: 231137280 04:21:24 INFO - PROCESS | 32141 | 04:24:27 INFO - PROCESS | 32141 | Cycle 1(1): loaded http://localhost:34761/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34761/tests/dromaeo/cssquery-yui.html) 04:24:28 INFO - PROCESS | 32141 | RSS: Main: 210329600 04:24:28 INFO - PROCESS | 32141 | 04:27:30 INFO - PROCESS | 32141 | Cycle 1(1): loaded http://localhost:34761/tests/dromaeo/cssquery-yui.html (next: http://localhost:34761/tests/dromaeo/cssquery-dojo.html) 04:27:31 INFO - PROCESS | 32141 | RSS: Main: 271155200 04:27:31 INFO - PROCESS | 32141 | 04:27:31 INFO - PROCESS | 32141 | __start_tp_report 04:27:31 INFO - PROCESS | 32141 | _x_x_mozilla_page_load 04:27:31 INFO - PROCESS | 32141 | _x_x_mozilla_page_load_details 04:27:31 INFO - PROCESS | 32141 | |i|pagename|runs| 04:27:31 INFO - PROCESS | 32141 | |0;dojo.html;2587.6377307176995;2621.0564196889127;2644.6165306030625;2654.270075729173;2662.9067982620613;4470.485894122177;4581.45022597288;4613.769311534418;4628.120657075154;4632.2356811126165;4536.9092618147615;4589.977050114745;4629.305604159378;4629.3518907353;4640.373549570807;4258.552851950547;4279.572042795711;4293.184294983958;4305.892352691177;4429.645628349725;4337.783110844461;4342.370356298335;4350.216960947028;4361.236783562879;4364.9802726864045;4201.1807697499;4267.039916018902;4276.828926842923;4300.8709738707885;4332.783360831946;4242.00312926462;4246.40550322955;4275.935860962088;4281.614654681093;4330.501992270866;4286.828526858922;4296.355546667994;4298.828046878121;4315.201687687788;4338.674599405026;4423.159599676052;4494.7078439901625;4539.182947069527;4561.566651168134;4590.839320623762;4900.901981960376;4929.038837426703;4933.062718083588;4948.455669876311;4970.105381031413;4923.77842997066;4942.505749425065;4954.826581069645;4990.550850423443;5002.074616196015;4507.233770259064;4597.42532183477;4627.606653434428;4628.722276663378;4670.159371313128;5013.248012798036;5034.194528875362;5081.74591270435;5084.084864724311;5088.313077734532;4839.685420447659;4842.806287748451;4846.297286893451;4857.368542089576;4886.53577910098;4872.756362181876;4910.680805747615;4940.505949405031;4950.727709975914;4957.157283261782;4877.365942427533;4881.707097574157;4883.876708357097;4885.706857588556;4928.581070609039;4845.563899249014;4857.975710121426;4859.781309841065;4872.756362181947;4911.066897289504;4053.250148722496;4115.588441155861;4119.567445418248;4126.09225970286;4169.854055108057;3614.6023937366867;3642.9089272767865;3643.635636436335;3679.7608155469807;3703.5555733311635;4201.810918508674;4220.683448741357;4227.281362168439;4229.048464095554;4275.786210689453;4800.1119792838435;4869.318295438641;4883.877903052381;4896.510348965075;4909.337239472626;4308.9569104309185;4310.655147588185;4311.525732169459;4353.804078816461;4355.063661312833;4377.715448495837;4406.471223453206;4411.977940110343;4425.424694789656;4466.6203372713035;4548.090381923563;4648.767561621906;4675.672702910763;4696;4705.341252224623;4888.95111048885;4895.192293271571;4902.534259245366;4910.2129647113115;4954.628402869727;4645.442546894259;4650.139724151043;4651.720896746206;4704.341392205026;4722.456917454537;4757.476677565396;4840.7337596432535;4889.217725163957;4890.633202509897;4892.119418504703;4853.272009198648;4854.320395144612;4870.391201099863;4883.389576302962;4929.162042452864;4760.880977975578;4781.952180478151;4782.665213435026;4787.712737235777;4839.128956787812;4658.324542941323;4764.785584648768;4813.278008298783;4839.104765618372;4861.1006963711825;4674.859754207379;4683.953160468488;4696.225122854691;4702.506236845082;4720.244760838249;4699.15415225249;4801.783919723691;4807.639427043056;4813.181759101031;4862.07620552094;4761.9285710713675;4780.689255198401;4787.736674482937;4801.039792041536;4830.516948305141 04:27:31 INFO - PROCESS | 32141 | |1;ext.html;569.2997612936089;604.6976511744128;610.7068607068607;616.9444749972502;627.1408170805994;27341.863290683545;34354.828225858895;35006.47490287648;35039.47440788384;35110.297794044105;37528.24943501128;38107;38158.809205953934;38399.80800095996;38422;7257;7447.9627601862185;7452.515586486861;7459;7681.500702454323;7313.963430182842;9348.672796452125;9644.517774111302;9666.178374838148;9669.951650241774;9784.26618003649;9896;9907.702768916944;9910.157636600861;9914.107730304271;7263.164736055369;7473.065866766654;9674.854877176847;9796.510174491246;9825.16486098686;7377.88933166003;9320.394174378644;9581;9587.808243835154;9602;36760;37553.62446375529;37613;37678;37712.245755085016;2956.231379841235;2961.970380296191;3167.7782555221143;3198.2643991881764;3661.4324779659196;28984.130476085753;29140.41719165626;29219.707802921912;29384.11847644553;30437.543436848464;3276.2955964467515;3323.418401779679;3345.8327083645963;3375.2911888503445;3389.6440873708398;173255;173692.13153934275;173853;174630;175616;51308.23037654438;51411.48588514142;51815.48184518182;51817;51830.74084629553;55101.44898551043;55274;55274.72362638161;55285;55309.72345138249;14470.204138772258;15391.384344626089;15406.22968851553;15410.614734631725;15421.768673469682;9583.90416095844;10064.44645544502;10235.795284094425;10702.357858528514;10708.357498550113;14925.25373731309;15013.174275414956;15160.696786064216;15254;16023.839761602469;6175.320714721377;6248;6312.779052733133;6362.141110950055;6400.23197216337;871.7254064969515;906.1934877958622;914.2366124286162;949.0651708067548;958.9424634521812;27212.319692007462;28131.666108815727;28430.573541396894;28518.71481285202;28923;991.5389343955095;1000.6047611193683;1010.7624708193568;1055.3034996902009;1100.312304809494;14576.85423145755;14668;15124.54626361211;15238.390464381522;15284.847151528566;333028;337657;338044;338363;340865;48080.27879581809;48249.035019299416;48264.517354826705;48347.516524835;48366;1073.6456969200144;1140.184767890962;1168.339887963298;1221.6274036418977;1229.9077569182348;26964.191074267805;27827.304317391416;29895.252618684706;30536.530820071624;30644.693553065077;42166;42612;43074.78462607667;43076.78461607672;43123.353149703406;307326;316736;317440;317622;319309;29282.56076158902;30917.0724878254;32819.17952051218;35500.28999420049;38728;36488.452673209395;42249.577504225796;42452.787736061124;42507;43103.568964309954;36241.093972650895;36921.81539092287;36959.63040369562;37443;37991.62008379881;34247.48628770521;36476.63523364732;36479.088022799646;36514.63485365112;36872.26255474822;35348.293034139686;36016.09959751027;36438.8178059108;36605.450918235714;36853.63146368502;31620.525692114177;32736.83631581827;32973.50539741858;33037.71396576536;33323.33353332871;24824.379390515383;25103.372415689755;25221.369465763502;25263.747362526876;25654.486910261316 04:27:31 INFO - PROCESS | 32141 | |2;jquery.html;372.09766316682055;372.465511990294;377.3114066828038;379.71711075248936;393.716524102646;16420.917895410523;17071;17506.56233594161;17526.12369381529;17551.385701500432;14329.355179016944;14752.262386880666;15104.546863594082;15113.471028514005;15121.395144194219;4687.156311863863;4811.542903424169;4840.104580652591;4841.128596852565;4848.612111031109;3554.289142171563;4744.6952088175685;5238.73806309683;5517;5527.419620939803;5500.559955203574;5521.089020311644;5524.668519888799;5526.309211348582;5535.6955367454775;5528.585356098289;6081.756729730805;6083.48290395317;6084.330723620443;6086.7565297388055;3465.549478567795;5173.611979101583;5228.320318358627;5422.566194704415;5437.157240627709;12031.157818952677;12193.93903030488;12257.632271031884;12330.136890417674;12422.192557483824;1949.7952714964865;2353.1528649686097;2394.293683363412;2400.3159099656687;2457.213691618683;8637.740867773977;9271.397359171633;9547.644062084939;9647.565859536338;9678.56446459911;1741.3818094576495;1755.7629719987895;1762.4712586224082;1810.1220907859677;1812.6284111757059;66335.66832165857;69348.3065169347;70050;71062.28937710608;71259.28740712578;9728.513574321256;10224.182065434747;10518.316309439862;10698.679039628823;11097.500612472459;14193.432262709583;14240.928795355956;14287.714245715028;14295.78556321656;14300.713985720227;7191.173015103225;7352.669129889167;7457.47797654159;7500.437467189873;7530.585817780075;7021.122359705037;7028.2620324866175;7118.9644051779405;7193.280671932765;7201.675924583406;4385.232584297799;4424.380586717862;4436.778161091933;4549.522300158502;4558.544145585415;1743.6425532765752;1778.4486809088964;1785.9374921877672;1835.8859419748474;1842.7469320861942;876.8816209811721;900.9819803603891;920.3281604428804;920.4155361345594;928.535732133933;16254.918725406298;17321.56696082608;17399.304027838996;17445.7383139253;17749.201285942163;913.7441516375426;931.4132096779122;962.3600305796567;977.6529332087007;985.3890587835444;9265.490398028038;9758;9767.658131965347;9778.571999041536;9915.206783457306;249044;255901;256769;403702;404209;85083;85758;88225.55887220523;88298.55850720833;90411;954.2604481526872;970.1075010989765;982.543117450389;987.7234374375187;994.8905620381752;15529.378824846879;15775.447859324868;15886.443974460839;16212.432564860645;16412.917935410245;34763.30473390569;35912.4613130798;36169.45745813762;36665.45001825028;37503.249935001695;50580.74709626575;52771.736141319045;52875;53065;53792.731036344565;7153.3919616833155;7493.512921660074;7575.886361704469;7575.962120189364;7672.923270767221;10856.945715271373;10939.234253602172;11181.888181118085;11184.664460066211;11191.552337906392;9538.713838584854;9548.570314335733;9721.85417218728;9729.124378805942;9889.604415823287;9881.555330010024;9960.651377201762;9998.600055997678;10119.190464762654;10177.643782467874;9790.755231118994;9876.555555000186;10099.545520451744;10198.082172604501;10319.587216511556;7669.309762121436;7748.3413909816045;7763.039792559997;7848.450608457353;7881.251281128284;9041.412308199946;9236.815263694554;9237.399569027992;9464.716058518256;9548.52257387114 04:27:31 INFO - PROCESS | 32141 | |3;mootools.html;1311.7901135818272;1438.1586771738532;1459.5183589415494;1572.4732214708072;1726.7323564847445;6712.395884370406;7559.39524838013;7777.377809775211;7806.960965195166;7817.530948143115;7544.735934242302;7694.6152692365295;7696;7699.615019249043;7701.653425595848;1899.4396652987332;1974.7729011163756;1976.9505762355911;2132.6694362373855;2168.3061420345416;2182.2471247419694;2252.8648281103106;2257.480779420734;2257.8758168300737;2258.9096436142536;2160.3087012156116;2187.0923566719794;2191.824654027674;2193.56128774245;2203.0967303405605;1865.2632210276865;2150.6989021536997;2196.1325276515768;2200.7249093863265;2202.592520383734;2229.0860747093775;2246.70792796937;2250.5386395788987;2254.3124347074136;2254.8308876834303;7501.287377699165;7501.5874126923;7547.886781698279;7577.6211189440855;7577.696892124309;4201.70588058836;4314.18030574193;4327.480702315742;4339.327404252346;4339.848105316299;2753.821001634907;2768.584712293152;2919.168037109435;2933.0467598030514;2941.4411261860178;920.0891117793336;934.1779234273796;950.0404591362774;961.7739831139677;967.3712087143343;9970;9993.750156246151;10005.549750261256;10026.69919902404;10029.648962286357;4155.355919832431;4159.646430053419;4260.765657888784;4270.338097594878;4313.633341165973;8600.526971016528;8606.053334133241;8616.741497755078;8624.482531048032;8631.482111073356;4558.9772051139535;4559.521250268674;4593.173228818845;4597.471290801601;4599.172149013143;3632.838461115632;3917.7061720370516;4092.1611069730634;4146.357314616239;4148.709590328648;3468.0809585459874;3534.823258837048;3554.8400321985573;3740.214554943438;3769.359208934488;1195.055905834381;1222.8104643780227;1230.9322987235787;1233.9814902776466;1237.2143688757524;695.4471195399669;750.4371721209093;775.2092865277385;775.4765533265137;776.9184235655288;5065.164247899055;5127.897442051138;5202;5246;5395.298611180521;417.63039709857;421.24596971421425;426.2242718252812;427.8074866310173;436.03200894015237;3529.382358087376;3555.2711694102645;3643.9453408198897;3669.284489524517;3720.6837418819164;9284.582193801296;9546.140847323635;9657.46883921377;9785.608575657036;9869.259805514615;8569.614367353484;9598.520073996273;9601.567929443052;9603.951980240054;9717.222622190207;7004.509684322151;7110.964445177741;7144.499885007999;7164.498485106097;7166.104236970379;4932.161532539405;5205.557527610195;5209.140491818807;5248.6588371755715;5283.630145889751;8490.27832634233;8545.102764209669;8669.436486628349;8918.152775486318;9089;8932.776680583038;8945.507997060224;9091.454512729257;9148;9162.862557061517;6869.107016087876;6935.133108361455;7027.718891244497;7058.470614703815;7064.894026589708;7477.813054673677;7500.399968002655;7535.171131175676;7535.623218838927;7553.357964572853;6629.7348106075215;6758.493113016445;6836.453083753388;6894.482913781386;6988.545744526589;6730.865382692221;6770.763023294161;6771;6864.965675171592;6885.242623311332;5790.305163380422;5807.651540907559;5838.474537291664;5848.356680765198;6105.542084343603;4441.800118994717;4480.596746292849;4544.886377840448;4550.522195169459;4567.977160114178;4570.748608826547;4570.771461426982;4581.587657110876;4631.328457373729;4671.392718946651 04:27:31 INFO - PROCESS | 32141 | |4;prototype.html;297.19460262688114;297.5893267291138;301.22284505974585;301.4558721507679;306.6933066933067;4678.461976872661;4708.223143181375;4716.3632909557155;4717.78769955352;4760.071786001731;4648.930266046003;4667.369905062816;4667.976660116703;4668.299755036746;4677.88305292367;3562.251927095313;3620.3664358737246;3686.4470329450664;3729.403295472725;3788.3331334212994;3739.1773809761944;3775.528058992626;3777.6600105990456;3778.792166430845;3810.637989391017;3549.982250088746;3759.097816524028;3764.7929363884973;3770.9811450942843;3793.658570728634;3621.149029977953;3727.4781530585738;3732.9253414931823;3734.8879533613763;3766.924661506782;3318.469044952796;3322.302316513535;3323.2854936188837;3355.9696383688006;3367.51171080192;4489.124620698965;4502.921056573632;4514.841980530666;4517.954820451786;4538.8865278367975;3947.7631342119566;4155.189738001091;4162.458880345566;4238.364245363189;4248.830046798124;4869.196582563873;4871.561559459666;4899.926501102486;4904.509549045067;4931.137051016058;3463.4716656840396;3475;3488.4244099723514;3501.667341602569;3511.841092439489;4948.331975183341;5065.721385323805;5075.822346217901;5130.1791713326065;5141.203113517411;3618.9638103619154;3641.1807343347537;3641.198936234024;3660.5790334111384;3661.6338366163172;3678.9816050919576;3683.281760056817;3697.556293244828;3701.40777475608;3702.8703995360033;4130.752154870717;4152.086540960984;4170.416141740159;4185.602367775056;4200.432941552851;4633.891579331396;4906.877328066756;4907.435644900882;4935.679180853233;4942.4316203637045;1327.1108357400565;1332.660171656241;1335.2455862437691;1337.6388375138852;1342.7784415571516;852.6972924611673;877.912208779117;909.1045320359441;916.9679061232824;927.4481683398367;4603.838865639686;4605.539446055368;4608.838690645811;4610.170169369546;4638.884027899329;5364.329458817648;5367.114426119724;5367.570594352521;5375.6774593524515;5389.164679474609;4445.777711114431;4602.2636378180005;4617.8845528861375;4624.213883639789;4646.163690535668;2799.8520606551215;2819.2951762059483;2825.4914115459414;2827.872745726447;2832.716728327192;4955.306257124005;4965.453800081988;4982.451930287665;4988.725620090857;4998.550130488274;5189.766460509286;5363.651362661492;5374.193870919394;5377.139657654757;5381.54256888161;4948.6783359082265;4974.875628109254;4975.154223782039;4977.352944117241;4978.5768209701855;5233.241180028951;5252.789888404421;5259.973700131475;5263.815766448156;5267.130923397596;5002.324686167321;5097.623641616817;5111;5111.977604479045;5125.538701516882;4941.555260026615;4965.379327584052;4980.800767969386;4984.675996060245;4997.725125118153;3763.360228761172;3767.8869633911027;3772.4152756322815;3774.414965680324;3783.735138540276;5076.466970968143;5213.132776972574;5219.582433405394;5274.815381461631;5288.603354748486;5059.949400505948;5079.3650793650795;5085.872853178552;5086.9745651271505;5095.643304968617;5075.264086707481;5082.3138876252715;5095.388553373619;5096.655538452205;5098.592112631055;4907.533784290629;5026.6679329978315;5032.647714659939;5033.899322013613;5038.722870242172;4710.152172608963;4769;4952.57903078228;4954.355933728592;4961.975190124026;4787.281907713871;4813.614910807057;4817.723303324552;4830.550834749632;4845.345878306524 04:27:31 INFO - PROCESS | 32141 | |5;yui.html;619.9287081985572;641.6438876423585;660.41223311253;663.4327649859367;701.7087908517965;11473.541058357667;11525.0779937605;11707.765844683101;12500.56248031319;13067;12641.178323408973;12692.238465692066;12744.107912446132;12749.235045897229;12766.170198937085;635.9554831161821;792.0455850699907;799.9480033797813;801.3228821645729;801.8676918308472;775.6548335990486;803.0804728585766;805.6374631415857;805.9113497515298;805.9758207253792;827.4828232354778;830.6303694855792;832.7252006837729;835.2983493865152;837.0666706622134;660.5937348530667;675.7972608217564;821.7534739578133;822.9877250981267;823.6952327638782;500.02495134487896;584.7923986984601;606.0152252589542;606.1120458528234;606.3845197124922;12106.81839772404;12160.452779624939;12164.209326393844;12200.877991220063;12201.145919785618;11464.828027579593;12052.698682532919;12120.575779847752;12206.877931220663;12529.937350313281;9107.726768196964;9171.862422063674;9240.491772952484;9378.53107344637;9433.952830235805;3146.103360542257;3155.5897733294755;3174.6349169845535;3189.649138594753;3237.109794806447;46606.53393466056;46981;47527;47642.52357476416;47650.76174619139;9225.538723063954;9236.168744813;9599.568019439143;9720;9760;17089.91455042717;17094;17260.568485787706;17333.7399939001;17346.566335841453;6208.689565521706;6309;6517.478601711851;6577.967110164419;6607.306232845578;3570.842430361094;3586.6234045425376;3587.157018100744;3631.473436351714;3640.0899775056237;2811.9015834445695;2865.6131422258145;2866.1831378057154;2871.54055351147;3063.908082757521;542.2814770429197;542.9212764149177;545.1958361416957;546.2652732075352;551.4513059505737;478.32794923133054;501.51353187408154;515.4330236739556;562.5415286541455;566.1507738392411;7600.885986710204;7611.2769286917655;7622.237776222444;7653.885191722128;7961.960190199012;445.5588966922723;519.6154845414366;560.2324073661663;563.6111083352474;569.0014025385423;3677.8344974476213;3708.8678192972607;3760.0035990462;3760.435934609776;3772.6981841452616;55260;56530;57557;57661.423385766444;58019.70990145107;47941.28088078681;48974.26538601924;49841;50796.74601627042;52308;45729.31406028912;46092.53907460949;46563.76718116388;46763.29855052177;47356.763216183695;7215.170255420484;7254.854902901807;7364.594947277951;7381.8154546136775;7386.4090872728975;29968.400631986802;30713.232169195948;31291.687083128876;31411;31828;38554.22891542209;40539;41069.794651026554;41147;41209;9379.343445958717;9386.436813791195;9463.290253230898;9509.381890177116;9558.139767420966;10321.48392580353;10436.63471778484;10662.573497060032;10684.305520141166;11283.887161128612;7860.528368297921;9595.42427454355;9673.274504412057;9704.6118155273;9797.363171393836;9682.515874206121;9932.503374831085;10203.183745300506;10351.327163734333;10510.159187264848;9653.613855445985;10245.180385569285;10395.220358472994;10442.947785261329;10550.577976880839;8613.698520552001;8709.477698803783;8813.867791983253;9044.14080662336;9227.953860230657;8481.745547633582;8780.121987801169;9041.367104302635;9054.469225062212;9237.769055773391 04:27:31 INFO - PROCESS | 32141 | __end_tp_report 04:27:31 INFO - PROCESS | 32141 | __start_cc_report 04:27:31 INFO - PROCESS | 32141 | _x_x_mozilla_cycle_collect,1020 04:27:31 INFO - PROCESS | 32141 | __end_cc_report 04:27:31 INFO - PROCESS | 32141 | __startTimestamp1461929251185__endTimestamp 04:27:31 INFO - PROCESS | 32141 | 04:27:31 INFO - PROCESS | 32141 | ------- Summary: start ------- 04:27:31 INFO - PROCESS | 32141 | Number of tests: 6 04:27:31 INFO - PROCESS | 32141 | 04:27:31 INFO - PROCESS | 32141 | [#0] dojo.html Cycles:165 Average:4558.59 Median:4675.67 stddev:459.67 (9.8%) stddev-sans-first:434.30 04:27:31 INFO - PROCESS | 32141 | Values: 2587.6 2621.1 2644.6 2654.3 2662.9 4470.5 4581.5 4613.8 4628.1 4632.2 4536.9 4590.0 4629.3 4629.4 4640.4 4258.6 4279.6 4293.2 4305.9 4429.6 4337.8 4342.4 4350.2 4361.2 4365.0 4201.2 4267.0 4276.8 4300.9 4332.8 4242.0 4246.4 4275.9 4281.6 4330.5 4286.8 4296.4 4298.8 4315.2 4338.7 4423.2 4494.7 4539.2 4561.6 4590.8 4900.9 4929.0 4933.1 4948.5 4970.1 4923.8 4942.5 4954.8 4990.6 5002.1 4507.2 4597.4 4627.6 4628.7 4670.2 5013.2 5034.2 5081.7 5084.1 5088.3 4839.7 4842.8 4846.3 4857.4 4886.5 4872.8 4910.7 4940.5 4950.7 4957.2 4877.4 4881.7 4883.9 4885.7 4928.6 4845.6 4858.0 4859.8 4872.8 4911.1 4053.3 4115.6 4119.6 4126.1 4169.9 3614.6 3642.9 3643.6 3679.8 3703.6 4201.8 4220.7 4227.3 4229.0 4275.8 4800.1 4869.3 4883.9 4896.5 4909.3 4309.0 4310.7 4311.5 4353.8 4355.1 4377.7 4406.5 4412.0 4425.4 4466.6 4548.1 4648.8 4675.7 4696.0 4705.3 4889.0 4895.2 4902.5 4910.2 4954.6 4645.4 4650.1 4651.7 4704.3 4722.5 4757.5 4840.7 4889.2 4890.6 4892.1 4853.3 4854.3 4870.4 4883.4 4929.2 4760.9 4782.0 4782.7 4787.7 4839.1 4658.3 4764.8 4813.3 4839.1 4861.1 4674.9 4684.0 4696.2 4702.5 4720.2 4699.2 4801.8 4807.6 4813.2 4862.1 4761.9 4780.7 4787.7 4801.0 4830.5 04:27:31 INFO - PROCESS | 32141 | 04:27:31 INFO - PROCESS | 32141 | [#1] ext.html Cycles:180 Average:43893.18 Median:36457.73 stddev:74898.99 (205.4%) stddev-sans-first:75038.46 04:27:31 INFO - PROCESS | 32141 | Values: 569.3 604.7 610.7 616.9 627.1 27341.9 34354.8 35006.5 35039.5 35110.3 37528.2 38107.0 38158.8 38399.8 38422.0 7257.0 7448.0 7452.5 7459.0 7681.5 7314.0 9348.7 9644.5 9666.2 9670.0 9784.3 9896.0 9907.7 9910.2 9914.1 7263.2 7473.1 9674.9 9796.5 9825.2 7377.9 9320.4 9581.0 9587.8 9602.0 36760.0 37553.6 37613.0 37678.0 37712.2 2956.2 2962.0 3167.8 3198.3 3661.4 28984.1 29140.4 29219.7 29384.1 30437.5 3276.3 3323.4 3345.8 3375.3 3389.6 173255.0 173692.1 173853.0 174630.0 175616.0 51308.2 51411.5 51815.5 51817.0 51830.7 55101.4 55274.0 55274.7 55285.0 55309.7 14470.2 15391.4 15406.2 15410.6 15421.8 9583.9 10064.4 10235.8 10702.4 10708.4 14925.3 15013.2 15160.7 15254.0 16023.8 6175.3 6248.0 6312.8 6362.1 6400.2 871.7 906.2 914.2 949.1 958.9 27212.3 28131.7 28430.6 28518.7 28923.0 991.5 1000.6 1010.8 1055.3 1100.3 14576.9 14668.0 15124.5 15238.4 15284.8 333028.0 337657.0 338044.0 338363.0 340865.0 48080.3 48249.0 48264.5 48347.5 48366.0 1073.6 1140.2 1168.3 1221.6 1229.9 26964.2 27827.3 29895.3 30536.5 30644.7 42166.0 42612.0 43074.8 43076.8 43123.4 307326.0 316736.0 317440.0 317622.0 319309.0 29282.6 30917.1 32819.2 35500.3 38728.0 36488.5 42249.6 42452.8 42507.0 43103.6 36241.1 36921.8 36959.6 37443.0 37991.6 34247.5 36476.6 36479.1 36514.6 36872.3 35348.3 36016.1 36438.8 36605.5 36853.6 31620.5 32736.8 32973.5 33037.7 33323.3 24824.4 25103.4 25221.4 25263.7 25654.5 04:27:31 INFO - PROCESS | 32141 | 04:27:31 INFO - PROCESS | 32141 | [#2] jquery.html Cycles:180 Average:22247.40 Median:29005.24 stddev:54248.83 (187.0%) stddev-sans-first:54376.15 04:27:31 INFO - PROCESS | 32141 | Values: 372.1 372.5 377.3 379.7 393.7 16420.9 17071.0 17506.6 17526.1 17551.4 14329.4 14752.3 15104.5 15113.5 15121.4 4687.2 4811.5 4840.1 4841.1 4848.6 3554.3 4744.7 5238.7 5517.0 5527.4 5500.6 5521.1 5524.7 5526.3 5535.7 5528.6 6081.8 6083.5 6084.3 6086.8 3465.5 5173.6 5228.3 5422.6 5437.2 12031.2 12193.9 12257.6 12330.1 12422.2 1949.8 2353.2 2394.3 2400.3 2457.2 8637.7 9271.4 9547.6 9647.6 9678.6 1741.4 1755.8 1762.5 1810.1 1812.6 66335.7 69348.3 70050.0 71062.3 71259.3 9728.5 10224.2 10518.3 10698.7 11097.5 14193.4 14240.9 14287.7 14295.8 14300.7 7191.2 7352.7 7457.5 7500.4 7530.6 7021.1 7028.3 7119.0 7193.3 7201.7 4385.2 4424.4 4436.8 4549.5 4558.5 1743.6 1778.4 1785.9 1835.9 1842.7 876.9 901.0 920.3 920.4 928.5 16254.9 17321.6 17399.3 17445.7 17749.2 913.7 931.4 962.4 977.7 985.4 9265.5 9758.0 9767.7 9778.6 9915.2 249044.0 255901.0 256769.0 403702.0 404209.0 85083.0 85758.0 88225.6 88298.6 90411.0 954.3 970.1 982.5 987.7 994.9 15529.4 15775.4 15886.4 16212.4 16412.9 34763.3 35912.5 36169.5 36665.5 37503.2 50580.7 52771.7 52875.0 53065.0 53792.7 7153.4 7493.5 7575.9 7576.0 7672.9 10856.9 10939.2 11181.9 11184.7 11191.6 9538.7 9548.6 9721.9 9729.1 9889.6 9881.6 9960.7 9998.6 10119.2 10177.6 9790.8 9876.6 10099.5 10198.1 10319.6 7669.3 7748.3 7763.0 7848.5 7881.3 9041.4 9236.8 9237.4 9464.7 9548.5 04:27:31 INFO - PROCESS | 32141 | 04:27:31 INFO - PROCESS | 32141 | [#3] mootools.html Cycles:180 Average:5048.26 Median:5164.95 stddev:2823.67 (54.7%) stddev-sans-first:2817.63 04:27:31 INFO - PROCESS | 32141 | Values: 1311.8 1438.2 1459.5 1572.5 1726.7 6712.4 7559.4 7777.4 7807.0 7817.5 7544.7 7694.6 7696.0 7699.6 7701.7 1899.4 1974.8 1977.0 2132.7 2168.3 2182.2 2252.9 2257.5 2257.9 2258.9 2160.3 2187.1 2191.8 2193.6 2203.1 1865.3 2150.7 2196.1 2200.7 2202.6 2229.1 2246.7 2250.5 2254.3 2254.8 7501.3 7501.6 7547.9 7577.6 7577.7 4201.7 4314.2 4327.5 4339.3 4339.8 2753.8 2768.6 2919.2 2933.0 2941.4 920.1 934.2 950.0 961.8 967.4 9970.0 9993.8 10005.5 10026.7 10029.6 4155.4 4159.6 4260.8 4270.3 4313.6 8600.5 8606.1 8616.7 8624.5 8631.5 4559.0 4559.5 4593.2 4597.5 4599.2 3632.8 3917.7 4092.2 4146.4 4148.7 3468.1 3534.8 3554.8 3740.2 3769.4 1195.1 1222.8 1230.9 1234.0 1237.2 695.4 750.4 775.2 775.5 776.9 5065.2 5127.9 5202.0 5246.0 5395.3 417.6 421.2 426.2 427.8 436.0 3529.4 3555.3 3643.9 3669.3 3720.7 9284.6 9546.1 9657.5 9785.6 9869.3 8569.6 9598.5 9601.6 9604.0 9717.2 7004.5 7111.0 7144.5 7164.5 7166.1 4932.2 5205.6 5209.1 5248.7 5283.6 8490.3 8545.1 8669.4 8918.2 9089.0 8932.8 8945.5 9091.5 9148.0 9162.9 6869.1 6935.1 7027.7 7058.5 7064.9 7477.8 7500.4 7535.2 7535.6 7553.4 6629.7 6758.5 6836.5 6894.5 6988.5 6730.9 6770.8 6771.0 6865.0 6885.2 5790.3 5807.7 5838.5 5848.4 6105.5 4441.8 4480.6 4544.9 4550.5 4568.0 4570.7 4570.8 4581.6 4631.3 4671.4 04:27:31 INFO - PROCESS | 32141 | 04:27:31 INFO - PROCESS | 32141 | [#4] prototype.html Cycles:180 Average:4180.40 Median:4678.17 stddev:1208.12 (25.8%) stddev-sans-first:1175.82 04:27:31 INFO - PROCESS | 32141 | Values: 297.2 297.6 301.2 301.5 306.7 4678.5 4708.2 4716.4 4717.8 4760.1 4648.9 4667.4 4668.0 4668.3 4677.9 3562.3 3620.4 3686.4 3729.4 3788.3 3739.2 3775.5 3777.7 3778.8 3810.6 3550.0 3759.1 3764.8 3771.0 3793.7 3621.1 3727.5 3732.9 3734.9 3766.9 3318.5 3322.3 3323.3 3356.0 3367.5 4489.1 4502.9 4514.8 4518.0 4538.9 3947.8 4155.2 4162.5 4238.4 4248.8 4869.2 4871.6 4899.9 4904.5 4931.1 3463.5 3475.0 3488.4 3501.7 3511.8 4948.3 5065.7 5075.8 5130.2 5141.2 3619.0 3641.2 3641.2 3660.6 3661.6 3679.0 3683.3 3697.6 3701.4 3702.9 4130.8 4152.1 4170.4 4185.6 4200.4 4633.9 4906.9 4907.4 4935.7 4942.4 1327.1 1332.7 1335.2 1337.6 1342.8 852.7 877.9 909.1 917.0 927.4 4603.8 4605.5 4608.8 4610.2 4638.9 5364.3 5367.1 5367.6 5375.7 5389.2 4445.8 4602.3 4617.9 4624.2 4646.2 2799.9 2819.3 2825.5 2827.9 2832.7 4955.3 4965.5 4982.5 4988.7 4998.6 5189.8 5363.7 5374.2 5377.1 5381.5 4948.7 4974.9 4975.2 4977.4 4978.6 5233.2 5252.8 5260.0 5263.8 5267.1 5002.3 5097.6 5111.0 5112.0 5125.5 4941.6 4965.4 4980.8 4984.7 4997.7 3763.4 3767.9 3772.4 3774.4 3783.7 5076.5 5213.1 5219.6 5274.8 5288.6 5059.9 5079.4 5085.9 5087.0 5095.6 5075.3 5082.3 5095.4 5096.7 5098.6 4907.5 5026.7 5032.6 5033.9 5038.7 4710.2 4769.0 4952.6 4954.4 4962.0 4787.3 4813.6 4817.7 4830.6 4845.3 04:27:31 INFO - PROCESS | 32141 | 04:27:31 INFO - PROCESS | 32141 | [#5] yui.html Cycles:180 Average:12940.25 Median:545.73 stddev:15555.04 (2850.3%) stddev-sans-first:15571.16 04:27:31 INFO - PROCESS | 32141 | Values: 619.9 641.6 660.4 663.4 701.7 11473.5 11525.1 11707.8 12500.6 13067.0 12641.2 12692.2 12744.1 12749.2 12766.2 636.0 792.0 799.9 801.3 801.9 775.7 803.1 805.6 805.9 806.0 827.5 830.6 832.7 835.3 837.1 660.6 675.8 821.8 823.0 823.7 500.0 584.8 606.0 606.1 606.4 12106.8 12160.5 12164.2 12200.9 12201.1 11464.8 12052.7 12120.6 12206.9 12529.9 9107.7 9171.9 9240.5 9378.5 9434.0 3146.1 3155.6 3174.6 3189.6 3237.1 46606.5 46981.0 47527.0 47642.5 47650.8 9225.5 9236.2 9599.6 9720.0 9760.0 17089.9 17094.0 17260.6 17333.7 17346.6 6208.7 6309.0 6517.5 6578.0 6607.3 3570.8 3586.6 3587.2 3631.5 3640.1 2811.9 2865.6 2866.2 2871.5 3063.9 542.3 542.9 545.2 546.3 551.5 478.3 501.5 515.4 562.5 566.2 7600.9 7611.3 7622.2 7653.9 7962.0 445.6 519.6 560.2 563.6 569.0 3677.8 3708.9 3760.0 3760.4 3772.7 55260.0 56530.0 57557.0 57661.4 58019.7 47941.3 48974.3 49841.0 50796.7 52308.0 45729.3 46092.5 46563.8 46763.3 47356.8 7215.2 7254.9 7364.6 7381.8 7386.4 29968.4 30713.2 31291.7 31411.0 31828.0 38554.2 40539.0 41069.8 41147.0 41209.0 9379.3 9386.4 9463.3 9509.4 9558.1 10321.5 10436.6 10662.6 10684.3 11283.9 7860.5 9595.4 9673.3 9704.6 9797.4 9682.5 9932.5 10203.2 10351.3 10510.2 9653.6 10245.2 10395.2 10442.9 10550.6 8613.7 8709.5 8813.9 9044.1 9228.0 8481.7 8780.1 9041.4 9054.5 9237.8 04:27:31 INFO - PROCESS | 32141 | -------- Summary: end -------- 04:27:31 INFO - PROCESS | 32141 | 04:27:31 INFO - TEST-INFO | 32141: exit 0 04:27:31 INFO - TEST-OK | dromaeo_css | took 1119188ms 04:27:31 INFO - TEST-START | kraken 04:27:31 INFO - operating with platform_type : linux_ 04:27:31 INFO - Initialising browser for kraken test... 04:27:32 INFO - TEST-INFO | started process 32322 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7DNUOa/profile http://localhost:34761/getInfo.html) 04:27:36 INFO - PROCESS | 32322 | __metrics Screen width/height:1600/1200 04:27:36 INFO - PROCESS | 32322 | colorDepth:24 04:27:36 INFO - PROCESS | 32322 | Browser inner width/height: 1024/697 04:27:36 INFO - PROCESS | 32322 | __metrics 04:27:37 ERROR - PROCESS | 32322 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:27:38 INFO - TEST-INFO | 32322: exit 0 04:27:38 INFO - Browser initialized. 04:27:38 INFO - Running cycle 1/1 for kraken test... 04:27:38 INFO - TEST-INFO | started process 32405 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7DNUOa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:27:50 INFO - PROCESS | 32405 | RSS: Main: 156512256 04:27:50 INFO - PROCESS | 32405 | 04:27:52 INFO - PROCESS | 32405 | Cycle 1(1): loaded http://localhost:34761/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34761/tests/kraken/driver.html?testName=audio-beat-detection) 04:27:53 INFO - PROCESS | 32405 | RSS: Main: 211046400 04:27:53 INFO - PROCESS | 32405 | 04:27:56 INFO - PROCESS | 32405 | Cycle 1(1): loaded http://localhost:34761/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34761/tests/kraken/driver.html?testName=audio-dft) 04:27:57 INFO - PROCESS | 32405 | RSS: Main: 196440064 04:27:57 INFO - PROCESS | 32405 | 04:28:00 INFO - PROCESS | 32405 | Cycle 1(1): loaded http://localhost:34761/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34761/tests/kraken/driver.html?testName=audio-fft) 04:28:00 INFO - PROCESS | 32405 | RSS: Main: 267927552 04:28:00 INFO - PROCESS | 32405 | 04:28:03 INFO - PROCESS | 32405 | Cycle 1(1): loaded http://localhost:34761/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34761/tests/kraken/driver.html?testName=audio-oscillator) 04:28:03 INFO - PROCESS | 32405 | RSS: Main: 175714304 04:28:03 INFO - PROCESS | 32405 | 04:28:05 INFO - PROCESS | 32405 | Cycle 1(1): loaded http://localhost:34761/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34761/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:28:06 INFO - PROCESS | 32405 | RSS: Main: 180092928 04:28:06 INFO - PROCESS | 32405 | 04:28:09 INFO - PROCESS | 32405 | Cycle 1(1): loaded http://localhost:34761/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34761/tests/kraken/driver.html?testName=imaging-darkroom) 04:28:10 INFO - PROCESS | 32405 | RSS: Main: 216072192 04:28:10 INFO - PROCESS | 32405 | 04:28:13 INFO - PROCESS | 32405 | Cycle 1(1): loaded http://localhost:34761/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34761/tests/kraken/driver.html?testName=imaging-desaturate) 04:28:14 INFO - PROCESS | 32405 | RSS: Main: 213671936 04:28:14 INFO - PROCESS | 32405 | 04:28:17 INFO - PROCESS | 32405 | Cycle 1(1): loaded http://localhost:34761/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34761/tests/kraken/driver.html?testName=json-parse-financial) 04:28:17 INFO - PROCESS | 32405 | RSS: Main: 215445504 04:28:17 INFO - PROCESS | 32405 | 04:28:19 INFO - PROCESS | 32405 | Cycle 1(1): loaded http://localhost:34761/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34761/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:28:20 INFO - PROCESS | 32405 | RSS: Main: 203329536 04:28:20 INFO - PROCESS | 32405 | 04:28:22 INFO - PROCESS | 32405 | Cycle 1(1): loaded http://localhost:34761/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34761/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:28:22 INFO - PROCESS | 32405 | RSS: Main: 206790656 04:28:22 INFO - PROCESS | 32405 | 04:28:24 INFO - PROCESS | 32405 | Cycle 1(1): loaded http://localhost:34761/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34761/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:28:25 INFO - PROCESS | 32405 | RSS: Main: 217268224 04:28:25 INFO - PROCESS | 32405 | 04:28:28 INFO - PROCESS | 32405 | Cycle 1(1): loaded http://localhost:34761/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34761/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:28:28 INFO - PROCESS | 32405 | RSS: Main: 225947648 04:28:28 INFO - PROCESS | 32405 | 04:28:31 INFO - PROCESS | 32405 | Cycle 1(1): loaded http://localhost:34761/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34761/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:28:32 INFO - PROCESS | 32405 | RSS: Main: 221511680 04:28:32 INFO - PROCESS | 32405 | 04:28:34 INFO - PROCESS | 32405 | Cycle 1(1): loaded http://localhost:34761/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34761/tests/kraken/driver.html?testName=ai-astar) 04:28:34 INFO - PROCESS | 32405 | RSS: Main: 284774400 04:28:34 INFO - PROCESS | 32405 | 04:28:34 INFO - PROCESS | 32405 | __start_tp_report 04:28:34 INFO - PROCESS | 32405 | _x_x_mozilla_page_load 04:28:34 INFO - PROCESS | 32405 | _x_x_mozilla_page_load_details 04:28:34 INFO - PROCESS | 32405 | |i|pagename|runs| 04:28:34 INFO - PROCESS | 32405 | |0;ai-astar;111;113;110;117;115;114;102;111;112;115 04:28:34 INFO - PROCESS | 32405 | |1;audio-beat-detection;155;132;159;182;140;167;159;133;189;134 04:28:34 INFO - PROCESS | 32405 | |2;audio-dft;163;162;163;164;164;163;163;163;165;163 04:28:34 INFO - PROCESS | 32405 | |3;audio-fft;73;76;114;115;75;74;75;119;101;76 04:28:34 INFO - PROCESS | 32405 | |4;audio-oscillator;94;95;150;94;94;94;141;94;94;150 04:28:34 INFO - PROCESS | 32405 | |5;imaging-gaussian-blur;117;116;116;117;116;116;116;117;117;116 04:28:34 INFO - PROCESS | 32405 | |6;imaging-darkroom;146;146;146;146;145;147;146;146;146;146 04:28:34 INFO - PROCESS | 32405 | |7;imaging-desaturate;95;95;94;95;95;95;95;95;95;95 04:28:34 INFO - PROCESS | 32405 | |8;json-parse-financial;66;65;67;64;64;64;65;79;63;62 04:28:34 INFO - PROCESS | 32405 | |9;json-stringify-tinderbox;64;65;64;65;65;65;65;65;64;66 04:28:34 INFO - PROCESS | 32405 | |10;stanford-crypto-aes;79;78;78;78;80;80;87;85;80;80 04:28:34 INFO - PROCESS | 32405 | |11;stanford-crypto-ccm;131;131;130;129;130;129;127;132;165;131 04:28:34 INFO - PROCESS | 32405 | |12;stanford-crypto-pbkdf2;178;178;174;170;183;181;172;171;169;177 04:28:34 INFO - PROCESS | 32405 | |13;stanford-crypto-sha256-iterative;73;72;73;72;74;73;73;71;70;70 04:28:34 INFO - PROCESS | 32405 | __end_tp_report 04:28:34 INFO - PROCESS | 32405 | __start_cc_report 04:28:34 INFO - PROCESS | 32405 | _x_x_mozilla_cycle_collect,1944 04:28:34 INFO - PROCESS | 32405 | __end_cc_report 04:28:34 INFO - PROCESS | 32405 | __startTimestamp1461929314466__endTimestamp 04:28:34 INFO - PROCESS | 32405 | 04:28:34 INFO - PROCESS | 32405 | ------- Summary: start ------- 04:28:34 INFO - PROCESS | 32405 | Number of tests: 14 04:28:34 INFO - PROCESS | 32405 | 04:28:34 INFO - PROCESS | 32405 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.50 stddev:4.14 (3.6%) stddev-sans-first:4.37 04:28:34 INFO - PROCESS | 32405 | Values: 111.0 113.0 110.0 117.0 115.0 114.0 102.0 111.0 112.0 115.0 04:28:34 INFO - PROCESS | 32405 | 04:28:34 INFO - PROCESS | 32405 | [#1] audio-beat-detection Cycles:10 Average:155.00 Median:159.00 stddev:20.39 (12.8%) stddev-sans-first:21.62 04:28:34 INFO - PROCESS | 32405 | Values: 155.0 132.0 159.0 182.0 140.0 167.0 159.0 133.0 189.0 134.0 04:28:34 INFO - PROCESS | 32405 | 04:28:34 INFO - PROCESS | 32405 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 04:28:34 INFO - PROCESS | 32405 | Values: 163.0 162.0 163.0 164.0 164.0 163.0 163.0 163.0 165.0 163.0 04:28:34 INFO - PROCESS | 32405 | 04:28:34 INFO - PROCESS | 32405 | [#3] audio-fft Cycles:10 Average:89.80 Median:74.50 stddev:19.86 (26.7%) stddev-sans-first:20.11 04:28:34 INFO - PROCESS | 32405 | Values: 73.0 76.0 114.0 115.0 75.0 74.0 75.0 119.0 101.0 76.0 04:28:34 INFO - PROCESS | 32405 | 04:28:34 INFO - PROCESS | 32405 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:94.00 stddev:25.65 (27.3%) stddev-sans-first:26.55 04:28:34 INFO - PROCESS | 32405 | Values: 94.0 95.0 150.0 94.0 94.0 94.0 141.0 94.0 94.0 150.0 04:28:34 INFO - PROCESS | 32405 | 04:28:34 INFO - PROCESS | 32405 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 04:28:34 INFO - PROCESS | 32405 | Values: 117.0 116.0 116.0 117.0 116.0 116.0 116.0 117.0 117.0 116.0 04:28:34 INFO - PROCESS | 32405 | 04:28:34 INFO - PROCESS | 32405 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 04:28:34 INFO - PROCESS | 32405 | Values: 146.0 146.0 146.0 146.0 145.0 147.0 146.0 146.0 146.0 146.0 04:28:34 INFO - PROCESS | 32405 | 04:28:34 INFO - PROCESS | 32405 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:28:34 INFO - PROCESS | 32405 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 04:28:34 INFO - PROCESS | 32405 | 04:28:34 INFO - PROCESS | 32405 | [#8] json-parse-financial Cycles:10 Average:65.90 Median:65.00 stddev:4.82 (7.4%) stddev-sans-first:5.11 04:28:34 INFO - PROCESS | 32405 | Values: 66.0 65.0 67.0 64.0 64.0 64.0 65.0 79.0 63.0 62.0 04:28:34 INFO - PROCESS | 32405 | 04:28:34 INFO - PROCESS | 32405 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 04:28:34 INFO - PROCESS | 32405 | Values: 64.0 65.0 64.0 65.0 65.0 65.0 65.0 65.0 64.0 66.0 04:28:34 INFO - PROCESS | 32405 | 04:28:34 INFO - PROCESS | 32405 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:80.00 stddev:3.06 (3.8%) stddev-sans-first:3.20 04:28:34 INFO - PROCESS | 32405 | Values: 79.0 78.0 78.0 78.0 80.0 80.0 87.0 85.0 80.0 80.0 04:28:34 INFO - PROCESS | 32405 | 04:28:34 INFO - PROCESS | 32405 | [#11] stanford-crypto-ccm Cycles:10 Average:133.50 Median:131.00 stddev:11.16 (8.5%) stddev-sans-first:11.80 04:28:34 INFO - PROCESS | 32405 | Values: 131.0 131.0 130.0 129.0 130.0 129.0 127.0 132.0 165.0 131.0 04:28:34 INFO - PROCESS | 32405 | 04:28:34 INFO - PROCESS | 32405 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.30 Median:177.50 stddev:4.81 (2.7%) stddev-sans-first:5.00 04:28:34 INFO - PROCESS | 32405 | Values: 178.0 178.0 174.0 170.0 183.0 181.0 172.0 171.0 169.0 177.0 04:28:34 INFO - PROCESS | 32405 | 04:28:34 INFO - PROCESS | 32405 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.10 Median:73.00 stddev:1.37 (1.9%) stddev-sans-first:1.41 04:28:34 INFO - PROCESS | 32405 | Values: 73.0 72.0 73.0 72.0 74.0 73.0 73.0 71.0 70.0 70.0 04:28:34 INFO - PROCESS | 32405 | -------- Summary: end -------- 04:28:34 INFO - PROCESS | 32405 | 04:28:35 INFO - TEST-INFO | 32405: exit 0 04:28:35 INFO - TEST-OK | kraken | took 63528ms 04:28:35 INFO - SUITE-END | took 1182s 04:28:35 INFO - Completed test suite (00:19:42) 04:28:35 INFO - javascript benchmark 04:28:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2587.6377307176995, 2621.0564196889127, 2644.6165306030625, 2654.270075729173, 2662.9067982620613, 4470.485894122177, 4581.45022597288, 4613.769311534418, 4628.120657075154, 4632.2356811126165, 4536.9092618147615, 4589.977050114745, 4629.305604159378, 4629.3518907353, 4640.373549570807, 4258.552851950547, 4279.572042795711, 4293.184294983958, 4305.892352691177, 4429.645628349725, 4337.783110844461, 4342.370356298335, 4350.216960947028, 4361.236783562879, 4364.9802726864045, 4201.1807697499, 4267.039916018902, 4276.828926842923, 4300.8709738707885, 4332.783360831946, 4242.00312926462, 4246.40550322955, 4275.935860962088, 4281.614654681093, 4330.501992270866, 4286.828526858922, 4296.355546667994, 4298.828046878121, 4315.201687687788, 4338.674599405026, 4423.159599676052, 4494.7078439901625, 4539.182947069527, 4561.566651168134, 4590.839320623762, 4900.901981960376, 4929.038837426703, 4933.062718083588, 4948.455669876311, 4970.105381031413, 4923.77842997066, 4942.505749425065, 4954.826581069645, 4990.550850423443, 5002.074616196015, 4507.233770259064, 4597.42532183477, 4627.606653434428, 4628.722276663378, 4670.159371313128, 5013.248012798036, 5034.194528875362, 5081.74591270435, 5084.084864724311, 5088.313077734532, 4839.685420447659, 4842.806287748451, 4846.297286893451, 4857.368542089576, 4886.53577910098, 4872.756362181876, 4910.680805747615, 4940.505949405031, 4950.727709975914, 4957.157283261782, 4877.365942427533, 4881.707097574157, 4883.876708357097, 4885.706857588556, 4928.581070609039, 4845.563899249014, 4857.975710121426, 4859.781309841065, 4872.756362181947, 4911.066897289504, 4053.250148722496, 4115.588441155861, 4119.567445418248, 4126.09225970286, 4169.854055108057, 3614.6023937366867, 3642.9089272767865, 3643.635636436335, 3679.7608155469807, 3703.5555733311635, 4201.810918508674, 4220.683448741357, 4227.281362168439, 4229.048464095554, 4275.786210689453, 4800.1119792838435, 4869.318295438641, 4883.877903052381, 4896.510348965075, 4909.337239472626, 4308.9569104309185, 4310.655147588185, 4311.525732169459, 4353.804078816461, 4355.063661312833, 4377.715448495837, 4406.471223453206, 4411.977940110343, 4425.424694789656, 4466.6203372713035, 4548.090381923563, 4648.767561621906, 4675.672702910763, 4696.0, 4705.341252224623, 4888.95111048885, 4895.192293271571, 4902.534259245366, 4910.2129647113115, 4954.628402869727, 4645.442546894259, 4650.139724151043, 4651.720896746206, 4704.341392205026, 4722.456917454537, 4757.476677565396, 4840.7337596432535, 4889.217725163957, 4890.633202509897, 4892.119418504703, 4853.272009198648, 4854.320395144612, 4870.391201099863, 4883.389576302962, 4929.162042452864, 4760.880977975578, 4781.952180478151, 4782.665213435026, 4787.712737235777, 4839.128956787812, 4658.324542941323, 4764.785584648768, 4813.278008298783, 4839.104765618372, 4861.1006963711825, 4674.859754207379, 4683.953160468488, 4696.225122854691, 4702.506236845082, 4720.244760838249, 4699.15415225249, 4801.783919723691, 4807.639427043056, 4813.181759101031, 4862.07620552094, 4761.9285710713675, 4780.689255198401, 4787.736674482937, 4801.039792041536, 4830.516948305141], "value": 4530.397217385041, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.2997612936089, 604.6976511744128, 610.7068607068607, 616.9444749972502, 627.1408170805994, 27341.863290683545, 34354.828225858895, 35006.47490287648, 35039.47440788384, 35110.297794044105, 37528.24943501128, 38107.0, 38158.809205953934, 38399.80800095996, 38422.0, 7257.0, 7447.9627601862185, 7452.515586486861, 7459.0, 7681.500702454323, 7313.963430182842, 9348.672796452125, 9644.517774111302, 9666.178374838148, 9669.951650241774, 9784.26618003649, 9896.0, 9907.702768916944, 9910.157636600861, 9914.107730304271, 7263.164736055369, 7473.065866766654, 9674.854877176847, 9796.510174491246, 9825.16486098686, 7377.88933166003, 9320.394174378644, 9581.0, 9587.808243835154, 9602.0, 36760.0, 37553.62446375529, 37613.0, 37678.0, 37712.245755085016, 2956.231379841235, 2961.970380296191, 3167.7782555221143, 3198.2643991881764, 3661.4324779659196, 28984.130476085753, 29140.41719165626, 29219.707802921912, 29384.11847644553, 30437.543436848464, 3276.2955964467515, 3323.418401779679, 3345.8327083645963, 3375.2911888503445, 3389.6440873708398, 173255.0, 173692.13153934275, 173853.0, 174630.0, 175616.0, 51308.23037654438, 51411.48588514142, 51815.48184518182, 51817.0, 51830.74084629553, 55101.44898551043, 55274.0, 55274.72362638161, 55285.0, 55309.72345138249, 14470.204138772258, 15391.384344626089, 15406.22968851553, 15410.614734631725, 15421.768673469682, 9583.90416095844, 10064.44645544502, 10235.795284094425, 10702.357858528514, 10708.357498550113, 14925.25373731309, 15013.174275414956, 15160.696786064216, 15254.0, 16023.839761602469, 6175.320714721377, 6248.0, 6312.779052733133, 6362.141110950055, 6400.23197216337, 871.7254064969515, 906.1934877958622, 914.2366124286162, 949.0651708067548, 958.9424634521812, 27212.319692007462, 28131.666108815727, 28430.573541396894, 28518.71481285202, 28923.0, 991.5389343955095, 1000.6047611193683, 1010.7624708193568, 1055.3034996902009, 1100.312304809494, 14576.85423145755, 14668.0, 15124.54626361211, 15238.390464381522, 15284.847151528566, 333028.0, 337657.0, 338044.0, 338363.0, 340865.0, 48080.27879581809, 48249.035019299416, 48264.517354826705, 48347.516524835, 48366.0, 1073.6456969200144, 1140.184767890962, 1168.339887963298, 1221.6274036418977, 1229.9077569182348, 26964.191074267805, 27827.304317391416, 29895.252618684706, 30536.530820071624, 30644.693553065077, 42166.0, 42612.0, 43074.78462607667, 43076.78461607672, 43123.353149703406, 307326.0, 316736.0, 317440.0, 317622.0, 319309.0, 29282.56076158902, 30917.0724878254, 32819.17952051218, 35500.28999420049, 38728.0, 36488.452673209395, 42249.577504225796, 42452.787736061124, 42507.0, 43103.568964309954, 36241.093972650895, 36921.81539092287, 36959.63040369562, 37443.0, 37991.62008379881, 34247.48628770521, 36476.63523364732, 36479.088022799646, 36514.63485365112, 36872.26255474822, 35348.293034139686, 36016.09959751027, 36438.8178059108, 36605.450918235714, 36853.63146368502, 31620.525692114177, 32736.83631581827, 32973.50539741858, 33037.71396576536, 33323.33353332871, 24824.379390515383, 25103.372415689755, 25221.369465763502, 25263.747362526876, 25654.486910261316], "value": 17541.56430739902, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.09766316682055, 372.465511990294, 377.3114066828038, 379.71711075248936, 393.716524102646, 16420.917895410523, 17071.0, 17506.56233594161, 17526.12369381529, 17551.385701500432, 14329.355179016944, 14752.262386880666, 15104.546863594082, 15113.471028514005, 15121.395144194219, 4687.156311863863, 4811.542903424169, 4840.104580652591, 4841.128596852565, 4848.612111031109, 3554.289142171563, 4744.6952088175685, 5238.73806309683, 5517.0, 5527.419620939803, 5500.559955203574, 5521.089020311644, 5524.668519888799, 5526.309211348582, 5535.6955367454775, 5528.585356098289, 6081.756729730805, 6083.48290395317, 6084.330723620443, 6086.7565297388055, 3465.549478567795, 5173.611979101583, 5228.320318358627, 5422.566194704415, 5437.157240627709, 12031.157818952677, 12193.93903030488, 12257.632271031884, 12330.136890417674, 12422.192557483824, 1949.7952714964865, 2353.1528649686097, 2394.293683363412, 2400.3159099656687, 2457.213691618683, 8637.740867773977, 9271.397359171633, 9547.644062084939, 9647.565859536338, 9678.56446459911, 1741.3818094576495, 1755.7629719987895, 1762.4712586224082, 1810.1220907859677, 1812.6284111757059, 66335.66832165857, 69348.3065169347, 70050.0, 71062.28937710608, 71259.28740712578, 9728.513574321256, 10224.182065434747, 10518.316309439862, 10698.679039628823, 11097.500612472459, 14193.432262709583, 14240.928795355956, 14287.714245715028, 14295.78556321656, 14300.713985720227, 7191.173015103225, 7352.669129889167, 7457.47797654159, 7500.437467189873, 7530.585817780075, 7021.122359705037, 7028.2620324866175, 7118.9644051779405, 7193.280671932765, 7201.675924583406, 4385.232584297799, 4424.380586717862, 4436.778161091933, 4549.522300158502, 4558.544145585415, 1743.6425532765752, 1778.4486809088964, 1785.9374921877672, 1835.8859419748474, 1842.7469320861942, 876.8816209811721, 900.9819803603891, 920.3281604428804, 920.4155361345594, 928.535732133933, 16254.918725406298, 17321.56696082608, 17399.304027838996, 17445.7383139253, 17749.201285942163, 913.7441516375426, 931.4132096779122, 962.3600305796567, 977.6529332087007, 985.3890587835444, 9265.490398028038, 9758.0, 9767.658131965347, 9778.571999041536, 9915.206783457306, 249044.0, 255901.0, 256769.0, 403702.0, 404209.0, 85083.0, 85758.0, 88225.55887220523, 88298.55850720833, 90411.0, 954.2604481526872, 970.1075010989765, 982.543117450389, 987.7234374375187, 994.8905620381752, 15529.378824846879, 15775.447859324868, 15886.443974460839, 16212.432564860645, 16412.917935410245, 34763.30473390569, 35912.4613130798, 36169.45745813762, 36665.45001825028, 37503.249935001695, 50580.74709626575, 52771.736141319045, 52875.0, 53065.0, 53792.731036344565, 7153.3919616833155, 7493.512921660074, 7575.886361704469, 7575.962120189364, 7672.923270767221, 10856.945715271373, 10939.234253602172, 11181.888181118085, 11184.664460066211, 11191.552337906392, 9538.713838584854, 9548.570314335733, 9721.85417218728, 9729.124378805942, 9889.604415823287, 9881.555330010024, 9960.651377201762, 9998.600055997678, 10119.190464762654, 10177.643782467874, 9790.755231118994, 9876.555555000186, 10099.545520451744, 10198.082172604501, 10319.587216511556, 7669.309762121436, 7748.3413909816045, 7763.039792559997, 7848.450608457353, 7881.251281128284, 9041.412308199946, 9236.815263694554, 9237.399569027992, 9464.716058518256, 9548.52257387114], "value": 8114.520436986017, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1311.7901135818272, 1438.1586771738532, 1459.5183589415494, 1572.4732214708072, 1726.7323564847445, 6712.395884370406, 7559.39524838013, 7777.377809775211, 7806.960965195166, 7817.530948143115, 7544.735934242302, 7694.6152692365295, 7696.0, 7699.615019249043, 7701.653425595848, 1899.4396652987332, 1974.7729011163756, 1976.9505762355911, 2132.6694362373855, 2168.3061420345416, 2182.2471247419694, 2252.8648281103106, 2257.480779420734, 2257.8758168300737, 2258.9096436142536, 2160.3087012156116, 2187.0923566719794, 2191.824654027674, 2193.56128774245, 2203.0967303405605, 1865.2632210276865, 2150.6989021536997, 2196.1325276515768, 2200.7249093863265, 2202.592520383734, 2229.0860747093775, 2246.70792796937, 2250.5386395788987, 2254.3124347074136, 2254.8308876834303, 7501.287377699165, 7501.5874126923, 7547.886781698279, 7577.6211189440855, 7577.696892124309, 4201.70588058836, 4314.18030574193, 4327.480702315742, 4339.327404252346, 4339.848105316299, 2753.821001634907, 2768.584712293152, 2919.168037109435, 2933.0467598030514, 2941.4411261860178, 920.0891117793336, 934.1779234273796, 950.0404591362774, 961.7739831139677, 967.3712087143343, 9970.0, 9993.750156246151, 10005.549750261256, 10026.69919902404, 10029.648962286357, 4155.355919832431, 4159.646430053419, 4260.765657888784, 4270.338097594878, 4313.633341165973, 8600.526971016528, 8606.053334133241, 8616.741497755078, 8624.482531048032, 8631.482111073356, 4558.9772051139535, 4559.521250268674, 4593.173228818845, 4597.471290801601, 4599.172149013143, 3632.838461115632, 3917.7061720370516, 4092.1611069730634, 4146.357314616239, 4148.709590328648, 3468.0809585459874, 3534.823258837048, 3554.8400321985573, 3740.214554943438, 3769.359208934488, 1195.055905834381, 1222.8104643780227, 1230.9322987235787, 1233.9814902776466, 1237.2143688757524, 695.4471195399669, 750.4371721209093, 775.2092865277385, 775.4765533265137, 776.9184235655288, 5065.164247899055, 5127.897442051138, 5202.0, 5246.0, 5395.298611180521, 417.63039709857, 421.24596971421425, 426.2242718252812, 427.8074866310173, 436.03200894015237, 3529.382358087376, 3555.2711694102645, 3643.9453408198897, 3669.284489524517, 3720.6837418819164, 9284.582193801296, 9546.140847323635, 9657.46883921377, 9785.608575657036, 9869.259805514615, 8569.614367353484, 9598.520073996273, 9601.567929443052, 9603.951980240054, 9717.222622190207, 7004.509684322151, 7110.964445177741, 7144.499885007999, 7164.498485106097, 7166.104236970379, 4932.161532539405, 5205.557527610195, 5209.140491818807, 5248.6588371755715, 5283.630145889751, 8490.27832634233, 8545.102764209669, 8669.436486628349, 8918.152775486318, 9089.0, 8932.776680583038, 8945.507997060224, 9091.454512729257, 9148.0, 9162.862557061517, 6869.107016087876, 6935.133108361455, 7027.718891244497, 7058.470614703815, 7064.894026589708, 7477.813054673677, 7500.399968002655, 7535.171131175676, 7535.623218838927, 7553.357964572853, 6629.7348106075215, 6758.493113016445, 6836.453083753388, 6894.482913781386, 6988.545744526589, 6730.865382692221, 6770.763023294161, 6771.0, 6864.965675171592, 6885.242623311332, 5790.305163380422, 5807.651540907559, 5838.474537291664, 5848.356680765198, 6105.542084343603, 4441.800118994717, 4480.596746292849, 4544.886377840448, 4550.522195169459, 4567.977160114178, 4570.748608826547, 4570.771461426982, 4581.587657110876, 4631.328457373729, 4671.392718946651], "value": 4009.356380430966, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.19460262688114, 297.5893267291138, 301.22284505974585, 301.4558721507679, 306.6933066933067, 4678.461976872661, 4708.223143181375, 4716.3632909557155, 4717.78769955352, 4760.071786001731, 4648.930266046003, 4667.369905062816, 4667.976660116703, 4668.299755036746, 4677.88305292367, 3562.251927095313, 3620.3664358737246, 3686.4470329450664, 3729.403295472725, 3788.3331334212994, 3739.1773809761944, 3775.528058992626, 3777.6600105990456, 3778.792166430845, 3810.637989391017, 3549.982250088746, 3759.097816524028, 3764.7929363884973, 3770.9811450942843, 3793.658570728634, 3621.149029977953, 3727.4781530585738, 3732.9253414931823, 3734.8879533613763, 3766.924661506782, 3318.469044952796, 3322.302316513535, 3323.2854936188837, 3355.9696383688006, 3367.51171080192, 4489.124620698965, 4502.921056573632, 4514.841980530666, 4517.954820451786, 4538.8865278367975, 3947.7631342119566, 4155.189738001091, 4162.458880345566, 4238.364245363189, 4248.830046798124, 4869.196582563873, 4871.561559459666, 4899.926501102486, 4904.509549045067, 4931.137051016058, 3463.4716656840396, 3475.0, 3488.4244099723514, 3501.667341602569, 3511.841092439489, 4948.331975183341, 5065.721385323805, 5075.822346217901, 5130.1791713326065, 5141.203113517411, 3618.9638103619154, 3641.1807343347537, 3641.198936234024, 3660.5790334111384, 3661.6338366163172, 3678.9816050919576, 3683.281760056817, 3697.556293244828, 3701.40777475608, 3702.8703995360033, 4130.752154870717, 4152.086540960984, 4170.416141740159, 4185.602367775056, 4200.432941552851, 4633.891579331396, 4906.877328066756, 4907.435644900882, 4935.679180853233, 4942.4316203637045, 1327.1108357400565, 1332.660171656241, 1335.2455862437691, 1337.6388375138852, 1342.7784415571516, 852.6972924611673, 877.912208779117, 909.1045320359441, 916.9679061232824, 927.4481683398367, 4603.838865639686, 4605.539446055368, 4608.838690645811, 4610.170169369546, 4638.884027899329, 5364.329458817648, 5367.114426119724, 5367.570594352521, 5375.6774593524515, 5389.164679474609, 4445.777711114431, 4602.2636378180005, 4617.8845528861375, 4624.213883639789, 4646.163690535668, 2799.8520606551215, 2819.2951762059483, 2825.4914115459414, 2827.872745726447, 2832.716728327192, 4955.306257124005, 4965.453800081988, 4982.451930287665, 4988.725620090857, 4998.550130488274, 5189.766460509286, 5363.651362661492, 5374.193870919394, 5377.139657654757, 5381.54256888161, 4948.6783359082265, 4974.875628109254, 4975.154223782039, 4977.352944117241, 4978.5768209701855, 5233.241180028951, 5252.789888404421, 5259.973700131475, 5263.815766448156, 5267.130923397596, 5002.324686167321, 5097.623641616817, 5111.0, 5111.977604479045, 5125.538701516882, 4941.555260026615, 4965.379327584052, 4980.800767969386, 4984.675996060245, 4997.725125118153, 3763.360228761172, 3767.8869633911027, 3772.4152756322815, 3774.414965680324, 3783.735138540276, 5076.466970968143, 5213.132776972574, 5219.582433405394, 5274.815381461631, 5288.603354748486, 5059.949400505948, 5079.3650793650795, 5085.872853178552, 5086.9745651271505, 5095.643304968617, 5075.264086707481, 5082.3138876252715, 5095.388553373619, 5096.655538452205, 5098.592112631055, 4907.533784290629, 5026.6679329978315, 5032.647714659939, 5033.899322013613, 5038.722870242172, 4710.152172608963, 4769.0, 4952.57903078228, 4954.355933728592, 4961.975190124026, 4787.281907713871, 4813.614910807057, 4817.723303324552, 4830.550834749632, 4845.345878306524], "value": 3802.356453923427, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [619.9287081985572, 641.6438876423585, 660.41223311253, 663.4327649859367, 701.7087908517965, 11473.541058357667, 11525.0779937605, 11707.765844683101, 12500.56248031319, 13067.0, 12641.178323408973, 12692.238465692066, 12744.107912446132, 12749.235045897229, 12766.170198937085, 635.9554831161821, 792.0455850699907, 799.9480033797813, 801.3228821645729, 801.8676918308472, 775.6548335990486, 803.0804728585766, 805.6374631415857, 805.9113497515298, 805.9758207253792, 827.4828232354778, 830.6303694855792, 832.7252006837729, 835.2983493865152, 837.0666706622134, 660.5937348530667, 675.7972608217564, 821.7534739578133, 822.9877250981267, 823.6952327638782, 500.02495134487896, 584.7923986984601, 606.0152252589542, 606.1120458528234, 606.3845197124922, 12106.81839772404, 12160.452779624939, 12164.209326393844, 12200.877991220063, 12201.145919785618, 11464.828027579593, 12052.698682532919, 12120.575779847752, 12206.877931220663, 12529.937350313281, 9107.726768196964, 9171.862422063674, 9240.491772952484, 9378.53107344637, 9433.952830235805, 3146.103360542257, 3155.5897733294755, 3174.6349169845535, 3189.649138594753, 3237.109794806447, 46606.53393466056, 46981.0, 47527.0, 47642.52357476416, 47650.76174619139, 9225.538723063954, 9236.168744813, 9599.568019439143, 9720.0, 9760.0, 17089.91455042717, 17094.0, 17260.568485787706, 17333.7399939001, 17346.566335841453, 6208.689565521706, 6309.0, 6517.478601711851, 6577.967110164419, 6607.306232845578, 3570.842430361094, 3586.6234045425376, 3587.157018100744, 3631.473436351714, 3640.0899775056237, 2811.9015834445695, 2865.6131422258145, 2866.1831378057154, 2871.54055351147, 3063.908082757521, 542.2814770429197, 542.9212764149177, 545.1958361416957, 546.2652732075352, 551.4513059505737, 478.32794923133054, 501.51353187408154, 515.4330236739556, 562.5415286541455, 566.1507738392411, 7600.885986710204, 7611.2769286917655, 7622.237776222444, 7653.885191722128, 7961.960190199012, 445.5588966922723, 519.6154845414366, 560.2324073661663, 563.6111083352474, 569.0014025385423, 3677.8344974476213, 3708.8678192972607, 3760.0035990462, 3760.435934609776, 3772.6981841452616, 55260.0, 56530.0, 57557.0, 57661.423385766444, 58019.70990145107, 47941.28088078681, 48974.26538601924, 49841.0, 50796.74601627042, 52308.0, 45729.31406028912, 46092.53907460949, 46563.76718116388, 46763.29855052177, 47356.763216183695, 7215.170255420484, 7254.854902901807, 7364.594947277951, 7381.8154546136775, 7386.4090872728975, 29968.400631986802, 30713.232169195948, 31291.687083128876, 31411.0, 31828.0, 38554.22891542209, 40539.0, 41069.794651026554, 41147.0, 41209.0, 9379.343445958717, 9386.436813791195, 9463.290253230898, 9509.381890177116, 9558.139767420966, 10321.48392580353, 10436.63471778484, 10662.573497060032, 10684.305520141166, 11283.887161128612, 7860.528368297921, 9595.42427454355, 9673.274504412057, 9704.6118155273, 9797.363171393836, 9682.515874206121, 9932.503374831085, 10203.183745300506, 10351.327163734333, 10510.159187264848, 9653.613855445985, 10245.180385569285, 10395.220358472994, 10442.947785261329, 10550.577976880839, 8613.698520552001, 8709.477698803783, 8813.867791983253, 9044.14080662336, 9227.953860230657, 8481.745547633582, 8780.121987801169, 9041.367104302635, 9054.469225062212, 9237.769055773391], "value": 5743.6076895882, "unit": "score"}], "name": "dromaeo_css", "value": 6194.009736210258, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 110.0, 117.0, 115.0, 114.0, 102.0, 111.0, 112.0, 115.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 132.0, 159.0, 182.0, 140.0, 167.0, 159.0, 133.0, 189.0, 134.0], "value": 155.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 164.0, 164.0, 163.0, 163.0, 163.0, 165.0, 163.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 114.0, 115.0, 75.0, 74.0, 75.0, 119.0, 101.0, 76.0], "value": 89.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 150.0, 94.0, 94.0, 94.0, 141.0, 94.0, 94.0, 150.0], "value": 110.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 116.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 145.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 67.0, 64.0, 64.0, 64.0, 65.0, 79.0, 63.0, 62.0], "value": 65.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 64.0, 66.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 78.0, 78.0, 80.0, 80.0, 87.0, 85.0, 80.0, 80.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 131.0, 130.0, 129.0, 130.0, 129.0, 127.0, 132.0, 165.0, 131.0], "value": 133.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 178.0, 174.0, 170.0, 183.0, 181.0, 172.0, 171.0, 169.0, 177.0], "value": 175.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 73.0, 72.0, 74.0, 73.0, 73.0, 71.0, 70.0, 70.0], "value": 72.1, "unit": "score"}], "name": "kraken", "value": 1579.4999999999998, "alertThreshold": 2.0}]} 04:28:35 INFO - Return code: 0 04:28:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:28:35 ERROR - # TBPL SUCCESS # 04:28:35 INFO - Running post-action listener: _resource_record_post_action 04:28:35 INFO - Running post-run listener: _resource_record_post_run 04:28:36 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 0; Write bytes: 518643712; Read time: 0; Write time: 482780 04:28:36 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234745856; Read time: 0; Write time: 302444 04:28:36 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 283897856; Read time: 0; Write time: 180336 04:28:36 INFO - Running post-run listener: _upload_blobber_files 04:28:36 INFO - Blob upload gear active. 04:28:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:28:36 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 04:28:36 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:28:36 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:28:37 INFO - (blobuploader) - INFO - Open directory for files ... 04:28:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:28:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:28:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:28:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:28:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:28:37 INFO - (blobuploader) - INFO - Done attempting. 04:28:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:28:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:28:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:28:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:28:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:28:38 INFO - (blobuploader) - INFO - Done attempting. 04:28:38 INFO - (blobuploader) - INFO - Iteration through files over. 04:28:38 INFO - Return code: 0 04:28:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:28:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:28:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7e245e123a6a95270087e3e83964482dfca9bcf17451f97aea6250ce815ad11321be4055c7203cfd0ee42d22b109033f46bb3bf5195163c59653f5e06243b567", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/797a3051c34991feee90d3117d71d3dca13db5390374cdcfcf35ec9bdeeea0ec00d30c8ecaf6707ddaac9481b253751ad9a925ee2f3589d5567d90109e13178f"} 04:28:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:28:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:28:38 INFO - Contents: 04:28:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7e245e123a6a95270087e3e83964482dfca9bcf17451f97aea6250ce815ad11321be4055c7203cfd0ee42d22b109033f46bb3bf5195163c59653f5e06243b567", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/797a3051c34991feee90d3117d71d3dca13db5390374cdcfcf35ec9bdeeea0ec00d30c8ecaf6707ddaac9481b253751ad9a925ee2f3589d5567d90109e13178f"} 04:28:38 INFO - Running post-run listener: copy_logs_to_upload_dir 04:28:38 INFO - Copying logs to upload dir... 04:28:38 INFO - mkdir: /builds/slave/test/build/upload/logs 04:28:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.702330 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-04-29 04:28:37.624498) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 04:28:37.628100) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1461914341.137192-1479835385 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7e245e123a6a95270087e3e83964482dfca9bcf17451f97aea6250ce815ad11321be4055c7203cfd0ee42d22b109033f46bb3bf5195163c59653f5e06243b567", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/797a3051c34991feee90d3117d71d3dca13db5390374cdcfcf35ec9bdeeea0ec00d30c8ecaf6707ddaac9481b253751ad9a925ee2f3589d5567d90109e13178f"} build_url:https://queue.taskcluster.net/v1/task/TpZeID42Qki-J0DFAi3dCw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011157 build_url: 'https://queue.taskcluster.net/v1/task/TpZeID42Qki-J0DFAi3dCw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7e245e123a6a95270087e3e83964482dfca9bcf17451f97aea6250ce815ad11321be4055c7203cfd0ee42d22b109033f46bb3bf5195163c59653f5e06243b567", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/797a3051c34991feee90d3117d71d3dca13db5390374cdcfcf35ec9bdeeea0ec00d30c8ecaf6707ddaac9481b253751ad9a925ee2f3589d5567d90109e13178f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 04:28:37.657322) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 04:28:37.658078) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1461914341.137192-1479835385 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004426 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 04:28:37.742322) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 04:28:37.743044) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 04:28:37.743721) ========= ========= Total master_lag: 0.19 =========