builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-052 starttime: 1461928067.0 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.002622) ========= 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.003053) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 04:07:47.003375) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 04:07:47.018108) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 04:07:47.018709) ========= 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=826874ccc97bd7bf541b4875000001d5-1461915075.292191-1940632884 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-29 04:07:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 93.6M=0s 2016-04-29 04:07:47 (93.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.083574 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 04:07:47.119276) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 04:07:47.119935) ========= 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=826874ccc97bd7bf541b4875000001d5-1461915075.292191-1940632884 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014862 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 04:07:47.204123) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-29 04:07:47.205144) ========= 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=826874ccc97bd7bf541b4875000001d5-1461915075.292191-1940632884 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-29 04:07:48,096 truncating revision to first 12 chars 2016-04-29 04:07:48,096 Setting DEBUG logging. 2016-04-29 04:07:48,096 attempt 1/10 2016-04-29 04:07:48,096 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:48,816 unpacking tar archive at: mozilla-central-8c3fd523d75b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.998676 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-29 04:07:48.217291) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 04:07:48.217619) ========= script_repo_revision: 8c3fd523d75bd30f691ca2d6cfdad18d576392a1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 04:07:48.218068) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 04:07:48.218389) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 04:07:48.229893) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-04-29 04:07:48.230292) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=826874ccc97bd7bf541b4875000001d5-1461915075.292191-1940632884 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:07:49 INFO - MultiFileLogger online at 20160429 04:07:49 in /builds/slave/test 04:07:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:07:49 INFO - {'append_to_log': False, 04:07:49 INFO - 'base_work_dir': '/builds/slave/test', 04:07:49 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:07:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:07:49 INFO - 'branch': 'Firefox-Non-PGO', 04:07:49 INFO - 'buildbot_json_path': 'buildprops.json', 04:07:49 INFO - 'config_files': ('talos/linux_config.py',), 04:07:49 INFO - 'default_actions': ('clobber', 04:07:49 INFO - 'read-buildbot-config', 04:07:49 INFO - 'download-and-extract', 04:07:49 INFO - 'populate-webroot', 04:07:49 INFO - 'create-virtualenv', 04:07:49 INFO - 'install', 04:07:49 INFO - 'run-tests'), 04:07:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:07:49 INFO - 'download_minidump_stackwalk': True, 04:07:49 INFO - 'download_symbols': 'ondemand', 04:07:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:07:49 INFO - 'tooltool.py': '/tools/tooltool.py', 04:07:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:07:49 INFO - '/tools/misc-python/virtualenv.py')}, 04:07:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:07:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:07:49 INFO - 'installer_path': 'installer.exe', 04:07:49 INFO - 'log_level': 'info', 04:07:49 INFO - 'log_name': 'talos', 04:07:49 INFO - 'log_to_console': True, 04:07:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:07:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:07:49 INFO - 'opt_config_files': (), 04:07:49 INFO - 'pip_index': False, 04:07:49 INFO - 'sps_profile': False, 04:07:49 INFO - 'sps_profile_interval': 0, 04:07:49 INFO - 'suite': 'dromaeojs-e10s', 04:07:49 INFO - 'system_bits': '32', 04:07:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:07:49 INFO - 'title': 'talos-linux64-ix-052', 04:07:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:07:49 INFO - 'use_talos_json': True, 04:07:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:07:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:07:49 INFO - 'work_dir': 'build'} 04:07:49 INFO - ##### 04:07:49 INFO - ##### Running clobber step. 04:07:49 INFO - ##### 04:07:49 INFO - Running pre-action listener: _resource_record_pre_action 04:07:49 INFO - Running main action method: clobber 04:07:49 INFO - rmtree: /builds/slave/test/build 04:07:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:07:49 INFO - Running post-action listener: _resource_record_post_action 04:07:49 INFO - ##### 04:07:49 INFO - ##### Running read-buildbot-config step. 04:07:49 INFO - ##### 04:07:49 INFO - Running pre-action listener: _resource_record_pre_action 04:07:49 INFO - Running main action method: read_buildbot_config 04:07:49 INFO - Using buildbot properties: 04:07:49 INFO - { 04:07:49 INFO - "project": "", 04:07:49 INFO - "product": "firefox", 04:07:49 INFO - "script_repo_revision": "production", 04:07:49 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:07:49 INFO - "repository": "", 04:07:49 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:07:49 INFO - "buildid": "20160429024841", 04:07:49 INFO - "pgo_build": "False", 04:07:49 INFO - "basedir": "/builds/slave/test", 04:07:49 INFO - "buildnumber": 341, 04:07:49 INFO - "slavename": "talos-linux64-ix-052", 04:07:49 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:07:49 INFO - "platform": "ubuntu64_hw", 04:07:49 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:07:49 INFO - "branch": "mozilla-central", 04:07:49 INFO - "repo_path": "mozilla-central", 04:07:49 INFO - "revision": "8c3fd523d75bd30f691ca2d6cfdad18d576392a1", 04:07:49 INFO - "stage_platform": "linux64", 04:07:49 INFO - "builduid": "dacd43d705b647c4b4cd567123664053", 04:07:49 INFO - "slavebuilddir": "test" 04:07:49 INFO - } 04:07:49 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:49 INFO - Running post-action listener: _resource_record_post_action 04:07:49 INFO - ##### 04:07:49 INFO - ##### Running download-and-extract step. 04:07:49 INFO - ##### 04:07:49 INFO - Running pre-action listener: _resource_record_pre_action 04:07:49 INFO - Running main action method: download_and_extract 04:07:49 INFO - mkdir: /builds/slave/test/build/tests 04:07:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:49 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:49 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:49 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:49 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:49 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:08:09 INFO - Downloaded 22301045 bytes. 04:08:09 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:09 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:10 INFO - Return code: 0 04:08:10 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:08:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:10 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:08:10 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:08:10 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:08:10 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:08:10 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:15 INFO - Downloaded 22301045 bytes. 04:08:15 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:15 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:17 INFO - Return code: 0 04:08:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:17 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:17 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:17 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:17 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:17 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:18 INFO - Downloaded 10840145 bytes. 04:08:18 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:18 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:18 INFO - Return code: 0 04:08:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:18 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:18 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:18 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:18 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:18 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:20 INFO - Downloaded 54842749 bytes. 04:08:20 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:20 INFO - mkdir: /builds/slave/test/properties 04:08:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:08:20 INFO - Writing to file /builds/slave/test/properties/build_url 04:08:20 INFO - Contents: 04:08:20 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:20 INFO - Running post-action listener: _resource_record_post_action 04:08:20 INFO - Running post-action listener: set_extra_try_arguments 04:08:20 INFO - ##### 04:08:20 INFO - ##### Running populate-webroot step. 04:08:20 INFO - ##### 04:08:20 INFO - Running pre-action listener: _resource_record_pre_action 04:08:20 INFO - Running main action method: populate_webroot 04:08:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:08:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:08:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:08:21 INFO - '--tppagecycles', 04:08:21 INFO - '7'], 04:08:21 INFO - 'tests': ['tsvgm']}}, 04:08:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:08:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:08:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:08:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:08:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:08:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:08:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:21 INFO - 'talos_options': ['--disable-e10s'], 04:08:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:08:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:08:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:21 INFO - 'talos_options': ['--disable-e10s'], 04:08:21 INFO - 'tests': ['damp', 'tps']}, 04:08:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:21 INFO - 'tests': ['damp', 'tps']}, 04:08:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:08:21 INFO - 'tests': ['dromaeo_dom']}, 04:08:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:08:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:08:21 INFO - 'tests': ['a11yr', 04:08:21 INFO - 'ts_paint', 04:08:21 INFO - 'tpaint', 04:08:21 INFO - 'sessionrestore', 04:08:21 INFO - 'sessionrestore_no_auto_restore', 04:08:21 INFO - 'tabpaint']}, 04:08:21 INFO - 'other-e10s': {'tests': ['a11yr', 04:08:21 INFO - 'ts_paint', 04:08:21 INFO - 'tpaint', 04:08:21 INFO - 'sessionrestore', 04:08:21 INFO - 'sessionrestore_no_auto_restore', 04:08:21 INFO - 'tabpaint']}, 04:08:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:08:21 INFO - 'ts_paint', 04:08:21 INFO - 'tpaint', 04:08:21 INFO - 'sessionrestore', 04:08:21 INFO - 'sessionrestore_no_auto_restore', 04:08:21 INFO - 'tabpaint']}, 04:08:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:08:21 INFO - 'ts_paint', 04:08:21 INFO - 'tpaint', 04:08:21 INFO - 'sessionrestore', 04:08:21 INFO - 'sessionrestore_no_auto_restore', 04:08:21 INFO - 'tabpaint']}, 04:08:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:08:21 INFO - 'tests': ['a11yr', 04:08:21 INFO - 'ts_paint', 04:08:21 INFO - 'tpaint', 04:08:21 INFO - 'sessionrestore', 04:08:21 INFO - 'sessionrestore_no_auto_restore', 04:08:21 INFO - 'tabpaint']}, 04:08:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:08:21 INFO - 'tests': ['a11yr', 04:08:21 INFO - 'ts_paint', 04:08:21 INFO - 'tpaint', 04:08:21 INFO - 'sessionrestore', 04:08:21 INFO - 'sessionrestore_no_auto_restore', 04:08:21 INFO - 'tabpaint']}, 04:08:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:08:21 INFO - 'tests': ['tsvgx', 04:08:21 INFO - 'tsvgr_opacity', 04:08:21 INFO - 'tart', 04:08:21 INFO - 'tscrollx', 04:08:21 INFO - 'cart']}, 04:08:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:08:21 INFO - 'tsvgr_opacity', 04:08:21 INFO - 'tart', 04:08:21 INFO - 'tscrollx', 04:08:21 INFO - 'cart']}, 04:08:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:21 INFO - 'talos_options': ['--disable-e10s'], 04:08:21 INFO - 'tests': ['tp5o']}, 04:08:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:21 INFO - 'tests': ['tp5o']}, 04:08:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:21 INFO - 'talos_options': ['--disable-e10s', 04:08:21 INFO - '--xperf_path', 04:08:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:08:21 INFO - 'tests': ['tp5n']}, 04:08:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:21 INFO - 'talos_options': ['--xperf_path', 04:08:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:08:21 INFO - 'tests': ['tp5n']}}, 04:08:21 INFO - 'talos.zip': {'path': '', 04:08:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:08:21 INFO - Running post-action listener: _resource_record_post_action 04:08:21 INFO - ##### 04:08:21 INFO - ##### Running create-virtualenv step. 04:08:21 INFO - ##### 04:08:21 INFO - Running pre-action listener: _resource_record_pre_action 04:08:21 INFO - Running main action method: create_virtualenv 04:08:21 INFO - Creating virtualenv /builds/slave/test/build/venv 04:08:21 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:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:08:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:08:21 INFO - Using real prefix '/usr' 04:08:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:08:21 INFO - Installing distribute.............................................................................................................................................................................................done. 04:08:23 INFO - Installing pip.................done. 04:08:23 INFO - Return code: 0 04:08:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:08:23 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:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:23 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:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:23 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 0x7f3e980e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b445a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd3410>, '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 0x2bd4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd47a0>, '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': '826874ccc97bd7bf541b4875000001d5-1461915075.292191-1940632884', '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:23 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:23 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:23 INFO - Using env: {'DISPLAY': ':0', 04:08:23 INFO - 'HOME': '/home/cltbld', 04:08:23 INFO - 'LANG': 'en_US.UTF-8', 04:08:23 INFO - 'LANGUAGE': 'en_US:en', 04:08:23 INFO - 'LOGNAME': 'cltbld', 04:08:23 INFO - 'MAIL': '/var/mail/cltbld', 04:08:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:23 INFO - 'MOZ_NO_REMOTE': '1', 04:08:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:23 INFO - 'NO_EM_RESTART': '1', 04:08:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:23 INFO - 'PWD': '/builds/slave/test', 04:08:23 INFO - 'SHELL': '/bin/bash', 04:08:23 INFO - 'SHLVL': '1', 04:08:23 INFO - 'TERM': 'linux', 04:08:23 INFO - 'TMOUT': '86400', 04:08:23 INFO - 'USER': 'cltbld', 04:08:23 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1461915075.292191-1940632884', 04:08:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:23 INFO - '_': '/tools/buildbot/bin/python'} 04:08:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:23 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:23 INFO - Cleaning up... 04:08:23 INFO - Return code: 0 04:08:23 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:08:23 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:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:23 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:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:23 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 0x7f3e980e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b445a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd3410>, '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 0x2bd4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd47a0>, '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': '826874ccc97bd7bf541b4875000001d5-1461915075.292191-1940632884', '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:23 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:23 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:23 INFO - Using env: {'DISPLAY': ':0', 04:08:23 INFO - 'HOME': '/home/cltbld', 04:08:23 INFO - 'LANG': 'en_US.UTF-8', 04:08:23 INFO - 'LANGUAGE': 'en_US:en', 04:08:23 INFO - 'LOGNAME': 'cltbld', 04:08:23 INFO - 'MAIL': '/var/mail/cltbld', 04:08:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:23 INFO - 'MOZ_NO_REMOTE': '1', 04:08:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:23 INFO - 'NO_EM_RESTART': '1', 04:08:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:23 INFO - 'PWD': '/builds/slave/test', 04:08:23 INFO - 'SHELL': '/bin/bash', 04:08:23 INFO - 'SHLVL': '1', 04:08:23 INFO - 'TERM': 'linux', 04:08:23 INFO - 'TMOUT': '86400', 04:08:23 INFO - 'USER': 'cltbld', 04:08:23 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1461915075.292191-1940632884', 04:08:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:23 INFO - '_': '/tools/buildbot/bin/python'} 04:08:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:24 INFO - Downloading/unpacking psutil>=0.7.1 04:08:24 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:24 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:24 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:24 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:24 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:24 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:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:08:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:08:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:08:26 INFO - Installing collected packages: psutil 04:08:26 INFO - Running setup.py install for psutil 04:08:26 INFO - building 'psutil._psutil_linux' extension 04:08:26 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:26 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:26 INFO - building 'psutil._psutil_posix' extension 04:08:26 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:26 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:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:08:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:08:26 INFO - Successfully installed psutil 04:08:26 INFO - Cleaning up... 04:08:26 INFO - Return code: 0 04:08:26 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:08:26 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:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:26 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:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:26 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 0x7f3e980e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b445a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd3410>, '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 0x2bd4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd47a0>, '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': '826874ccc97bd7bf541b4875000001d5-1461915075.292191-1940632884', '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:26 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:26 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:26 INFO - Using env: {'DISPLAY': ':0', 04:08:26 INFO - 'HOME': '/home/cltbld', 04:08:26 INFO - 'LANG': 'en_US.UTF-8', 04:08:26 INFO - 'LANGUAGE': 'en_US:en', 04:08:26 INFO - 'LOGNAME': 'cltbld', 04:08:26 INFO - 'MAIL': '/var/mail/cltbld', 04:08:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:26 INFO - 'MOZ_NO_REMOTE': '1', 04:08:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:26 INFO - 'NO_EM_RESTART': '1', 04:08:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:26 INFO - 'PWD': '/builds/slave/test', 04:08:26 INFO - 'SHELL': '/bin/bash', 04:08:26 INFO - 'SHLVL': '1', 04:08:26 INFO - 'TERM': 'linux', 04:08:26 INFO - 'TMOUT': '86400', 04:08:26 INFO - 'USER': 'cltbld', 04:08:26 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1461915075.292191-1940632884', 04:08:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:26 INFO - '_': '/tools/buildbot/bin/python'} 04:08:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:26 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:08:26 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:26 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:26 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:26 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:26 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:26 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:28 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:08:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:08:28 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:28 INFO - Installing collected packages: mozsystemmonitor 04:08:28 INFO - Running setup.py install for mozsystemmonitor 04:08:28 INFO - Successfully installed mozsystemmonitor 04:08:28 INFO - Cleaning up... 04:08:28 INFO - Return code: 0 04:08:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:08:28 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:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:28 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:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:28 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 0x7f3e980e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b445a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd3410>, '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 0x2bd4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd47a0>, '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': '826874ccc97bd7bf541b4875000001d5-1461915075.292191-1940632884', '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:28 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:28 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:28 INFO - Using env: {'DISPLAY': ':0', 04:08:28 INFO - 'HOME': '/home/cltbld', 04:08:28 INFO - 'LANG': 'en_US.UTF-8', 04:08:28 INFO - 'LANGUAGE': 'en_US:en', 04:08:28 INFO - 'LOGNAME': 'cltbld', 04:08:28 INFO - 'MAIL': '/var/mail/cltbld', 04:08:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:28 INFO - 'MOZ_NO_REMOTE': '1', 04:08:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:28 INFO - 'NO_EM_RESTART': '1', 04:08:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:28 INFO - 'PWD': '/builds/slave/test', 04:08:28 INFO - 'SHELL': '/bin/bash', 04:08:28 INFO - 'SHLVL': '1', 04:08:28 INFO - 'TERM': 'linux', 04:08:28 INFO - 'TMOUT': '86400', 04:08:28 INFO - 'USER': 'cltbld', 04:08:28 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1461915075.292191-1940632884', 04:08:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:28 INFO - '_': '/tools/buildbot/bin/python'} 04:08:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:29 INFO - Downloading/unpacking blobuploader==1.2.4 04:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:30 INFO - Downloading blobuploader-1.2.4.tar.gz 04:08:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:08:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 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 - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:08:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:08:31 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:31 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 - 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:31 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:31 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:31 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 docopt-0.6.1.tar.gz 04:08:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:08:31 INFO - Installing collected packages: blobuploader, requests, docopt 04:08:31 INFO - Running setup.py install for blobuploader 04:08:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:08:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:08:31 INFO - Running setup.py install for requests 04:08:32 INFO - Running setup.py install for docopt 04:08:32 INFO - Successfully installed blobuploader requests docopt 04:08:32 INFO - Cleaning up... 04:08:32 INFO - Return code: 0 04:08:32 INFO - Installing None 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', '--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 0x7f3e980e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b445a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd3410>, '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 0x2bd4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd47a0>, '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': '826874ccc97bd7bf541b4875000001d5-1461915075.292191-1940632884', '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', '--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:32 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: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': '826874ccc97bd7bf541b4875000001d5-1461915075.292191-1940632884', 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 - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:08:32 INFO - Running setup.py (path:/tmp/pip-ilHOW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:08:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:08:32 INFO - Running setup.py (path:/tmp/pip-C5tVhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:08:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:08:32 INFO - Running setup.py (path:/tmp/pip-CNgKUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:08:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:08:32 INFO - Running setup.py (path:/tmp/pip-1p20ry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:08:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:08:32 INFO - Running setup.py (path:/tmp/pip-caU6uX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:08:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:08:32 INFO - Running setup.py (path:/tmp/pip-MFQkKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:08:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:08:32 INFO - Running setup.py (path:/tmp/pip-1iNWNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:08:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:08:32 INFO - Running setup.py (path:/tmp/pip-eBGmKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:08:33 INFO - Running setup.py (path:/tmp/pip-DRRqRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:08:33 INFO - Running setup.py (path:/tmp/pip-mXyXhp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:08:33 INFO - Running setup.py (path:/tmp/pip-cY169P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:08:33 INFO - Running setup.py (path:/tmp/pip-TpUyaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:08:33 INFO - Running setup.py (path:/tmp/pip-N3g_Mr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:08:33 INFO - Running setup.py (path:/tmp/pip-dtJVkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:08:33 INFO - Running setup.py (path:/tmp/pip-eq6zIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:08:33 INFO - Running setup.py (path:/tmp/pip-WH4CmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:08:33 INFO - Running setup.py (path:/tmp/pip-Uniw8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:08:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:08:33 INFO - Running setup.py install for manifestparser 04:08:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:08:33 INFO - Running setup.py install for mozcrash 04:08:33 INFO - Running setup.py install for mozdebug 04:08:33 INFO - Running setup.py install for mozdevice 04:08:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:08:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:08:34 INFO - Running setup.py install for mozfile 04:08:34 INFO - Running setup.py install for mozhttpd 04:08:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:08:34 INFO - Running setup.py install for mozinfo 04:08:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:08:34 INFO - Running setup.py install for mozInstall 04:08:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:08:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:08:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:08:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:08:34 INFO - Running setup.py install for mozleak 04:08:34 INFO - Running setup.py install for mozlog 04:08:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:08:34 INFO - Running setup.py install for moznetwork 04:08:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:08:34 INFO - Running setup.py install for mozprocess 04:08:34 INFO - Running setup.py install for mozprofile 04:08:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:08:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:08:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:08:35 INFO - Running setup.py install for mozrunner 04:08:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:08:35 INFO - Running setup.py install for mozscreenshot 04:08:35 INFO - Running setup.py install for moztest 04:08:35 INFO - Running setup.py install for mozversion 04:08:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:08:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:08:35 INFO - Cleaning up... 04:08:35 INFO - Return code: 0 04:08:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:08:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:35 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 0x7f3e980e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b445a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd3410>, '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 0x2bd4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd47a0>, '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': '826874ccc97bd7bf541b4875000001d5-1461915075.292191-1940632884', '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:35 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:35 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:35 INFO - Using env: {'DISPLAY': ':0', 04:08:35 INFO - 'HOME': '/home/cltbld', 04:08:35 INFO - 'LANG': 'en_US.UTF-8', 04:08:35 INFO - 'LANGUAGE': 'en_US:en', 04:08:35 INFO - 'LOGNAME': 'cltbld', 04:08:35 INFO - 'MAIL': '/var/mail/cltbld', 04:08:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:35 INFO - 'MOZ_NO_REMOTE': '1', 04:08:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:35 INFO - 'NO_EM_RESTART': '1', 04:08:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:35 INFO - 'PWD': '/builds/slave/test', 04:08:35 INFO - 'SHELL': '/bin/bash', 04:08:35 INFO - 'SHLVL': '1', 04:08:35 INFO - 'TERM': 'linux', 04:08:35 INFO - 'TMOUT': '86400', 04:08:35 INFO - 'USER': 'cltbld', 04:08:35 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1461915075.292191-1940632884', 04:08:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:35 INFO - '_': '/tools/buildbot/bin/python'} 04:08:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:08:35 INFO - Running setup.py (path:/tmp/pip-oOSkGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:08:35 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:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:08:35 INFO - Running setup.py (path:/tmp/pip-E1eGeG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:08:35 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:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:08:35 INFO - Running setup.py (path:/tmp/pip-8jaGVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:08:35 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:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:08:35 INFO - Running setup.py (path:/tmp/pip-s5B9mL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:08:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:08:36 INFO - Running setup.py (path:/tmp/pip-SlzbNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:08:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:08:36 INFO - Running setup.py (path:/tmp/pip-Cx35af-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:08:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:08:36 INFO - Running setup.py (path:/tmp/pip-z6kPse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:08:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:08:36 INFO - Running setup.py (path:/tmp/pip-vvOJo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:08:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:08:36 INFO - Running setup.py (path:/tmp/pip-u_P0is-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:08:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:08:36 INFO - Running setup.py (path:/tmp/pip-WZ4yT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:08:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:08:36 INFO - Running setup.py (path:/tmp/pip-vpnNli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:08:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:08:36 INFO - Running setup.py (path:/tmp/pip-gqkz56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:08:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:08:36 INFO - Running setup.py (path:/tmp/pip-T2DStO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:08:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:08:36 INFO - Running setup.py (path:/tmp/pip-uG3jCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:08:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:08:36 INFO - Running setup.py (path:/tmp/pip-Y2atdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:08:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:08:36 INFO - Running setup.py (path:/tmp/pip-6t8ZR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:08:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:08:36 INFO - Running setup.py (path:/tmp/pip-dRuHYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:08:36 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:36 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:36 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:36 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:36 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:36 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:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:08:36 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:36 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:36 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:36 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:36 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:36 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:38 INFO - Downloading blessings-1.6.tar.gz 04:08:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:08:38 INFO - Installing collected packages: blessings 04:08:38 INFO - Running setup.py install for blessings 04:08:38 INFO - Successfully installed blessings 04:08:38 INFO - Cleaning up... 04:08:39 INFO - Return code: 0 04:08:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:08:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:08:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:08:39 INFO - Reading from file tmpfile_stdout 04:08:39 INFO - Current package versions: 04:08:39 INFO - argparse == 1.2.1 04:08:39 INFO - blessings == 1.6 04:08:39 INFO - blobuploader == 1.2.4 04:08:39 INFO - docopt == 0.6.1 04:08:39 INFO - manifestparser == 1.1 04:08:39 INFO - mozInstall == 1.12 04:08:39 INFO - mozcrash == 0.17 04:08:39 INFO - mozdebug == 0.1 04:08:39 INFO - mozdevice == 0.48 04:08:39 INFO - mozfile == 1.2 04:08:39 INFO - mozhttpd == 0.7 04:08:39 INFO - mozinfo == 0.9 04:08:39 INFO - mozleak == 0.1 04:08:39 INFO - mozlog == 3.1 04:08:39 INFO - moznetwork == 0.27 04:08:39 INFO - mozprocess == 0.22 04:08:39 INFO - mozprofile == 0.28 04:08:39 INFO - mozrunner == 6.11 04:08:39 INFO - mozscreenshot == 0.1 04:08:39 INFO - mozsystemmonitor == 0.0 04:08:39 INFO - moztest == 0.7 04:08:39 INFO - mozversion == 1.4 04:08:39 INFO - psutil == 3.1.1 04:08:39 INFO - requests == 1.2.3 04:08:39 INFO - wsgiref == 0.1.2 04:08:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:08:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:39 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 0x7f3e980e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b445a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd3410>, '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 0x2bd4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd47a0>, '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': '826874ccc97bd7bf541b4875000001d5-1461915075.292191-1940632884', '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:39 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:39 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:39 INFO - Using env: {'DISPLAY': ':0', 04:08:39 INFO - 'HOME': '/home/cltbld', 04:08:39 INFO - 'LANG': 'en_US.UTF-8', 04:08:39 INFO - 'LANGUAGE': 'en_US:en', 04:08:39 INFO - 'LOGNAME': 'cltbld', 04:08:39 INFO - 'MAIL': '/var/mail/cltbld', 04:08:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:39 INFO - 'MOZ_NO_REMOTE': '1', 04:08:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:39 INFO - 'NO_EM_RESTART': '1', 04:08:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:39 INFO - 'PWD': '/builds/slave/test', 04:08:39 INFO - 'SHELL': '/bin/bash', 04:08:39 INFO - 'SHLVL': '1', 04:08:39 INFO - 'TERM': 'linux', 04:08:39 INFO - 'TMOUT': '86400', 04:08:39 INFO - 'USER': 'cltbld', 04:08:39 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1461915075.292191-1940632884', 04:08:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:39 INFO - '_': '/tools/buildbot/bin/python'} 04:08:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:39 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:39 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:39 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:39 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:39 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:39 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:39 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:39 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:39 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:39 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:39 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:39 INFO - Cleaning up... 04:08:39 INFO - Return code: 0 04:08:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:08:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:39 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 0x7f3e980e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b445a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd3410>, '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 0x2bd4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd47a0>, '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': '826874ccc97bd7bf541b4875000001d5-1461915075.292191-1940632884', '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:39 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:39 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:39 INFO - Using env: {'DISPLAY': ':0', 04:08:39 INFO - 'HOME': '/home/cltbld', 04:08:39 INFO - 'LANG': 'en_US.UTF-8', 04:08:39 INFO - 'LANGUAGE': 'en_US:en', 04:08:39 INFO - 'LOGNAME': 'cltbld', 04:08:39 INFO - 'MAIL': '/var/mail/cltbld', 04:08:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:39 INFO - 'MOZ_NO_REMOTE': '1', 04:08:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:39 INFO - 'NO_EM_RESTART': '1', 04:08:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:39 INFO - 'PWD': '/builds/slave/test', 04:08:39 INFO - 'SHELL': '/bin/bash', 04:08:39 INFO - 'SHLVL': '1', 04:08:39 INFO - 'TERM': 'linux', 04:08:39 INFO - 'TMOUT': '86400', 04:08:39 INFO - 'USER': 'cltbld', 04:08:39 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1461915075.292191-1940632884', 04:08:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:39 INFO - '_': '/tools/buildbot/bin/python'} 04:08:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:39 INFO - Downloading/unpacking jsonschema 04:08:39 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:39 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:39 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:39 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:39 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:39 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:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:08:41 INFO - Downloading/unpacking functools32 (from jsonschema) 04:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:41 INFO - Downloading functools32-3.2.3-2.tar.gz 04:08:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:08:41 INFO - warning: no files found matching '*.txt' 04:08:41 INFO - no previously-included directories found matching 'build' 04:08:41 INFO - no previously-included directories found matching 'dist' 04:08:41 INFO - no previously-included directories found matching '.git*' 04:08:41 INFO - Installing collected packages: jsonschema, functools32 04:08:41 INFO - Running setup.py install for functools32 04:08:41 INFO - warning: no files found matching '*.txt' 04:08:41 INFO - no previously-included directories found matching 'build' 04:08:41 INFO - no previously-included directories found matching 'dist' 04:08:41 INFO - no previously-included directories found matching '.git*' 04:08:42 INFO - Successfully installed jsonschema functools32 04:08:42 INFO - Cleaning up... 04:08:42 INFO - Return code: 0 04:08:42 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:08:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:42 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 0x7f3e980e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b445a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd3410>, '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 0x2bd4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd47a0>, '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': '826874ccc97bd7bf541b4875000001d5-1461915075.292191-1940632884', '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:42 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:42 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:42 INFO - Using env: {'DISPLAY': ':0', 04:08:42 INFO - 'HOME': '/home/cltbld', 04:08:42 INFO - 'LANG': 'en_US.UTF-8', 04:08:42 INFO - 'LANGUAGE': 'en_US:en', 04:08:42 INFO - 'LOGNAME': 'cltbld', 04:08:42 INFO - 'MAIL': '/var/mail/cltbld', 04:08:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:42 INFO - 'MOZ_NO_REMOTE': '1', 04:08:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:42 INFO - 'NO_EM_RESTART': '1', 04:08:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:42 INFO - 'PWD': '/builds/slave/test', 04:08:42 INFO - 'SHELL': '/bin/bash', 04:08:42 INFO - 'SHLVL': '1', 04:08:42 INFO - 'TERM': 'linux', 04:08:42 INFO - 'TMOUT': '86400', 04:08:42 INFO - 'USER': 'cltbld', 04:08:42 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1461915075.292191-1940632884', 04:08:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:42 INFO - '_': '/tools/buildbot/bin/python'} 04:08:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:42 INFO - Downloading/unpacking flake8 04:08:42 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:42 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:42 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:42 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:42 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:42 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:44 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:08:44 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:08:44 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:44 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:44 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:44 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:44 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:44 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:44 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:08:44 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:08:44 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:44 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:44 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:44 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:44 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:44 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:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:08:44 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:44 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:44 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:44 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:44 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:44 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:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:08:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:08:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:08:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:08:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:08:44 INFO - no previously-included directories found matching 'docs/_build' 04:08:44 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:08:44 INFO - Running setup.py install for pep8 04:08:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:08:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:08:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:08:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:08:45 INFO - no previously-included directories found matching 'docs/_build' 04:08:45 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:08:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:08:45 INFO - Cleaning up... 04:08:45 INFO - Return code: 0 04:08:45 INFO - Running post-action listener: _resource_record_post_action 04:08:45 INFO - Running post-action listener: _start_resource_monitoring 04:08:45 INFO - Starting resource monitoring. 04:08:45 INFO - ##### 04:08:45 INFO - ##### Running install step. 04:08:45 INFO - ##### 04:08:45 INFO - Running pre-action listener: _resource_record_pre_action 04:08:45 INFO - Running main action method: install 04:08:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:08:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:08:45 INFO - Reading from file tmpfile_stdout 04:08:45 INFO - Detecting whether we're running mozinstall >=1.0... 04:08:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:08:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:08:45 INFO - Reading from file tmpfile_stdout 04:08:45 INFO - Output received: 04:08:45 INFO - Usage: mozinstall [options] installer 04:08:45 INFO - Options: 04:08:45 INFO - -h, --help show this help message and exit 04:08:45 INFO - -d DEST, --destination=DEST 04:08:45 INFO - Directory to install application into. [default: 04:08:45 INFO - "/builds/slave/test"] 04:08:45 INFO - --app=APP Application being installed. [default: firefox] 04:08:45 INFO - mkdir: /builds/slave/test/build/application 04:08:45 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:45 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:09:01 INFO - Reading from file tmpfile_stdout 04:09:01 INFO - Output received: 04:09:01 INFO - /builds/slave/test/build/application/firefox/firefox 04:09:01 INFO - Running post-action listener: _resource_record_post_action 04:09:01 INFO - ##### 04:09:01 INFO - ##### Running run-tests step. 04:09:01 INFO - ##### 04:09:01 INFO - Running pre-action listener: _resource_record_pre_action 04:09:01 INFO - Running main action method: run_tests 04:09:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:09:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:09:01 INFO - Python 2.7.3 04:09:01 INFO - Return code: 0 04:09:01 INFO - grabbing minidump binary from tooltool 04:09:01 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:09:01 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 0x2bd3410>, '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 0x2bd4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd47a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:09:01 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:09:01 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:09:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:09:01 INFO - Return code: 0 04:09:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:09:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:09:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:09:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:09:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:09:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:09:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:09:02 INFO - Return code: 0 04:09:02 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-e10s', '--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-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:09:02 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-e10s --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-052 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:09:02 INFO - Using env: {'DISPLAY': ':0', 04:09:02 INFO - 'HOME': '/home/cltbld', 04:09:02 INFO - 'LANG': 'en_US.UTF-8', 04:09:02 INFO - 'LANGUAGE': 'en_US:en', 04:09:02 INFO - 'LOGNAME': 'cltbld', 04:09:02 INFO - 'MAIL': '/var/mail/cltbld', 04:09:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:09:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:09:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:02 INFO - 'MOZ_NO_REMOTE': '1', 04:09:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:09:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:02 INFO - 'NO_EM_RESTART': '1', 04:09:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:02 INFO - 'PWD': '/builds/slave/test', 04:09:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:09:02 INFO - 'SHELL': '/bin/bash', 04:09:02 INFO - 'SHLVL': '1', 04:09:02 INFO - 'TERM': 'linux', 04:09:02 INFO - 'TMOUT': '86400', 04:09:02 INFO - 'USER': 'cltbld', 04:09:02 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1461915075.292191-1940632884', 04:09:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:02 INFO - '_': '/tools/buildbot/bin/python'} 04:09:02 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-e10s', '--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-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:09:02 INFO - mozversion application_buildid: 20160429024841 04:09:02 INFO - mozversion application_changeset: 8c3fd523d75bd30f691ca2d6cfdad18d576392a1 04:09:02 INFO - mozversion application_display_name: Nightly 04:09:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:09:02 INFO - mozversion application_name: Firefox 04:09:02 INFO - mozversion application_remotingname: firefox 04:09:02 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:09:02 INFO - mozversion application_vendor: Mozilla 04:09:02 INFO - mozversion application_version: 49.0a1 04:09:02 INFO - mozversion platform_buildid: 20160429024841 04:09:02 INFO - mozversion platform_changeset: 8c3fd523d75bd30f691ca2d6cfdad18d576392a1 04:09:02 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:09:02 INFO - mozversion platform_version: 49.0a1 04:09:02 INFO - using testdate: 1461928142 04:09:02 INFO - actual date: 1461928142 04:09:02 INFO - starting webserver on 'localhost:47393' 04:09:02 INFO - SUITE-START | Running 2 tests 04:09:02 INFO - TEST-START | dromaeo_css 04:09:02 INFO - operating with platform_type : linux_ 04:09:02 INFO - Initialising browser for dromaeo_css test... 04:09:02 INFO - TEST-INFO | started process 22450 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2_tp8z/profile http://localhost:47393/getInfo.html) 04:09:06 INFO - PROCESS | 22450 | 04:09:06 INFO - PROCESS | 22450 | (process:22522): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:09:07 INFO - PROCESS | 22450 | __metrics Screen width/height:1600/1200 04:09:07 INFO - PROCESS | 22450 | colorDepth:24 04:09:07 INFO - PROCESS | 22450 | Browser inner width/height: 1024/697 04:09:07 INFO - PROCESS | 22450 | __metrics 04:09:08 ERROR - PROCESS | 22450 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 04:09:09 INFO - TEST-INFO | 22450: exit 0 04:09:09 INFO - Browser initialized. 04:09:09 INFO - Running cycle 1/1 for dromaeo_css test... 04:09:09 INFO - TEST-INFO | started process 22573 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2_tp8z/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 | 22573 | 04:09:11 INFO - PROCESS | 22573 | (process:22633): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:09:21 INFO - PROCESS | 22573 | RSS: Main: 166141952 04:09:21 INFO - PROCESS | 22573 | 04:10:10 INFO - PROCESS | 22573 | 1461928210650 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:23 INFO - PROCESS | 22573 | Cycle 1(1): loaded http://localhost:47393/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47393/tests/dromaeo/cssquery-ext.html) 04:12:24 INFO - PROCESS | 22573 | RSS: Main: 167186432 04:12:24 INFO - PROCESS | 22573 | 04:15:26 INFO - PROCESS | 22573 | Cycle 1(1): loaded http://localhost:47393/tests/dromaeo/cssquery-ext.html (next: http://localhost:47393/tests/dromaeo/cssquery-jquery.html) 04:15:27 INFO - PROCESS | 22573 | RSS: Main: 167010304 04:15:27 INFO - PROCESS | 22573 | 04:18:29 INFO - PROCESS | 22573 | Cycle 1(1): loaded http://localhost:47393/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47393/tests/dromaeo/cssquery-mootools.html) 04:18:30 INFO - PROCESS | 22573 | RSS: Main: 167641088 04:18:30 INFO - PROCESS | 22573 | 04:21:31 INFO - PROCESS | 22573 | Cycle 1(1): loaded http://localhost:47393/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47393/tests/dromaeo/cssquery-prototype.html) 04:21:32 INFO - PROCESS | 22573 | RSS: Main: 165543936 04:21:32 INFO - PROCESS | 22573 | 04:24:35 INFO - PROCESS | 22573 | Cycle 1(1): loaded http://localhost:47393/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47393/tests/dromaeo/cssquery-yui.html) 04:24:35 INFO - PROCESS | 22573 | RSS: Main: 166547456 04:24:35 INFO - PROCESS | 22573 | 04:27:38 INFO - PROCESS | 22573 | Cycle 1(1): loaded http://localhost:47393/tests/dromaeo/cssquery-yui.html (next: http://localhost:47393/tests/dromaeo/cssquery-dojo.html) 04:27:38 INFO - PROCESS | 22573 | RSS: Main: 168534016 04:27:38 INFO - PROCESS | 22573 | 04:27:38 INFO - PROCESS | 22573 | __start_tp_report 04:27:38 INFO - PROCESS | 22573 | _x_x_mozilla_page_load 04:27:38 INFO - PROCESS | 22573 | _x_x_mozilla_page_load_details 04:27:38 INFO - PROCESS | 22573 | |i|pagename|runs| 04:27:38 INFO - PROCESS | 22573 | |0;dojo.html;2590.8445493270406;2649.8940042398303;2690.9461810763773;2696.042904768807;2697.892084316626;4644.419447569054;4668.626509879215;4682.625389968799;4736.194846876031;4740.217864052432;4591.104734576759;4678.041001594674;4704.905901881961;4718.976405117978;4775.856724298268;4300.39794428781;4369.410129632507;4383.802728877192;4386.956130438687;4396.6043056124945;559.7595526234602;4193.496780386358;4269.423627810237;4324.156789426063;4331.285337919256;4278.251306021434;4284.993026638737;4289.5924887135825;4332.1119170569955;4333.631641310492;4220.894477638084;4338.089001309729;4341.848035318749;4367.3448982652535;4389.517153113155;4300.677449191323;4317.848875289381;4342.435483387171;4347.30443129101;4386.232409328355;4587.839425620121;4628.143793398232;4630.930536041962;4631.861044168681;4680.899988502699;5009.398872135367;5015.874603134951;5016.1723315653235;5033.697978121324;5054.9241761373605;5070.771815268322;5100.413452452978;5102.617303702237;5106.821261255838;5113.795448182068;4702.130105930414;4746.1456937750845;4752.025834703877;4753.263244197155;4773.140834649727;5016;5210.661307015108;5257.185136303879;5260.947390526046;5271.762770675329;4942.8764280893265;4950.133726597831;4951.900961980812;4956.033573453142;5017.247412888023;5059.924101138486;5062.620303477254;5062.7468626568525;5073.518015788494;5077.289179514871;4757.14371413149;4957.82647607332;5014.398272207359;5028;5044.848654540369;4812.831550895772;4942.4316203637045;4997.3253610762085;5011.799528018912;5040.949590504048;4199.706020578591;4202.831886724497;4203.558626344251;4245.0236445617065;4245.80893859777;3610.837512311952;3653.12325041988;3654.4152935530187;3688.8340024698955;3713.0717320669833;4448.955510444919;4455.443069616298;4460.264056430718;4473;4511;4947.727874966839;5062.291279220912;5062.316587260746;5082.1360368737405;5090.338256026693;4462.330650402466;4462.776861156929;4492.910141797146;4531.478879928784;4542.909141817211;4469.642428605704;4486.484054333728;4518.819247230074;4534.093181363741;4537.296719008559;4601.976990115028;4794.2808578713475;4801.567858892577;4804.183288840835;4812.205986012339;5012.924806127838;5030.949690503195;5040;5045.268436076822;5085.720285384339;4734.076855013377;4750.548697873696;4751.928721069117;4770.403699537558;4801.303810947324;4850.5149485051215;4938.185199442052;4939.506049395031;4963.305137280856;5005.224190250517;4971.254311853251;4998.050370429607;4999.950010497836;5004.699718016931;5039.168537191469;4852.587530059985;4866.002469493675;4875.341828853201;4876.512348765095;4895.412550493964;4644.651651126247;4843.370361852936;4901.289313049517;4922.138625740553;4933.629977751755;4684.648651351231;4830.058138662927;4847.103285892122;4858.878528036827;4858.951410485991;4889.535494128052;4915.311856340187;4917.729524876167;4927.482614325444;4976.278439626306;4705.811767529261;4802.903941921212;4829;4845.200541910686;4863.537963893425 04:27:38 INFO - PROCESS | 22573 | |1;ext.html;568.6985897474337;600.723667113128;615.9353267906872;623.1276213301379;640.0335493404957;28774.56838147427;34737.82631086844;35158.2968340633;35328.2934341313;35392.64607353929;37810;38206.426903596395;38652.806735966355;38712.806435967854;38770.80614596923;7621.809454763634;7815.218478152196;7826.804329891741;7864.05631324239;7870.0949390820215;7607.087149542062;7772.028496437945;7776.183500732426;7777.338926191281;7795.18150594188;7919.802004949865;7997.160298168696;8000.599970001505;8005.759827205193;8010.67957281708;7878.212178782133;7888.2506161914525;7893.644785984645;7929.603519824043;7932.801679957989;7661.42539309554;7752.030996125484;7759.340456061242;7770.300672939463;7770.922290777133;39210;39849.80075099635;39939.8003009986;40098.59901400978;40128;3275.606927168731;3354.26206234628;3581.1226249568763;3752.43713442983;3787.9431808522895;29008.274793130342;29393.265168370748;29472.26319342012;29632.851835740683;30748.8462557688;3181.904542863718;3196.328770958102;3250.138713240993;3258.6252580953255;3326.0687007637657;173727.13136434363;178695;180595;181195;181758.0912095431;51955.22067168995;52590.21114683283;52867.73566132145;52910.73544632252;52958;55777;55795;55901.88196236134;56071.71964140235;56080.71959640176;12754.61736147917;12801.42393592272;12856.55002074923;12875.871241287654;12878.935605321913;10280.177585793119;10371.740706482398;10466.162706983423;10490.632827850988;10507.684769456928;18609;18614.06929653539;18644.906775466035;18717.25130994745;18827.15277812502;6811.352921472452;6891.241963384024;6910.308969103049;7039.9296007039275;7088;806.9314108300742;902.0032863685664;902.6073657958809;904.0913881549001;927.6567669962158;27860.442791144065;28732.425351492853;28922.27694307659;29024.41951160965;29113;996.6312464388222;1002.6190047781942;1010.3584224017802;1084.6387783332025;1104.1442881766695;15064.548063558112;15396.230188490754;15462.38150473991;15552.922235388976;15690;374243;377679;383347;383940;383977;49717.502824971285;50090.749546252766;50335.49664503308;50358.244626330634;50550.24174637383;1165.1436194397281;1176.6409796684843;1186.5006089655328;1197.9460924258428;1258.6538701857062;26830.59754103651;27992.30019249535;28062.158135255973;28540.42919141647;28731.85634071816;38093.238135236585;38238.235235295695;38324.61675383322;38377.80811095927;38392.808035960756;310612;310690;311222;312113;313628;25666.230013099637;25978;26306.473870522866;26620.467590648466;26683.733162668126;42084.15831683288;42403.363949540166;42702.78648606737;43195.35206971961;43423.78288108539;36809.26381472302;36994.8150259247;37269.627303726615;37459;37610.247795044495;36056.819715901256;36464.635353646125;36766.080847979014;36812.447813282284;37036;27726.72273277322;31637;32563.18592035218;32716.50925236171;36001.099972500895;27440.601743145173;28900.42199156047;29759.85120074386;30024.549631755104;31235;22934.770652293264;23183.420414489774;23259.53480930406;23423.76576234216;23794.40513987095 04:27:38 INFO - PROCESS | 22573 | |2;jquery.html;372.1682040639172;381.0397797550174;381.7346943874007;386.37407400011983;390.29162070841403;15831.44589939351;16357.672846543062;17194.05432701201;17240.224189911452;17266.482005539838;15678.764818527703;15716.214189290518;16420.75368869468;16442;16500.75248871268;4390.560943905608;4538.228501154795;4569.9314510282375;4572.611328037121;4580.656450766189;3458.792472451661;5120.667156634825;5427.592930530206;5427.864303392427;5440.945590544084;5372.892542149155;5374.381946076192;5376.51611354978;5384.5692344612335;5414.269073675063;4937.876553086184;5207.479252074762;5232.29364035856;5232.686038837663;5236;4950.183219768734;5074.898502029976;5240.2401651760665;5368.489993450655;5382.865428364322;12621.495140194382;12671;12831.165974211646;12871.034672399514;19096.80903190978;1765.205657454138;1936.5158710322419;1973.9407817765345;2098.95802083959;2325.68603238564;8961.686340978034;9421.38760980534;9522.714318570454;12565.806248406387;12602;1643.983560164395;1665.4837000529753;1691.3826453344564;1698.5074328444737;1768.6197467544412;69850;72252.27747722509;72896.27103729;73118;74280;10089.243306752023;10300.896991030144;10311.175105991502;10396;10449.477526123663;14293.78559321611;14298.428062877369;14344.49794257196;14394.352254148589;14410.207438590769;6864.176298844171;6969.059177011039;7077.82305442368;7096.893546596805;7160.892586611205;6402;6463.57986730861;6515.902261466082;6529.902051469232;6600.306967768412;4327.285997810389;4393.450818647669;4429.468463784367;4475.70907890986;4544.590986811137;1725.8619310455133;1824.6715591193713;1869.168220142051;1882.9435116946513;1891.7162425636266;813.5688085314792;909.6043221198668;928.8188803183449;935.2284365398573;973.5764942250144;14937.850621493862;16492.25784839661;16497.340106395848;16624.085675287974;16780.496585102468;870.7866572689732;878.5607196401799;893.1775589138292;907.8547432410915;942.5805516545208;7440.3303702665935;9052.27581793455;9362.719118426457;9488.240940724725;9518.762030949281;398464;404000;413063;413129;413664;75426.24573754302;75492.24507754963;80314;81188.59405702933;81955;928.8467402878449;958.8130314588589;1001.5543083327995;1003.9598416063421;1004.6985904228555;14912.776308355167;15167.772483412979;15482.303296351916;15497;15758.68482630318;24984.125555605468;35986.64013359833;36356.454653179695;37069.44395834119;37638;51146;51315.23027154521;52433;52633;54187.45812541982;5312.867178320573;6408.391202835724;7576.166621671501;7689;7716.344110750649;10169.38983660953;10500.26498145153;10595.682129536126;10765.30025548337;11117.83323250168;9428;9503.76240593963;9671.854922176313;9711.660091897033;9908.702738917844;9083.863742043743;9582.993785652685;9705.805883882424;9869.703908882744;9871;9619.134277915022;9670.274729395183;9685;9697.612095516382;9890.307678462439;7509.624518774149;7706.07527096752;7722.575258360844;7763.68945242184;7834.529928204326;7473.215312392338;9042.683506077256;9118.817623647623;9446.85829712541;9612.086851749073 04:27:38 INFO - PROCESS | 22573 | |3;mootools.html;1410.1680008794813;1467.6991216800554;1577.337518242338;1734.653069386123;1766.1345940489157;6946.270641582637;7371.520851144672;7463.25367463254;7762.53424794512;7770.728024519143;7417.703291868319;7532.548047117177;7627.313541781238;7630.389568834494;7659.502132361406;2173.6196165670985;2229.7435794883636;2232.9106835726634;2234.486068204314;2241.23797908711;2176.7823217678265;2204.2836078274545;2239.641657334827;2263.4680850000236;2269.1944359752297;2206.1396055538353;2232.2745107839937;2243.7644047375034;2272.8295377846644;2300.275413244831;2151.8601290916117;2152.4511249631246;2162.3296777998794;2166.7724888886596;2175;2142.882141482218;2169.5769324981634;2174.8260139188983;2175.945601359963;2179.498715295475;7700.422468314899;7703.34521565662;7745.3416459601;7811.4922530035365;7839.25527074927;4461.063176732858;4630.351750754897;4635.049814787994;4651.651126165551;4654.511276316006;2779.3628618090993;2919.416116776632;2978.27032377069;2981.701829817023;2997.5503674448787;921.1755478846462;927.9489628070453;931.9673811416636;969.4038166527605;974.2206235012032;10546.683599492027;10670.89329106699;10799.730006749816;10844.80707122216;10847.294925829796;4277.572242775697;4321.65426765858;4384.649228061748;4434.268345722984;4435.844745433894;9200.81598368029;9220.216281616003;9280.118388753057;9285.907140928504;9299.67451139207;4557.931631025537;4577.565131312586;4585.197590421662;4590.67865249436;4604.37840891482;3685.5577330720484;4139.937900931488;4145.502539695256;4267.146570685875;4274.187904298174;3631.5460567429072;3661.2677464507206;3708.8331025103394;3770.3024940386117;3793.639604237593;1179.292424545266;1243.564752336675;1253.154120968361;1264.879836415539;1269.1243042300966;817.6034623207739;824.575343697996;842.0232530264864;844.4131328726476;853.3088198559187;5157;5303.814366497154;5305.283786688748;5397.622166448311;5430.972845135828;432.04733562494624;437.3221506664657;438.2921581645683;442.28350072882137;445.4120560859634;3720.9441858372147;3773.3208022556205;3789.6399842014966;3796.008075343356;3866.3233934061427;9396.530173491297;9638.95180524107;9710.514474276399;9751.414915104975;9759.414435133915;9555.522223888778;9669.854952175723;9683.176929960891;9686.75783105414;9699;6927.826804329831;7138.9286107139305;7213.134423869169;7222.96388518054;7232.240614735482;5529.723513824373;5539.25220095282;5547.140193270049;5658.462446067617;5706.885862282648;8666.826663466822;8758.956205218934;8848.46909185451;8861.822763544822;8862.822743545223;8678.956605216934;9060.456372617664;9091.227245683926;9121.543922803967;9155.496447695441;6623.536352455282;7026.718931242897;7105.147382314155;7178.210396856446;7317.707291708272;7390.630468476662;7424.8143796403365;7441.069866266716;7474.626268686435;7490.213527579525;6413.935860641333;6590.9670451647435;6595.1096601958125;6644.767433139817;6725.991101334839;6460.967695161494;6540.247871494839;6574.4411725002;6597.80206593803;6703.899441508479;6265.467435267871;6313;6325.335839736761;6343.207099112611;6357.205349331333;4459.175052615276;4587.61005314552;4621.913850245257;4679.555442232982;4709.623230141512;4528.547145285445;4534.977325113353;4650.37219975299;4652.418447694038;4682.1103990241745 04:27:38 INFO - PROCESS | 22573 | |4;prototype.html;304.7912180156593;305.93116548776527;313.15135981490147;313.32634835104534;313.74116354007936;4890.193118135508;4923.507649235079;4942.851714448568;4952.430470495894;4971.825986090487;4852.393450818648;4855.150348688974;4856.781444834982;4875.707457552549;4890.853274401774;3666.523351964241;3791.772493650376;3913.726039177259;3930.508686414198;3944.467496887912;3891.066144125418;3903.726739128262;3907.8241479133367;3911.1004468972155;3919.764814111148;3876.6898648108086;3883.184531248441;3899.395593682984;3905.511811023622;3918.784466854322;3767.717421193394;3867.1298957734284;3879.1853710720784;3889.183271512986;3906.7069969752383;3435.158386195373;3450.413429716954;3450.6721861423375;3466.6879980801596;3467.8266086695817;4675.298705194214;4689.366935463703;4703.341532185496;4704.929426058612;4737.881552961169;4406.889827754299;4458.4426946631675;4469.703785902085;4477.283634618478;4479.574440428154;4834.637402194814;5175.818846340398;5192.3249977503065;5203.453637368059;5208.765605547722;3671.3391589513876;3671.751604454498;3698.0939669780805;3702.2410405867004;3703.4629978653215;5323.600729945269;5430.321209848769;5435.891282174374;5449.918251226235;5471.945280547184;3616.72874534411;3697.68732100106;3699.741018128705;3737.4767532545466;3748.3065632857465;3758.962410375916;3765.173890663026;3784.4701741756176;3786.1291902862495;3801.372773492398;4326.567343265649;4330.437043184366;4346.304591265382;4351.912961740747;4355.956440435619;5022.221555658879;5175.249588809602;5205.427402985669;5213.983273261678;5227.92158117621;1371.5199680111882;1378.6622277541867;1384.2663388404162;1390.4368730664098;1393.7491251574813;859.2696208223085;902.3187493442409;921.8801555797703;939.3518472254123;940.7130825098411;4477.574630410106;4603.49361570227;4648.953985353269;4653.976730116396;4664.95335046652;5279.709615971082;5346.4386239445075;5385.630322658018;5391.056565101092;5411.675299482044;4546;4642.628589712815;4662.370579971661;4675.976620116878;4684.437867455859;3034.1656044587917;3049.9542506862413;3064.483080874981;3074.6771588983283;3080.183751305906;5364.678119312854;5392.164214546751;5411.2965314508865;5418.214358917935;5429.457054294539;5624.831255062355;5803.274590676166;5811.186433899257;5889.615940254037;5900.321463031721;5374.462553744673;5411.5659350273;5416.729163541807;5417;5419.810306639249;5694.914576281442;5726.4273572642405;5736.569757268305;5741.712914354182;5770.798022069207;5017.347744793154;5245.59036626196;5322.494363035506;5324.760385782572;5329.546988505866;5100.158473851773;5101.183810590288;5107.233914912793;5109.259157422227;5131.743412829418;3756.1736417988;3799.7150213733526;3805.8287377067545;3821.197548514732;3822.5412950446125;5196.4283928767045;5383.680998155477;5394.892102157856;5397.730113494388;5408.594355423437;5203.713795741119;5227.2420499028185;5248.9475105249985;5263.0000299942885;5266.10476219036;4940.604751619933;5150;5200.60995425337;5230.241614965885;5247.107991641354;5102.897942041212;5121.871953201051;5133.717645529532;5150.79769432868;5170.560502357342;4905.705657660552;5059.406287019577;5246.842594722164;5251.186066159751;5253.290805741176;5086.64393492452;5124.871878203075;5132.640715149903;5148.459411761861;5159.793608255628 04:27:38 INFO - PROCESS | 22573 | |5;yui.html;580.1732531143122;594.6491569973715;643.6588608037736;688.8277930517371;704.9647517624121;10916.727081822959;11062.446877656124;11082.501287442064;11243.437828108592;12781.80827287589;12864.935675321634;12903.870961290384;12926;12930.676733081678;12951.287679177665;633.3951076721743;774.0711146624045;794.3565711773467;796.5061661769711;800.1798156889206;786.1077676836803;787.6534324897056;790.1150711203431;791.2325044706625;792.1523969352795;829.9502029878226;830.0869044051556;830.6884918155691;831.264331067007;832.4672209785742;822.9629666664955;825.4840724547158;828.2752591482453;830.4933990265963;831.1646794971045;606.654207101952;609.6372658268367;610.5542953643865;611.5505103748741;611.9969400153016;11569.190156689036;11608.24546404481;11609.535618575246;11620.128490363257;11621.128415368798;10557.102646275076;10756.623518176826;10840.728981775439;10866.076383507412;11225.101991840633;9076.137766912132;9152.597740062645;9239.445633262027;9398.966113727485;9400.435973841591;3006.609140811702;3012.186709588421;3034.8179109253297;3053.9463884959655;3093.7834351595397;44123.558764412264;44941.55058449406;46554.06891862144;46774.29838552424;46799.53200467952;8707.738767836974;8732.432391894507;8787.297016238814;8924.375293729376;8946.552672366355;16050.197490125447;16058.919705401631;16115.919420403057;16122.435714750161;16145.919270403572;6365.204349456318;6431.389018043278;6605.70274337656;6678.899816502756;6742.932570674328;3607;3690.907727306785;3711.408090271014;3734.2344819311975;3753.399456087013;2677.6519052523436;2776.153273251637;2778.3470884342164;2778.569321755131;2780.666320041608;494.83423053277556;504.482905022355;506.12945733339336;506.6073792810601;511.82853743995435;437.4247864058816;497.909578024126;576.5416493887369;606.6481440764346;608.1394826320795;7663.31030207284;7901.328387087047;7938.206179382016;7959.124496305401;7966.561839098789;449.16679559417463;556.1407625219047;580.1327016110857;623.5074291309905;634.5875181132209;3351.262722201112;3474.3225071111397;3477.791332520006;3499.562554680665;3594.946075808865;48999.51000490021;49197.262041069414;50727.23909141292;50949.235761463606;51623.741881291106;44242.557574424485;44833.775831120634;45486;45830.770846146224;46227;41243.381349279785;41534.58465415307;41537.792311038254;41589.58410415857;42620.78689606532;7158.498905076803;7173.390261827803;7194.100737407824;7401.33387995083;7401.740939067106;28400;28931.276718082216;28985.56521652219;29299.7070029297;29316.560251595816;33533;34681.30637387289;36465.453018204214;36912.26175476529;37009.62990370062;8465.830683386175;8917.28661707049;9171.954140229524;9229.307801915018;9310.860337094813;9681.225501959685;9815.803683926424;9872.457014863965;9926;10213.285070045025;9396.483193424427;9424.246060315021;9427.57575909072;9475.952620236854;9746.220302375934;9347.672831450867;9478.526073696425;9504.667336643184;9511.762205944906;9622.422654640744;9491.430514169171;9492.905070949202;9511.143997040299;9623.855642165234;9649.951750241204;7910.169432209766;8180.7954801130445;8337.749867503984;8528.701495447629;8619.569021549023;8107.959460202661;8157.714479993172;8267.586620668822;8378.329733621418;8435.198656127657 04:27:38 INFO - PROCESS | 22573 | __end_tp_report 04:27:38 INFO - PROCESS | 22573 | __start_cc_report 04:27:38 INFO - PROCESS | 22573 | _x_x_mozilla_cycle_collect,376 04:27:38 INFO - PROCESS | 22573 | __end_cc_report 04:27:38 INFO - PROCESS | 22573 | __startTimestamp1461929258323__endTimestamp 04:27:38 INFO - PROCESS | 22573 | 04:27:38 INFO - PROCESS | 22573 | ------- Summary: start ------- 04:27:38 INFO - PROCESS | 22573 | Number of tests: 6 04:27:38 INFO - PROCESS | 22573 | 04:27:38 INFO - PROCESS | 22573 | [#0] dojo.html Cycles:165 Average:4629.71 Median:4775.86 stddev:578.78 (12.1%) stddev-sans-first:558.02 04:27:38 INFO - PROCESS | 22573 | Values: 2590.8 2649.9 2690.9 2696.0 2697.9 4644.4 4668.6 4682.6 4736.2 4740.2 4591.1 4678.0 4704.9 4719.0 4775.9 4300.4 4369.4 4383.8 4387.0 4396.6 559.8 4193.5 4269.4 4324.2 4331.3 4278.3 4285.0 4289.6 4332.1 4333.6 4220.9 4338.1 4341.8 4367.3 4389.5 4300.7 4317.8 4342.4 4347.3 4386.2 4587.8 4628.1 4630.9 4631.9 4680.9 5009.4 5015.9 5016.2 5033.7 5054.9 5070.8 5100.4 5102.6 5106.8 5113.8 4702.1 4746.1 4752.0 4753.3 4773.1 5016.0 5210.7 5257.2 5260.9 5271.8 4942.9 4950.1 4951.9 4956.0 5017.2 5059.9 5062.6 5062.7 5073.5 5077.3 4757.1 4957.8 5014.4 5028.0 5044.8 4812.8 4942.4 4997.3 5011.8 5040.9 4199.7 4202.8 4203.6 4245.0 4245.8 3610.8 3653.1 3654.4 3688.8 3713.1 4449.0 4455.4 4460.3 4473.0 4511.0 4947.7 5062.3 5062.3 5082.1 5090.3 4462.3 4462.8 4492.9 4531.5 4542.9 4469.6 4486.5 4518.8 4534.1 4537.3 4602.0 4794.3 4801.6 4804.2 4812.2 5012.9 5030.9 5040.0 5045.3 5085.7 4734.1 4750.5 4751.9 4770.4 4801.3 4850.5 4938.2 4939.5 4963.3 5005.2 4971.3 4998.1 5000.0 5004.7 5039.2 4852.6 4866.0 4875.3 4876.5 4895.4 4644.7 4843.4 4901.3 4922.1 4933.6 4684.6 4830.1 4847.1 4858.9 4859.0 4889.5 4915.3 4917.7 4927.5 4976.3 4705.8 4802.9 4829.0 4845.2 4863.5 04:27:38 INFO - PROCESS | 22573 | 04:27:38 INFO - PROCESS | 22573 | [#1] ext.html Cycles:180 Average:44692.93 Median:36810.86 stddev:79765.68 (216.7%) stddev-sans-first:79920.65 04:27:38 INFO - PROCESS | 22573 | Values: 568.7 600.7 615.9 623.1 640.0 28774.6 34737.8 35158.3 35328.3 35392.6 37810.0 38206.4 38652.8 38712.8 38770.8 7621.8 7815.2 7826.8 7864.1 7870.1 7607.1 7772.0 7776.2 7777.3 7795.2 7919.8 7997.2 8000.6 8005.8 8010.7 7878.2 7888.3 7893.6 7929.6 7932.8 7661.4 7752.0 7759.3 7770.3 7770.9 39210.0 39849.8 39939.8 40098.6 40128.0 3275.6 3354.3 3581.1 3752.4 3787.9 29008.3 29393.3 29472.3 29632.9 30748.8 3181.9 3196.3 3250.1 3258.6 3326.1 173727.1 178695.0 180595.0 181195.0 181758.1 51955.2 52590.2 52867.7 52910.7 52958.0 55777.0 55795.0 55901.9 56071.7 56080.7 12754.6 12801.4 12856.6 12875.9 12878.9 10280.2 10371.7 10466.2 10490.6 10507.7 18609.0 18614.1 18644.9 18717.3 18827.2 6811.4 6891.2 6910.3 7039.9 7088.0 806.9 902.0 902.6 904.1 927.7 27860.4 28732.4 28922.3 29024.4 29113.0 996.6 1002.6 1010.4 1084.6 1104.1 15064.5 15396.2 15462.4 15552.9 15690.0 374243.0 377679.0 383347.0 383940.0 383977.0 49717.5 50090.7 50335.5 50358.2 50550.2 1165.1 1176.6 1186.5 1197.9 1258.7 26830.6 27992.3 28062.2 28540.4 28731.9 38093.2 38238.2 38324.6 38377.8 38392.8 310612.0 310690.0 311222.0 312113.0 313628.0 25666.2 25978.0 26306.5 26620.5 26683.7 42084.2 42403.4 42702.8 43195.4 43423.8 36809.3 36994.8 37269.6 37459.0 37610.2 36056.8 36464.6 36766.1 36812.4 37036.0 27726.7 31637.0 32563.2 32716.5 36001.1 27440.6 28900.4 29759.9 30024.5 31235.0 22934.8 23183.4 23259.5 23423.8 23794.4 04:27:38 INFO - PROCESS | 22573 | 04:27:38 INFO - PROCESS | 22573 | [#2] jquery.html Cycles:180 Average:24570.71 Median:28217.95 stddev:67511.63 (239.3%) stddev-sans-first:67676.57 04:27:38 INFO - PROCESS | 22573 | Values: 372.2 381.0 381.7 386.4 390.3 15831.4 16357.7 17194.1 17240.2 17266.5 15678.8 15716.2 16420.8 16442.0 16500.8 4390.6 4538.2 4569.9 4572.6 4580.7 3458.8 5120.7 5427.6 5427.9 5440.9 5372.9 5374.4 5376.5 5384.6 5414.3 4937.9 5207.5 5232.3 5232.7 5236.0 4950.2 5074.9 5240.2 5368.5 5382.9 12621.5 12671.0 12831.2 12871.0 19096.8 1765.2 1936.5 1973.9 2099.0 2325.7 8961.7 9421.4 9522.7 12565.8 12602.0 1644.0 1665.5 1691.4 1698.5 1768.6 69850.0 72252.3 72896.3 73118.0 74280.0 10089.2 10300.9 10311.2 10396.0 10449.5 14293.8 14298.4 14344.5 14394.4 14410.2 6864.2 6969.1 7077.8 7096.9 7160.9 6402.0 6463.6 6515.9 6529.9 6600.3 4327.3 4393.5 4429.5 4475.7 4544.6 1725.9 1824.7 1869.2 1882.9 1891.7 813.6 909.6 928.8 935.2 973.6 14937.9 16492.3 16497.3 16624.1 16780.5 870.8 878.6 893.2 907.9 942.6 7440.3 9052.3 9362.7 9488.2 9518.8 398464.0 404000.0 413063.0 413129.0 413664.0 75426.2 75492.2 80314.0 81188.6 81955.0 928.8 958.8 1001.6 1004.0 1004.7 14912.8 15167.8 15482.3 15497.0 15758.7 24984.1 35986.6 36356.5 37069.4 37638.0 51146.0 51315.2 52433.0 52633.0 54187.5 5312.9 6408.4 7576.2 7689.0 7716.3 10169.4 10500.3 10595.7 10765.3 11117.8 9428.0 9503.8 9671.9 9711.7 9908.7 9083.9 9583.0 9705.8 9869.7 9871.0 9619.1 9670.3 9685.0 9697.6 9890.3 7509.6 7706.1 7722.6 7763.7 7834.5 7473.2 9042.7 9118.8 9446.9 9612.1 04:27:38 INFO - PROCESS | 22573 | 04:27:38 INFO - PROCESS | 22573 | [#3] mootools.html Cycles:180 Average:5149.45 Median:5230.41 stddev:2873.08 (54.9%) stddev-sans-first:2867.40 04:27:38 INFO - PROCESS | 22573 | Values: 1410.2 1467.7 1577.3 1734.7 1766.1 6946.3 7371.5 7463.3 7762.5 7770.7 7417.7 7532.5 7627.3 7630.4 7659.5 2173.6 2229.7 2232.9 2234.5 2241.2 2176.8 2204.3 2239.6 2263.5 2269.2 2206.1 2232.3 2243.8 2272.8 2300.3 2151.9 2152.5 2162.3 2166.8 2175.0 2142.9 2169.6 2174.8 2175.9 2179.5 7700.4 7703.3 7745.3 7811.5 7839.3 4461.1 4630.4 4635.0 4651.7 4654.5 2779.4 2919.4 2978.3 2981.7 2997.6 921.2 927.9 932.0 969.4 974.2 10546.7 10670.9 10799.7 10844.8 10847.3 4277.6 4321.7 4384.6 4434.3 4435.8 9200.8 9220.2 9280.1 9285.9 9299.7 4557.9 4577.6 4585.2 4590.7 4604.4 3685.6 4139.9 4145.5 4267.1 4274.2 3631.5 3661.3 3708.8 3770.3 3793.6 1179.3 1243.6 1253.2 1264.9 1269.1 817.6 824.6 842.0 844.4 853.3 5157.0 5303.8 5305.3 5397.6 5431.0 432.0 437.3 438.3 442.3 445.4 3720.9 3773.3 3789.6 3796.0 3866.3 9396.5 9639.0 9710.5 9751.4 9759.4 9555.5 9669.9 9683.2 9686.8 9699.0 6927.8 7138.9 7213.1 7223.0 7232.2 5529.7 5539.3 5547.1 5658.5 5706.9 8666.8 8759.0 8848.5 8861.8 8862.8 8679.0 9060.5 9091.2 9121.5 9155.5 6623.5 7026.7 7105.1 7178.2 7317.7 7390.6 7424.8 7441.1 7474.6 7490.2 6413.9 6591.0 6595.1 6644.8 6726.0 6461.0 6540.2 6574.4 6597.8 6703.9 6265.5 6313.0 6325.3 6343.2 6357.2 4459.2 4587.6 4621.9 4679.6 4709.6 4528.5 4535.0 4650.4 4652.4 4682.1 04:27:38 INFO - PROCESS | 22573 | 04:27:38 INFO - PROCESS | 22573 | [#4] prototype.html Cycles:180 Average:4364.19 Median:4890.52 stddev:1274.96 (26.1%) stddev-sans-first:1241.60 04:27:38 INFO - PROCESS | 22573 | Values: 304.8 305.9 313.2 313.3 313.7 4890.2 4923.5 4942.9 4952.4 4971.8 4852.4 4855.2 4856.8 4875.7 4890.9 3666.5 3791.8 3913.7 3930.5 3944.5 3891.1 3903.7 3907.8 3911.1 3919.8 3876.7 3883.2 3899.4 3905.5 3918.8 3767.7 3867.1 3879.2 3889.2 3906.7 3435.2 3450.4 3450.7 3466.7 3467.8 4675.3 4689.4 4703.3 4704.9 4737.9 4406.9 4458.4 4469.7 4477.3 4479.6 4834.6 5175.8 5192.3 5203.5 5208.8 3671.3 3671.8 3698.1 3702.2 3703.5 5323.6 5430.3 5435.9 5449.9 5471.9 3616.7 3697.7 3699.7 3737.5 3748.3 3759.0 3765.2 3784.5 3786.1 3801.4 4326.6 4330.4 4346.3 4351.9 4356.0 5022.2 5175.2 5205.4 5214.0 5227.9 1371.5 1378.7 1384.3 1390.4 1393.7 859.3 902.3 921.9 939.4 940.7 4477.6 4603.5 4649.0 4654.0 4665.0 5279.7 5346.4 5385.6 5391.1 5411.7 4546.0 4642.6 4662.4 4676.0 4684.4 3034.2 3050.0 3064.5 3074.7 3080.2 5364.7 5392.2 5411.3 5418.2 5429.5 5624.8 5803.3 5811.2 5889.6 5900.3 5374.5 5411.6 5416.7 5417.0 5419.8 5694.9 5726.4 5736.6 5741.7 5770.8 5017.3 5245.6 5322.5 5324.8 5329.5 5100.2 5101.2 5107.2 5109.3 5131.7 3756.2 3799.7 3805.8 3821.2 3822.5 5196.4 5383.7 5394.9 5397.7 5408.6 5203.7 5227.2 5248.9 5263.0 5266.1 4940.6 5150.0 5200.6 5230.2 5247.1 5102.9 5121.9 5133.7 5150.8 5170.6 4905.7 5059.4 5246.8 5251.2 5253.3 5086.6 5124.9 5132.6 5148.5 5159.8 04:27:38 INFO - PROCESS | 22573 | 04:27:38 INFO - PROCESS | 22573 | [#5] yui.html Cycles:180 Average:12045.92 Median:607.40 stddev:14071.46 (2316.7%) stddev-sans-first:14084.59 04:27:38 INFO - PROCESS | 22573 | Values: 580.2 594.6 643.7 688.8 705.0 10916.7 11062.4 11082.5 11243.4 12781.8 12864.9 12903.9 12926.0 12930.7 12951.3 633.4 774.1 794.4 796.5 800.2 786.1 787.7 790.1 791.2 792.2 830.0 830.1 830.7 831.3 832.5 823.0 825.5 828.3 830.5 831.2 606.7 609.6 610.6 611.6 612.0 11569.2 11608.2 11609.5 11620.1 11621.1 10557.1 10756.6 10840.7 10866.1 11225.1 9076.1 9152.6 9239.4 9399.0 9400.4 3006.6 3012.2 3034.8 3053.9 3093.8 44123.6 44941.6 46554.1 46774.3 46799.5 8707.7 8732.4 8787.3 8924.4 8946.6 16050.2 16058.9 16115.9 16122.4 16145.9 6365.2 6431.4 6605.7 6678.9 6742.9 3607.0 3690.9 3711.4 3734.2 3753.4 2677.7 2776.2 2778.3 2778.6 2780.7 494.8 504.5 506.1 506.6 511.8 437.4 497.9 576.5 606.6 608.1 7663.3 7901.3 7938.2 7959.1 7966.6 449.2 556.1 580.1 623.5 634.6 3351.3 3474.3 3477.8 3499.6 3594.9 48999.5 49197.3 50727.2 50949.2 51623.7 44242.6 44833.8 45486.0 45830.8 46227.0 41243.4 41534.6 41537.8 41589.6 42620.8 7158.5 7173.4 7194.1 7401.3 7401.7 28400.0 28931.3 28985.6 29299.7 29316.6 33533.0 34681.3 36465.5 36912.3 37009.6 8465.8 8917.3 9172.0 9229.3 9310.9 9681.2 9815.8 9872.5 9926.0 10213.3 9396.5 9424.2 9427.6 9476.0 9746.2 9347.7 9478.5 9504.7 9511.8 9622.4 9491.4 9492.9 9511.1 9623.9 9650.0 7910.2 8180.8 8337.7 8528.7 8619.6 8108.0 8157.7 8267.6 8378.3 8435.2 04:27:38 INFO - PROCESS | 22573 | -------- Summary: end -------- 04:27:38 INFO - PROCESS | 22573 | 04:27:39 INFO - TEST-INFO | 22573: exit 0 04:27:39 INFO - TEST-OK | dromaeo_css | took 1116632ms 04:27:39 INFO - TEST-START | kraken 04:27:39 INFO - operating with platform_type : linux_ 04:27:39 INFO - Initialising browser for kraken test... 04:27:39 INFO - TEST-INFO | started process 22810 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZA0c39/profile http://localhost:47393/getInfo.html) 04:27:42 INFO - PROCESS | 22810 | 04:27:42 INFO - PROCESS | 22810 | (process:22876): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:27:43 INFO - PROCESS | 22810 | __metrics Screen width/height:1600/1200 04:27:43 INFO - PROCESS | 22810 | colorDepth:24 04:27:43 INFO - PROCESS | 22810 | Browser inner width/height: 1024/697 04:27:43 INFO - PROCESS | 22810 | __metrics 04:27:44 ERROR - PROCESS | 22810 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 04:27:45 INFO - TEST-INFO | 22810: exit 0 04:27:45 INFO - Browser initialized. 04:27:45 INFO - Running cycle 1/1 for kraken test... 04:27:45 INFO - TEST-INFO | started process 22927 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZA0c39/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:27:47 INFO - PROCESS | 22927 | 04:27:47 INFO - PROCESS | 22927 | (process:22987): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:27:57 INFO - PROCESS | 22927 | RSS: Main: 166109184 04:27:57 INFO - PROCESS | 22927 | 04:27:59 INFO - PROCESS | 22927 | Cycle 1(1): loaded http://localhost:47393/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47393/tests/kraken/driver.html?testName=audio-beat-detection) 04:28:00 INFO - PROCESS | 22927 | RSS: Main: 170684416 04:28:00 INFO - PROCESS | 22927 | 04:28:03 INFO - PROCESS | 22927 | Cycle 1(1): loaded http://localhost:47393/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47393/tests/kraken/driver.html?testName=audio-dft) 04:28:04 INFO - PROCESS | 22927 | RSS: Main: 174059520 04:28:04 INFO - PROCESS | 22927 | 04:28:07 INFO - PROCESS | 22927 | Cycle 1(1): loaded http://localhost:47393/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47393/tests/kraken/driver.html?testName=audio-fft) 04:28:07 INFO - PROCESS | 22927 | RSS: Main: 164397056 04:28:07 INFO - PROCESS | 22927 | 04:28:09 INFO - PROCESS | 22927 | Cycle 1(1): loaded http://localhost:47393/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47393/tests/kraken/driver.html?testName=audio-oscillator) 04:28:10 INFO - PROCESS | 22927 | RSS: Main: 164605952 04:28:10 INFO - PROCESS | 22927 | 04:28:12 INFO - PROCESS | 22927 | Cycle 1(1): loaded http://localhost:47393/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47393/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:28:13 INFO - PROCESS | 22927 | RSS: Main: 166735872 04:28:13 INFO - PROCESS | 22927 | 04:28:16 INFO - PROCESS | 22927 | Cycle 1(1): loaded http://localhost:47393/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47393/tests/kraken/driver.html?testName=imaging-darkroom) 04:28:17 INFO - PROCESS | 22927 | RSS: Main: 165986304 04:28:17 INFO - PROCESS | 22927 | 04:28:20 INFO - PROCESS | 22927 | Cycle 1(1): loaded http://localhost:47393/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47393/tests/kraken/driver.html?testName=imaging-desaturate) 04:28:21 INFO - PROCESS | 22927 | RSS: Main: 165683200 04:28:21 INFO - PROCESS | 22927 | 04:28:24 INFO - PROCESS | 22927 | Cycle 1(1): loaded http://localhost:47393/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47393/tests/kraken/driver.html?testName=json-parse-financial) 04:28:24 INFO - PROCESS | 22927 | RSS: Main: 166486016 04:28:24 INFO - PROCESS | 22927 | 04:28:26 INFO - PROCESS | 22927 | Cycle 1(1): loaded http://localhost:47393/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47393/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:28:27 INFO - PROCESS | 22927 | RSS: Main: 166502400 04:28:27 INFO - PROCESS | 22927 | 04:28:29 INFO - PROCESS | 22927 | Cycle 1(1): loaded http://localhost:47393/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47393/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:28:29 INFO - PROCESS | 22927 | RSS: Main: 166555648 04:28:29 INFO - PROCESS | 22927 | 04:28:31 INFO - PROCESS | 22927 | Cycle 1(1): loaded http://localhost:47393/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47393/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:28:32 INFO - PROCESS | 22927 | RSS: Main: 166899712 04:28:32 INFO - PROCESS | 22927 | 04:28:35 INFO - PROCESS | 22927 | Cycle 1(1): loaded http://localhost:47393/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47393/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:28:35 INFO - PROCESS | 22927 | RSS: Main: 167247872 04:28:35 INFO - PROCESS | 22927 | 04:28:38 INFO - PROCESS | 22927 | Cycle 1(1): loaded http://localhost:47393/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47393/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:28:39 INFO - PROCESS | 22927 | RSS: Main: 166907904 04:28:39 INFO - PROCESS | 22927 | 04:28:41 INFO - PROCESS | 22927 | Cycle 1(1): loaded http://localhost:47393/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47393/tests/kraken/driver.html?testName=ai-astar) 04:28:41 INFO - PROCESS | 22927 | RSS: Main: 168566784 04:28:41 INFO - PROCESS | 22927 | 04:28:41 INFO - PROCESS | 22927 | __start_tp_report 04:28:41 INFO - PROCESS | 22927 | _x_x_mozilla_page_load 04:28:41 INFO - PROCESS | 22927 | _x_x_mozilla_page_load_details 04:28:41 INFO - PROCESS | 22927 | |i|pagename|runs| 04:28:41 INFO - PROCESS | 22927 | |0;ai-astar;113;110;115;114;112;126;114;113;113;114 04:28:41 INFO - PROCESS | 22927 | |1;audio-beat-detection;166;134;155;184;147;156;160;134;193;133 04:28:41 INFO - PROCESS | 22927 | |2;audio-dft;163;162;165;165;167;162;163;161;165;165 04:28:41 INFO - PROCESS | 22927 | |3;audio-fft;74;78;77;154;74;78;73;75;162;74 04:28:41 INFO - PROCESS | 22927 | |4;audio-oscillator;93;96;148;93;94;94;139;94;93;142 04:28:41 INFO - PROCESS | 22927 | |5;imaging-gaussian-blur;117;117;118;118;117;118;117;118;118;118 04:28:41 INFO - PROCESS | 22927 | |6;imaging-darkroom;147;147;147;147;146;147;146;147;146;146 04:28:41 INFO - PROCESS | 22927 | |7;imaging-desaturate;95;97;95;96;95;96;95;95;94;95 04:28:41 INFO - PROCESS | 22927 | |8;json-parse-financial;69;68;68;68;68;68;67;82;66;65 04:28:41 INFO - PROCESS | 22927 | |9;json-stringify-tinderbox;64;65;64;66;65;65;64;64;65;64 04:28:41 INFO - PROCESS | 22927 | |10;stanford-crypto-aes;80;79;79;81;82;80;82;88;81;80 04:28:41 INFO - PROCESS | 22927 | |11;stanford-crypto-ccm;130;136;130;132;147;131;133;141;214;136 04:28:41 INFO - PROCESS | 22927 | |12;stanford-crypto-pbkdf2;188;180;172;179;174;181;176;175;175;185 04:28:41 INFO - PROCESS | 22927 | |13;stanford-crypto-sha256-iterative;76;74;77;78;71;72;73;72;73;75 04:28:41 INFO - PROCESS | 22927 | __end_tp_report 04:28:41 INFO - PROCESS | 22927 | __start_cc_report 04:28:41 INFO - PROCESS | 22927 | _x_x_mozilla_cycle_collect,922 04:28:41 INFO - PROCESS | 22927 | __end_cc_report 04:28:41 INFO - PROCESS | 22927 | __startTimestamp1461929321578__endTimestamp 04:28:41 INFO - PROCESS | 22927 | 04:28:41 INFO - PROCESS | 22927 | ------- Summary: start ------- 04:28:41 INFO - PROCESS | 22927 | Number of tests: 14 04:28:41 INFO - PROCESS | 22927 | 04:28:41 INFO - PROCESS | 22927 | [#0] ai-astar Cycles:10 Average:114.40 Median:114.00 stddev:4.30 (3.8%) stddev-sans-first:4.53 04:28:41 INFO - PROCESS | 22927 | Values: 113.0 110.0 115.0 114.0 112.0 126.0 114.0 113.0 113.0 114.0 04:28:41 INFO - PROCESS | 22927 | 04:28:41 INFO - PROCESS | 22927 | [#1] audio-beat-detection Cycles:10 Average:156.20 Median:158.00 stddev:20.68 (13.1%) stddev-sans-first:21.62 04:28:41 INFO - PROCESS | 22927 | Values: 166.0 134.0 155.0 184.0 147.0 156.0 160.0 134.0 193.0 133.0 04:28:41 INFO - PROCESS | 22927 | 04:28:41 INFO - PROCESS | 22927 | [#2] audio-dft Cycles:10 Average:163.80 Median:165.00 stddev:1.87 (1.1%) stddev-sans-first:1.96 04:28:41 INFO - PROCESS | 22927 | Values: 163.0 162.0 165.0 165.0 167.0 162.0 163.0 161.0 165.0 165.0 04:28:41 INFO - PROCESS | 22927 | 04:28:41 INFO - PROCESS | 22927 | [#3] audio-fft Cycles:10 Average:91.90 Median:74.50 stddev:34.93 (46.9%) stddev-sans-first:36.45 04:28:41 INFO - PROCESS | 22927 | Values: 74.0 78.0 77.0 154.0 74.0 78.0 73.0 75.0 162.0 74.0 04:28:41 INFO - PROCESS | 22927 | 04:28:41 INFO - PROCESS | 22927 | [#4] audio-oscillator Cycles:10 Average:108.60 Median:93.50 stddev:23.85 (25.5%) stddev-sans-first:24.62 04:28:41 INFO - PROCESS | 22927 | Values: 93.0 96.0 148.0 93.0 94.0 94.0 139.0 94.0 93.0 142.0 04:28:41 INFO - PROCESS | 22927 | 04:28:41 INFO - PROCESS | 22927 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 04:28:41 INFO - PROCESS | 22927 | Values: 117.0 117.0 118.0 118.0 117.0 118.0 117.0 118.0 118.0 118.0 04:28:41 INFO - PROCESS | 22927 | 04:28:41 INFO - PROCESS | 22927 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:28:41 INFO - PROCESS | 22927 | Values: 147.0 147.0 147.0 147.0 146.0 147.0 146.0 147.0 146.0 146.0 04:28:41 INFO - PROCESS | 22927 | 04:28:41 INFO - PROCESS | 22927 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 04:28:41 INFO - PROCESS | 22927 | Values: 95.0 97.0 95.0 96.0 95.0 96.0 95.0 95.0 94.0 95.0 04:28:41 INFO - PROCESS | 22927 | 04:28:41 INFO - PROCESS | 22927 | [#8] json-parse-financial Cycles:10 Average:68.90 Median:68.00 stddev:4.75 (7.0%) stddev-sans-first:5.04 04:28:41 INFO - PROCESS | 22927 | Values: 69.0 68.0 68.0 68.0 68.0 68.0 67.0 82.0 66.0 65.0 04:28:41 INFO - PROCESS | 22927 | 04:28:41 INFO - PROCESS | 22927 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 04:28:41 INFO - PROCESS | 22927 | Values: 64.0 65.0 64.0 66.0 65.0 65.0 64.0 64.0 65.0 64.0 04:28:41 INFO - PROCESS | 22927 | 04:28:41 INFO - PROCESS | 22927 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:81.00 stddev:2.62 (3.2%) stddev-sans-first:2.74 04:28:41 INFO - PROCESS | 22927 | Values: 80.0 79.0 79.0 81.0 82.0 80.0 82.0 88.0 81.0 80.0 04:28:41 INFO - PROCESS | 22927 | 04:28:41 INFO - PROCESS | 22927 | [#11] stanford-crypto-ccm Cycles:10 Average:143.00 Median:136.00 stddev:25.52 (18.8%) stddev-sans-first:26.63 04:28:41 INFO - PROCESS | 22927 | Values: 130.0 136.0 130.0 132.0 147.0 131.0 133.0 141.0 214.0 136.0 04:28:41 INFO - PROCESS | 22927 | 04:28:41 INFO - PROCESS | 22927 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.50 Median:179.50 stddev:5.10 (2.8%) stddev-sans-first:4.10 04:28:41 INFO - PROCESS | 22927 | Values: 188.0 180.0 172.0 179.0 174.0 181.0 176.0 175.0 175.0 185.0 04:28:41 INFO - PROCESS | 22927 | 04:28:41 INFO - PROCESS | 22927 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.10 Median:74.50 stddev:2.33 (3.1%) stddev-sans-first:2.37 04:28:41 INFO - PROCESS | 22927 | Values: 76.0 74.0 77.0 78.0 71.0 72.0 73.0 72.0 73.0 75.0 04:28:41 INFO - PROCESS | 22927 | -------- Summary: end -------- 04:28:41 INFO - PROCESS | 22927 | 04:28:42 INFO - TEST-INFO | 22927: exit 0 04:28:42 INFO - TEST-OK | kraken | took 63547ms 04:28:42 INFO - SUITE-END | took 1180s 04:28:42 INFO - Completed test suite (00:19:40) 04:28:42 INFO - javascript benchmark 04:28:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2590.8445493270406, 2649.8940042398303, 2690.9461810763773, 2696.042904768807, 2697.892084316626, 4644.419447569054, 4668.626509879215, 4682.625389968799, 4736.194846876031, 4740.217864052432, 4591.104734576759, 4678.041001594674, 4704.905901881961, 4718.976405117978, 4775.856724298268, 4300.39794428781, 4369.410129632507, 4383.802728877192, 4386.956130438687, 4396.6043056124945, 559.7595526234602, 4193.496780386358, 4269.423627810237, 4324.156789426063, 4331.285337919256, 4278.251306021434, 4284.993026638737, 4289.5924887135825, 4332.1119170569955, 4333.631641310492, 4220.894477638084, 4338.089001309729, 4341.848035318749, 4367.3448982652535, 4389.517153113155, 4300.677449191323, 4317.848875289381, 4342.435483387171, 4347.30443129101, 4386.232409328355, 4587.839425620121, 4628.143793398232, 4630.930536041962, 4631.861044168681, 4680.899988502699, 5009.398872135367, 5015.874603134951, 5016.1723315653235, 5033.697978121324, 5054.9241761373605, 5070.771815268322, 5100.413452452978, 5102.617303702237, 5106.821261255838, 5113.795448182068, 4702.130105930414, 4746.1456937750845, 4752.025834703877, 4753.263244197155, 4773.140834649727, 5016.0, 5210.661307015108, 5257.185136303879, 5260.947390526046, 5271.762770675329, 4942.8764280893265, 4950.133726597831, 4951.900961980812, 4956.033573453142, 5017.247412888023, 5059.924101138486, 5062.620303477254, 5062.7468626568525, 5073.518015788494, 5077.289179514871, 4757.14371413149, 4957.82647607332, 5014.398272207359, 5028.0, 5044.848654540369, 4812.831550895772, 4942.4316203637045, 4997.3253610762085, 5011.799528018912, 5040.949590504048, 4199.706020578591, 4202.831886724497, 4203.558626344251, 4245.0236445617065, 4245.80893859777, 3610.837512311952, 3653.12325041988, 3654.4152935530187, 3688.8340024698955, 3713.0717320669833, 4448.955510444919, 4455.443069616298, 4460.264056430718, 4473.0, 4511.0, 4947.727874966839, 5062.291279220912, 5062.316587260746, 5082.1360368737405, 5090.338256026693, 4462.330650402466, 4462.776861156929, 4492.910141797146, 4531.478879928784, 4542.909141817211, 4469.642428605704, 4486.484054333728, 4518.819247230074, 4534.093181363741, 4537.296719008559, 4601.976990115028, 4794.2808578713475, 4801.567858892577, 4804.183288840835, 4812.205986012339, 5012.924806127838, 5030.949690503195, 5040.0, 5045.268436076822, 5085.720285384339, 4734.076855013377, 4750.548697873696, 4751.928721069117, 4770.403699537558, 4801.303810947324, 4850.5149485051215, 4938.185199442052, 4939.506049395031, 4963.305137280856, 5005.224190250517, 4971.254311853251, 4998.050370429607, 4999.950010497836, 5004.699718016931, 5039.168537191469, 4852.587530059985, 4866.002469493675, 4875.341828853201, 4876.512348765095, 4895.412550493964, 4644.651651126247, 4843.370361852936, 4901.289313049517, 4922.138625740553, 4933.629977751755, 4684.648651351231, 4830.058138662927, 4847.103285892122, 4858.878528036827, 4858.951410485991, 4889.535494128052, 4915.311856340187, 4917.729524876167, 4927.482614325444, 4976.278439626306, 4705.811767529261, 4802.903941921212, 4829.0, 4845.200541910686, 4863.537963893425], "value": 4595.115999606833, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.6985897474337, 600.723667113128, 615.9353267906872, 623.1276213301379, 640.0335493404957, 28774.56838147427, 34737.82631086844, 35158.2968340633, 35328.2934341313, 35392.64607353929, 37810.0, 38206.426903596395, 38652.806735966355, 38712.806435967854, 38770.80614596923, 7621.809454763634, 7815.218478152196, 7826.804329891741, 7864.05631324239, 7870.0949390820215, 7607.087149542062, 7772.028496437945, 7776.183500732426, 7777.338926191281, 7795.18150594188, 7919.802004949865, 7997.160298168696, 8000.599970001505, 8005.759827205193, 8010.67957281708, 7878.212178782133, 7888.2506161914525, 7893.644785984645, 7929.603519824043, 7932.801679957989, 7661.42539309554, 7752.030996125484, 7759.340456061242, 7770.300672939463, 7770.922290777133, 39210.0, 39849.80075099635, 39939.8003009986, 40098.59901400978, 40128.0, 3275.606927168731, 3354.26206234628, 3581.1226249568763, 3752.43713442983, 3787.9431808522895, 29008.274793130342, 29393.265168370748, 29472.26319342012, 29632.851835740683, 30748.8462557688, 3181.904542863718, 3196.328770958102, 3250.138713240993, 3258.6252580953255, 3326.0687007637657, 173727.13136434363, 178695.0, 180595.0, 181195.0, 181758.0912095431, 51955.22067168995, 52590.21114683283, 52867.73566132145, 52910.73544632252, 52958.0, 55777.0, 55795.0, 55901.88196236134, 56071.71964140235, 56080.71959640176, 12754.61736147917, 12801.42393592272, 12856.55002074923, 12875.871241287654, 12878.935605321913, 10280.177585793119, 10371.740706482398, 10466.162706983423, 10490.632827850988, 10507.684769456928, 18609.0, 18614.06929653539, 18644.906775466035, 18717.25130994745, 18827.15277812502, 6811.352921472452, 6891.241963384024, 6910.308969103049, 7039.9296007039275, 7088.0, 806.9314108300742, 902.0032863685664, 902.6073657958809, 904.0913881549001, 927.6567669962158, 27860.442791144065, 28732.425351492853, 28922.27694307659, 29024.41951160965, 29113.0, 996.6312464388222, 1002.6190047781942, 1010.3584224017802, 1084.6387783332025, 1104.1442881766695, 15064.548063558112, 15396.230188490754, 15462.38150473991, 15552.922235388976, 15690.0, 374243.0, 377679.0, 383347.0, 383940.0, 383977.0, 49717.502824971285, 50090.749546252766, 50335.49664503308, 50358.244626330634, 50550.24174637383, 1165.1436194397281, 1176.6409796684843, 1186.5006089655328, 1197.9460924258428, 1258.6538701857062, 26830.59754103651, 27992.30019249535, 28062.158135255973, 28540.42919141647, 28731.85634071816, 38093.238135236585, 38238.235235295695, 38324.61675383322, 38377.80811095927, 38392.808035960756, 310612.0, 310690.0, 311222.0, 312113.0, 313628.0, 25666.230013099637, 25978.0, 26306.473870522866, 26620.467590648466, 26683.733162668126, 42084.15831683288, 42403.363949540166, 42702.78648606737, 43195.35206971961, 43423.78288108539, 36809.26381472302, 36994.8150259247, 37269.627303726615, 37459.0, 37610.247795044495, 36056.819715901256, 36464.635353646125, 36766.080847979014, 36812.447813282284, 37036.0, 27726.72273277322, 31637.0, 32563.18592035218, 32716.50925236171, 36001.099972500895, 27440.601743145173, 28900.42199156047, 29759.85120074386, 30024.549631755104, 31235.0, 22934.770652293264, 23183.420414489774, 23259.53480930406, 23423.76576234216, 23794.40513987095], "value": 17215.039879728378, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.1682040639172, 381.0397797550174, 381.7346943874007, 386.37407400011983, 390.29162070841403, 15831.44589939351, 16357.672846543062, 17194.05432701201, 17240.224189911452, 17266.482005539838, 15678.764818527703, 15716.214189290518, 16420.75368869468, 16442.0, 16500.75248871268, 4390.560943905608, 4538.228501154795, 4569.9314510282375, 4572.611328037121, 4580.656450766189, 3458.792472451661, 5120.667156634825, 5427.592930530206, 5427.864303392427, 5440.945590544084, 5372.892542149155, 5374.381946076192, 5376.51611354978, 5384.5692344612335, 5414.269073675063, 4937.876553086184, 5207.479252074762, 5232.29364035856, 5232.686038837663, 5236.0, 4950.183219768734, 5074.898502029976, 5240.2401651760665, 5368.489993450655, 5382.865428364322, 12621.495140194382, 12671.0, 12831.165974211646, 12871.034672399514, 19096.80903190978, 1765.205657454138, 1936.5158710322419, 1973.9407817765345, 2098.95802083959, 2325.68603238564, 8961.686340978034, 9421.38760980534, 9522.714318570454, 12565.806248406387, 12602.0, 1643.983560164395, 1665.4837000529753, 1691.3826453344564, 1698.5074328444737, 1768.6197467544412, 69850.0, 72252.27747722509, 72896.27103729, 73118.0, 74280.0, 10089.243306752023, 10300.896991030144, 10311.175105991502, 10396.0, 10449.477526123663, 14293.78559321611, 14298.428062877369, 14344.49794257196, 14394.352254148589, 14410.207438590769, 6864.176298844171, 6969.059177011039, 7077.82305442368, 7096.893546596805, 7160.892586611205, 6402.0, 6463.57986730861, 6515.902261466082, 6529.902051469232, 6600.306967768412, 4327.285997810389, 4393.450818647669, 4429.468463784367, 4475.70907890986, 4544.590986811137, 1725.8619310455133, 1824.6715591193713, 1869.168220142051, 1882.9435116946513, 1891.7162425636266, 813.5688085314792, 909.6043221198668, 928.8188803183449, 935.2284365398573, 973.5764942250144, 14937.850621493862, 16492.25784839661, 16497.340106395848, 16624.085675287974, 16780.496585102468, 870.7866572689732, 878.5607196401799, 893.1775589138292, 907.8547432410915, 942.5805516545208, 7440.3303702665935, 9052.27581793455, 9362.719118426457, 9488.240940724725, 9518.762030949281, 398464.0, 404000.0, 413063.0, 413129.0, 413664.0, 75426.24573754302, 75492.24507754963, 80314.0, 81188.59405702933, 81955.0, 928.8467402878449, 958.8130314588589, 1001.5543083327995, 1003.9598416063421, 1004.6985904228555, 14912.776308355167, 15167.772483412979, 15482.303296351916, 15497.0, 15758.68482630318, 24984.125555605468, 35986.64013359833, 36356.454653179695, 37069.44395834119, 37638.0, 51146.0, 51315.23027154521, 52433.0, 52633.0, 54187.45812541982, 5312.867178320573, 6408.391202835724, 7576.166621671501, 7689.0, 7716.344110750649, 10169.38983660953, 10500.26498145153, 10595.682129536126, 10765.30025548337, 11117.83323250168, 9428.0, 9503.76240593963, 9671.854922176313, 9711.660091897033, 9908.702738917844, 9083.863742043743, 9582.993785652685, 9705.805883882424, 9869.703908882744, 9871.0, 9619.134277915022, 9670.274729395183, 9685.0, 9697.612095516382, 9890.307678462439, 7509.624518774149, 7706.07527096752, 7722.575258360844, 7763.68945242184, 7834.529928204326, 7473.215312392338, 9042.683506077256, 9118.817623647623, 9446.85829712541, 9612.086851749073], "value": 8004.705362023832, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1410.1680008794813, 1467.6991216800554, 1577.337518242338, 1734.653069386123, 1766.1345940489157, 6946.270641582637, 7371.520851144672, 7463.25367463254, 7762.53424794512, 7770.728024519143, 7417.703291868319, 7532.548047117177, 7627.313541781238, 7630.389568834494, 7659.502132361406, 2173.6196165670985, 2229.7435794883636, 2232.9106835726634, 2234.486068204314, 2241.23797908711, 2176.7823217678265, 2204.2836078274545, 2239.641657334827, 2263.4680850000236, 2269.1944359752297, 2206.1396055538353, 2232.2745107839937, 2243.7644047375034, 2272.8295377846644, 2300.275413244831, 2151.8601290916117, 2152.4511249631246, 2162.3296777998794, 2166.7724888886596, 2175.0, 2142.882141482218, 2169.5769324981634, 2174.8260139188983, 2175.945601359963, 2179.498715295475, 7700.422468314899, 7703.34521565662, 7745.3416459601, 7811.4922530035365, 7839.25527074927, 4461.063176732858, 4630.351750754897, 4635.049814787994, 4651.651126165551, 4654.511276316006, 2779.3628618090993, 2919.416116776632, 2978.27032377069, 2981.701829817023, 2997.5503674448787, 921.1755478846462, 927.9489628070453, 931.9673811416636, 969.4038166527605, 974.2206235012032, 10546.683599492027, 10670.89329106699, 10799.730006749816, 10844.80707122216, 10847.294925829796, 4277.572242775697, 4321.65426765858, 4384.649228061748, 4434.268345722984, 4435.844745433894, 9200.81598368029, 9220.216281616003, 9280.118388753057, 9285.907140928504, 9299.67451139207, 4557.931631025537, 4577.565131312586, 4585.197590421662, 4590.67865249436, 4604.37840891482, 3685.5577330720484, 4139.937900931488, 4145.502539695256, 4267.146570685875, 4274.187904298174, 3631.5460567429072, 3661.2677464507206, 3708.8331025103394, 3770.3024940386117, 3793.639604237593, 1179.292424545266, 1243.564752336675, 1253.154120968361, 1264.879836415539, 1269.1243042300966, 817.6034623207739, 824.575343697996, 842.0232530264864, 844.4131328726476, 853.3088198559187, 5157.0, 5303.814366497154, 5305.283786688748, 5397.622166448311, 5430.972845135828, 432.04733562494624, 437.3221506664657, 438.2921581645683, 442.28350072882137, 445.4120560859634, 3720.9441858372147, 3773.3208022556205, 3789.6399842014966, 3796.008075343356, 3866.3233934061427, 9396.530173491297, 9638.95180524107, 9710.514474276399, 9751.414915104975, 9759.414435133915, 9555.522223888778, 9669.854952175723, 9683.176929960891, 9686.75783105414, 9699.0, 6927.826804329831, 7138.9286107139305, 7213.134423869169, 7222.96388518054, 7232.240614735482, 5529.723513824373, 5539.25220095282, 5547.140193270049, 5658.462446067617, 5706.885862282648, 8666.826663466822, 8758.956205218934, 8848.46909185451, 8861.822763544822, 8862.822743545223, 8678.956605216934, 9060.456372617664, 9091.227245683926, 9121.543922803967, 9155.496447695441, 6623.536352455282, 7026.718931242897, 7105.147382314155, 7178.210396856446, 7317.707291708272, 7390.630468476662, 7424.8143796403365, 7441.069866266716, 7474.626268686435, 7490.213527579525, 6413.935860641333, 6590.9670451647435, 6595.1096601958125, 6644.767433139817, 6725.991101334839, 6460.967695161494, 6540.247871494839, 6574.4411725002, 6597.80206593803, 6703.899441508479, 6265.467435267871, 6313.0, 6325.335839736761, 6343.207099112611, 6357.205349331333, 4459.175052615276, 4587.61005314552, 4621.913850245257, 4679.555442232982, 4709.623230141512, 4528.547145285445, 4534.977325113353, 4650.37219975299, 4652.418447694038, 4682.1103990241745], "value": 4103.131462529106, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.7912180156593, 305.93116548776527, 313.15135981490147, 313.32634835104534, 313.74116354007936, 4890.193118135508, 4923.507649235079, 4942.851714448568, 4952.430470495894, 4971.825986090487, 4852.393450818648, 4855.150348688974, 4856.781444834982, 4875.707457552549, 4890.853274401774, 3666.523351964241, 3791.772493650376, 3913.726039177259, 3930.508686414198, 3944.467496887912, 3891.066144125418, 3903.726739128262, 3907.8241479133367, 3911.1004468972155, 3919.764814111148, 3876.6898648108086, 3883.184531248441, 3899.395593682984, 3905.511811023622, 3918.784466854322, 3767.717421193394, 3867.1298957734284, 3879.1853710720784, 3889.183271512986, 3906.7069969752383, 3435.158386195373, 3450.413429716954, 3450.6721861423375, 3466.6879980801596, 3467.8266086695817, 4675.298705194214, 4689.366935463703, 4703.341532185496, 4704.929426058612, 4737.881552961169, 4406.889827754299, 4458.4426946631675, 4469.703785902085, 4477.283634618478, 4479.574440428154, 4834.637402194814, 5175.818846340398, 5192.3249977503065, 5203.453637368059, 5208.765605547722, 3671.3391589513876, 3671.751604454498, 3698.0939669780805, 3702.2410405867004, 3703.4629978653215, 5323.600729945269, 5430.321209848769, 5435.891282174374, 5449.918251226235, 5471.945280547184, 3616.72874534411, 3697.68732100106, 3699.741018128705, 3737.4767532545466, 3748.3065632857465, 3758.962410375916, 3765.173890663026, 3784.4701741756176, 3786.1291902862495, 3801.372773492398, 4326.567343265649, 4330.437043184366, 4346.304591265382, 4351.912961740747, 4355.956440435619, 5022.221555658879, 5175.249588809602, 5205.427402985669, 5213.983273261678, 5227.92158117621, 1371.5199680111882, 1378.6622277541867, 1384.2663388404162, 1390.4368730664098, 1393.7491251574813, 859.2696208223085, 902.3187493442409, 921.8801555797703, 939.3518472254123, 940.7130825098411, 4477.574630410106, 4603.49361570227, 4648.953985353269, 4653.976730116396, 4664.95335046652, 5279.709615971082, 5346.4386239445075, 5385.630322658018, 5391.056565101092, 5411.675299482044, 4546.0, 4642.628589712815, 4662.370579971661, 4675.976620116878, 4684.437867455859, 3034.1656044587917, 3049.9542506862413, 3064.483080874981, 3074.6771588983283, 3080.183751305906, 5364.678119312854, 5392.164214546751, 5411.2965314508865, 5418.214358917935, 5429.457054294539, 5624.831255062355, 5803.274590676166, 5811.186433899257, 5889.615940254037, 5900.321463031721, 5374.462553744673, 5411.5659350273, 5416.729163541807, 5417.0, 5419.810306639249, 5694.914576281442, 5726.4273572642405, 5736.569757268305, 5741.712914354182, 5770.798022069207, 5017.347744793154, 5245.59036626196, 5322.494363035506, 5324.760385782572, 5329.546988505866, 5100.158473851773, 5101.183810590288, 5107.233914912793, 5109.259157422227, 5131.743412829418, 3756.1736417988, 3799.7150213733526, 3805.8287377067545, 3821.197548514732, 3822.5412950446125, 5196.4283928767045, 5383.680998155477, 5394.892102157856, 5397.730113494388, 5408.594355423437, 5203.713795741119, 5227.2420499028185, 5248.9475105249985, 5263.0000299942885, 5266.10476219036, 4940.604751619933, 5150.0, 5200.60995425337, 5230.241614965885, 5247.107991641354, 5102.897942041212, 5121.871953201051, 5133.717645529532, 5150.79769432868, 5170.560502357342, 4905.705657660552, 5059.406287019577, 5246.842594722164, 5251.186066159751, 5253.290805741176, 5086.64393492452, 5124.871878203075, 5132.640715149903, 5148.459411761861, 5159.793608255628], "value": 3963.621586058138, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.1732531143122, 594.6491569973715, 643.6588608037736, 688.8277930517371, 704.9647517624121, 10916.727081822959, 11062.446877656124, 11082.501287442064, 11243.437828108592, 12781.80827287589, 12864.935675321634, 12903.870961290384, 12926.0, 12930.676733081678, 12951.287679177665, 633.3951076721743, 774.0711146624045, 794.3565711773467, 796.5061661769711, 800.1798156889206, 786.1077676836803, 787.6534324897056, 790.1150711203431, 791.2325044706625, 792.1523969352795, 829.9502029878226, 830.0869044051556, 830.6884918155691, 831.264331067007, 832.4672209785742, 822.9629666664955, 825.4840724547158, 828.2752591482453, 830.4933990265963, 831.1646794971045, 606.654207101952, 609.6372658268367, 610.5542953643865, 611.5505103748741, 611.9969400153016, 11569.190156689036, 11608.24546404481, 11609.535618575246, 11620.128490363257, 11621.128415368798, 10557.102646275076, 10756.623518176826, 10840.728981775439, 10866.076383507412, 11225.101991840633, 9076.137766912132, 9152.597740062645, 9239.445633262027, 9398.966113727485, 9400.435973841591, 3006.609140811702, 3012.186709588421, 3034.8179109253297, 3053.9463884959655, 3093.7834351595397, 44123.558764412264, 44941.55058449406, 46554.06891862144, 46774.29838552424, 46799.53200467952, 8707.738767836974, 8732.432391894507, 8787.297016238814, 8924.375293729376, 8946.552672366355, 16050.197490125447, 16058.919705401631, 16115.919420403057, 16122.435714750161, 16145.919270403572, 6365.204349456318, 6431.389018043278, 6605.70274337656, 6678.899816502756, 6742.932570674328, 3607.0, 3690.907727306785, 3711.408090271014, 3734.2344819311975, 3753.399456087013, 2677.6519052523436, 2776.153273251637, 2778.3470884342164, 2778.569321755131, 2780.666320041608, 494.83423053277556, 504.482905022355, 506.12945733339336, 506.6073792810601, 511.82853743995435, 437.4247864058816, 497.909578024126, 576.5416493887369, 606.6481440764346, 608.1394826320795, 7663.31030207284, 7901.328387087047, 7938.206179382016, 7959.124496305401, 7966.561839098789, 449.16679559417463, 556.1407625219047, 580.1327016110857, 623.5074291309905, 634.5875181132209, 3351.262722201112, 3474.3225071111397, 3477.791332520006, 3499.562554680665, 3594.946075808865, 48999.51000490021, 49197.262041069414, 50727.23909141292, 50949.235761463606, 51623.741881291106, 44242.557574424485, 44833.775831120634, 45486.0, 45830.770846146224, 46227.0, 41243.381349279785, 41534.58465415307, 41537.792311038254, 41589.58410415857, 42620.78689606532, 7158.498905076803, 7173.390261827803, 7194.100737407824, 7401.33387995083, 7401.740939067106, 28400.0, 28931.276718082216, 28985.56521652219, 29299.7070029297, 29316.560251595816, 33533.0, 34681.30637387289, 36465.453018204214, 36912.26175476529, 37009.62990370062, 8465.830683386175, 8917.28661707049, 9171.954140229524, 9229.307801915018, 9310.860337094813, 9681.225501959685, 9815.803683926424, 9872.457014863965, 9926.0, 10213.285070045025, 9396.483193424427, 9424.246060315021, 9427.57575909072, 9475.952620236854, 9746.220302375934, 9347.672831450867, 9478.526073696425, 9504.667336643184, 9511.762205944906, 9622.422654640744, 9491.430514169171, 9492.905070949202, 9511.143997040299, 9623.855642165234, 9649.951750241204, 7910.169432209766, 8180.7954801130445, 8337.749867503984, 8528.701495447629, 8619.569021549023, 8107.959460202661, 8157.714479993172, 8267.586620668822, 8378.329733621418, 8435.198656127657], "value": 5545.310371521147, "unit": "score"}], "name": "dromaeo_css", "value": 6205.66782405229, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 110.0, 115.0, 114.0, 112.0, 126.0, 114.0, 113.0, 113.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 134.0, 155.0, 184.0, 147.0, 156.0, 160.0, 134.0, 193.0, 133.0], "value": 156.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 165.0, 165.0, 167.0, 162.0, 163.0, 161.0, 165.0, 165.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 78.0, 77.0, 154.0, 74.0, 78.0, 73.0, 75.0, 162.0, 74.0], "value": 91.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 96.0, 148.0, 93.0, 94.0, 94.0, 139.0, 94.0, 93.0, 142.0], "value": 108.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 94.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 68.0, 68.0, 68.0, 68.0, 67.0, 82.0, 66.0, 65.0], "value": 68.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 66.0, 65.0, 65.0, 64.0, 64.0, 65.0, 64.0], "value": 64.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 81.0, 82.0, 80.0, 82.0, 88.0, 81.0, 80.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 136.0, 130.0, 132.0, 147.0, 131.0, 133.0, 141.0, 214.0, 136.0], "value": 143.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 180.0, 172.0, 179.0, 174.0, 181.0, 176.0, 175.0, 175.0, 185.0], "value": 178.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 77.0, 78.0, 71.0, 72.0, 73.0, 72.0, 73.0, 75.0], "value": 74.1, "unit": "score"}], "name": "kraken", "value": 1604.7, "alertThreshold": 2.0}]} 04:28:42 INFO - Return code: 0 04:28:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:28:42 ERROR - # TBPL SUCCESS # 04:28:42 INFO - Running post-action listener: _resource_record_post_action 04:28:42 INFO - Running post-run listener: _resource_record_post_run 04:28:43 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 521129984; Read time: 0; Write time: 436724 04:28:43 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234889216; Read time: 0; Write time: 267680 04:28:43 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 286240768; Read time: 0; Write time: 169044 04:28:43 INFO - Running post-run listener: _upload_blobber_files 04:28:43 INFO - Blob upload gear active. 04:28:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:28:43 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:43 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:43 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:44 INFO - (blobuploader) - INFO - Open directory for files ... 04:28:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:28:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:28:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:28:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:28:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:28:45 INFO - (blobuploader) - INFO - Done attempting. 04:28:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:28:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:28:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:28:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:28:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:28:45 INFO - (blobuploader) - INFO - Done attempting. 04:28:45 INFO - (blobuploader) - INFO - Iteration through files over. 04:28:45 INFO - Return code: 0 04:28:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:28:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:28:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/40046dd0d44d66730735b70e46bbdca409b346e5f09ebbf168f9985313914a7189106608cb170ca72db280ada177d06f600603fde07c3b71d5c014e9adc3c15b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1e2b10458b77f5816b4d0d4128fb4c0f15a8eea0fa0c64cf2191ddd56443914e126494635915646ea038d7045ce7c2c858d97c22e9491e1a38e46ef02ad381a6"} 04:28:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:28:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:28:45 INFO - Contents: 04:28:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/40046dd0d44d66730735b70e46bbdca409b346e5f09ebbf168f9985313914a7189106608cb170ca72db280ada177d06f600603fde07c3b71d5c014e9adc3c15b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1e2b10458b77f5816b4d0d4128fb4c0f15a8eea0fa0c64cf2191ddd56443914e126494635915646ea038d7045ce7c2c858d97c22e9491e1a38e46ef02ad381a6"} 04:28:45 INFO - Running post-run listener: copy_logs_to_upload_dir 04:28:45 INFO - Copying logs to upload dir... 04:28:45 INFO - mkdir: /builds/slave/test/build/upload/logs 04:28:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.760624 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-04-29 04:28:45.002013) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 04:28:45.005043) ========= 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=826874ccc97bd7bf541b4875000001d5-1461915075.292191-1940632884 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/40046dd0d44d66730735b70e46bbdca409b346e5f09ebbf168f9985313914a7189106608cb170ca72db280ada177d06f600603fde07c3b71d5c014e9adc3c15b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1e2b10458b77f5816b4d0d4128fb4c0f15a8eea0fa0c64cf2191ddd56443914e126494635915646ea038d7045ce7c2c858d97c22e9491e1a38e46ef02ad381a6"} 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.011395 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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/40046dd0d44d66730735b70e46bbdca409b346e5f09ebbf168f9985313914a7189106608cb170ca72db280ada177d06f600603fde07c3b71d5c014e9adc3c15b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1e2b10458b77f5816b4d0d4128fb4c0f15a8eea0fa0c64cf2191ddd56443914e126494635915646ea038d7045ce7c2c858d97c22e9491e1a38e46ef02ad381a6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 04:28:45.031741) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 04:28:45.032446) ========= 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=826874ccc97bd7bf541b4875000001d5-1461915075.292191-1940632884 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004484 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 04:28:45.117064) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 04:28:45.117769) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 04:28:45.118366) ========= ========= Total master_lag: 0.21 =========