builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-051 starttime: 1466592265.42 results: success (0) buildid: 20160622010102 builduid: 15a2bdba63f94b45ac0a712a9a170911 revision: 800dc20aca781026226a03c3f43ff132b5cfdc1d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 03:44:25.419728) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 03:44:25.420200) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 03:44:25.420492) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 03:44:25.435902) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 03:44:25.436256) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1466592023.86729-176544120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-22 03:44:25-- 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% 226M=0s 2016-06-22 03:44:25 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100820 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 03:44:25.556456) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 03:44:25.556753) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1466592023.86729-176544120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015408 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 03:44:25.608603) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 03:44:25.608948) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 800dc20aca781026226a03c3f43ff132b5cfdc1d --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 800dc20aca781026226a03c3f43ff132b5cfdc1d --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=5ac5dba3e01a12f1ff77ab15000001b1-1466592023.86729-176544120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-22 03:44:25,663 truncating revision to first 12 chars 2016-06-22 03:44:25,663 Setting DEBUG logging. 2016-06-22 03:44:25,663 attempt 1/10 2016-06-22 03:44:25,663 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/800dc20aca78?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-22 03:44:26,033 unpacking tar archive at: mozilla-beta-800dc20aca78/testing/mozharness/ program finished with exit code 0 elapsedTime=0.705294 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 03:44:26.327733) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 03:44:26.328017) ========= script_repo_revision: 800dc20aca781026226a03c3f43ff132b5cfdc1d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 03:44:26.328422) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 03:44:26.328706) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 03:44:26.337250) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-06-22 03:44:26.337532) ========= /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=5ac5dba3e01a12f1ff77ab15000001b1-1466592023.86729-176544120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:44:26 INFO - MultiFileLogger online at 20160622 03:44:26 in /builds/slave/test 03:44:26 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:44:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:44:26 INFO - {'append_to_log': False, 03:44:26 INFO - 'base_work_dir': '/builds/slave/test', 03:44:26 INFO - 'blob_upload_branch': 'Mozilla-Beta', 03:44:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:44:26 INFO - 'branch': 'Mozilla-Beta', 03:44:26 INFO - 'buildbot_json_path': 'buildprops.json', 03:44:26 INFO - 'config_files': ('talos/linux_config.py',), 03:44:26 INFO - 'default_actions': ('clobber', 03:44:26 INFO - 'read-buildbot-config', 03:44:26 INFO - 'download-and-extract', 03:44:26 INFO - 'populate-webroot', 03:44:26 INFO - 'create-virtualenv', 03:44:26 INFO - 'install', 03:44:26 INFO - 'run-tests'), 03:44:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:44:26 INFO - 'download_minidump_stackwalk': True, 03:44:26 INFO - 'download_symbols': 'ondemand', 03:44:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:44:26 INFO - 'tooltool.py': '/tools/tooltool.py', 03:44:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:44:26 INFO - '/tools/misc-python/virtualenv.py')}, 03:44:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:44:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:44:26 INFO - 'installer_path': 'installer.exe', 03:44:26 INFO - 'log_level': 'info', 03:44:26 INFO - 'log_name': 'talos', 03:44:26 INFO - 'log_to_console': True, 03:44:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:44:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:44:26 INFO - 'opt_config_files': (), 03:44:26 INFO - 'pip_index': False, 03:44:26 INFO - 'sps_profile': False, 03:44:26 INFO - 'sps_profile_interval': 0, 03:44:26 INFO - 'suite': 'dromaeojs', 03:44:26 INFO - 'system_bits': '32', 03:44:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:44:26 INFO - 'title': 'talos-linux64-ix-051', 03:44:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:44:26 INFO - 'use_talos_json': True, 03:44:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:44:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:44:26 INFO - 'work_dir': 'build'} 03:44:26 INFO - ##### 03:44:26 INFO - ##### Running clobber step. 03:44:26 INFO - ##### 03:44:26 INFO - Running pre-action listener: _resource_record_pre_action 03:44:26 INFO - Running main action method: clobber 03:44:26 INFO - rmtree: /builds/slave/test/build 03:44:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:44:27 INFO - Running post-action listener: _resource_record_post_action 03:44:27 INFO - ##### 03:44:27 INFO - ##### Running read-buildbot-config step. 03:44:27 INFO - ##### 03:44:27 INFO - Running pre-action listener: _resource_record_pre_action 03:44:27 INFO - Running main action method: read_buildbot_config 03:44:27 INFO - Using buildbot properties: 03:44:27 INFO - { 03:44:27 INFO - "project": "", 03:44:27 INFO - "product": "firefox", 03:44:27 INFO - "script_repo_revision": "production", 03:44:27 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 03:44:27 INFO - "repository": "", 03:44:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 03:44:27 INFO - "buildid": "20160622010102", 03:44:27 INFO - "pgo_build": "True", 03:44:27 INFO - "basedir": "/builds/slave/test", 03:44:27 INFO - "buildnumber": 57, 03:44:27 INFO - "slavename": "talos-linux64-ix-051", 03:44:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:44:27 INFO - "platform": "ubuntu64_hw", 03:44:27 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 03:44:27 INFO - "branch": "mozilla-beta", 03:44:27 INFO - "repo_path": "releases/mozilla-beta", 03:44:27 INFO - "revision": "800dc20aca781026226a03c3f43ff132b5cfdc1d", 03:44:27 INFO - "stage_platform": "linux64-pgo", 03:44:27 INFO - "builduid": "15a2bdba63f94b45ac0a712a9a170911", 03:44:27 INFO - "slavebuilddir": "test" 03:44:27 INFO - } 03:44:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 03:44:27 INFO - Running post-action listener: _resource_record_post_action 03:44:27 INFO - ##### 03:44:27 INFO - ##### Running download-and-extract step. 03:44:27 INFO - ##### 03:44:27 INFO - Running pre-action listener: _resource_record_pre_action 03:44:27 INFO - Running main action method: download_and_extract 03:44:27 INFO - mkdir: /builds/slave/test/build/tests 03:44:27 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:44:27 INFO - https://queue.taskcluster.net/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:44:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 03:44:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 03:44:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 03:44:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:44:29 INFO - Downloaded 1327 bytes. 03:44:29 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 03:44:29 INFO - Using the following test package requirements: 03:44:29 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 03:44:29 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:44:29 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 03:44:29 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:44:29 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 03:44:29 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:44:29 INFO - u'jsshell-linux-x86_64.zip'], 03:44:29 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:44:29 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 03:44:29 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 03:44:29 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:44:29 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 03:44:29 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:44:29 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 03:44:29 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:44:29 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 03:44:29 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 03:44:29 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 03:44:29 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:44:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:29 INFO - https://queue.taskcluster.net/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:44:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 03:44:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 03:44:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 03:44:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:44:31 INFO - Downloaded 24185922 bytes. 03:44:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:44:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:44:32 INFO - Return code: 0 03:44:32 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:32 INFO - https://queue.taskcluster.net/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:44:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 03:44:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 03:44:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 03:44:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:44:37 INFO - Downloaded 24185922 bytes. 03:44:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:44:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:44:38 INFO - Return code: 0 03:44:38 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:44:38 INFO - https://queue.taskcluster.net/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:44:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 03:44:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 03:44:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 03:44:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:44:39 INFO - Downloaded 10840145 bytes. 03:44:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:44:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:44:39 INFO - Return code: 0 03:44:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:39 INFO - https://queue.taskcluster.net/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:44:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 03:44:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 03:44:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 03:44:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:44:41 INFO - Downloaded 55991552 bytes. 03:44:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 03:44:41 INFO - mkdir: /builds/slave/test/properties 03:44:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:44:41 INFO - Writing to file /builds/slave/test/properties/build_url 03:44:41 INFO - Contents: 03:44:41 INFO - build_url:https://queue.taskcluster.net/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 03:44:41 INFO - Running post-action listener: _resource_record_post_action 03:44:41 INFO - Running post-action listener: set_extra_try_arguments 03:44:41 INFO - ##### 03:44:41 INFO - ##### Running populate-webroot step. 03:44:41 INFO - ##### 03:44:41 INFO - Running pre-action listener: _resource_record_pre_action 03:44:41 INFO - Running main action method: populate_webroot 03:44:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:44:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:44:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:44:42 INFO - '--tppagecycles', 03:44:42 INFO - '7'], 03:44:42 INFO - 'tests': ['tsvgm']}}, 03:44:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:44:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:44:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:44:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:44:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:44:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:44:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:42 INFO - 'talos_options': ['--disable-e10s'], 03:44:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:44:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:44:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:42 INFO - 'talos_options': ['--disable-e10s'], 03:44:42 INFO - 'tests': ['damp', 'tps']}, 03:44:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:42 INFO - 'tests': ['damp', 'tps']}, 03:44:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:44:42 INFO - 'tests': ['dromaeo_dom']}, 03:44:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:44:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:44:42 INFO - 'tests': ['a11yr', 03:44:42 INFO - 'ts_paint', 03:44:42 INFO - 'tpaint', 03:44:42 INFO - 'sessionrestore', 03:44:42 INFO - 'sessionrestore_no_auto_restore', 03:44:42 INFO - 'tabpaint']}, 03:44:42 INFO - 'other-e10s': {'tests': ['a11yr', 03:44:42 INFO - 'ts_paint', 03:44:42 INFO - 'tpaint', 03:44:42 INFO - 'sessionrestore', 03:44:42 INFO - 'sessionrestore_no_auto_restore', 03:44:42 INFO - 'tabpaint']}, 03:44:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:44:42 INFO - 'ts_paint', 03:44:42 INFO - 'tpaint', 03:44:42 INFO - 'sessionrestore', 03:44:42 INFO - 'sessionrestore_no_auto_restore', 03:44:42 INFO - 'tabpaint']}, 03:44:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:44:42 INFO - 'ts_paint', 03:44:42 INFO - 'tpaint', 03:44:42 INFO - 'sessionrestore', 03:44:42 INFO - 'sessionrestore_no_auto_restore', 03:44:42 INFO - 'tabpaint']}, 03:44:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:44:42 INFO - 'tests': ['a11yr', 03:44:42 INFO - 'ts_paint', 03:44:42 INFO - 'tpaint', 03:44:42 INFO - 'sessionrestore', 03:44:42 INFO - 'sessionrestore_no_auto_restore', 03:44:42 INFO - 'tabpaint']}, 03:44:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:44:42 INFO - 'tests': ['a11yr', 03:44:42 INFO - 'ts_paint', 03:44:42 INFO - 'tpaint', 03:44:42 INFO - 'sessionrestore', 03:44:42 INFO - 'sessionrestore_no_auto_restore', 03:44:42 INFO - 'tabpaint']}, 03:44:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:44:42 INFO - 'tests': ['tsvgx', 03:44:42 INFO - 'tsvgr_opacity', 03:44:42 INFO - 'tart', 03:44:42 INFO - 'tscrollx', 03:44:42 INFO - 'cart']}, 03:44:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:44:42 INFO - 'tsvgr_opacity', 03:44:42 INFO - 'tart', 03:44:42 INFO - 'tscrollx', 03:44:42 INFO - 'cart']}, 03:44:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:42 INFO - 'talos_options': ['--disable-e10s'], 03:44:42 INFO - 'tests': ['tp5o']}, 03:44:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:42 INFO - 'tests': ['tp5o']}, 03:44:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:42 INFO - 'talos_options': ['--disable-e10s', 03:44:42 INFO - '--xperf_path', 03:44:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:44:42 INFO - 'tests': ['tp5n']}, 03:44:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:42 INFO - 'talos_options': ['--xperf_path', 03:44:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:44:42 INFO - 'tests': ['tp5n']}}, 03:44:42 INFO - 'talos.zip': {'path': '', 03:44:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:44:42 INFO - Running post-action listener: _resource_record_post_action 03:44:42 INFO - ##### 03:44:42 INFO - ##### Running create-virtualenv step. 03:44:42 INFO - ##### 03:44:42 INFO - Running pre-action listener: _resource_record_pre_action 03:44:42 INFO - Running main action method: create_virtualenv 03:44:42 INFO - Creating virtualenv /builds/slave/test/build/venv 03:44:42 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:44:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:44:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:44:42 INFO - Using real prefix '/usr' 03:44:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:44:42 INFO - Installing distribute.............................................................................................................................................................................................done. 03:44:44 INFO - Installing pip.................done. 03:44:44 INFO - Return code: 0 03:44:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:44:44 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:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:44 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:44:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:44 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 0x7f4e1a958f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1e640>, '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 0x1d1f540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1f9d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466592023.86729-176544120', '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:44:44 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:44:44 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:44:44 INFO - Using env: {'DISPLAY': ':0', 03:44:44 INFO - 'HOME': '/home/cltbld', 03:44:44 INFO - 'LANG': 'en_US.UTF-8', 03:44:44 INFO - 'LANGUAGE': 'en_US:en', 03:44:44 INFO - 'LOGNAME': 'cltbld', 03:44:44 INFO - 'MAIL': '/var/mail/cltbld', 03:44:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:44 INFO - 'MOZ_NO_REMOTE': '1', 03:44:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:44 INFO - 'NO_EM_RESTART': '1', 03:44:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:44 INFO - 'PWD': '/builds/slave/test', 03:44:44 INFO - 'SHELL': '/bin/bash', 03:44:44 INFO - 'SHLVL': '1', 03:44:44 INFO - 'TERM': 'linux', 03:44:44 INFO - 'TMOUT': '86400', 03:44:44 INFO - 'USER': 'cltbld', 03:44:44 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466592023.86729-176544120', 03:44:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:44 INFO - '_': '/tools/buildbot/bin/python'} 03:44:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:44 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:44:44 INFO - Cleaning up... 03:44:44 INFO - Return code: 0 03:44:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:44:44 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:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:44 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:44:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:44 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 0x7f4e1a958f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1e640>, '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 0x1d1f540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1f9d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466592023.86729-176544120', '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:44:44 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:44:44 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:44:44 INFO - Using env: {'DISPLAY': ':0', 03:44:44 INFO - 'HOME': '/home/cltbld', 03:44:44 INFO - 'LANG': 'en_US.UTF-8', 03:44:44 INFO - 'LANGUAGE': 'en_US:en', 03:44:44 INFO - 'LOGNAME': 'cltbld', 03:44:44 INFO - 'MAIL': '/var/mail/cltbld', 03:44:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:44 INFO - 'MOZ_NO_REMOTE': '1', 03:44:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:44 INFO - 'NO_EM_RESTART': '1', 03:44:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:44 INFO - 'PWD': '/builds/slave/test', 03:44:44 INFO - 'SHELL': '/bin/bash', 03:44:44 INFO - 'SHLVL': '1', 03:44:44 INFO - 'TERM': 'linux', 03:44:44 INFO - 'TMOUT': '86400', 03:44:44 INFO - 'USER': 'cltbld', 03:44:44 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466592023.86729-176544120', 03:44:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:44 INFO - '_': '/tools/buildbot/bin/python'} 03:44:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:44 INFO - Downloading/unpacking psutil>=0.7.1 03:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:44:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:44:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:44:47 INFO - Installing collected packages: psutil 03:44:47 INFO - Running setup.py install for psutil 03:44:47 INFO - building 'psutil._psutil_linux' extension 03:44:47 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:44:47 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:44:47 INFO - building 'psutil._psutil_posix' extension 03:44:47 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:44:47 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:44:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:44:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:44:47 INFO - Successfully installed psutil 03:44:47 INFO - Cleaning up... 03:44:47 INFO - Return code: 0 03:44:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:44:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:47 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 0x7f4e1a958f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1e640>, '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 0x1d1f540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1f9d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466592023.86729-176544120', '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:44:47 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:44:47 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:44:47 INFO - Using env: {'DISPLAY': ':0', 03:44:47 INFO - 'HOME': '/home/cltbld', 03:44:47 INFO - 'LANG': 'en_US.UTF-8', 03:44:47 INFO - 'LANGUAGE': 'en_US:en', 03:44:47 INFO - 'LOGNAME': 'cltbld', 03:44:47 INFO - 'MAIL': '/var/mail/cltbld', 03:44:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:47 INFO - 'MOZ_NO_REMOTE': '1', 03:44:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:47 INFO - 'NO_EM_RESTART': '1', 03:44:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:47 INFO - 'PWD': '/builds/slave/test', 03:44:47 INFO - 'SHELL': '/bin/bash', 03:44:47 INFO - 'SHLVL': '1', 03:44:47 INFO - 'TERM': 'linux', 03:44:47 INFO - 'TMOUT': '86400', 03:44:47 INFO - 'USER': 'cltbld', 03:44:47 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466592023.86729-176544120', 03:44:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:47 INFO - '_': '/tools/buildbot/bin/python'} 03:44:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:44:47 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:44:47 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:44:47 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:44:47 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:44:47 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:44:47 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:44:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:44:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:44:49 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:44:49 INFO - Installing collected packages: mozsystemmonitor 03:44:49 INFO - Running setup.py install for mozsystemmonitor 03:44:49 INFO - Successfully installed mozsystemmonitor 03:44:49 INFO - Cleaning up... 03:44:49 INFO - Return code: 0 03:44:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:44:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:49 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 0x7f4e1a958f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1e640>, '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 0x1d1f540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1f9d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466592023.86729-176544120', '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:44:49 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:44:49 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:44:49 INFO - Using env: {'DISPLAY': ':0', 03:44:49 INFO - 'HOME': '/home/cltbld', 03:44:49 INFO - 'LANG': 'en_US.UTF-8', 03:44:49 INFO - 'LANGUAGE': 'en_US:en', 03:44:49 INFO - 'LOGNAME': 'cltbld', 03:44:49 INFO - 'MAIL': '/var/mail/cltbld', 03:44:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:49 INFO - 'MOZ_NO_REMOTE': '1', 03:44:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:49 INFO - 'NO_EM_RESTART': '1', 03:44:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:49 INFO - 'PWD': '/builds/slave/test', 03:44:49 INFO - 'SHELL': '/bin/bash', 03:44:49 INFO - 'SHLVL': '1', 03:44:49 INFO - 'TERM': 'linux', 03:44:49 INFO - 'TMOUT': '86400', 03:44:49 INFO - 'USER': 'cltbld', 03:44:49 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466592023.86729-176544120', 03:44:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:49 INFO - '_': '/tools/buildbot/bin/python'} 03:44:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:50 INFO - Downloading/unpacking blobuploader==1.2.4 03:44:50 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:44:50 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:44:50 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:44:50 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:44:50 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:44:50 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:44:51 INFO - Downloading blobuploader-1.2.4.tar.gz 03:44:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:44:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:44:52 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:44:52 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:44:52 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:44:52 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:44:52 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:44:52 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:44:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:44:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:44:52 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:44:52 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:44:52 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:44:52 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:44:52 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:44:52 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:44:52 INFO - Downloading docopt-0.6.1.tar.gz 03:44:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:44:52 INFO - Installing collected packages: blobuploader, requests, docopt 03:44:52 INFO - Running setup.py install for blobuploader 03:44:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:44:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:44:52 INFO - Running setup.py install for requests 03:44:53 INFO - Running setup.py install for docopt 03:44:53 INFO - Successfully installed blobuploader requests docopt 03:44:53 INFO - Cleaning up... 03:44:53 INFO - Return code: 0 03:44:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:44: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:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44: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:44:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:53 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 0x7f4e1a958f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1e640>, '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 0x1d1f540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1f9d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466592023.86729-176544120', '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:44:53 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:44:53 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:44:53 INFO - Using env: {'DISPLAY': ':0', 03:44:53 INFO - 'HOME': '/home/cltbld', 03:44:53 INFO - 'LANG': 'en_US.UTF-8', 03:44:53 INFO - 'LANGUAGE': 'en_US:en', 03:44:53 INFO - 'LOGNAME': 'cltbld', 03:44:53 INFO - 'MAIL': '/var/mail/cltbld', 03:44:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:53 INFO - 'MOZ_NO_REMOTE': '1', 03:44:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:53 INFO - 'NO_EM_RESTART': '1', 03:44:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:53 INFO - 'PWD': '/builds/slave/test', 03:44:53 INFO - 'SHELL': '/bin/bash', 03:44:53 INFO - 'SHLVL': '1', 03:44:53 INFO - 'TERM': 'linux', 03:44:53 INFO - 'TMOUT': '86400', 03:44:53 INFO - 'USER': 'cltbld', 03:44:53 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466592023.86729-176544120', 03:44:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:53 INFO - '_': '/tools/buildbot/bin/python'} 03:44:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:44:53 INFO - Running setup.py (path:/tmp/pip-EXOsLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:44:53 INFO - Running setup.py (path:/tmp/pip-RFKPct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:44:53 INFO - Running setup.py (path:/tmp/pip-8vPX1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:44:53 INFO - Running setup.py (path:/tmp/pip-yYqL96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:44:53 INFO - Running setup.py (path:/tmp/pip-5NCyTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:44:53 INFO - Running setup.py (path:/tmp/pip-Nwy3I8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:44:54 INFO - Running setup.py (path:/tmp/pip-KarGgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:44:54 INFO - Running setup.py (path:/tmp/pip-PxrVV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:44:54 INFO - Running setup.py (path:/tmp/pip-2caPnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:44:54 INFO - Running setup.py (path:/tmp/pip-Lc_R0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:44:54 INFO - Running setup.py (path:/tmp/pip-ul_5Ez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:44:54 INFO - Running setup.py (path:/tmp/pip-Kl24Lz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:44:54 INFO - Running setup.py (path:/tmp/pip-jbQ80a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:44:54 INFO - Running setup.py (path:/tmp/pip-Dklari-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:44:54 INFO - Running setup.py (path:/tmp/pip-aS1qG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:44:54 INFO - Running setup.py (path:/tmp/pip-c7vSbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:44:54 INFO - Running setup.py (path:/tmp/pip-Dya8qc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:44:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:44:54 INFO - Running setup.py install for manifestparser 03:44:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:44:54 INFO - Running setup.py install for mozcrash 03:44:55 INFO - Running setup.py install for mozdebug 03:44:55 INFO - Running setup.py install for mozdevice 03:44:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:44:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:44:55 INFO - Running setup.py install for mozfile 03:44:55 INFO - Running setup.py install for mozhttpd 03:44:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:44:55 INFO - Running setup.py install for mozinfo 03:44:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:44:55 INFO - Running setup.py install for mozInstall 03:44:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:44:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:44:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:44:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:44:55 INFO - Running setup.py install for mozleak 03:44:55 INFO - Running setup.py install for mozlog 03:44:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:44:55 INFO - Running setup.py install for moznetwork 03:44:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:44:55 INFO - Running setup.py install for mozprocess 03:44:56 INFO - Running setup.py install for mozprofile 03:44:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:44:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:44:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:44:56 INFO - Running setup.py install for mozrunner 03:44:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:44:56 INFO - Running setup.py install for mozscreenshot 03:44:56 INFO - Running setup.py install for moztest 03:44:56 INFO - Running setup.py install for mozversion 03:44:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:44:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:44:56 INFO - Cleaning up... 03:44:56 INFO - Return code: 0 03:44:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:44:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:56 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 0x7f4e1a958f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1e640>, '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 0x1d1f540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1f9d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466592023.86729-176544120', '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:44:56 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:44:56 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:44:56 INFO - Using env: {'DISPLAY': ':0', 03:44:56 INFO - 'HOME': '/home/cltbld', 03:44:56 INFO - 'LANG': 'en_US.UTF-8', 03:44:56 INFO - 'LANGUAGE': 'en_US:en', 03:44:56 INFO - 'LOGNAME': 'cltbld', 03:44:56 INFO - 'MAIL': '/var/mail/cltbld', 03:44:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:56 INFO - 'MOZ_NO_REMOTE': '1', 03:44:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:56 INFO - 'NO_EM_RESTART': '1', 03:44:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:56 INFO - 'PWD': '/builds/slave/test', 03:44:56 INFO - 'SHELL': '/bin/bash', 03:44:56 INFO - 'SHLVL': '1', 03:44:56 INFO - 'TERM': 'linux', 03:44:56 INFO - 'TMOUT': '86400', 03:44:56 INFO - 'USER': 'cltbld', 03:44:56 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466592023.86729-176544120', 03:44:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:56 INFO - '_': '/tools/buildbot/bin/python'} 03:44:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:44:56 INFO - Running setup.py (path:/tmp/pip-XViHEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:44:56 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:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:44:56 INFO - Running setup.py (path:/tmp/pip-4GN6Ey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:44:56 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:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:44:56 INFO - Running setup.py (path:/tmp/pip-SUAGbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:44:57 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:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:44:57 INFO - Running setup.py (path:/tmp/pip-M9JMZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:44:57 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:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:44:57 INFO - Running setup.py (path:/tmp/pip-xE9Zw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:44:57 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:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:44:57 INFO - Running setup.py (path:/tmp/pip-Dvy72d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:44:57 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:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:44:57 INFO - Running setup.py (path:/tmp/pip-f2itpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:44:57 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:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:44:57 INFO - Running setup.py (path:/tmp/pip-FRzhcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:44:57 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:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:44:57 INFO - Running setup.py (path:/tmp/pip-wgyVv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:44:57 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:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:44:57 INFO - Running setup.py (path:/tmp/pip-s5OOAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:44:57 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:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:44:57 INFO - Running setup.py (path:/tmp/pip-qXQhje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:44:57 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:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:44:57 INFO - Running setup.py (path:/tmp/pip-qdMOqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:44:57 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:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:44:57 INFO - Running setup.py (path:/tmp/pip-YkfQbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:44:57 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:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:44:57 INFO - Running setup.py (path:/tmp/pip-aJDk5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:44:57 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:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:44:57 INFO - Running setup.py (path:/tmp/pip-n5P6no-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:44:57 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:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:44:57 INFO - Running setup.py (path:/tmp/pip-wDe3VV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:44:57 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:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:44:57 INFO - Running setup.py (path:/tmp/pip-s3SLpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:44:58 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:44:58 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:44:58 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:44:58 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:44:58 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:44:58 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:44:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:44:58 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:44:58 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:44:58 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:44:58 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:44:58 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:44:58 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:44:59 INFO - Downloading blessings-1.6.tar.gz 03:44:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:45:00 INFO - Installing collected packages: blessings 03:45:00 INFO - Running setup.py install for blessings 03:45:00 INFO - Successfully installed blessings 03:45:00 INFO - Cleaning up... 03:45:00 INFO - Return code: 0 03:45:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:45:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:45:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:45:00 INFO - Reading from file tmpfile_stdout 03:45:00 INFO - Current package versions: 03:45:00 INFO - argparse == 1.2.1 03:45:00 INFO - blessings == 1.6 03:45:00 INFO - blobuploader == 1.2.4 03:45:00 INFO - docopt == 0.6.1 03:45:00 INFO - manifestparser == 1.1 03:45:00 INFO - mozInstall == 1.12 03:45:00 INFO - mozcrash == 0.17 03:45:00 INFO - mozdebug == 0.1 03:45:00 INFO - mozdevice == 0.48 03:45:00 INFO - mozfile == 1.2 03:45:00 INFO - mozhttpd == 0.7 03:45:00 INFO - mozinfo == 0.9 03:45:00 INFO - mozleak == 0.1 03:45:00 INFO - mozlog == 3.1 03:45:00 INFO - moznetwork == 0.27 03:45:00 INFO - mozprocess == 0.22 03:45:00 INFO - mozprofile == 0.28 03:45:00 INFO - mozrunner == 6.11 03:45:00 INFO - mozscreenshot == 0.1 03:45:00 INFO - mozsystemmonitor == 0.0 03:45:00 INFO - moztest == 0.7 03:45:00 INFO - mozversion == 1.4 03:45:00 INFO - psutil == 3.1.1 03:45:00 INFO - requests == 1.2.3 03:45:00 INFO - wsgiref == 0.1.2 03:45:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:45:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:00 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 0x7f4e1a958f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1e640>, '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 0x1d1f540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1f9d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466592023.86729-176544120', '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:45:00 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:45:00 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:45:00 INFO - Using env: {'DISPLAY': ':0', 03:45:00 INFO - 'HOME': '/home/cltbld', 03:45:00 INFO - 'LANG': 'en_US.UTF-8', 03:45:00 INFO - 'LANGUAGE': 'en_US:en', 03:45:00 INFO - 'LOGNAME': 'cltbld', 03:45:00 INFO - 'MAIL': '/var/mail/cltbld', 03:45:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:00 INFO - 'MOZ_NO_REMOTE': '1', 03:45:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:00 INFO - 'NO_EM_RESTART': '1', 03:45:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:00 INFO - 'PWD': '/builds/slave/test', 03:45:00 INFO - 'SHELL': '/bin/bash', 03:45:00 INFO - 'SHLVL': '1', 03:45:00 INFO - 'TERM': 'linux', 03:45:00 INFO - 'TMOUT': '86400', 03:45:00 INFO - 'USER': 'cltbld', 03:45:00 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466592023.86729-176544120', 03:45:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:00 INFO - '_': '/tools/buildbot/bin/python'} 03:45:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:00 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:45:00 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:45:00 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:45:00 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:45:00 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:45:00 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:45:00 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:45:00 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:45:00 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:45:00 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:45:00 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:45:00 INFO - Cleaning up... 03:45:00 INFO - Return code: 0 03:45:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:45:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4e1a958f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1e640>, '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 0x1d1f540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1f9d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466592023.86729-176544120', '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:45:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:45:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:45:00 INFO - Using env: {'DISPLAY': ':0', 03:45:00 INFO - 'HOME': '/home/cltbld', 03:45:00 INFO - 'LANG': 'en_US.UTF-8', 03:45:00 INFO - 'LANGUAGE': 'en_US:en', 03:45:00 INFO - 'LOGNAME': 'cltbld', 03:45:00 INFO - 'MAIL': '/var/mail/cltbld', 03:45:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:00 INFO - 'MOZ_NO_REMOTE': '1', 03:45:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:00 INFO - 'NO_EM_RESTART': '1', 03:45:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:00 INFO - 'PWD': '/builds/slave/test', 03:45:00 INFO - 'SHELL': '/bin/bash', 03:45:00 INFO - 'SHLVL': '1', 03:45:00 INFO - 'TERM': 'linux', 03:45:00 INFO - 'TMOUT': '86400', 03:45:00 INFO - 'USER': 'cltbld', 03:45:00 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466592023.86729-176544120', 03:45:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:00 INFO - '_': '/tools/buildbot/bin/python'} 03:45:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:00 INFO - Downloading/unpacking jsonschema 03:45:00 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:45:00 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:45:00 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:45:00 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:45:00 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:45:00 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:45:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:45:02 INFO - Downloading/unpacking functools32 (from jsonschema) 03:45:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:02 INFO - Downloading functools32-3.2.3-2.tar.gz 03:45:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:45:02 INFO - warning: no files found matching '*.txt' 03:45:02 INFO - no previously-included directories found matching 'build' 03:45:02 INFO - no previously-included directories found matching 'dist' 03:45:02 INFO - no previously-included directories found matching '.git*' 03:45:03 INFO - Installing collected packages: jsonschema, functools32 03:45:03 INFO - Running setup.py install for functools32 03:45:03 INFO - warning: no files found matching '*.txt' 03:45:03 INFO - no previously-included directories found matching 'build' 03:45:03 INFO - no previously-included directories found matching 'dist' 03:45:03 INFO - no previously-included directories found matching '.git*' 03:45:03 INFO - Successfully installed jsonschema functools32 03:45:03 INFO - Cleaning up... 03:45:03 INFO - Return code: 0 03:45:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:45:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4e1a958f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1e640>, '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 0x1d1f540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1f9d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466592023.86729-176544120', '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:45:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:45:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:45:03 INFO - Using env: {'DISPLAY': ':0', 03:45:03 INFO - 'HOME': '/home/cltbld', 03:45:03 INFO - 'LANG': 'en_US.UTF-8', 03:45:03 INFO - 'LANGUAGE': 'en_US:en', 03:45:03 INFO - 'LOGNAME': 'cltbld', 03:45:03 INFO - 'MAIL': '/var/mail/cltbld', 03:45:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:03 INFO - 'MOZ_NO_REMOTE': '1', 03:45:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:03 INFO - 'NO_EM_RESTART': '1', 03:45:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:03 INFO - 'PWD': '/builds/slave/test', 03:45:03 INFO - 'SHELL': '/bin/bash', 03:45:03 INFO - 'SHLVL': '1', 03:45:03 INFO - 'TERM': 'linux', 03:45:03 INFO - 'TMOUT': '86400', 03:45:03 INFO - 'USER': 'cltbld', 03:45:03 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466592023.86729-176544120', 03:45:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:03 INFO - '_': '/tools/buildbot/bin/python'} 03:45:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:03 INFO - Downloading/unpacking flake8 03:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:45:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:45:05 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:45:05 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:45:05 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:45:05 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:45:05 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:45:05 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:45:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:45:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:45:05 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:45:05 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:45:05 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:45:05 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:45:05 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:45:05 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:45:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:45:05 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:45:05 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:45:05 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:45:05 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:45:05 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:45:05 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:45:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:45:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:45:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:45:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:45:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:45:06 INFO - no previously-included directories found matching 'docs/_build' 03:45:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:45:06 INFO - Running setup.py install for pep8 03:45:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:45:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:45:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:45:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:45:06 INFO - no previously-included directories found matching 'docs/_build' 03:45:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:45:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:45:06 INFO - Cleaning up... 03:45:06 INFO - Return code: 0 03:45:06 INFO - Running post-action listener: _resource_record_post_action 03:45:06 INFO - Running post-action listener: _start_resource_monitoring 03:45:06 INFO - Starting resource monitoring. 03:45:06 INFO - ##### 03:45:06 INFO - ##### Running install step. 03:45:06 INFO - ##### 03:45:06 INFO - Running pre-action listener: _resource_record_pre_action 03:45:06 INFO - Running main action method: install 03:45:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:45:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:45:06 INFO - Reading from file tmpfile_stdout 03:45:06 INFO - Detecting whether we're running mozinstall >=1.0... 03:45:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:45:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:45:06 INFO - Reading from file tmpfile_stdout 03:45:06 INFO - Output received: 03:45:06 INFO - Usage: mozinstall [options] installer 03:45:06 INFO - Options: 03:45:06 INFO - -h, --help show this help message and exit 03:45:06 INFO - -d DEST, --destination=DEST 03:45:06 INFO - Directory to install application into. [default: 03:45:06 INFO - "/builds/slave/test"] 03:45:06 INFO - --app=APP Application being installed. [default: firefox] 03:45:06 INFO - mkdir: /builds/slave/test/build/application 03:45:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:45:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:45:19 INFO - Reading from file tmpfile_stdout 03:45:19 INFO - Output received: 03:45:19 INFO - /builds/slave/test/build/application/firefox/firefox 03:45:19 INFO - Running post-action listener: _resource_record_post_action 03:45:19 INFO - ##### 03:45:19 INFO - ##### Running run-tests step. 03:45:19 INFO - ##### 03:45:19 INFO - Running pre-action listener: _resource_record_pre_action 03:45:19 INFO - Running main action method: run_tests 03:45:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:45:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:45:19 INFO - Python 2.7.3 03:45:19 INFO - Return code: 0 03:45:19 INFO - grabbing minidump binary from tooltool 03:45:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:19 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 0x1d1e640>, '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 0x1d1f540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1f9d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:45:19 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:45:19 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:45:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:45:19 INFO - Return code: 0 03:45:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:45:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:45:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:45:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:45:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:45:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:45:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:45:20 INFO - Return code: 0 03:45:20 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/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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:45:20 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/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --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:45:20 INFO - Using env: {'DISPLAY': ':0', 03:45:20 INFO - 'HOME': '/home/cltbld', 03:45:20 INFO - 'LANG': 'en_US.UTF-8', 03:45:20 INFO - 'LANGUAGE': 'en_US:en', 03:45:20 INFO - 'LOGNAME': 'cltbld', 03:45:20 INFO - 'MAIL': '/var/mail/cltbld', 03:45:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:45:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:45:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:20 INFO - 'MOZ_NO_REMOTE': '1', 03:45:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:45:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:20 INFO - 'NO_EM_RESTART': '1', 03:45:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:20 INFO - 'PWD': '/builds/slave/test', 03:45:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:45:20 INFO - 'SHELL': '/bin/bash', 03:45:20 INFO - 'SHLVL': '1', 03:45:20 INFO - 'TERM': 'linux', 03:45:20 INFO - 'TMOUT': '86400', 03:45:20 INFO - 'USER': 'cltbld', 03:45:20 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466592023.86729-176544120', 03:45:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:20 INFO - '_': '/tools/buildbot/bin/python'} 03:45:20 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/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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:45:20 INFO - mozversion application_buildid: 20160622010102 03:45:20 INFO - mozversion application_changeset: 800dc20aca781026226a03c3f43ff132b5cfdc1d 03:45:20 INFO - mozversion application_display_name: Firefox 03:45:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:45:20 INFO - mozversion application_name: Firefox 03:45:20 INFO - mozversion application_remotingname: firefox 03:45:20 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 03:45:20 INFO - mozversion application_vendor: Mozilla 03:45:20 INFO - mozversion application_version: 48.0 03:45:20 INFO - mozversion platform_buildid: 20160622010102 03:45:20 INFO - mozversion platform_changeset: 800dc20aca781026226a03c3f43ff132b5cfdc1d 03:45:20 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 03:45:20 INFO - mozversion platform_version: 48.0 03:45:20 INFO - using testdate: 1466592320 03:45:20 INFO - actual date: 1466592320 03:45:20 INFO - starting webserver on 'localhost:49709' 03:45:20 INFO - SUITE-START | Running 2 tests 03:45:20 INFO - TEST-START | dromaeo_css 03:45:20 INFO - operating with platform_type : linux_ 03:45:20 INFO - Initialising browser for dromaeo_css test... 03:45:21 INFO - TEST-INFO | started process 16780 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwL6mtq/profile http://localhost:49709/getInfo.html) 03:45:24 INFO - PROCESS | 16780 | __metrics Screen width/height:1600/1200 03:45:24 INFO - PROCESS | 16780 | colorDepth:24 03:45:24 INFO - PROCESS | 16780 | Browser inner width/height: 1024/697 03:45:24 INFO - PROCESS | 16780 | __metrics 03:45:25 ERROR - PROCESS | 16780 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:45:26 INFO - TEST-INFO | 16780: exit 0 03:45:26 INFO - Browser initialized. 03:45:26 INFO - Running cycle 1/1 for dromaeo_css test... 03:45:26 INFO - TEST-INFO | started process 16873 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwL6mtq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:45:38 INFO - PROCESS | 16873 | RSS: Main: 140836864 03:45:38 INFO - PROCESS | 16873 | 03:46:29 INFO - PROCESS | 16873 | 1466592389387 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:48:36 INFO - PROCESS | 16873 | Cycle 1(1): loaded http://localhost:49709/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49709/tests/dromaeo/cssquery-ext.html) 03:48:37 INFO - PROCESS | 16873 | RSS: Main: 250871808 03:48:37 INFO - PROCESS | 16873 | 03:51:40 INFO - PROCESS | 16873 | Cycle 1(1): loaded http://localhost:49709/tests/dromaeo/cssquery-ext.html (next: http://localhost:49709/tests/dromaeo/cssquery-jquery.html) 03:51:40 INFO - PROCESS | 16873 | RSS: Main: 221585408 03:51:40 INFO - PROCESS | 16873 | 03:54:42 INFO - PROCESS | 16873 | Cycle 1(1): loaded http://localhost:49709/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49709/tests/dromaeo/cssquery-mootools.html) 03:54:43 INFO - PROCESS | 16873 | RSS: Main: 221958144 03:54:43 INFO - PROCESS | 16873 | 03:57:45 INFO - PROCESS | 16873 | Cycle 1(1): loaded http://localhost:49709/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49709/tests/dromaeo/cssquery-prototype.html) 03:57:45 INFO - PROCESS | 16873 | RSS: Main: 217079808 03:57:45 INFO - PROCESS | 16873 | 04:00:48 INFO - PROCESS | 16873 | Cycle 1(1): loaded http://localhost:49709/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49709/tests/dromaeo/cssquery-yui.html) 04:00:48 INFO - PROCESS | 16873 | RSS: Main: 215252992 04:00:48 INFO - PROCESS | 16873 | 04:03:50 INFO - PROCESS | 16873 | Cycle 1(1): loaded http://localhost:49709/tests/dromaeo/cssquery-yui.html (next: http://localhost:49709/tests/dromaeo/cssquery-dojo.html) 04:03:51 INFO - PROCESS | 16873 | RSS: Main: 255766528 04:03:51 INFO - PROCESS | 16873 | 04:03:51 INFO - PROCESS | 16873 | __start_tp_report 04:03:51 INFO - PROCESS | 16873 | _x_x_mozilla_page_load 04:03:51 INFO - PROCESS | 16873 | _x_x_mozilla_page_load_details 04:03:51 INFO - PROCESS | 16873 | |i|pagename|runs| 04:03:51 INFO - PROCESS | 16873 | |0;dojo.html;3357.345317663056;3392.0841372829323;3417.8120203388803;3431.845566949487;3462.169079420938;5664.291963504562;5677.772889084436;5678.176664383662;5685;5700.458456446641;5671.574631902614;5725.026745453272;5725.456081672234;5729.6562206267545;5735.11105778605;5058.190689489682;5115.53960143587;5269.394019687747;5289.841304760864;5320.600954928376;5044.470330615288;5068.670536415139;5096.745162741867;5105.84682459525;5106.106431374513;5051.267566202899;5057.645964782467;5080.237964305346;5110.872228194306;5137.614678899079;5161;5190.32525771651;5199.4800519948085;5204.921926171091;5232.3459567554055;5018.573421259197;5063.797448102072;5090.669106508102;5096.592272618182;5103.4896510349035;5518.806841760559;5519.641223320471;5530.5022547970875;5563.666180029211;5572.693501857396;5987.461128498456;5990.251218597676;5990.820275391745;5992.0712289595185;5999.6700181490005;6027.668478233739;6045.909311360333;6073.89759207295;6123;6126.969365153146;5648.152777083429;5699.544036477113;5700.743466544015;5706.885862282731;5708.857278568027;6042.244719410074;6210.844728881814;6219.346968568326;6231.719572619243;6232.283287421914;5795.710214489259;5862.091375836752;5873.089671100986;5874.441928016831;5880.176775251468;5999.970000149971;6014.51883849291;6019.69901504923;6020.729067191987;6024.608400453956;5788;5856.209411729447;5976.7908123215475;5986.311574168939;5987.341392446828;5917.142014407887;5927.792527261525;5931.347551769302;5943.197668314809;5967.582269241198;4529.569690879362;4536.387587675622;4538.659600529973;4539.319102134707;4567.840125595655;4048.39274108886;4048.8582899598373;4060;4098.918021639551;4099.487564054493;5842.503387212135;5858.091995740667;5863.091220860773;5865.501432378211;5866.178734977107;6128.417800308964;6165.907511387333;6194.628322300677;6194.81415557534;6196.783112591038;5660.377358490563;5744.080947048452;5829.59192856496;5845.766169353264;5851.678157701367;5190.429052804188;5221.7128057956415;5227.163653815372;5227.817026404134;5230.34620672416;6242.5942313749465;6257.530685198628;6270.2475702915945;6273.65494897785;6291.653959032297;5957.79147729836;6080.300765411857;6137.8979746733885;6151.507879369729;6153.569250152446;6244.375562443719;6247.750089996349;6276.592021518587;6287.497000240061;6295.276043255084;5910.556708246812;5931.051031834886;5938.079597662369;5957.642541447527;5981.162637230878;5929.584929054925;5978;5978.611390259619;6002.399760023963;6016.789412370546;5834.824955251349;5854.2389489366105;5857.5313974881055;5859.238299021271;5859.765609375748;5759.308882934075;5820.068788993741;5826.417358264309;5850.444207800252;5882.49998750111;5718;5752.9137062943255;5754.367019627922;5760.366359700346;5786.363500014911;5809.302883653989;5837;5852.122181672613;5852.209951656472;5862.853428664317;5638.6898720569125;5727.284089488814;5752.539796816328;5766.711664416846;5835.503982161564 04:03:51 INFO - PROCESS | 16873 | |1;ext.html;664.8204984654144;670.9664516774161;678.1997243252965;749.3892477630732;751.3388218367835;32874.83562582187;33519.16202094946;39148.41277380841;39862.80068599653;39892;41229.7938510307;41665.37501937473;41757.164856702846;41807;41841.790791046005;8106.310963568104;8636.395452318324;8803.77990550235;8809.339299552526;10260.33307834992;10406.219533535015;10526.315789473698;10554.630587929423;10556.049955504042;10556.10273126785;10571.894281057168;10643.14854811617;10647.14822814173;10652.946735266312;10653.041226289632;10490.527926243338;10541.209409294333;10550.314229575053;10552.419616921066;10562.947185264025;10210.642627508076;10638.840417393745;10639.57441702331;10651.30766500175;10659.147268218523;43595;43806.34290485645;44039.33940990888;44177.116457670985;44255.11489770187;3630.6006339302658;3696.1129328961124;3793.279276937373;3992.800359982018;4446.288593825005;33643.15892102692;33895.83052084724;33908.830455847565;34826.47760283598;35340.29319413623;4399.296112621997;4421.447319085114;4468.061707041493;4475.910481790378;4516.322551617251;335348;337081;338751;339282;339899;39268;39973.20053598912;40014.79992600018;61173.69413152906;61715.69142154261;37604;37861.24277514434;37896.431553526716;37916.62083379186;37947.43078853819;17441.825581744273;17637.206325715375;17657.117144142743;17659.646807063786;17675.11624418774;13893.374798134108;15008.47470338533;15488.380464781283;15488.612784680474;15504.147271900154;9315.72052838416;9388;9404.341696081208;9461.385009974467;9485.952570237243;3596.5504311961004;3636.7636103653176;3713;3725.3666876631037;3765.3975363941636;1123.3035517978742;1193.2899924544881;1201.357273858499;1207.9758404831855;1269.1433282534254;32622.510662340082;32806.67193328084;32930.48965319152;32960.83519582387;33293.50059749106;1243.720162963326;1269.5556555205603;1324.3775425549977;1335.706144648176;1357.7827547592337;17441.47675569735;17621.207045682975;17638.206280717142;17642.5589360267;17647.11764411774;471135;471530;474381;475561;476746;60981.390186098455;61620.38379616146;61648.383516164264;61698;61718.69140654268;1400.7198560287984;1477.1580199286518;1513.4173343262703;1582.327510807902;1608.3807734022253;29988.250293742833;31461.528077078405;32687.34625307433;32764.67235327616;33333.166670832456;49016;49476.752616236685;49540;49614.50385496243;49645.75177124091;270304;276894;278716;279148;280079;27166.864165679046;29564.704352957055;30039.699603004563;30497;30819.380352670276;42931.78534107434;46605;46838.53161468478;46996.530034699215;48028.27957580569;39038.20634197552;39558;40039.39940900831;40289.79855100706;40720.185596287316;38118.82424018534;38894.80552597219;38994.80502597469;39318.803405982784;39402.60597394104;40982.38526422166;40988.38517422182;41633.58366416418;41760.79119604383;41808.58191418047;34865.30269394547;35256.823715881255;36273.093172670895;36681.816590916875;36781.26437471289;27590;28068.578971315856;28253.434931300846;28365.14904552784;28414.147575572766 04:03:51 INFO - PROCESS | 16873 | |2;jquery.html;434.5393882484569;441.3566012566265;442.38729359836617;443.81501391285263;447.76193824076415;18711.3451029214;18760.718589221156;19188.71216931747;20095.59808803823;20108.798912010876;19371.709424358647;19432.805671943275;19718.605627887435;19723.5069123272;19724.408267751955;5642.492175704186;5691.886162276763;5900.88198236035;5903.793367232148;5911.083782013773;4086.4891888513935;5802;5860.706964651772;5862.589618726691;7530.924690753104;7498.6625601848045;7503;7513.474056816025;7519.285667861544;7532.887006694904;7239.963800180992;7474;7624.123225829046;7636.809079773022;7637.618119094023;4686.882827929295;7070.399016083639;7377.8155546111775;7381.0404647396035;7448.217937116633;25544.23367298984;25692.74307256922;26010.08964686227;26622.33444163892;26909.461810763674;2499.9750002499923;2561.3340531461768;2608.321836322551;2616.2936007278117;2705.986470067637;15299.694006119815;15379.61550961235;15393.923030384776;16367.754483682755;16458.506244812674;2156.7735387784214;2162.7945345192184;2203.823694104484;2274.226762900622;2338.298510446859;87589;89625;90321.54839225828;91294.5435272826;93242.06757932402;17821.465356039338;18134.637307253783;18262;18282.89190837561;18455.630887382176;34359.96920092401;34367;34636;34847;34909.301813963575;11253.66239012831;11421.885781142082;11467.197296189353;11481.311121332747;11619.825702614467;9795.853062204073;9811.558479868423;9838.26213034011;9851.753706157404;9959.452230127412;9400.15398614128;9419.434833909987;9467.289953253534;9504.38221515613;9662.420254784736;3589.6948759355746;3631.3100510902846;3730.198007428416;3748.83130259139;3826.345839723058;981.79873126009;1006.8238058339762;1041.2143174455693;1072.1904961753983;1157.2362240920952;18066.638667226583;19614.509637259183;19775.60448791016;20026.299079532437;20041;1036.6112707734599;1041.03704073733;1114.6098865397207;1122.680036189682;1195.3186683590443;11098.445077746243;11250.606228782117;11343.659690209306;11381.146414018982;11425.942870285595;487834;495440;501119;516867;539287;67031.66484167548;77280.61359693165;78787.21212787798;83587.5820620893;90352.5482372584;1115.8772535021303;1123.8201887697928;1125.4204084896285;1128.5485805677795;1160.0777381981177;17159.828401716324;17501.21244543973;17606.91196544009;17810.198541065423;18051.277948882424;38283.425748613234;38307.2338553233;39430.802845985585;39870.202595948496;39963.60036399599;56749.14876276776;57811;58030.709846450496;58477;58833.41166588279;9037.81924361496;9068.773280668036;9209.263258939134;9341.813163736822;9368.67209647659;11571.305721656727;13256.734865302833;13513.797293040416;13537.458501659823;13678.042537022313;11232.943835280772;11522.942385288019;11745.706357341134;11968.820467692818;12003.339816309837;11615.76768464643;11719.179657423898;11813.291202527877;11898.583549575724;12036;11787.646370608896;11790.292582445081;12291.893729564383;12387.318697471726;12455.128141030042;9105.317101217302;9148.222401095714;9228.769280768034;9245.768855778659;9254.398464099811;11133.443327833415;12236;12368;12452.626421207378;12560.937195313965 04:03:51 INFO - PROCESS | 16873 | |3;mootools.html;1430.0418719457962;1557.3303479503813;1597.8242393336732;1795.515210893059;1945.6303302372548;7808.648610812513;8355.248027677508;8535.615897284622;8550.615222315004;8561.229489345973;8314.29328507076;8451.450655707375;8476.23713865752;8493.235608795207;8508.319334453245;2417.5648383290954;2443.657887895696;2444.3889027743066;2448.1186772761794;2453.6442215878687;2449.960846513344;2480;2486.6021436570154;2490.5267999080206;2510.598304271317;2420.249722585995;2439.4145405102736;2455.238875948453;2455.9508809823883;2460.9138680146198;2289.095807156172;2299.5171014087064;2299.678045073691;2404.4229384947485;2466.223139711003;2389.7012873390827;2448.669429627013;2460.1020627470843;2462.2367066209354;2462.581361168606;7321.26787321269;7480.8877866832045;8712.782180445476;8748.8687669685;8761.824763504694;5277.577793776489;5339.5461385782255;5346.251524786533;5386.111291636915;5387.622866399353;3482.460218666111;3498.177928186874;3548.183917698944;3582.8208589570418;3633.963660363389;1148.8219326004482;1155.5098762167543;1165.3823473559028;1174.6241202815102;1182.119321105773;11605.071594272438;11850.822237666442;11871.109666775026;12158.51365945361;12238.877611223863;4757.666963312604;4850.6362022848425;4889.850885042012;4909.189983652657;4936.7284799336385;10426.426546539862;10472.790544189225;10486.318389304672;10491.422971736627;10500.107490863362;5504.53211477029;5527.695976721319;5528.944710552923;5550.084236101079;5553.972230138905;4988.925166122511;5044.697318160922;5057;5061.139606266944;5063.721495317719;3873.3996230584303;3970.4242884782125;3982.104026594051;4026.355783074694;4030.717849750489;1231.9199252048588;1257.3587470389984;1257.886790188869;1270.8792664697023;1279.609719035703;1042.9739256518649;1069.668402795136;1087.141158484804;1092.7158938676002;1099.4777480696605;6046.395360463918;6090.056041313604;6175.752969881244;6189.226346706661;6208.50331973441;466.13299263370106;476.0336516870758;477.4557005014286;477.53917469641965;485.9757012149378;3813.1229817141657;3954.8220330085214;3972;3992.920141597152;4021.235965166609;10374.481275936172;10747.30142540748;10822.837657435144;10848.72878178036;10901.182411319183;10537.262391632665;10729.83905241422;10749.032587067202;10755.139588832875;10767.407792571326;7847.529148251123;8279.668813247403;8317.085120636724;8317.500949943023;8400.327973762085;5964.254468191476;6037.849053773515;6042.637441753509;6174.938250617616;6179.6910154493;9369.437833729999;9614.423134611945;9665.323427360017;9688.564014619218;9711.9028809711;9884.061014203638;9896.752581185528;9962.103410693073;10102.292839501164;10116.797664046826;7627.199144089791;7705.383569314554;7708.306252437307;7756.457048006585;7796.181400953045;8394.370422218235;8432.241098301183;8490.15098490146;8521.488710677379;8544.914550854412;7560.281773231534;7563.168051514219;7694.538327700356;7733.226677332222;7752.92247077522;7613.505122167041;7655.770326890202;7713.922860771545;7785.182555831556;7835.451518393657;7119.537230080028;7153.105861767279;7284.053073100675;7313;7316.926830731837;4502.189605870974;5228.424873263862;5326.36083669962;5333.386660534088;5432.266644003167;5214.608904332114;5232.215167724872;5268.1834315681135;5268.894622107613;5330.9733451332495 04:03:51 INFO - PROCESS | 16873 | |4;prototype.html;354.3904484287027;364.6535790998551;365.08298693439394;367.0859559696356;370.8590735520502;6255.530835187362;6480.189976252968;6515.478761699064;6539.084528166055;6554.279029306785;6287.4655654269445;6387.808365749023;6388.520860935425;6402.775902843401;6412.294647588773;4606.147862645421;4692.694974826625;4739.810407583693;4847.563719265257;4849.854504364875;4684.203685373494;4757.167495688258;4777.784999675006;4780.928286075712;4795.184818580832;4784.473707892129;4789.6168306535565;4790.928136077961;4792.90414191716;4804.975975120137;4584.1519318925775;4786.1863483207935;4789.640776941726;4796.376471058775;4801.375821143264;4080.7143499955014;4157.771322577257;4164.937525937114;4166.375043743433;4176.436181115571;6077;6078.1186727924205;6081.239845019372;6083.939160608382;6091.451769340736;5606.103023516259;5607.158926161109;5608.523275521586;5609.691466969315;5613.578981576357;6668.86662266752;6680.5991640501725;6682.632455214961;6691.732330706766;6693.364130407604;4491.910161796778;4667.603253723438;4678.345031695565;4681.297805329194;4685.250359942393;6832.555883867532;6949.061876646639;6979.336962988508;6990.650467476606;6997.545159564663;4770.737609431445;4774.4509381421585;4775.5224477551965;4778.761061946889;4784.856454306377;4840.273958906122;4841.080194762983;4842.854714358575;4844.636652251095;4847.103285892122;5560.666360018412;5580.995420824291;5584.162375643686;5596.104623260258;5596.300462442195;6598.769043083469;6659.2008958925235;6709.7651582194385;6719.193696756322;6720.327967203339;1675.656490419461;1685.1068933465283;1701.140923833456;1701.1664284500505;1702.5062731807884;1100.3178029621527;1107.8892110788856;1119.781642579689;1123.4438952718294;1124.7413094988199;6261;6440.323766004502;6521.869562608721;6544.8363790905605;6577.440917521969;6988.021676965229;6989.615571143534;6994.965025174842;7003.723789768345;7010.544314619533;6624.735010599522;6659.9001014984815;6660.966695166493;6661.26726060133;6667.399934005963;3712.2204337088974;3750.456183853326;3761.605031471711;3769.7172712046704;3771.7171212159196;7145.571265724073;7237.095363079615;7281.344678978918;7300.196978332486;7309.634518274065;7077.610731409719;7105.680244388912;7106.893396599055;7112.288771122846;7125;7249.238829922782;7271.836506158989;7275;7281.19906810261;7292.34368906801;6959.164900212007;6962.721491140298;6963.442924566124;6977.441804655514;6978.092847929736;6710.553834815628;6773.491988100814;6813.965930170318;6824.249332573314;6864.347886950732;7236.20401755817;7251.56490610565;7259.963700181465;7287.380572651172;7292;4751.239801631722;4753.595944344769;4759.785809638505;4760.143174228672;4761.095391875532;6925;6925.376716095374;6944.895826562504;6949.548279362028;6949.61777102244;6612.107365505787;6678.265390806911;6715.966420168063;6726.226483954212;6738.797836064926;6686.29793871656;6705.765298214539;6726.39462448382;6727.831804204739;6738.090357801634;6598.076269322395;6599;6602.9009564855605;6616.371444712745;6621.470282377302;6708.496862735412;6759.087523184307;6776.457883369417;6797.354251346114;6802.761903333359;6487.481001519962;6610.8347291318105;6625.072489851521;6628;6647.734090636513 04:03:51 INFO - PROCESS | 16873 | |5;yui.html;796.3151689546991;828.2793969246752;844.8014716541612;905.8007238407548;934.0146145816166;14935;14961.102333859975;15057.548273551798;15115.16866572338;15151.545453636394;14217.715645687105;14300.213488258141;14312.427502899898;14366.20985845778;14464.20446875424;747.9962600186991;901.9098090190961;905.9682911098097;917.6375331743957;923.3351986569659;916.2807196350866;920.1764420843341;922.580225997173;924.7780532672144;925.4354843545432;966.8501382285722;969.6218474794836;969.7624082099895;970.1317320997703;970.553545369131;786.5634572812087;945.8392073347547;955.7658373698488;956.1251454918742;956.3496822160928;696.8884978403431;700.5306444682025;701.8315604254942;702.4801646781397;702.5012241308677;14194.574162775134;14336.42654293827;14337.42650293987;14434.783478247835;14456.494022709154;14685.926570367079;15014.324355404033;15015.324310406058;15091.773623395658;15211.163386013764;11887.762244755057;11933.105017123664;11996;12065.879341206562;12361.196522226026;4557.202489564313;4570.977145114253;4673.532646735333;4701.576858082789;4703.459102203256;59491.10763338597;60643.69678151581;61645.38354616441;61880.69059654718;62205;10930.56277748881;11027.83458248127;11096.61161859331;11138.164637652208;11343.205975581795;20058.89970550138;20126;20136.597268054556;20141.798582014286;20187.596248074955;8452.366072544584;8488.660453581911;8630.39587228888;8679.696210632597;8719.215270625675;4908.141075311806;4927.556519913225;4951.183054795918;5036.748162591855;5058.266551350107;3553.271579326232;3590.3537363274863;3593.7664051836546;3600.1899572595958;3607.1703508193264;602.3223873142714;650.6031320894251;666.0841343153164;674.5682763031664;677.915260592426;695.6730336741723;730.6018220070075;734.3097488360924;741.5550669598198;755.6372940988247;9228.446293222429;9479.76300592477;9661.806763864683;9663.710088697351;9742;566.2949627713441;679.4021261290034;690.0955935861771;727.0294157300063;731.9304666056822;4487.6634252431195;4529.547045295444;4597.356370108188;4634.9536504634525;4667.836625718083;64597.354026460074;64934.35065649378;65046.67476662587;65098.349016510176;65301.34698653048;57101;57964.42035579675;58973.70513147407;59564.70217648971;60601.39398606046;53978.19032714512;54412.72793636007;54858.72570637121;54946.450535494936;55904.72047639817;8854.690085846965;9042.367034307536;9046.050164732871;9167.358284919992;9259.259259259108;38520.80739596396;39612.60387396089;39753.602463976145;40120.79939600283;40220.39669404903;42575.7871210642;48083.75958120187;51317.23024154716;51398;52203.216951746515;11355.602553910574;12008.819867702166;12028.15802893824;12145.210561313486;12186.51253949832;12760.617181484571;12919.289439080565;13496.73006539844;13626.250556219504;13995.650108747363;12123.818142728043;12198.756024879276;12347;12421.503139874665;12427.627171184879;10864.293820901616;10886.564537418415;10897.12822974176;10967.177461690564;11105.333679979227;11873.762524749629;12045.33750643723;12059.51761929513;12090.093243006633;12457.875421245672;9907.950460247941;10343.534540945826;10764.40795756241;11106.333619982826;11420.257683250562;11318;11330.696969848574;11510.884891150981;11572.826407603725;11951.402429878297 04:03:51 INFO - PROCESS | 16873 | __end_tp_report 04:03:51 INFO - PROCESS | 16873 | __start_cc_report 04:03:51 INFO - PROCESS | 16873 | _x_x_mozilla_cycle_collect,849 04:03:51 INFO - PROCESS | 16873 | __end_cc_report 04:03:51 INFO - PROCESS | 16873 | __startTimestamp1466593431185__endTimestamp 04:03:51 INFO - PROCESS | 16873 | 04:03:51 INFO - PROCESS | 16873 | ------- Summary: start ------- 04:03:51 INFO - PROCESS | 16873 | Number of tests: 6 04:03:51 INFO - PROCESS | 16873 | 04:03:51 INFO - PROCESS | 16873 | [#0] dojo.html Cycles:165 Average:5603.72 Median:5829.59 stddev:625.45 (10.7%) stddev-sans-first:602.03 04:03:51 INFO - PROCESS | 16873 | Values: 3357.3 3392.1 3417.8 3431.8 3462.2 5664.3 5677.8 5678.2 5685.0 5700.5 5671.6 5725.0 5725.5 5729.7 5735.1 5058.2 5115.5 5269.4 5289.8 5320.6 5044.5 5068.7 5096.7 5105.8 5106.1 5051.3 5057.6 5080.2 5110.9 5137.6 5161.0 5190.3 5199.5 5204.9 5232.3 5018.6 5063.8 5090.7 5096.6 5103.5 5518.8 5519.6 5530.5 5563.7 5572.7 5987.5 5990.3 5990.8 5992.1 5999.7 6027.7 6045.9 6073.9 6123.0 6127.0 5648.2 5699.5 5700.7 5706.9 5708.9 6042.2 6210.8 6219.3 6231.7 6232.3 5795.7 5862.1 5873.1 5874.4 5880.2 6000.0 6014.5 6019.7 6020.7 6024.6 5788.0 5856.2 5976.8 5986.3 5987.3 5917.1 5927.8 5931.3 5943.2 5967.6 4529.6 4536.4 4538.7 4539.3 4567.8 4048.4 4048.9 4060.0 4098.9 4099.5 5842.5 5858.1 5863.1 5865.5 5866.2 6128.4 6165.9 6194.6 6194.8 6196.8 5660.4 5744.1 5829.6 5845.8 5851.7 5190.4 5221.7 5227.2 5227.8 5230.3 6242.6 6257.5 6270.2 6273.7 6291.7 5957.8 6080.3 6137.9 6151.5 6153.6 6244.4 6247.8 6276.6 6287.5 6295.3 5910.6 5931.1 5938.1 5957.6 5981.2 5929.6 5978.0 5978.6 6002.4 6016.8 5834.8 5854.2 5857.5 5859.2 5859.8 5759.3 5820.1 5826.4 5850.4 5882.5 5718.0 5752.9 5754.4 5760.4 5786.4 5809.3 5837.0 5852.1 5852.2 5862.9 5638.7 5727.3 5752.5 5766.7 5835.5 04:03:51 INFO - PROCESS | 16873 | 04:03:51 INFO - PROCESS | 16873 | [#1] ext.html Cycles:180 Average:52672.16 Median:19934.82 stddev:98261.05 (492.9%) stddev-sans-first:98459.12 04:03:51 INFO - PROCESS | 16873 | Values: 664.8 671.0 678.2 749.4 751.3 32874.8 33519.2 39148.4 39862.8 39892.0 41229.8 41665.4 41757.2 41807.0 41841.8 8106.3 8636.4 8803.8 8809.3 10260.3 10406.2 10526.3 10554.6 10556.0 10556.1 10571.9 10643.1 10647.1 10652.9 10653.0 10490.5 10541.2 10550.3 10552.4 10562.9 10210.6 10638.8 10639.6 10651.3 10659.1 43595.0 43806.3 44039.3 44177.1 44255.1 3630.6 3696.1 3793.3 3992.8 4446.3 33643.2 33895.8 33908.8 34826.5 35340.3 4399.3 4421.4 4468.1 4475.9 4516.3 335348.0 337081.0 338751.0 339282.0 339899.0 39268.0 39973.2 40014.8 61173.7 61715.7 37604.0 37861.2 37896.4 37916.6 37947.4 17441.8 17637.2 17657.1 17659.6 17675.1 13893.4 15008.5 15488.4 15488.6 15504.1 9315.7 9388.0 9404.3 9461.4 9486.0 3596.6 3636.8 3713.0 3725.4 3765.4 1123.3 1193.3 1201.4 1208.0 1269.1 32622.5 32806.7 32930.5 32960.8 33293.5 1243.7 1269.6 1324.4 1335.7 1357.8 17441.5 17621.2 17638.2 17642.6 17647.1 471135.0 471530.0 474381.0 475561.0 476746.0 60981.4 61620.4 61648.4 61698.0 61718.7 1400.7 1477.2 1513.4 1582.3 1608.4 29988.3 31461.5 32687.3 32764.7 33333.2 49016.0 49476.8 49540.0 49614.5 49645.8 270304.0 276894.0 278716.0 279148.0 280079.0 27166.9 29564.7 30039.7 30497.0 30819.4 42931.8 46605.0 46838.5 46996.5 48028.3 39038.2 39558.0 40039.4 40289.8 40720.2 38118.8 38894.8 38994.8 39318.8 39402.6 40982.4 40988.4 41633.6 41760.8 41808.6 34865.3 35256.8 36273.1 36681.8 36781.3 27590.0 28068.6 28253.4 28365.1 28414.1 04:03:51 INFO - PROCESS | 16873 | 04:03:51 INFO - PROCESS | 16873 | [#2] jquery.html Cycles:180 Average:30918.47 Median:14619.31 stddev:83409.86 (570.5%) stddev-sans-first:83612.44 04:03:51 INFO - PROCESS | 16873 | Values: 434.5 441.4 442.4 443.8 447.8 18711.3 18760.7 19188.7 20095.6 20108.8 19371.7 19432.8 19718.6 19723.5 19724.4 5642.5 5691.9 5900.9 5903.8 5911.1 4086.5 5802.0 5860.7 5862.6 7530.9 7498.7 7503.0 7513.5 7519.3 7532.9 7240.0 7474.0 7624.1 7636.8 7637.6 4686.9 7070.4 7377.8 7381.0 7448.2 25544.2 25692.7 26010.1 26622.3 26909.5 2500.0 2561.3 2608.3 2616.3 2706.0 15299.7 15379.6 15393.9 16367.8 16458.5 2156.8 2162.8 2203.8 2274.2 2338.3 87589.0 89625.0 90321.5 91294.5 93242.1 17821.5 18134.6 18262.0 18282.9 18455.6 34360.0 34367.0 34636.0 34847.0 34909.3 11253.7 11421.9 11467.2 11481.3 11619.8 9795.9 9811.6 9838.3 9851.8 9959.5 9400.2 9419.4 9467.3 9504.4 9662.4 3589.7 3631.3 3730.2 3748.8 3826.3 981.8 1006.8 1041.2 1072.2 1157.2 18066.6 19614.5 19775.6 20026.3 20041.0 1036.6 1041.0 1114.6 1122.7 1195.3 11098.4 11250.6 11343.7 11381.1 11425.9 487834.0 495440.0 501119.0 516867.0 539287.0 67031.7 77280.6 78787.2 83587.6 90352.5 1115.9 1123.8 1125.4 1128.5 1160.1 17159.8 17501.2 17606.9 17810.2 18051.3 38283.4 38307.2 39430.8 39870.2 39963.6 56749.1 57811.0 58030.7 58477.0 58833.4 9037.8 9068.8 9209.3 9341.8 9368.7 11571.3 13256.7 13513.8 13537.5 13678.0 11232.9 11522.9 11745.7 11968.8 12003.3 11615.8 11719.2 11813.3 11898.6 12036.0 11787.6 11790.3 12291.9 12387.3 12455.1 9105.3 9148.2 9228.8 9245.8 9254.4 11133.4 12236.0 12368.0 12452.6 12560.9 04:03:51 INFO - PROCESS | 16873 | 04:03:51 INFO - PROCESS | 16873 | [#3] mootools.html Cycles:180 Average:5785.09 Median:4899.52 stddev:3203.23 (65.4%) stddev-sans-first:3195.50 04:03:51 INFO - PROCESS | 16873 | Values: 1430.0 1557.3 1597.8 1795.5 1945.6 7808.6 8355.2 8535.6 8550.6 8561.2 8314.3 8451.5 8476.2 8493.2 8508.3 2417.6 2443.7 2444.4 2448.1 2453.6 2450.0 2480.0 2486.6 2490.5 2510.6 2420.2 2439.4 2455.2 2456.0 2460.9 2289.1 2299.5 2299.7 2404.4 2466.2 2389.7 2448.7 2460.1 2462.2 2462.6 7321.3 7480.9 8712.8 8748.9 8761.8 5277.6 5339.5 5346.3 5386.1 5387.6 3482.5 3498.2 3548.2 3582.8 3634.0 1148.8 1155.5 1165.4 1174.6 1182.1 11605.1 11850.8 11871.1 12158.5 12238.9 4757.7 4850.6 4889.9 4909.2 4936.7 10426.4 10472.8 10486.3 10491.4 10500.1 5504.5 5527.7 5528.9 5550.1 5554.0 4988.9 5044.7 5057.0 5061.1 5063.7 3873.4 3970.4 3982.1 4026.4 4030.7 1231.9 1257.4 1257.9 1270.9 1279.6 1043.0 1069.7 1087.1 1092.7 1099.5 6046.4 6090.1 6175.8 6189.2 6208.5 466.1 476.0 477.5 477.5 486.0 3813.1 3954.8 3972.0 3992.9 4021.2 10374.5 10747.3 10822.8 10848.7 10901.2 10537.3 10729.8 10749.0 10755.1 10767.4 7847.5 8279.7 8317.1 8317.5 8400.3 5964.3 6037.8 6042.6 6174.9 6179.7 9369.4 9614.4 9665.3 9688.6 9711.9 9884.1 9896.8 9962.1 10102.3 10116.8 7627.2 7705.4 7708.3 7756.5 7796.2 8394.4 8432.2 8490.2 8521.5 8544.9 7560.3 7563.2 7694.5 7733.2 7752.9 7613.5 7655.8 7713.9 7785.2 7835.5 7119.5 7153.1 7284.1 7313.0 7316.9 4502.2 5228.4 5326.4 5333.4 5432.3 5214.6 5232.2 5268.2 5268.9 5331.0 04:03:51 INFO - PROCESS | 16873 | 04:03:51 INFO - PROCESS | 16873 | [#4] prototype.html Cycles:180 Average:5630.30 Median:6518.67 stddev:1713.49 (26.3%) stddev-sans-first:1671.91 04:03:51 INFO - PROCESS | 16873 | Values: 354.4 364.7 365.1 367.1 370.9 6255.5 6480.2 6515.5 6539.1 6554.3 6287.5 6387.8 6388.5 6402.8 6412.3 4606.1 4692.7 4739.8 4847.6 4849.9 4684.2 4757.2 4777.8 4780.9 4795.2 4784.5 4789.6 4790.9 4792.9 4805.0 4584.2 4786.2 4789.6 4796.4 4801.4 4080.7 4157.8 4164.9 4166.4 4176.4 6077.0 6078.1 6081.2 6083.9 6091.5 5606.1 5607.2 5608.5 5609.7 5613.6 6668.9 6680.6 6682.6 6691.7 6693.4 4491.9 4667.6 4678.3 4681.3 4685.3 6832.6 6949.1 6979.3 6990.7 6997.5 4770.7 4774.5 4775.5 4778.8 4784.9 4840.3 4841.1 4842.9 4844.6 4847.1 5560.7 5581.0 5584.2 5596.1 5596.3 6598.8 6659.2 6709.8 6719.2 6720.3 1675.7 1685.1 1701.1 1701.2 1702.5 1100.3 1107.9 1119.8 1123.4 1124.7 6261.0 6440.3 6521.9 6544.8 6577.4 6988.0 6989.6 6995.0 7003.7 7010.5 6624.7 6659.9 6661.0 6661.3 6667.4 3712.2 3750.5 3761.6 3769.7 3771.7 7145.6 7237.1 7281.3 7300.2 7309.6 7077.6 7105.7 7106.9 7112.3 7125.0 7249.2 7271.8 7275.0 7281.2 7292.3 6959.2 6962.7 6963.4 6977.4 6978.1 6710.6 6773.5 6814.0 6824.2 6864.3 7236.2 7251.6 7260.0 7287.4 7292.0 4751.2 4753.6 4759.8 4760.1 4761.1 6925.0 6925.4 6944.9 6949.5 6949.6 6612.1 6678.3 6716.0 6726.2 6738.8 6686.3 6705.8 6726.4 6727.8 6738.1 6598.1 6599.0 6602.9 6616.4 6621.5 6708.5 6759.1 6776.5 6797.4 6802.8 6487.5 6610.8 6625.1 6628.0 6647.7 04:03:51 INFO - PROCESS | 16873 | 04:03:51 INFO - PROCESS | 16873 | [#5] yui.html Cycles:180 Average:15717.89 Median:26495.95 stddev:18609.64 (70.2%) stddev-sans-first:18628.11 04:03:51 INFO - PROCESS | 16873 | Values: 796.3 828.3 844.8 905.8 934.0 14935.0 14961.1 15057.5 15115.2 15151.5 14217.7 14300.2 14312.4 14366.2 14464.2 748.0 901.9 906.0 917.6 923.3 916.3 920.2 922.6 924.8 925.4 966.9 969.6 969.8 970.1 970.6 786.6 945.8 955.8 956.1 956.3 696.9 700.5 701.8 702.5 702.5 14194.6 14336.4 14337.4 14434.8 14456.5 14685.9 15014.3 15015.3 15091.8 15211.2 11887.8 11933.1 11996.0 12065.9 12361.2 4557.2 4571.0 4673.5 4701.6 4703.5 59491.1 60643.7 61645.4 61880.7 62205.0 10930.6 11027.8 11096.6 11138.2 11343.2 20058.9 20126.0 20136.6 20141.8 20187.6 8452.4 8488.7 8630.4 8679.7 8719.2 4908.1 4927.6 4951.2 5036.7 5058.3 3553.3 3590.4 3593.8 3600.2 3607.2 602.3 650.6 666.1 674.6 677.9 695.7 730.6 734.3 741.6 755.6 9228.4 9479.8 9661.8 9663.7 9742.0 566.3 679.4 690.1 727.0 731.9 4487.7 4529.5 4597.4 4635.0 4667.8 64597.4 64934.4 65046.7 65098.3 65301.3 57101.0 57964.4 58973.7 59564.7 60601.4 53978.2 54412.7 54858.7 54946.5 55904.7 8854.7 9042.4 9046.1 9167.4 9259.3 38520.8 39612.6 39753.6 40120.8 40220.4 42575.8 48083.8 51317.2 51398.0 52203.2 11355.6 12008.8 12028.2 12145.2 12186.5 12760.6 12919.3 13496.7 13626.3 13995.7 12123.8 12198.8 12347.0 12421.5 12427.6 10864.3 10886.6 10897.1 10967.2 11105.3 11873.8 12045.3 12059.5 12090.1 12457.9 9908.0 10343.5 10764.4 11106.3 11420.3 11318.0 11330.7 11510.9 11572.8 11951.4 04:03:51 INFO - PROCESS | 16873 | -------- Summary: end -------- 04:03:51 INFO - PROCESS | 16873 | 04:03:51 INFO - TEST-INFO | 16873: exit 0 04:03:51 INFO - TEST-OK | dromaeo_css | took 1110870ms 04:03:51 INFO - TEST-START | kraken 04:03:51 INFO - operating with platform_type : linux_ 04:03:51 INFO - Initialising browser for kraken test... 04:03:51 INFO - TEST-INFO | started process 17074 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFq9nYq/profile http://localhost:49709/getInfo.html) 04:03:55 INFO - PROCESS | 17074 | __metrics Screen width/height:1600/1200 04:03:55 INFO - PROCESS | 17074 | colorDepth:24 04:03:55 INFO - PROCESS | 17074 | Browser inner width/height: 1024/697 04:03:55 INFO - PROCESS | 17074 | __metrics 04:03:56 ERROR - PROCESS | 17074 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:03:57 INFO - TEST-INFO | 17074: exit 0 04:03:57 INFO - Browser initialized. 04:03:57 INFO - Running cycle 1/1 for kraken test... 04:03:57 INFO - TEST-INFO | started process 17163 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFq9nYq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:04:09 INFO - PROCESS | 17163 | RSS: Main: 140836864 04:04:09 INFO - PROCESS | 17163 | 04:04:11 INFO - PROCESS | 17163 | Cycle 1(1): loaded http://localhost:49709/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49709/tests/kraken/driver.html?testName=audio-beat-detection) 04:04:12 INFO - PROCESS | 17163 | RSS: Main: 197824512 04:04:12 INFO - PROCESS | 17163 | 04:04:14 INFO - PROCESS | 17163 | Cycle 1(1): loaded http://localhost:49709/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49709/tests/kraken/driver.html?testName=audio-dft) 04:04:15 INFO - PROCESS | 17163 | RSS: Main: 184995840 04:04:15 INFO - PROCESS | 17163 | 04:04:18 INFO - PROCESS | 17163 | Cycle 1(1): loaded http://localhost:49709/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49709/tests/kraken/driver.html?testName=audio-fft) 04:04:18 INFO - PROCESS | 17163 | RSS: Main: 274071552 04:04:18 INFO - PROCESS | 17163 | 04:04:20 INFO - PROCESS | 17163 | Cycle 1(1): loaded http://localhost:49709/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49709/tests/kraken/driver.html?testName=audio-oscillator) 04:04:21 INFO - PROCESS | 17163 | RSS: Main: 180051968 04:04:21 INFO - PROCESS | 17163 | 04:04:23 INFO - PROCESS | 17163 | Cycle 1(1): loaded http://localhost:49709/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49709/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:04:24 INFO - PROCESS | 17163 | RSS: Main: 178204672 04:04:24 INFO - PROCESS | 17163 | 04:04:27 INFO - PROCESS | 17163 | Cycle 1(1): loaded http://localhost:49709/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49709/tests/kraken/driver.html?testName=imaging-darkroom) 04:04:27 INFO - PROCESS | 17163 | RSS: Main: 213409792 04:04:27 INFO - PROCESS | 17163 | 04:04:31 INFO - PROCESS | 17163 | Cycle 1(1): loaded http://localhost:49709/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49709/tests/kraken/driver.html?testName=imaging-desaturate) 04:04:31 INFO - PROCESS | 17163 | RSS: Main: 213319680 04:04:31 INFO - PROCESS | 17163 | 04:04:34 INFO - PROCESS | 17163 | Cycle 1(1): loaded http://localhost:49709/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49709/tests/kraken/driver.html?testName=json-parse-financial) 04:04:35 INFO - PROCESS | 17163 | RSS: Main: 213262336 04:04:35 INFO - PROCESS | 17163 | 04:04:36 INFO - PROCESS | 17163 | Cycle 1(1): loaded http://localhost:49709/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49709/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:04:37 INFO - PROCESS | 17163 | RSS: Main: 193409024 04:04:37 INFO - PROCESS | 17163 | 04:04:38 INFO - PROCESS | 17163 | Cycle 1(1): loaded http://localhost:49709/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49709/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:04:39 INFO - PROCESS | 17163 | RSS: Main: 197025792 04:04:39 INFO - PROCESS | 17163 | 04:04:41 INFO - PROCESS | 17163 | Cycle 1(1): loaded http://localhost:49709/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49709/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:04:42 INFO - PROCESS | 17163 | RSS: Main: 209932288 04:04:42 INFO - PROCESS | 17163 | 04:04:44 INFO - PROCESS | 17163 | Cycle 1(1): loaded http://localhost:49709/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49709/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:04:45 INFO - PROCESS | 17163 | RSS: Main: 217939968 04:04:45 INFO - PROCESS | 17163 | 04:04:47 INFO - PROCESS | 17163 | Cycle 1(1): loaded http://localhost:49709/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49709/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:04:48 INFO - PROCESS | 17163 | RSS: Main: 212467712 04:04:48 INFO - PROCESS | 17163 | 04:04:50 INFO - PROCESS | 17163 | Cycle 1(1): loaded http://localhost:49709/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49709/tests/kraken/driver.html?testName=ai-astar) 04:04:50 INFO - PROCESS | 17163 | RSS: Main: 273252352 04:04:50 INFO - PROCESS | 17163 | 04:04:50 INFO - PROCESS | 17163 | __start_tp_report 04:04:50 INFO - PROCESS | 17163 | _x_x_mozilla_page_load 04:04:50 INFO - PROCESS | 17163 | _x_x_mozilla_page_load_details 04:04:50 INFO - PROCESS | 17163 | |i|pagename|runs| 04:04:50 INFO - PROCESS | 17163 | |0;ai-astar;110;111;109;109;109;109;104;109;110;109 04:04:50 INFO - PROCESS | 17163 | |1;audio-beat-detection;161;141;159;173;125;162;148;134;190;125 04:04:50 INFO - PROCESS | 17163 | |2;audio-dft;160;161;159;159;160;163;160;159;159;160 04:04:50 INFO - PROCESS | 17163 | |3;audio-fft;73;75;73;184;76;75;73;77;161;76 04:04:50 INFO - PROCESS | 17163 | |4;audio-oscillator;92;92;151;92;92;92;148;92;91;145 04:04:50 INFO - PROCESS | 17163 | |5;imaging-gaussian-blur;117;118;117;117;116;118;117;117;117;117 04:04:50 INFO - PROCESS | 17163 | |6;imaging-darkroom;146;145;146;145;145;146;145;145;144;145 04:04:50 INFO - PROCESS | 17163 | |7;imaging-desaturate;95;94;95;95;94;94;95;95;95;96 04:04:50 INFO - PROCESS | 17163 | |8;json-parse-financial;57;55;55;56;55;57;55;74;55;53 04:04:50 INFO - PROCESS | 17163 | |9;json-stringify-tinderbox;57;64;58;58;58;59;58;58;59;58 04:04:50 INFO - PROCESS | 17163 | |10;stanford-crypto-aes;71;72;71;72;72;73;73;74;73;82 04:04:50 INFO - PROCESS | 17163 | |11;stanford-crypto-ccm;117;121;123;113;114;112;111;115;132;113 04:04:50 INFO - PROCESS | 17163 | |12;stanford-crypto-pbkdf2;164;157;161;157;157;164;164;158;162;156 04:04:50 INFO - PROCESS | 17163 | |13;stanford-crypto-sha256-iterative;67;67;67;77;65;64;66;66;64;64 04:04:50 INFO - PROCESS | 17163 | __end_tp_report 04:04:50 INFO - PROCESS | 17163 | __start_cc_report 04:04:50 INFO - PROCESS | 17163 | _x_x_mozilla_cycle_collect,1589 04:04:50 INFO - PROCESS | 17163 | __end_cc_report 04:04:50 INFO - PROCESS | 17163 | __startTimestamp1466593490408__endTimestamp 04:04:50 INFO - PROCESS | 17163 | 04:04:50 INFO - PROCESS | 17163 | ------- Summary: start ------- 04:04:50 INFO - PROCESS | 17163 | Number of tests: 14 04:04:50 INFO - PROCESS | 17163 | 04:04:50 INFO - PROCESS | 17163 | [#0] ai-astar Cycles:10 Average:108.90 Median:109.00 stddev:1.85 (1.7%) stddev-sans-first:1.92 04:04:50 INFO - PROCESS | 17163 | Values: 110.0 111.0 109.0 109.0 109.0 109.0 104.0 109.0 110.0 109.0 04:04:50 INFO - PROCESS | 17163 | 04:04:50 INFO - PROCESS | 17163 | [#1] audio-beat-detection Cycles:10 Average:151.80 Median:160.00 stddev:21.17 (13.2%) stddev-sans-first:22.19 04:04:50 INFO - PROCESS | 17163 | Values: 161.0 141.0 159.0 173.0 125.0 162.0 148.0 134.0 190.0 125.0 04:04:50 INFO - PROCESS | 17163 | 04:04:50 INFO - PROCESS | 17163 | [#2] audio-dft Cycles:10 Average:160.00 Median:160.00 stddev:1.25 (0.8%) stddev-sans-first:1.32 04:04:50 INFO - PROCESS | 17163 | Values: 160.0 161.0 159.0 159.0 160.0 163.0 160.0 159.0 159.0 160.0 04:04:50 INFO - PROCESS | 17163 | 04:04:50 INFO - PROCESS | 17163 | [#3] audio-fft Cycles:10 Average:94.30 Median:75.00 stddev:41.59 (55.5%) stddev-sans-first:43.40 04:04:50 INFO - PROCESS | 17163 | Values: 73.0 75.0 73.0 184.0 76.0 75.0 73.0 77.0 161.0 76.0 04:04:50 INFO - PROCESS | 17163 | 04:04:50 INFO - PROCESS | 17163 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:92.00 stddev:27.16 (29.5%) stddev-sans-first:28.13 04:04:50 INFO - PROCESS | 17163 | Values: 92.0 92.0 151.0 92.0 92.0 92.0 148.0 92.0 91.0 145.0 04:04:50 INFO - PROCESS | 17163 | 04:04:50 INFO - PROCESS | 17163 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 04:04:50 INFO - PROCESS | 17163 | Values: 117.0 118.0 117.0 117.0 116.0 118.0 117.0 117.0 117.0 117.0 04:04:50 INFO - PROCESS | 17163 | 04:04:50 INFO - PROCESS | 17163 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 04:04:50 INFO - PROCESS | 17163 | Values: 146.0 145.0 146.0 145.0 145.0 146.0 145.0 145.0 144.0 145.0 04:04:50 INFO - PROCESS | 17163 | 04:04:50 INFO - PROCESS | 17163 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 04:04:50 INFO - PROCESS | 17163 | Values: 95.0 94.0 95.0 95.0 94.0 94.0 95.0 95.0 95.0 96.0 04:04:50 INFO - PROCESS | 17163 | 04:04:50 INFO - PROCESS | 17163 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:55.50 stddev:6.01 (10.8%) stddev-sans-first:6.38 04:04:50 INFO - PROCESS | 17163 | Values: 57.0 55.0 55.0 56.0 55.0 57.0 55.0 74.0 55.0 53.0 04:04:50 INFO - PROCESS | 17163 | 04:04:50 INFO - PROCESS | 17163 | [#9] json-stringify-tinderbox Cycles:10 Average:58.70 Median:58.00 stddev:1.95 (3.4%) stddev-sans-first:1.96 04:04:50 INFO - PROCESS | 17163 | Values: 57.0 64.0 58.0 58.0 58.0 59.0 58.0 58.0 59.0 58.0 04:04:50 INFO - PROCESS | 17163 | 04:04:50 INFO - PROCESS | 17163 | [#10] stanford-crypto-aes Cycles:10 Average:73.30 Median:73.00 stddev:3.20 (4.4%) stddev-sans-first:3.28 04:04:50 INFO - PROCESS | 17163 | Values: 71.0 72.0 71.0 72.0 72.0 73.0 73.0 74.0 73.0 82.0 04:04:50 INFO - PROCESS | 17163 | 04:04:50 INFO - PROCESS | 17163 | [#11] stanford-crypto-ccm Cycles:10 Average:117.10 Median:116.00 stddev:6.52 (5.6%) stddev-sans-first:6.92 04:04:50 INFO - PROCESS | 17163 | Values: 117.0 121.0 123.0 113.0 114.0 112.0 111.0 115.0 132.0 113.0 04:04:50 INFO - PROCESS | 17163 | 04:04:50 INFO - PROCESS | 17163 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.00 Median:161.50 stddev:3.33 (2.1%) stddev-sans-first:3.21 04:04:50 INFO - PROCESS | 17163 | Values: 164.0 157.0 161.0 157.0 157.0 164.0 164.0 158.0 162.0 156.0 04:04:50 INFO - PROCESS | 17163 | 04:04:50 INFO - PROCESS | 17163 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:66.50 stddev:3.83 (5.8%) stddev-sans-first:4.06 04:04:50 INFO - PROCESS | 17163 | Values: 67.0 67.0 67.0 77.0 65.0 64.0 66.0 66.0 64.0 64.0 04:04:50 INFO - PROCESS | 17163 | -------- Summary: end -------- 04:04:50 INFO - PROCESS | 17163 | 04:04:51 INFO - TEST-INFO | 17163: exit 0 04:04:51 INFO - TEST-OK | kraken | took 59457ms 04:04:51 INFO - SUITE-END | took 1170s 04:04:51 INFO - Completed test suite (00:19:30) 04:04:51 INFO - javascript benchmark 04:04:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3357.345317663056, 3392.0841372829323, 3417.8120203388803, 3431.845566949487, 3462.169079420938, 5664.291963504562, 5677.772889084436, 5678.176664383662, 5685.0, 5700.458456446641, 5671.574631902614, 5725.026745453272, 5725.456081672234, 5729.6562206267545, 5735.11105778605, 5058.190689489682, 5115.53960143587, 5269.394019687747, 5289.841304760864, 5320.600954928376, 5044.470330615288, 5068.670536415139, 5096.745162741867, 5105.84682459525, 5106.106431374513, 5051.267566202899, 5057.645964782467, 5080.237964305346, 5110.872228194306, 5137.614678899079, 5161.0, 5190.32525771651, 5199.4800519948085, 5204.921926171091, 5232.3459567554055, 5018.573421259197, 5063.797448102072, 5090.669106508102, 5096.592272618182, 5103.4896510349035, 5518.806841760559, 5519.641223320471, 5530.5022547970875, 5563.666180029211, 5572.693501857396, 5987.461128498456, 5990.251218597676, 5990.820275391745, 5992.0712289595185, 5999.6700181490005, 6027.668478233739, 6045.909311360333, 6073.89759207295, 6123.0, 6126.969365153146, 5648.152777083429, 5699.544036477113, 5700.743466544015, 5706.885862282731, 5708.857278568027, 6042.244719410074, 6210.844728881814, 6219.346968568326, 6231.719572619243, 6232.283287421914, 5795.710214489259, 5862.091375836752, 5873.089671100986, 5874.441928016831, 5880.176775251468, 5999.970000149971, 6014.51883849291, 6019.69901504923, 6020.729067191987, 6024.608400453956, 5788.0, 5856.209411729447, 5976.7908123215475, 5986.311574168939, 5987.341392446828, 5917.142014407887, 5927.792527261525, 5931.347551769302, 5943.197668314809, 5967.582269241198, 4529.569690879362, 4536.387587675622, 4538.659600529973, 4539.319102134707, 4567.840125595655, 4048.39274108886, 4048.8582899598373, 4060.0, 4098.918021639551, 4099.487564054493, 5842.503387212135, 5858.091995740667, 5863.091220860773, 5865.501432378211, 5866.178734977107, 6128.417800308964, 6165.907511387333, 6194.628322300677, 6194.81415557534, 6196.783112591038, 5660.377358490563, 5744.080947048452, 5829.59192856496, 5845.766169353264, 5851.678157701367, 5190.429052804188, 5221.7128057956415, 5227.163653815372, 5227.817026404134, 5230.34620672416, 6242.5942313749465, 6257.530685198628, 6270.2475702915945, 6273.65494897785, 6291.653959032297, 5957.79147729836, 6080.300765411857, 6137.8979746733885, 6151.507879369729, 6153.569250152446, 6244.375562443719, 6247.750089996349, 6276.592021518587, 6287.497000240061, 6295.276043255084, 5910.556708246812, 5931.051031834886, 5938.079597662369, 5957.642541447527, 5981.162637230878, 5929.584929054925, 5978.0, 5978.611390259619, 6002.399760023963, 6016.789412370546, 5834.824955251349, 5854.2389489366105, 5857.5313974881055, 5859.238299021271, 5859.765609375748, 5759.308882934075, 5820.068788993741, 5826.417358264309, 5850.444207800252, 5882.49998750111, 5718.0, 5752.9137062943255, 5754.367019627922, 5760.366359700346, 5786.363500014911, 5809.302883653989, 5837.0, 5852.122181672613, 5852.209951656472, 5862.853428664317, 5638.6898720569125, 5727.284089488814, 5752.539796816328, 5766.711664416846, 5835.503982161564], "value": 5562.838777794211, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [664.8204984654144, 670.9664516774161, 678.1997243252965, 749.3892477630732, 751.3388218367835, 32874.83562582187, 33519.16202094946, 39148.41277380841, 39862.80068599653, 39892.0, 41229.7938510307, 41665.37501937473, 41757.164856702846, 41807.0, 41841.790791046005, 8106.310963568104, 8636.395452318324, 8803.77990550235, 8809.339299552526, 10260.33307834992, 10406.219533535015, 10526.315789473698, 10554.630587929423, 10556.049955504042, 10556.10273126785, 10571.894281057168, 10643.14854811617, 10647.14822814173, 10652.946735266312, 10653.041226289632, 10490.527926243338, 10541.209409294333, 10550.314229575053, 10552.419616921066, 10562.947185264025, 10210.642627508076, 10638.840417393745, 10639.57441702331, 10651.30766500175, 10659.147268218523, 43595.0, 43806.34290485645, 44039.33940990888, 44177.116457670985, 44255.11489770187, 3630.6006339302658, 3696.1129328961124, 3793.279276937373, 3992.800359982018, 4446.288593825005, 33643.15892102692, 33895.83052084724, 33908.830455847565, 34826.47760283598, 35340.29319413623, 4399.296112621997, 4421.447319085114, 4468.061707041493, 4475.910481790378, 4516.322551617251, 335348.0, 337081.0, 338751.0, 339282.0, 339899.0, 39268.0, 39973.20053598912, 40014.79992600018, 61173.69413152906, 61715.69142154261, 37604.0, 37861.24277514434, 37896.431553526716, 37916.62083379186, 37947.43078853819, 17441.825581744273, 17637.206325715375, 17657.117144142743, 17659.646807063786, 17675.11624418774, 13893.374798134108, 15008.47470338533, 15488.380464781283, 15488.612784680474, 15504.147271900154, 9315.72052838416, 9388.0, 9404.341696081208, 9461.385009974467, 9485.952570237243, 3596.5504311961004, 3636.7636103653176, 3713.0, 3725.3666876631037, 3765.3975363941636, 1123.3035517978742, 1193.2899924544881, 1201.357273858499, 1207.9758404831855, 1269.1433282534254, 32622.510662340082, 32806.67193328084, 32930.48965319152, 32960.83519582387, 33293.50059749106, 1243.720162963326, 1269.5556555205603, 1324.3775425549977, 1335.706144648176, 1357.7827547592337, 17441.47675569735, 17621.207045682975, 17638.206280717142, 17642.5589360267, 17647.11764411774, 471135.0, 471530.0, 474381.0, 475561.0, 476746.0, 60981.390186098455, 61620.38379616146, 61648.383516164264, 61698.0, 61718.69140654268, 1400.7198560287984, 1477.1580199286518, 1513.4173343262703, 1582.327510807902, 1608.3807734022253, 29988.250293742833, 31461.528077078405, 32687.34625307433, 32764.67235327616, 33333.166670832456, 49016.0, 49476.752616236685, 49540.0, 49614.50385496243, 49645.75177124091, 270304.0, 276894.0, 278716.0, 279148.0, 280079.0, 27166.864165679046, 29564.704352957055, 30039.699603004563, 30497.0, 30819.380352670276, 42931.78534107434, 46605.0, 46838.53161468478, 46996.530034699215, 48028.27957580569, 39038.20634197552, 39558.0, 40039.39940900831, 40289.79855100706, 40720.185596287316, 38118.82424018534, 38894.80552597219, 38994.80502597469, 39318.803405982784, 39402.60597394104, 40982.38526422166, 40988.38517422182, 41633.58366416418, 41760.79119604383, 41808.58191418047, 34865.30269394547, 35256.823715881255, 36273.093172670895, 36681.816590916875, 36781.26437471289, 27590.0, 28068.578971315856, 28253.434931300846, 28365.14904552784, 28414.147575572766], "value": 19519.576549811216, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [434.5393882484569, 441.3566012566265, 442.38729359836617, 443.81501391285263, 447.76193824076415, 18711.3451029214, 18760.718589221156, 19188.71216931747, 20095.59808803823, 20108.798912010876, 19371.709424358647, 19432.805671943275, 19718.605627887435, 19723.5069123272, 19724.408267751955, 5642.492175704186, 5691.886162276763, 5900.88198236035, 5903.793367232148, 5911.083782013773, 4086.4891888513935, 5802.0, 5860.706964651772, 5862.589618726691, 7530.924690753104, 7498.6625601848045, 7503.0, 7513.474056816025, 7519.285667861544, 7532.887006694904, 7239.963800180992, 7474.0, 7624.123225829046, 7636.809079773022, 7637.618119094023, 4686.882827929295, 7070.399016083639, 7377.8155546111775, 7381.0404647396035, 7448.217937116633, 25544.23367298984, 25692.74307256922, 26010.08964686227, 26622.33444163892, 26909.461810763674, 2499.9750002499923, 2561.3340531461768, 2608.321836322551, 2616.2936007278117, 2705.986470067637, 15299.694006119815, 15379.61550961235, 15393.923030384776, 16367.754483682755, 16458.506244812674, 2156.7735387784214, 2162.7945345192184, 2203.823694104484, 2274.226762900622, 2338.298510446859, 87589.0, 89625.0, 90321.54839225828, 91294.5435272826, 93242.06757932402, 17821.465356039338, 18134.637307253783, 18262.0, 18282.89190837561, 18455.630887382176, 34359.96920092401, 34367.0, 34636.0, 34847.0, 34909.301813963575, 11253.66239012831, 11421.885781142082, 11467.197296189353, 11481.311121332747, 11619.825702614467, 9795.853062204073, 9811.558479868423, 9838.26213034011, 9851.753706157404, 9959.452230127412, 9400.15398614128, 9419.434833909987, 9467.289953253534, 9504.38221515613, 9662.420254784736, 3589.6948759355746, 3631.3100510902846, 3730.198007428416, 3748.83130259139, 3826.345839723058, 981.79873126009, 1006.8238058339762, 1041.2143174455693, 1072.1904961753983, 1157.2362240920952, 18066.638667226583, 19614.509637259183, 19775.60448791016, 20026.299079532437, 20041.0, 1036.6112707734599, 1041.03704073733, 1114.6098865397207, 1122.680036189682, 1195.3186683590443, 11098.445077746243, 11250.606228782117, 11343.659690209306, 11381.146414018982, 11425.942870285595, 487834.0, 495440.0, 501119.0, 516867.0, 539287.0, 67031.66484167548, 77280.61359693165, 78787.21212787798, 83587.5820620893, 90352.5482372584, 1115.8772535021303, 1123.8201887697928, 1125.4204084896285, 1128.5485805677795, 1160.0777381981177, 17159.828401716324, 17501.21244543973, 17606.91196544009, 17810.198541065423, 18051.277948882424, 38283.425748613234, 38307.2338553233, 39430.802845985585, 39870.202595948496, 39963.60036399599, 56749.14876276776, 57811.0, 58030.709846450496, 58477.0, 58833.41166588279, 9037.81924361496, 9068.773280668036, 9209.263258939134, 9341.813163736822, 9368.67209647659, 11571.305721656727, 13256.734865302833, 13513.797293040416, 13537.458501659823, 13678.042537022313, 11232.943835280772, 11522.942385288019, 11745.706357341134, 11968.820467692818, 12003.339816309837, 11615.76768464643, 11719.179657423898, 11813.291202527877, 11898.583549575724, 12036.0, 11787.646370608896, 11790.292582445081, 12291.893729564383, 12387.318697471726, 12455.128141030042, 9105.317101217302, 9148.222401095714, 9228.769280768034, 9245.768855778659, 9254.398464099811, 11133.443327833415, 12236.0, 12368.0, 12452.626421207378, 12560.937195313965], "value": 10726.509650441829, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1430.0418719457962, 1557.3303479503813, 1597.8242393336732, 1795.515210893059, 1945.6303302372548, 7808.648610812513, 8355.248027677508, 8535.615897284622, 8550.615222315004, 8561.229489345973, 8314.29328507076, 8451.450655707375, 8476.23713865752, 8493.235608795207, 8508.319334453245, 2417.5648383290954, 2443.657887895696, 2444.3889027743066, 2448.1186772761794, 2453.6442215878687, 2449.960846513344, 2480.0, 2486.6021436570154, 2490.5267999080206, 2510.598304271317, 2420.249722585995, 2439.4145405102736, 2455.238875948453, 2455.9508809823883, 2460.9138680146198, 2289.095807156172, 2299.5171014087064, 2299.678045073691, 2404.4229384947485, 2466.223139711003, 2389.7012873390827, 2448.669429627013, 2460.1020627470843, 2462.2367066209354, 2462.581361168606, 7321.26787321269, 7480.8877866832045, 8712.782180445476, 8748.8687669685, 8761.824763504694, 5277.577793776489, 5339.5461385782255, 5346.251524786533, 5386.111291636915, 5387.622866399353, 3482.460218666111, 3498.177928186874, 3548.183917698944, 3582.8208589570418, 3633.963660363389, 1148.8219326004482, 1155.5098762167543, 1165.3823473559028, 1174.6241202815102, 1182.119321105773, 11605.071594272438, 11850.822237666442, 11871.109666775026, 12158.51365945361, 12238.877611223863, 4757.666963312604, 4850.6362022848425, 4889.850885042012, 4909.189983652657, 4936.7284799336385, 10426.426546539862, 10472.790544189225, 10486.318389304672, 10491.422971736627, 10500.107490863362, 5504.53211477029, 5527.695976721319, 5528.944710552923, 5550.084236101079, 5553.972230138905, 4988.925166122511, 5044.697318160922, 5057.0, 5061.139606266944, 5063.721495317719, 3873.3996230584303, 3970.4242884782125, 3982.104026594051, 4026.355783074694, 4030.717849750489, 1231.9199252048588, 1257.3587470389984, 1257.886790188869, 1270.8792664697023, 1279.609719035703, 1042.9739256518649, 1069.668402795136, 1087.141158484804, 1092.7158938676002, 1099.4777480696605, 6046.395360463918, 6090.056041313604, 6175.752969881244, 6189.226346706661, 6208.50331973441, 466.13299263370106, 476.0336516870758, 477.4557005014286, 477.53917469641965, 485.9757012149378, 3813.1229817141657, 3954.8220330085214, 3972.0, 3992.920141597152, 4021.235965166609, 10374.481275936172, 10747.30142540748, 10822.837657435144, 10848.72878178036, 10901.182411319183, 10537.262391632665, 10729.83905241422, 10749.032587067202, 10755.139588832875, 10767.407792571326, 7847.529148251123, 8279.668813247403, 8317.085120636724, 8317.500949943023, 8400.327973762085, 5964.254468191476, 6037.849053773515, 6042.637441753509, 6174.938250617616, 6179.6910154493, 9369.437833729999, 9614.423134611945, 9665.323427360017, 9688.564014619218, 9711.9028809711, 9884.061014203638, 9896.752581185528, 9962.103410693073, 10102.292839501164, 10116.797664046826, 7627.199144089791, 7705.383569314554, 7708.306252437307, 7756.457048006585, 7796.181400953045, 8394.370422218235, 8432.241098301183, 8490.15098490146, 8521.488710677379, 8544.914550854412, 7560.281773231534, 7563.168051514219, 7694.538327700356, 7733.226677332222, 7752.92247077522, 7613.505122167041, 7655.770326890202, 7713.922860771545, 7785.182555831556, 7835.451518393657, 7119.537230080028, 7153.105861767279, 7284.053073100675, 7313.0, 7316.926830731837, 4502.189605870974, 5228.424873263862, 5326.36083669962, 5333.386660534088, 5432.266644003167, 5214.608904332114, 5232.215167724872, 5268.1834315681135, 5268.894622107613, 5330.9733451332495], "value": 4615.503193030261, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.3904484287027, 364.6535790998551, 365.08298693439394, 367.0859559696356, 370.8590735520502, 6255.530835187362, 6480.189976252968, 6515.478761699064, 6539.084528166055, 6554.279029306785, 6287.4655654269445, 6387.808365749023, 6388.520860935425, 6402.775902843401, 6412.294647588773, 4606.147862645421, 4692.694974826625, 4739.810407583693, 4847.563719265257, 4849.854504364875, 4684.203685373494, 4757.167495688258, 4777.784999675006, 4780.928286075712, 4795.184818580832, 4784.473707892129, 4789.6168306535565, 4790.928136077961, 4792.90414191716, 4804.975975120137, 4584.1519318925775, 4786.1863483207935, 4789.640776941726, 4796.376471058775, 4801.375821143264, 4080.7143499955014, 4157.771322577257, 4164.937525937114, 4166.375043743433, 4176.436181115571, 6077.0, 6078.1186727924205, 6081.239845019372, 6083.939160608382, 6091.451769340736, 5606.103023516259, 5607.158926161109, 5608.523275521586, 5609.691466969315, 5613.578981576357, 6668.86662266752, 6680.5991640501725, 6682.632455214961, 6691.732330706766, 6693.364130407604, 4491.910161796778, 4667.603253723438, 4678.345031695565, 4681.297805329194, 4685.250359942393, 6832.555883867532, 6949.061876646639, 6979.336962988508, 6990.650467476606, 6997.545159564663, 4770.737609431445, 4774.4509381421585, 4775.5224477551965, 4778.761061946889, 4784.856454306377, 4840.273958906122, 4841.080194762983, 4842.854714358575, 4844.636652251095, 4847.103285892122, 5560.666360018412, 5580.995420824291, 5584.162375643686, 5596.104623260258, 5596.300462442195, 6598.769043083469, 6659.2008958925235, 6709.7651582194385, 6719.193696756322, 6720.327967203339, 1675.656490419461, 1685.1068933465283, 1701.140923833456, 1701.1664284500505, 1702.5062731807884, 1100.3178029621527, 1107.8892110788856, 1119.781642579689, 1123.4438952718294, 1124.7413094988199, 6261.0, 6440.323766004502, 6521.869562608721, 6544.8363790905605, 6577.440917521969, 6988.021676965229, 6989.615571143534, 6994.965025174842, 7003.723789768345, 7010.544314619533, 6624.735010599522, 6659.9001014984815, 6660.966695166493, 6661.26726060133, 6667.399934005963, 3712.2204337088974, 3750.456183853326, 3761.605031471711, 3769.7172712046704, 3771.7171212159196, 7145.571265724073, 7237.095363079615, 7281.344678978918, 7300.196978332486, 7309.634518274065, 7077.610731409719, 7105.680244388912, 7106.893396599055, 7112.288771122846, 7125.0, 7249.238829922782, 7271.836506158989, 7275.0, 7281.19906810261, 7292.34368906801, 6959.164900212007, 6962.721491140298, 6963.442924566124, 6977.441804655514, 6978.092847929736, 6710.553834815628, 6773.491988100814, 6813.965930170318, 6824.249332573314, 6864.347886950732, 7236.20401755817, 7251.56490610565, 7259.963700181465, 7287.380572651172, 7292.0, 4751.239801631722, 4753.595944344769, 4759.785809638505, 4760.143174228672, 4761.095391875532, 6925.0, 6925.376716095374, 6944.895826562504, 6949.548279362028, 6949.61777102244, 6612.107365505787, 6678.265390806911, 6715.966420168063, 6726.226483954212, 6738.797836064926, 6686.29793871656, 6705.765298214539, 6726.39462448382, 6727.831804204739, 6738.090357801634, 6598.076269322395, 6599.0, 6602.9009564855605, 6616.371444712745, 6621.470282377302, 6708.496862735412, 6759.087523184307, 6776.457883369417, 6797.354251346114, 6802.761903333359, 6487.481001519962, 6610.8347291318105, 6625.072489851521, 6628.0, 6647.734090636513], "value": 5073.72288845577, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [796.3151689546991, 828.2793969246752, 844.8014716541612, 905.8007238407548, 934.0146145816166, 14935.0, 14961.102333859975, 15057.548273551798, 15115.16866572338, 15151.545453636394, 14217.715645687105, 14300.213488258141, 14312.427502899898, 14366.20985845778, 14464.20446875424, 747.9962600186991, 901.9098090190961, 905.9682911098097, 917.6375331743957, 923.3351986569659, 916.2807196350866, 920.1764420843341, 922.580225997173, 924.7780532672144, 925.4354843545432, 966.8501382285722, 969.6218474794836, 969.7624082099895, 970.1317320997703, 970.553545369131, 786.5634572812087, 945.8392073347547, 955.7658373698488, 956.1251454918742, 956.3496822160928, 696.8884978403431, 700.5306444682025, 701.8315604254942, 702.4801646781397, 702.5012241308677, 14194.574162775134, 14336.42654293827, 14337.42650293987, 14434.783478247835, 14456.494022709154, 14685.926570367079, 15014.324355404033, 15015.324310406058, 15091.773623395658, 15211.163386013764, 11887.762244755057, 11933.105017123664, 11996.0, 12065.879341206562, 12361.196522226026, 4557.202489564313, 4570.977145114253, 4673.532646735333, 4701.576858082789, 4703.459102203256, 59491.10763338597, 60643.69678151581, 61645.38354616441, 61880.69059654718, 62205.0, 10930.56277748881, 11027.83458248127, 11096.61161859331, 11138.164637652208, 11343.205975581795, 20058.89970550138, 20126.0, 20136.597268054556, 20141.798582014286, 20187.596248074955, 8452.366072544584, 8488.660453581911, 8630.39587228888, 8679.696210632597, 8719.215270625675, 4908.141075311806, 4927.556519913225, 4951.183054795918, 5036.748162591855, 5058.266551350107, 3553.271579326232, 3590.3537363274863, 3593.7664051836546, 3600.1899572595958, 3607.1703508193264, 602.3223873142714, 650.6031320894251, 666.0841343153164, 674.5682763031664, 677.915260592426, 695.6730336741723, 730.6018220070075, 734.3097488360924, 741.5550669598198, 755.6372940988247, 9228.446293222429, 9479.76300592477, 9661.806763864683, 9663.710088697351, 9742.0, 566.2949627713441, 679.4021261290034, 690.0955935861771, 727.0294157300063, 731.9304666056822, 4487.6634252431195, 4529.547045295444, 4597.356370108188, 4634.9536504634525, 4667.836625718083, 64597.354026460074, 64934.35065649378, 65046.67476662587, 65098.349016510176, 65301.34698653048, 57101.0, 57964.42035579675, 58973.70513147407, 59564.70217648971, 60601.39398606046, 53978.19032714512, 54412.72793636007, 54858.72570637121, 54946.450535494936, 55904.72047639817, 8854.690085846965, 9042.367034307536, 9046.050164732871, 9167.358284919992, 9259.259259259108, 38520.80739596396, 39612.60387396089, 39753.602463976145, 40120.79939600283, 40220.39669404903, 42575.7871210642, 48083.75958120187, 51317.23024154716, 51398.0, 52203.216951746515, 11355.602553910574, 12008.819867702166, 12028.15802893824, 12145.210561313486, 12186.51253949832, 12760.617181484571, 12919.289439080565, 13496.73006539844, 13626.250556219504, 13995.650108747363, 12123.818142728043, 12198.756024879276, 12347.0, 12421.503139874665, 12427.627171184879, 10864.293820901616, 10886.564537418415, 10897.12822974176, 10967.177461690564, 11105.333679979227, 11873.762524749629, 12045.33750643723, 12059.51761929513, 12090.093243006633, 12457.875421245672, 9907.950460247941, 10343.534540945826, 10764.40795756241, 11106.333619982826, 11420.257683250562, 11318.0, 11330.696969848574, 11510.884891150981, 11572.826407603725, 11951.402429878297], "value": 7083.736761136763, "unit": "score"}], "name": "dromaeo_css", "value": 7603.474601296445, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 109.0, 109.0, 109.0, 109.0, 104.0, 109.0, 110.0, 109.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 141.0, 159.0, 173.0, 125.0, 162.0, 148.0, 134.0, 190.0, 125.0], "value": 151.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 159.0, 159.0, 160.0, 163.0, 160.0, 159.0, 159.0, 160.0], "value": 160.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 73.0, 184.0, 76.0, 75.0, 73.0, 77.0, 161.0, 76.0], "value": 94.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 151.0, 92.0, 92.0, 92.0, 148.0, 92.0, 91.0, 145.0], "value": 108.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 116.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 144.0, 145.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 96.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 55.0, 56.0, 55.0, 57.0, 55.0, 74.0, 55.0, 53.0], "value": 57.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 64.0, 58.0, 58.0, 58.0, 59.0, 58.0, 58.0, 59.0, 58.0], "value": 58.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 71.0, 72.0, 72.0, 73.0, 73.0, 74.0, 73.0, 82.0], "value": 73.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 121.0, 123.0, 113.0, 114.0, 112.0, 111.0, 115.0, 132.0, 113.0], "value": 117.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 157.0, 161.0, 157.0, 157.0, 164.0, 164.0, 158.0, 162.0, 156.0], "value": 160.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 77.0, 65.0, 64.0, 66.0, 66.0, 64.0, 64.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1513.8, "alertThreshold": 2.0}]} 04:04:51 INFO - Return code: 0 04:04:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:04:51 ERROR - # TBPL SUCCESS # 04:04:51 INFO - Running post-action listener: _resource_record_post_action 04:04:51 INFO - Running post-run listener: _resource_record_post_run 04:04:52 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 465178624; Read time: 8; Write time: 327044 04:04:52 INFO - install - Wall time: 13s; CPU: 14.0%; Read bytes: 0; Write bytes: 241745920; Read time: 0; Write time: 203176 04:04:52 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 223432704; Read time: 8; Write time: 123868 04:04:52 INFO - Running post-run listener: _upload_blobber_files 04:04:52 INFO - Blob upload gear active. 04:04:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:04:52 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:04:52 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'] 04:04:52 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 04:04:53 INFO - (blobuploader) - INFO - Open directory for files ... 04:04:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:04:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:04:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:04:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:04:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:04:53 INFO - (blobuploader) - INFO - Done attempting. 04:04:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:04:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:04:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:04:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:04:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:04:54 INFO - (blobuploader) - INFO - Done attempting. 04:04:54 INFO - (blobuploader) - INFO - Iteration through files over. 04:04:54 INFO - Return code: 0 04:04:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:04:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:04:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/31630fbbfe0ce932c241170c872cd24fba80ba3abe5d3864c76021ccbbb42a741d1339d69e017b8f040170a3aee55f485c3b7ccc4f73228dc1c7640e509c8b8a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5a3da4dec188b636e71b6e0d450a6df3714f24d305db72a62399cb331443d4cad24332add170bc78ab1143ba328bb37bd26d4653bae885f6953182fe8aa8a91c"} 04:04:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:04:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:04:54 INFO - Contents: 04:04:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/31630fbbfe0ce932c241170c872cd24fba80ba3abe5d3864c76021ccbbb42a741d1339d69e017b8f040170a3aee55f485c3b7ccc4f73228dc1c7640e509c8b8a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5a3da4dec188b636e71b6e0d450a6df3714f24d305db72a62399cb331443d4cad24332add170bc78ab1143ba328bb37bd26d4653bae885f6953182fe8aa8a91c"} 04:04:54 INFO - Running post-run listener: copy_logs_to_upload_dir 04:04:54 INFO - Copying logs to upload dir... 04:04:54 INFO - mkdir: /builds/slave/test/build/upload/logs 04:04:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.355127 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-06-22 04:04:54.705603) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 04:04:54.708982) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1466592023.86729-176544120 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/31630fbbfe0ce932c241170c872cd24fba80ba3abe5d3864c76021ccbbb42a741d1339d69e017b8f040170a3aee55f485c3b7ccc4f73228dc1c7640e509c8b8a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5a3da4dec188b636e71b6e0d450a6df3714f24d305db72a62399cb331443d4cad24332add170bc78ab1143ba328bb37bd26d4653bae885f6953182fe8aa8a91c"} build_url:https://queue.taskcluster.net/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011418 build_url: 'https://queue.taskcluster.net/v1/task/SK5icZkESsqmqSwIOnmpkQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/31630fbbfe0ce932c241170c872cd24fba80ba3abe5d3864c76021ccbbb42a741d1339d69e017b8f040170a3aee55f485c3b7ccc4f73228dc1c7640e509c8b8a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5a3da4dec188b636e71b6e0d450a6df3714f24d305db72a62399cb331443d4cad24332add170bc78ab1143ba328bb37bd26d4653bae885f6953182fe8aa8a91c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 04:04:54.735221) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 04:04:54.735557) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1466592023.86729-176544120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004552 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 04:04:54.820208) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 04:04:54.820899) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 04:04:54.821515) ========= ========= Total master_lag: 0.18 =========