builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-041 starttime: 1462793016.87 results: success (0) buildid: 20160509024751 builduid: 991189a231734b41ad920f1637f0b2f5 revision: 7adbdf0fce9ac43118938d8e3dc6c0f500a2ffce ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 04:23:36.869517) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 04:23:36.869912) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 04:23:36.870184) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 04:23:36.883939) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 04:23:36.884201) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1462792983.479185-972499090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-09 04:23:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.0M=0s 2016-05-09 04:23:37 (43.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.145433 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 04:23:37.040848) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 04:23:37.041155) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1462792983.479185-972499090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018418 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 04:23:37.091351) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-09 04:23:37.091707) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7adbdf0fce9ac43118938d8e3dc6c0f500a2ffce --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 7adbdf0fce9ac43118938d8e3dc6c0f500a2ffce --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=8c6b6742ce8f6f39ef4ce27d000001f1-1462792983.479185-972499090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-09 04:23:37,502 truncating revision to first 12 chars 2016-05-09 04:23:37,502 Setting DEBUG logging. 2016-05-09 04:23:37,502 attempt 1/10 2016-05-09 04:23:37,502 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7adbdf0fce9a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 04:23:38,659 unpacking tar archive at: mozilla-central-7adbdf0fce9a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.445457 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-09 04:23:38.630832) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 04:23:38.631130) ========= script_repo_revision: 7adbdf0fce9ac43118938d8e3dc6c0f500a2ffce ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 04:23:38.631520) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 04:23:38.631781) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 04:23:38.643114) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-09 04:23:38.643384) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1462792983.479185-972499090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:23:39 INFO - MultiFileLogger online at 20160509 04:23:39 in /builds/slave/test 04:23:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:23:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:23:39 INFO - {'append_to_log': False, 04:23:39 INFO - 'base_work_dir': '/builds/slave/test', 04:23:39 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:23:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:23:39 INFO - 'branch': 'Firefox-Non-PGO', 04:23:39 INFO - 'buildbot_json_path': 'buildprops.json', 04:23:39 INFO - 'config_files': ('talos/linux_config.py',), 04:23:39 INFO - 'default_actions': ('clobber', 04:23:39 INFO - 'read-buildbot-config', 04:23:39 INFO - 'download-and-extract', 04:23:39 INFO - 'populate-webroot', 04:23:39 INFO - 'create-virtualenv', 04:23:39 INFO - 'install', 04:23:39 INFO - 'run-tests'), 04:23:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:23:39 INFO - 'download_minidump_stackwalk': True, 04:23:39 INFO - 'download_symbols': 'ondemand', 04:23:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:23:39 INFO - 'tooltool.py': '/tools/tooltool.py', 04:23:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:23:39 INFO - '/tools/misc-python/virtualenv.py')}, 04:23:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:23:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:23:39 INFO - 'installer_path': 'installer.exe', 04:23:39 INFO - 'log_level': 'info', 04:23:39 INFO - 'log_name': 'talos', 04:23:39 INFO - 'log_to_console': True, 04:23:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:23:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:23:39 INFO - 'opt_config_files': (), 04:23:39 INFO - 'pip_index': False, 04:23:39 INFO - 'sps_profile': False, 04:23:39 INFO - 'sps_profile_interval': 0, 04:23:39 INFO - 'suite': 'dromaeojs', 04:23:39 INFO - 'system_bits': '32', 04:23:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:23:39 INFO - 'title': 'talos-linux64-ix-041', 04:23:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:23:39 INFO - 'use_talos_json': True, 04:23:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:23:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:23:39 INFO - 'work_dir': 'build'} 04:23:39 INFO - ##### 04:23:39 INFO - ##### Running clobber step. 04:23:39 INFO - ##### 04:23:39 INFO - Running pre-action listener: _resource_record_pre_action 04:23:39 INFO - Running main action method: clobber 04:23:39 INFO - rmtree: /builds/slave/test/build 04:23:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:23:40 INFO - Running post-action listener: _resource_record_post_action 04:23:40 INFO - ##### 04:23:40 INFO - ##### Finished clobber step (success) 04:23:40 INFO - ##### 04:23:40 INFO - ##### 04:23:40 INFO - ##### Running read-buildbot-config step. 04:23:40 INFO - ##### 04:23:40 INFO - Running pre-action listener: _resource_record_pre_action 04:23:40 INFO - Running main action method: read_buildbot_config 04:23:40 INFO - Using buildbot properties: 04:23:40 INFO - { 04:23:40 INFO - "project": "", 04:23:40 INFO - "product": "firefox", 04:23:40 INFO - "script_repo_revision": "production", 04:23:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:23:40 INFO - "repository": "", 04:23:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:23:40 INFO - "buildid": "20160509024751", 04:23:40 INFO - "pgo_build": "False", 04:23:40 INFO - "basedir": "/builds/slave/test", 04:23:40 INFO - "buildnumber": 501, 04:23:40 INFO - "slavename": "talos-linux64-ix-041", 04:23:40 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:23:40 INFO - "platform": "ubuntu64_hw", 04:23:40 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:23:40 INFO - "branch": "mozilla-central", 04:23:40 INFO - "repo_path": "mozilla-central", 04:23:40 INFO - "revision": "7adbdf0fce9ac43118938d8e3dc6c0f500a2ffce", 04:23:40 INFO - "stage_platform": "linux64", 04:23:40 INFO - "builduid": "991189a231734b41ad920f1637f0b2f5", 04:23:40 INFO - "slavebuilddir": "test" 04:23:40 INFO - } 04:23:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/M4wkJiVKQDa5z1MyGphD2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 04:23:40 INFO - Running post-action listener: _resource_record_post_action 04:23:40 INFO - ##### 04:23:40 INFO - ##### Finished read-buildbot-config step (success) 04:23:40 INFO - ##### 04:23:40 INFO - ##### 04:23:40 INFO - ##### Running download-and-extract step. 04:23:40 INFO - ##### 04:23:40 INFO - Running pre-action listener: _resource_record_pre_action 04:23:40 INFO - Running main action method: download_and_extract 04:23:40 INFO - mkdir: /builds/slave/test/build/tests 04:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:40 INFO - https://queue.taskcluster.net/v1/task/M4wkJiVKQDa5z1MyGphD2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:23:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4wkJiVKQDa5z1MyGphD2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:23:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4wkJiVKQDa5z1MyGphD2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:23:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4wkJiVKQDa5z1MyGphD2A/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:23:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4wkJiVKQDa5z1MyGphD2A/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:23:41 INFO - Downloaded 1361 bytes. 04:23:41 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:23:41 INFO - Using the following test package requirements: 04:23:41 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:23:41 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:23:41 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:23:41 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:41 INFO - u'jsshell-linux-x86_64.zip'], 04:23:41 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:23:41 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:23:41 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:23:41 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:23:41 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:23:41 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:23:41 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:23:41 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:23:41 INFO - https://queue.taskcluster.net/v1/task/M4wkJiVKQDa5z1MyGphD2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:23:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4wkJiVKQDa5z1MyGphD2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:23:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4wkJiVKQDa5z1MyGphD2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:23:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4wkJiVKQDa5z1MyGphD2A/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:23:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4wkJiVKQDa5z1MyGphD2A/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:23:44 INFO - Downloaded 22322613 bytes. 04:23:44 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:23:44 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:23:45 INFO - Return code: 0 04:23:45 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:23:45 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:23:45 INFO - https://queue.taskcluster.net/v1/task/M4wkJiVKQDa5z1MyGphD2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:23:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4wkJiVKQDa5z1MyGphD2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:23:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4wkJiVKQDa5z1MyGphD2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:23:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4wkJiVKQDa5z1MyGphD2A/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:23:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4wkJiVKQDa5z1MyGphD2A/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:23:46 INFO - Downloaded 22322613 bytes. 04:23:46 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:23:46 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:23:48 INFO - Return code: 0 04:23:48 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:23:48 INFO - https://queue.taskcluster.net/v1/task/M4wkJiVKQDa5z1MyGphD2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:23:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4wkJiVKQDa5z1MyGphD2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:23:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4wkJiVKQDa5z1MyGphD2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:23:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4wkJiVKQDa5z1MyGphD2A/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:23:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4wkJiVKQDa5z1MyGphD2A/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:23:49 INFO - Downloaded 10840152 bytes. 04:23:49 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:23:49 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:23:49 INFO - Return code: 0 04:23: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:23:49 INFO - https://queue.taskcluster.net/v1/task/M4wkJiVKQDa5z1MyGphD2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:23:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4wkJiVKQDa5z1MyGphD2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:23:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4wkJiVKQDa5z1MyGphD2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:23:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4wkJiVKQDa5z1MyGphD2A/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:23:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4wkJiVKQDa5z1MyGphD2A/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:23:50 INFO - Downloaded 54853767 bytes. 04:23:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M4wkJiVKQDa5z1MyGphD2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:23:50 INFO - mkdir: /builds/slave/test/properties 04:23:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:23:50 INFO - Writing to file /builds/slave/test/properties/build_url 04:23:50 INFO - Contents: 04:23:50 INFO - build_url:https://queue.taskcluster.net/v1/task/M4wkJiVKQDa5z1MyGphD2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:23:51 INFO - Running post-action listener: _resource_record_post_action 04:23:51 INFO - Running post-action listener: set_extra_try_arguments 04:23:51 INFO - ##### 04:23:51 INFO - ##### Finished download-and-extract step (success) 04:23:51 INFO - ##### 04:23:51 INFO - ##### 04:23:51 INFO - ##### Running populate-webroot step. 04:23:51 INFO - ##### 04:23:51 INFO - Running pre-action listener: _resource_record_pre_action 04:23:51 INFO - Running main action method: populate_webroot 04:23:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:23:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:23:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:23:51 INFO - '--tppagecycles', 04:23:51 INFO - '7'], 04:23:51 INFO - 'tests': ['tsvgm']}}, 04:23:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:23:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:23:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:23:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:23:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:23:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:23:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:51 INFO - 'talos_options': ['--disable-e10s'], 04:23:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:23:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:23:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:51 INFO - 'talos_options': ['--disable-e10s'], 04:23:51 INFO - 'tests': ['damp', 'tps']}, 04:23:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:51 INFO - 'tests': ['damp', 'tps']}, 04:23:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:23:51 INFO - 'tests': ['dromaeo_dom']}, 04:23:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:23:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:23:51 INFO - 'tests': ['a11yr', 04:23:51 INFO - 'ts_paint', 04:23:51 INFO - 'tpaint', 04:23:51 INFO - 'sessionrestore', 04:23:51 INFO - 'sessionrestore_no_auto_restore', 04:23:51 INFO - 'tabpaint']}, 04:23:51 INFO - 'other-e10s': {'tests': ['a11yr', 04:23:51 INFO - 'ts_paint', 04:23:51 INFO - 'tpaint', 04:23:51 INFO - 'sessionrestore', 04:23:51 INFO - 'sessionrestore_no_auto_restore', 04:23:51 INFO - 'tabpaint']}, 04:23:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:23:51 INFO - 'ts_paint', 04:23:51 INFO - 'tpaint', 04:23:51 INFO - 'sessionrestore', 04:23:51 INFO - 'sessionrestore_no_auto_restore', 04:23:51 INFO - 'tabpaint']}, 04:23:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:23:51 INFO - 'ts_paint', 04:23:51 INFO - 'tpaint', 04:23:51 INFO - 'sessionrestore', 04:23:51 INFO - 'sessionrestore_no_auto_restore', 04:23:51 INFO - 'tabpaint']}, 04:23:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:23:51 INFO - 'tests': ['a11yr', 04:23:51 INFO - 'ts_paint', 04:23:51 INFO - 'tpaint', 04:23:51 INFO - 'sessionrestore', 04:23:51 INFO - 'sessionrestore_no_auto_restore', 04:23:51 INFO - 'tabpaint']}, 04:23:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:23:51 INFO - 'tests': ['a11yr', 04:23:51 INFO - 'ts_paint', 04:23:51 INFO - 'tpaint', 04:23:51 INFO - 'sessionrestore', 04:23:51 INFO - 'sessionrestore_no_auto_restore', 04:23:51 INFO - 'tabpaint']}, 04:23:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:23:51 INFO - 'tests': ['tsvgx', 04:23:51 INFO - 'tsvgr_opacity', 04:23:51 INFO - 'tart', 04:23:51 INFO - 'tscrollx', 04:23:51 INFO - 'cart']}, 04:23:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:23:51 INFO - 'tsvgr_opacity', 04:23:51 INFO - 'tart', 04:23:51 INFO - 'tscrollx', 04:23:51 INFO - 'cart']}, 04:23:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:51 INFO - 'talos_options': ['--disable-e10s'], 04:23:51 INFO - 'tests': ['tp5o']}, 04:23:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:51 INFO - 'tests': ['tp5o']}, 04:23:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:51 INFO - 'talos_options': ['--disable-e10s', 04:23:51 INFO - '--xperf_path', 04:23:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:23:51 INFO - 'tests': ['tp5n']}, 04:23:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:51 INFO - 'talos_options': ['--xperf_path', 04:23:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:23:51 INFO - 'tests': ['tp5n']}}, 04:23:51 INFO - 'talos.zip': {'path': '', 04:23:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:23:51 INFO - Running post-action listener: _resource_record_post_action 04:23:51 INFO - ##### 04:23:51 INFO - ##### Finished populate-webroot step (success) 04:23:51 INFO - ##### 04:23:51 INFO - ##### 04:23:51 INFO - ##### Running create-virtualenv step. 04:23:51 INFO - ##### 04:23:51 INFO - Running pre-action listener: _resource_record_pre_action 04:23:51 INFO - Running main action method: create_virtualenv 04:23:51 INFO - Creating virtualenv /builds/slave/test/build/venv 04:23:51 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:23:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:23:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:23:51 INFO - Using real prefix '/usr' 04:23:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:23:52 INFO - Installing distribute.............................................................................................................................................................................................done. 04:23:54 INFO - Installing pip.................done. 04:23:54 INFO - Return code: 0 04:23:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:54 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 0x7f3a11678f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1480770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150f9c0>, '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 0x15108c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1510d50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1462792983.479185-972499090', '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:23:54 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:23:54 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:23:54 INFO - Using env: {'DISPLAY': ':0', 04:23:54 INFO - 'HOME': '/home/cltbld', 04:23:54 INFO - 'LANG': 'en_US.UTF-8', 04:23:54 INFO - 'LANGUAGE': 'en_US:en', 04:23:54 INFO - 'LOGNAME': 'cltbld', 04:23:54 INFO - 'MAIL': '/var/mail/cltbld', 04:23:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:54 INFO - 'MOZ_NO_REMOTE': '1', 04:23:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:54 INFO - 'NO_EM_RESTART': '1', 04:23:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:54 INFO - 'PWD': '/builds/slave/test', 04:23:54 INFO - 'SHELL': '/bin/bash', 04:23:54 INFO - 'SHLVL': '1', 04:23:54 INFO - 'TERM': 'linux', 04:23:54 INFO - 'TMOUT': '86400', 04:23:54 INFO - 'USER': 'cltbld', 04:23:54 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1462792983.479185-972499090', 04:23:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:54 INFO - '_': '/tools/buildbot/bin/python'} 04:23:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:54 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:23:54 INFO - Cleaning up... 04:23:54 INFO - Return code: 0 04:23:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:54 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 0x7f3a11678f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1480770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150f9c0>, '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 0x15108c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1510d50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1462792983.479185-972499090', '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:23:54 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:23:54 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:23:54 INFO - Using env: {'DISPLAY': ':0', 04:23:54 INFO - 'HOME': '/home/cltbld', 04:23:54 INFO - 'LANG': 'en_US.UTF-8', 04:23:54 INFO - 'LANGUAGE': 'en_US:en', 04:23:54 INFO - 'LOGNAME': 'cltbld', 04:23:54 INFO - 'MAIL': '/var/mail/cltbld', 04:23:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:54 INFO - 'MOZ_NO_REMOTE': '1', 04:23:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:54 INFO - 'NO_EM_RESTART': '1', 04:23:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:54 INFO - 'PWD': '/builds/slave/test', 04:23:54 INFO - 'SHELL': '/bin/bash', 04:23:54 INFO - 'SHLVL': '1', 04:23:54 INFO - 'TERM': 'linux', 04:23:54 INFO - 'TMOUT': '86400', 04:23:54 INFO - 'USER': 'cltbld', 04:23:54 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1462792983.479185-972499090', 04:23:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:54 INFO - '_': '/tools/buildbot/bin/python'} 04:23:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:54 INFO - Downloading/unpacking psutil>=0.7.1 04:23:54 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:23:54 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:23:54 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:23:54 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:23:54 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:23:54 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:23:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:23:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:23:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:23:56 INFO - Installing collected packages: psutil 04:23:56 INFO - Running setup.py install for psutil 04:23:56 INFO - building 'psutil._psutil_linux' extension 04:23:56 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:23:56 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:23:56 INFO - building 'psutil._psutil_posix' extension 04:23:56 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:23:56 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:23:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:23:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:23:57 INFO - Successfully installed psutil 04:23:57 INFO - Cleaning up... 04:23:57 INFO - Return code: 0 04:23:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:23:57 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:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:57 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:23:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:57 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 0x7f3a11678f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1480770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150f9c0>, '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 0x15108c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1510d50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1462792983.479185-972499090', '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:23:57 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:23:57 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:23:57 INFO - Using env: {'DISPLAY': ':0', 04:23:57 INFO - 'HOME': '/home/cltbld', 04:23:57 INFO - 'LANG': 'en_US.UTF-8', 04:23:57 INFO - 'LANGUAGE': 'en_US:en', 04:23:57 INFO - 'LOGNAME': 'cltbld', 04:23:57 INFO - 'MAIL': '/var/mail/cltbld', 04:23:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:57 INFO - 'MOZ_NO_REMOTE': '1', 04:23:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:57 INFO - 'NO_EM_RESTART': '1', 04:23:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:57 INFO - 'PWD': '/builds/slave/test', 04:23:57 INFO - 'SHELL': '/bin/bash', 04:23:57 INFO - 'SHLVL': '1', 04:23:57 INFO - 'TERM': 'linux', 04:23:57 INFO - 'TMOUT': '86400', 04:23:57 INFO - 'USER': 'cltbld', 04:23:57 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1462792983.479185-972499090', 04:23:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:57 INFO - '_': '/tools/buildbot/bin/python'} 04:23:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:23:57 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:23:57 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:23:57 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:23:57 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:23:57 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:23:57 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:23:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:23:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:23:59 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:23:59 INFO - Installing collected packages: mozsystemmonitor 04:23:59 INFO - Running setup.py install for mozsystemmonitor 04:23:59 INFO - Successfully installed mozsystemmonitor 04:23:59 INFO - Cleaning up... 04:23:59 INFO - Return code: 0 04:23:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:23:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:59 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 0x7f3a11678f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1480770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150f9c0>, '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 0x15108c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1510d50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1462792983.479185-972499090', '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:23:59 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:23:59 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:23:59 INFO - Using env: {'DISPLAY': ':0', 04:23:59 INFO - 'HOME': '/home/cltbld', 04:23:59 INFO - 'LANG': 'en_US.UTF-8', 04:23:59 INFO - 'LANGUAGE': 'en_US:en', 04:23:59 INFO - 'LOGNAME': 'cltbld', 04:23:59 INFO - 'MAIL': '/var/mail/cltbld', 04:23:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:59 INFO - 'MOZ_NO_REMOTE': '1', 04:23:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:59 INFO - 'NO_EM_RESTART': '1', 04:23:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:59 INFO - 'PWD': '/builds/slave/test', 04:23:59 INFO - 'SHELL': '/bin/bash', 04:23:59 INFO - 'SHLVL': '1', 04:23:59 INFO - 'TERM': 'linux', 04:23:59 INFO - 'TMOUT': '86400', 04:23:59 INFO - 'USER': 'cltbld', 04:23:59 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1462792983.479185-972499090', 04:23:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:59 INFO - '_': '/tools/buildbot/bin/python'} 04:23:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:59 INFO - Downloading/unpacking blobuploader==1.2.4 04:23:59 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:23:59 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:23:59 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:23:59 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:23:59 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:23:59 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:24:01 INFO - Downloading blobuploader-1.2.4.tar.gz 04:24:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:24:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:24:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:24:02 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:24:02 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:24:02 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:24:02 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:24:02 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:24:02 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:24:02 INFO - Downloading docopt-0.6.1.tar.gz 04:24:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:24:02 INFO - Installing collected packages: blobuploader, requests, docopt 04:24:02 INFO - Running setup.py install for blobuploader 04:24:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:24:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:24:02 INFO - Running setup.py install for requests 04:24:02 INFO - Running setup.py install for docopt 04:24:02 INFO - Successfully installed blobuploader requests docopt 04:24:02 INFO - Cleaning up... 04:24:03 INFO - Return code: 0 04:24:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:24:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:03 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 0x7f3a11678f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1480770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150f9c0>, '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 0x15108c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1510d50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1462792983.479185-972499090', '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:24:03 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:24:03 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:24:03 INFO - Using env: {'DISPLAY': ':0', 04:24:03 INFO - 'HOME': '/home/cltbld', 04:24:03 INFO - 'LANG': 'en_US.UTF-8', 04:24:03 INFO - 'LANGUAGE': 'en_US:en', 04:24:03 INFO - 'LOGNAME': 'cltbld', 04:24:03 INFO - 'MAIL': '/var/mail/cltbld', 04:24:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:03 INFO - 'MOZ_NO_REMOTE': '1', 04:24:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:03 INFO - 'NO_EM_RESTART': '1', 04:24:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:03 INFO - 'PWD': '/builds/slave/test', 04:24:03 INFO - 'SHELL': '/bin/bash', 04:24:03 INFO - 'SHLVL': '1', 04:24:03 INFO - 'TERM': 'linux', 04:24:03 INFO - 'TMOUT': '86400', 04:24:03 INFO - 'USER': 'cltbld', 04:24:03 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1462792983.479185-972499090', 04:24:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:03 INFO - '_': '/tools/buildbot/bin/python'} 04:24:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:24:03 INFO - Running setup.py (path:/tmp/pip-9ImqN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:24:03 INFO - Running setup.py (path:/tmp/pip-KHtAt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:24:03 INFO - Running setup.py (path:/tmp/pip-8y7N0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:24:03 INFO - Running setup.py (path:/tmp/pip-5HaDfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:24:03 INFO - Running setup.py (path:/tmp/pip-671NMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:24:03 INFO - Running setup.py (path:/tmp/pip-yHVUOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:24:03 INFO - Running setup.py (path:/tmp/pip-vN1aF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:24:03 INFO - Running setup.py (path:/tmp/pip-QMpyfw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:24:03 INFO - Running setup.py (path:/tmp/pip-azDmUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:24:03 INFO - Running setup.py (path:/tmp/pip-DiEcQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:24:03 INFO - Running setup.py (path:/tmp/pip-wB7z7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:24:04 INFO - Running setup.py (path:/tmp/pip-RYWroe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:24:04 INFO - Running setup.py (path:/tmp/pip-dMLSyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:24:04 INFO - Running setup.py (path:/tmp/pip-aEA7th-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:24:04 INFO - Running setup.py (path:/tmp/pip-k2nIks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:24:04 INFO - Running setup.py (path:/tmp/pip-EUjxpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:24:04 INFO - Running setup.py (path:/tmp/pip-R96iu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:24:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:24:04 INFO - Running setup.py install for manifestparser 04:24:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:24:04 INFO - Running setup.py install for mozcrash 04:24:04 INFO - Running setup.py install for mozdebug 04:24:04 INFO - Running setup.py install for mozdevice 04:24:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:24:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:24:04 INFO - Running setup.py install for mozfile 04:24:05 INFO - Running setup.py install for mozhttpd 04:24:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:24:05 INFO - Running setup.py install for mozinfo 04:24:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:24:05 INFO - Running setup.py install for mozInstall 04:24:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:24:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:24:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:24:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:24:05 INFO - Running setup.py install for mozleak 04:24:05 INFO - Running setup.py install for mozlog 04:24:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:24:05 INFO - Running setup.py install for moznetwork 04:24:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:24:05 INFO - Running setup.py install for mozprocess 04:24:05 INFO - Running setup.py install for mozprofile 04:24:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:24:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:24:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:24:05 INFO - Running setup.py install for mozrunner 04:24:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:24:05 INFO - Running setup.py install for mozscreenshot 04:24:06 INFO - Running setup.py install for moztest 04:24:06 INFO - Running setup.py install for mozversion 04:24:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:24:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:24:06 INFO - Cleaning up... 04:24:06 INFO - Return code: 0 04:24:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:24:06 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:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:06 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:24:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:06 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 0x7f3a11678f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1480770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150f9c0>, '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 0x15108c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1510d50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1462792983.479185-972499090', '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:24:06 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:24:06 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:24:06 INFO - Using env: {'DISPLAY': ':0', 04:24:06 INFO - 'HOME': '/home/cltbld', 04:24:06 INFO - 'LANG': 'en_US.UTF-8', 04:24:06 INFO - 'LANGUAGE': 'en_US:en', 04:24:06 INFO - 'LOGNAME': 'cltbld', 04:24:06 INFO - 'MAIL': '/var/mail/cltbld', 04:24:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:06 INFO - 'MOZ_NO_REMOTE': '1', 04:24:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:06 INFO - 'NO_EM_RESTART': '1', 04:24:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:06 INFO - 'PWD': '/builds/slave/test', 04:24:06 INFO - 'SHELL': '/bin/bash', 04:24:06 INFO - 'SHLVL': '1', 04:24:06 INFO - 'TERM': 'linux', 04:24:06 INFO - 'TMOUT': '86400', 04:24:06 INFO - 'USER': 'cltbld', 04:24:06 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1462792983.479185-972499090', 04:24:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:06 INFO - '_': '/tools/buildbot/bin/python'} 04:24:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:24:06 INFO - Running setup.py (path:/tmp/pip-abHLn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:24:06 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:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:24:06 INFO - Running setup.py (path:/tmp/pip-qbLQxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:24:06 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:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:24:06 INFO - Running setup.py (path:/tmp/pip-1lmTUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:24:06 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:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:24:06 INFO - Running setup.py (path:/tmp/pip-IYYnSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:24:06 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:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:24:06 INFO - Running setup.py (path:/tmp/pip-ud7iHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:24:06 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:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:24:06 INFO - Running setup.py (path:/tmp/pip-Vp3QCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:24:06 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:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:24:06 INFO - Running setup.py (path:/tmp/pip-ZdEy_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:24:07 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:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:24:07 INFO - Running setup.py (path:/tmp/pip-g83ALQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:24:07 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:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:24:07 INFO - Running setup.py (path:/tmp/pip-q6A5Zf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:24:07 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:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:24:07 INFO - Running setup.py (path:/tmp/pip-FVF59T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:24:07 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:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:24:07 INFO - Running setup.py (path:/tmp/pip-29TxWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:24:07 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:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:24:07 INFO - Running setup.py (path:/tmp/pip-dqLegT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:24:07 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:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:24:07 INFO - Running setup.py (path:/tmp/pip-CK3Fie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:24:07 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:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:24:07 INFO - Running setup.py (path:/tmp/pip-MLqtB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:24:07 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:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:24:07 INFO - Running setup.py (path:/tmp/pip-nt9KwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:24:07 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:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:24:07 INFO - Running setup.py (path:/tmp/pip-MhAu7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:24:07 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:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:24:07 INFO - Running setup.py (path:/tmp/pip-5CgyrI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:24:07 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:24:07 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:24:07 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:24:07 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:24:07 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:24:07 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:24:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:24:07 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:24:07 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:24:07 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:24:07 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:24:07 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:24:07 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:24:09 INFO - Downloading blessings-1.6.tar.gz 04:24:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:24:09 INFO - Installing collected packages: blessings 04:24:09 INFO - Running setup.py install for blessings 04:24:09 INFO - Successfully installed blessings 04:24:09 INFO - Cleaning up... 04:24:09 INFO - Return code: 0 04:24:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:24:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:24:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:24:10 INFO - Reading from file tmpfile_stdout 04:24:10 INFO - Current package versions: 04:24:10 INFO - argparse == 1.2.1 04:24:10 INFO - blessings == 1.6 04:24:10 INFO - blobuploader == 1.2.4 04:24:10 INFO - docopt == 0.6.1 04:24:10 INFO - manifestparser == 1.1 04:24:10 INFO - mozInstall == 1.12 04:24:10 INFO - mozcrash == 0.17 04:24:10 INFO - mozdebug == 0.1 04:24:10 INFO - mozdevice == 0.48 04:24:10 INFO - mozfile == 1.2 04:24:10 INFO - mozhttpd == 0.7 04:24:10 INFO - mozinfo == 0.9 04:24:10 INFO - mozleak == 0.1 04:24:10 INFO - mozlog == 3.1 04:24:10 INFO - moznetwork == 0.27 04:24:10 INFO - mozprocess == 0.22 04:24:10 INFO - mozprofile == 0.28 04:24:10 INFO - mozrunner == 6.11 04:24:10 INFO - mozscreenshot == 0.1 04:24:10 INFO - mozsystemmonitor == 0.0 04:24:10 INFO - moztest == 0.7 04:24:10 INFO - mozversion == 1.4 04:24:10 INFO - psutil == 3.1.1 04:24:10 INFO - requests == 1.2.3 04:24:10 INFO - wsgiref == 0.1.2 04:24:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:24: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:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24: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:24:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:10 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 0x7f3a11678f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1480770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150f9c0>, '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 0x15108c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1510d50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1462792983.479185-972499090', '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:24:10 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:24:10 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:24:10 INFO - Using env: {'DISPLAY': ':0', 04:24:10 INFO - 'HOME': '/home/cltbld', 04:24:10 INFO - 'LANG': 'en_US.UTF-8', 04:24:10 INFO - 'LANGUAGE': 'en_US:en', 04:24:10 INFO - 'LOGNAME': 'cltbld', 04:24:10 INFO - 'MAIL': '/var/mail/cltbld', 04:24:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:10 INFO - 'MOZ_NO_REMOTE': '1', 04:24:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:10 INFO - 'NO_EM_RESTART': '1', 04:24:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:10 INFO - 'PWD': '/builds/slave/test', 04:24:10 INFO - 'SHELL': '/bin/bash', 04:24:10 INFO - 'SHLVL': '1', 04:24:10 INFO - 'TERM': 'linux', 04:24:10 INFO - 'TMOUT': '86400', 04:24:10 INFO - 'USER': 'cltbld', 04:24:10 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1462792983.479185-972499090', 04:24:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:10 INFO - '_': '/tools/buildbot/bin/python'} 04:24:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:10 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:24:10 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:24:10 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:24:10 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:24:10 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:24:10 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:24:10 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:24:10 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:24:10 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:24:10 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:24:10 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:24:10 INFO - Cleaning up... 04:24:10 INFO - Return code: 0 04:24:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:24: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:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24: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:24:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:10 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 0x7f3a11678f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1480770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150f9c0>, '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 0x15108c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1510d50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1462792983.479185-972499090', '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:24:10 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:24:10 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:24:10 INFO - Using env: {'DISPLAY': ':0', 04:24:10 INFO - 'HOME': '/home/cltbld', 04:24:10 INFO - 'LANG': 'en_US.UTF-8', 04:24:10 INFO - 'LANGUAGE': 'en_US:en', 04:24:10 INFO - 'LOGNAME': 'cltbld', 04:24:10 INFO - 'MAIL': '/var/mail/cltbld', 04:24:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:10 INFO - 'MOZ_NO_REMOTE': '1', 04:24:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:10 INFO - 'NO_EM_RESTART': '1', 04:24:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:10 INFO - 'PWD': '/builds/slave/test', 04:24:10 INFO - 'SHELL': '/bin/bash', 04:24:10 INFO - 'SHLVL': '1', 04:24:10 INFO - 'TERM': 'linux', 04:24:10 INFO - 'TMOUT': '86400', 04:24:10 INFO - 'USER': 'cltbld', 04:24:10 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1462792983.479185-972499090', 04:24:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:10 INFO - '_': '/tools/buildbot/bin/python'} 04:24:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:10 INFO - Downloading/unpacking jsonschema 04:24:10 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:24:10 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:24:10 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:24:10 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:24:10 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:24:10 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:24:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:24:12 INFO - Downloading/unpacking functools32 (from jsonschema) 04:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:12 INFO - Downloading functools32-3.2.3-2.tar.gz 04:24:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:24:12 INFO - warning: no files found matching '*.txt' 04:24:12 INFO - no previously-included directories found matching 'build' 04:24:12 INFO - no previously-included directories found matching 'dist' 04:24:12 INFO - no previously-included directories found matching '.git*' 04:24:12 INFO - Installing collected packages: jsonschema, functools32 04:24:12 INFO - Running setup.py install for functools32 04:24:12 INFO - warning: no files found matching '*.txt' 04:24:12 INFO - no previously-included directories found matching 'build' 04:24:12 INFO - no previously-included directories found matching 'dist' 04:24:12 INFO - no previously-included directories found matching '.git*' 04:24:12 INFO - Successfully installed jsonschema functools32 04:24:12 INFO - Cleaning up... 04:24:12 INFO - Return code: 0 04:24:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:24:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3a11678f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1480770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150f9c0>, '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 0x15108c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1510d50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1462792983.479185-972499090', '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:24:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:24:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:24:12 INFO - Using env: {'DISPLAY': ':0', 04:24:12 INFO - 'HOME': '/home/cltbld', 04:24:12 INFO - 'LANG': 'en_US.UTF-8', 04:24:12 INFO - 'LANGUAGE': 'en_US:en', 04:24:12 INFO - 'LOGNAME': 'cltbld', 04:24:12 INFO - 'MAIL': '/var/mail/cltbld', 04:24:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:12 INFO - 'MOZ_NO_REMOTE': '1', 04:24:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:12 INFO - 'NO_EM_RESTART': '1', 04:24:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:12 INFO - 'PWD': '/builds/slave/test', 04:24:12 INFO - 'SHELL': '/bin/bash', 04:24:12 INFO - 'SHLVL': '1', 04:24:12 INFO - 'TERM': 'linux', 04:24:12 INFO - 'TMOUT': '86400', 04:24:12 INFO - 'USER': 'cltbld', 04:24:12 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1462792983.479185-972499090', 04:24:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:12 INFO - '_': '/tools/buildbot/bin/python'} 04:24:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:13 INFO - Downloading/unpacking flake8 04:24:13 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:24:13 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:24:13 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:24:13 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:24:13 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:24:13 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:24:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:24:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:24:15 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:24:15 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:24:15 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:24:15 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:24:15 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:24:15 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:24:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:24:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:24:15 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:24:15 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:24:15 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:24:15 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:24:15 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:24:15 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:24:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:24:15 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:24:15 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:24:15 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:24:15 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:24:15 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:24:15 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:24:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:24:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:24:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:24:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:24:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:24:15 INFO - no previously-included directories found matching 'docs/_build' 04:24:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:24:15 INFO - Running setup.py install for pep8 04:24:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:24:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:24:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:24:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:24:15 INFO - no previously-included directories found matching 'docs/_build' 04:24:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:24:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:24:15 INFO - Cleaning up... 04:24:16 INFO - Return code: 0 04:24:16 INFO - Running post-action listener: _resource_record_post_action 04:24:16 INFO - Running post-action listener: _start_resource_monitoring 04:24:16 INFO - Starting resource monitoring. 04:24:16 INFO - ##### 04:24:16 INFO - ##### Finished create-virtualenv step (success) 04:24:16 INFO - ##### 04:24:16 INFO - ##### 04:24:16 INFO - ##### Running install step. 04:24:16 INFO - ##### 04:24:16 INFO - Running pre-action listener: _resource_record_pre_action 04:24:16 INFO - Running main action method: install 04:24:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:24:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:24:16 INFO - Reading from file tmpfile_stdout 04:24:16 INFO - Detecting whether we're running mozinstall >=1.0... 04:24:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:24:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:24:16 INFO - Reading from file tmpfile_stdout 04:24:16 INFO - Output received: 04:24:16 INFO - Usage: mozinstall [options] installer 04:24:16 INFO - Options: 04:24:16 INFO - -h, --help show this help message and exit 04:24:16 INFO - -d DEST, --destination=DEST 04:24:16 INFO - Directory to install application into. [default: 04:24:16 INFO - "/builds/slave/test"] 04:24:16 INFO - --app=APP Application being installed. [default: firefox] 04:24:16 INFO - mkdir: /builds/slave/test/build/application 04:24:16 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:24:16 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:24:32 INFO - Reading from file tmpfile_stdout 04:24:32 INFO - Output received: 04:24:32 INFO - /builds/slave/test/build/application/firefox/firefox 04:24:32 INFO - Running post-action listener: _resource_record_post_action 04:24:32 INFO - ##### 04:24:32 INFO - ##### Finished install step (success) 04:24:32 INFO - ##### 04:24:32 INFO - ##### 04:24:32 INFO - ##### Running run-tests step. 04:24:32 INFO - ##### 04:24:32 INFO - Running pre-action listener: _resource_record_pre_action 04:24:32 INFO - Running main action method: run_tests 04:24:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:24:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:24:32 INFO - Python 2.7.3 04:24:32 INFO - Return code: 0 04:24:32 INFO - grabbing minidump binary from tooltool 04:24: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:24:32 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 0x150f9c0>, '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 0x15108c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1510d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:24:32 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:24:32 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:24:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:24:32 INFO - Return code: 0 04:24:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:24:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:24:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:24:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:24:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:24:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:24:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:24:33 INFO - Return code: 0 04:24:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M4wkJiVKQDa5z1MyGphD2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:24:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M4wkJiVKQDa5z1MyGphD2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:24:33 INFO - Using env: {'DISPLAY': ':0', 04:24:33 INFO - 'HOME': '/home/cltbld', 04:24:33 INFO - 'LANG': 'en_US.UTF-8', 04:24:33 INFO - 'LANGUAGE': 'en_US:en', 04:24:33 INFO - 'LOGNAME': 'cltbld', 04:24:33 INFO - 'MAIL': '/var/mail/cltbld', 04:24:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:24:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:24:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:33 INFO - 'MOZ_NO_REMOTE': '1', 04:24:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:24:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:33 INFO - 'NO_EM_RESTART': '1', 04:24:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:33 INFO - 'PWD': '/builds/slave/test', 04:24:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:24:33 INFO - 'SHELL': '/bin/bash', 04:24:33 INFO - 'SHLVL': '1', 04:24:33 INFO - 'TERM': 'linux', 04:24:33 INFO - 'TMOUT': '86400', 04:24:33 INFO - 'USER': 'cltbld', 04:24:33 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1462792983.479185-972499090', 04:24:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:33 INFO - '_': '/tools/buildbot/bin/python'} 04:24:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M4wkJiVKQDa5z1MyGphD2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:24:33 INFO - mozversion application_buildid: 20160509024751 04:24:33 INFO - mozversion application_changeset: 7adbdf0fce9ac43118938d8e3dc6c0f500a2ffce 04:24:33 INFO - mozversion application_display_name: Nightly 04:24:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:24:33 INFO - mozversion application_name: Firefox 04:24:33 INFO - mozversion application_remotingname: firefox 04:24:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:24:33 INFO - mozversion application_vendor: Mozilla 04:24:33 INFO - mozversion application_version: 49.0a1 04:24:33 INFO - mozversion platform_buildid: 20160509024751 04:24:33 INFO - mozversion platform_changeset: 7adbdf0fce9ac43118938d8e3dc6c0f500a2ffce 04:24:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:24:33 INFO - mozversion platform_version: 49.0a1 04:24:33 INFO - using testdate: 1462793073 04:24:33 INFO - actual date: 1462793073 04:24:33 INFO - starting webserver on 'localhost:45322' 04:24:33 INFO - SUITE-START | Running 2 tests 04:24:33 INFO - TEST-START | dromaeo_css 04:24:33 INFO - operating with platform_type : linux_ 04:24:33 INFO - Initialising browser for dromaeo_css test... 04:24:33 INFO - TEST-INFO | started process 27129 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyF0KuY/profile http://localhost:45322/getInfo.html) 04:24:37 INFO - PROCESS | 27129 | __metrics Screen width/height:1600/1200 04:24:37 INFO - PROCESS | 27129 | colorDepth:24 04:24:37 INFO - PROCESS | 27129 | Browser inner width/height: 1024/697 04:24:37 INFO - PROCESS | 27129 | __metrics 04:24:38 ERROR - PROCESS | 27129 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:24:39 INFO - TEST-INFO | 27129: exit 0 04:24:39 INFO - Browser initialized. 04:24:39 INFO - Running cycle 1/1 for dromaeo_css test... 04:24:39 INFO - TEST-INFO | started process 27210 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyF0KuY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:24:51 INFO - PROCESS | 27210 | RSS: Main: 153509888 04:24:51 INFO - PROCESS | 27210 | 04:25:43 INFO - PROCESS | 27210 | 1462793143421 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:27:54 INFO - PROCESS | 27210 | Cycle 1(1): loaded http://localhost:45322/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45322/tests/dromaeo/cssquery-ext.html) 04:27:55 INFO - PROCESS | 27210 | RSS: Main: 240676864 04:27:55 INFO - PROCESS | 27210 | 04:30:58 INFO - PROCESS | 27210 | Cycle 1(1): loaded http://localhost:45322/tests/dromaeo/cssquery-ext.html (next: http://localhost:45322/tests/dromaeo/cssquery-jquery.html) 04:30:59 INFO - PROCESS | 27210 | RSS: Main: 236748800 04:30:59 INFO - PROCESS | 27210 | 04:34:01 INFO - PROCESS | 27210 | Cycle 1(1): loaded http://localhost:45322/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45322/tests/dromaeo/cssquery-mootools.html) 04:34:01 INFO - PROCESS | 27210 | RSS: Main: 228966400 04:34:01 INFO - PROCESS | 27210 | 04:37:04 INFO - PROCESS | 27210 | Cycle 1(1): loaded http://localhost:45322/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45322/tests/dromaeo/cssquery-prototype.html) 04:37:04 INFO - PROCESS | 27210 | RSS: Main: 226717696 04:37:04 INFO - PROCESS | 27210 | 04:40:07 INFO - PROCESS | 27210 | Cycle 1(1): loaded http://localhost:45322/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45322/tests/dromaeo/cssquery-yui.html) 04:40:08 INFO - PROCESS | 27210 | RSS: Main: 212516864 04:40:08 INFO - PROCESS | 27210 | 04:43:10 INFO - PROCESS | 27210 | Cycle 1(1): loaded http://localhost:45322/tests/dromaeo/cssquery-yui.html (next: http://localhost:45322/tests/dromaeo/cssquery-dojo.html) 04:43:11 INFO - PROCESS | 27210 | RSS: Main: 267591680 04:43:11 INFO - PROCESS | 27210 | 04:43:11 INFO - PROCESS | 27210 | __start_tp_report 04:43:11 INFO - PROCESS | 27210 | _x_x_mozilla_page_load 04:43:11 INFO - PROCESS | 27210 | _x_x_mozilla_page_load_details 04:43:11 INFO - PROCESS | 27210 | |i|pagename|runs| 04:43:11 INFO - PROCESS | 27210 | |0;dojo.html;2670.6127611496336;2672.8529930853806;2688.6235926970216;2708.891644334227;2717.9864100679492;4680.485146633876;4726.716397016182;4750.334953106568;4827.420709514859;4887.3890763654545;4759;4784.880377990543;4789.688670236441;4795.904081918359;4807.639427042968;4361.193179261831;4390.97804510977;4436.617971675875;4480.0367920897;4615.076984603076;4481.417415735949;4513.887152821189;4549.567791059844;4557.430321209848;4579.954200458003;4339.978300108511;4389.934150987738;4390.209762242795;4398.252297109499;4426.690131690783;4421.425214722098;4437.06821567468;4481.596656300949;4482.7758612069265;4485.708428952108;4453.198424283628;4470.173017991649;4472.575105364985;4473.955260447419;4517.819287228507;4538.319252112176;4615.884602884921;4681.180793361148;4702.224133018048;4777.856664300077;5121.8719532012;5140.768665410065;5177.792888284464;5193.091209038441;5212;5037.471065538139;5177.171652535576;5178.97410512945;5219.451957544441;5222.973885130588;4762.476127625993;4804.183288840905;4806.735629540409;4860.3195552622665;4886.560209581155;5306.8407947761625;5330.600204984642;5364.061289274361;5365.812196573102;5368.248445217672;4925;4957.6281778866005;5114.488551144856;5138.820141295037;5142.331496905378;5063.569596584258;5093.974530127326;5115.590752739772;5115.616328775357;5163.070647283525;5038.193888977819;5051.292819005343;5054.166062599704;5065.772040258197;5100.948990510122;4918.754062296943;4988.451270360258;5048.697078175322;5050.772715227824;5057.671251368649;4325.4593175853015;4342.782860856944;4345.956540434619;4373.518912919576;4392.626626736763;3785.9242815143543;3799.7910114943943;3801.7718936863325;3830.042489377656;3833.1950290438763;4294.506131794821;4297.957020429756;4355.412019377407;4356.28121359972;4373.9125217495475;5099.643024988215;5110.97444512775;5124.743762811844;5127.384713834289;5153;4359.498657654347;4360.912781744348;4361.890952726144;4365.388845561624;4410.911781764346;4521.344405061248;4596.931046034312;4625.976870115628;4649.790759415834;4700.835470758507;4843.588294994895;4848.200046992207;4861.416630004281;4863.975680121577;4913.1893237615395;5180.559652429435;5181.3782346118705;5183.50756678115;5185.11852985001;5241.135212689864;4725.385699858996;4823.204171311834;4848.80604775805;4884.438289596742;4894;5113.463086375877;5136.9743151284;5145.125328694056;5146.0479811235045;5203.765830537711;5043.672161309503;5136.897262054813;5146.794128234828;5148.613853960893;5152.716600586854;4879.5120487952345;4889.413270407574;4920.975395123145;4922.778474968563;4949.529794669501;4935.851924442272;4949.109160351171;4949.430815456125;4955.380577427822;5009.699418034929;4813.78337974799;4875.488073752347;4882.072406242803;4902.485239049848;4963.751812409438;5009.5491405773655;5049.192129259301;5064.72144032067;5067.949320506896;5118.564921981673;4946.826861059845;4954.950450495449;4967.453580106113;4969.35398398206;5024.623153263593 04:43:11 INFO - PROCESS | 27210 | |1;ext.html;556.1620899161348;580.2630659062991;594.860207851155;598.4374687793471;606.6360183889664;28473.85763071187;31727;42904.570954290444;43676.56323436765;43698;42521.787391063;43127;43132;43196.13607727851;43262;7870.2916737493615;8060.596970151499;8061.113277539466;8064.879026814573;8067.273945344918;7912.327452166573;8042.959785201066;8044.477108987897;8046.959765201166;8047.919520804805;8046.678132874678;8076.152004039579;8078;8085.797855053641;8086.71696490623;8009.759707208793;8043.276105150565;8052.798680032987;8053.51678899265;8061.516309021477;7957.045154581488;8019.198080191993;8026.518408895427;8028.518288902685;8030.277275045274;40483;40530;40736.592634073575;40858.59141408578;40886.59113408857;3218.6459489456142;3265.7224135948472;3455.447128459434;3501.124718820295;3702.796346200958;30222.17818839332;30289.394212115854;30531.69468305311;31117.688823111705;31272.687273127205;3258.7393008559498;3269.1663625775514;3277.1970867137466;3297.8351082445784;3373.7638365314438;247397;301605;307812;310231;438464.9999999968;59125.40874591285;59405.70297148487;59601.105983410285;59669.701651491465;59692;36003.4599481008;37160.07099822472;37179;39132.80433597814;39153;14148.363323650461;14303.856961430252;14305.713885722227;14412.13527188372;14445.638859028608;10724.249302548902;10787.190960677824;10789.298695584763;10792.406417646947;10799.190060745475;19263.807361926483;19300.22799088021;19314.71027934582;19324.227030918886;19359.8064019358;7180.246074162243;7223.602701851449;7243.348098671145;7340.889886651705;7424.665890034961;887.3477993674644;966.3187452845727;997.2520609542843;1024.3853687787416;1105.6461932181785;27955.72044279572;28241;28412;28595.857020714764;28800.279992999924;1006.9093781559695;1060.4326685223368;1088.2382332367374;1102.4818335382358;1112.1992165640727;15037.849621503645;15277.854160937974;15437.38250469991;15715.21423928799;15738.842611573738;304311;778753;796704;796863;798350;53163.46836531585;53513.46486535163;53846.46153538493;53912.46087539153;53925.460745392826;1145.9770804583861;1242.8197911302811;1281.5450515067016;1293.1012946002438;1307.8626744191913;26048.609270861332;30492;30534;30925.381492369575;31136.532952005284;44013.779931100136;44390.556094438645;44667.32999005083;44795.10409791721;44866.55133448754;302360;305945;306295;306380;306830;23837.523249534566;26726;26864.32839178958;27457.588136178372;27513.17460476189;44064;44280;44915.55084449114;45722.77138614286;45867.541324586324;35151.82424087863;35523.28953420969;35928.82035589805;36017.819910900274;36215.63784362228;37159.25681486301;37229.25541489209;37880;38019.32054264913;38019.42970855495;37587.62412375951;37785.62214377931;37851.242975139794;38399.616003839605;39281;33228.1692957678;34755;34937.82531087328;34949.82525087358;35354.29291414106;25973.740262597134;26128.477430451665;26258.606120907818;26488.602670960336;26498 04:43:11 INFO - PROCESS | 27210 | |2;jquery.html;364.53703796178854;376.96795772359366;381.3098292091313;382.7492992090181;392.430975086125;16088.91955540222;18000.36998705044;18165.09174541274;18360.632787344246;18379.172937217823;17032.744508832347;17328.740068898944;17860;18023;18084.186211620476;5167.4574169712205;5250.343707036621;5333.173358129496;5370.140777475604;5372.355317361922;3639.7998110103936;5292.894142117156;5846.2107615472005;6165.1677023601915;6176.598521096137;6143.232095988002;6200.100985357143;6207.658578778165;6230.221222347207;6238.251409830827;6036.3360030396625;6145.047517634774;6179.104029915682;6213.099100630406;6221.035739460368;3260.6250281217726;3437.7937323760652;3440.3291358185165;3471.1669199392218;5011.448740638527;20163.798362016485;20952.5809483811;21470.248541301135;21505.67741483879;21653.566928661498;2044.488877780555;2159.2010955946243;2251.1097019657605;2434.951300973971;2590.663213782196;12451.315177665225;13294.376913335238;13394.933025334909;13508.662283442894;13829.239391833446;1766.8056513783474;1804.2422182683304;1817.5274428648515;1824.9908750456163;1885.3118611706766;63497;64456.35543644597;64623.676881615764;65654.67172664106;67813.66093169502;9334.953325233331;9671.371360861522;9785.26610504215;9803.264755143393;10088.546015429323;12627.305498197504;12841.486340546273;12876.80684789729;12883.806742898863;12942;6956.513044086865;7009.2990700929495;7088.645567721594;7117.928820711727;7217.458690598226;6650.501212408992;6662.200535935719;6793.490488213305;6814.965925170342;6853.143357080365;6234.220722409699;6256.468200202943;6272.529560282997;6277.2781130170615;6375.234971803413;1586.5954181683596;1621.5946013496625;1732.385003323827;1734;1779.234928980525;889.857622780352;894.065701342099;898.5507246376811;926.3885835348638;966.5408930757974;16848.57878553046;17406.39077632277;17481.56296092608;17640.20619072145;18145.909270453827;846.1580727176499;885.610331454171;977.9462129582942;983.7934033852828;995.5320999130397;9274.860877086849;9502.287328450255;9700.417974921527;9787.51062446889;9922.206223502248;419302;420887;443718;448986;453247;83258.58370708108;88528.5573572128;88941;91017.54491227501;91494;970.9708708738749;981.4062492192263;984.684900831727;997.5959736306808;1006.2201793609864;14658.853411465749;15993.1203783793;16092.356305748108;16247.70018398549;16547.503574892773;31799.205019873763;35869.282614347045;36676.44985325169;36820.81589592035;37233.81383093176;45410;49377.50622493729;49669.75165124296;49838.75080624719;50268;6498.610083395011;6784.3894049535775;7930.881036784337;7945.1657575953695;7986.7603971880935;10483.895161048596;11488.48301826403;11506.654800356002;11603;11653.59212427561;10231.130353919703;10342.638007669695;10371.429571373345;10458.68623941283;10462.63380781669;10116.393016419039;10235.590576377159;10351.792964140826;10398.220133489867;10510;10454.947725261629;10511.94744026275;10641.965524073768;10650.094741946712;10687.946560267148;6952.721891124298;7059.964700176466;7062.364387205176;7134.357907788324;7212.350888420067;9433.292503062436;10027.44849033281;10174.440405777754;10501.789964200825;10506.947465262625 04:43:11 INFO - PROCESS | 27210 | |3;mootools.html;1181.7695549367866;1452.789345544896;1503.2408633640014;1650.1996531682132;1826.7625208722857;7080.4335653147755;7411.221821708724;7428.702851885918;7594.240575942403;7597.544147351149;7348.816279593013;7503.962480187605;7518.060242469692;7522.360599349062;7524.05949256343;2177.7277840269967;2206.382212980368;2206.580749657568;2206.6359050756687;2207.3377986604037;2211.5908556916943;2222.3333000099988;2258.4015235962484;2258.503129311557;2262.2082271205113;2186.5736181444627;2189.179057853305;2216.2021672198;2220;2220.4670878989086;2180.607490651682;2188.6060509108356;2213.6015517206897;2215.9224427145055;2220.3449982255274;2115.5663089066707;2122.564874200785;2125.7130287411155;2143.3141394753684;2145.131221855151;7123.394511466531;7297.124345078571;7363.637727020465;7368;7398.445116616275;4440.444944381952;4524.5927866492175;4543.0459603483305;4547.658925580562;4550.362949187116;2881.0780550223935;2961.2596850787304;3014.216303761016;3017.336186039068;3033.3023404616843;939.9953000235023;952.2429668413628;956.9330146889721;966.4249771386085;974.9805003899953;9881.80236395268;9964.05341492557;9971.800563988752;9995.550200241007;10005.249606279558;3899.2396482685604;3979.641832235113;4032.6169013943627;4057.715959882839;4088.468499095158;7822.413319000984;7877.645505952246;7887.645055972495;7889.132195458495;7899.368050555941;4468.55314468557;4530.728156310632;4531.3882625845745;4552.248878934939;4558.703684260512;3497.492863534824;3986.421968814506;4146.5853414658895;4216.47294088239;4237.724547904377;3204.3110731192905;3246.7077962983444;3249.2851572653976;3270.149761062141;3326.6673332667024;1015.9898401015895;1054.6308791922766;1062.888396718349;1067.7597540553468;1068.4764465411893;737.6717360774404;860.6041221038267;884.4428010353436;892.683097500391;906.1482206725657;4902.48523904992;4945.67853089548;5038.269450929594;5064.290999260106;5120.462351453044;417.67004066787507;423.3332501310387;431.7905815679393;434.9347597860283;440.5682431217361;3430.1767575781632;3436.1753179236803;3443.8794642187904;3447.1554469155217;3546.8226588670464;8844.778880528038;9182.770430739285;9239.630414783467;9242.72271831846;9302.86045709315;9137.360384773003;9163.404378715362;9198.816023679623;9253.629854805733;9269.397489163182;6863.553868998499;6908.309169083152;6909.963505474219;6950.756723514653;6974.093367862146;4908.558229759339;4908.9754551227015;5029.497050294941;5068.239764035424;5110.71891045996;8005.239502247277;8224.547649879314;8517.872231916403;8521.744347669579;8637.56812159402;7985.321247693779;8210.261076503144;8261.256486916207;8517.616707248064;8592.785180370542;5468.316460442445;6105.664188469676;6355.459785918249;6453.741850325934;6530.67346632657;6862.828429289308;7172.103487064117;7189.820254493679;7213.314735100157;7222.494425390382;6351.809445716636;6518.413342799171;6529.771457998947;6562.573432727048;6594.4724422045165;6326.2092238470195;6357.809265722036;6402.935970640234;6493.415592596689;6528.21661400616;6096.603720758137;6129.08063790435;6160.137580738789;6166.907496387647;6171.074338849208;4325.48094228682;4334.111507141091;4393.516713161485;4446.577575130357;4467;4215.494140703136;4281.079567892918;4301.204277208726;4322.265214913409;4359.803808828674 04:43:11 INFO - PROCESS | 27210 | |4;prototype.html;300.8495752123937;308.4632739034081;315.7821103438627;317.4048658764816;318.8007495315428;4537.342085397615;4702.788374523147;4757.357756702849;4761.619070474358;4802.399700037496;4627.259638457847;4757.8096876125;4771.212749896263;4774.40319960005;4791.377120974277;3766.435034744783;3791.507104076466;3792.184680293736;3793.848246070154;3808.3906574948014;3585;3639.7452178347526;3784;3791.886243412688;3811.1805961718223;3746.83139258734;3766.623337666239;3773.4528493368584;3778.4521244419543;3783.2622638585485;3719.274741425423;3755.6995440364703;3771.9622803771886;3785.1294202333343;3787.072167318997;3374.3757404880175;3377.5946886373545;3379.3579219948133;3386.9322613547592;3407.8807241746667;4504.8873778155485;4550.38569793077;4578.244589642705;4582.358469814229;4609.216433206363;4236.6187043166265;4256.34026725858;4264.573542645741;4268.338407546835;4270.487541495009;4903.681260718042;4925.7783399747095;4943.096907690529;4944.703317800908;4958.380202474691;3499.475078738184;3595.94606080909;3625.655562721537;3627.7689221128817;3647.3981793004123;5147.202183661539;5154.948450515484;5155.793768249303;5160;5187.351581052406;3682.2451397463456;3700.40793473043;3703.9444408333898;3727.4036154215196;3738.5513738351574;3757.229767897574;3760.435934609776;3768.77387356754;3771.5662698789442;3791.962080379161;4135.8966025849595;4285.357196420562;4286.635635970977;4292.399064131024;4301.3117901135665;4850.95149048512;4947.243728476411;4949.183384741549;4958.7024778513405;4979.775910084055;1193.2065176657425;1233.210745123122;1253.260576260011;1269.162352847135;1270.866559011309;873.8770679676585;883.1389395339621;893.0176805513883;893.1202765276198;907.5008745190119;4222.345536441856;4230.5769423057445;4245.766482843412;4253.170631726845;4254;4896.192128298862;4944.242375794351;4953.678010929278;4961.677490963076;4968.776405061781;4190.769507677107;4217.915641687149;4226.8798768326415;4238.766867822238;4259.829606815754;2488.8133389995824;2568.2680436076002;2585.4699786543715;2594.3125071855975;2606.8566228857217;4620.930686039712;4633.212353899845;4656.41794775653;4679.9704065105625;4719.702081927498;5005.371105948158;5014.771381011603;5029.044481548494;5035.446100928895;5046.495350464924;4510.534570774909;4607.907841843212;4610.723356598548;4673;4688.765561721969;4923.236898280772;4927.211646136601;4927.457979622167;4947.822957898513;4958.528939750718;4764.547368000034;4791.305260737243;4798.4001999750035;4843.861692502189;4857.222844344888;4391.802368893472;4612.354270402079;4619.630429565559;4644;4692.7888245029735;3606.2787442512126;3611.656892595199;3615.602283748838;3615.6565126312958;3622.4747411625694;4872.759614856081;4913.70517768935;4926.187179115406;4932.186189278729;4984.526469985346;4825.203841366135;4976.626752993468;4979.0788704089855;4988.301637770643;5002.449730529566;4878.878028049186;4943.950560494349;4944.159492886146;4950.579200767975;4984.651074424755;4666.346711460466;4890.508394939578;4901.215805471107;4910.2880082388565;4930.901381972412;4995;4997.350344455198;5012.122878496321;5020.548150666457;5057.519535644108;4921.237208232729;4924.236743304794;4930.433000205022;4936.753162341796;4958.925466210972 04:43:11 INFO - PROCESS | 27210 | |5;yui.html;708.9361957423831;779.2558107007808;811.8944537210164;820.9409861278947;831.3806214370295;10949.726256843573;11578.710532236699;11701;11711.472983715732;11733.58932437366;11334.489947952341;11693.941530292337;11696.122790790681;11997.940010299937;12032.278063316207;669.250439507752;868.7002983970551;884.1732979664002;884.2483888694622;884.2925659472396;849.7068511363569;876.3777717820324;878.2798105553449;884.2704768565927;884.4162852517339;903.9638414463413;908.3550679017906;909.3270979475207;909.9363044586881;910.4901255297021;697.2260790522516;716.8494616130619;914.4284821986258;914.8444764390036;914.9405288656216;529.8172130614931;647.3429469088878;665.5540787672223;666.3702800853196;667.6995352091529;10799.892001080047;10811.6215932442;10813.67558973232;10825.67522974312;10844.511996960156;10573.9471302643;10884.455777211188;10977.12183025356;11021.44892755367;11402.144839137098;11281.774364512747;11299.717507062307;11369.715757106138;11414.942925285404;11442.42787860612;4156.630720489322;4190.371444283352;4237.364395340693;4245.3844192591905;4286.828526858922;42920.78539607313;43207.783961080306;43395.13209735788;43434.78282608598;43510.78244608756;9497.46793883256;9539.761505962268;9700.369475984038;9873.111419972238;10088.192944564416;17406.825931740776;17424.215910284067;17431.04129272902;17445.127743612768;17458.039807810692;6523.869522609616;6584;6612.23959244693;6626.271110177877;6716.630585317855;3558.377283975294;3698.907527311785;3715.1640880802142;3721.10693433574;3761.4921985531605;2883.33683252853;2916.431295897322;2949.631296087989;2951.026161366744;2974.6579143398353;516.2024671881951;521.1713375732603;522.8144008876794;529.1269405480987;535.5100083423702;518.6265888560231;534.6658338538414;539.2232593604084;571.5656101362994;601.6781022153127;7234.74678386254;7360.374368178657;7398.038255026812;7490.063742032246;7508.5119467235545;557.6727388814676;595.4016213705198;595.4194660206351;598.1267349669531;612.4732729852324;3475.9826200868833;3530.7289375824685;3543.53933988585;3553.911152221215;3625.6736893679695;50700;51302.74348628233;52376.47623523792;53173.202401964;53259.73370133124;44301.77849110734;44682.55317446849;45824.312635310496;46535.76732116318;47636;44075.559244407785;44173.11653766907;44873;45622.54377456183;45747.31379029317;7126.35862772353;7599.392048635986;7643.044619422572;7664.540127592362;7742.612869356397;29594;29779.55330670085;30054.398912022076;30435.84782076164;31034;36184.63815361813;38205.61794382021;38385.42421863618;38525.61474385332;38659;8751.474911505074;8793.91206087931;8870.112988701336;10844.45777711127;10854.403007834644;9054.502002389932;9117.403411416031;9594.136527712539;9662.323637345318;9978.002199779963;8559.614817333111;8781.25359344463;8992.55037248148;9041.634285544738;9245.58394872219;8343.582820858812;8546.487210767375;8575.614097365758;8757.992830824536;9002.144796244347;8519.574021299035;8647;8665.306775458075;8847.380683352103;8864.689735859214;7301.269873012869;7340.70637174507;7456.888146677913;7495.887561686688;7553.5845528494265;7224;7486.064241969754;7508.587027713528;7608.771736847903;7805.453618246668 04:43:11 INFO - PROCESS | 27210 | __end_tp_report 04:43:11 INFO - PROCESS | 27210 | __start_cc_report 04:43:11 INFO - PROCESS | 27210 | _x_x_mozilla_cycle_collect,879 04:43:11 INFO - PROCESS | 27210 | __end_cc_report 04:43:11 INFO - PROCESS | 27210 | __startTimestamp1462794191222__endTimestamp 04:43:11 INFO - PROCESS | 27210 | 04:43:11 INFO - PROCESS | 27210 | ------- Summary: start ------- 04:43:11 INFO - PROCESS | 27210 | Number of tests: 6 04:43:11 INFO - PROCESS | 27210 | 04:43:11 INFO - PROCESS | 27210 | [#0] dojo.html Cycles:165 Average:4744.46 Median:4879.51 stddev:496.77 (10.2%) stddev-sans-first:470.91 04:43:11 INFO - PROCESS | 27210 | Values: 2670.6 2672.9 2688.6 2708.9 2718.0 4680.5 4726.7 4750.3 4827.4 4887.4 4759.0 4784.9 4789.7 4795.9 4807.6 4361.2 4391.0 4436.6 4480.0 4615.1 4481.4 4513.9 4549.6 4557.4 4580.0 4340.0 4389.9 4390.2 4398.3 4426.7 4421.4 4437.1 4481.6 4482.8 4485.7 4453.2 4470.2 4472.6 4474.0 4517.8 4538.3 4615.9 4681.2 4702.2 4777.9 5121.9 5140.8 5177.8 5193.1 5212.0 5037.5 5177.2 5179.0 5219.5 5223.0 4762.5 4804.2 4806.7 4860.3 4886.6 5306.8 5330.6 5364.1 5365.8 5368.2 4925.0 4957.6 5114.5 5138.8 5142.3 5063.6 5094.0 5115.6 5115.6 5163.1 5038.2 5051.3 5054.2 5065.8 5100.9 4918.8 4988.5 5048.7 5050.8 5057.7 4325.5 4342.8 4346.0 4373.5 4392.6 3785.9 3799.8 3801.8 3830.0 3833.2 4294.5 4298.0 4355.4 4356.3 4373.9 5099.6 5111.0 5124.7 5127.4 5153.0 4359.5 4360.9 4361.9 4365.4 4410.9 4521.3 4596.9 4626.0 4649.8 4700.8 4843.6 4848.2 4861.4 4864.0 4913.2 5180.6 5181.4 5183.5 5185.1 5241.1 4725.4 4823.2 4848.8 4884.4 4894.0 5113.5 5137.0 5145.1 5146.0 5203.8 5043.7 5136.9 5146.8 5148.6 5152.7 4879.5 4889.4 4921.0 4922.8 4949.5 4935.9 4949.1 4949.4 4955.4 5009.7 4813.8 4875.5 4882.1 4902.5 4963.8 5009.5 5049.2 5064.7 5067.9 5118.6 4946.8 4955.0 4967.5 4969.4 5024.6 04:43:11 INFO - PROCESS | 27210 | 04:43:11 INFO - PROCESS | 27210 | [#1] ext.html Cycles:180 Average:58049.57 Median:37159.66 stddev:132441.41 (356.4%) stddev-sans-first:132742.59 04:43:11 INFO - PROCESS | 27210 | Values: 556.2 580.3 594.9 598.4 606.6 28473.9 31727.0 42904.6 43676.6 43698.0 42521.8 43127.0 43132.0 43196.1 43262.0 7870.3 8060.6 8061.1 8064.9 8067.3 7912.3 8043.0 8044.5 8047.0 8047.9 8046.7 8076.2 8078.0 8085.8 8086.7 8009.8 8043.3 8052.8 8053.5 8061.5 7957.0 8019.2 8026.5 8028.5 8030.3 40483.0 40530.0 40736.6 40858.6 40886.6 3218.6 3265.7 3455.4 3501.1 3702.8 30222.2 30289.4 30531.7 31117.7 31272.7 3258.7 3269.2 3277.2 3297.8 3373.8 247397.0 301605.0 307812.0 310231.0 438465.0 59125.4 59405.7 59601.1 59669.7 59692.0 36003.5 37160.1 37179.0 39132.8 39153.0 14148.4 14303.9 14305.7 14412.1 14445.6 10724.2 10787.2 10789.3 10792.4 10799.2 19263.8 19300.2 19314.7 19324.2 19359.8 7180.2 7223.6 7243.3 7340.9 7424.7 887.3 966.3 997.3 1024.4 1105.6 27955.7 28241.0 28412.0 28595.9 28800.3 1006.9 1060.4 1088.2 1102.5 1112.2 15037.8 15277.9 15437.4 15715.2 15738.8 304311.0 778753.0 796704.0 796863.0 798350.0 53163.5 53513.5 53846.5 53912.5 53925.5 1146.0 1242.8 1281.5 1293.1 1307.9 26048.6 30492.0 30534.0 30925.4 31136.5 44013.8 44390.6 44667.3 44795.1 44866.6 302360.0 305945.0 306295.0 306380.0 306830.0 23837.5 26726.0 26864.3 27457.6 27513.2 44064.0 44280.0 44915.6 45722.8 45867.5 35151.8 35523.3 35928.8 36017.8 36215.6 37159.3 37229.3 37880.0 38019.3 38019.4 37587.6 37785.6 37851.2 38399.6 39281.0 33228.2 34755.0 34937.8 34949.8 35354.3 25973.7 26128.5 26258.6 26488.6 26498.0 04:43:11 INFO - PROCESS | 27210 | 04:43:11 INFO - PROCESS | 27210 | [#2] jquery.html Cycles:180 Average:25956.55 Median:209847.22 stddev:72088.20 (34.4%) stddev-sans-first:72264.82 04:43:11 INFO - PROCESS | 27210 | Values: 364.5 377.0 381.3 382.7 392.4 16088.9 18000.4 18165.1 18360.6 18379.2 17032.7 17328.7 17860.0 18023.0 18084.2 5167.5 5250.3 5333.2 5370.1 5372.4 3639.8 5292.9 5846.2 6165.2 6176.6 6143.2 6200.1 6207.7 6230.2 6238.3 6036.3 6145.0 6179.1 6213.1 6221.0 3260.6 3437.8 3440.3 3471.2 5011.4 20163.8 20952.6 21470.2 21505.7 21653.6 2044.5 2159.2 2251.1 2435.0 2590.7 12451.3 13294.4 13394.9 13508.7 13829.2 1766.8 1804.2 1817.5 1825.0 1885.3 63497.0 64456.4 64623.7 65654.7 67813.7 9335.0 9671.4 9785.3 9803.3 10088.5 12627.3 12841.5 12876.8 12883.8 12942.0 6956.5 7009.3 7088.6 7117.9 7217.5 6650.5 6662.2 6793.5 6815.0 6853.1 6234.2 6256.5 6272.5 6277.3 6375.2 1586.6 1621.6 1732.4 1734.0 1779.2 889.9 894.1 898.6 926.4 966.5 16848.6 17406.4 17481.6 17640.2 18145.9 846.2 885.6 977.9 983.8 995.5 9274.9 9502.3 9700.4 9787.5 9922.2 419302.0 420887.0 443718.0 448986.0 453247.0 83258.6 88528.6 88941.0 91017.5 91494.0 971.0 981.4 984.7 997.6 1006.2 14658.9 15993.1 16092.4 16247.7 16547.5 31799.2 35869.3 36676.4 36820.8 37233.8 45410.0 49377.5 49669.8 49838.8 50268.0 6498.6 6784.4 7930.9 7945.2 7986.8 10483.9 11488.5 11506.7 11603.0 11653.6 10231.1 10342.6 10371.4 10458.7 10462.6 10116.4 10235.6 10351.8 10398.2 10510.0 10454.9 10511.9 10642.0 10650.1 10687.9 6952.7 7060.0 7062.4 7134.4 7212.4 9433.3 10027.4 10174.4 10501.8 10506.9 04:43:11 INFO - PROCESS | 27210 | 04:43:11 INFO - PROCESS | 27210 | [#3] mootools.html Cycles:180 Average:4881.24 Median:5033.88 stddev:2679.57 (53.2%) stddev-sans-first:2672.66 04:43:11 INFO - PROCESS | 27210 | Values: 1181.8 1452.8 1503.2 1650.2 1826.8 7080.4 7411.2 7428.7 7594.2 7597.5 7348.8 7504.0 7518.1 7522.4 7524.1 2177.7 2206.4 2206.6 2206.6 2207.3 2211.6 2222.3 2258.4 2258.5 2262.2 2186.6 2189.2 2216.2 2220.0 2220.5 2180.6 2188.6 2213.6 2215.9 2220.3 2115.6 2122.6 2125.7 2143.3 2145.1 7123.4 7297.1 7363.6 7368.0 7398.4 4440.4 4524.6 4543.0 4547.7 4550.4 2881.1 2961.3 3014.2 3017.3 3033.3 940.0 952.2 956.9 966.4 975.0 9881.8 9964.1 9971.8 9995.6 10005.2 3899.2 3979.6 4032.6 4057.7 4088.5 7822.4 7877.6 7887.6 7889.1 7899.4 4468.6 4530.7 4531.4 4552.2 4558.7 3497.5 3986.4 4146.6 4216.5 4237.7 3204.3 3246.7 3249.3 3270.1 3326.7 1016.0 1054.6 1062.9 1067.8 1068.5 737.7 860.6 884.4 892.7 906.1 4902.5 4945.7 5038.3 5064.3 5120.5 417.7 423.3 431.8 434.9 440.6 3430.2 3436.2 3443.9 3447.2 3546.8 8844.8 9182.8 9239.6 9242.7 9302.9 9137.4 9163.4 9198.8 9253.6 9269.4 6863.6 6908.3 6910.0 6950.8 6974.1 4908.6 4909.0 5029.5 5068.2 5110.7 8005.2 8224.5 8517.9 8521.7 8637.6 7985.3 8210.3 8261.3 8517.6 8592.8 5468.3 6105.7 6355.5 6453.7 6530.7 6862.8 7172.1 7189.8 7213.3 7222.5 6351.8 6518.4 6529.8 6562.6 6594.5 6326.2 6357.8 6402.9 6493.4 6528.2 6096.6 6129.1 6160.1 6166.9 6171.1 4325.5 4334.1 4393.5 4446.6 4467.0 4215.5 4281.1 4301.2 4322.3 4359.8 04:43:11 INFO - PROCESS | 27210 | 04:43:11 INFO - PROCESS | 27210 | [#4] prototype.html Cycles:180 Average:4094.62 Median:4615.99 stddev:1162.68 (25.2%) stddev-sans-first:1130.53 04:43:11 INFO - PROCESS | 27210 | Values: 300.8 308.5 315.8 317.4 318.8 4537.3 4702.8 4757.4 4761.6 4802.4 4627.3 4757.8 4771.2 4774.4 4791.4 3766.4 3791.5 3792.2 3793.8 3808.4 3585.0 3639.7 3784.0 3791.9 3811.2 3746.8 3766.6 3773.5 3778.5 3783.3 3719.3 3755.7 3772.0 3785.1 3787.1 3374.4 3377.6 3379.4 3386.9 3407.9 4504.9 4550.4 4578.2 4582.4 4609.2 4236.6 4256.3 4264.6 4268.3 4270.5 4903.7 4925.8 4943.1 4944.7 4958.4 3499.5 3595.9 3625.7 3627.8 3647.4 5147.2 5154.9 5155.8 5160.0 5187.4 3682.2 3700.4 3703.9 3727.4 3738.6 3757.2 3760.4 3768.8 3771.6 3792.0 4135.9 4285.4 4286.6 4292.4 4301.3 4851.0 4947.2 4949.2 4958.7 4979.8 1193.2 1233.2 1253.3 1269.2 1270.9 873.9 883.1 893.0 893.1 907.5 4222.3 4230.6 4245.8 4253.2 4254.0 4896.2 4944.2 4953.7 4961.7 4968.8 4190.8 4217.9 4226.9 4238.8 4259.8 2488.8 2568.3 2585.5 2594.3 2606.9 4620.9 4633.2 4656.4 4680.0 4719.7 5005.4 5014.8 5029.0 5035.4 5046.5 4510.5 4607.9 4610.7 4673.0 4688.8 4923.2 4927.2 4927.5 4947.8 4958.5 4764.5 4791.3 4798.4 4843.9 4857.2 4391.8 4612.4 4619.6 4644.0 4692.8 3606.3 3611.7 3615.6 3615.7 3622.5 4872.8 4913.7 4926.2 4932.2 4984.5 4825.2 4976.6 4979.1 4988.3 5002.4 4878.9 4944.0 4944.2 4950.6 4984.7 4666.3 4890.5 4901.2 4910.3 4930.9 4995.0 4997.4 5012.1 5020.5 5057.5 4921.2 4924.2 4930.4 4936.8 4958.9 04:43:11 INFO - PROCESS | 27210 | 04:43:11 INFO - PROCESS | 27210 | [#5] yui.html Cycles:180 Average:12243.95 Median:537.37 stddev:14421.48 (2683.7%) stddev-sans-first:14435.92 04:43:11 INFO - PROCESS | 27210 | Values: 708.9 779.3 811.9 820.9 831.4 10949.7 11578.7 11701.0 11711.5 11733.6 11334.5 11693.9 11696.1 11997.9 12032.3 669.3 868.7 884.2 884.2 884.3 849.7 876.4 878.3 884.3 884.4 904.0 908.4 909.3 909.9 910.5 697.2 716.8 914.4 914.8 914.9 529.8 647.3 665.6 666.4 667.7 10799.9 10811.6 10813.7 10825.7 10844.5 10573.9 10884.5 10977.1 11021.4 11402.1 11281.8 11299.7 11369.7 11414.9 11442.4 4156.6 4190.4 4237.4 4245.4 4286.8 42920.8 43207.8 43395.1 43434.8 43510.8 9497.5 9539.8 9700.4 9873.1 10088.2 17406.8 17424.2 17431.0 17445.1 17458.0 6523.9 6584.0 6612.2 6626.3 6716.6 3558.4 3698.9 3715.2 3721.1 3761.5 2883.3 2916.4 2949.6 2951.0 2974.7 516.2 521.2 522.8 529.1 535.5 518.6 534.7 539.2 571.6 601.7 7234.7 7360.4 7398.0 7490.1 7508.5 557.7 595.4 595.4 598.1 612.5 3476.0 3530.7 3543.5 3553.9 3625.7 50700.0 51302.7 52376.5 53173.2 53259.7 44301.8 44682.6 45824.3 46535.8 47636.0 44075.6 44173.1 44873.0 45622.5 45747.3 7126.4 7599.4 7643.0 7664.5 7742.6 29594.0 29779.6 30054.4 30435.8 31034.0 36184.6 38205.6 38385.4 38525.6 38659.0 8751.5 8793.9 8870.1 10844.5 10854.4 9054.5 9117.4 9594.1 9662.3 9978.0 8559.6 8781.3 8992.6 9041.6 9245.6 8343.6 8546.5 8575.6 8758.0 9002.1 8519.6 8647.0 8665.3 8847.4 8864.7 7301.3 7340.7 7456.9 7495.9 7553.6 7224.0 7486.1 7508.6 7608.8 7805.5 04:43:11 INFO - PROCESS | 27210 | -------- Summary: end -------- 04:43:11 INFO - PROCESS | 27210 | 04:43:11 INFO - TEST-INFO | 27210: exit 0 04:43:12 INFO - TEST-OK | dromaeo_css | took 1118706ms 04:43:12 INFO - TEST-START | kraken 04:43:12 INFO - operating with platform_type : linux_ 04:43:12 INFO - Initialising browser for kraken test... 04:43:12 INFO - TEST-INFO | started process 27391 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBE1JwS/profile http://localhost:45322/getInfo.html) 04:43:16 INFO - PROCESS | 27391 | __metrics Screen width/height:1600/1200 04:43:16 INFO - PROCESS | 27391 | colorDepth:24 04:43:16 INFO - PROCESS | 27391 | Browser inner width/height: 1024/697 04:43:16 INFO - PROCESS | 27391 | __metrics 04:43:17 ERROR - PROCESS | 27391 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:43:18 INFO - TEST-INFO | 27391: exit 0 04:43:18 INFO - Browser initialized. 04:43:18 INFO - Running cycle 1/1 for kraken test... 04:43:18 INFO - TEST-INFO | started process 27471 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBE1JwS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:43:30 INFO - PROCESS | 27471 | RSS: Main: 154103808 04:43:30 INFO - PROCESS | 27471 | 04:43:33 INFO - PROCESS | 27471 | Cycle 1(1): loaded http://localhost:45322/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45322/tests/kraken/driver.html?testName=audio-beat-detection) 04:43:34 INFO - PROCESS | 27471 | RSS: Main: 209735680 04:43:34 INFO - PROCESS | 27471 | 04:43:36 INFO - PROCESS | 27471 | Cycle 1(1): loaded http://localhost:45322/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45322/tests/kraken/driver.html?testName=audio-dft) 04:43:37 INFO - PROCESS | 27471 | RSS: Main: 197005312 04:43:37 INFO - PROCESS | 27471 | 04:43:40 INFO - PROCESS | 27471 | Cycle 1(1): loaded http://localhost:45322/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45322/tests/kraken/driver.html?testName=audio-fft) 04:43:41 INFO - PROCESS | 27471 | RSS: Main: 266223616 04:43:41 INFO - PROCESS | 27471 | 04:43:43 INFO - PROCESS | 27471 | Cycle 1(1): loaded http://localhost:45322/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45322/tests/kraken/driver.html?testName=audio-oscillator) 04:43:44 INFO - PROCESS | 27471 | RSS: Main: 175677440 04:43:44 INFO - PROCESS | 27471 | 04:43:46 INFO - PROCESS | 27471 | Cycle 1(1): loaded http://localhost:45322/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45322/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:43:47 INFO - PROCESS | 27471 | RSS: Main: 179056640 04:43:47 INFO - PROCESS | 27471 | 04:43:50 INFO - PROCESS | 27471 | Cycle 1(1): loaded http://localhost:45322/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45322/tests/kraken/driver.html?testName=imaging-darkroom) 04:43:51 INFO - PROCESS | 27471 | RSS: Main: 215707648 04:43:51 INFO - PROCESS | 27471 | 04:43:54 INFO - PROCESS | 27471 | Cycle 1(1): loaded http://localhost:45322/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45322/tests/kraken/driver.html?testName=imaging-desaturate) 04:43:55 INFO - PROCESS | 27471 | RSS: Main: 213954560 04:43:55 INFO - PROCESS | 27471 | 04:43:58 INFO - PROCESS | 27471 | Cycle 1(1): loaded http://localhost:45322/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45322/tests/kraken/driver.html?testName=json-parse-financial) 04:43:59 INFO - PROCESS | 27471 | RSS: Main: 214855680 04:43:59 INFO - PROCESS | 27471 | 04:44:01 INFO - PROCESS | 27471 | Cycle 1(1): loaded http://localhost:45322/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45322/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:44:01 INFO - PROCESS | 27471 | RSS: Main: 204537856 04:44:01 INFO - PROCESS | 27471 | 04:44:03 INFO - PROCESS | 27471 | Cycle 1(1): loaded http://localhost:45322/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45322/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:44:04 INFO - PROCESS | 27471 | RSS: Main: 207867904 04:44:04 INFO - PROCESS | 27471 | 04:44:06 INFO - PROCESS | 27471 | Cycle 1(1): loaded http://localhost:45322/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45322/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:44:07 INFO - PROCESS | 27471 | RSS: Main: 216281088 04:44:07 INFO - PROCESS | 27471 | 04:44:10 INFO - PROCESS | 27471 | Cycle 1(1): loaded http://localhost:45322/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45322/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:44:10 INFO - PROCESS | 27471 | RSS: Main: 224620544 04:44:10 INFO - PROCESS | 27471 | 04:44:13 INFO - PROCESS | 27471 | Cycle 1(1): loaded http://localhost:45322/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45322/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:44:14 INFO - PROCESS | 27471 | RSS: Main: 219807744 04:44:14 INFO - PROCESS | 27471 | 04:44:16 INFO - PROCESS | 27471 | Cycle 1(1): loaded http://localhost:45322/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45322/tests/kraken/driver.html?testName=ai-astar) 04:44:16 INFO - PROCESS | 27471 | RSS: Main: 267014144 04:44:16 INFO - PROCESS | 27471 | 04:44:16 INFO - PROCESS | 27471 | __start_tp_report 04:44:16 INFO - PROCESS | 27471 | _x_x_mozilla_page_load 04:44:16 INFO - PROCESS | 27471 | _x_x_mozilla_page_load_details 04:44:16 INFO - PROCESS | 27471 | |i|pagename|runs| 04:44:16 INFO - PROCESS | 27471 | |0;ai-astar;115;109;115;118;114;114;114;113;114;113 04:44:16 INFO - PROCESS | 27471 | |1;audio-beat-detection;170;128;159;212;140;160;166;131;180;140 04:44:16 INFO - PROCESS | 27471 | |2;audio-dft;161;161;162;160;161;162;163;162;161;160 04:44:16 INFO - PROCESS | 27471 | |3;audio-fft;76;74;77;145;77;76;75;74;142;75 04:44:16 INFO - PROCESS | 27471 | |4;audio-oscillator;93;98;147;92;93;93;124;93;93;130 04:44:16 INFO - PROCESS | 27471 | |5;imaging-gaussian-blur;117;117;117;117;116;116;117;117;116;117 04:44:16 INFO - PROCESS | 27471 | |6;imaging-darkroom;146;145;145;146;146;146;146;146;145;146 04:44:16 INFO - PROCESS | 27471 | |7;imaging-desaturate;95;94;95;95;96;95;94;95;95;95 04:44:16 INFO - PROCESS | 27471 | |8;json-parse-financial;66;66;66;66;67;66;67;125;65;64 04:44:16 INFO - PROCESS | 27471 | |9;json-stringify-tinderbox;64;64;64;64;65;64;64;65;65;65 04:44:16 INFO - PROCESS | 27471 | |10;stanford-crypto-aes;88;82;82;82;87;82;82;83;84;84 04:44:16 INFO - PROCESS | 27471 | |11;stanford-crypto-ccm;130;136;149;138;132;129;139;130;201;134 04:44:16 INFO - PROCESS | 27471 | |12;stanford-crypto-pbkdf2;178;170;171;172;171;178;170;173;176;176 04:44:16 INFO - PROCESS | 27471 | |13;stanford-crypto-sha256-iterative;68;69;71;67;66;66;73;68;66;66 04:44:16 INFO - PROCESS | 27471 | __end_tp_report 04:44:16 INFO - PROCESS | 27471 | __start_cc_report 04:44:16 INFO - PROCESS | 27471 | _x_x_mozilla_cycle_collect,2110 04:44:16 INFO - PROCESS | 27471 | __end_cc_report 04:44:16 INFO - PROCESS | 27471 | __startTimestamp1462794256392__endTimestamp 04:44:16 INFO - PROCESS | 27471 | 04:44:16 INFO - PROCESS | 27471 | ------- Summary: start ------- 04:44:16 INFO - PROCESS | 27471 | Number of tests: 14 04:44:16 INFO - PROCESS | 27471 | 04:44:16 INFO - PROCESS | 27471 | [#0] ai-astar Cycles:10 Average:113.90 Median:114.00 stddev:2.23 (2.0%) stddev-sans-first:2.33 04:44:16 INFO - PROCESS | 27471 | Values: 115.0 109.0 115.0 118.0 114.0 114.0 114.0 113.0 114.0 113.0 04:44:16 INFO - PROCESS | 27471 | 04:44:16 INFO - PROCESS | 27471 | [#1] audio-beat-detection Cycles:10 Average:158.60 Median:163.00 stddev:25.57 (15.7%) stddev-sans-first:26.79 04:44:16 INFO - PROCESS | 27471 | Values: 170.0 128.0 159.0 212.0 140.0 160.0 166.0 131.0 180.0 140.0 04:44:16 INFO - PROCESS | 27471 | 04:44:16 INFO - PROCESS | 27471 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.95 (0.6%) stddev-sans-first:1.00 04:44:16 INFO - PROCESS | 27471 | Values: 161.0 161.0 162.0 160.0 161.0 162.0 163.0 162.0 161.0 160.0 04:44:16 INFO - PROCESS | 27471 | 04:44:16 INFO - PROCESS | 27471 | [#3] audio-fft Cycles:10 Average:89.10 Median:75.50 stddev:28.70 (38.0%) stddev-sans-first:30.05 04:44:16 INFO - PROCESS | 27471 | Values: 76.0 74.0 77.0 145.0 77.0 76.0 75.0 74.0 142.0 75.0 04:44:16 INFO - PROCESS | 27471 | 04:44:16 INFO - PROCESS | 27471 | [#4] audio-oscillator Cycles:10 Average:105.60 Median:93.00 stddev:20.23 (21.8%) stddev-sans-first:20.94 04:44:16 INFO - PROCESS | 27471 | Values: 93.0 98.0 147.0 92.0 93.0 93.0 124.0 93.0 93.0 130.0 04:44:16 INFO - PROCESS | 27471 | 04:44:16 INFO - PROCESS | 27471 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 04:44:16 INFO - PROCESS | 27471 | Values: 117.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 116.0 117.0 04:44:16 INFO - PROCESS | 27471 | 04:44:16 INFO - PROCESS | 27471 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 04:44:16 INFO - PROCESS | 27471 | Values: 146.0 145.0 145.0 146.0 146.0 146.0 146.0 146.0 145.0 146.0 04:44:16 INFO - PROCESS | 27471 | 04:44:16 INFO - PROCESS | 27471 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 04:44:16 INFO - PROCESS | 27471 | Values: 95.0 94.0 95.0 95.0 96.0 95.0 94.0 95.0 95.0 95.0 04:44:16 INFO - PROCESS | 27471 | 04:44:16 INFO - PROCESS | 27471 | [#8] json-parse-financial Cycles:10 Average:71.80 Median:66.00 stddev:18.71 (28.4%) stddev-sans-first:19.73 04:44:16 INFO - PROCESS | 27471 | Values: 66.0 66.0 66.0 66.0 67.0 66.0 67.0 125.0 65.0 64.0 04:44:16 INFO - PROCESS | 27471 | 04:44:16 INFO - PROCESS | 27471 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 04:44:16 INFO - PROCESS | 27471 | Values: 64.0 64.0 64.0 64.0 65.0 64.0 64.0 65.0 65.0 65.0 04:44:16 INFO - PROCESS | 27471 | 04:44:16 INFO - PROCESS | 27471 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:83.50 stddev:2.22 (2.7%) stddev-sans-first:1.69 04:44:16 INFO - PROCESS | 27471 | Values: 88.0 82.0 82.0 82.0 87.0 82.0 82.0 83.0 84.0 84.0 04:44:16 INFO - PROCESS | 27471 | 04:44:16 INFO - PROCESS | 27471 | [#11] stanford-crypto-ccm Cycles:10 Average:141.80 Median:137.00 stddev:21.63 (15.8%) stddev-sans-first:22.52 04:44:16 INFO - PROCESS | 27471 | Values: 130.0 136.0 149.0 138.0 132.0 129.0 139.0 130.0 201.0 134.0 04:44:16 INFO - PROCESS | 27471 | 04:44:16 INFO - PROCESS | 27471 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.50 Median:174.50 stddev:3.21 (1.8%) stddev-sans-first:2.96 04:44:16 INFO - PROCESS | 27471 | Values: 178.0 170.0 171.0 172.0 171.0 178.0 170.0 173.0 176.0 176.0 04:44:16 INFO - PROCESS | 27471 | 04:44:16 INFO - PROCESS | 27471 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:2.40 (3.5%) stddev-sans-first:2.55 04:44:16 INFO - PROCESS | 27471 | Values: 68.0 69.0 71.0 67.0 66.0 66.0 73.0 68.0 66.0 66.0 04:44:16 INFO - PROCESS | 27471 | -------- Summary: end -------- 04:44:16 INFO - PROCESS | 27471 | 04:44:17 INFO - TEST-INFO | 27471: exit 0 04:44:17 INFO - TEST-OK | kraken | took 65521ms 04:44:17 INFO - SUITE-END | took 1184s 04:44:17 INFO - Completed test suite (00:19:44) 04:44:17 INFO - javascript benchmark 04:44:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2670.6127611496336, 2672.8529930853806, 2688.6235926970216, 2708.891644334227, 2717.9864100679492, 4680.485146633876, 4726.716397016182, 4750.334953106568, 4827.420709514859, 4887.3890763654545, 4759.0, 4784.880377990543, 4789.688670236441, 4795.904081918359, 4807.639427042968, 4361.193179261831, 4390.97804510977, 4436.617971675875, 4480.0367920897, 4615.076984603076, 4481.417415735949, 4513.887152821189, 4549.567791059844, 4557.430321209848, 4579.954200458003, 4339.978300108511, 4389.934150987738, 4390.209762242795, 4398.252297109499, 4426.690131690783, 4421.425214722098, 4437.06821567468, 4481.596656300949, 4482.7758612069265, 4485.708428952108, 4453.198424283628, 4470.173017991649, 4472.575105364985, 4473.955260447419, 4517.819287228507, 4538.319252112176, 4615.884602884921, 4681.180793361148, 4702.224133018048, 4777.856664300077, 5121.8719532012, 5140.768665410065, 5177.792888284464, 5193.091209038441, 5212.0, 5037.471065538139, 5177.171652535576, 5178.97410512945, 5219.451957544441, 5222.973885130588, 4762.476127625993, 4804.183288840905, 4806.735629540409, 4860.3195552622665, 4886.560209581155, 5306.8407947761625, 5330.600204984642, 5364.061289274361, 5365.812196573102, 5368.248445217672, 4925.0, 4957.6281778866005, 5114.488551144856, 5138.820141295037, 5142.331496905378, 5063.569596584258, 5093.974530127326, 5115.590752739772, 5115.616328775357, 5163.070647283525, 5038.193888977819, 5051.292819005343, 5054.166062599704, 5065.772040258197, 5100.948990510122, 4918.754062296943, 4988.451270360258, 5048.697078175322, 5050.772715227824, 5057.671251368649, 4325.4593175853015, 4342.782860856944, 4345.956540434619, 4373.518912919576, 4392.626626736763, 3785.9242815143543, 3799.7910114943943, 3801.7718936863325, 3830.042489377656, 3833.1950290438763, 4294.506131794821, 4297.957020429756, 4355.412019377407, 4356.28121359972, 4373.9125217495475, 5099.643024988215, 5110.97444512775, 5124.743762811844, 5127.384713834289, 5153.0, 4359.498657654347, 4360.912781744348, 4361.890952726144, 4365.388845561624, 4410.911781764346, 4521.344405061248, 4596.931046034312, 4625.976870115628, 4649.790759415834, 4700.835470758507, 4843.588294994895, 4848.200046992207, 4861.416630004281, 4863.975680121577, 4913.1893237615395, 5180.559652429435, 5181.3782346118705, 5183.50756678115, 5185.11852985001, 5241.135212689864, 4725.385699858996, 4823.204171311834, 4848.80604775805, 4884.438289596742, 4894.0, 5113.463086375877, 5136.9743151284, 5145.125328694056, 5146.0479811235045, 5203.765830537711, 5043.672161309503, 5136.897262054813, 5146.794128234828, 5148.613853960893, 5152.716600586854, 4879.5120487952345, 4889.413270407574, 4920.975395123145, 4922.778474968563, 4949.529794669501, 4935.851924442272, 4949.109160351171, 4949.430815456125, 4955.380577427822, 5009.699418034929, 4813.78337974799, 4875.488073752347, 4882.072406242803, 4902.485239049848, 4963.751812409438, 5009.5491405773655, 5049.192129259301, 5064.72144032067, 5067.949320506896, 5118.564921981673, 4946.826861059845, 4954.950450495449, 4967.453580106113, 4969.35398398206, 5024.623153263593], "value": 4712.88205561831, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.1620899161348, 580.2630659062991, 594.860207851155, 598.4374687793471, 606.6360183889664, 28473.85763071187, 31727.0, 42904.570954290444, 43676.56323436765, 43698.0, 42521.787391063, 43127.0, 43132.0, 43196.13607727851, 43262.0, 7870.2916737493615, 8060.596970151499, 8061.113277539466, 8064.879026814573, 8067.273945344918, 7912.327452166573, 8042.959785201066, 8044.477108987897, 8046.959765201166, 8047.919520804805, 8046.678132874678, 8076.152004039579, 8078.0, 8085.797855053641, 8086.71696490623, 8009.759707208793, 8043.276105150565, 8052.798680032987, 8053.51678899265, 8061.516309021477, 7957.045154581488, 8019.198080191993, 8026.518408895427, 8028.518288902685, 8030.277275045274, 40483.0, 40530.0, 40736.592634073575, 40858.59141408578, 40886.59113408857, 3218.6459489456142, 3265.7224135948472, 3455.447128459434, 3501.124718820295, 3702.796346200958, 30222.17818839332, 30289.394212115854, 30531.69468305311, 31117.688823111705, 31272.687273127205, 3258.7393008559498, 3269.1663625775514, 3277.1970867137466, 3297.8351082445784, 3373.7638365314438, 247397.0, 301605.0, 307812.0, 310231.0, 438464.9999999968, 59125.40874591285, 59405.70297148487, 59601.105983410285, 59669.701651491465, 59692.0, 36003.4599481008, 37160.07099822472, 37179.0, 39132.80433597814, 39153.0, 14148.363323650461, 14303.856961430252, 14305.713885722227, 14412.13527188372, 14445.638859028608, 10724.249302548902, 10787.190960677824, 10789.298695584763, 10792.406417646947, 10799.190060745475, 19263.807361926483, 19300.22799088021, 19314.71027934582, 19324.227030918886, 19359.8064019358, 7180.246074162243, 7223.602701851449, 7243.348098671145, 7340.889886651705, 7424.665890034961, 887.3477993674644, 966.3187452845727, 997.2520609542843, 1024.3853687787416, 1105.6461932181785, 27955.72044279572, 28241.0, 28412.0, 28595.857020714764, 28800.279992999924, 1006.9093781559695, 1060.4326685223368, 1088.2382332367374, 1102.4818335382358, 1112.1992165640727, 15037.849621503645, 15277.854160937974, 15437.38250469991, 15715.21423928799, 15738.842611573738, 304311.0, 778753.0, 796704.0, 796863.0, 798350.0, 53163.46836531585, 53513.46486535163, 53846.46153538493, 53912.46087539153, 53925.460745392826, 1145.9770804583861, 1242.8197911302811, 1281.5450515067016, 1293.1012946002438, 1307.8626744191913, 26048.609270861332, 30492.0, 30534.0, 30925.381492369575, 31136.532952005284, 44013.779931100136, 44390.556094438645, 44667.32999005083, 44795.10409791721, 44866.55133448754, 302360.0, 305945.0, 306295.0, 306380.0, 306830.0, 23837.523249534566, 26726.0, 26864.32839178958, 27457.588136178372, 27513.17460476189, 44064.0, 44280.0, 44915.55084449114, 45722.77138614286, 45867.541324586324, 35151.82424087863, 35523.28953420969, 35928.82035589805, 36017.819910900274, 36215.63784362228, 37159.25681486301, 37229.25541489209, 37880.0, 38019.32054264913, 38019.42970855495, 37587.62412375951, 37785.62214377931, 37851.242975139794, 38399.616003839605, 39281.0, 33228.1692957678, 34755.0, 34937.82531087328, 34949.82525087358, 35354.29291414106, 25973.740262597134, 26128.477430451665, 26258.606120907818, 26488.602670960336, 26498.0], "value": 18420.501626622303, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.53703796178854, 376.96795772359366, 381.3098292091313, 382.7492992090181, 392.430975086125, 16088.91955540222, 18000.36998705044, 18165.09174541274, 18360.632787344246, 18379.172937217823, 17032.744508832347, 17328.740068898944, 17860.0, 18023.0, 18084.186211620476, 5167.4574169712205, 5250.343707036621, 5333.173358129496, 5370.140777475604, 5372.355317361922, 3639.7998110103936, 5292.894142117156, 5846.2107615472005, 6165.1677023601915, 6176.598521096137, 6143.232095988002, 6200.100985357143, 6207.658578778165, 6230.221222347207, 6238.251409830827, 6036.3360030396625, 6145.047517634774, 6179.104029915682, 6213.099100630406, 6221.035739460368, 3260.6250281217726, 3437.7937323760652, 3440.3291358185165, 3471.1669199392218, 5011.448740638527, 20163.798362016485, 20952.5809483811, 21470.248541301135, 21505.67741483879, 21653.566928661498, 2044.488877780555, 2159.2010955946243, 2251.1097019657605, 2434.951300973971, 2590.663213782196, 12451.315177665225, 13294.376913335238, 13394.933025334909, 13508.662283442894, 13829.239391833446, 1766.8056513783474, 1804.2422182683304, 1817.5274428648515, 1824.9908750456163, 1885.3118611706766, 63497.0, 64456.35543644597, 64623.676881615764, 65654.67172664106, 67813.66093169502, 9334.953325233331, 9671.371360861522, 9785.26610504215, 9803.264755143393, 10088.546015429323, 12627.305498197504, 12841.486340546273, 12876.80684789729, 12883.806742898863, 12942.0, 6956.513044086865, 7009.2990700929495, 7088.645567721594, 7117.928820711727, 7217.458690598226, 6650.501212408992, 6662.200535935719, 6793.490488213305, 6814.965925170342, 6853.143357080365, 6234.220722409699, 6256.468200202943, 6272.529560282997, 6277.2781130170615, 6375.234971803413, 1586.5954181683596, 1621.5946013496625, 1732.385003323827, 1734.0, 1779.234928980525, 889.857622780352, 894.065701342099, 898.5507246376811, 926.3885835348638, 966.5408930757974, 16848.57878553046, 17406.39077632277, 17481.56296092608, 17640.20619072145, 18145.909270453827, 846.1580727176499, 885.610331454171, 977.9462129582942, 983.7934033852828, 995.5320999130397, 9274.860877086849, 9502.287328450255, 9700.417974921527, 9787.51062446889, 9922.206223502248, 419302.0, 420887.0, 443718.0, 448986.0, 453247.0, 83258.58370708108, 88528.5573572128, 88941.0, 91017.54491227501, 91494.0, 970.9708708738749, 981.4062492192263, 984.684900831727, 997.5959736306808, 1006.2201793609864, 14658.853411465749, 15993.1203783793, 16092.356305748108, 16247.70018398549, 16547.503574892773, 31799.205019873763, 35869.282614347045, 36676.44985325169, 36820.81589592035, 37233.81383093176, 45410.0, 49377.50622493729, 49669.75165124296, 49838.75080624719, 50268.0, 6498.610083395011, 6784.3894049535775, 7930.881036784337, 7945.1657575953695, 7986.7603971880935, 10483.895161048596, 11488.48301826403, 11506.654800356002, 11603.0, 11653.59212427561, 10231.130353919703, 10342.638007669695, 10371.429571373345, 10458.68623941283, 10462.63380781669, 10116.393016419039, 10235.590576377159, 10351.792964140826, 10398.220133489867, 10510.0, 10454.947725261629, 10511.94744026275, 10641.965524073768, 10650.094741946712, 10687.946560267148, 6952.721891124298, 7059.964700176466, 7062.364387205176, 7134.357907788324, 7212.350888420067, 9433.292503062436, 10027.44849033281, 10174.440405777754, 10501.789964200825, 10506.947465262625], "value": 8468.839226821798, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1181.7695549367866, 1452.789345544896, 1503.2408633640014, 1650.1996531682132, 1826.7625208722857, 7080.4335653147755, 7411.221821708724, 7428.702851885918, 7594.240575942403, 7597.544147351149, 7348.816279593013, 7503.962480187605, 7518.060242469692, 7522.360599349062, 7524.05949256343, 2177.7277840269967, 2206.382212980368, 2206.580749657568, 2206.6359050756687, 2207.3377986604037, 2211.5908556916943, 2222.3333000099988, 2258.4015235962484, 2258.503129311557, 2262.2082271205113, 2186.5736181444627, 2189.179057853305, 2216.2021672198, 2220.0, 2220.4670878989086, 2180.607490651682, 2188.6060509108356, 2213.6015517206897, 2215.9224427145055, 2220.3449982255274, 2115.5663089066707, 2122.564874200785, 2125.7130287411155, 2143.3141394753684, 2145.131221855151, 7123.394511466531, 7297.124345078571, 7363.637727020465, 7368.0, 7398.445116616275, 4440.444944381952, 4524.5927866492175, 4543.0459603483305, 4547.658925580562, 4550.362949187116, 2881.0780550223935, 2961.2596850787304, 3014.216303761016, 3017.336186039068, 3033.3023404616843, 939.9953000235023, 952.2429668413628, 956.9330146889721, 966.4249771386085, 974.9805003899953, 9881.80236395268, 9964.05341492557, 9971.800563988752, 9995.550200241007, 10005.249606279558, 3899.2396482685604, 3979.641832235113, 4032.6169013943627, 4057.715959882839, 4088.468499095158, 7822.413319000984, 7877.645505952246, 7887.645055972495, 7889.132195458495, 7899.368050555941, 4468.55314468557, 4530.728156310632, 4531.3882625845745, 4552.248878934939, 4558.703684260512, 3497.492863534824, 3986.421968814506, 4146.5853414658895, 4216.47294088239, 4237.724547904377, 3204.3110731192905, 3246.7077962983444, 3249.2851572653976, 3270.149761062141, 3326.6673332667024, 1015.9898401015895, 1054.6308791922766, 1062.888396718349, 1067.7597540553468, 1068.4764465411893, 737.6717360774404, 860.6041221038267, 884.4428010353436, 892.683097500391, 906.1482206725657, 4902.48523904992, 4945.67853089548, 5038.269450929594, 5064.290999260106, 5120.462351453044, 417.67004066787507, 423.3332501310387, 431.7905815679393, 434.9347597860283, 440.5682431217361, 3430.1767575781632, 3436.1753179236803, 3443.8794642187904, 3447.1554469155217, 3546.8226588670464, 8844.778880528038, 9182.770430739285, 9239.630414783467, 9242.72271831846, 9302.86045709315, 9137.360384773003, 9163.404378715362, 9198.816023679623, 9253.629854805733, 9269.397489163182, 6863.553868998499, 6908.309169083152, 6909.963505474219, 6950.756723514653, 6974.093367862146, 4908.558229759339, 4908.9754551227015, 5029.497050294941, 5068.239764035424, 5110.71891045996, 8005.239502247277, 8224.547649879314, 8517.872231916403, 8521.744347669579, 8637.56812159402, 7985.321247693779, 8210.261076503144, 8261.256486916207, 8517.616707248064, 8592.785180370542, 5468.316460442445, 6105.664188469676, 6355.459785918249, 6453.741850325934, 6530.67346632657, 6862.828429289308, 7172.103487064117, 7189.820254493679, 7213.314735100157, 7222.494425390382, 6351.809445716636, 6518.413342799171, 6529.771457998947, 6562.573432727048, 6594.4724422045165, 6326.2092238470195, 6357.809265722036, 6402.935970640234, 6493.415592596689, 6528.21661400616, 6096.603720758137, 6129.08063790435, 6160.137580738789, 6166.907496387647, 6171.074338849208, 4325.48094228682, 4334.111507141091, 4393.516713161485, 4446.577575130357, 4467.0, 4215.494140703136, 4281.079567892918, 4301.204277208726, 4322.265214913409, 4359.803808828674], "value": 3918.0540724063244, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.8495752123937, 308.4632739034081, 315.7821103438627, 317.4048658764816, 318.8007495315428, 4537.342085397615, 4702.788374523147, 4757.357756702849, 4761.619070474358, 4802.399700037496, 4627.259638457847, 4757.8096876125, 4771.212749896263, 4774.40319960005, 4791.377120974277, 3766.435034744783, 3791.507104076466, 3792.184680293736, 3793.848246070154, 3808.3906574948014, 3585.0, 3639.7452178347526, 3784.0, 3791.886243412688, 3811.1805961718223, 3746.83139258734, 3766.623337666239, 3773.4528493368584, 3778.4521244419543, 3783.2622638585485, 3719.274741425423, 3755.6995440364703, 3771.9622803771886, 3785.1294202333343, 3787.072167318997, 3374.3757404880175, 3377.5946886373545, 3379.3579219948133, 3386.9322613547592, 3407.8807241746667, 4504.8873778155485, 4550.38569793077, 4578.244589642705, 4582.358469814229, 4609.216433206363, 4236.6187043166265, 4256.34026725858, 4264.573542645741, 4268.338407546835, 4270.487541495009, 4903.681260718042, 4925.7783399747095, 4943.096907690529, 4944.703317800908, 4958.380202474691, 3499.475078738184, 3595.94606080909, 3625.655562721537, 3627.7689221128817, 3647.3981793004123, 5147.202183661539, 5154.948450515484, 5155.793768249303, 5160.0, 5187.351581052406, 3682.2451397463456, 3700.40793473043, 3703.9444408333898, 3727.4036154215196, 3738.5513738351574, 3757.229767897574, 3760.435934609776, 3768.77387356754, 3771.5662698789442, 3791.962080379161, 4135.8966025849595, 4285.357196420562, 4286.635635970977, 4292.399064131024, 4301.3117901135665, 4850.95149048512, 4947.243728476411, 4949.183384741549, 4958.7024778513405, 4979.775910084055, 1193.2065176657425, 1233.210745123122, 1253.260576260011, 1269.162352847135, 1270.866559011309, 873.8770679676585, 883.1389395339621, 893.0176805513883, 893.1202765276198, 907.5008745190119, 4222.345536441856, 4230.5769423057445, 4245.766482843412, 4253.170631726845, 4254.0, 4896.192128298862, 4944.242375794351, 4953.678010929278, 4961.677490963076, 4968.776405061781, 4190.769507677107, 4217.915641687149, 4226.8798768326415, 4238.766867822238, 4259.829606815754, 2488.8133389995824, 2568.2680436076002, 2585.4699786543715, 2594.3125071855975, 2606.8566228857217, 4620.930686039712, 4633.212353899845, 4656.41794775653, 4679.9704065105625, 4719.702081927498, 5005.371105948158, 5014.771381011603, 5029.044481548494, 5035.446100928895, 5046.495350464924, 4510.534570774909, 4607.907841843212, 4610.723356598548, 4673.0, 4688.765561721969, 4923.236898280772, 4927.211646136601, 4927.457979622167, 4947.822957898513, 4958.528939750718, 4764.547368000034, 4791.305260737243, 4798.4001999750035, 4843.861692502189, 4857.222844344888, 4391.802368893472, 4612.354270402079, 4619.630429565559, 4644.0, 4692.7888245029735, 3606.2787442512126, 3611.656892595199, 3615.602283748838, 3615.6565126312958, 3622.4747411625694, 4872.759614856081, 4913.70517768935, 4926.187179115406, 4932.186189278729, 4984.526469985346, 4825.203841366135, 4976.626752993468, 4979.0788704089855, 4988.301637770643, 5002.449730529566, 4878.878028049186, 4943.950560494349, 4944.159492886146, 4950.579200767975, 4984.651074424755, 4666.346711460466, 4890.508394939578, 4901.215805471107, 4910.2880082388565, 4930.901381972412, 4995.0, 4997.350344455198, 5012.122878496321, 5020.548150666457, 5057.519535644108, 4921.237208232729, 4924.236743304794, 4930.433000205022, 4936.753162341796, 4958.925466210972], "value": 3731.8364968907035, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.9361957423831, 779.2558107007808, 811.8944537210164, 820.9409861278947, 831.3806214370295, 10949.726256843573, 11578.710532236699, 11701.0, 11711.472983715732, 11733.58932437366, 11334.489947952341, 11693.941530292337, 11696.122790790681, 11997.940010299937, 12032.278063316207, 669.250439507752, 868.7002983970551, 884.1732979664002, 884.2483888694622, 884.2925659472396, 849.7068511363569, 876.3777717820324, 878.2798105553449, 884.2704768565927, 884.4162852517339, 903.9638414463413, 908.3550679017906, 909.3270979475207, 909.9363044586881, 910.4901255297021, 697.2260790522516, 716.8494616130619, 914.4284821986258, 914.8444764390036, 914.9405288656216, 529.8172130614931, 647.3429469088878, 665.5540787672223, 666.3702800853196, 667.6995352091529, 10799.892001080047, 10811.6215932442, 10813.67558973232, 10825.67522974312, 10844.511996960156, 10573.9471302643, 10884.455777211188, 10977.12183025356, 11021.44892755367, 11402.144839137098, 11281.774364512747, 11299.717507062307, 11369.715757106138, 11414.942925285404, 11442.42787860612, 4156.630720489322, 4190.371444283352, 4237.364395340693, 4245.3844192591905, 4286.828526858922, 42920.78539607313, 43207.783961080306, 43395.13209735788, 43434.78282608598, 43510.78244608756, 9497.46793883256, 9539.761505962268, 9700.369475984038, 9873.111419972238, 10088.192944564416, 17406.825931740776, 17424.215910284067, 17431.04129272902, 17445.127743612768, 17458.039807810692, 6523.869522609616, 6584.0, 6612.23959244693, 6626.271110177877, 6716.630585317855, 3558.377283975294, 3698.907527311785, 3715.1640880802142, 3721.10693433574, 3761.4921985531605, 2883.33683252853, 2916.431295897322, 2949.631296087989, 2951.026161366744, 2974.6579143398353, 516.2024671881951, 521.1713375732603, 522.8144008876794, 529.1269405480987, 535.5100083423702, 518.6265888560231, 534.6658338538414, 539.2232593604084, 571.5656101362994, 601.6781022153127, 7234.74678386254, 7360.374368178657, 7398.038255026812, 7490.063742032246, 7508.5119467235545, 557.6727388814676, 595.4016213705198, 595.4194660206351, 598.1267349669531, 612.4732729852324, 3475.9826200868833, 3530.7289375824685, 3543.53933988585, 3553.911152221215, 3625.6736893679695, 50700.0, 51302.74348628233, 52376.47623523792, 53173.202401964, 53259.73370133124, 44301.77849110734, 44682.55317446849, 45824.312635310496, 46535.76732116318, 47636.0, 44075.559244407785, 44173.11653766907, 44873.0, 45622.54377456183, 45747.31379029317, 7126.35862772353, 7599.392048635986, 7643.044619422572, 7664.540127592362, 7742.612869356397, 29594.0, 29779.55330670085, 30054.398912022076, 30435.84782076164, 31034.0, 36184.63815361813, 38205.61794382021, 38385.42421863618, 38525.61474385332, 38659.0, 8751.474911505074, 8793.91206087931, 8870.112988701336, 10844.45777711127, 10854.403007834644, 9054.502002389932, 9117.403411416031, 9594.136527712539, 9662.323637345318, 9978.002199779963, 8559.614817333111, 8781.25359344463, 8992.55037248148, 9041.634285544738, 9245.58394872219, 8343.582820858812, 8546.487210767375, 8575.614097365758, 8757.992830824536, 9002.144796244347, 8519.574021299035, 8647.0, 8665.306775458075, 8847.380683352103, 8864.689735859214, 7301.269873012869, 7340.70637174507, 7456.888146677913, 7495.887561686688, 7553.5845528494265, 7224.0, 7486.064241969754, 7508.587027713528, 7608.771736847903, 7805.453618246668], "value": 5701.1807099838325, "unit": "score"}], "name": "dromaeo_css", "value": 6279.198216589316, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 109.0, 115.0, 118.0, 114.0, 114.0, 114.0, 113.0, 114.0, 113.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 128.0, 159.0, 212.0, 140.0, 160.0, 166.0, 131.0, 180.0, 140.0], "value": 158.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 160.0, 161.0, 162.0, 163.0, 162.0, 161.0, 160.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 77.0, 145.0, 77.0, 76.0, 75.0, 74.0, 142.0, 75.0], "value": 89.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 98.0, 147.0, 92.0, 93.0, 93.0, 124.0, 93.0, 93.0, 130.0], "value": 105.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 96.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 67.0, 66.0, 67.0, 125.0, 65.0, 64.0], "value": 71.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 65.0, 65.0, 65.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 82.0, 82.0, 82.0, 87.0, 82.0, 82.0, 83.0, 84.0, 84.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 136.0, 149.0, 138.0, 132.0, 129.0, 139.0, 130.0, 201.0, 134.0], "value": 141.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 170.0, 171.0, 172.0, 171.0, 178.0, 170.0, 173.0, 176.0, 176.0], "value": 173.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 71.0, 67.0, 66.0, 66.0, 73.0, 68.0, 66.0, 66.0], "value": 68.0, "unit": "score"}], "name": "kraken", "value": 1588.9, "alertThreshold": 2.0}]} 04:44:17 INFO - Return code: 0 04:44:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:44:17 ERROR - # TBPL SUCCESS # 04:44:17 INFO - Running post-action listener: _resource_record_post_action 04:44:17 INFO - ##### 04:44:17 INFO - ##### Finished run-tests step (success) 04:44:17 INFO - ##### 04:44:17 INFO - Running post-run listener: _resource_record_post_run 04:44:18 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 0; Write bytes: 528605184; Read time: 0; Write time: 533952 04:44:18 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 234741760; Read time: 0; Write time: 248664 04:44:18 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 293863424; Read time: 0; Write time: 285288 04:44:18 INFO - Running post-run listener: _upload_blobber_files 04:44:18 INFO - Blob upload gear active. 04:44:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:44:18 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:44:18 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:44:18 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:44:19 INFO - (blobuploader) - INFO - Open directory for files ... 04:44:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:44:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:44:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:44:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:44:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:44:20 INFO - (blobuploader) - INFO - Done attempting. 04:44:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:44:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:44:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:44:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:44:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:44:21 INFO - (blobuploader) - INFO - Done attempting. 04:44:21 INFO - (blobuploader) - INFO - Iteration through files over. 04:44:21 INFO - Return code: 0 04:44:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:44:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:44:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e5f639767358d53fde598fd84a5888412d4e0a55bff9526ed1dd1fe889555b004379fa93b2c8ff40141187e3bcd5cb3457c98c75e1b98f5cad44202792d31c9e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eea36b1708cc70d839c38cf391e94cfce9bbca56efe8e8ccdbdfd44b7af2d25c1dbf28a8b33fd92e6b069834a3a3e25d261f6a41193d29b944f2048e5dddc3fc"} 04:44:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:44:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:44:21 INFO - Contents: 04:44:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e5f639767358d53fde598fd84a5888412d4e0a55bff9526ed1dd1fe889555b004379fa93b2c8ff40141187e3bcd5cb3457c98c75e1b98f5cad44202792d31c9e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eea36b1708cc70d839c38cf391e94cfce9bbca56efe8e8ccdbdfd44b7af2d25c1dbf28a8b33fd92e6b069834a3a3e25d261f6a41193d29b944f2048e5dddc3fc"} 04:44:21 INFO - Running post-run listener: copy_logs_to_upload_dir 04:44:21 INFO - Copying logs to upload dir... 04:44:21 INFO - mkdir: /builds/slave/test/build/upload/logs 04:44:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.115532 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-09 04:44:20.775531) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 04:44:20.781518) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1462792983.479185-972499090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e5f639767358d53fde598fd84a5888412d4e0a55bff9526ed1dd1fe889555b004379fa93b2c8ff40141187e3bcd5cb3457c98c75e1b98f5cad44202792d31c9e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eea36b1708cc70d839c38cf391e94cfce9bbca56efe8e8ccdbdfd44b7af2d25c1dbf28a8b33fd92e6b069834a3a3e25d261f6a41193d29b944f2048e5dddc3fc"} build_url:https://queue.taskcluster.net/v1/task/M4wkJiVKQDa5z1MyGphD2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011345 build_url: 'https://queue.taskcluster.net/v1/task/M4wkJiVKQDa5z1MyGphD2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e5f639767358d53fde598fd84a5888412d4e0a55bff9526ed1dd1fe889555b004379fa93b2c8ff40141187e3bcd5cb3457c98c75e1b98f5cad44202792d31c9e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eea36b1708cc70d839c38cf391e94cfce9bbca56efe8e8ccdbdfd44b7af2d25c1dbf28a8b33fd92e6b069834a3a3e25d261f6a41193d29b944f2048e5dddc3fc"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 04:44:20.805738) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 04:44:20.806049) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1462792983.479185-972499090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004540 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 04:44:20.888288) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 04:44:20.888653) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 04:44:20.888932) ========= ========= Total master_lag: 0.24 =========