builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1460734975.38 results: success (0) buildid: 20160415055421 builduid: 74db4086b7e8498db1707ec0409ecba3 revision: f1631a25825bc0da92bbc8dcca350bcd893edfe0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 08:42:55.380025) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 08:42:55.380501) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 08:42:55.380773) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 08:42:55.396569) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 08:42:55.396840) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1460734974.766806-367780479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-15 08:42:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 112M=0s 2016-04-15 08:42:55 (112 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117046 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 08:42:55.526977) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 08:42:55.527289) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1460734974.766806-367780479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022278 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 08:42:55.576728) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 08:42:55.577086) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev f1631a25825bc0da92bbc8dcca350bcd893edfe0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev f1631a25825bc0da92bbc8dcca350bcd893edfe0 --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=edae0fb5fee9fb758e8af6d3000002a4-1460734974.766806-367780479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-15 08:42:55,659 truncating revision to first 12 chars 2016-04-15 08:42:55,660 Setting DEBUG logging. 2016-04-15 08:42:55,660 attempt 1/10 2016-04-15 08:42:55,660 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/f1631a25825b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-15 08:42:55,881 unpacking tar archive at: mozilla-inbound-f1631a25825b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.481602 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 08:42:56.072513) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 08:42:56.072836) ========= script_repo_revision: f1631a25825bc0da92bbc8dcca350bcd893edfe0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 08:42:56.073231) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 08:42:56.073496) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 08:42:56.083627) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 33 secs) (at 2016-04-15 08:42:56.083896) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=edae0fb5fee9fb758e8af6d3000002a4-1460734974.766806-367780479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:42:56 INFO - MultiFileLogger online at 20160415 08:42:56 in /builds/slave/test 08:42:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 08:42:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:42:56 INFO - {'append_to_log': False, 08:42:56 INFO - 'base_work_dir': '/builds/slave/test', 08:42:56 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 08:42:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:42:56 INFO - 'branch': 'Mozilla-Inbound', 08:42:56 INFO - 'buildbot_json_path': 'buildprops.json', 08:42:56 INFO - 'config_files': ('talos/linux_config.py',), 08:42:56 INFO - 'default_actions': ('clobber', 08:42:56 INFO - 'read-buildbot-config', 08:42:56 INFO - 'download-and-extract', 08:42:56 INFO - 'populate-webroot', 08:42:56 INFO - 'create-virtualenv', 08:42:56 INFO - 'install', 08:42:56 INFO - 'run-tests'), 08:42:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:42:56 INFO - 'download_minidump_stackwalk': True, 08:42:56 INFO - 'download_symbols': 'ondemand', 08:42:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:42:56 INFO - 'tooltool.py': '/tools/tooltool.py', 08:42:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:42:56 INFO - '/tools/misc-python/virtualenv.py')}, 08:42:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:42:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:42:56 INFO - 'installer_path': 'installer.exe', 08:42:56 INFO - 'log_level': 'info', 08:42:56 INFO - 'log_name': 'talos', 08:42:56 INFO - 'log_to_console': True, 08:42:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:42:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:42:56 INFO - 'opt_config_files': (), 08:42:56 INFO - 'pip_index': False, 08:42:56 INFO - 'sps_profile': False, 08:42:56 INFO - 'sps_profile_interval': 0, 08:42:56 INFO - 'suite': 'dromaeojs', 08:42:56 INFO - 'system_bits': '32', 08:42:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:42:56 INFO - 'title': 'talos-linux64-ix-033', 08:42:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:42:56 INFO - 'use_talos_json': True, 08:42:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:42:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:42:56 INFO - 'work_dir': 'build'} 08:42:56 INFO - ##### 08:42:56 INFO - ##### Running clobber step. 08:42:56 INFO - ##### 08:42:56 INFO - Running pre-action listener: _resource_record_pre_action 08:42:56 INFO - Running main action method: clobber 08:42:56 INFO - rmtree: /builds/slave/test/build 08:42:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:42:56 INFO - Running post-action listener: _resource_record_post_action 08:42:56 INFO - ##### 08:42:56 INFO - ##### Running read-buildbot-config step. 08:42:56 INFO - ##### 08:42:56 INFO - Running pre-action listener: _resource_record_pre_action 08:42:56 INFO - Running main action method: read_buildbot_config 08:42:56 INFO - Using buildbot properties: 08:42:56 INFO - { 08:42:56 INFO - "project": "", 08:42:56 INFO - "product": "firefox", 08:42:56 INFO - "script_repo_revision": "production", 08:42:56 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 08:42:56 INFO - "repository": "", 08:42:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 08:42:56 INFO - "buildid": "20160415055421", 08:42:56 INFO - "pgo_build": "True", 08:42:56 INFO - "basedir": "/builds/slave/test", 08:42:56 INFO - "buildnumber": 876, 08:42:56 INFO - "slavename": "talos-linux64-ix-033", 08:42:56 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:42:56 INFO - "platform": "ubuntu64_hw", 08:42:56 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 08:42:56 INFO - "branch": "mozilla-inbound", 08:42:56 INFO - "repo_path": "integration/mozilla-inbound", 08:42:56 INFO - "revision": "f1631a25825bc0da92bbc8dcca350bcd893edfe0", 08:42:56 INFO - "stage_platform": "linux64-pgo", 08:42:56 INFO - "builduid": "74db4086b7e8498db1707ec0409ecba3", 08:42:56 INFO - "slavebuilddir": "test" 08:42:56 INFO - } 08:42:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/VONXSUoCSDuWKx8eztikbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 08:42:56 INFO - Running post-action listener: _resource_record_post_action 08:42:56 INFO - ##### 08:42:56 INFO - ##### Running download-and-extract step. 08:42:56 INFO - ##### 08:42:56 INFO - Running pre-action listener: _resource_record_pre_action 08:42:56 INFO - Running main action method: download_and_extract 08:42:56 INFO - mkdir: /builds/slave/test/build/tests 08:42: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')]} 08:42:56 INFO - https://queue.taskcluster.net/v1/task/VONXSUoCSDuWKx8eztikbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:42:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VONXSUoCSDuWKx8eztikbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:42:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VONXSUoCSDuWKx8eztikbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:42:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VONXSUoCSDuWKx8eztikbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:42:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VONXSUoCSDuWKx8eztikbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:42:57 INFO - Downloaded 1361 bytes. 08:42:57 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:42:57 INFO - Using the following test package requirements: 08:42:57 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:42:57 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:42:57 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:42:57 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:42:57 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:42:57 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:42:57 INFO - u'jsshell-linux-x86_64.zip'], 08:42:57 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:42:57 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:42:57 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:42:57 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:42:57 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:42:57 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:42:57 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:42:57 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:42:57 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:42:57 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:42:57 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:42:57 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:42:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:57 INFO - https://queue.taskcluster.net/v1/task/VONXSUoCSDuWKx8eztikbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:42:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VONXSUoCSDuWKx8eztikbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:42:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VONXSUoCSDuWKx8eztikbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:42:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VONXSUoCSDuWKx8eztikbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:42:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VONXSUoCSDuWKx8eztikbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:42:58 INFO - Downloaded 23765084 bytes. 08:42:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:42:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:42:59 INFO - Return code: 0 08:42:59 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:42:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:59 INFO - https://queue.taskcluster.net/v1/task/VONXSUoCSDuWKx8eztikbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:42:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VONXSUoCSDuWKx8eztikbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:42:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VONXSUoCSDuWKx8eztikbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:42:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VONXSUoCSDuWKx8eztikbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:42:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VONXSUoCSDuWKx8eztikbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:43:00 INFO - Downloaded 23765084 bytes. 08:43:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:43:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:43:03 INFO - Return code: 0 08:43: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')]} 08:43:03 INFO - https://queue.taskcluster.net/v1/task/VONXSUoCSDuWKx8eztikbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:43:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VONXSUoCSDuWKx8eztikbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:43:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VONXSUoCSDuWKx8eztikbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:43:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VONXSUoCSDuWKx8eztikbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:43:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VONXSUoCSDuWKx8eztikbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:43:04 INFO - Downloaded 10841076 bytes. 08:43:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:43:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:43:04 INFO - Return code: 0 08:43:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:04 INFO - https://queue.taskcluster.net/v1/task/VONXSUoCSDuWKx8eztikbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:43:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VONXSUoCSDuWKx8eztikbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:43:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VONXSUoCSDuWKx8eztikbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:43:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VONXSUoCSDuWKx8eztikbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:43:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VONXSUoCSDuWKx8eztikbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:43:06 INFO - Downloaded 57848651 bytes. 08:43:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VONXSUoCSDuWKx8eztikbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:43:06 INFO - mkdir: /builds/slave/test/properties 08:43:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:43:06 INFO - Writing to file /builds/slave/test/properties/build_url 08:43:06 INFO - Contents: 08:43:06 INFO - build_url:https://queue.taskcluster.net/v1/task/VONXSUoCSDuWKx8eztikbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:43:06 INFO - Running post-action listener: _resource_record_post_action 08:43:06 INFO - Running post-action listener: set_extra_try_arguments 08:43:06 INFO - ##### 08:43:06 INFO - ##### Running populate-webroot step. 08:43:06 INFO - ##### 08:43:06 INFO - Running pre-action listener: _resource_record_pre_action 08:43:06 INFO - Running main action method: populate_webroot 08:43:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:43:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:43:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:43:06 INFO - '--tppagecycles', 08:43:06 INFO - '7'], 08:43:06 INFO - 'tests': ['tsvgm']}}, 08:43:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:43:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:43:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:43:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:43:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:43:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:43:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:06 INFO - 'talos_options': ['--disable-e10s'], 08:43:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:43:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:43:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:06 INFO - 'talos_options': ['--disable-e10s'], 08:43:06 INFO - 'tests': ['damp', 'tps']}, 08:43:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:06 INFO - 'tests': ['damp', 'tps']}, 08:43:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:43:06 INFO - 'tests': ['dromaeo_dom']}, 08:43:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:43:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:43:06 INFO - 'tests': ['a11yr', 08:43:06 INFO - 'ts_paint', 08:43:06 INFO - 'tpaint', 08:43:06 INFO - 'sessionrestore', 08:43:06 INFO - 'sessionrestore_no_auto_restore', 08:43:06 INFO - 'tabpaint']}, 08:43:06 INFO - 'other-e10s': {'tests': ['a11yr', 08:43:06 INFO - 'ts_paint', 08:43:06 INFO - 'tpaint', 08:43:06 INFO - 'sessionrestore', 08:43:06 INFO - 'sessionrestore_no_auto_restore', 08:43:06 INFO - 'tabpaint']}, 08:43:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:43:06 INFO - 'ts_paint', 08:43:06 INFO - 'tpaint', 08:43:06 INFO - 'sessionrestore', 08:43:06 INFO - 'sessionrestore_no_auto_restore', 08:43:06 INFO - 'tabpaint']}, 08:43:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:43:06 INFO - 'ts_paint', 08:43:06 INFO - 'tpaint', 08:43:06 INFO - 'sessionrestore', 08:43:06 INFO - 'sessionrestore_no_auto_restore', 08:43:06 INFO - 'tabpaint']}, 08:43:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:43:06 INFO - 'tests': ['a11yr', 08:43:06 INFO - 'ts_paint', 08:43:06 INFO - 'tpaint', 08:43:06 INFO - 'sessionrestore', 08:43:06 INFO - 'sessionrestore_no_auto_restore', 08:43:06 INFO - 'tabpaint']}, 08:43:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:43:06 INFO - 'tests': ['a11yr', 08:43:06 INFO - 'ts_paint', 08:43:06 INFO - 'tpaint', 08:43:06 INFO - 'sessionrestore', 08:43:06 INFO - 'sessionrestore_no_auto_restore', 08:43:06 INFO - 'tabpaint']}, 08:43:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:43:06 INFO - 'tests': ['tsvgx', 08:43:06 INFO - 'tsvgr_opacity', 08:43:06 INFO - 'tart', 08:43:06 INFO - 'tscrollx', 08:43:06 INFO - 'cart']}, 08:43:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:43:06 INFO - 'tsvgr_opacity', 08:43:06 INFO - 'tart', 08:43:06 INFO - 'tscrollx', 08:43:06 INFO - 'cart']}, 08:43:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:06 INFO - 'talos_options': ['--disable-e10s'], 08:43:06 INFO - 'tests': ['tp5o']}, 08:43:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:06 INFO - 'tests': ['tp5o']}, 08:43:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:06 INFO - 'talos_options': ['--disable-e10s', 08:43:06 INFO - '--xperf_path', 08:43:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:43:06 INFO - 'tests': ['tp5n']}, 08:43:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:06 INFO - 'talos_options': ['--xperf_path', 08:43:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:43:06 INFO - 'tests': ['tp5n']}}, 08:43:06 INFO - 'talos.zip': {'path': '', 08:43:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:43:06 INFO - Running post-action listener: _resource_record_post_action 08:43:06 INFO - ##### 08:43:06 INFO - ##### Running create-virtualenv step. 08:43:06 INFO - ##### 08:43:06 INFO - Running pre-action listener: _resource_record_pre_action 08:43:06 INFO - Running main action method: create_virtualenv 08:43:06 INFO - Creating virtualenv /builds/slave/test/build/venv 08:43:06 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 08:43:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:43:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:43:07 INFO - Using real prefix '/usr' 08:43:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:43:07 INFO - Installing distribute.............................................................................................................................................................................................done. 08:43:09 INFO - Installing pip.................done. 08:43:09 INFO - Return code: 0 08:43:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:43:09 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')]} 08:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:09 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')]} 08:43:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:09 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 0x7f71c94dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1982410>, '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 0x1983310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19837a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1460734974.766806-367780479', '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 08:43:09 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 08:43:09 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 08:43:09 INFO - Using env: {'DISPLAY': ':0', 08:43:09 INFO - 'HOME': '/home/cltbld', 08:43:09 INFO - 'LANG': 'en_US.UTF-8', 08:43:09 INFO - 'LANGUAGE': 'en_US:en', 08:43:09 INFO - 'LOGNAME': 'cltbld', 08:43:09 INFO - 'MAIL': '/var/mail/cltbld', 08:43:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:09 INFO - 'MOZ_NO_REMOTE': '1', 08:43:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:09 INFO - 'NO_EM_RESTART': '1', 08:43:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:09 INFO - 'PWD': '/builds/slave/test', 08:43:09 INFO - 'SHELL': '/bin/bash', 08:43:09 INFO - 'SHLVL': '1', 08:43:09 INFO - 'TERM': 'linux', 08:43:09 INFO - 'TMOUT': '86400', 08:43:09 INFO - 'USER': 'cltbld', 08:43:09 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1460734974.766806-367780479', 08:43:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:09 INFO - '_': '/tools/buildbot/bin/python'} 08:43:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:09 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 08:43:09 INFO - Cleaning up... 08:43:09 INFO - Return code: 0 08:43:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:43:09 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')]} 08:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:09 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')]} 08:43:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:09 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 0x7f71c94dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1982410>, '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 0x1983310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19837a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1460734974.766806-367780479', '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 08:43:09 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 08:43:09 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 08:43:09 INFO - Using env: {'DISPLAY': ':0', 08:43:09 INFO - 'HOME': '/home/cltbld', 08:43:09 INFO - 'LANG': 'en_US.UTF-8', 08:43:09 INFO - 'LANGUAGE': 'en_US:en', 08:43:09 INFO - 'LOGNAME': 'cltbld', 08:43:09 INFO - 'MAIL': '/var/mail/cltbld', 08:43:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:09 INFO - 'MOZ_NO_REMOTE': '1', 08:43:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:09 INFO - 'NO_EM_RESTART': '1', 08:43:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:09 INFO - 'PWD': '/builds/slave/test', 08:43:09 INFO - 'SHELL': '/bin/bash', 08:43:09 INFO - 'SHLVL': '1', 08:43:09 INFO - 'TERM': 'linux', 08:43:09 INFO - 'TMOUT': '86400', 08:43:09 INFO - 'USER': 'cltbld', 08:43:09 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1460734974.766806-367780479', 08:43:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:09 INFO - '_': '/tools/buildbot/bin/python'} 08:43:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:09 INFO - Downloading/unpacking psutil>=0.7.1 08:43:09 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 08:43:09 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 08:43:09 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 08:43:09 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 08:43:09 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 08:43:09 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 08:43:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:43:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:43:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:43:11 INFO - Installing collected packages: psutil 08:43:11 INFO - Running setup.py install for psutil 08:43:11 INFO - building 'psutil._psutil_linux' extension 08:43:11 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 08:43:12 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 08:43:12 INFO - building 'psutil._psutil_posix' extension 08:43:12 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 08:43:12 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 08:43:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:43:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:43:12 INFO - Successfully installed psutil 08:43:12 INFO - Cleaning up... 08:43:12 INFO - Return code: 0 08:43:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:43:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f71c94dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1982410>, '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 0x1983310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19837a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1460734974.766806-367780479', '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 08:43:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:43:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:43:12 INFO - Using env: {'DISPLAY': ':0', 08:43:12 INFO - 'HOME': '/home/cltbld', 08:43:12 INFO - 'LANG': 'en_US.UTF-8', 08:43:12 INFO - 'LANGUAGE': 'en_US:en', 08:43:12 INFO - 'LOGNAME': 'cltbld', 08:43:12 INFO - 'MAIL': '/var/mail/cltbld', 08:43:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:12 INFO - 'MOZ_NO_REMOTE': '1', 08:43:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:12 INFO - 'NO_EM_RESTART': '1', 08:43:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:12 INFO - 'PWD': '/builds/slave/test', 08:43:12 INFO - 'SHELL': '/bin/bash', 08:43:12 INFO - 'SHLVL': '1', 08:43:12 INFO - 'TERM': 'linux', 08:43:12 INFO - 'TMOUT': '86400', 08:43:12 INFO - 'USER': 'cltbld', 08:43:12 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1460734974.766806-367780479', 08:43:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:12 INFO - '_': '/tools/buildbot/bin/python'} 08:43:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:43:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:43:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:43:14 INFO - Installing collected packages: mozsystemmonitor 08:43:14 INFO - Running setup.py install for mozsystemmonitor 08:43:14 INFO - Successfully installed mozsystemmonitor 08:43:14 INFO - Cleaning up... 08:43:14 INFO - Return code: 0 08:43:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:43:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f71c94dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1982410>, '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 0x1983310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19837a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1460734974.766806-367780479', '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 08:43:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:43:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:43:14 INFO - Using env: {'DISPLAY': ':0', 08:43:14 INFO - 'HOME': '/home/cltbld', 08:43:14 INFO - 'LANG': 'en_US.UTF-8', 08:43:14 INFO - 'LANGUAGE': 'en_US:en', 08:43:14 INFO - 'LOGNAME': 'cltbld', 08:43:14 INFO - 'MAIL': '/var/mail/cltbld', 08:43:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:14 INFO - 'MOZ_NO_REMOTE': '1', 08:43:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:14 INFO - 'NO_EM_RESTART': '1', 08:43:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:14 INFO - 'PWD': '/builds/slave/test', 08:43:14 INFO - 'SHELL': '/bin/bash', 08:43:14 INFO - 'SHLVL': '1', 08:43:14 INFO - 'TERM': 'linux', 08:43:14 INFO - 'TMOUT': '86400', 08:43:14 INFO - 'USER': 'cltbld', 08:43:14 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1460734974.766806-367780479', 08:43:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:14 INFO - '_': '/tools/buildbot/bin/python'} 08:43:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:14 INFO - Downloading/unpacking blobuploader==1.2.4 08:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:16 INFO - Downloading blobuploader-1.2.4.tar.gz 08:43:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:43:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:43:16 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 08:43:16 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 08:43:16 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 08:43:16 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 08:43:16 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 08:43:16 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 08:43:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:43:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:43:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:17 INFO - Downloading docopt-0.6.1.tar.gz 08:43:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:43:17 INFO - Installing collected packages: blobuploader, requests, docopt 08:43:17 INFO - Running setup.py install for blobuploader 08:43:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:43:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:43:17 INFO - Running setup.py install for requests 08:43:18 INFO - Running setup.py install for docopt 08:43:18 INFO - Successfully installed blobuploader requests docopt 08:43:18 INFO - Cleaning up... 08:43:18 INFO - Return code: 0 08:43:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:43:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:18 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 0x7f71c94dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1982410>, '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 0x1983310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19837a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1460734974.766806-367780479', '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 08:43:18 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 08:43:18 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 08:43:18 INFO - Using env: {'DISPLAY': ':0', 08:43:18 INFO - 'HOME': '/home/cltbld', 08:43:18 INFO - 'LANG': 'en_US.UTF-8', 08:43:18 INFO - 'LANGUAGE': 'en_US:en', 08:43:18 INFO - 'LOGNAME': 'cltbld', 08:43:18 INFO - 'MAIL': '/var/mail/cltbld', 08:43:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:18 INFO - 'MOZ_NO_REMOTE': '1', 08:43:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:18 INFO - 'NO_EM_RESTART': '1', 08:43:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:18 INFO - 'PWD': '/builds/slave/test', 08:43:18 INFO - 'SHELL': '/bin/bash', 08:43:18 INFO - 'SHLVL': '1', 08:43:18 INFO - 'TERM': 'linux', 08:43:18 INFO - 'TMOUT': '86400', 08:43:18 INFO - 'USER': 'cltbld', 08:43:18 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1460734974.766806-367780479', 08:43:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:18 INFO - '_': '/tools/buildbot/bin/python'} 08:43:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:43:18 INFO - Running setup.py (path:/tmp/pip-ywYbB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:43:18 INFO - Running setup.py (path:/tmp/pip-Emrv98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:43:18 INFO - Running setup.py (path:/tmp/pip-3ftwj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:43:18 INFO - Running setup.py (path:/tmp/pip-VPn9Sn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:43:18 INFO - Running setup.py (path:/tmp/pip-IdSAzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:43:18 INFO - Running setup.py (path:/tmp/pip-83Osjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:43:18 INFO - Running setup.py (path:/tmp/pip-BMQTvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:43:18 INFO - Running setup.py (path:/tmp/pip-aCm6Xf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:43:18 INFO - Running setup.py (path:/tmp/pip-EcYq6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:43:19 INFO - Running setup.py (path:/tmp/pip-HiHuOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:43:19 INFO - Running setup.py (path:/tmp/pip-MPZLAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:43:19 INFO - Running setup.py (path:/tmp/pip-YO_lJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:43:19 INFO - Running setup.py (path:/tmp/pip-NB3HKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:43:19 INFO - Running setup.py (path:/tmp/pip-2SofbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:43:19 INFO - Running setup.py (path:/tmp/pip-SBaooB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:43:19 INFO - Running setup.py (path:/tmp/pip-TlH_xf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:43:19 INFO - Running setup.py (path:/tmp/pip-GOUD6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:43:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:43:19 INFO - Running setup.py install for manifestparser 08:43:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:43:19 INFO - Running setup.py install for mozcrash 08:43:19 INFO - Running setup.py install for mozdebug 08:43:19 INFO - Running setup.py install for mozdevice 08:43:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:43:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:43:20 INFO - Running setup.py install for mozfile 08:43:20 INFO - Running setup.py install for mozhttpd 08:43:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:43:20 INFO - Running setup.py install for mozinfo 08:43:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:43:20 INFO - Running setup.py install for mozInstall 08:43:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:43:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:43:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:43:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:43:20 INFO - Running setup.py install for mozleak 08:43:20 INFO - Running setup.py install for mozlog 08:43:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:43:20 INFO - Running setup.py install for moznetwork 08:43:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:43:20 INFO - Running setup.py install for mozprocess 08:43:20 INFO - Running setup.py install for mozprofile 08:43:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:43:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:43:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:43:20 INFO - Running setup.py install for mozrunner 08:43:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:43:21 INFO - Running setup.py install for mozscreenshot 08:43:21 INFO - Running setup.py install for moztest 08:43:21 INFO - Running setup.py install for mozversion 08:43:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:43:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:43:21 INFO - Cleaning up... 08:43:21 INFO - Return code: 0 08:43:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:43:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:21 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 0x7f71c94dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1982410>, '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 0x1983310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19837a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1460734974.766806-367780479', '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 08:43:21 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 08:43:21 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 08:43:21 INFO - Using env: {'DISPLAY': ':0', 08:43:21 INFO - 'HOME': '/home/cltbld', 08:43:21 INFO - 'LANG': 'en_US.UTF-8', 08:43:21 INFO - 'LANGUAGE': 'en_US:en', 08:43:21 INFO - 'LOGNAME': 'cltbld', 08:43:21 INFO - 'MAIL': '/var/mail/cltbld', 08:43:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:21 INFO - 'MOZ_NO_REMOTE': '1', 08:43:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:21 INFO - 'NO_EM_RESTART': '1', 08:43:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:21 INFO - 'PWD': '/builds/slave/test', 08:43:21 INFO - 'SHELL': '/bin/bash', 08:43:21 INFO - 'SHLVL': '1', 08:43:21 INFO - 'TERM': 'linux', 08:43:21 INFO - 'TMOUT': '86400', 08:43:21 INFO - 'USER': 'cltbld', 08:43:21 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1460734974.766806-367780479', 08:43:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:21 INFO - '_': '/tools/buildbot/bin/python'} 08:43:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:43:21 INFO - Running setup.py (path:/tmp/pip-5QzBdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:43:21 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)) 08:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:43:21 INFO - Running setup.py (path:/tmp/pip-ZCDGLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:43:21 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)) 08:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:43:21 INFO - Running setup.py (path:/tmp/pip-4SfG24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:43:21 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)) 08:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:43:21 INFO - Running setup.py (path:/tmp/pip-pWNX5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:43:21 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)) 08:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:43:21 INFO - Running setup.py (path:/tmp/pip-nakeia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:43:21 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)) 08:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:43:21 INFO - Running setup.py (path:/tmp/pip-Eokjc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:43:22 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)) 08:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:43:22 INFO - Running setup.py (path:/tmp/pip-kovtun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:43:22 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)) 08:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:43:22 INFO - Running setup.py (path:/tmp/pip-80_2RG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:43:22 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)) 08:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:43:22 INFO - Running setup.py (path:/tmp/pip-EKtxdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:43:22 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)) 08:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:43:22 INFO - Running setup.py (path:/tmp/pip-cDv3YS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:43:22 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)) 08:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:43:22 INFO - Running setup.py (path:/tmp/pip-C8bCFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:43:22 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)) 08:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:43:22 INFO - Running setup.py (path:/tmp/pip-qcYDtQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:43:22 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)) 08:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:43:22 INFO - Running setup.py (path:/tmp/pip-7O1Hi9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:43:22 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)) 08:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:43:22 INFO - Running setup.py (path:/tmp/pip-Y7RoMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:43:22 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)) 08:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:43:22 INFO - Running setup.py (path:/tmp/pip-hvSJ5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:43:22 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)) 08:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:43:22 INFO - Running setup.py (path:/tmp/pip-CAzLEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:43:22 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)) 08:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:43:22 INFO - Running setup.py (path:/tmp/pip-bpEkeY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:43:22 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)) 08:43:22 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)) 08:43:22 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)) 08:43:22 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)) 08:43:22 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)) 08:43:22 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)) 08:43:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:43:22 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 08:43:22 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 08:43:22 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 08:43:22 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 08:43:22 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 08:43:22 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 08:43:24 INFO - Downloading blessings-1.6.tar.gz 08:43:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:43:24 INFO - Installing collected packages: blessings 08:43:24 INFO - Running setup.py install for blessings 08:43:24 INFO - Successfully installed blessings 08:43:24 INFO - Cleaning up... 08:43:24 INFO - Return code: 0 08:43:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:43:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:43:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:43:25 INFO - Reading from file tmpfile_stdout 08:43:25 INFO - Current package versions: 08:43:25 INFO - argparse == 1.2.1 08:43:25 INFO - blessings == 1.6 08:43:25 INFO - blobuploader == 1.2.4 08:43:25 INFO - docopt == 0.6.1 08:43:25 INFO - manifestparser == 1.1 08:43:25 INFO - mozInstall == 1.12 08:43:25 INFO - mozcrash == 0.17 08:43:25 INFO - mozdebug == 0.1 08:43:25 INFO - mozdevice == 0.48 08:43:25 INFO - mozfile == 1.2 08:43:25 INFO - mozhttpd == 0.7 08:43:25 INFO - mozinfo == 0.9 08:43:25 INFO - mozleak == 0.1 08:43:25 INFO - mozlog == 3.1 08:43:25 INFO - moznetwork == 0.27 08:43:25 INFO - mozprocess == 0.22 08:43:25 INFO - mozprofile == 0.28 08:43:25 INFO - mozrunner == 6.11 08:43:25 INFO - mozscreenshot == 0.1 08:43:25 INFO - mozsystemmonitor == 0.0 08:43:25 INFO - moztest == 0.7 08:43:25 INFO - mozversion == 1.4 08:43:25 INFO - psutil == 3.1.1 08:43:25 INFO - requests == 1.2.3 08:43:25 INFO - wsgiref == 0.1.2 08:43:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:43:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:25 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 0x7f71c94dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1982410>, '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 0x1983310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19837a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1460734974.766806-367780479', '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 08:43:25 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 08:43:25 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 08:43:25 INFO - Using env: {'DISPLAY': ':0', 08:43:25 INFO - 'HOME': '/home/cltbld', 08:43:25 INFO - 'LANG': 'en_US.UTF-8', 08:43:25 INFO - 'LANGUAGE': 'en_US:en', 08:43:25 INFO - 'LOGNAME': 'cltbld', 08:43:25 INFO - 'MAIL': '/var/mail/cltbld', 08:43:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:25 INFO - 'MOZ_NO_REMOTE': '1', 08:43:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:25 INFO - 'NO_EM_RESTART': '1', 08:43:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:25 INFO - 'PWD': '/builds/slave/test', 08:43:25 INFO - 'SHELL': '/bin/bash', 08:43:25 INFO - 'SHLVL': '1', 08:43:25 INFO - 'TERM': 'linux', 08:43:25 INFO - 'TMOUT': '86400', 08:43:25 INFO - 'USER': 'cltbld', 08:43:25 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1460734974.766806-367780479', 08:43:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:25 INFO - '_': '/tools/buildbot/bin/python'} 08:43:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:25 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)) 08:43:25 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)) 08:43:25 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)) 08:43:25 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)) 08:43:25 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)) 08:43:25 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)) 08:43:25 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)) 08:43:25 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)) 08:43:25 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)) 08:43:25 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)) 08:43:25 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)) 08:43:25 INFO - Cleaning up... 08:43:25 INFO - Return code: 0 08:43:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:43:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:25 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 0x7f71c94dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1982410>, '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 0x1983310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19837a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1460734974.766806-367780479', '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 08:43:25 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 08:43:25 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 08:43:25 INFO - Using env: {'DISPLAY': ':0', 08:43:25 INFO - 'HOME': '/home/cltbld', 08:43:25 INFO - 'LANG': 'en_US.UTF-8', 08:43:25 INFO - 'LANGUAGE': 'en_US:en', 08:43:25 INFO - 'LOGNAME': 'cltbld', 08:43:25 INFO - 'MAIL': '/var/mail/cltbld', 08:43:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:25 INFO - 'MOZ_NO_REMOTE': '1', 08:43:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:25 INFO - 'NO_EM_RESTART': '1', 08:43:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:25 INFO - 'PWD': '/builds/slave/test', 08:43:25 INFO - 'SHELL': '/bin/bash', 08:43:25 INFO - 'SHLVL': '1', 08:43:25 INFO - 'TERM': 'linux', 08:43:25 INFO - 'TMOUT': '86400', 08:43:25 INFO - 'USER': 'cltbld', 08:43:25 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1460734974.766806-367780479', 08:43:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:25 INFO - '_': '/tools/buildbot/bin/python'} 08:43:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:25 INFO - Downloading/unpacking jsonschema 08:43:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:43:27 INFO - Downloading/unpacking functools32 (from jsonschema) 08:43:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:27 INFO - Downloading functools32-3.2.3-2.tar.gz 08:43:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:43:27 INFO - warning: no files found matching '*.txt' 08:43:27 INFO - no previously-included directories found matching 'build' 08:43:27 INFO - no previously-included directories found matching 'dist' 08:43:27 INFO - no previously-included directories found matching '.git*' 08:43:27 INFO - Installing collected packages: jsonschema, functools32 08:43:27 INFO - Running setup.py install for functools32 08:43:27 INFO - warning: no files found matching '*.txt' 08:43:27 INFO - no previously-included directories found matching 'build' 08:43:27 INFO - no previously-included directories found matching 'dist' 08:43:27 INFO - no previously-included directories found matching '.git*' 08:43:27 INFO - Successfully installed jsonschema functools32 08:43:27 INFO - Cleaning up... 08:43:27 INFO - Return code: 0 08:43:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:43: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')]} 08:43:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43: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')]} 08:43:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:27 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 0x7f71c94dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1982410>, '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 0x1983310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19837a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1460734974.766806-367780479', '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 08:43:27 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 08:43:27 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 08:43:27 INFO - Using env: {'DISPLAY': ':0', 08:43:27 INFO - 'HOME': '/home/cltbld', 08:43:27 INFO - 'LANG': 'en_US.UTF-8', 08:43:27 INFO - 'LANGUAGE': 'en_US:en', 08:43:27 INFO - 'LOGNAME': 'cltbld', 08:43:27 INFO - 'MAIL': '/var/mail/cltbld', 08:43:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:27 INFO - 'MOZ_NO_REMOTE': '1', 08:43:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:27 INFO - 'NO_EM_RESTART': '1', 08:43:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:27 INFO - 'PWD': '/builds/slave/test', 08:43:27 INFO - 'SHELL': '/bin/bash', 08:43:27 INFO - 'SHLVL': '1', 08:43:27 INFO - 'TERM': 'linux', 08:43:27 INFO - 'TMOUT': '86400', 08:43:27 INFO - 'USER': 'cltbld', 08:43:27 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1460734974.766806-367780479', 08:43:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:27 INFO - '_': '/tools/buildbot/bin/python'} 08:43:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:28 INFO - Downloading/unpacking flake8 08:43:28 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 08:43:28 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 08:43:28 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 08:43:28 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 08:43:28 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 08:43:28 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 08:43:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:43:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:43:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:43:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:43:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:43:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:43:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:43:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:43:30 INFO - no previously-included directories found matching 'docs/_build' 08:43:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:43:30 INFO - Running setup.py install for pep8 08:43:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:43:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:43:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:43:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:43:30 INFO - no previously-included directories found matching 'docs/_build' 08:43:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:43:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:43:30 INFO - Cleaning up... 08:43:30 INFO - Return code: 0 08:43:30 INFO - Running post-action listener: _resource_record_post_action 08:43:30 INFO - Running post-action listener: _start_resource_monitoring 08:43:30 INFO - Starting resource monitoring. 08:43:30 INFO - ##### 08:43:30 INFO - ##### Running install step. 08:43:30 INFO - ##### 08:43:30 INFO - Running pre-action listener: _resource_record_pre_action 08:43:30 INFO - Running main action method: install 08:43:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:43:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:43:31 INFO - Reading from file tmpfile_stdout 08:43:31 INFO - Detecting whether we're running mozinstall >=1.0... 08:43:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:43:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:43:31 INFO - Reading from file tmpfile_stdout 08:43:31 INFO - Output received: 08:43:31 INFO - Usage: mozinstall [options] installer 08:43:31 INFO - Options: 08:43:31 INFO - -h, --help show this help message and exit 08:43:31 INFO - -d DEST, --destination=DEST 08:43:31 INFO - Directory to install application into. [default: 08:43:31 INFO - "/builds/slave/test"] 08:43:31 INFO - --app=APP Application being installed. [default: firefox] 08:43:31 INFO - mkdir: /builds/slave/test/build/application 08:43:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:43:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:43:47 INFO - Reading from file tmpfile_stdout 08:43:47 INFO - Output received: 08:43:47 INFO - /builds/slave/test/build/application/firefox/firefox 08:43:47 INFO - Running post-action listener: _resource_record_post_action 08:43:47 INFO - ##### 08:43:47 INFO - ##### Running run-tests step. 08:43:47 INFO - ##### 08:43:47 INFO - Running pre-action listener: _resource_record_pre_action 08:43:47 INFO - Running main action method: run_tests 08:43:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:43:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:43:47 INFO - Python 2.7.3 08:43:47 INFO - Return code: 0 08:43:47 INFO - grabbing minidump binary from tooltool 08:43: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')]} 08:43:47 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 0x1982410>, '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 0x1983310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19837a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:43:47 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 08:43:47 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 08:43:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:43:47 INFO - Return code: 0 08:43:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:43:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:43:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:43:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:43:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:43:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:43:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:43:48 INFO - Return code: 0 08:43:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VONXSUoCSDuWKx8eztikbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 08:43:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VONXSUoCSDuWKx8eztikbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --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 08:43:48 INFO - Using env: {'DISPLAY': ':0', 08:43:48 INFO - 'HOME': '/home/cltbld', 08:43:48 INFO - 'LANG': 'en_US.UTF-8', 08:43:48 INFO - 'LANGUAGE': 'en_US:en', 08:43:48 INFO - 'LOGNAME': 'cltbld', 08:43:48 INFO - 'MAIL': '/var/mail/cltbld', 08:43:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:43:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:43:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:48 INFO - 'MOZ_NO_REMOTE': '1', 08:43:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:43:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:48 INFO - 'NO_EM_RESTART': '1', 08:43:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:48 INFO - 'PWD': '/builds/slave/test', 08:43:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:43:48 INFO - 'SHELL': '/bin/bash', 08:43:48 INFO - 'SHLVL': '1', 08:43:48 INFO - 'TERM': 'linux', 08:43:48 INFO - 'TMOUT': '86400', 08:43:48 INFO - 'USER': 'cltbld', 08:43:48 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1460734974.766806-367780479', 08:43:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:48 INFO - '_': '/tools/buildbot/bin/python'} 08:43:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VONXSUoCSDuWKx8eztikbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 08:43:49 INFO - mozversion application_buildid: 20160415055421 08:43:49 INFO - mozversion application_changeset: f1631a25825bc0da92bbc8dcca350bcd893edfe0 08:43:49 INFO - mozversion application_display_name: Nightly 08:43:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:43:49 INFO - mozversion application_name: Firefox 08:43:49 INFO - mozversion application_remotingname: firefox 08:43:49 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 08:43:49 INFO - mozversion application_vendor: Mozilla 08:43:49 INFO - mozversion application_version: 48.0a1 08:43:49 INFO - mozversion platform_buildid: 20160415055421 08:43:49 INFO - mozversion platform_changeset: f1631a25825bc0da92bbc8dcca350bcd893edfe0 08:43:49 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 08:43:49 INFO - mozversion platform_version: 48.0a1 08:43:49 INFO - using testdate: 1460735029 08:43:49 INFO - actual date: 1460735029 08:43:49 INFO - starting webserver on 'localhost:53428' 08:43:49 INFO - SUITE-START | Running 2 tests 08:43:49 INFO - TEST-START | dromaeo_css 08:43:49 INFO - operating with platform_type : linux_ 08:43:49 INFO - Initialising browser for dromaeo_css test... 08:43:49 INFO - TEST-INFO | started process 20467 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0woeaR/profile http://localhost:53428/getInfo.html) 08:43:54 INFO - PROCESS | 20467 | __metrics Screen width/height:1600/1200 08:43:54 INFO - PROCESS | 20467 | colorDepth:24 08:43:54 INFO - PROCESS | 20467 | Browser inner width/height: 1024/697 08:43:54 INFO - PROCESS | 20467 | __metrics 08:43:55 ERROR - PROCESS | 20467 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:43:56 INFO - TEST-INFO | 20467: exit 0 08:43:56 INFO - Browser initialized. 08:43:56 INFO - Running cycle 1/1 for dromaeo_css test... 08:43:56 INFO - TEST-INFO | started process 20549 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0woeaR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:44:08 INFO - PROCESS | 20549 | RSS: Main: 152502272 08:44:08 INFO - PROCESS | 20549 | 08:44:59 INFO - PROCESS | 20549 | 1460735099277 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] 08:47:07 INFO - PROCESS | 20549 | Cycle 1(1): loaded http://localhost:53428/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53428/tests/dromaeo/cssquery-ext.html) 08:47:08 INFO - PROCESS | 20549 | RSS: Main: 254779392 08:47:08 INFO - PROCESS | 20549 | 08:50:10 INFO - PROCESS | 20549 | Cycle 1(1): loaded http://localhost:53428/tests/dromaeo/cssquery-ext.html (next: http://localhost:53428/tests/dromaeo/cssquery-jquery.html) 08:50:10 INFO - PROCESS | 20549 | RSS: Main: 232955904 08:50:10 INFO - PROCESS | 20549 | 08:53:12 INFO - PROCESS | 20549 | Cycle 1(1): loaded http://localhost:53428/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53428/tests/dromaeo/cssquery-mootools.html) 08:53:13 INFO - PROCESS | 20549 | RSS: Main: 244809728 08:53:13 INFO - PROCESS | 20549 | 08:56:15 INFO - PROCESS | 20549 | Cycle 1(1): loaded http://localhost:53428/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53428/tests/dromaeo/cssquery-prototype.html) 08:56:15 INFO - PROCESS | 20549 | RSS: Main: 208982016 08:56:15 INFO - PROCESS | 20549 | 08:59:18 INFO - PROCESS | 20549 | Cycle 1(1): loaded http://localhost:53428/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53428/tests/dromaeo/cssquery-yui.html) 08:59:18 INFO - PROCESS | 20549 | RSS: Main: 222142464 08:59:18 INFO - PROCESS | 20549 | 09:02:21 INFO - PROCESS | 20549 | Cycle 1(1): loaded http://localhost:53428/tests/dromaeo/cssquery-yui.html (next: http://localhost:53428/tests/dromaeo/cssquery-dojo.html) 09:02:21 INFO - PROCESS | 20549 | RSS: Main: 263753728 09:02:21 INFO - PROCESS | 20549 | 09:02:21 INFO - PROCESS | 20549 | __start_tp_report 09:02:21 INFO - PROCESS | 20549 | _x_x_mozilla_page_load 09:02:21 INFO - PROCESS | 20549 | _x_x_mozilla_page_load_details 09:02:21 INFO - PROCESS | 20549 | |i|pagename|runs| 09:02:21 INFO - PROCESS | 20549 | |0;dojo.html;3093.767967402445;3126.405982863257;3161.051684494651;3161.1780936956397;3191.3457741163065;5341.332333458317;5352.411234764178;5384.273123128377;5403.432639572842;5420.5934554908445;5352.4915133062395;5421;5423.593230507718;5435.2934118564535;5501.559875209973;4756.7859446325;4802.423709154898;4955.578775804043;5015.14742493777;5023.899522009558;4931.876703082416;4952.529509696573;4966.230234313687;5019.272205530196;5021.723805190713;4792.185328494147;4853.975730121362;4881.707097574157;4947.851564453073;4961.875953101166;4889.608831293488;4896.755162241873;4904.509549045067;4914.21372580389;4944.110060189165;4712.670113092085;4865.95134048662;4875.000624871893;4884.535969082932;4899.363082799213;5342.492463215988;5363.061464243741;5367.597430192751;5372.677639341652;5414.377346605112;5792.855178620526;5797.420257974211;5806.274215723035;5825.038868586678;5825.854353641151;5585.636933599344;5807.274090738658;5846.766129354864;5858.41415858415;5873.970630146865;5400.648957817729;5404.972975135099;5408.513233808937;5421.864453388657;5453.15476101205;5880.441358070976;5884.47039766423;5885.61743486672;5887.4406931341455;5892.558058145656;5425.593080518976;5653.632513886584;5678.119891416837;5753.827385178452;5767.913481297784;5747.425257474303;5766.135079737989;5769.365369809318;5770.307563092372;5770.394108618619;5750.0512415450985;5757.510611598061;5762;5766.077427611646;5769.538436925036;5593.021221286259;5696.1455781633085;5769.8557536061935;5772.191893134965;5822.0684690449325;4339.1972485090355;4342.218400687906;4344.956550434518;4359.520452750195;4379.627731642782;3855.4024126260474;3899.863504777376;3906.160175562268;3915.960840391617;3961.1483531040963;5389.137737961907;5451.945480545223;5455.208994695826;5499.450054994549;5505.366882808448;5835.766569337179;5854.882902341929;5891.852703682356;5898.2332296802;5898.469137777621;5364.329458817648;5457.945420545823;5490.396056433789;5517.089680202722;5523.171524271311;4959.2561115832195;4961.90076198474;4962.404511458576;4969.801207951641;5012.949870501248;5925.881482370329;5926.318473375617;5928.584999050025;5929.258842644669;5934.584579079509;5595.188697638901;5784.305883294031;5784.479396854387;5800.970995144998;5837.09525023622;5936.8812623748145;5963.731632076654;5963.850903727442;5964.701764911651;6019.247594050744;5642.238297829905;5682;5683.488486036276;5687.71561421919;5700.572457065819;5609.1305847593685;5617.382087970238;5697.829065128053;5767.163761254511;5768.53851691872;5549.472800083986;5594.86012849682;5619.719014049363;5624.240727501899;5675.716214189357;5565.443455654402;5612.382637909745;5618.101103823368;5630.493255607015;5640.717964101696;5348.277982472317;5493.505584497414;5556.222128902038;5586.245856809279;5595.832125036255;5618.971905140448;5630.211770352072;5642.463965923231;5644.717764111696;5652.7173641318595;5501.257330260523;5503.724813759376;5516.475934786189;5517.944820551743;5574.024545704405 09:02:21 INFO - PROCESS | 20549 | |1;ext.html;594.8839976204639;634.3402861024534;635.0791352538819;642.0593830038991;653.9771108011217;27109.728902710965;35478.82260588697;36385.272294554095;36388.63611363882;36444.27111457769;39599.604003959954;40529.59470405302;40748.38877416841;40761.38857917126;40795.18409631806;8566.828663426728;8798.912010879872;8800;8801.647934082628;8803.867941980876;8706;8755.518446485441;8802.427842190269;8808.207261346477;8811.911880881173;8772.342074344419;8845.690400835972;8851.159139881702;8863.335249856254;8866.202041816236;8721.476711397274;8758.649654013832;8824.161704638049;8829.823403531893;8833.73498795034;8684.218420342137;8704.434211776213;8722.127787221227;8767.167119123673;8805.69180078694;37012.81493592515;37412;37440.812795936115;37460.438093428624;37462;3431;3462.9653703463146;3516.331896939573;3535.292941411702;3885.630865067814;29727.40545189084;30180.54729179064;30183.69816301853;30193.849030754925;30233;3347.2301370684636;3363.865445382182;3393.8303084845907;3401.4727717203873;3495.1436897959907;264009;264754;265530;267621;268399;48799.99999999929;53217;54023.18965215525;54220.728896355264;56822.147667785015;56900.71549642225;57726.134107988415;57729.13406298909;57787.711061444425;57796.11019449011;12960.805587916;13297;13332.866671333357;13345.132566383154;13345.266010369329;9341.205997490153;9442.291828112919;9525.761855953657;9536.761580960392;9730.659426920023;16381.262843172086;16397.91801040987;16399.91800041016;16457.91771041137;16482.34070637185;6115.266168059861;6158.82658566806;6187.381261873867;6189.319174890758;6312.305646378894;1007.0584003956325;1090.8145615245428;1139.2822521811206;1152.4698638626157;1183.9526418943146;30969.225769355948;30972.690273097433;31526.684733152833;31734.206644834063;31931.361372772415;1084.2356138922041;1159.8550181227347;1166.87278094707;1217.6347095871204;1241.2862604002735;16006.839931600534;16704.415345463094;16732;16791.812281577633;16812.83187168137;369017.85892846517;373929;375089;375313;375420;53929.1910621341;55530.72234638801;55591.72204139034;55601.1659825103;55704.72147639236;1217.549506682533;1268.6764874956827;1358.9388477518535;1371.8216631837797;1372.9107608005447;27924.581131283452;30877.536836947016;31645.525317119802;32448.675513244565;35289.82355088208;49695.75152124361;50032.499675002786;50308.24537631865;50458.74770626123;50491.242631359826;319515;320691;321438;322133;323561;24154.75845241525;27223;28190.577141342485;28316.15051548457;28411.147665570064;43063.35404968991;43141.568584313754;44032.339514906664;44150.55849441465;44623.55376446194;37051.81474092612;37470.56676781906;37621;37762.43356349712;37797.43303850389;36193.55999280463;36356.45465318075;37040.444393333586;37468.62531374651;37614;37266.25467490689;37417.43873841949;38070;38078.428823568225;38232;31940.36119277648;33249.88530051281;33416.665833342326;33769.3246135071;33910.491342630376;25744.356391090372;26093.347666308495;26117.347066323495;26141.738582614693;26192.214233573024 09:02:21 INFO - PROCESS | 20549 | |2;jquery.html;381.1975790960029;399.4407829039345;400.3814107204369;402.1534669520659;409.91596722671835;17682.29270829167;18275.177617007233;18309.542261443472;18379.26482940681;19134.234630614792;18016.729749053775;18103.547411314725;18906;18940.905295473538;18955;5384.326959130109;5502.532284755791;5708.8296899135785;5721.713914304289;5734.913976290359;5628.32460104788;5637.774489020434;5662.207290979266;5675.290588676416;5684.801031963882;5573.5819813514145;5641.8589535261535;5645.15322701596;5675.722962333462;5680.886382272352;5614.915776263339;5731.541476681856;5735.827925162252;5752.539796816244;5773.134029895528;5502.752376143083;5566.463675959047;5649.209110724501;5654.067078932012;5659.943400565983;20637.58724825495;20723.896380518152;20839.5832083359;22139.225127120473;22164.335069947767;2210.4473881529616;2220.1452440810244;2288.439332363582;2307.8384513084093;2374.1809075868796;9879.901200988043;10106.797864042752;10118.595256189743;10538.104261137813;10539.420331881744;1914.4352416037302;1927.3061697788926;1955.6773132433132;2021.3834780391974;2023.979760202394;68529.54557953717;72647.27352726458;74890;75572.24427755707;77608;10691.572337106429;10795.244332896622;10832.891671083345;10984.780304393867;11145.164112691418;15455.072695638297;15625.609359766097;15628.609284767972;15652.4521641742;15658.138802365751;7211.639418029077;7460.776176714708;7480.850382992309;7553.924460755432;7554.697812087455;6807;6871.415929646036;6963.338482844122;6975.3024697530855;6975.953606958997;4668.393108895822;4784.114938736345;4797.160496913027;4817.325574419584;4834.468208497063;1820.963580728378;1869.2149297295168;1897.8386837118724;1922.1542521290587;1948.795376485477;876.9429987050821;992.2260636703382;1014.2038499777786;1015.3248090020202;1042.8696412948382;17923.283068677367;18543.81456185448;19013.524661883286;19228.615427691646;19381.4185574433;944.460529337176;944.6693657219918;955.7753927826955;967.0426277984885;994.9701508954743;10215.846762298572;10471.68584942453;10618.946905265424;10631.46842657864;10636.574537018432;447883;450306;453033;478753;484149;86035.13964860396;87784;88268.11731882728;89009;89061;979.872616559857;987.3532835992437;991.0139411285672;1004.3321191407778;1005.666852901262;16269.918650406673;16331;16423.17884105766;16451.9177404117;16510.83489165093;35745;35876.28247434984;36022.27955440824;36731.26537469289;36764.44853327149;50552.49447505478;52029;52226;52355;52655.73672131615;7551.207123251979;7875.1731068239305;7953.602319883867;8051.1948805121365;8728.956355218183;9038.728838134866;11223.4388280584;12861.228326300452;12927.676808079874;13120.147190432592;6376.202974628171;9500.857487137837;11063.834042489209;11737.589184378507;11836.881631183922;11420.086393088699;11476.770464590494;11626.593069242535;11654.533818647498;11667.183297169116;11581.42092895335;11604.709882253012;11802.527898884291;12063.819042714542;12110.576129835767;7873.37013038967;7974.84050319002;7989.320907722677;8041.517508949481;8259.752207433787;10891.782164356828;11280.7743845121;11771.176017678681;11795.056395488513;11917.16579839403 09:02:21 INFO - PROCESS | 20549 | |3;mootools.html;1294.094134106126;1495.289737374747;1501.759718445049;1651.7109505836484;1801.7027190513566;7256.346928776409;7516.661750221239;7525.247475252472;7531.736389226378;7535.472516923811;7268.382187514055;7447.851042979137;7456.254374562541;7458;7459.142198647157;1995.5510010247724;2057.5987682401937;2267.0818318581;2288.302067869299;2325.3721495196287;2301.8158547316257;2317.687112239851;2319.5592837360846;2322.512272422793;2325.197806756666;2270.14869423966;2279.544091181762;2296.575133600281;2297.6668383084443;2298.9885050574726;1941.223510595766;2000.9499762505982;2139.893005349726;2207.073029327686;2223.399682085836;2271.3867255840833;2277.2598905355826;2285.337252196861;2285.6228722260807;2287.5996700577334;7418.517796343221;7473.290037446434;7476.36450901674;7482.326590606817;7487.8502429951095;4604.723716576983;4726.858194254178;4759.666823322369;4762.071396077767;4766.6901651392545;2965.4662160811044;3028.9394212115635;3107.564940908275;3109.9222519437194;3130.9530357044664;1023.703126093432;1028.4857571214393;1034.0900007992918;1038.8285932821075;1039.9220058495569;10034.24743144267;10104.999999999927;10145.289829711923;10164.695059148164;10239.334443261165;4226.260404429213;4232.957670423257;4362.847300344472;4403.119376124788;4503.324501324828;8785.912140878638;8875.201231889161;8876.245519130816;8893.955530222307;8894.28845692343;4920.237363208708;4925.975370123127;4939.6542242042715;4945;4947.876303092451;4070.921205880444;4416.183006143874;4515.616172625364;4530.682852200314;4537.841175558906;3768.340540405418;3839.9040023999064;3867.7679339239735;3877.302085624615;3895.2014836958356;1227.7974134267745;1236.505397840871;1238.182799352423;1254.6047994881583;1259.389196239823;964.1708131007329;981.1169947047572;982.2485798364257;1063.4470075560664;1248.1138391741965;7149.89275160873;7172.46206534512;7191.748288809867;7223.133224013152;7227.602481863443;498.4517031265651;501.39331408995525;504.2788811998877;506.3215291509395;508.280782692486;5602.4957753802355;5666.036773748473;5705.429457054262;5716.999525083093;5755.107958266475;8980.730578082668;9262.490563019099;9304.953475232716;9305.581248843819;9333.439993600407;8918.821623567623;9169.35814492979;9232.122948319899;9278.443293402417;9280.118388753057;7161.248068952789;7164.892526612105;7227.3134052266005;7230.060092188087;7274.563526188445;6925.27284635106;7042.577445353295;7044.119485064367;7056.082709247765;7073.3987611053635;8387.538685372363;8462.746117616482;8568.871466927876;8576.228139467477;8616.870746938926;8614.870776938225;8623.180797824196;8696;8716.651333946571;8827.602757875782;6167.5374346925055;6402.775902843378;6577.835554111186;6614.305497922649;6638.236602790741;7034.613096279753;7045.964770176116;7081.504294699322;7099.787006389816;7100.0414943981905;6337.302896681454;6575.80272591823;6613.041109039259;6634.914764634275;6724.8567743482745;6400.071989561395;6417.550771445954;6476.740930362733;6482.060101285193;6505.31694172124;6667.266600674019;6673.8998915015345;6695.096162018065;6703.229128650268;6717.932820671731;6191.876162476815;6224.782132625336;6229.470495007975;6229.595076320206;6266.749330026931;6443.871122577616;6470.48236141117;6501.934980650322;6505.869882602226;6515.02274658805 09:02:21 INFO - PROCESS | 20549 | |4;prototype.html;337.1638336924427;338.9525466434698;341.62421336529815;341.9059758566394;344.936186805441;5574.832755017351;5621.57838162138;5634.211210430538;5635.464630860072;5645.266115404992;5544.306961629796;5552.77788888444;5557.416471270519;5561.63849349792;5562.888742225153;4026.174634199982;4037.7577345359373;4280.657547396217;4347.369631403445;4362.323839804835;4332.988572941791;4337.284348082579;4337.934930976038;4351.26028575143;4362.520122786491;4300.483941926973;4301.2902871026245;4310.525842157376;4310.935335969963;4327.913441731163;4102.8974275643195;4209.126938512348;4290.2706539888295;4320.611144996934;4338.913221735579;3809.2191100824266;3817.0838998640124;3822.2164456286396;3823.495610375209;3824.770513769183;5402.648827826218;5409.594280428944;5409.783608655649;5422.186671999192;5424.403315635277;4849.466558678542;4947.356843610343;4985.579109953682;4993;4997.250412438127;5767.798127065533;5790.594658373915;5806.970965145148;5826.504747096459;5828.41715828418;4194.161167766459;4209.7474151551005;4210.894727631803;4214.557471465513;4216.177845320164;5881.500072493843;6034.758609655564;6047.969760151171;6071;6109.205803245594;4294.377315289328;4298.849540266076;4303.548127446636;4314.762688052125;4329.761863097497;4318.568143185719;4330.7401555906745;4337.869863904088;4343.457067866517;4349.869034051107;4811;4924.926126108111;4936.827211047596;4959.652824302337;4970.801167953241;5852.209951656557;5865.970670146708;5871.94128058714;5872.970635146797;5905.557083218776;1496.2817847433294;1501.69215310861;1515.454436402894;1528.9311980960883;1533.2946844451676;985.4432245781111;1016.2936758952604;1035.1977217656377;1061.8513408122715;1063.5852017713098;5480.424555421703;5499.257600223918;5638.802641907513;5776.826695199151;5781.306243250753;6111.724972376253;6139.84650383744;6154.169187159766;6156.907646385308;6171.321154672983;5579.721013949367;5730.5129064030025;5741.942580574224;5745.511631511285;5760.107183386582;3234;3247.5291082792864;3254.1376535218187;3260.2175477885135;3264.3308121835444;6058.545609079337;6231.844203894939;6238.812835614939;6269.8746025079245;6288.654124023131;6219.626822390671;6231.345708700612;6231.4391704746795;6235.844103897439;6243.313235544087;6220.564560480813;6247.562670613104;6257.186565746424;6270.122182894398;6274.403931626488;5804.419558044331;6056.848578785565;6071;6080.72636731357;6124.479419249414;5984.16221728967;5993.6104153231645;6000.189974353581;6000.309964353981;6046.879062418639;6041.607295525777;6293.590916590407;6295.653739044396;6295.874082518232;6297.496200303873;4247.808848601759;4251.44731184944;4268.573142685706;4281.507626622853;4282.614564689193;6046.57673962836;6076.483498902643;6088.695565221633;6098.481629061402;6147.047207682816;5764.7405866736935;5967.254093238345;5983.461488466059;5989.64062156272;5998.25021872266;5907.645541267538;5932.851678708067;5937.851553711192;5941.1385349123275;5942;5371.570274377962;5548.722563871871;5805.506531944663;5831.533477321889;5847.736851841592;5945.970270148621;5950.16697662319;5974.551908606959;5976.312724036791;5980.501406677143;5665.830025099253;5822.446867547576;5827.5337972961215;5851;5853.473187413153 09:02:21 INFO - PROCESS | 20549 | |5;yui.html;759.077720569508;761.8971438855756;819.8237378963522;836.1178956201213;867.8220964702234;13977.371018304175;14280.71438571228;14298.499552515637;14313.355898984544;14358.066725662839;13744.931275343633;14230;14272.286385680727;14305.141691498491;14312.785308220358;676.5906626490976;804.7867315161487;808.5795386399069;811.8619834628098;820.3109388113983;819.4714409206058;820.335528222142;821.4455242711176;823.259066839843;823.3372135430976;869.1221865915439;870.0168809245544;870.3124531620012;870.7431307764193;871.6208449324532;702.4029574861353;720.3552820225894;841.6591280531395;867.1805144138791;868.8262347530488;625.2809269340249;632.5192853431425;633.9904901426436;634.2674211285926;634.6731433311849;13880.51418200358;13881.583552493441;13894.096883702527;13911.721765564733;13947.302634868318;13089.47642094315;13163.144395614254;13265.336733163304;13392.86607133926;13539.039361505493;11375.431228438545;11380.886191138065;11464.369459679714;11497.770044599145;11774.646760597196;3823.6941044716355;3840.9039774005596;3876.0503676599133;3920.8431662733456;3942.802859856996;53756.46243537593;53965.1905221422;53970;54222;54683.453165468236;10469.581216751398;10981.12151027916;11005.559777608805;11024.779504409868;11035.503402346914;18900.71648925267;18958.43124706261;18967.43097707071;18972;18980.715289270673;7796;7915.287624113857;8181.713640022571;8234.629441675139;8254.05078415978;4646.7444290564345;4676;4689.109069276827;4759.785809638574;4790.4969978152485;3312.5528053712924;3415;3417.487376893486;3417.8803741868915;3421.9828900855337;593.9168516407707;621.6363427394934;633.8130251575797;649.1334069017914;651.7686221391433;732.5824280160364;749.4079677055174;757.3978686943893;778.5523324088672;801.6753214947955;8660.783480412914;8757;8980.68567600144;8983.326250531236;9062.139096785795;667.6761770541381;705.6721750781578;721.5594418087666;761.2996043639864;767.8656235158825;4224.852130175429;4314.352847072902;4348.63036641889;4397.1205758848355;4427.446569178853;64562;66139;67412.662936685;67416.325836741;67461.66269168623;55528.44471555233;55588.166177507366;55684.443155567926;57395;58514.12228816571;51319.328487296414;51775;52857.47142528602;53014;54284.18573721397;8294.83410331802;8422.452540584842;8565.229129378386;8610.65557377698;8644.178803013703;33409.665903340654;33625.66374336225;33933.32133357369;34069.318613627096;34843.47734784031;43250.35124473072;46846.76576617095;47167;47252.52747472481;47680;11034.944825275823;11051.889481105407;11092.389918554558;11359.432028398382;11371.260868043551;11913.344766037952;12043.91604755541;12087.758244834878;12173.939130304292;12177;10906.563737450731;11173.967509096978;11199.760944270327;11212.15908806859;11334.319940803578;11907.940460297643;11974.700632484257;12033.578824741093;12088.456019479321;12098.395080246128;10912.181586380895;11034.889651103707;11250.662480125282;11282.94358528202;11622.128340374336;9981.950090249502;10083.294169408071;10094.949525252327;10099.646512372032;10541.57833686644;9082.228010618906;9481.288903332415;9551.904480955101;9699;9923.950380248052 09:02:21 INFO - PROCESS | 20549 | __end_tp_report 09:02:21 INFO - PROCESS | 20549 | __start_cc_report 09:02:21 INFO - PROCESS | 20549 | _x_x_mozilla_cycle_collect,830 09:02:21 INFO - PROCESS | 20549 | __end_cc_report 09:02:21 INFO - PROCESS | 20549 | __startTimestamp1460736141527__endTimestamp 09:02:21 INFO - PROCESS | 20549 | 09:02:21 INFO - PROCESS | 20549 | ------- Summary: start ------- 09:02:21 INFO - PROCESS | 20549 | Number of tests: 6 09:02:21 INFO - PROCESS | 20549 | 09:02:21 INFO - PROCESS | 20549 | [#0] dojo.html Cycles:165 Average:5353.14 Median:5549.47 stddev:608.28 (11.0%) stddev-sans-first:583.75 09:02:21 INFO - PROCESS | 20549 | Values: 3093.8 3126.4 3161.1 3161.2 3191.3 5341.3 5352.4 5384.3 5403.4 5420.6 5352.5 5421.0 5423.6 5435.3 5501.6 4756.8 4802.4 4955.6 5015.1 5023.9 4931.9 4952.5 4966.2 5019.3 5021.7 4792.2 4854.0 4881.7 4947.9 4961.9 4889.6 4896.8 4904.5 4914.2 4944.1 4712.7 4866.0 4875.0 4884.5 4899.4 5342.5 5363.1 5367.6 5372.7 5414.4 5792.9 5797.4 5806.3 5825.0 5825.9 5585.6 5807.3 5846.8 5858.4 5874.0 5400.6 5405.0 5408.5 5421.9 5453.2 5880.4 5884.5 5885.6 5887.4 5892.6 5425.6 5653.6 5678.1 5753.8 5767.9 5747.4 5766.1 5769.4 5770.3 5770.4 5750.1 5757.5 5762.0 5766.1 5769.5 5593.0 5696.1 5769.9 5772.2 5822.1 4339.2 4342.2 4345.0 4359.5 4379.6 3855.4 3899.9 3906.2 3916.0 3961.1 5389.1 5451.9 5455.2 5499.5 5505.4 5835.8 5854.9 5891.9 5898.2 5898.5 5364.3 5457.9 5490.4 5517.1 5523.2 4959.3 4961.9 4962.4 4969.8 5012.9 5925.9 5926.3 5928.6 5929.3 5934.6 5595.2 5784.3 5784.5 5801.0 5837.1 5936.9 5963.7 5963.9 5964.7 6019.2 5642.2 5682.0 5683.5 5687.7 5700.6 5609.1 5617.4 5697.8 5767.2 5768.5 5549.5 5594.9 5619.7 5624.2 5675.7 5565.4 5612.4 5618.1 5630.5 5640.7 5348.3 5493.5 5556.2 5586.2 5595.8 5619.0 5630.2 5642.5 5644.7 5652.7 5501.3 5503.7 5516.5 5517.9 5574.0 09:02:21 INFO - PROCESS | 20549 | 09:02:21 INFO - PROCESS | 20549 | [#1] ext.html Cycles:180 Average:48413.88 Median:205597.63 stddev:84933.95 (41.3%) stddev-sans-first:85096.32 09:02:21 INFO - PROCESS | 20549 | Values: 594.9 634.3 635.1 642.1 654.0 27109.7 35478.8 36385.3 36388.6 36444.3 39599.6 40529.6 40748.4 40761.4 40795.2 8566.8 8798.9 8800.0 8801.6 8803.9 8706.0 8755.5 8802.4 8808.2 8811.9 8772.3 8845.7 8851.2 8863.3 8866.2 8721.5 8758.6 8824.2 8829.8 8833.7 8684.2 8704.4 8722.1 8767.2 8805.7 37012.8 37412.0 37440.8 37460.4 37462.0 3431.0 3463.0 3516.3 3535.3 3885.6 29727.4 30180.5 30183.7 30193.8 30233.0 3347.2 3363.9 3393.8 3401.5 3495.1 264009.0 264754.0 265530.0 267621.0 268399.0 48800.0 53217.0 54023.2 54220.7 56822.1 56900.7 57726.1 57729.1 57787.7 57796.1 12960.8 13297.0 13332.9 13345.1 13345.3 9341.2 9442.3 9525.8 9536.8 9730.7 16381.3 16397.9 16399.9 16457.9 16482.3 6115.3 6158.8 6187.4 6189.3 6312.3 1007.1 1090.8 1139.3 1152.5 1184.0 30969.2 30972.7 31526.7 31734.2 31931.4 1084.2 1159.9 1166.9 1217.6 1241.3 16006.8 16704.4 16732.0 16791.8 16812.8 369017.9 373929.0 375089.0 375313.0 375420.0 53929.2 55530.7 55591.7 55601.2 55704.7 1217.5 1268.7 1358.9 1371.8 1372.9 27924.6 30877.5 31645.5 32448.7 35289.8 49695.8 50032.5 50308.2 50458.7 50491.2 319515.0 320691.0 321438.0 322133.0 323561.0 24154.8 27223.0 28190.6 28316.2 28411.1 43063.4 43141.6 44032.3 44150.6 44623.6 37051.8 37470.6 37621.0 37762.4 37797.4 36193.6 36356.5 37040.4 37468.6 37614.0 37266.3 37417.4 38070.0 38078.4 38232.0 31940.4 33249.9 33416.7 33769.3 33910.5 25744.4 26093.3 26117.3 26141.7 26192.2 09:02:21 INFO - PROCESS | 20549 | 09:02:21 INFO - PROCESS | 20549 | [#2] jquery.html Cycles:180 Average:27316.75 Median:18572.82 stddev:76266.21 (410.6%) stddev-sans-first:76453.34 09:02:21 INFO - PROCESS | 20549 | Values: 381.2 399.4 400.4 402.2 409.9 17682.3 18275.2 18309.5 18379.3 19134.2 18016.7 18103.5 18906.0 18940.9 18955.0 5384.3 5502.5 5708.8 5721.7 5734.9 5628.3 5637.8 5662.2 5675.3 5684.8 5573.6 5641.9 5645.2 5675.7 5680.9 5614.9 5731.5 5735.8 5752.5 5773.1 5502.8 5566.5 5649.2 5654.1 5659.9 20637.6 20723.9 20839.6 22139.2 22164.3 2210.4 2220.1 2288.4 2307.8 2374.2 9879.9 10106.8 10118.6 10538.1 10539.4 1914.4 1927.3 1955.7 2021.4 2024.0 68529.5 72647.3 74890.0 75572.2 77608.0 10691.6 10795.2 10832.9 10984.8 11145.2 15455.1 15625.6 15628.6 15652.5 15658.1 7211.6 7460.8 7480.9 7553.9 7554.7 6807.0 6871.4 6963.3 6975.3 6976.0 4668.4 4784.1 4797.2 4817.3 4834.5 1821.0 1869.2 1897.8 1922.2 1948.8 876.9 992.2 1014.2 1015.3 1042.9 17923.3 18543.8 19013.5 19228.6 19381.4 944.5 944.7 955.8 967.0 995.0 10215.8 10471.7 10618.9 10631.5 10636.6 447883.0 450306.0 453033.0 478753.0 484149.0 86035.1 87784.0 88268.1 89009.0 89061.0 979.9 987.4 991.0 1004.3 1005.7 16269.9 16331.0 16423.2 16451.9 16510.8 35745.0 35876.3 36022.3 36731.3 36764.4 50552.5 52029.0 52226.0 52355.0 52655.7 7551.2 7875.2 7953.6 8051.2 8729.0 9038.7 11223.4 12861.2 12927.7 13120.1 6376.2 9500.9 11063.8 11737.6 11836.9 11420.1 11476.8 11626.6 11654.5 11667.2 11581.4 11604.7 11802.5 12063.8 12110.6 7873.4 7974.8 7989.3 8041.5 8259.8 10891.8 11280.8 11771.2 11795.1 11917.2 09:02:21 INFO - PROCESS | 20549 | 09:02:21 INFO - PROCESS | 20549 | [#3] mootools.html Cycles:180 Average:5333.33 Median:6229.53 stddev:2750.41 (44.2%) stddev-sans-first:2741.36 09:02:21 INFO - PROCESS | 20549 | Values: 1294.1 1495.3 1501.8 1651.7 1801.7 7256.3 7516.7 7525.2 7531.7 7535.5 7268.4 7447.9 7456.3 7458.0 7459.1 1995.6 2057.6 2267.1 2288.3 2325.4 2301.8 2317.7 2319.6 2322.5 2325.2 2270.1 2279.5 2296.6 2297.7 2299.0 1941.2 2000.9 2139.9 2207.1 2223.4 2271.4 2277.3 2285.3 2285.6 2287.6 7418.5 7473.3 7476.4 7482.3 7487.9 4604.7 4726.9 4759.7 4762.1 4766.7 2965.5 3028.9 3107.6 3109.9 3131.0 1023.7 1028.5 1034.1 1038.8 1039.9 10034.2 10105.0 10145.3 10164.7 10239.3 4226.3 4233.0 4362.8 4403.1 4503.3 8785.9 8875.2 8876.2 8894.0 8894.3 4920.2 4926.0 4939.7 4945.0 4947.9 4070.9 4416.2 4515.6 4530.7 4537.8 3768.3 3839.9 3867.8 3877.3 3895.2 1227.8 1236.5 1238.2 1254.6 1259.4 964.2 981.1 982.2 1063.4 1248.1 7149.9 7172.5 7191.7 7223.1 7227.6 498.5 501.4 504.3 506.3 508.3 5602.5 5666.0 5705.4 5717.0 5755.1 8980.7 9262.5 9305.0 9305.6 9333.4 8918.8 9169.4 9232.1 9278.4 9280.1 7161.2 7164.9 7227.3 7230.1 7274.6 6925.3 7042.6 7044.1 7056.1 7073.4 8387.5 8462.7 8568.9 8576.2 8616.9 8614.9 8623.2 8696.0 8716.7 8827.6 6167.5 6402.8 6577.8 6614.3 6638.2 7034.6 7046.0 7081.5 7099.8 7100.0 6337.3 6575.8 6613.0 6634.9 6724.9 6400.1 6417.6 6476.7 6482.1 6505.3 6667.3 6673.9 6695.1 6703.2 6717.9 6191.9 6224.8 6229.5 6229.6 6266.7 6443.9 6470.5 6501.9 6505.9 6515.0 09:02:21 INFO - PROCESS | 20549 | 09:02:21 INFO - PROCESS | 20549 | [#4] prototype.html Cycles:180 Average:4951.70 Median:5627.89 stddev:1466.79 (26.1%) stddev-sans-first:1429.42 09:02:21 INFO - PROCESS | 20549 | Values: 337.2 339.0 341.6 341.9 344.9 5574.8 5621.6 5634.2 5635.5 5645.3 5544.3 5552.8 5557.4 5561.6 5562.9 4026.2 4037.8 4280.7 4347.4 4362.3 4333.0 4337.3 4337.9 4351.3 4362.5 4300.5 4301.3 4310.5 4310.9 4327.9 4102.9 4209.1 4290.3 4320.6 4338.9 3809.2 3817.1 3822.2 3823.5 3824.8 5402.6 5409.6 5409.8 5422.2 5424.4 4849.5 4947.4 4985.6 4993.0 4997.3 5767.8 5790.6 5807.0 5826.5 5828.4 4194.2 4209.7 4210.9 4214.6 4216.2 5881.5 6034.8 6048.0 6071.0 6109.2 4294.4 4298.8 4303.5 4314.8 4329.8 4318.6 4330.7 4337.9 4343.5 4349.9 4811.0 4924.9 4936.8 4959.7 4970.8 5852.2 5866.0 5871.9 5873.0 5905.6 1496.3 1501.7 1515.5 1528.9 1533.3 985.4 1016.3 1035.2 1061.9 1063.6 5480.4 5499.3 5638.8 5776.8 5781.3 6111.7 6139.8 6154.2 6156.9 6171.3 5579.7 5730.5 5741.9 5745.5 5760.1 3234.0 3247.5 3254.1 3260.2 3264.3 6058.5 6231.8 6238.8 6269.9 6288.7 6219.6 6231.3 6231.4 6235.8 6243.3 6220.6 6247.6 6257.2 6270.1 6274.4 5804.4 6056.8 6071.0 6080.7 6124.5 5984.2 5993.6 6000.2 6000.3 6046.9 6041.6 6293.6 6295.7 6295.9 6297.5 4247.8 4251.4 4268.6 4281.5 4282.6 6046.6 6076.5 6088.7 6098.5 6147.0 5764.7 5967.3 5983.5 5989.6 5998.3 5907.6 5932.9 5937.9 5941.1 5942.0 5371.6 5548.7 5805.5 5831.5 5847.7 5946.0 5950.2 5974.6 5976.3 5980.5 5665.8 5822.4 5827.5 5851.0 5853.5 09:02:21 INFO - PROCESS | 20549 | 09:02:21 INFO - PROCESS | 20549 | [#5] yui.html Cycles:180 Average:14814.23 Median:26006.16 stddev:17754.54 (68.3%) stddev-sans-first:17772.98 09:02:21 INFO - PROCESS | 20549 | Values: 759.1 761.9 819.8 836.1 867.8 13977.4 14280.7 14298.5 14313.4 14358.1 13744.9 14230.0 14272.3 14305.1 14312.8 676.6 804.8 808.6 811.9 820.3 819.5 820.3 821.4 823.3 823.3 869.1 870.0 870.3 870.7 871.6 702.4 720.4 841.7 867.2 868.8 625.3 632.5 634.0 634.3 634.7 13880.5 13881.6 13894.1 13911.7 13947.3 13089.5 13163.1 13265.3 13392.9 13539.0 11375.4 11380.9 11464.4 11497.8 11774.6 3823.7 3840.9 3876.1 3920.8 3942.8 53756.5 53965.2 53970.0 54222.0 54683.5 10469.6 10981.1 11005.6 11024.8 11035.5 18900.7 18958.4 18967.4 18972.0 18980.7 7796.0 7915.3 8181.7 8234.6 8254.1 4646.7 4676.0 4689.1 4759.8 4790.5 3312.6 3415.0 3417.5 3417.9 3422.0 593.9 621.6 633.8 649.1 651.8 732.6 749.4 757.4 778.6 801.7 8660.8 8757.0 8980.7 8983.3 9062.1 667.7 705.7 721.6 761.3 767.9 4224.9 4314.4 4348.6 4397.1 4427.4 64562.0 66139.0 67412.7 67416.3 67461.7 55528.4 55588.2 55684.4 57395.0 58514.1 51319.3 51775.0 52857.5 53014.0 54284.2 8294.8 8422.5 8565.2 8610.7 8644.2 33409.7 33625.7 33933.3 34069.3 34843.5 43250.4 46846.8 47167.0 47252.5 47680.0 11034.9 11051.9 11092.4 11359.4 11371.3 11913.3 12043.9 12087.8 12173.9 12177.0 10906.6 11174.0 11199.8 11212.2 11334.3 11907.9 11974.7 12033.6 12088.5 12098.4 10912.2 11034.9 11250.7 11282.9 11622.1 9982.0 10083.3 10094.9 10099.6 10541.6 9082.2 9481.3 9551.9 9699.0 9924.0 09:02:21 INFO - PROCESS | 20549 | -------- Summary: end -------- 09:02:21 INFO - PROCESS | 20549 | 09:02:22 INFO - TEST-INFO | 20549: exit 0 09:02:22 INFO - TEST-OK | dromaeo_css | took 1113114ms 09:02:22 INFO - TEST-START | kraken 09:02:22 INFO - operating with platform_type : linux_ 09:02:22 INFO - Initialising browser for kraken test... 09:02:22 INFO - TEST-INFO | started process 20736 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGJI3QC/profile http://localhost:53428/getInfo.html) 09:02:27 INFO - PROCESS | 20736 | __metrics Screen width/height:1600/1200 09:02:27 INFO - PROCESS | 20736 | colorDepth:24 09:02:27 INFO - PROCESS | 20736 | Browser inner width/height: 1024/697 09:02:27 INFO - PROCESS | 20736 | __metrics 09:02:28 ERROR - PROCESS | 20736 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:02:29 INFO - TEST-INFO | 20736: exit 0 09:02:29 INFO - Browser initialized. 09:02:29 INFO - Running cycle 1/1 for kraken test... 09:02:29 INFO - TEST-INFO | started process 20820 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGJI3QC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:02:41 INFO - PROCESS | 20820 | RSS: Main: 152653824 09:02:41 INFO - PROCESS | 20820 | 09:02:43 INFO - PROCESS | 20820 | Cycle 1(1): loaded http://localhost:53428/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53428/tests/kraken/driver.html?testName=audio-beat-detection) 09:02:44 INFO - PROCESS | 20820 | RSS: Main: 208633856 09:02:44 INFO - PROCESS | 20820 | 09:02:47 INFO - PROCESS | 20820 | Cycle 1(1): loaded http://localhost:53428/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53428/tests/kraken/driver.html?testName=audio-dft) 09:02:48 INFO - PROCESS | 20820 | RSS: Main: 194408448 09:02:48 INFO - PROCESS | 20820 | 09:02:51 INFO - PROCESS | 20820 | Cycle 1(1): loaded http://localhost:53428/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53428/tests/kraken/driver.html?testName=audio-fft) 09:02:51 INFO - PROCESS | 20820 | RSS: Main: 265060352 09:02:51 INFO - PROCESS | 20820 | 09:02:53 INFO - PROCESS | 20820 | Cycle 1(1): loaded http://localhost:53428/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53428/tests/kraken/driver.html?testName=audio-oscillator) 09:02:54 INFO - PROCESS | 20820 | RSS: Main: 172494848 09:02:54 INFO - PROCESS | 20820 | 09:02:56 INFO - PROCESS | 20820 | Cycle 1(1): loaded http://localhost:53428/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53428/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:02:57 INFO - PROCESS | 20820 | RSS: Main: 177033216 09:02:57 INFO - PROCESS | 20820 | 09:03:00 INFO - PROCESS | 20820 | Cycle 1(1): loaded http://localhost:53428/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53428/tests/kraken/driver.html?testName=imaging-darkroom) 09:03:00 INFO - PROCESS | 20820 | RSS: Main: 212635648 09:03:00 INFO - PROCESS | 20820 | 09:03:04 INFO - PROCESS | 20820 | Cycle 1(1): loaded http://localhost:53428/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53428/tests/kraken/driver.html?testName=imaging-desaturate) 09:03:04 INFO - PROCESS | 20820 | RSS: Main: 213868544 09:03:04 INFO - PROCESS | 20820 | 09:03:07 INFO - PROCESS | 20820 | Cycle 1(1): loaded http://localhost:53428/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53428/tests/kraken/driver.html?testName=json-parse-financial) 09:03:08 INFO - PROCESS | 20820 | RSS: Main: 213245952 09:03:08 INFO - PROCESS | 20820 | 09:03:09 INFO - PROCESS | 20820 | Cycle 1(1): loaded http://localhost:53428/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53428/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:03:10 INFO - PROCESS | 20820 | RSS: Main: 202424320 09:03:10 INFO - PROCESS | 20820 | 09:03:12 INFO - PROCESS | 20820 | Cycle 1(1): loaded http://localhost:53428/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53428/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:03:12 INFO - PROCESS | 20820 | RSS: Main: 206995456 09:03:12 INFO - PROCESS | 20820 | 09:03:14 INFO - PROCESS | 20820 | Cycle 1(1): loaded http://localhost:53428/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53428/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:03:15 INFO - PROCESS | 20820 | RSS: Main: 220176384 09:03:15 INFO - PROCESS | 20820 | 09:03:18 INFO - PROCESS | 20820 | Cycle 1(1): loaded http://localhost:53428/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53428/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:03:18 INFO - PROCESS | 20820 | RSS: Main: 220725248 09:03:18 INFO - PROCESS | 20820 | 09:03:21 INFO - PROCESS | 20820 | Cycle 1(1): loaded http://localhost:53428/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53428/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:03:21 INFO - PROCESS | 20820 | RSS: Main: 219582464 09:03:21 INFO - PROCESS | 20820 | 09:03:23 INFO - PROCESS | 20820 | Cycle 1(1): loaded http://localhost:53428/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53428/tests/kraken/driver.html?testName=ai-astar) 09:03:23 INFO - PROCESS | 20820 | RSS: Main: 283209728 09:03:23 INFO - PROCESS | 20820 | 09:03:23 INFO - PROCESS | 20820 | __start_tp_report 09:03:23 INFO - PROCESS | 20820 | _x_x_mozilla_page_load 09:03:23 INFO - PROCESS | 20820 | _x_x_mozilla_page_load_details 09:03:23 INFO - PROCESS | 20820 | |i|pagename|runs| 09:03:23 INFO - PROCESS | 20820 | |0;ai-astar;109;110;104;111;111;111;99;111;111;110 09:03:23 INFO - PROCESS | 20820 | |1;audio-beat-detection;172;134;154;184;128;158;150;132;183;124 09:03:23 INFO - PROCESS | 20820 | |2;audio-dft;163;161;161;161;160;162;161;160;161;160 09:03:23 INFO - PROCESS | 20820 | |3;audio-fft;77;74;106;119;73;76;73;123;106;74 09:03:23 INFO - PROCESS | 20820 | |4;audio-oscillator;94;93;152;93;94;93;155;93;94;148 09:03:23 INFO - PROCESS | 20820 | |5;imaging-gaussian-blur;117;117;116;116;118;116;117;117;117;117 09:03:23 INFO - PROCESS | 20820 | |6;imaging-darkroom;145;146;145;145;146;147;144;145;145;145 09:03:23 INFO - PROCESS | 20820 | |7;imaging-desaturate;97;96;95;96;96;95;95;96;95;94 09:03:23 INFO - PROCESS | 20820 | |8;json-parse-financial;56;58;58;57;56;57;60;81;66;54 09:03:23 INFO - PROCESS | 20820 | |9;json-stringify-tinderbox;62;63;62;62;62;62;62;62;61;63 09:03:23 INFO - PROCESS | 20820 | |10;stanford-crypto-aes;80;79;81;81;89;80;80;81;80;87 09:03:23 INFO - PROCESS | 20820 | |11;stanford-crypto-ccm;139;129;127;132;132;127;124;125;204;128 09:03:23 INFO - PROCESS | 20820 | |12;stanford-crypto-pbkdf2;170;163;168;164;165;163;171;164;167;170 09:03:23 INFO - PROCESS | 20820 | |13;stanford-crypto-sha256-iterative;69;69;67;67;69;69;66;69;68;66 09:03:23 INFO - PROCESS | 20820 | __end_tp_report 09:03:23 INFO - PROCESS | 20820 | __start_cc_report 09:03:23 INFO - PROCESS | 20820 | _x_x_mozilla_cycle_collect,1609 09:03:23 INFO - PROCESS | 20820 | __end_cc_report 09:03:23 INFO - PROCESS | 20820 | __startTimestamp1460736203943__endTimestamp 09:03:23 INFO - PROCESS | 20820 | 09:03:23 INFO - PROCESS | 20820 | ------- Summary: start ------- 09:03:23 INFO - PROCESS | 20820 | Number of tests: 14 09:03:23 INFO - PROCESS | 20820 | 09:03:23 INFO - PROCESS | 20820 | [#0] ai-astar Cycles:10 Average:108.70 Median:111.00 stddev:4.03 (3.6%) stddev-sans-first:4.27 09:03:23 INFO - PROCESS | 20820 | Values: 109.0 110.0 104.0 111.0 111.0 111.0 99.0 111.0 111.0 110.0 09:03:23 INFO - PROCESS | 20820 | 09:03:23 INFO - PROCESS | 20820 | [#1] audio-beat-detection Cycles:10 Average:151.90 Median:156.00 stddev:22.39 (14.4%) stddev-sans-first:22.54 09:03:23 INFO - PROCESS | 20820 | Values: 172.0 134.0 154.0 184.0 128.0 158.0 150.0 132.0 183.0 124.0 09:03:23 INFO - PROCESS | 20820 | 09:03:23 INFO - PROCESS | 20820 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.94 (0.6%) stddev-sans-first:0.67 09:03:23 INFO - PROCESS | 20820 | Values: 163.0 161.0 161.0 161.0 160.0 162.0 161.0 160.0 161.0 160.0 09:03:23 INFO - PROCESS | 20820 | 09:03:23 INFO - PROCESS | 20820 | [#3] audio-fft Cycles:10 Average:90.10 Median:73.50 stddev:20.81 (28.3%) stddev-sans-first:21.52 09:03:23 INFO - PROCESS | 20820 | Values: 77.0 74.0 106.0 119.0 73.0 76.0 73.0 123.0 106.0 74.0 09:03:23 INFO - PROCESS | 20820 | 09:03:23 INFO - PROCESS | 20820 | [#4] audio-oscillator Cycles:10 Average:110.90 Median:93.00 stddev:28.18 (30.3%) stddev-sans-first:29.22 09:03:23 INFO - PROCESS | 20820 | Values: 94.0 93.0 152.0 93.0 94.0 93.0 155.0 93.0 94.0 148.0 09:03:23 INFO - PROCESS | 20820 | 09:03:23 INFO - PROCESS | 20820 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 09:03:23 INFO - PROCESS | 20820 | Values: 117.0 117.0 116.0 116.0 118.0 116.0 117.0 117.0 117.0 117.0 09:03:23 INFO - PROCESS | 20820 | 09:03:23 INFO - PROCESS | 20820 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 09:03:23 INFO - PROCESS | 20820 | Values: 145.0 146.0 145.0 145.0 146.0 147.0 144.0 145.0 145.0 145.0 09:03:23 INFO - PROCESS | 20820 | 09:03:23 INFO - PROCESS | 20820 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.85 (0.9%) stddev-sans-first:0.71 09:03:23 INFO - PROCESS | 20820 | Values: 97.0 96.0 95.0 96.0 96.0 95.0 95.0 96.0 95.0 94.0 09:03:23 INFO - PROCESS | 20820 | 09:03:23 INFO - PROCESS | 20820 | [#8] json-parse-financial Cycles:10 Average:60.30 Median:58.00 stddev:7.96 (13.7%) stddev-sans-first:8.29 09:03:23 INFO - PROCESS | 20820 | Values: 56.0 58.0 58.0 57.0 56.0 57.0 60.0 81.0 66.0 54.0 09:03:23 INFO - PROCESS | 20820 | 09:03:23 INFO - PROCESS | 20820 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 09:03:23 INFO - PROCESS | 20820 | Values: 62.0 63.0 62.0 62.0 62.0 62.0 62.0 62.0 61.0 63.0 09:03:23 INFO - PROCESS | 20820 | 09:03:23 INFO - PROCESS | 20820 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:81.00 stddev:3.36 (4.1%) stddev-sans-first:3.50 09:03:23 INFO - PROCESS | 20820 | Values: 80.0 79.0 81.0 81.0 89.0 80.0 80.0 81.0 80.0 87.0 09:03:23 INFO - PROCESS | 20820 | 09:03:23 INFO - PROCESS | 20820 | [#11] stanford-crypto-ccm Cycles:10 Average:136.70 Median:130.50 stddev:24.04 (18.4%) stddev-sans-first:25.48 09:03:23 INFO - PROCESS | 20820 | Values: 139.0 129.0 127.0 132.0 132.0 127.0 124.0 125.0 204.0 128.0 09:03:23 INFO - PROCESS | 20820 | 09:03:23 INFO - PROCESS | 20820 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.50 Median:167.50 stddev:3.10 (1.9%) stddev-sans-first:3.02 09:03:23 INFO - PROCESS | 20820 | Values: 170.0 163.0 168.0 164.0 165.0 163.0 171.0 164.0 167.0 170.0 09:03:23 INFO - PROCESS | 20820 | 09:03:23 INFO - PROCESS | 20820 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:69.00 stddev:1.29 (1.9%) stddev-sans-first:1.30 09:03:23 INFO - PROCESS | 20820 | Values: 69.0 69.0 67.0 67.0 69.0 69.0 66.0 69.0 68.0 66.0 09:03:23 INFO - PROCESS | 20820 | -------- Summary: end -------- 09:03:23 INFO - PROCESS | 20820 | 09:03:24 INFO - TEST-INFO | 20820: exit 0 09:03:24 INFO - TEST-OK | kraken | took 62676ms 09:03:24 INFO - SUITE-END | took 1175s 09:03:25 INFO - Completed test suite (00:19:35) 09:03:25 INFO - javascript benchmark 09:03:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3093.767967402445, 3126.405982863257, 3161.051684494651, 3161.1780936956397, 3191.3457741163065, 5341.332333458317, 5352.411234764178, 5384.273123128377, 5403.432639572842, 5420.5934554908445, 5352.4915133062395, 5421.0, 5423.593230507718, 5435.2934118564535, 5501.559875209973, 4756.7859446325, 4802.423709154898, 4955.578775804043, 5015.14742493777, 5023.899522009558, 4931.876703082416, 4952.529509696573, 4966.230234313687, 5019.272205530196, 5021.723805190713, 4792.185328494147, 4853.975730121362, 4881.707097574157, 4947.851564453073, 4961.875953101166, 4889.608831293488, 4896.755162241873, 4904.509549045067, 4914.21372580389, 4944.110060189165, 4712.670113092085, 4865.95134048662, 4875.000624871893, 4884.535969082932, 4899.363082799213, 5342.492463215988, 5363.061464243741, 5367.597430192751, 5372.677639341652, 5414.377346605112, 5792.855178620526, 5797.420257974211, 5806.274215723035, 5825.038868586678, 5825.854353641151, 5585.636933599344, 5807.274090738658, 5846.766129354864, 5858.41415858415, 5873.970630146865, 5400.648957817729, 5404.972975135099, 5408.513233808937, 5421.864453388657, 5453.15476101205, 5880.441358070976, 5884.47039766423, 5885.61743486672, 5887.4406931341455, 5892.558058145656, 5425.593080518976, 5653.632513886584, 5678.119891416837, 5753.827385178452, 5767.913481297784, 5747.425257474303, 5766.135079737989, 5769.365369809318, 5770.307563092372, 5770.394108618619, 5750.0512415450985, 5757.510611598061, 5762.0, 5766.077427611646, 5769.538436925036, 5593.021221286259, 5696.1455781633085, 5769.8557536061935, 5772.191893134965, 5822.0684690449325, 4339.1972485090355, 4342.218400687906, 4344.956550434518, 4359.520452750195, 4379.627731642782, 3855.4024126260474, 3899.863504777376, 3906.160175562268, 3915.960840391617, 3961.1483531040963, 5389.137737961907, 5451.945480545223, 5455.208994695826, 5499.450054994549, 5505.366882808448, 5835.766569337179, 5854.882902341929, 5891.852703682356, 5898.2332296802, 5898.469137777621, 5364.329458817648, 5457.945420545823, 5490.396056433789, 5517.089680202722, 5523.171524271311, 4959.2561115832195, 4961.90076198474, 4962.404511458576, 4969.801207951641, 5012.949870501248, 5925.881482370329, 5926.318473375617, 5928.584999050025, 5929.258842644669, 5934.584579079509, 5595.188697638901, 5784.305883294031, 5784.479396854387, 5800.970995144998, 5837.09525023622, 5936.8812623748145, 5963.731632076654, 5963.850903727442, 5964.701764911651, 6019.247594050744, 5642.238297829905, 5682.0, 5683.488486036276, 5687.71561421919, 5700.572457065819, 5609.1305847593685, 5617.382087970238, 5697.829065128053, 5767.163761254511, 5768.53851691872, 5549.472800083986, 5594.86012849682, 5619.719014049363, 5624.240727501899, 5675.716214189357, 5565.443455654402, 5612.382637909745, 5618.101103823368, 5630.493255607015, 5640.717964101696, 5348.277982472317, 5493.505584497414, 5556.222128902038, 5586.245856809279, 5595.832125036255, 5618.971905140448, 5630.211770352072, 5642.463965923231, 5644.717764111696, 5652.7173641318595, 5501.257330260523, 5503.724813759376, 5516.475934786189, 5517.944820551743, 5574.024545704405], "value": 5312.170571852017, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.8839976204639, 634.3402861024534, 635.0791352538819, 642.0593830038991, 653.9771108011217, 27109.728902710965, 35478.82260588697, 36385.272294554095, 36388.63611363882, 36444.27111457769, 39599.604003959954, 40529.59470405302, 40748.38877416841, 40761.38857917126, 40795.18409631806, 8566.828663426728, 8798.912010879872, 8800.0, 8801.647934082628, 8803.867941980876, 8706.0, 8755.518446485441, 8802.427842190269, 8808.207261346477, 8811.911880881173, 8772.342074344419, 8845.690400835972, 8851.159139881702, 8863.335249856254, 8866.202041816236, 8721.476711397274, 8758.649654013832, 8824.161704638049, 8829.823403531893, 8833.73498795034, 8684.218420342137, 8704.434211776213, 8722.127787221227, 8767.167119123673, 8805.69180078694, 37012.81493592515, 37412.0, 37440.812795936115, 37460.438093428624, 37462.0, 3431.0, 3462.9653703463146, 3516.331896939573, 3535.292941411702, 3885.630865067814, 29727.40545189084, 30180.54729179064, 30183.69816301853, 30193.849030754925, 30233.0, 3347.2301370684636, 3363.865445382182, 3393.8303084845907, 3401.4727717203873, 3495.1436897959907, 264009.0, 264754.0, 265530.0, 267621.0, 268399.0, 48799.99999999929, 53217.0, 54023.18965215525, 54220.728896355264, 56822.147667785015, 56900.71549642225, 57726.134107988415, 57729.13406298909, 57787.711061444425, 57796.11019449011, 12960.805587916, 13297.0, 13332.866671333357, 13345.132566383154, 13345.266010369329, 9341.205997490153, 9442.291828112919, 9525.761855953657, 9536.761580960392, 9730.659426920023, 16381.262843172086, 16397.91801040987, 16399.91800041016, 16457.91771041137, 16482.34070637185, 6115.266168059861, 6158.82658566806, 6187.381261873867, 6189.319174890758, 6312.305646378894, 1007.0584003956325, 1090.8145615245428, 1139.2822521811206, 1152.4698638626157, 1183.9526418943146, 30969.225769355948, 30972.690273097433, 31526.684733152833, 31734.206644834063, 31931.361372772415, 1084.2356138922041, 1159.8550181227347, 1166.87278094707, 1217.6347095871204, 1241.2862604002735, 16006.839931600534, 16704.415345463094, 16732.0, 16791.812281577633, 16812.83187168137, 369017.85892846517, 373929.0, 375089.0, 375313.0, 375420.0, 53929.1910621341, 55530.72234638801, 55591.72204139034, 55601.1659825103, 55704.72147639236, 1217.549506682533, 1268.6764874956827, 1358.9388477518535, 1371.8216631837797, 1372.9107608005447, 27924.581131283452, 30877.536836947016, 31645.525317119802, 32448.675513244565, 35289.82355088208, 49695.75152124361, 50032.499675002786, 50308.24537631865, 50458.74770626123, 50491.242631359826, 319515.0, 320691.0, 321438.0, 322133.0, 323561.0, 24154.75845241525, 27223.0, 28190.577141342485, 28316.15051548457, 28411.147665570064, 43063.35404968991, 43141.568584313754, 44032.339514906664, 44150.55849441465, 44623.55376446194, 37051.81474092612, 37470.56676781906, 37621.0, 37762.43356349712, 37797.43303850389, 36193.55999280463, 36356.45465318075, 37040.444393333586, 37468.62531374651, 37614.0, 37266.25467490689, 37417.43873841949, 38070.0, 38078.428823568225, 38232.0, 31940.36119277648, 33249.88530051281, 33416.665833342326, 33769.3246135071, 33910.491342630376, 25744.356391090372, 26093.347666308495, 26117.347066323495, 26141.738582614693, 26192.214233573024], "value": 18397.480898537815, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.1975790960029, 399.4407829039345, 400.3814107204369, 402.1534669520659, 409.91596722671835, 17682.29270829167, 18275.177617007233, 18309.542261443472, 18379.26482940681, 19134.234630614792, 18016.729749053775, 18103.547411314725, 18906.0, 18940.905295473538, 18955.0, 5384.326959130109, 5502.532284755791, 5708.8296899135785, 5721.713914304289, 5734.913976290359, 5628.32460104788, 5637.774489020434, 5662.207290979266, 5675.290588676416, 5684.801031963882, 5573.5819813514145, 5641.8589535261535, 5645.15322701596, 5675.722962333462, 5680.886382272352, 5614.915776263339, 5731.541476681856, 5735.827925162252, 5752.539796816244, 5773.134029895528, 5502.752376143083, 5566.463675959047, 5649.209110724501, 5654.067078932012, 5659.943400565983, 20637.58724825495, 20723.896380518152, 20839.5832083359, 22139.225127120473, 22164.335069947767, 2210.4473881529616, 2220.1452440810244, 2288.439332363582, 2307.8384513084093, 2374.1809075868796, 9879.901200988043, 10106.797864042752, 10118.595256189743, 10538.104261137813, 10539.420331881744, 1914.4352416037302, 1927.3061697788926, 1955.6773132433132, 2021.3834780391974, 2023.979760202394, 68529.54557953717, 72647.27352726458, 74890.0, 75572.24427755707, 77608.0, 10691.572337106429, 10795.244332896622, 10832.891671083345, 10984.780304393867, 11145.164112691418, 15455.072695638297, 15625.609359766097, 15628.609284767972, 15652.4521641742, 15658.138802365751, 7211.639418029077, 7460.776176714708, 7480.850382992309, 7553.924460755432, 7554.697812087455, 6807.0, 6871.415929646036, 6963.338482844122, 6975.3024697530855, 6975.953606958997, 4668.393108895822, 4784.114938736345, 4797.160496913027, 4817.325574419584, 4834.468208497063, 1820.963580728378, 1869.2149297295168, 1897.8386837118724, 1922.1542521290587, 1948.795376485477, 876.9429987050821, 992.2260636703382, 1014.2038499777786, 1015.3248090020202, 1042.8696412948382, 17923.283068677367, 18543.81456185448, 19013.524661883286, 19228.615427691646, 19381.4185574433, 944.460529337176, 944.6693657219918, 955.7753927826955, 967.0426277984885, 994.9701508954743, 10215.846762298572, 10471.68584942453, 10618.946905265424, 10631.46842657864, 10636.574537018432, 447883.0, 450306.0, 453033.0, 478753.0, 484149.0, 86035.13964860396, 87784.0, 88268.11731882728, 89009.0, 89061.0, 979.872616559857, 987.3532835992437, 991.0139411285672, 1004.3321191407778, 1005.666852901262, 16269.918650406673, 16331.0, 16423.17884105766, 16451.9177404117, 16510.83489165093, 35745.0, 35876.28247434984, 36022.27955440824, 36731.26537469289, 36764.44853327149, 50552.49447505478, 52029.0, 52226.0, 52355.0, 52655.73672131615, 7551.207123251979, 7875.1731068239305, 7953.602319883867, 8051.1948805121365, 8728.956355218183, 9038.728838134866, 11223.4388280584, 12861.228326300452, 12927.676808079874, 13120.147190432592, 6376.202974628171, 9500.857487137837, 11063.834042489209, 11737.589184378507, 11836.881631183922, 11420.086393088699, 11476.770464590494, 11626.593069242535, 11654.533818647498, 11667.183297169116, 11581.42092895335, 11604.709882253012, 11802.527898884291, 12063.819042714542, 12110.576129835767, 7873.37013038967, 7974.84050319002, 7989.320907722677, 8041.517508949481, 8259.752207433787, 10891.782164356828, 11280.7743845121, 11771.176017678681, 11795.056395488513, 11917.16579839403], "value": 8861.08589383482, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1294.094134106126, 1495.289737374747, 1501.759718445049, 1651.7109505836484, 1801.7027190513566, 7256.346928776409, 7516.661750221239, 7525.247475252472, 7531.736389226378, 7535.472516923811, 7268.382187514055, 7447.851042979137, 7456.254374562541, 7458.0, 7459.142198647157, 1995.5510010247724, 2057.5987682401937, 2267.0818318581, 2288.302067869299, 2325.3721495196287, 2301.8158547316257, 2317.687112239851, 2319.5592837360846, 2322.512272422793, 2325.197806756666, 2270.14869423966, 2279.544091181762, 2296.575133600281, 2297.6668383084443, 2298.9885050574726, 1941.223510595766, 2000.9499762505982, 2139.893005349726, 2207.073029327686, 2223.399682085836, 2271.3867255840833, 2277.2598905355826, 2285.337252196861, 2285.6228722260807, 2287.5996700577334, 7418.517796343221, 7473.290037446434, 7476.36450901674, 7482.326590606817, 7487.8502429951095, 4604.723716576983, 4726.858194254178, 4759.666823322369, 4762.071396077767, 4766.6901651392545, 2965.4662160811044, 3028.9394212115635, 3107.564940908275, 3109.9222519437194, 3130.9530357044664, 1023.703126093432, 1028.4857571214393, 1034.0900007992918, 1038.8285932821075, 1039.9220058495569, 10034.24743144267, 10104.999999999927, 10145.289829711923, 10164.695059148164, 10239.334443261165, 4226.260404429213, 4232.957670423257, 4362.847300344472, 4403.119376124788, 4503.324501324828, 8785.912140878638, 8875.201231889161, 8876.245519130816, 8893.955530222307, 8894.28845692343, 4920.237363208708, 4925.975370123127, 4939.6542242042715, 4945.0, 4947.876303092451, 4070.921205880444, 4416.183006143874, 4515.616172625364, 4530.682852200314, 4537.841175558906, 3768.340540405418, 3839.9040023999064, 3867.7679339239735, 3877.302085624615, 3895.2014836958356, 1227.7974134267745, 1236.505397840871, 1238.182799352423, 1254.6047994881583, 1259.389196239823, 964.1708131007329, 981.1169947047572, 982.2485798364257, 1063.4470075560664, 1248.1138391741965, 7149.89275160873, 7172.46206534512, 7191.748288809867, 7223.133224013152, 7227.602481863443, 498.4517031265651, 501.39331408995525, 504.2788811998877, 506.3215291509395, 508.280782692486, 5602.4957753802355, 5666.036773748473, 5705.429457054262, 5716.999525083093, 5755.107958266475, 8980.730578082668, 9262.490563019099, 9304.953475232716, 9305.581248843819, 9333.439993600407, 8918.821623567623, 9169.35814492979, 9232.122948319899, 9278.443293402417, 9280.118388753057, 7161.248068952789, 7164.892526612105, 7227.3134052266005, 7230.060092188087, 7274.563526188445, 6925.27284635106, 7042.577445353295, 7044.119485064367, 7056.082709247765, 7073.3987611053635, 8387.538685372363, 8462.746117616482, 8568.871466927876, 8576.228139467477, 8616.870746938926, 8614.870776938225, 8623.180797824196, 8696.0, 8716.651333946571, 8827.602757875782, 6167.5374346925055, 6402.775902843378, 6577.835554111186, 6614.305497922649, 6638.236602790741, 7034.613096279753, 7045.964770176116, 7081.504294699322, 7099.787006389816, 7100.0414943981905, 6337.302896681454, 6575.80272591823, 6613.041109039259, 6634.914764634275, 6724.8567743482745, 6400.071989561395, 6417.550771445954, 6476.740930362733, 6482.060101285193, 6505.31694172124, 6667.266600674019, 6673.8998915015345, 6695.096162018065, 6703.229128650268, 6717.932820671731, 6191.876162476815, 6224.782132625336, 6229.470495007975, 6229.595076320206, 6266.749330026931, 6443.871122577616, 6470.48236141117, 6501.934980650322, 6505.869882602226, 6515.02274658805], "value": 4325.5832489672475, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.1638336924427, 338.9525466434698, 341.62421336529815, 341.9059758566394, 344.936186805441, 5574.832755017351, 5621.57838162138, 5634.211210430538, 5635.464630860072, 5645.266115404992, 5544.306961629796, 5552.77788888444, 5557.416471270519, 5561.63849349792, 5562.888742225153, 4026.174634199982, 4037.7577345359373, 4280.657547396217, 4347.369631403445, 4362.323839804835, 4332.988572941791, 4337.284348082579, 4337.934930976038, 4351.26028575143, 4362.520122786491, 4300.483941926973, 4301.2902871026245, 4310.525842157376, 4310.935335969963, 4327.913441731163, 4102.8974275643195, 4209.126938512348, 4290.2706539888295, 4320.611144996934, 4338.913221735579, 3809.2191100824266, 3817.0838998640124, 3822.2164456286396, 3823.495610375209, 3824.770513769183, 5402.648827826218, 5409.594280428944, 5409.783608655649, 5422.186671999192, 5424.403315635277, 4849.466558678542, 4947.356843610343, 4985.579109953682, 4993.0, 4997.250412438127, 5767.798127065533, 5790.594658373915, 5806.970965145148, 5826.504747096459, 5828.41715828418, 4194.161167766459, 4209.7474151551005, 4210.894727631803, 4214.557471465513, 4216.177845320164, 5881.500072493843, 6034.758609655564, 6047.969760151171, 6071.0, 6109.205803245594, 4294.377315289328, 4298.849540266076, 4303.548127446636, 4314.762688052125, 4329.761863097497, 4318.568143185719, 4330.7401555906745, 4337.869863904088, 4343.457067866517, 4349.869034051107, 4811.0, 4924.926126108111, 4936.827211047596, 4959.652824302337, 4970.801167953241, 5852.209951656557, 5865.970670146708, 5871.94128058714, 5872.970635146797, 5905.557083218776, 1496.2817847433294, 1501.69215310861, 1515.454436402894, 1528.9311980960883, 1533.2946844451676, 985.4432245781111, 1016.2936758952604, 1035.1977217656377, 1061.8513408122715, 1063.5852017713098, 5480.424555421703, 5499.257600223918, 5638.802641907513, 5776.826695199151, 5781.306243250753, 6111.724972376253, 6139.84650383744, 6154.169187159766, 6156.907646385308, 6171.321154672983, 5579.721013949367, 5730.5129064030025, 5741.942580574224, 5745.511631511285, 5760.107183386582, 3234.0, 3247.5291082792864, 3254.1376535218187, 3260.2175477885135, 3264.3308121835444, 6058.545609079337, 6231.844203894939, 6238.812835614939, 6269.8746025079245, 6288.654124023131, 6219.626822390671, 6231.345708700612, 6231.4391704746795, 6235.844103897439, 6243.313235544087, 6220.564560480813, 6247.562670613104, 6257.186565746424, 6270.122182894398, 6274.403931626488, 5804.419558044331, 6056.848578785565, 6071.0, 6080.72636731357, 6124.479419249414, 5984.16221728967, 5993.6104153231645, 6000.189974353581, 6000.309964353981, 6046.879062418639, 6041.607295525777, 6293.590916590407, 6295.653739044396, 6295.874082518232, 6297.496200303873, 4247.808848601759, 4251.44731184944, 4268.573142685706, 4281.507626622853, 4282.614564689193, 6046.57673962836, 6076.483498902643, 6088.695565221633, 6098.481629061402, 6147.047207682816, 5764.7405866736935, 5967.254093238345, 5983.461488466059, 5989.64062156272, 5998.25021872266, 5907.645541267538, 5932.851678708067, 5937.851553711192, 5941.1385349123275, 5942.0, 5371.570274377962, 5548.722563871871, 5805.506531944663, 5831.533477321889, 5847.736851841592, 5945.970270148621, 5950.16697662319, 5974.551908606959, 5976.312724036791, 5980.501406677143, 5665.830025099253, 5822.446867547576, 5827.5337972961215, 5851.0, 5853.473187413153], "value": 4484.597540668092, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [759.077720569508, 761.8971438855756, 819.8237378963522, 836.1178956201213, 867.8220964702234, 13977.371018304175, 14280.71438571228, 14298.499552515637, 14313.355898984544, 14358.066725662839, 13744.931275343633, 14230.0, 14272.286385680727, 14305.141691498491, 14312.785308220358, 676.5906626490976, 804.7867315161487, 808.5795386399069, 811.8619834628098, 820.3109388113983, 819.4714409206058, 820.335528222142, 821.4455242711176, 823.259066839843, 823.3372135430976, 869.1221865915439, 870.0168809245544, 870.3124531620012, 870.7431307764193, 871.6208449324532, 702.4029574861353, 720.3552820225894, 841.6591280531395, 867.1805144138791, 868.8262347530488, 625.2809269340249, 632.5192853431425, 633.9904901426436, 634.2674211285926, 634.6731433311849, 13880.51418200358, 13881.583552493441, 13894.096883702527, 13911.721765564733, 13947.302634868318, 13089.47642094315, 13163.144395614254, 13265.336733163304, 13392.86607133926, 13539.039361505493, 11375.431228438545, 11380.886191138065, 11464.369459679714, 11497.770044599145, 11774.646760597196, 3823.6941044716355, 3840.9039774005596, 3876.0503676599133, 3920.8431662733456, 3942.802859856996, 53756.46243537593, 53965.1905221422, 53970.0, 54222.0, 54683.453165468236, 10469.581216751398, 10981.12151027916, 11005.559777608805, 11024.779504409868, 11035.503402346914, 18900.71648925267, 18958.43124706261, 18967.43097707071, 18972.0, 18980.715289270673, 7796.0, 7915.287624113857, 8181.713640022571, 8234.629441675139, 8254.05078415978, 4646.7444290564345, 4676.0, 4689.109069276827, 4759.785809638574, 4790.4969978152485, 3312.5528053712924, 3415.0, 3417.487376893486, 3417.8803741868915, 3421.9828900855337, 593.9168516407707, 621.6363427394934, 633.8130251575797, 649.1334069017914, 651.7686221391433, 732.5824280160364, 749.4079677055174, 757.3978686943893, 778.5523324088672, 801.6753214947955, 8660.783480412914, 8757.0, 8980.68567600144, 8983.326250531236, 9062.139096785795, 667.6761770541381, 705.6721750781578, 721.5594418087666, 761.2996043639864, 767.8656235158825, 4224.852130175429, 4314.352847072902, 4348.63036641889, 4397.1205758848355, 4427.446569178853, 64562.0, 66139.0, 67412.662936685, 67416.325836741, 67461.66269168623, 55528.44471555233, 55588.166177507366, 55684.443155567926, 57395.0, 58514.12228816571, 51319.328487296414, 51775.0, 52857.47142528602, 53014.0, 54284.18573721397, 8294.83410331802, 8422.452540584842, 8565.229129378386, 8610.65557377698, 8644.178803013703, 33409.665903340654, 33625.66374336225, 33933.32133357369, 34069.318613627096, 34843.47734784031, 43250.35124473072, 46846.76576617095, 47167.0, 47252.52747472481, 47680.0, 11034.944825275823, 11051.889481105407, 11092.389918554558, 11359.432028398382, 11371.260868043551, 11913.344766037952, 12043.91604755541, 12087.758244834878, 12173.939130304292, 12177.0, 10906.563737450731, 11173.967509096978, 11199.760944270327, 11212.15908806859, 11334.319940803578, 11907.940460297643, 11974.700632484257, 12033.578824741093, 12088.456019479321, 12098.395080246128, 10912.181586380895, 11034.889651103707, 11250.662480125282, 11282.94358528202, 11622.128340374336, 9981.950090249502, 10083.294169408071, 10094.949525252327, 10099.646512372032, 10541.57833686644, 9082.228010618906, 9481.288903332415, 9551.904480955101, 9699.0, 9923.950380248052], "value": 6639.052617658662, "unit": "score"}], "name": "dromaeo_css", "value": 6938.072552713828, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 104.0, 111.0, 111.0, 111.0, 99.0, 111.0, 111.0, 110.0], "value": 108.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 134.0, 154.0, 184.0, 128.0, 158.0, 150.0, 132.0, 183.0, 124.0], "value": 151.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 161.0, 161.0, 160.0, 162.0, 161.0, 160.0, 161.0, 160.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 106.0, 119.0, 73.0, 76.0, 73.0, 123.0, 106.0, 74.0], "value": 90.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 152.0, 93.0, 94.0, 93.0, 155.0, 93.0, 94.0, 148.0], "value": 110.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 118.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 146.0, 147.0, 144.0, 145.0, 145.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 94.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 58.0, 57.0, 56.0, 57.0, 60.0, 81.0, 66.0, 54.0], "value": 60.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 61.0, 63.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 81.0, 81.0, 89.0, 80.0, 80.0, 81.0, 80.0, 87.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 129.0, 127.0, 132.0, 132.0, 127.0, 124.0, 125.0, 204.0, 128.0], "value": 136.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 163.0, 168.0, 164.0, 165.0, 163.0, 171.0, 164.0, 167.0, 170.0], "value": 166.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 67.0, 67.0, 69.0, 69.0, 66.0, 69.0, 68.0, 66.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1555.5, "alertThreshold": 2.0}]} 09:03:25 INFO - Return code: 0 09:03:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:03:25 ERROR - # TBPL SUCCESS # 09:03:25 INFO - Running post-action listener: _resource_record_post_action 09:03:25 INFO - Running post-run listener: _resource_record_post_run 09:03:26 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 8192; Write bytes: 534372352; Read time: 36; Write time: 1237892 09:03:26 INFO - install - Wall time: 17s; CPU: 16.0%; Read bytes: 0; Write bytes: 241909760; Read time: 0; Write time: 603244 09:03:26 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 8192; Write bytes: 290217984; Read time: 36; Write time: 634268 09:03:26 INFO - Running post-run listener: _upload_blobber_files 09:03:26 INFO - Blob upload gear active. 09:03:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:03:26 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 09:03:26 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-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:03:26 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-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:03:26 INFO - (blobuploader) - INFO - Open directory for files ... 09:03:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:03:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:03:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:27 INFO - (blobuploader) - INFO - Done attempting. 09:03:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:03:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:03:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:28 INFO - (blobuploader) - INFO - Done attempting. 09:03:28 INFO - (blobuploader) - INFO - Iteration through files over. 09:03:28 INFO - Return code: 0 09:03:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:03:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:03:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f243024c314bc7c5d988bfb3c7778bb7dc42f39743f072838f89e25f0803d45ffb721115ea1cf1b784dbb4f1fac895ef20ec0b14f16f02eba374f43d73db0536", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c8ea42e296e57db24a993bd012eda1832300b5d79f8aef33aef83d5c940dd7f5b0c6fb9c348a99a620ceac3691e14e7552eb717c166dd8df8755aa381c456d87"} 09:03:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:03:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:03:28 INFO - Contents: 09:03:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f243024c314bc7c5d988bfb3c7778bb7dc42f39743f072838f89e25f0803d45ffb721115ea1cf1b784dbb4f1fac895ef20ec0b14f16f02eba374f43d73db0536", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c8ea42e296e57db24a993bd012eda1832300b5d79f8aef33aef83d5c940dd7f5b0c6fb9c348a99a620ceac3691e14e7552eb717c166dd8df8755aa381c456d87"} 09:03:28 INFO - Running post-run listener: copy_logs_to_upload_dir 09:03:28 INFO - Copying logs to upload dir... 09:03:28 INFO - mkdir: /builds/slave/test/build/upload/logs 09:03:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.303071 ========= master_lag: 61.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 33 secs) (at 2016-04-15 09:04:29.422645) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 09:04:29.431601) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1460734974.766806-367780479 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-Inbound/sha512/f243024c314bc7c5d988bfb3c7778bb7dc42f39743f072838f89e25f0803d45ffb721115ea1cf1b784dbb4f1fac895ef20ec0b14f16f02eba374f43d73db0536", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c8ea42e296e57db24a993bd012eda1832300b5d79f8aef33aef83d5c940dd7f5b0c6fb9c348a99a620ceac3691e14e7552eb717c166dd8df8755aa381c456d87"} build_url:https://queue.taskcluster.net/v1/task/VONXSUoCSDuWKx8eztikbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011374 build_url: 'https://queue.taskcluster.net/v1/task/VONXSUoCSDuWKx8eztikbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f243024c314bc7c5d988bfb3c7778bb7dc42f39743f072838f89e25f0803d45ffb721115ea1cf1b784dbb4f1fac895ef20ec0b14f16f02eba374f43d73db0536", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c8ea42e296e57db24a993bd012eda1832300b5d79f8aef33aef83d5c940dd7f5b0c6fb9c348a99a620ceac3691e14e7552eb717c166dd8df8755aa381c456d87"}' ========= master_lag: 0.45 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 09:04:29.896267) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 09:04:29.896652) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1460734974.766806-367780479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004522 ========= master_lag: 0.17 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 09:04:30.072760) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 09:04:30.073092) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 09:04:30.073404) ========= ========= Total master_lag: 61.71 =========