builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-004 starttime: 1463048581.99 results: success (0) buildid: 20160512003946 builduid: 98c888a95b8c4fb79c0a7b36c9ba277d revision: 93a53170dedffdff45bf9eb8dac6e5ef7a13c4ba ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-12 03:23:01.985935) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-12 03:23:01.986608) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-12 03:23:01.987064) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-12 03:23:02.007917) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 03:23:02.008257) ========= 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=c6927cf182745ad25b1d38b9000001fe-1463048581.421689-1784723497 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-12 03:23:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-05-12 03:23:02 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116847 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 03:23:02.138365) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 03:23:02.141806) ========= 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=c6927cf182745ad25b1d38b9000001fe-1463048581.421689-1784723497 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020417 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 03:23:02.191512) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 03:23:02.191973) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 93a53170dedffdff45bf9eb8dac6e5ef7a13c4ba --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 93a53170dedffdff45bf9eb8dac6e5ef7a13c4ba --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=c6927cf182745ad25b1d38b9000001fe-1463048581.421689-1784723497 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-12 03:23:02,615 truncating revision to first 12 chars 2016-05-12 03:23:02,615 Setting DEBUG logging. 2016-05-12 03:23:02,615 attempt 1/10 2016-05-12 03:23:02,616 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/93a53170dedf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-12 03:23:02,875 unpacking tar archive at: mozilla-beta-93a53170dedf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.547448 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 03:23:02.758540) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-12 03:23:02.758901) ========= script_repo_revision: 93a53170dedffdff45bf9eb8dac6e5ef7a13c4ba ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-12 03:23:02.759312) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-12 03:23:02.759658) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-12 03:23:02.771270) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-05-12 03:23:02.771727) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=c6927cf182745ad25b1d38b9000001fe-1463048581.421689-1784723497 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:23:03 INFO - MultiFileLogger online at 20160512 03:23:03 in /builds/slave/test 03:23:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 03:23:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:23:03 INFO - {'append_to_log': False, 03:23:03 INFO - 'base_work_dir': '/builds/slave/test', 03:23:03 INFO - 'blob_upload_branch': 'Mozilla-Beta', 03:23:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:23:03 INFO - 'branch': 'Mozilla-Beta', 03:23:03 INFO - 'buildbot_json_path': 'buildprops.json', 03:23:03 INFO - 'config_files': ('talos/linux_config.py',), 03:23:03 INFO - 'default_actions': ('clobber', 03:23:03 INFO - 'read-buildbot-config', 03:23:03 INFO - 'download-and-extract', 03:23:03 INFO - 'populate-webroot', 03:23:03 INFO - 'create-virtualenv', 03:23:03 INFO - 'install', 03:23:03 INFO - 'run-tests'), 03:23:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:23:03 INFO - 'download_minidump_stackwalk': True, 03:23:03 INFO - 'download_symbols': 'ondemand', 03:23:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:23:03 INFO - 'tooltool.py': '/tools/tooltool.py', 03:23:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:23:03 INFO - '/tools/misc-python/virtualenv.py')}, 03:23:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:23:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:23:03 INFO - 'installer_path': 'installer.exe', 03:23:03 INFO - 'log_level': 'info', 03:23:03 INFO - 'log_name': 'talos', 03:23:03 INFO - 'log_to_console': True, 03:23:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:23:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:23:03 INFO - 'opt_config_files': (), 03:23:03 INFO - 'pip_index': False, 03:23:03 INFO - 'sps_profile': False, 03:23:03 INFO - 'sps_profile_interval': 0, 03:23:03 INFO - 'suite': 'dromaeojs', 03:23:03 INFO - 'system_bits': '32', 03:23:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:23:03 INFO - 'title': 'talos-linux64-ix-004', 03:23:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:23:03 INFO - 'use_talos_json': True, 03:23:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:23:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:23:03 INFO - 'work_dir': 'build'} 03:23:03 INFO - ##### 03:23:03 INFO - ##### Running clobber step. 03:23:03 INFO - ##### 03:23:03 INFO - Running pre-action listener: _resource_record_pre_action 03:23:03 INFO - Running main action method: clobber 03:23:03 INFO - rmtree: /builds/slave/test/build 03:23:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:23:04 INFO - Running post-action listener: _resource_record_post_action 03:23:04 INFO - ##### 03:23:04 INFO - ##### Running read-buildbot-config step. 03:23:04 INFO - ##### 03:23:04 INFO - Running pre-action listener: _resource_record_pre_action 03:23:04 INFO - Running main action method: read_buildbot_config 03:23:04 INFO - Using buildbot properties: 03:23:04 INFO - { 03:23:04 INFO - "project": "", 03:23:04 INFO - "product": "firefox", 03:23:04 INFO - "script_repo_revision": "production", 03:23:04 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 03:23:04 INFO - "repository": "", 03:23:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 03:23:04 INFO - "buildid": "20160512003946", 03:23:04 INFO - "pgo_build": "True", 03:23:04 INFO - "basedir": "/builds/slave/test", 03:23:04 INFO - "buildnumber": 91, 03:23:04 INFO - "slavename": "talos-linux64-ix-004", 03:23:04 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:23:04 INFO - "platform": "ubuntu64_hw", 03:23:04 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 03:23:04 INFO - "branch": "mozilla-beta", 03:23:04 INFO - "repo_path": "releases/mozilla-beta", 03:23:04 INFO - "revision": "93a53170dedffdff45bf9eb8dac6e5ef7a13c4ba", 03:23:04 INFO - "stage_platform": "linux64-pgo", 03:23:04 INFO - "builduid": "98c888a95b8c4fb79c0a7b36c9ba277d", 03:23:04 INFO - "slavebuilddir": "test" 03:23:04 INFO - } 03:23:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/OEGpvG6FQTiNV5Bu6m7RvQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2. 03:23:04 INFO - Running post-action listener: _resource_record_post_action 03:23:04 INFO - ##### 03:23:04 INFO - ##### Running download-and-extract step. 03:23:04 INFO - ##### 03:23:04 INFO - Running pre-action listener: _resource_record_pre_action 03:23:04 INFO - Running main action method: download_and_extract 03:23:04 INFO - mkdir: /builds/slave/test/build/tests 03:23:04 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')]} 03:23:04 INFO - https://queue.taskcluster.net/v1/task/OEGpvG6FQTiNV5Bu6m7RvQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:23:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OEGpvG6FQTiNV5Bu6m7RvQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 03:23:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OEGpvG6FQTiNV5Bu6m7RvQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 03:23:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OEGpvG6FQTiNV5Bu6m7RvQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 03:23:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OEGpvG6FQTiNV5Bu6m7RvQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:23:05 INFO - Downloaded 1412 bytes. 03:23:05 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 03:23:05 INFO - Using the following test package requirements: 03:23:05 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 03:23:05 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 03:23:05 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 03:23:05 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 03:23:05 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 03:23:05 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 03:23:05 INFO - u'jsshell-linux-x86_64.zip'], 03:23:05 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 03:23:05 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 03:23:05 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 03:23:05 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 03:23:05 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 03:23:05 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 03:23:05 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 03:23:05 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 03:23:05 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 03:23:05 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 03:23:05 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 03:23:05 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 03:23:05 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:23:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:05 INFO - https://queue.taskcluster.net/v1/task/OEGpvG6FQTiNV5Bu6m7RvQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:23:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OEGpvG6FQTiNV5Bu6m7RvQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 03:23:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OEGpvG6FQTiNV5Bu6m7RvQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 03:23:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OEGpvG6FQTiNV5Bu6m7RvQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 03:23:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OEGpvG6FQTiNV5Bu6m7RvQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:23:06 INFO - Downloaded 23364534 bytes. 03:23:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:23:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:23:07 INFO - Return code: 0 03:23:07 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:23:07 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')]} 03:23:07 INFO - https://queue.taskcluster.net/v1/task/OEGpvG6FQTiNV5Bu6m7RvQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:23:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OEGpvG6FQTiNV5Bu6m7RvQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 03:23:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OEGpvG6FQTiNV5Bu6m7RvQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 03:23:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OEGpvG6FQTiNV5Bu6m7RvQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 03:23:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OEGpvG6FQTiNV5Bu6m7RvQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:23:09 INFO - Downloaded 23364534 bytes. 03:23:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:23:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:23:10 INFO - Return code: 0 03:23: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')]} 03:23:10 INFO - https://queue.taskcluster.net/v1/task/OEGpvG6FQTiNV5Bu6m7RvQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:23:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OEGpvG6FQTiNV5Bu6m7RvQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 03:23:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OEGpvG6FQTiNV5Bu6m7RvQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 03:23:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OEGpvG6FQTiNV5Bu6m7RvQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 03:23:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OEGpvG6FQTiNV5Bu6m7RvQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:23:11 INFO - Downloaded 10845194 bytes. 03:23:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:23:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:23:12 INFO - Return code: 0 03:23: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')]} 03:23:12 INFO - https://queue.taskcluster.net/v1/task/OEGpvG6FQTiNV5Bu6m7RvQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:23:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OEGpvG6FQTiNV5Bu6m7RvQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 03:23:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OEGpvG6FQTiNV5Bu6m7RvQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 03:23:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OEGpvG6FQTiNV5Bu6m7RvQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 03:23:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OEGpvG6FQTiNV5Bu6m7RvQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:23:14 INFO - Downloaded 53793025 bytes. 03:23:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OEGpvG6FQTiNV5Bu6m7RvQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 03:23:14 INFO - mkdir: /builds/slave/test/properties 03:23:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:23:14 INFO - Writing to file /builds/slave/test/properties/build_url 03:23:14 INFO - Contents: 03:23:14 INFO - build_url:https://queue.taskcluster.net/v1/task/OEGpvG6FQTiNV5Bu6m7RvQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 03:23:15 INFO - Running post-action listener: _resource_record_post_action 03:23:15 INFO - Running post-action listener: set_extra_try_arguments 03:23:15 INFO - ##### 03:23:15 INFO - ##### Running populate-webroot step. 03:23:15 INFO - ##### 03:23:15 INFO - Running pre-action listener: _resource_record_pre_action 03:23:15 INFO - Running main action method: populate_webroot 03:23:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:23:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:23:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:23:15 INFO - '--tppagecycles', 03:23:15 INFO - '7'], 03:23:15 INFO - 'tests': ['tsvgm']}}, 03:23:15 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:23:15 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:23:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:23:15 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 03:23:15 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:23:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:23:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:23:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:15 INFO - 'talos_options': ['--e10s'], 03:23:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:23:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:15 INFO - 'tests': ['damp', 'tps']}, 03:23:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:15 INFO - 'talos_options': ['--e10s'], 03:23:15 INFO - 'tests': ['damp', 'tps']}, 03:23:15 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:23:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:23:15 INFO - 'other': {'tests': ['a11yr', 03:23:15 INFO - 'ts_paint', 03:23:15 INFO - 'tpaint', 03:23:15 INFO - 'sessionrestore', 03:23:15 INFO - 'sessionrestore_no_auto_restore', 03:23:15 INFO - 'tabpaint']}, 03:23:15 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:23:15 INFO - 'tests': ['a11yr', 03:23:15 INFO - 'ts_paint', 03:23:15 INFO - 'tpaint', 03:23:15 INFO - 'sessionrestore', 03:23:15 INFO - 'sessionrestore_no_auto_restore', 03:23:15 INFO - 'tabpaint']}, 03:23:15 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:23:15 INFO - 'tests': ['a11yr', 03:23:15 INFO - 'ts_paint', 03:23:15 INFO - 'tpaint', 03:23:15 INFO - 'sessionrestore', 03:23:15 INFO - 'sessionrestore_no_auto_restore', 03:23:15 INFO - 'tabpaint']}, 03:23:15 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:23:15 INFO - 'tests': ['a11yr', 03:23:15 INFO - 'ts_paint', 03:23:15 INFO - 'tpaint', 03:23:15 INFO - 'sessionrestore', 03:23:15 INFO - 'sessionrestore_no_auto_restore', 03:23:15 INFO - 'tabpaint']}, 03:23:15 INFO - 'other_l64': {'tests': ['a11yr', 03:23:15 INFO - 'ts_paint', 03:23:15 INFO - 'tpaint', 03:23:15 INFO - 'sessionrestore', 03:23:15 INFO - 'sessionrestore_no_auto_restore', 03:23:15 INFO - 'tabpaint']}, 03:23:15 INFO - 'other_nol64': {'tests': ['a11yr', 03:23:15 INFO - 'ts_paint', 03:23:15 INFO - 'tpaint', 03:23:15 INFO - 'sessionrestore', 03:23:15 INFO - 'sessionrestore_no_auto_restore', 03:23:15 INFO - 'tabpaint']}, 03:23:15 INFO - 'svgr': {'tests': ['tsvgx', 03:23:15 INFO - 'tsvgr_opacity', 03:23:15 INFO - 'tart', 03:23:15 INFO - 'tscrollx', 03:23:15 INFO - 'cart']}, 03:23:15 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:23:15 INFO - 'tests': ['tsvgx', 03:23:15 INFO - 'tsvgr_opacity', 03:23:15 INFO - 'tart', 03:23:15 INFO - 'tscrollx', 03:23:15 INFO - 'cart']}, 03:23:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:15 INFO - 'tests': ['tp5o']}, 03:23:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:15 INFO - 'talos_options': ['--e10s'], 03:23:15 INFO - 'tests': ['tp5o']}, 03:23:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:15 INFO - 'talos_options': ['--xperf_path', 03:23:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:23:15 INFO - 'tests': ['tp5n']}, 03:23:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:15 INFO - 'talos_options': ['--e10s', 03:23:15 INFO - '--xperf_path', 03:23:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:23:15 INFO - 'tests': ['tp5n']}}, 03:23:15 INFO - 'talos.zip': {'path': '', 03:23:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:23:15 INFO - Running post-action listener: _resource_record_post_action 03:23:15 INFO - ##### 03:23:15 INFO - ##### Running create-virtualenv step. 03:23:15 INFO - ##### 03:23:15 INFO - Running pre-action listener: _resource_record_pre_action 03:23:15 INFO - Running main action method: create_virtualenv 03:23:15 INFO - Creating virtualenv /builds/slave/test/build/venv 03:23:15 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 03:23:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:23:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:23:15 INFO - Using real prefix '/usr' 03:23:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:23:16 INFO - Installing distribute.............................................................................................................................................................................................done. 03:23:18 INFO - Installing pip.................done. 03:23:18 INFO - Return code: 0 03:23:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:23:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:18 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 0x7f584a0d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fca410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2059160>, '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 0x205a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205a4f0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1463048581.421689-1784723497', '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 03:23:18 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 03:23:18 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 03:23:18 INFO - Using env: {'DISPLAY': ':0', 03:23:18 INFO - 'HOME': '/home/cltbld', 03:23:18 INFO - 'LANG': 'en_US.UTF-8', 03:23:18 INFO - 'LANGUAGE': 'en_US:en', 03:23:18 INFO - 'LOGNAME': 'cltbld', 03:23:18 INFO - 'MAIL': '/var/mail/cltbld', 03:23:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:18 INFO - 'MOZ_NO_REMOTE': '1', 03:23:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:18 INFO - 'NO_EM_RESTART': '1', 03:23:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:18 INFO - 'PWD': '/builds/slave/test', 03:23:18 INFO - 'SHELL': '/bin/bash', 03:23:18 INFO - 'SHLVL': '1', 03:23:18 INFO - 'TERM': 'linux', 03:23:18 INFO - 'TMOUT': '86400', 03:23:18 INFO - 'USER': 'cltbld', 03:23:18 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1463048581.421689-1784723497', 03:23:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:18 INFO - '_': '/tools/buildbot/bin/python'} 03:23:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:18 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 03:23:18 INFO - Cleaning up... 03:23:18 INFO - Return code: 0 03:23:18 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:23:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:18 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 0x7f584a0d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fca410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2059160>, '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 0x205a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205a4f0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1463048581.421689-1784723497', '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 03:23:18 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 03:23:18 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 03:23:18 INFO - Using env: {'DISPLAY': ':0', 03:23:18 INFO - 'HOME': '/home/cltbld', 03:23:18 INFO - 'LANG': 'en_US.UTF-8', 03:23:18 INFO - 'LANGUAGE': 'en_US:en', 03:23:18 INFO - 'LOGNAME': 'cltbld', 03:23:18 INFO - 'MAIL': '/var/mail/cltbld', 03:23:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:18 INFO - 'MOZ_NO_REMOTE': '1', 03:23:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:18 INFO - 'NO_EM_RESTART': '1', 03:23:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:18 INFO - 'PWD': '/builds/slave/test', 03:23:18 INFO - 'SHELL': '/bin/bash', 03:23:18 INFO - 'SHLVL': '1', 03:23:18 INFO - 'TERM': 'linux', 03:23:18 INFO - 'TMOUT': '86400', 03:23:18 INFO - 'USER': 'cltbld', 03:23:18 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1463048581.421689-1784723497', 03:23:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:18 INFO - '_': '/tools/buildbot/bin/python'} 03:23:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:18 INFO - Downloading/unpacking psutil>=0.7.1 03:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:23:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:23:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:23:20 INFO - Installing collected packages: psutil 03:23:20 INFO - Running setup.py install for psutil 03:23:20 INFO - building 'psutil._psutil_linux' extension 03:23:20 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 03:23:20 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 03:23:20 INFO - building 'psutil._psutil_posix' extension 03:23:20 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 03:23:20 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 03:23:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:23:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:23:21 INFO - Successfully installed psutil 03:23:21 INFO - Cleaning up... 03:23:21 INFO - Return code: 0 03:23:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:23:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:21 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 0x7f584a0d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fca410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2059160>, '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 0x205a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205a4f0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1463048581.421689-1784723497', '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 03:23:21 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 03:23:21 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 03:23:21 INFO - Using env: {'DISPLAY': ':0', 03:23:21 INFO - 'HOME': '/home/cltbld', 03:23:21 INFO - 'LANG': 'en_US.UTF-8', 03:23:21 INFO - 'LANGUAGE': 'en_US:en', 03:23:21 INFO - 'LOGNAME': 'cltbld', 03:23:21 INFO - 'MAIL': '/var/mail/cltbld', 03:23:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:21 INFO - 'MOZ_NO_REMOTE': '1', 03:23:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:21 INFO - 'NO_EM_RESTART': '1', 03:23:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:21 INFO - 'PWD': '/builds/slave/test', 03:23:21 INFO - 'SHELL': '/bin/bash', 03:23:21 INFO - 'SHLVL': '1', 03:23:21 INFO - 'TERM': 'linux', 03:23:21 INFO - 'TMOUT': '86400', 03:23:21 INFO - 'USER': 'cltbld', 03:23:21 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1463048581.421689-1784723497', 03:23:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:21 INFO - '_': '/tools/buildbot/bin/python'} 03:23:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:23:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:23:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:23:23 INFO - Installing collected packages: mozsystemmonitor 03:23:23 INFO - Running setup.py install for mozsystemmonitor 03:23:23 INFO - Successfully installed mozsystemmonitor 03:23:23 INFO - Cleaning up... 03:23:23 INFO - Return code: 0 03:23:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f584a0d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fca410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2059160>, '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 0x205a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205a4f0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1463048581.421689-1784723497', '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 03:23:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:23:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:23:23 INFO - Using env: {'DISPLAY': ':0', 03:23:23 INFO - 'HOME': '/home/cltbld', 03:23:23 INFO - 'LANG': 'en_US.UTF-8', 03:23:23 INFO - 'LANGUAGE': 'en_US:en', 03:23:23 INFO - 'LOGNAME': 'cltbld', 03:23:23 INFO - 'MAIL': '/var/mail/cltbld', 03:23:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:23 INFO - 'MOZ_NO_REMOTE': '1', 03:23:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:23 INFO - 'NO_EM_RESTART': '1', 03:23:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:23 INFO - 'PWD': '/builds/slave/test', 03:23:23 INFO - 'SHELL': '/bin/bash', 03:23:23 INFO - 'SHLVL': '1', 03:23:23 INFO - 'TERM': 'linux', 03:23:23 INFO - 'TMOUT': '86400', 03:23:23 INFO - 'USER': 'cltbld', 03:23:23 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1463048581.421689-1784723497', 03:23:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:23 INFO - '_': '/tools/buildbot/bin/python'} 03:23:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:23 INFO - Downloading/unpacking blobuploader==1.2.4 03:23:23 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 03:23:23 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 03:23:23 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 03:23:23 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 03:23:23 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 03:23:23 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 03:23:25 INFO - Downloading blobuploader-1.2.4.tar.gz 03:23:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:23:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:23:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:26 INFO - Downloading docopt-0.6.1.tar.gz 03:23:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:23:26 INFO - Installing collected packages: blobuploader, requests, docopt 03:23:26 INFO - Running setup.py install for blobuploader 03:23:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:23:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:23:26 INFO - Running setup.py install for requests 03:23:26 INFO - Running setup.py install for docopt 03:23:26 INFO - Successfully installed blobuploader requests docopt 03:23:26 INFO - Cleaning up... 03:23:26 INFO - Return code: 0 03:23:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:23:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:26 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 0x7f584a0d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fca410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2059160>, '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 0x205a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205a4f0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1463048581.421689-1784723497', '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 03:23:26 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 03:23:26 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 03:23:26 INFO - Using env: {'DISPLAY': ':0', 03:23:26 INFO - 'HOME': '/home/cltbld', 03:23:26 INFO - 'LANG': 'en_US.UTF-8', 03:23:26 INFO - 'LANGUAGE': 'en_US:en', 03:23:26 INFO - 'LOGNAME': 'cltbld', 03:23:26 INFO - 'MAIL': '/var/mail/cltbld', 03:23:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:26 INFO - 'MOZ_NO_REMOTE': '1', 03:23:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:26 INFO - 'NO_EM_RESTART': '1', 03:23:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:26 INFO - 'PWD': '/builds/slave/test', 03:23:26 INFO - 'SHELL': '/bin/bash', 03:23:26 INFO - 'SHLVL': '1', 03:23:26 INFO - 'TERM': 'linux', 03:23:26 INFO - 'TMOUT': '86400', 03:23:26 INFO - 'USER': 'cltbld', 03:23:26 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1463048581.421689-1784723497', 03:23:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:26 INFO - '_': '/tools/buildbot/bin/python'} 03:23:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:23:27 INFO - Running setup.py (path:/tmp/pip-pjYg0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:23:27 INFO - Running setup.py (path:/tmp/pip-1YKX29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:23:27 INFO - Running setup.py (path:/tmp/pip-DLeteU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:23:27 INFO - Running setup.py (path:/tmp/pip-n2C0VI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:23:27 INFO - Running setup.py (path:/tmp/pip-LDFuYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:23:27 INFO - Running setup.py (path:/tmp/pip-rWJ1PJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:23:27 INFO - Running setup.py (path:/tmp/pip-NWRMR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:23:27 INFO - Running setup.py (path:/tmp/pip-3tZ6nQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:23:27 INFO - Running setup.py (path:/tmp/pip-6skYKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:23:27 INFO - Running setup.py (path:/tmp/pip-DFZWDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:23:27 INFO - Running setup.py (path:/tmp/pip-cuI75r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:23:27 INFO - Running setup.py (path:/tmp/pip-RkWdKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:23:27 INFO - Running setup.py (path:/tmp/pip-hP_YGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:23:28 INFO - Running setup.py (path:/tmp/pip-FmXMSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:28 INFO - Running setup.py (path:/tmp/pip-X12KDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:23:28 INFO - Running setup.py (path:/tmp/pip-w1dwyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:23:28 INFO - Running setup.py (path:/tmp/pip-2yy4oK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:23:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:23:28 INFO - Running setup.py install for manifestparser 03:23:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:23:28 INFO - Running setup.py install for mozcrash 03:23:28 INFO - Running setup.py install for mozdebug 03:23:28 INFO - Running setup.py install for mozdevice 03:23:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:23:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:23:28 INFO - Running setup.py install for mozfile 03:23:28 INFO - Running setup.py install for mozhttpd 03:23:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:23:28 INFO - Running setup.py install for mozinfo 03:23:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:23:28 INFO - Running setup.py install for mozInstall 03:23:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:23:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:23:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:23:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:23:29 INFO - Running setup.py install for mozleak 03:23:29 INFO - Running setup.py install for mozlog 03:23:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:23:29 INFO - Running setup.py install for moznetwork 03:23:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:23:29 INFO - Running setup.py install for mozprocess 03:23:29 INFO - Running setup.py install for mozprofile 03:23:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:23:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:23:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:23:29 INFO - Running setup.py install for mozrunner 03:23:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:23:29 INFO - Running setup.py install for mozscreenshot 03:23:29 INFO - Running setup.py install for moztest 03:23:29 INFO - Running setup.py install for mozversion 03:23:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:23:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:23:30 INFO - Cleaning up... 03:23:30 INFO - Return code: 0 03:23:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:23:30 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')]} 03:23:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:30 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')]} 03:23:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:30 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 0x7f584a0d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fca410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2059160>, '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 0x205a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205a4f0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1463048581.421689-1784723497', '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 03:23:30 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 03:23:30 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 03:23:30 INFO - Using env: {'DISPLAY': ':0', 03:23:30 INFO - 'HOME': '/home/cltbld', 03:23:30 INFO - 'LANG': 'en_US.UTF-8', 03:23:30 INFO - 'LANGUAGE': 'en_US:en', 03:23:30 INFO - 'LOGNAME': 'cltbld', 03:23:30 INFO - 'MAIL': '/var/mail/cltbld', 03:23:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:30 INFO - 'MOZ_NO_REMOTE': '1', 03:23:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:30 INFO - 'NO_EM_RESTART': '1', 03:23:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:30 INFO - 'PWD': '/builds/slave/test', 03:23:30 INFO - 'SHELL': '/bin/bash', 03:23:30 INFO - 'SHLVL': '1', 03:23:30 INFO - 'TERM': 'linux', 03:23:30 INFO - 'TMOUT': '86400', 03:23:30 INFO - 'USER': 'cltbld', 03:23:30 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1463048581.421689-1784723497', 03:23:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:30 INFO - '_': '/tools/buildbot/bin/python'} 03:23:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:23:30 INFO - Running setup.py (path:/tmp/pip-QHmys7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:23:30 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)) 03:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:23:30 INFO - Running setup.py (path:/tmp/pip-H6cNMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:23:30 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)) 03:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:23:30 INFO - Running setup.py (path:/tmp/pip-nnyMQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:23:30 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)) 03:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:23:30 INFO - Running setup.py (path:/tmp/pip-55TfVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:23:30 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)) 03:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:23:30 INFO - Running setup.py (path:/tmp/pip-Q9PsIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:23:30 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)) 03:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:23:30 INFO - Running setup.py (path:/tmp/pip-HwKTBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:23:30 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)) 03:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:23:30 INFO - Running setup.py (path:/tmp/pip-dQfStF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:23:30 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)) 03:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:23:30 INFO - Running setup.py (path:/tmp/pip-F5kGu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:23:30 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)) 03:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:23:30 INFO - Running setup.py (path:/tmp/pip-ZJkJSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:23:30 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)) 03:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:23:30 INFO - Running setup.py (path:/tmp/pip-SFzXa6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:23:31 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)) 03:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:23:31 INFO - Running setup.py (path:/tmp/pip-YR_MZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:23:31 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)) 03:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:23:31 INFO - Running setup.py (path:/tmp/pip-vj9kaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:23:31 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)) 03:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:23:31 INFO - Running setup.py (path:/tmp/pip-38XoV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:23:31 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)) 03:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:23:31 INFO - Running setup.py (path:/tmp/pip-w1RYWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:23:31 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)) 03:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:31 INFO - Running setup.py (path:/tmp/pip-Xk6VuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:31 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)) 03:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:23:31 INFO - Running setup.py (path:/tmp/pip-YAvx1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:23:31 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)) 03:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:23:31 INFO - Running setup.py (path:/tmp/pip-vWVcpF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:23:31 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)) 03:23:31 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)) 03:23:31 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)) 03:23:31 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)) 03:23:31 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)) 03:23:31 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)) 03:23:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:23:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:33 INFO - Downloading blessings-1.6.tar.gz 03:23:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:23:33 INFO - Installing collected packages: blessings 03:23:33 INFO - Running setup.py install for blessings 03:23:33 INFO - Successfully installed blessings 03:23:33 INFO - Cleaning up... 03:23:33 INFO - Return code: 0 03:23:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:23:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:23:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:23:33 INFO - Reading from file tmpfile_stdout 03:23:33 INFO - Current package versions: 03:23:33 INFO - argparse == 1.2.1 03:23:33 INFO - blessings == 1.6 03:23:33 INFO - blobuploader == 1.2.4 03:23:33 INFO - docopt == 0.6.1 03:23:33 INFO - manifestparser == 1.1 03:23:33 INFO - mozInstall == 1.12 03:23:33 INFO - mozcrash == 0.17 03:23:33 INFO - mozdebug == 0.1 03:23:33 INFO - mozdevice == 0.48 03:23:33 INFO - mozfile == 1.2 03:23:33 INFO - mozhttpd == 0.7 03:23:33 INFO - mozinfo == 0.9 03:23:33 INFO - mozleak == 0.1 03:23:33 INFO - mozlog == 3.1 03:23:33 INFO - moznetwork == 0.27 03:23:33 INFO - mozprocess == 0.22 03:23:33 INFO - mozprofile == 0.28 03:23:33 INFO - mozrunner == 6.11 03:23:33 INFO - mozscreenshot == 0.1 03:23:33 INFO - mozsystemmonitor == 0.0 03:23:33 INFO - moztest == 0.7 03:23:33 INFO - mozversion == 1.4 03:23:33 INFO - psutil == 3.1.1 03:23:33 INFO - requests == 1.2.3 03:23:33 INFO - wsgiref == 0.1.2 03:23:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:23:33 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')]} 03:23:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:33 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')]} 03:23:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:33 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 0x7f584a0d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fca410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2059160>, '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 0x205a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205a4f0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1463048581.421689-1784723497', '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 03:23:33 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 03:23:33 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 03:23:33 INFO - Using env: {'DISPLAY': ':0', 03:23:33 INFO - 'HOME': '/home/cltbld', 03:23:33 INFO - 'LANG': 'en_US.UTF-8', 03:23:33 INFO - 'LANGUAGE': 'en_US:en', 03:23:33 INFO - 'LOGNAME': 'cltbld', 03:23:33 INFO - 'MAIL': '/var/mail/cltbld', 03:23:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:33 INFO - 'MOZ_NO_REMOTE': '1', 03:23:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:33 INFO - 'NO_EM_RESTART': '1', 03:23:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:33 INFO - 'PWD': '/builds/slave/test', 03:23:33 INFO - 'SHELL': '/bin/bash', 03:23:33 INFO - 'SHLVL': '1', 03:23:33 INFO - 'TERM': 'linux', 03:23:33 INFO - 'TMOUT': '86400', 03:23:33 INFO - 'USER': 'cltbld', 03:23:33 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1463048581.421689-1784723497', 03:23:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:33 INFO - '_': '/tools/buildbot/bin/python'} 03:23:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:34 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)) 03:23:34 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)) 03:23:34 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)) 03:23:34 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)) 03:23:34 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)) 03:23:34 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)) 03:23:34 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)) 03:23:34 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)) 03:23:34 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)) 03:23:34 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)) 03:23:34 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)) 03:23:34 INFO - Cleaning up... 03:23:34 INFO - Return code: 0 03:23:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:23:34 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')]} 03:23:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:34 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')]} 03:23:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:34 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 0x7f584a0d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fca410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2059160>, '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 0x205a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205a4f0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1463048581.421689-1784723497', '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 03:23:34 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 03:23:34 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 03:23:34 INFO - Using env: {'DISPLAY': ':0', 03:23:34 INFO - 'HOME': '/home/cltbld', 03:23:34 INFO - 'LANG': 'en_US.UTF-8', 03:23:34 INFO - 'LANGUAGE': 'en_US:en', 03:23:34 INFO - 'LOGNAME': 'cltbld', 03:23:34 INFO - 'MAIL': '/var/mail/cltbld', 03:23:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:34 INFO - 'MOZ_NO_REMOTE': '1', 03:23:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:34 INFO - 'NO_EM_RESTART': '1', 03:23:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:34 INFO - 'PWD': '/builds/slave/test', 03:23:34 INFO - 'SHELL': '/bin/bash', 03:23:34 INFO - 'SHLVL': '1', 03:23:34 INFO - 'TERM': 'linux', 03:23:34 INFO - 'TMOUT': '86400', 03:23:34 INFO - 'USER': 'cltbld', 03:23:34 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1463048581.421689-1784723497', 03:23:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:34 INFO - '_': '/tools/buildbot/bin/python'} 03:23:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:34 INFO - Downloading/unpacking jsonschema 03:23:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:23:36 INFO - Downloading/unpacking functools32 (from jsonschema) 03:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:36 INFO - Downloading functools32-3.2.3-2.tar.gz 03:23:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:23:36 INFO - warning: no files found matching '*.txt' 03:23:36 INFO - no previously-included directories found matching 'build' 03:23:36 INFO - no previously-included directories found matching 'dist' 03:23:36 INFO - no previously-included directories found matching '.git*' 03:23:36 INFO - Installing collected packages: jsonschema, functools32 03:23:36 INFO - Running setup.py install for functools32 03:23:36 INFO - warning: no files found matching '*.txt' 03:23:36 INFO - no previously-included directories found matching 'build' 03:23:36 INFO - no previously-included directories found matching 'dist' 03:23:36 INFO - no previously-included directories found matching '.git*' 03:23:36 INFO - Successfully installed jsonschema functools32 03:23:36 INFO - Cleaning up... 03:23:36 INFO - Return code: 0 03:23:36 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:23:36 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')]} 03:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:36 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')]} 03:23:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:36 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 0x7f584a0d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fca410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2059160>, '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 0x205a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205a4f0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1463048581.421689-1784723497', '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 03:23:36 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 03:23:36 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 03:23:36 INFO - Using env: {'DISPLAY': ':0', 03:23:36 INFO - 'HOME': '/home/cltbld', 03:23:36 INFO - 'LANG': 'en_US.UTF-8', 03:23:36 INFO - 'LANGUAGE': 'en_US:en', 03:23:36 INFO - 'LOGNAME': 'cltbld', 03:23:36 INFO - 'MAIL': '/var/mail/cltbld', 03:23:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:36 INFO - 'MOZ_NO_REMOTE': '1', 03:23:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:36 INFO - 'NO_EM_RESTART': '1', 03:23:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:36 INFO - 'PWD': '/builds/slave/test', 03:23:36 INFO - 'SHELL': '/bin/bash', 03:23:36 INFO - 'SHLVL': '1', 03:23:36 INFO - 'TERM': 'linux', 03:23:36 INFO - 'TMOUT': '86400', 03:23:36 INFO - 'USER': 'cltbld', 03:23:36 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1463048581.421689-1784723497', 03:23:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:36 INFO - '_': '/tools/buildbot/bin/python'} 03:23:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:36 INFO - Downloading/unpacking flake8 03:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:23:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:23:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:23:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:23:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:23:40 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 03:23:40 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 03:23:40 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 03:23:40 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 03:23:40 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 03:23:40 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 03:23:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:23:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:23:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:23:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:23:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:23:40 INFO - no previously-included directories found matching 'docs/_build' 03:23:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:23:40 INFO - Running setup.py install for pep8 03:23:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:23:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:23:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:23:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:23:40 INFO - no previously-included directories found matching 'docs/_build' 03:23:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:23:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:23:40 INFO - Cleaning up... 03:23:40 INFO - Return code: 0 03:23:40 INFO - Running post-action listener: _resource_record_post_action 03:23:40 INFO - Running post-action listener: _start_resource_monitoring 03:23:40 INFO - Starting resource monitoring. 03:23:40 INFO - ##### 03:23:40 INFO - ##### Running install step. 03:23:40 INFO - ##### 03:23:40 INFO - Running pre-action listener: _resource_record_pre_action 03:23:40 INFO - Running main action method: install 03:23:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:23:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:23:40 INFO - Reading from file tmpfile_stdout 03:23:40 INFO - Detecting whether we're running mozinstall >=1.0... 03:23:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:23:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:23:40 INFO - Reading from file tmpfile_stdout 03:23:40 INFO - Output received: 03:23:40 INFO - Usage: mozinstall [options] installer 03:23:40 INFO - Options: 03:23:40 INFO - -h, --help show this help message and exit 03:23:40 INFO - -d DEST, --destination=DEST 03:23:40 INFO - Directory to install application into. [default: 03:23:40 INFO - "/builds/slave/test"] 03:23:40 INFO - --app=APP Application being installed. [default: firefox] 03:23:40 INFO - mkdir: /builds/slave/test/build/application 03:23:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:23:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:23:53 INFO - Reading from file tmpfile_stdout 03:23:53 INFO - Output received: 03:23:53 INFO - /builds/slave/test/build/application/firefox/firefox 03:23:53 INFO - Running post-action listener: _resource_record_post_action 03:23:53 INFO - ##### 03:23:53 INFO - ##### Running run-tests step. 03:23:53 INFO - ##### 03:23:53 INFO - Running pre-action listener: _resource_record_pre_action 03:23:53 INFO - Running main action method: run_tests 03:23:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:23:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:23:53 INFO - Python 2.7.3 03:23:53 INFO - Return code: 0 03:23:53 INFO - grabbing minidump binary from tooltool 03:23:53 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')]} 03:23:53 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 0x2059160>, '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 0x205a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205a4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:23:53 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 03:23:53 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 03:23:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:23:53 INFO - Return code: 0 03:23:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:23:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:23:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:23:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:23:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:23:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:23:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:23:54 INFO - Return code: 0 03:23:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OEGpvG6FQTiNV5Bu6m7RvQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 03:23:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OEGpvG6FQTiNV5Bu6m7RvQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --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 03:23:54 INFO - Using env: {'DISPLAY': ':0', 03:23:54 INFO - 'HOME': '/home/cltbld', 03:23:54 INFO - 'LANG': 'en_US.UTF-8', 03:23:54 INFO - 'LANGUAGE': 'en_US:en', 03:23:54 INFO - 'LOGNAME': 'cltbld', 03:23:54 INFO - 'MAIL': '/var/mail/cltbld', 03:23:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:23:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:23:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:54 INFO - 'MOZ_NO_REMOTE': '1', 03:23:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:23:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:54 INFO - 'NO_EM_RESTART': '1', 03:23:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:54 INFO - 'PWD': '/builds/slave/test', 03:23:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:23:54 INFO - 'SHELL': '/bin/bash', 03:23:54 INFO - 'SHLVL': '1', 03:23:54 INFO - 'TERM': 'linux', 03:23:54 INFO - 'TMOUT': '86400', 03:23:54 INFO - 'USER': 'cltbld', 03:23:54 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1463048581.421689-1784723497', 03:23:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:54 INFO - '_': '/tools/buildbot/bin/python'} 03:23:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OEGpvG6FQTiNV5Bu6m7RvQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 03:23:54 INFO - mozversion application_buildid: 20160512003946 03:23:54 INFO - mozversion application_changeset: 93a53170dedffdff45bf9eb8dac6e5ef7a13c4ba 03:23:54 INFO - mozversion application_display_name: Firefox 03:23:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:23:54 INFO - mozversion application_name: Firefox 03:23:54 INFO - mozversion application_remotingname: firefox 03:23:54 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 03:23:54 INFO - mozversion application_vendor: Mozilla 03:23:54 INFO - mozversion application_version: 47.0 03:23:54 INFO - mozversion platform_buildid: 20160512003946 03:23:54 INFO - mozversion platform_changeset: 93a53170dedffdff45bf9eb8dac6e5ef7a13c4ba 03:23:54 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 03:23:54 INFO - mozversion platform_version: 47.0 03:23:54 INFO - using testdate: 1463048634 03:23:54 INFO - actual date: 1463048634 03:23:54 INFO - starting webserver on 'localhost:58987' 03:23:54 INFO - SUITE-START | Running 2 tests 03:23:54 INFO - TEST-START | dromaeo_css 03:23:54 INFO - operating with platform_type : linux_ 03:23:54 INFO - Initialising browser for dromaeo_css test... 03:23:54 INFO - TEST-INFO | started process 22842 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJjLgmE/profile http://localhost:58987/getInfo.html) 03:23:59 INFO - PROCESS | 22842 | __metrics Screen width/height:1600/1200 03:23:59 INFO - PROCESS | 22842 | colorDepth:24 03:23:59 INFO - PROCESS | 22842 | Browser inner width/height: 1024/697 03:23:59 INFO - PROCESS | 22842 | __metrics 03:24:00 INFO - PROCESS | 22842 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:24:01 INFO - TEST-INFO | 22842: exit 0 03:24:01 INFO - Browser initialized. 03:24:01 INFO - Running cycle 1/1 for dromaeo_css test... 03:24:01 INFO - TEST-INFO | started process 22931 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJjLgmE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:24:13 INFO - PROCESS | 22931 | RSS: Main: 139653120 03:24:13 INFO - PROCESS | 22931 | 03:25:04 INFO - PROCESS | 22931 | 1463048704823 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] 03:27:12 INFO - PROCESS | 22931 | Cycle 1(1): loaded http://localhost:58987/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58987/tests/dromaeo/cssquery-ext.html) 03:27:13 INFO - PROCESS | 22931 | RSS: Main: 214605824 03:27:13 INFO - PROCESS | 22931 | 03:30:14 INFO - PROCESS | 22931 | Cycle 1(1): loaded http://localhost:58987/tests/dromaeo/cssquery-ext.html (next: http://localhost:58987/tests/dromaeo/cssquery-jquery.html) 03:30:15 INFO - PROCESS | 22931 | RSS: Main: 216543232 03:30:15 INFO - PROCESS | 22931 | 03:33:17 INFO - PROCESS | 22931 | Cycle 1(1): loaded http://localhost:58987/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58987/tests/dromaeo/cssquery-mootools.html) 03:33:17 INFO - PROCESS | 22931 | RSS: Main: 212344832 03:33:17 INFO - PROCESS | 22931 | 03:36:19 INFO - PROCESS | 22931 | Cycle 1(1): loaded http://localhost:58987/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58987/tests/dromaeo/cssquery-prototype.html) 03:36:20 INFO - PROCESS | 22931 | RSS: Main: 207388672 03:36:20 INFO - PROCESS | 22931 | 03:39:22 INFO - PROCESS | 22931 | Cycle 1(1): loaded http://localhost:58987/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58987/tests/dromaeo/cssquery-yui.html) 03:39:23 INFO - PROCESS | 22931 | RSS: Main: 208310272 03:39:23 INFO - PROCESS | 22931 | 03:42:25 INFO - PROCESS | 22931 | Cycle 1(1): loaded http://localhost:58987/tests/dromaeo/cssquery-yui.html (next: http://localhost:58987/tests/dromaeo/cssquery-dojo.html) 03:42:25 INFO - PROCESS | 22931 | RSS: Main: 253181952 03:42:25 INFO - PROCESS | 22931 | 03:42:25 INFO - PROCESS | 22931 | __start_tp_report 03:42:25 INFO - PROCESS | 22931 | _x_x_mozilla_page_load 03:42:25 INFO - PROCESS | 22931 | _x_x_mozilla_page_load_details 03:42:25 INFO - PROCESS | 22931 | |i|pagename|runs| 03:42:25 INFO - PROCESS | 22931 | |0;dojo.html;3284.4252255855217;3350.229447227136;3375.1562109472648;3381;3403.5235067090603;5357.517823395893;5360.035193665139;5368.651037682553;5369.275147855038;5420.051490989071;5364.678119312844;5378.838634840951;5396.568274538037;5397.028534863723;5401.216823560581;4836.613070954315;4925.926111108336;4963.528464795839;4981.526754958291;5014.5737612303;4814.35006274152;4864.562189402953;4901.509849015106;4902.436219834729;4908.190148625473;4960.156773348522;5006.524380183877;5012;5019.071471777715;5038.143515602356;4881.365422495053;4913.828016019458;4967.10592093423;4981.701097934136;4986.202207646777;4865.148598995197;4901.1177987962155;4928.063667903087;4954.801807927679;4975;5049.267856160873;5118.2578526113875;5118.692878427306;5137.434882162959;5145.125328694094;5814.418558144152;5842.152887831241;5842.298924129089;5851;5854.795082172103;5739.684317362543;5773.393793651648;5824.621399609012;5827.504662103726;5852.941470585282;5430.456954304538;5469.179623056494;5472.425395333473;5478.287822583039;5508.980838544842;5949.643021418642;5966.492848107872;5971.7611295547695;5975.193348897843;5977.760889564369;5547.140193270049;5573.442655734475;5605.859853503695;5733.827985160452;5739.62692424991;5842.795502157404;5854.092615644497;5856.326522449973;5858.736356863866;5860.619059761188;5793.449622285876;5825.33008703996;5828.53371730269;5828.825135245865;5830.2420685310635;5704;5726.656400615976;5779.884402312015;5811.128330750336;5811.535077193815;4402.7358358498595;4425.402570652921;4428.269335559661;4428.2914733642465;4454.821807127743;4006.659433948147;4025.2150830587752;4032.4556184915245;4041.2927737646382;4060.9847538115473;5346.037713211582;5482.369527504388;5546.417626149277;5554.389017208104;5602.831915042555;5754.4533269339345;5807.274090738658;5822.650640961556;5825.7378417971295;5827.4172582741385;5448.237246785453;5479.04116779562;5509.146082357241;5541.972290138524;5543;4947.975260123676;5020.949790502122;5031.069252188357;5037.420696619863;5046;6045.33501314855;6060.454559089703;6076.149339092531;6085.878282434415;6093.786717464867;5668.51817595509;5676.772929082956;5812.244408226818;5842.1820945068575;5842.357340692605;6018.8194354169445;6039.15451836752;6044.516438684983;6051.425114614105;6068.696565171812;5655.293088363955;5696;5698.8290351289525;5700.059490184239;5704.743286552198;5596.972015139898;5777.046787280052;5780.971095144498;5788.305403351625;5852.385499522659;5570.136628822539;5574;5575.8606034847835;5578.330600327987;5581.413951535031;5547.944520554743;5549.306336707911;5558.277423934863;5561.694106824163;5562.972185139049;5344.679319240858;5464.699441530754;5509.807156749494;5577.6653400796085;5620.100783874724;5445.863853403696;5564.8330550083565;5583.106702927675;5680.971595141998;5693.772249109989;5455.9454405455435;5484.533814625802;5485.945140548543;5498.945010549844;5529.944700552943 03:42:25 INFO - PROCESS | 22931 | |1;ext.html;492.9580985616225;542.5388419843131;545.5880809988458;549.1022178737763;561.4049107945578;31862.36275274493;38480.42279365808;38947.41578876312;39136.60863391365;39147.60852391475;43242.56757432425;43747.78126109365;43877.78061109698;43946.78026609871;43972.56027439725;8886.377953543255;9078.182963533282;9089.909100909006;9094.363394562382;9098.499582522958;8910.599023043946;9000.504972226525;9056.456612603231;9058.23005044572;9067.319951003668;8959.462432254053;9301.44191348518;9346.532673366339;9352.532373381338;9356.859647105299;9169.95415022924;9269.953650231773;9270.258379329638;9271;9281.628734850598;9190.770230744285;9318.627254909796;9330.113639204264;9338.766530836783;9342.719718408458;42829.57170428287;43197.35203971943;43269.35095973563;43317.35023974643;43350.349744753854;3564.322778672044;3767.566729826078;3791.184895247535;4188.015816283171;4286.39990401344;31964.360712785616;32269.6773032269;32327.353452931045;32511.512327315108;33006.834965825255;4016.6786657067364;4047.8380864765372;4103.835846566134;4118.5263694675195;4150.418941348214;301884;302113.9999999978;302535;302805;304052;45128.3230751539;67119.66440167866;67693;67747;67845.3215467849;43366;43412.78293608512;43421.56578434175;43614;43730;16142.112183830002;16375.263113159936;16441.26014329334;16443.09562974024;16449.25978330978;12919.483220671067;12969.157004794659;12984.480620775063;13009.804852927213;13012.284324362061;15099.698006039818;15169.317380717894;15664.921675391777;15683.215839208222;15763.448279310169;5536.916946245809;5883.058231085823;5920.674362909996;5954.8809023819285;6012.579119461596;960.9903900961041;1026.1944373666636;1096.6107032003524;1169.5438778876246;1240.6030070377574;29877.701222987493;29906.85046574753;30215.546766798514;30944.535831962537;31139.532907006414;1158.6871544682888;1163.2555164694602;1212.3877441891789;1217.4095563651622;1256.6355756830599;15533;15625.53123406277;15768.92115539415;15959.44141955026;16025.439109631106;366426;368371;369034;369250;369427;57457.71271143617;58592.414075859546;58611;58626.70686646539;58677.706611467525;1283.8844503994685;1469.8309694385282;1475.7269905067596;1479.4526025370683;1584.881133914961;26970.460590788465;29832.85083574568;29925;30128.69871301259;30742;46576;47046;47062.35281765122;47064.7646761764;47115.29327060028;198125;199512;212241;215496;216049;30133.698663013965;35235.29529409346;35301.47047794234;35312.47031294584;36209.45685814662;41022.38466422947;41331;41430.1713965713;42077.36883946804;42174;36249.81875090607;37929.4310585347;38088.238235235694;38777.6122238774;38789.224215514965;37125.628743712216;37295.44056839095;37861.43207851939;38509.2298154041;38736;36664;37558;37963.620363796006;42299.78850105853;43035.3544696836;33126.17184570309;33723.66276337205;34276.65723342834;34896.65103349036;34956.47565286472;27013.1896043119;27232.455350892476;27505.86247068752;27549.207489918823;27626.861865690542 03:42:25 INFO - PROCESS | 22931 | |2;jquery.html;372.6217888842825;374.3224763178645;378.2076549628527;381.49832969644905;384.94610754494374;17985;18247.908760456197;19084.809151908477;19110.52223694408;19137.42587722367;17378.304867805306;17567.560810979732;17875.73186402205;17942.820571794276;17953.73069403957;5574.888502229953;5803;5820.796272130477;5838.2994040715175;5840.445157710032;4296.248156572603;5718.399568045358;5967.462928336449;6207.224096987877;6266.185395898527;6188.690565471708;6206.069089636546;6214.036824292242;6227.626342419469;6228.5951413158;5948.1375200595885;6206.789676013179;6214.627122372672;6217.1917650705345;6220.751169953196;3849.2109117630816;5275.657082289639;5446.809361672362;5477.04151773438;5480.588955828329;21122.5775484491;21248.36254912355;21332.46668833276;21543.461413464633;21563;2295.644175152854;2397.5924092904247;2399.928002159938;2422.551827911824;2486.1422809130822;9739.415635061849;10248.333858299187;10391.896081039169;10434.843477347846;10439.42583157926;1872.6161136967025;1881.0782716468968;1916.568772026297;1933.7002764571514;1957.314939771083;70427.29572704258;70783.64608176978;71036.6448167761;71440.64279678569;71826.64086679586;10459.372437653765;10706;10727.678169654922;10742.24804263694;10791.892081079088;14822.777658335133;14852.851471485363;15030.849691503163;15112.697746045018;15139.54581362561;7959.721409750631;8119.75640730779;8139.540695204514;8204.507729536246;8338.791530211673;7682.116556595951;7722;7772.572508512086;7784.883226751604;8000.479968802009;4616.469106052779;4645.74448405341;4657.138429390574;4693.436787585443;4705.270683044134;1686.9409570665214;1753.4739578126766;1764.2061072517417;1832.1663643042384;1880.5392678793783;943.1888575824785;1090.0788833435734;1095.7479779650726;1111.1721767283425;1121.545773961547;16122.355105795637;16384.0169589825;16392.590185245226;16691.833081669272;17073.06098164613;1020.4846552490944;1050.0497050169608;1056.1181413519644;1058.6771034834296;1065.5684447798653;10018.549165287579;10093.848592271122;10152.086312231935;10193.745156371002;10209.897901020895;401904;418029;469582;474308;479510;76362;77927;78382.21617783864;78917.21082789214;80696.59651701704;1020.3265844542566;1032.6437379104198;1042.2547878267076;1058.4601853054996;1076.7523469602036;15833.920830395775;15841.920790395974;16025.839741602435;16035.2784124717;16086.758698619296;35737.64262357447;35889.46165807567;36433.63566364408;36564.634353656125;37033.44449833308;51132.74433627957;51803.74098129485;51964.22053669274;52015.2197717027;52177.73911130572;8546.401751877558;8566.742997710078;8659.307255419677;8812.427192232484;8885.866711999195;10189.84715229287;10493.580256789643;13183;13280.203187808762;13706.588802335946;10701.678949631523;10916.126709863032;11145.832812507657;11169;11253.774924501628;10946.35804629312;11110.111191104854;11151.442427878412;11380.886191137983;11575.363355015555;11551.595694150665;11579.652610421701;11771.646850594496;11873.881261187278;12162;8482.345942541391;8583.742487725129;8590.269827064769;8783.253423458822;9028.277737781093;10123.7469063274;12237.69405764863;12250.203736757083;12304.81542776877;12535.435905384098 03:42:25 INFO - PROCESS | 22931 | |3;mootools.html;1415.603630983325;1429.8784603308718;1488.1815001749042;1636.63341110173;1674.1417027099924;8013.8797918031205;8134.877976830352;8210.261076503113;8226.765985102238;8228.547429891361;7313.232110628387;7580.88628670569;7714.537127772338;7753.263439973208;8089.23152300532;2247.43814046488;2292.16336037346;2292.266474728088;2293.117149897293;2295.024614538814;2307.7230732312064;2317.3048085574346;2380.3929997850523;2380.666706661069;2383.7377888432256;2073.2639912830955;2332.6384410416413;2383.2254517281867;2390.1634427950166;2390.306811024801;2312.861228326306;2320.454693147109;2340.7659234076627;2357.210334537932;2359.634256690216;2317.3974766560646;2334.9299521014395;2336.1823361823226;2340.4382948092507;2342.906283748648;8306.501609903366;8358.498490090615;8370.958145209295;8384.161583841567;8612.18184272493;4935.7532123393685;5058.46886076964;5059.139946209153;5076.568491678212;5086.084504789136;3180.936381272362;3195.0734287056725;3236.91907702307;3414.7438942079193;3444.2422667013216;1051.5057922776282;1064.1433645915035;1064.6646306413454;1095.9643137235316;1100.070440477795;11517.13621478384;11523;11528.193026488148;11542.249753765978;11624.593139240085;4490.39379683745;4624.745638989821;4663.696859704176;4672.873842401699;4672.929906051412;9958.551865166084;9987.650432234983;9990.650327238656;9992;9992.250581206294;5211.843644690665;5236.214567814858;5243.030039442715;5251.501107394792;5267.525922666979;4620.052889157714;4638.605718513964;4639.768011599406;4647.6281897448125;4651.511591282867;3973.2252210819192;3995.34076877312;4002.4396584478195;4014.157027024299;4049.4848244207496;1171.3206340322592;1239.7706424311532;1252.5929073051113;1285.5307812648502;1298.3702904091508;1127.689885281554;1133.5749094089717;1139.663799179244;1367.7196174784146;1439.3019385597977;7539.359154471931;7586.962065189638;7683.193264707125;7687.730929417556;7701;1193;1209.4376115106343;1210.6065528703207;1214.2107630040368;1234.8888600026041;5989.161517387569;6128.846778830565;6182.752689892354;6186.907196392058;6206.162168107247;9690.321677482509;9818.852717209247;9823.852642210373;9933.708617879629;9946.651867184613;9613.279004074582;9816.067473589997;9879.80240395188;9896.851547226797;9919;7923.247291507298;7925.8811117833275;7983.560904150328;7994.160613135653;8064.677412903536;7516.361109305771;7548.942678215331;7610.6194690266375;7634.083909930844;7664.501807382502;8608.741737747878;8769.473831570127;8847.73456796297;8995.460272383678;9041.68354107603;9028.18746312835;9054.094590541157;9244.676436324697;9271.490068046322;9343;7289.927100728924;7337.376323012603;7377.151627562899;7380.667869945973;7420.295071968154;7861.095973963067;7876.56678882667;7977.0427548692205;8057.315128213933;8070.636821342936;6413.422791948747;7415.258474152542;7470.4770666052855;7473.215312392121;7531.209223031503;6828.624425656637;6932.445404367538;7026.718931242693;7033.613151276729;7050.471214658818;7384.335409813142;7558;7566.886496702444;7577.696892124253;7586.9620651898595;6838.658067096526;6913.10129683138;6913.723451061901;6916.066331045446;6916.3429474199875;6747.2915343890145;6749.662516874235;6757.729690812313;6791.694373753094;6819.318068193141 03:42:25 INFO - PROCESS | 22931 | |4;prototype.html;337.21597286309327;341.61738852485223;344.19115079563045;349.12369951421937;349.39205781939415;5941.494972927301;5949.196858424111;5979.339194058645;5990.640561566309;6000.279966404027;5926.348101708809;5927.318358388787;5934.910976335358;5937.67342796146;5939.168516407706;4394.714343567658;4431.800568974404;4531.6601254905845;4559.74921379324;4624.306354046887;4535.501094879561;4540.59134677879;4545.272756358983;4546.431696037996;4549.7725113744345;4493.932591011137;4498.752568608726;4499.392582001437;4503.211937910853;4516.751578663172;4372.97813510932;4420.469543654766;4510.188166130095;4519.751413672247;4527.909441811145;3953.802309884523;3961.8811435656976;3963.583823698499;3966.3257246268204;3976.363781794899;5545.833624991256;5547.472990065938;5563.499285064364;5565.499105080522;5569.610127291091;5268.394134674485;5270.604704647167;5278.5249327560705;5279.52484276417;5294.788208471657;6254.499640028786;6258.593191442542;6259.6870156492;6264.997600383962;6270.843228919268;4203.7687927164;4350.064736081726;4370.12597480502;4392.748066800947;4406.405135306757;6516.413522782972;6539.378759017934;6543.541952063358;6562.704678289536;6581.440577550866;4453.977730111329;4458.08609235106;4461.063176732858;4467.508574056851;4468.575485328888;4509.7970591323465;4514.503404625489;4515.254982927846;4516.503184649686;4517.412736344254;5226.947730522722;5234.319538460052;5242;5246.685198888079;5249.818790772122;6130.049842274455;6314.684265786692;6323.9051414228825;6324.3991820776955;6326.588771729823;1557.0891028748308;1582.0349586752072;1589.2927647196886;1590.8091029076586;1596.5529651697543;968.6077138758814;1002.308407199045;1011.7066050845319;1017.2370721958531;1033.2973577966904;6044.335123136451;6054.878902422015;6067.393260673985;6094.634321940698;6150.231221097363;6456.451201647913;6474.902876456857;6476.190476190476;6479.967600161969;6499.675016249169;6113.052476866004;6120.112583675342;6120.44915957566;6128.479079278222;6130.417610327012;3463.3765922133753;3501.9474707879403;3503.8787587971606;3511.438169892805;3512.666296701809;6625;6804;6961.26906674802;6977.058097156921;6981.616011119438;6778.796636100925;6779.15260592426;6784.050232967388;6801.013852991288;6804.863902721918;6927.134108236471;6929.203141638675;6929.514933954676;6933.68798404073;6956.130483689539;6581.736730530916;6587;6601;6612.272650008592;6613.834654133685;6395.840103997251;6474.0612611172055;6500.739970401131;6514.4788416925585;6523.11937888398;6878.071460352789;6893.931060689329;6900.171979362509;6926.411255043377;6934.410575101173;4372.497162826316;4395.120975804915;4396.9120617588105;4401.449818772653;4402.11957608486;6581.045748366364;6583.275839657538;6586.110875032001;6593.241777195492;6599.769008084694;6089.360617135137;6393.968030159819;6423.293437721753;6423.807285781434;6425.742970281136;6399.872002560016;6415.230172379344;6423.132877061536;6437.806865794034;6438.195225596801;6294.402031806971;6297.055441683784;6297.244330680348;6301.149344838388;6312;6451.322611125952;6454.257760357431;6455.128557644658;6462.063000864942;6468.094466774562;5996.910046349395;6075.1191077294425;6203.038529028008;6317.6209427434505;6320 03:42:25 INFO - PROCESS | 22931 | |5;yui.html;746.250018731175;749.8275396658769;771.7646117934031;772.2624893226969;802.9036515618127;14136.151830890141;14299.356528956196;14314.42742290307;14346.99571030027;14351.497697580588;13817.447302107928;13817.585472435818;13860.099093558913;13878.167309961384;13893.583192504217;777.9338756205715;924.7503174143011;945.9763505912339;948.2556193388192;949.8147861167075;946.5125460387906;950.686273529737;951.980960380792;952.380952380951;953.0421925964431;829.9502029878226;1001.2940876681922;1001.5943542865151;1005.4671024357066;1009.6213919780082;964.9758756031085;992.3648864726581;994.3636072913341;995.0795514149455;995.6564985080136;728.5519405565592;729.7008226627111;731.5756861020595;733.6588486353871;734.9081364829397;14572.927135364362;14681.192534410604;14746.852531474655;14781.704365912728;14797.40810367584;13313.733725325535;13632.591022269347;13774.517891873737;14098.718025639533;14212.644683882985;11414.60048898293;11552.24910380831;11564.190506664538;11644.534218631245;11903.22629029119;3891.299566078105;3933.8229779659982;3940.6453419192126;3944.4280579315837;3949.98025009876;51916;51971;52141.47858521442;53030;54077.1888421674;10825.296355736851;10948.178886583539;10995.175361847734;11243.100551955824;11638.825417618742;19757.308494202633;19941.501462463264;19979.400617981482;19991.700124498144;19999.800002000084;8246.134155913664;8402.495850248883;8547.27348175412;8607.053224145338;8623.827523449496;4491.393661855608;4588.311753237042;4613.446386433649;4672.135654903854;4876.634252431082;3390.1016230698883;3418.333424982154;3428.194374322032;3432.3135372925517;3433.8798142065407;615.8614311779903;633.297040285283;645.4868379638199;646.1245013007401;646.1922596754057;724.2359310926918;729.5804912175414;752.9058867641545;766.2414209932127;773.8065483629093;8545.74362769118;8596.742097737078;9047.68333108338;9116.908830911738;9160.8625870612;702.2275496953413;703.6798256793147;714.8070021094276;720.7153174496044;741.1180694972965;4241.936370954438;4242.596953289432;4255.957440425618;4295.055087880662;4478.081993191388;52865.47134528682;53176.73411632917;53261;53319.20021199685;53391;51939;52652.47347526476;52884.206736898974;53278.73360633172;53432.46567534353;47898.5210147901;48134.518654813706;48151.75924120357;48947.510524895006;49964.00071998539;8944.955275223581;9045.366824322235;9051.32115091384;9069.77325566866;9283.257339412965;34233;36105.0973725659;36809.263814724094;37148.44277335896;37434.251314973;45448.54551454443;46118.53881461143;46311.76844115893;46477.3028404581;47352.7632361836;12465.626031218715;12549.623511294676;12636.2418254905;12913.289769062792;12998.610041698765;12717.427715752998;12907.483700651868;13117.540886068942;13146.408411621309;13230.867691323348;11938.76122477563;11947.522099115939;12178.939105304771;12211.206271592318;12705.936470317589;12614.432350544064;12658.43037063316;12729.363531823557;12866.485340586647;12953.935230323788;12389.318587477776;12482.251064936132;12578.496860125859;12742.362881856056;13079.084464087422;10815.945920270347;10849.643794525684;10873.891261087289;11132.109431245643;11234.719132021764;10253.923338049397;10471.267011309135;10521.368717876952;10544.789104218025;10755.677329680122 03:42:25 INFO - PROCESS | 22931 | __end_tp_report 03:42:25 INFO - PROCESS | 22931 | __start_cc_report 03:42:25 INFO - PROCESS | 22931 | _x_x_mozilla_cycle_collect,661 03:42:25 INFO - PROCESS | 22931 | __end_cc_report 03:42:25 INFO - PROCESS | 22931 | __startTimestamp1463049745744__endTimestamp 03:42:25 INFO - PROCESS | 22931 | 03:42:25 INFO - PROCESS | 22931 | ------- Summary: start ------- 03:42:25 INFO - PROCESS | 22931 | Number of tests: 6 03:42:25 INFO - PROCESS | 22931 | 03:42:25 INFO - PROCESS | 22931 | [#0] dojo.html Cycles:165 Average:5377.42 Median:5547.14 stddev:581.84 (10.5%) stddev-sans-first:559.98 03:42:25 INFO - PROCESS | 22931 | Values: 3284.4 3350.2 3375.2 3381.0 3403.5 5357.5 5360.0 5368.7 5369.3 5420.1 5364.7 5378.8 5396.6 5397.0 5401.2 4836.6 4925.9 4963.5 4981.5 5014.6 4814.4 4864.6 4901.5 4902.4 4908.2 4960.2 5006.5 5012.0 5019.1 5038.1 4881.4 4913.8 4967.1 4981.7 4986.2 4865.1 4901.1 4928.1 4954.8 4975.0 5049.3 5118.3 5118.7 5137.4 5145.1 5814.4 5842.2 5842.3 5851.0 5854.8 5739.7 5773.4 5824.6 5827.5 5852.9 5430.5 5469.2 5472.4 5478.3 5509.0 5949.6 5966.5 5971.8 5975.2 5977.8 5547.1 5573.4 5605.9 5733.8 5739.6 5842.8 5854.1 5856.3 5858.7 5860.6 5793.4 5825.3 5828.5 5828.8 5830.2 5704.0 5726.7 5779.9 5811.1 5811.5 4402.7 4425.4 4428.3 4428.3 4454.8 4006.7 4025.2 4032.5 4041.3 4061.0 5346.0 5482.4 5546.4 5554.4 5602.8 5754.5 5807.3 5822.7 5825.7 5827.4 5448.2 5479.0 5509.1 5542.0 5543.0 4948.0 5020.9 5031.1 5037.4 5046.0 6045.3 6060.5 6076.1 6085.9 6093.8 5668.5 5676.8 5812.2 5842.2 5842.4 6018.8 6039.2 6044.5 6051.4 6068.7 5655.3 5696.0 5698.8 5700.1 5704.7 5597.0 5777.0 5781.0 5788.3 5852.4 5570.1 5574.0 5575.9 5578.3 5581.4 5547.9 5549.3 5558.3 5561.7 5563.0 5344.7 5464.7 5509.8 5577.7 5620.1 5445.9 5564.8 5583.1 5681.0 5693.8 5455.9 5484.5 5485.9 5498.9 5529.9 03:42:25 INFO - PROCESS | 22931 | 03:42:25 INFO - PROCESS | 22931 | [#1] ext.html Cycles:180 Average:46831.36 Median:38025.93 stddev:78786.93 (207.2%) stddev-sans-first:78931.12 03:42:25 INFO - PROCESS | 22931 | Values: 493.0 542.5 545.6 549.1 561.4 31862.4 38480.4 38947.4 39136.6 39147.6 43242.6 43747.8 43877.8 43946.8 43972.6 8886.4 9078.2 9089.9 9094.4 9098.5 8910.6 9000.5 9056.5 9058.2 9067.3 8959.5 9301.4 9346.5 9352.5 9356.9 9170.0 9270.0 9270.3 9271.0 9281.6 9190.8 9318.6 9330.1 9338.8 9342.7 42829.6 43197.4 43269.4 43317.4 43350.3 3564.3 3767.6 3791.2 4188.0 4286.4 31964.4 32269.7 32327.4 32511.5 33006.8 4016.7 4047.8 4103.8 4118.5 4150.4 301884.0 302114.0 302535.0 302805.0 304052.0 45128.3 67119.7 67693.0 67747.0 67845.3 43366.0 43412.8 43421.6 43614.0 43730.0 16142.1 16375.3 16441.3 16443.1 16449.3 12919.5 12969.2 12984.5 13009.8 13012.3 15099.7 15169.3 15664.9 15683.2 15763.4 5536.9 5883.1 5920.7 5954.9 6012.6 961.0 1026.2 1096.6 1169.5 1240.6 29877.7 29906.9 30215.5 30944.5 31139.5 1158.7 1163.3 1212.4 1217.4 1256.6 15533.0 15625.5 15768.9 15959.4 16025.4 366426.0 368371.0 369034.0 369250.0 369427.0 57457.7 58592.4 58611.0 58626.7 58677.7 1283.9 1469.8 1475.7 1479.5 1584.9 26970.5 29832.9 29925.0 30128.7 30742.0 46576.0 47046.0 47062.4 47064.8 47115.3 198125.0 199512.0 212241.0 215496.0 216049.0 30133.7 35235.3 35301.5 35312.5 36209.5 41022.4 41331.0 41430.2 42077.4 42174.0 36249.8 37929.4 38088.2 38777.6 38789.2 37125.6 37295.4 37861.4 38509.2 38736.0 36664.0 37558.0 37963.6 42299.8 43035.4 33126.2 33723.7 34276.7 34896.7 34956.5 27013.2 27232.5 27505.9 27549.2 27626.9 03:42:25 INFO - PROCESS | 22931 | 03:42:25 INFO - PROCESS | 22931 | [#2] jquery.html Cycles:180 Average:26596.11 Median:21437.96 stddev:73888.84 (344.7%) stddev-sans-first:74069.89 03:42:25 INFO - PROCESS | 22931 | Values: 372.6 374.3 378.2 381.5 384.9 17985.0 18247.9 19084.8 19110.5 19137.4 17378.3 17567.6 17875.7 17942.8 17953.7 5574.9 5803.0 5820.8 5838.3 5840.4 4296.2 5718.4 5967.5 6207.2 6266.2 6188.7 6206.1 6214.0 6227.6 6228.6 5948.1 6206.8 6214.6 6217.2 6220.8 3849.2 5275.7 5446.8 5477.0 5480.6 21122.6 21248.4 21332.5 21543.5 21563.0 2295.6 2397.6 2399.9 2422.6 2486.1 9739.4 10248.3 10391.9 10434.8 10439.4 1872.6 1881.1 1916.6 1933.7 1957.3 70427.3 70783.6 71036.6 71440.6 71826.6 10459.4 10706.0 10727.7 10742.2 10791.9 14822.8 14852.9 15030.8 15112.7 15139.5 7959.7 8119.8 8139.5 8204.5 8338.8 7682.1 7722.0 7772.6 7784.9 8000.5 4616.5 4645.7 4657.1 4693.4 4705.3 1686.9 1753.5 1764.2 1832.2 1880.5 943.2 1090.1 1095.7 1111.2 1121.5 16122.4 16384.0 16392.6 16691.8 17073.1 1020.5 1050.0 1056.1 1058.7 1065.6 10018.5 10093.8 10152.1 10193.7 10209.9 401904.0 418029.0 469582.0 474308.0 479510.0 76362.0 77927.0 78382.2 78917.2 80696.6 1020.3 1032.6 1042.3 1058.5 1076.8 15833.9 15841.9 16025.8 16035.3 16086.8 35737.6 35889.5 36433.6 36564.6 37033.4 51132.7 51803.7 51964.2 52015.2 52177.7 8546.4 8566.7 8659.3 8812.4 8885.9 10189.8 10493.6 13183.0 13280.2 13706.6 10701.7 10916.1 11145.8 11169.0 11253.8 10946.4 11110.1 11151.4 11380.9 11575.4 11551.6 11579.7 11771.6 11873.9 12162.0 8482.3 8583.7 8590.3 8783.3 9028.3 10123.7 12237.7 12250.2 12304.8 12535.4 03:42:25 INFO - PROCESS | 22931 | 03:42:25 INFO - PROCESS | 22931 | [#3] mootools.html Cycles:180 Average:5789.06 Median:6580.36 stddev:3008.98 (45.7%) stddev-sans-first:2999.46 03:42:25 INFO - PROCESS | 22931 | Values: 1415.6 1429.9 1488.2 1636.6 1674.1 8013.9 8134.9 8210.3 8226.8 8228.5 7313.2 7580.9 7714.5 7753.3 8089.2 2247.4 2292.2 2292.3 2293.1 2295.0 2307.7 2317.3 2380.4 2380.7 2383.7 2073.3 2332.6 2383.2 2390.2 2390.3 2312.9 2320.5 2340.8 2357.2 2359.6 2317.4 2334.9 2336.2 2340.4 2342.9 8306.5 8358.5 8371.0 8384.2 8612.2 4935.8 5058.5 5059.1 5076.6 5086.1 3180.9 3195.1 3236.9 3414.7 3444.2 1051.5 1064.1 1064.7 1096.0 1100.1 11517.1 11523.0 11528.2 11542.2 11624.6 4490.4 4624.7 4663.7 4672.9 4672.9 9958.6 9987.7 9990.7 9992.0 9992.3 5211.8 5236.2 5243.0 5251.5 5267.5 4620.1 4638.6 4639.8 4647.6 4651.5 3973.2 3995.3 4002.4 4014.2 4049.5 1171.3 1239.8 1252.6 1285.5 1298.4 1127.7 1133.6 1139.7 1367.7 1439.3 7539.4 7587.0 7683.2 7687.7 7701.0 1193.0 1209.4 1210.6 1214.2 1234.9 5989.2 6128.8 6182.8 6186.9 6206.2 9690.3 9818.9 9823.9 9933.7 9946.7 9613.3 9816.1 9879.8 9896.9 9919.0 7923.2 7925.9 7983.6 7994.2 8064.7 7516.4 7548.9 7610.6 7634.1 7664.5 8608.7 8769.5 8847.7 8995.5 9041.7 9028.2 9054.1 9244.7 9271.5 9343.0 7289.9 7337.4 7377.2 7380.7 7420.3 7861.1 7876.6 7977.0 8057.3 8070.6 6413.4 7415.3 7470.5 7473.2 7531.2 6828.6 6932.4 7026.7 7033.6 7050.5 7384.3 7558.0 7566.9 7577.7 7587.0 6838.7 6913.1 6913.7 6916.1 6916.3 6747.3 6749.7 6757.7 6791.7 6819.3 03:42:25 INFO - PROCESS | 22931 | 03:42:25 INFO - PROCESS | 22931 | [#4] prototype.html Cycles:180 Average:5299.47 Median:6049.61 stddev:1626.56 (26.9%) stddev-sans-first:1587.91 03:42:25 INFO - PROCESS | 22931 | Values: 337.2 341.6 344.2 349.1 349.4 5941.5 5949.2 5979.3 5990.6 6000.3 5926.3 5927.3 5934.9 5937.7 5939.2 4394.7 4431.8 4531.7 4559.7 4624.3 4535.5 4540.6 4545.3 4546.4 4549.8 4493.9 4498.8 4499.4 4503.2 4516.8 4373.0 4420.5 4510.2 4519.8 4527.9 3953.8 3961.9 3963.6 3966.3 3976.4 5545.8 5547.5 5563.5 5565.5 5569.6 5268.4 5270.6 5278.5 5279.5 5294.8 6254.5 6258.6 6259.7 6265.0 6270.8 4203.8 4350.1 4370.1 4392.7 4406.4 6516.4 6539.4 6543.5 6562.7 6581.4 4454.0 4458.1 4461.1 4467.5 4468.6 4509.8 4514.5 4515.3 4516.5 4517.4 5226.9 5234.3 5242.0 5246.7 5249.8 6130.0 6314.7 6323.9 6324.4 6326.6 1557.1 1582.0 1589.3 1590.8 1596.6 968.6 1002.3 1011.7 1017.2 1033.3 6044.3 6054.9 6067.4 6094.6 6150.2 6456.5 6474.9 6476.2 6480.0 6499.7 6113.1 6120.1 6120.4 6128.5 6130.4 3463.4 3501.9 3503.9 3511.4 3512.7 6625.0 6804.0 6961.3 6977.1 6981.6 6778.8 6779.2 6784.1 6801.0 6804.9 6927.1 6929.2 6929.5 6933.7 6956.1 6581.7 6587.0 6601.0 6612.3 6613.8 6395.8 6474.1 6500.7 6514.5 6523.1 6878.1 6893.9 6900.2 6926.4 6934.4 4372.5 4395.1 4396.9 4401.4 4402.1 6581.0 6583.3 6586.1 6593.2 6599.8 6089.4 6394.0 6423.3 6423.8 6425.7 6399.9 6415.2 6423.1 6437.8 6438.2 6294.4 6297.1 6297.2 6301.1 6312.0 6451.3 6454.3 6455.1 6462.1 6468.1 5996.9 6075.1 6203.0 6317.6 6320.0 03:42:25 INFO - PROCESS | 22931 | 03:42:25 INFO - PROCESS | 22931 | [#5] yui.html Cycles:180 Average:14565.16 Median:4249.28 stddev:16196.86 (381.2%) stddev-sans-first:16209.05 03:42:25 INFO - PROCESS | 22931 | Values: 746.3 749.8 771.8 772.3 802.9 14136.2 14299.4 14314.4 14347.0 14351.5 13817.4 13817.6 13860.1 13878.2 13893.6 777.9 924.8 946.0 948.3 949.8 946.5 950.7 952.0 952.4 953.0 830.0 1001.3 1001.6 1005.5 1009.6 965.0 992.4 994.4 995.1 995.7 728.6 729.7 731.6 733.7 734.9 14572.9 14681.2 14746.9 14781.7 14797.4 13313.7 13632.6 13774.5 14098.7 14212.6 11414.6 11552.2 11564.2 11644.5 11903.2 3891.3 3933.8 3940.6 3944.4 3950.0 51916.0 51971.0 52141.5 53030.0 54077.2 10825.3 10948.2 10995.2 11243.1 11638.8 19757.3 19941.5 19979.4 19991.7 19999.8 8246.1 8402.5 8547.3 8607.1 8623.8 4491.4 4588.3 4613.4 4672.1 4876.6 3390.1 3418.3 3428.2 3432.3 3433.9 615.9 633.3 645.5 646.1 646.2 724.2 729.6 752.9 766.2 773.8 8545.7 8596.7 9047.7 9116.9 9160.9 702.2 703.7 714.8 720.7 741.1 4241.9 4242.6 4256.0 4295.1 4478.1 52865.5 53176.7 53261.0 53319.2 53391.0 51939.0 52652.5 52884.2 53278.7 53432.5 47898.5 48134.5 48151.8 48947.5 49964.0 8945.0 9045.4 9051.3 9069.8 9283.3 34233.0 36105.1 36809.3 37148.4 37434.3 45448.5 46118.5 46311.8 46477.3 47352.8 12465.6 12549.6 12636.2 12913.3 12998.6 12717.4 12907.5 13117.5 13146.4 13230.9 11938.8 11947.5 12178.9 12211.2 12705.9 12614.4 12658.4 12729.4 12866.5 12953.9 12389.3 12482.3 12578.5 12742.4 13079.1 10815.9 10849.6 10873.9 11132.1 11234.7 10253.9 10471.3 10521.4 10544.8 10755.7 03:42:25 INFO - PROCESS | 22931 | -------- Summary: end -------- 03:42:25 INFO - PROCESS | 22931 | 03:42:26 INFO - TEST-INFO | 22931: exit 0 03:42:26 INFO - TEST-OK | dromaeo_css | took 1111536ms 03:42:26 INFO - TEST-START | kraken 03:42:26 INFO - operating with platform_type : linux_ 03:42:26 INFO - Initialising browser for kraken test... 03:42:26 INFO - TEST-INFO | started process 23124 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpago7wl/profile http://localhost:58987/getInfo.html) 03:42:30 INFO - PROCESS | 23124 | __metrics Screen width/height:1600/1200 03:42:30 INFO - PROCESS | 23124 | colorDepth:24 03:42:30 INFO - PROCESS | 23124 | Browser inner width/height: 1024/697 03:42:30 INFO - PROCESS | 23124 | __metrics 03:42:32 INFO - PROCESS | 23124 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:42:32 INFO - TEST-INFO | 23124: exit 0 03:42:32 INFO - Browser initialized. 03:42:32 INFO - Running cycle 1/1 for kraken test... 03:42:32 INFO - TEST-INFO | started process 23213 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpago7wl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:42:44 INFO - PROCESS | 23213 | RSS: Main: 139255808 03:42:44 INFO - PROCESS | 23213 | 03:42:47 INFO - PROCESS | 23213 | Cycle 1(1): loaded http://localhost:58987/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58987/tests/kraken/driver.html?testName=audio-beat-detection) 03:42:47 INFO - PROCESS | 23213 | RSS: Main: 174137344 03:42:47 INFO - PROCESS | 23213 | 03:42:50 INFO - PROCESS | 23213 | Cycle 1(1): loaded http://localhost:58987/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58987/tests/kraken/driver.html?testName=audio-dft) 03:42:50 INFO - PROCESS | 23213 | RSS: Main: 172089344 03:42:50 INFO - PROCESS | 23213 | 03:42:53 INFO - PROCESS | 23213 | Cycle 1(1): loaded http://localhost:58987/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58987/tests/kraken/driver.html?testName=audio-fft) 03:42:54 INFO - PROCESS | 23213 | RSS: Main: 169119744 03:42:54 INFO - PROCESS | 23213 | 03:42:56 INFO - PROCESS | 23213 | Cycle 1(1): loaded http://localhost:58987/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58987/tests/kraken/driver.html?testName=audio-oscillator) 03:42:56 INFO - PROCESS | 23213 | RSS: Main: 169263104 03:42:56 INFO - PROCESS | 23213 | 03:42:59 INFO - PROCESS | 23213 | Cycle 1(1): loaded http://localhost:58987/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58987/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:42:59 INFO - PROCESS | 23213 | RSS: Main: 168394752 03:42:59 INFO - PROCESS | 23213 | 03:43:02 INFO - PROCESS | 23213 | Cycle 1(1): loaded http://localhost:58987/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58987/tests/kraken/driver.html?testName=imaging-darkroom) 03:43:03 INFO - PROCESS | 23213 | RSS: Main: 168308736 03:43:03 INFO - PROCESS | 23213 | 03:43:06 INFO - PROCESS | 23213 | Cycle 1(1): loaded http://localhost:58987/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58987/tests/kraken/driver.html?testName=imaging-desaturate) 03:43:07 INFO - PROCESS | 23213 | RSS: Main: 167915520 03:43:07 INFO - PROCESS | 23213 | 03:43:10 INFO - PROCESS | 23213 | Cycle 1(1): loaded http://localhost:58987/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58987/tests/kraken/driver.html?testName=json-parse-financial) 03:43:10 INFO - PROCESS | 23213 | RSS: Main: 168022016 03:43:10 INFO - PROCESS | 23213 | 03:43:12 INFO - PROCESS | 23213 | Cycle 1(1): loaded http://localhost:58987/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58987/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:43:12 INFO - PROCESS | 23213 | RSS: Main: 173264896 03:43:12 INFO - PROCESS | 23213 | 03:43:14 INFO - PROCESS | 23213 | Cycle 1(1): loaded http://localhost:58987/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58987/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:43:15 INFO - PROCESS | 23213 | RSS: Main: 171384832 03:43:15 INFO - PROCESS | 23213 | 03:43:17 INFO - PROCESS | 23213 | Cycle 1(1): loaded http://localhost:58987/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58987/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:43:17 INFO - PROCESS | 23213 | RSS: Main: 178360320 03:43:17 INFO - PROCESS | 23213 | 03:43:20 INFO - PROCESS | 23213 | Cycle 1(1): loaded http://localhost:58987/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58987/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:43:20 INFO - PROCESS | 23213 | RSS: Main: 181600256 03:43:20 INFO - PROCESS | 23213 | 03:43:23 INFO - PROCESS | 23213 | Cycle 1(1): loaded http://localhost:58987/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58987/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:43:23 INFO - PROCESS | 23213 | RSS: Main: 181968896 03:43:23 INFO - PROCESS | 23213 | 03:43:25 INFO - PROCESS | 23213 | Cycle 1(1): loaded http://localhost:58987/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58987/tests/kraken/driver.html?testName=ai-astar) 03:43:25 INFO - PROCESS | 23213 | RSS: Main: 244080640 03:43:25 INFO - PROCESS | 23213 | 03:43:25 INFO - PROCESS | 23213 | __start_tp_report 03:43:25 INFO - PROCESS | 23213 | _x_x_mozilla_page_load 03:43:25 INFO - PROCESS | 23213 | _x_x_mozilla_page_load_details 03:43:25 INFO - PROCESS | 23213 | |i|pagename|runs| 03:43:25 INFO - PROCESS | 23213 | |0;ai-astar;111;114;107;112;112;111;100;110;112;110 03:43:25 INFO - PROCESS | 23213 | |1;audio-beat-detection;157;127;155;170;126;158;148;127;179;134 03:43:25 INFO - PROCESS | 23213 | |2;audio-dft;162;161;161;161;162;160;159;164;162;162 03:43:25 INFO - PROCESS | 23213 | |3;audio-fft;77;77;76;174;76;76;76;77;171;74 03:43:25 INFO - PROCESS | 23213 | |4;audio-oscillator;92;93;152;93;92;93;148;92;94;137 03:43:25 INFO - PROCESS | 23213 | |5;imaging-gaussian-blur;117;116;117;116;117;117;117;119;117;116 03:43:25 INFO - PROCESS | 23213 | |6;imaging-darkroom;153;145;146;146;146;146;145;146;145;146 03:43:25 INFO - PROCESS | 23213 | |7;imaging-desaturate;95;95;95;96;96;95;95;95;95;95 03:43:25 INFO - PROCESS | 23213 | |8;json-parse-financial;55;55;57;54;54;57;56;56;55;54 03:43:25 INFO - PROCESS | 23213 | |9;json-stringify-tinderbox;78;78;77;77;77;78;78;77;77;77 03:43:25 INFO - PROCESS | 23213 | |10;stanford-crypto-aes;80;81;81;81;80;80;79;80;79;80 03:43:25 INFO - PROCESS | 23213 | |11;stanford-crypto-ccm;116;117;114;122;115;114;111;112;119;112 03:43:25 INFO - PROCESS | 23213 | |12;stanford-crypto-pbkdf2;138;138;150;147;160;138;151;148;145;147 03:43:25 INFO - PROCESS | 23213 | |13;stanford-crypto-sha256-iterative;67;72;69;67;68;67;65;71;68;65 03:43:25 INFO - PROCESS | 23213 | __end_tp_report 03:43:25 INFO - PROCESS | 23213 | __start_cc_report 03:43:25 INFO - PROCESS | 23213 | _x_x_mozilla_cycle_collect,1038 03:43:25 INFO - PROCESS | 23213 | __end_cc_report 03:43:25 INFO - PROCESS | 23213 | __startTimestamp1463049805841__endTimestamp 03:43:25 INFO - PROCESS | 23213 | 03:43:25 INFO - PROCESS | 23213 | ------- Summary: start ------- 03:43:25 INFO - PROCESS | 23213 | Number of tests: 14 03:43:25 INFO - PROCESS | 23213 | 03:43:25 INFO - PROCESS | 23213 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.50 stddev:3.93 (3.5%) stddev-sans-first:4.15 03:43:25 INFO - PROCESS | 23213 | Values: 111.0 114.0 107.0 112.0 112.0 111.0 100.0 110.0 112.0 110.0 03:43:25 INFO - PROCESS | 23213 | 03:43:25 INFO - PROCESS | 23213 | [#1] audio-beat-detection Cycles:10 Average:148.10 Median:156.00 stddev:18.96 (12.2%) stddev-sans-first:19.84 03:43:25 INFO - PROCESS | 23213 | Values: 157.0 127.0 155.0 170.0 126.0 158.0 148.0 127.0 179.0 134.0 03:43:25 INFO - PROCESS | 23213 | 03:43:25 INFO - PROCESS | 23213 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:1.35 (0.8%) stddev-sans-first:1.41 03:43:25 INFO - PROCESS | 23213 | Values: 162.0 161.0 161.0 161.0 162.0 160.0 159.0 164.0 162.0 162.0 03:43:25 INFO - PROCESS | 23213 | 03:43:25 INFO - PROCESS | 23213 | [#3] audio-fft Cycles:10 Average:95.40 Median:76.00 stddev:40.65 (53.5%) stddev-sans-first:42.57 03:43:25 INFO - PROCESS | 23213 | Values: 77.0 77.0 76.0 174.0 76.0 76.0 76.0 77.0 171.0 74.0 03:43:25 INFO - PROCESS | 23213 | 03:43:25 INFO - PROCESS | 23213 | [#4] audio-oscillator Cycles:10 Average:108.60 Median:92.50 stddev:25.85 (27.9%) stddev-sans-first:26.71 03:43:25 INFO - PROCESS | 23213 | Values: 92.0 93.0 152.0 93.0 92.0 93.0 148.0 92.0 94.0 137.0 03:43:25 INFO - PROCESS | 23213 | 03:43:25 INFO - PROCESS | 23213 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.88 (0.7%) stddev-sans-first:0.93 03:43:25 INFO - PROCESS | 23213 | Values: 117.0 116.0 117.0 116.0 117.0 117.0 117.0 119.0 117.0 116.0 03:43:25 INFO - PROCESS | 23213 | 03:43:25 INFO - PROCESS | 23213 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:2.37 (1.6%) stddev-sans-first:0.50 03:43:25 INFO - PROCESS | 23213 | Values: 153.0 145.0 146.0 146.0 146.0 146.0 145.0 146.0 145.0 146.0 03:43:25 INFO - PROCESS | 23213 | 03:43:25 INFO - PROCESS | 23213 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:43:25 INFO - PROCESS | 23213 | Values: 95.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 03:43:25 INFO - PROCESS | 23213 | 03:43:25 INFO - PROCESS | 23213 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.50 stddev:1.16 (2.1%) stddev-sans-first:1.22 03:43:25 INFO - PROCESS | 23213 | Values: 55.0 55.0 57.0 54.0 54.0 57.0 56.0 56.0 55.0 54.0 03:43:25 INFO - PROCESS | 23213 | 03:43:25 INFO - PROCESS | 23213 | [#9] json-stringify-tinderbox Cycles:10 Average:77.40 Median:77.50 stddev:0.52 (0.7%) stddev-sans-first:0.50 03:43:25 INFO - PROCESS | 23213 | Values: 78.0 78.0 77.0 77.0 77.0 78.0 78.0 77.0 77.0 77.0 03:43:25 INFO - PROCESS | 23213 | 03:43:25 INFO - PROCESS | 23213 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:80.00 stddev:0.74 (0.9%) stddev-sans-first:0.78 03:43:25 INFO - PROCESS | 23213 | Values: 80.0 81.0 81.0 81.0 80.0 80.0 79.0 80.0 79.0 80.0 03:43:25 INFO - PROCESS | 23213 | 03:43:25 INFO - PROCESS | 23213 | [#11] stanford-crypto-ccm Cycles:10 Average:115.20 Median:115.50 stddev:3.43 (3.0%) stddev-sans-first:3.62 03:43:25 INFO - PROCESS | 23213 | Values: 116.0 117.0 114.0 122.0 115.0 114.0 111.0 112.0 119.0 112.0 03:43:25 INFO - PROCESS | 23213 | 03:43:25 INFO - PROCESS | 23213 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.20 Median:147.50 stddev:6.96 (4.7%) stddev-sans-first:6.72 03:43:25 INFO - PROCESS | 23213 | Values: 138.0 138.0 150.0 147.0 160.0 138.0 151.0 148.0 145.0 147.0 03:43:25 INFO - PROCESS | 23213 | 03:43:25 INFO - PROCESS | 23213 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:2.28 (3.4%) stddev-sans-first:2.40 03:43:25 INFO - PROCESS | 23213 | Values: 67.0 72.0 69.0 67.0 68.0 67.0 65.0 71.0 68.0 65.0 03:43:25 INFO - PROCESS | 23213 | -------- Summary: end -------- 03:43:25 INFO - PROCESS | 23213 | 03:43:26 INFO - TEST-INFO | 23213: exit 0 03:43:26 INFO - TEST-OK | kraken | took 60285ms 03:43:26 INFO - SUITE-END | took 1171s 03:43:27 INFO - Completed test suite (00:19:32) 03:43:27 INFO - javascript benchmark 03:43:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3284.4252255855217, 3350.229447227136, 3375.1562109472648, 3381.0, 3403.5235067090603, 5357.517823395893, 5360.035193665139, 5368.651037682553, 5369.275147855038, 5420.051490989071, 5364.678119312844, 5378.838634840951, 5396.568274538037, 5397.028534863723, 5401.216823560581, 4836.613070954315, 4925.926111108336, 4963.528464795839, 4981.526754958291, 5014.5737612303, 4814.35006274152, 4864.562189402953, 4901.509849015106, 4902.436219834729, 4908.190148625473, 4960.156773348522, 5006.524380183877, 5012.0, 5019.071471777715, 5038.143515602356, 4881.365422495053, 4913.828016019458, 4967.10592093423, 4981.701097934136, 4986.202207646777, 4865.148598995197, 4901.1177987962155, 4928.063667903087, 4954.801807927679, 4975.0, 5049.267856160873, 5118.2578526113875, 5118.692878427306, 5137.434882162959, 5145.125328694094, 5814.418558144152, 5842.152887831241, 5842.298924129089, 5851.0, 5854.795082172103, 5739.684317362543, 5773.393793651648, 5824.621399609012, 5827.504662103726, 5852.941470585282, 5430.456954304538, 5469.179623056494, 5472.425395333473, 5478.287822583039, 5508.980838544842, 5949.643021418642, 5966.492848107872, 5971.7611295547695, 5975.193348897843, 5977.760889564369, 5547.140193270049, 5573.442655734475, 5605.859853503695, 5733.827985160452, 5739.62692424991, 5842.795502157404, 5854.092615644497, 5856.326522449973, 5858.736356863866, 5860.619059761188, 5793.449622285876, 5825.33008703996, 5828.53371730269, 5828.825135245865, 5830.2420685310635, 5704.0, 5726.656400615976, 5779.884402312015, 5811.128330750336, 5811.535077193815, 4402.7358358498595, 4425.402570652921, 4428.269335559661, 4428.2914733642465, 4454.821807127743, 4006.659433948147, 4025.2150830587752, 4032.4556184915245, 4041.2927737646382, 4060.9847538115473, 5346.037713211582, 5482.369527504388, 5546.417626149277, 5554.389017208104, 5602.831915042555, 5754.4533269339345, 5807.274090738658, 5822.650640961556, 5825.7378417971295, 5827.4172582741385, 5448.237246785453, 5479.04116779562, 5509.146082357241, 5541.972290138524, 5543.0, 4947.975260123676, 5020.949790502122, 5031.069252188357, 5037.420696619863, 5046.0, 6045.33501314855, 6060.454559089703, 6076.149339092531, 6085.878282434415, 6093.786717464867, 5668.51817595509, 5676.772929082956, 5812.244408226818, 5842.1820945068575, 5842.357340692605, 6018.8194354169445, 6039.15451836752, 6044.516438684983, 6051.425114614105, 6068.696565171812, 5655.293088363955, 5696.0, 5698.8290351289525, 5700.059490184239, 5704.743286552198, 5596.972015139898, 5777.046787280052, 5780.971095144498, 5788.305403351625, 5852.385499522659, 5570.136628822539, 5574.0, 5575.8606034847835, 5578.330600327987, 5581.413951535031, 5547.944520554743, 5549.306336707911, 5558.277423934863, 5561.694106824163, 5562.972185139049, 5344.679319240858, 5464.699441530754, 5509.807156749494, 5577.6653400796085, 5620.100783874724, 5445.863853403696, 5564.8330550083565, 5583.106702927675, 5680.971595141998, 5693.772249109989, 5455.9454405455435, 5484.533814625802, 5485.945140548543, 5498.945010549844, 5529.944700552943], "unit": "score", "name": "dojo.html", "value": 5341.338635114108}, {"lowerIsBetter": false, "replicates": [492.9580985616225, 542.5388419843131, 545.5880809988458, 549.1022178737763, 561.4049107945578, 31862.36275274493, 38480.42279365808, 38947.41578876312, 39136.60863391365, 39147.60852391475, 43242.56757432425, 43747.78126109365, 43877.78061109698, 43946.78026609871, 43972.56027439725, 8886.377953543255, 9078.182963533282, 9089.909100909006, 9094.363394562382, 9098.499582522958, 8910.599023043946, 9000.504972226525, 9056.456612603231, 9058.23005044572, 9067.319951003668, 8959.462432254053, 9301.44191348518, 9346.532673366339, 9352.532373381338, 9356.859647105299, 9169.95415022924, 9269.953650231773, 9270.258379329638, 9271.0, 9281.628734850598, 9190.770230744285, 9318.627254909796, 9330.113639204264, 9338.766530836783, 9342.719718408458, 42829.57170428287, 43197.35203971943, 43269.35095973563, 43317.35023974643, 43350.349744753854, 3564.322778672044, 3767.566729826078, 3791.184895247535, 4188.015816283171, 4286.39990401344, 31964.360712785616, 32269.6773032269, 32327.353452931045, 32511.512327315108, 33006.834965825255, 4016.6786657067364, 4047.8380864765372, 4103.835846566134, 4118.5263694675195, 4150.418941348214, 301884.0, 302113.9999999978, 302535.0, 302805.0, 304052.0, 45128.3230751539, 67119.66440167866, 67693.0, 67747.0, 67845.3215467849, 43366.0, 43412.78293608512, 43421.56578434175, 43614.0, 43730.0, 16142.112183830002, 16375.263113159936, 16441.26014329334, 16443.09562974024, 16449.25978330978, 12919.483220671067, 12969.157004794659, 12984.480620775063, 13009.804852927213, 13012.284324362061, 15099.698006039818, 15169.317380717894, 15664.921675391777, 15683.215839208222, 15763.448279310169, 5536.916946245809, 5883.058231085823, 5920.674362909996, 5954.8809023819285, 6012.579119461596, 960.9903900961041, 1026.1944373666636, 1096.6107032003524, 1169.5438778876246, 1240.6030070377574, 29877.701222987493, 29906.85046574753, 30215.546766798514, 30944.535831962537, 31139.532907006414, 1158.6871544682888, 1163.2555164694602, 1212.3877441891789, 1217.4095563651622, 1256.6355756830599, 15533.0, 15625.53123406277, 15768.92115539415, 15959.44141955026, 16025.439109631106, 366426.0, 368371.0, 369034.0, 369250.0, 369427.0, 57457.71271143617, 58592.414075859546, 58611.0, 58626.70686646539, 58677.706611467525, 1283.8844503994685, 1469.8309694385282, 1475.7269905067596, 1479.4526025370683, 1584.881133914961, 26970.460590788465, 29832.85083574568, 29925.0, 30128.69871301259, 30742.0, 46576.0, 47046.0, 47062.35281765122, 47064.7646761764, 47115.29327060028, 198125.0, 199512.0, 212241.0, 215496.0, 216049.0, 30133.698663013965, 35235.29529409346, 35301.47047794234, 35312.47031294584, 36209.45685814662, 41022.38466422947, 41331.0, 41430.1713965713, 42077.36883946804, 42174.0, 36249.81875090607, 37929.4310585347, 38088.238235235694, 38777.6122238774, 38789.224215514965, 37125.628743712216, 37295.44056839095, 37861.43207851939, 38509.2298154041, 38736.0, 36664.0, 37558.0, 37963.620363796006, 42299.78850105853, 43035.3544696836, 33126.17184570309, 33723.66276337205, 34276.65723342834, 34896.65103349036, 34956.47565286472, 27013.1896043119, 27232.455350892476, 27505.86247068752, 27549.207489918823, 27626.861865690542], "unit": "score", "name": "ext.html", "value": 18907.651829310824}, {"lowerIsBetter": false, "replicates": [372.6217888842825, 374.3224763178645, 378.2076549628527, 381.49832969644905, 384.94610754494374, 17985.0, 18247.908760456197, 19084.809151908477, 19110.52223694408, 19137.42587722367, 17378.304867805306, 17567.560810979732, 17875.73186402205, 17942.820571794276, 17953.73069403957, 5574.888502229953, 5803.0, 5820.796272130477, 5838.2994040715175, 5840.445157710032, 4296.248156572603, 5718.399568045358, 5967.462928336449, 6207.224096987877, 6266.185395898527, 6188.690565471708, 6206.069089636546, 6214.036824292242, 6227.626342419469, 6228.5951413158, 5948.1375200595885, 6206.789676013179, 6214.627122372672, 6217.1917650705345, 6220.751169953196, 3849.2109117630816, 5275.657082289639, 5446.809361672362, 5477.04151773438, 5480.588955828329, 21122.5775484491, 21248.36254912355, 21332.46668833276, 21543.461413464633, 21563.0, 2295.644175152854, 2397.5924092904247, 2399.928002159938, 2422.551827911824, 2486.1422809130822, 9739.415635061849, 10248.333858299187, 10391.896081039169, 10434.843477347846, 10439.42583157926, 1872.6161136967025, 1881.0782716468968, 1916.568772026297, 1933.7002764571514, 1957.314939771083, 70427.29572704258, 70783.64608176978, 71036.6448167761, 71440.64279678569, 71826.64086679586, 10459.372437653765, 10706.0, 10727.678169654922, 10742.24804263694, 10791.892081079088, 14822.777658335133, 14852.851471485363, 15030.849691503163, 15112.697746045018, 15139.54581362561, 7959.721409750631, 8119.75640730779, 8139.540695204514, 8204.507729536246, 8338.791530211673, 7682.116556595951, 7722.0, 7772.572508512086, 7784.883226751604, 8000.479968802009, 4616.469106052779, 4645.74448405341, 4657.138429390574, 4693.436787585443, 4705.270683044134, 1686.9409570665214, 1753.4739578126766, 1764.2061072517417, 1832.1663643042384, 1880.5392678793783, 943.1888575824785, 1090.0788833435734, 1095.7479779650726, 1111.1721767283425, 1121.545773961547, 16122.355105795637, 16384.0169589825, 16392.590185245226, 16691.833081669272, 17073.06098164613, 1020.4846552490944, 1050.0497050169608, 1056.1181413519644, 1058.6771034834296, 1065.5684447798653, 10018.549165287579, 10093.848592271122, 10152.086312231935, 10193.745156371002, 10209.897901020895, 401904.0, 418029.0, 469582.0, 474308.0, 479510.0, 76362.0, 77927.0, 78382.21617783864, 78917.21082789214, 80696.59651701704, 1020.3265844542566, 1032.6437379104198, 1042.2547878267076, 1058.4601853054996, 1076.7523469602036, 15833.920830395775, 15841.920790395974, 16025.839741602435, 16035.2784124717, 16086.758698619296, 35737.64262357447, 35889.46165807567, 36433.63566364408, 36564.634353656125, 37033.44449833308, 51132.74433627957, 51803.74098129485, 51964.22053669274, 52015.2197717027, 52177.73911130572, 8546.401751877558, 8566.742997710078, 8659.307255419677, 8812.427192232484, 8885.866711999195, 10189.84715229287, 10493.580256789643, 13183.0, 13280.203187808762, 13706.588802335946, 10701.678949631523, 10916.126709863032, 11145.832812507657, 11169.0, 11253.774924501628, 10946.35804629312, 11110.111191104854, 11151.442427878412, 11380.886191137983, 11575.363355015555, 11551.595694150665, 11579.652610421701, 11771.646850594496, 11873.881261187278, 12162.0, 8482.345942541391, 8583.742487725129, 8590.269827064769, 8783.253423458822, 9028.277737781093, 10123.7469063274, 12237.69405764863, 12250.203736757083, 12304.81542776877, 12535.435905384098], "unit": "score", "name": "jquery.html", "value": 8920.796984399822}, {"lowerIsBetter": false, "replicates": [1415.603630983325, 1429.8784603308718, 1488.1815001749042, 1636.63341110173, 1674.1417027099924, 8013.8797918031205, 8134.877976830352, 8210.261076503113, 8226.765985102238, 8228.547429891361, 7313.232110628387, 7580.88628670569, 7714.537127772338, 7753.263439973208, 8089.23152300532, 2247.43814046488, 2292.16336037346, 2292.266474728088, 2293.117149897293, 2295.024614538814, 2307.7230732312064, 2317.3048085574346, 2380.3929997850523, 2380.666706661069, 2383.7377888432256, 2073.2639912830955, 2332.6384410416413, 2383.2254517281867, 2390.1634427950166, 2390.306811024801, 2312.861228326306, 2320.454693147109, 2340.7659234076627, 2357.210334537932, 2359.634256690216, 2317.3974766560646, 2334.9299521014395, 2336.1823361823226, 2340.4382948092507, 2342.906283748648, 8306.501609903366, 8358.498490090615, 8370.958145209295, 8384.161583841567, 8612.18184272493, 4935.7532123393685, 5058.46886076964, 5059.139946209153, 5076.568491678212, 5086.084504789136, 3180.936381272362, 3195.0734287056725, 3236.91907702307, 3414.7438942079193, 3444.2422667013216, 1051.5057922776282, 1064.1433645915035, 1064.6646306413454, 1095.9643137235316, 1100.070440477795, 11517.13621478384, 11523.0, 11528.193026488148, 11542.249753765978, 11624.593139240085, 4490.39379683745, 4624.745638989821, 4663.696859704176, 4672.873842401699, 4672.929906051412, 9958.551865166084, 9987.650432234983, 9990.650327238656, 9992.0, 9992.250581206294, 5211.843644690665, 5236.214567814858, 5243.030039442715, 5251.501107394792, 5267.525922666979, 4620.052889157714, 4638.605718513964, 4639.768011599406, 4647.6281897448125, 4651.511591282867, 3973.2252210819192, 3995.34076877312, 4002.4396584478195, 4014.157027024299, 4049.4848244207496, 1171.3206340322592, 1239.7706424311532, 1252.5929073051113, 1285.5307812648502, 1298.3702904091508, 1127.689885281554, 1133.5749094089717, 1139.663799179244, 1367.7196174784146, 1439.3019385597977, 7539.359154471931, 7586.962065189638, 7683.193264707125, 7687.730929417556, 7701.0, 1193.0, 1209.4376115106343, 1210.6065528703207, 1214.2107630040368, 1234.8888600026041, 5989.161517387569, 6128.846778830565, 6182.752689892354, 6186.907196392058, 6206.162168107247, 9690.321677482509, 9818.852717209247, 9823.852642210373, 9933.708617879629, 9946.651867184613, 9613.279004074582, 9816.067473589997, 9879.80240395188, 9896.851547226797, 9919.0, 7923.247291507298, 7925.8811117833275, 7983.560904150328, 7994.160613135653, 8064.677412903536, 7516.361109305771, 7548.942678215331, 7610.6194690266375, 7634.083909930844, 7664.501807382502, 8608.741737747878, 8769.473831570127, 8847.73456796297, 8995.460272383678, 9041.68354107603, 9028.18746312835, 9054.094590541157, 9244.676436324697, 9271.490068046322, 9343.0, 7289.927100728924, 7337.376323012603, 7377.151627562899, 7380.667869945973, 7420.295071968154, 7861.095973963067, 7876.56678882667, 7977.0427548692205, 8057.315128213933, 8070.636821342936, 6413.422791948747, 7415.258474152542, 7470.4770666052855, 7473.215312392121, 7531.209223031503, 6828.624425656637, 6932.445404367538, 7026.718931242693, 7033.613151276729, 7050.471214658818, 7384.335409813142, 7558.0, 7566.886496702444, 7577.696892124253, 7586.9620651898595, 6838.658067096526, 6913.10129683138, 6913.723451061901, 6916.066331045446, 6916.3429474199875, 6747.2915343890145, 6749.662516874235, 6757.729690812313, 6791.694373753094, 6819.318068193141], "unit": "score", "name": "mootools.html", "value": 4746.852153987566}, {"lowerIsBetter": false, "replicates": [337.21597286309327, 341.61738852485223, 344.19115079563045, 349.12369951421937, 349.39205781939415, 5941.494972927301, 5949.196858424111, 5979.339194058645, 5990.640561566309, 6000.279966404027, 5926.348101708809, 5927.318358388787, 5934.910976335358, 5937.67342796146, 5939.168516407706, 4394.714343567658, 4431.800568974404, 4531.6601254905845, 4559.74921379324, 4624.306354046887, 4535.501094879561, 4540.59134677879, 4545.272756358983, 4546.431696037996, 4549.7725113744345, 4493.932591011137, 4498.752568608726, 4499.392582001437, 4503.211937910853, 4516.751578663172, 4372.97813510932, 4420.469543654766, 4510.188166130095, 4519.751413672247, 4527.909441811145, 3953.802309884523, 3961.8811435656976, 3963.583823698499, 3966.3257246268204, 3976.363781794899, 5545.833624991256, 5547.472990065938, 5563.499285064364, 5565.499105080522, 5569.610127291091, 5268.394134674485, 5270.604704647167, 5278.5249327560705, 5279.52484276417, 5294.788208471657, 6254.499640028786, 6258.593191442542, 6259.6870156492, 6264.997600383962, 6270.843228919268, 4203.7687927164, 4350.064736081726, 4370.12597480502, 4392.748066800947, 4406.405135306757, 6516.413522782972, 6539.378759017934, 6543.541952063358, 6562.704678289536, 6581.440577550866, 4453.977730111329, 4458.08609235106, 4461.063176732858, 4467.508574056851, 4468.575485328888, 4509.7970591323465, 4514.503404625489, 4515.254982927846, 4516.503184649686, 4517.412736344254, 5226.947730522722, 5234.319538460052, 5242.0, 5246.685198888079, 5249.818790772122, 6130.049842274455, 6314.684265786692, 6323.9051414228825, 6324.3991820776955, 6326.588771729823, 1557.0891028748308, 1582.0349586752072, 1589.2927647196886, 1590.8091029076586, 1596.5529651697543, 968.6077138758814, 1002.308407199045, 1011.7066050845319, 1017.2370721958531, 1033.2973577966904, 6044.335123136451, 6054.878902422015, 6067.393260673985, 6094.634321940698, 6150.231221097363, 6456.451201647913, 6474.902876456857, 6476.190476190476, 6479.967600161969, 6499.675016249169, 6113.052476866004, 6120.112583675342, 6120.44915957566, 6128.479079278222, 6130.417610327012, 3463.3765922133753, 3501.9474707879403, 3503.8787587971606, 3511.438169892805, 3512.666296701809, 6625.0, 6804.0, 6961.26906674802, 6977.058097156921, 6981.616011119438, 6778.796636100925, 6779.15260592426, 6784.050232967388, 6801.013852991288, 6804.863902721918, 6927.134108236471, 6929.203141638675, 6929.514933954676, 6933.68798404073, 6956.130483689539, 6581.736730530916, 6587.0, 6601.0, 6612.272650008592, 6613.834654133685, 6395.840103997251, 6474.0612611172055, 6500.739970401131, 6514.4788416925585, 6523.11937888398, 6878.071460352789, 6893.931060689329, 6900.171979362509, 6926.411255043377, 6934.410575101173, 4372.497162826316, 4395.120975804915, 4396.9120617588105, 4401.449818772653, 4402.11957608486, 6581.045748366364, 6583.275839657538, 6586.110875032001, 6593.241777195492, 6599.769008084694, 6089.360617135137, 6393.968030159819, 6423.293437721753, 6423.807285781434, 6425.742970281136, 6399.872002560016, 6415.230172379344, 6423.132877061536, 6437.806865794034, 6438.195225596801, 6294.402031806971, 6297.055441683784, 6297.244330680348, 6301.149344838388, 6312.0, 6451.322611125952, 6454.257760357431, 6455.128557644658, 6462.063000864942, 6468.094466774562, 5996.910046349395, 6075.1191077294425, 6203.038529028008, 6317.6209427434505, 6320.0], "unit": "score", "name": "prototype.html", "value": 4768.823418774394}, {"lowerIsBetter": false, "replicates": [746.250018731175, 749.8275396658769, 771.7646117934031, 772.2624893226969, 802.9036515618127, 14136.151830890141, 14299.356528956196, 14314.42742290307, 14346.99571030027, 14351.497697580588, 13817.447302107928, 13817.585472435818, 13860.099093558913, 13878.167309961384, 13893.583192504217, 777.9338756205715, 924.7503174143011, 945.9763505912339, 948.2556193388192, 949.8147861167075, 946.5125460387906, 950.686273529737, 951.980960380792, 952.380952380951, 953.0421925964431, 829.9502029878226, 1001.2940876681922, 1001.5943542865151, 1005.4671024357066, 1009.6213919780082, 964.9758756031085, 992.3648864726581, 994.3636072913341, 995.0795514149455, 995.6564985080136, 728.5519405565592, 729.7008226627111, 731.5756861020595, 733.6588486353871, 734.9081364829397, 14572.927135364362, 14681.192534410604, 14746.852531474655, 14781.704365912728, 14797.40810367584, 13313.733725325535, 13632.591022269347, 13774.517891873737, 14098.718025639533, 14212.644683882985, 11414.60048898293, 11552.24910380831, 11564.190506664538, 11644.534218631245, 11903.22629029119, 3891.299566078105, 3933.8229779659982, 3940.6453419192126, 3944.4280579315837, 3949.98025009876, 51916.0, 51971.0, 52141.47858521442, 53030.0, 54077.1888421674, 10825.296355736851, 10948.178886583539, 10995.175361847734, 11243.100551955824, 11638.825417618742, 19757.308494202633, 19941.501462463264, 19979.400617981482, 19991.700124498144, 19999.800002000084, 8246.134155913664, 8402.495850248883, 8547.27348175412, 8607.053224145338, 8623.827523449496, 4491.393661855608, 4588.311753237042, 4613.446386433649, 4672.135654903854, 4876.634252431082, 3390.1016230698883, 3418.333424982154, 3428.194374322032, 3432.3135372925517, 3433.8798142065407, 615.8614311779903, 633.297040285283, 645.4868379638199, 646.1245013007401, 646.1922596754057, 724.2359310926918, 729.5804912175414, 752.9058867641545, 766.2414209932127, 773.8065483629093, 8545.74362769118, 8596.742097737078, 9047.68333108338, 9116.908830911738, 9160.8625870612, 702.2275496953413, 703.6798256793147, 714.8070021094276, 720.7153174496044, 741.1180694972965, 4241.936370954438, 4242.596953289432, 4255.957440425618, 4295.055087880662, 4478.081993191388, 52865.47134528682, 53176.73411632917, 53261.0, 53319.20021199685, 53391.0, 51939.0, 52652.47347526476, 52884.206736898974, 53278.73360633172, 53432.46567534353, 47898.5210147901, 48134.518654813706, 48151.75924120357, 48947.510524895006, 49964.00071998539, 8944.955275223581, 9045.366824322235, 9051.32115091384, 9069.77325566866, 9283.257339412965, 34233.0, 36105.0973725659, 36809.263814724094, 37148.44277335896, 37434.251314973, 45448.54551454443, 46118.53881461143, 46311.76844115893, 46477.3028404581, 47352.7632361836, 12465.626031218715, 12549.623511294676, 12636.2418254905, 12913.289769062792, 12998.610041698765, 12717.427715752998, 12907.483700651868, 13117.540886068942, 13146.408411621309, 13230.867691323348, 11938.76122477563, 11947.522099115939, 12178.939105304771, 12211.206271592318, 12705.936470317589, 12614.432350544064, 12658.43037063316, 12729.363531823557, 12866.485340586647, 12953.935230323788, 12389.318587477776, 12482.251064936132, 12578.496860125859, 12742.362881856056, 13079.084464087422, 10815.945920270347, 10849.643794525684, 10873.891261087289, 11132.109431245643, 11234.719132021764, 10253.923338049397, 10471.267011309135, 10521.368717876952, 10544.789104218025, 10755.677329680122], "unit": "score", "name": "yui.html", "value": 6877.099388921866}], "name": "dromaeo_css", "value": 7208.171797532247}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 114.0, 107.0, 112.0, 112.0, 111.0, 100.0, 110.0, 112.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.9}, {"lowerIsBetter": true, "replicates": [157.0, 127.0, 155.0, 170.0, 126.0, 158.0, 148.0, 127.0, 179.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 148.1}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 161.0, 161.0, 162.0, 160.0, 159.0, 164.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [77.0, 77.0, 76.0, 174.0, 76.0, 76.0, 76.0, 77.0, 171.0, 74.0], "unit": "score", "name": "audio-fft", "value": 95.4}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 152.0, 93.0, 92.0, 93.0, 148.0, 92.0, 94.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 108.6}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 119.0, 117.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.9}, {"lowerIsBetter": true, "replicates": [153.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 57.0, 54.0, 54.0, 57.0, 56.0, 56.0, 55.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 55.3}, {"lowerIsBetter": true, "replicates": [78.0, 78.0, 77.0, 77.0, 77.0, 78.0, 78.0, 77.0, 77.0, 77.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 77.4}, {"lowerIsBetter": true, "replicates": [80.0, 81.0, 81.0, 81.0, 80.0, 80.0, 79.0, 80.0, 79.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.1}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 114.0, 122.0, 115.0, 114.0, 111.0, 112.0, 119.0, 112.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.2}, {"lowerIsBetter": true, "replicates": [138.0, 138.0, 150.0, 147.0, 160.0, 138.0, 151.0, 148.0, 145.0, 147.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.2}, {"lowerIsBetter": true, "replicates": [67.0, 72.0, 69.0, 67.0, 68.0, 67.0, 65.0, 71.0, 68.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.9}], "name": "kraken", "value": 1524.0000000000002}]} 03:43:27 INFO - Return code: 0 03:43:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:43:27 INFO - # TBPL SUCCESS # 03:43:27 INFO - Running post-action listener: _resource_record_post_action 03:43:27 INFO - Running post-run listener: _resource_record_post_run 03:43:28 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 463921152; Read time: 20; Write time: 607912 03:43:28 INFO - install - Wall time: 13s; CPU: 15.0%; Read bytes: 0; Write bytes: 245977088; Read time: 0; Write time: 371408 03:43:28 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 214335488; Read time: 20; Write time: 233992 03:43:28 INFO - Running post-run listener: _upload_blobber_files 03:43:28 INFO - Blob upload gear active. 03:43:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:43:28 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 03:43:28 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:43:28 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:43:28 INFO - (blobuploader) - INFO - Open directory for files ... 03:43:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:43:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:43:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:43:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:43:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:43:29 INFO - (blobuploader) - INFO - Done attempting. 03:43:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:43:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:43:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:43:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:43:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:43:30 INFO - (blobuploader) - INFO - Done attempting. 03:43:30 INFO - (blobuploader) - INFO - Iteration through files over. 03:43:30 INFO - Return code: 0 03:43:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:43:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:43:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b7d544bdfb2e86a5273fec3d4f76fbee2b8defc1a7b10c76376c7ad05d82208d47ae64e9aeb9c72a56c952956b690f58028c0dee95cff6553e7ac9d17a64da27", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dd76d784e73b2c3841c5b7903c3a0b8a454283b599273812dccb35b7043c30b4f66d184f30450eb9ed0deb0ba4ae171e54d9b2301d79f8da7c27a5adcf9641c1"} 03:43:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:43:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:43:30 INFO - Contents: 03:43:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b7d544bdfb2e86a5273fec3d4f76fbee2b8defc1a7b10c76376c7ad05d82208d47ae64e9aeb9c72a56c952956b690f58028c0dee95cff6553e7ac9d17a64da27", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dd76d784e73b2c3841c5b7903c3a0b8a454283b599273812dccb35b7043c30b4f66d184f30450eb9ed0deb0ba4ae171e54d9b2301d79f8da7c27a5adcf9641c1"} 03:43:30 INFO - Running post-run listener: copy_logs_to_upload_dir 03:43:30 INFO - Copying logs to upload dir... 03:43:30 INFO - mkdir: /builds/slave/test/build/upload/logs 03:43:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1227.156550 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-05-12 03:43:29.943358) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-12 03:43:29.946922) ========= 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=c6927cf182745ad25b1d38b9000001fe-1463048581.421689-1784723497 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b7d544bdfb2e86a5273fec3d4f76fbee2b8defc1a7b10c76376c7ad05d82208d47ae64e9aeb9c72a56c952956b690f58028c0dee95cff6553e7ac9d17a64da27", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dd76d784e73b2c3841c5b7903c3a0b8a454283b599273812dccb35b7043c30b4f66d184f30450eb9ed0deb0ba4ae171e54d9b2301d79f8da7c27a5adcf9641c1"} build_url:https://queue.taskcluster.net/v1/task/OEGpvG6FQTiNV5Bu6m7RvQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011288 build_url: 'https://queue.taskcluster.net/v1/task/OEGpvG6FQTiNV5Bu6m7RvQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b7d544bdfb2e86a5273fec3d4f76fbee2b8defc1a7b10c76376c7ad05d82208d47ae64e9aeb9c72a56c952956b690f58028c0dee95cff6553e7ac9d17a64da27", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dd76d784e73b2c3841c5b7903c3a0b8a454283b599273812dccb35b7043c30b4f66d184f30450eb9ed0deb0ba4ae171e54d9b2301d79f8da7c27a5adcf9641c1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-12 03:43:29.971857) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 03:43:29.972168) ========= 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=c6927cf182745ad25b1d38b9000001fe-1463048581.421689-1784723497 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004467 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 03:43:30.054378) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-12 03:43:30.054729) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-12 03:43:30.055062) ========= ========= Total master_lag: 0.17 =========