builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-066 starttime: 1464621275.97 results: success (0) buildid: 20160530035543 builduid: 865ed214ad954ae683a81bd20aaeb948 revision: 04934785596476f6dd8baccc355202aeba59af35 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 08:14:35.973428) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 08:14:35.973903) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 08:14:35.974192) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 08:14:35.989958) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 08:14:35.990371) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1464621275.769637-1846102734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-30 08:14:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-05-30 08:14:36 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108223 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 08:14:36.112786) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 08:14:36.113129) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1464621275.769637-1846102734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013751 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 08:14:36.162436) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 08:14:36.162836) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 04934785596476f6dd8baccc355202aeba59af35 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 04934785596476f6dd8baccc355202aeba59af35 --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=82c74bd3bc9a11c5833d2010000001e6-1464621275.769637-1846102734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-30 08:14:36,667 truncating revision to first 12 chars 2016-05-30 08:14:36,667 Setting DEBUG logging. 2016-05-30 08:14:36,667 attempt 1/10 2016-05-30 08:14:36,667 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/049347855964?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-30 08:14:37,010 unpacking tar archive at: mozilla-aurora-049347855964/testing/mozharness/ program finished with exit code 0 elapsedTime=0.680572 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 08:14:36.856921) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 08:14:36.857270) ========= script_repo_revision: 04934785596476f6dd8baccc355202aeba59af35 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 08:14:36.857684) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 08:14:36.857960) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 08:14:36.866372) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-05-30 08:14:36.866822) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=82c74bd3bc9a11c5833d2010000001e6-1464621275.769637-1846102734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:14:37 INFO - MultiFileLogger online at 20160530 08:14:37 in /builds/slave/test 08:14:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:14:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:14:37 INFO - {'append_to_log': False, 08:14:37 INFO - 'base_work_dir': '/builds/slave/test', 08:14:37 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:14:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:14:37 INFO - 'branch': 'Mozilla-Aurora', 08:14:37 INFO - 'buildbot_json_path': 'buildprops.json', 08:14:37 INFO - 'config_files': ('talos/linux_config.py',), 08:14:37 INFO - 'default_actions': ('clobber', 08:14:37 INFO - 'read-buildbot-config', 08:14:37 INFO - 'download-and-extract', 08:14:37 INFO - 'populate-webroot', 08:14:37 INFO - 'create-virtualenv', 08:14:37 INFO - 'install', 08:14:37 INFO - 'run-tests'), 08:14:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:14:37 INFO - 'download_minidump_stackwalk': True, 08:14:37 INFO - 'download_symbols': 'ondemand', 08:14:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:14:37 INFO - 'tooltool.py': '/tools/tooltool.py', 08:14:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:14:37 INFO - '/tools/misc-python/virtualenv.py')}, 08:14:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:14:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:14:37 INFO - 'installer_path': 'installer.exe', 08:14:37 INFO - 'log_level': 'info', 08:14:37 INFO - 'log_name': 'talos', 08:14:37 INFO - 'log_to_console': True, 08:14:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:14:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:14:37 INFO - 'opt_config_files': (), 08:14:37 INFO - 'pip_index': False, 08:14:37 INFO - 'sps_profile': False, 08:14:37 INFO - 'sps_profile_interval': 0, 08:14:37 INFO - 'suite': 'dromaeojs', 08:14:37 INFO - 'system_bits': '32', 08:14:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:14:37 INFO - 'title': 'talos-linux64-ix-066', 08:14:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:14:37 INFO - 'use_talos_json': True, 08:14:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:14:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:14:37 INFO - 'work_dir': 'build'} 08:14:37 INFO - ##### 08:14:37 INFO - ##### Running clobber step. 08:14:37 INFO - ##### 08:14:37 INFO - Running pre-action listener: _resource_record_pre_action 08:14:37 INFO - Running main action method: clobber 08:14:37 INFO - rmtree: /builds/slave/test/build 08:14:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:14:37 INFO - Running post-action listener: _resource_record_post_action 08:14:37 INFO - ##### 08:14:37 INFO - ##### Running read-buildbot-config step. 08:14:37 INFO - ##### 08:14:37 INFO - Running pre-action listener: _resource_record_pre_action 08:14:37 INFO - Running main action method: read_buildbot_config 08:14:37 INFO - Using buildbot properties: 08:14:37 INFO - { 08:14:37 INFO - "project": "", 08:14:37 INFO - "product": "firefox", 08:14:37 INFO - "script_repo_revision": "production", 08:14:37 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 08:14:37 INFO - "repository": "", 08:14:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 08:14:37 INFO - "buildid": "20160530035543", 08:14:37 INFO - "pgo_build": "True", 08:14:37 INFO - "basedir": "/builds/slave/test", 08:14:37 INFO - "buildnumber": 271, 08:14:37 INFO - "slavename": "talos-linux64-ix-066", 08:14:37 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:14:37 INFO - "platform": "ubuntu64_hw", 08:14:37 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 08:14:37 INFO - "branch": "mozilla-aurora", 08:14:37 INFO - "repo_path": "releases/mozilla-aurora", 08:14:37 INFO - "revision": "04934785596476f6dd8baccc355202aeba59af35", 08:14:37 INFO - "stage_platform": "linux64-pgo", 08:14:37 INFO - "builduid": "865ed214ad954ae683a81bd20aaeb948", 08:14:37 INFO - "slavebuilddir": "test" 08:14:37 INFO - } 08:14:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 08:14:37 INFO - Running post-action listener: _resource_record_post_action 08:14:37 INFO - ##### 08:14:37 INFO - ##### Running download-and-extract step. 08:14:37 INFO - ##### 08:14:37 INFO - Running pre-action listener: _resource_record_pre_action 08:14:37 INFO - Running main action method: download_and_extract 08:14:37 INFO - mkdir: /builds/slave/test/build/tests 08:14:37 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:14:37 INFO - https://queue.taskcluster.net/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:14:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 08:14:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 08:14:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 08:14:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:14:38 INFO - Downloaded 1361 bytes. 08:14:38 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 08:14:38 INFO - Using the following test package requirements: 08:14:38 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 08:14:38 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 08:14:38 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 08:14:38 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 08:14:38 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 08:14:38 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 08:14:38 INFO - u'jsshell-linux-x86_64.zip'], 08:14:38 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 08:14:38 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 08:14:38 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 08:14:38 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 08:14:38 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 08:14:38 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 08:14:38 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 08:14:38 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 08:14:38 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 08:14:38 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 08:14:38 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 08:14:38 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:38 INFO - https://queue.taskcluster.net/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:14:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 08:14:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 08:14:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 08:14:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:14:39 INFO - Downloaded 24135385 bytes. 08:14:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:14:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:14:41 INFO - Return code: 0 08:14:41 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:14:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:41 INFO - https://queue.taskcluster.net/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:14:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 08:14:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 08:14:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 08:14:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:14:42 INFO - Downloaded 24135385 bytes. 08:14:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:14:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:14:43 INFO - Return code: 0 08:14:43 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:14:43 INFO - https://queue.taskcluster.net/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:14:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 08:14:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 08:14:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 08:14:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:14:44 INFO - Downloaded 10840145 bytes. 08:14:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:14:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:14:44 INFO - Return code: 0 08:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:44 INFO - https://queue.taskcluster.net/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:14:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 08:14:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 08:14:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 08:14:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:14:46 INFO - Downloaded 62736116 bytes. 08:14:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 08:14:46 INFO - mkdir: /builds/slave/test/properties 08:14:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:14:46 INFO - Writing to file /builds/slave/test/properties/build_url 08:14:46 INFO - Contents: 08:14:46 INFO - build_url:https://queue.taskcluster.net/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 08:14:46 INFO - Running post-action listener: _resource_record_post_action 08:14:46 INFO - Running post-action listener: set_extra_try_arguments 08:14:46 INFO - ##### 08:14:46 INFO - ##### Running populate-webroot step. 08:14:46 INFO - ##### 08:14:46 INFO - Running pre-action listener: _resource_record_pre_action 08:14:46 INFO - Running main action method: populate_webroot 08:14:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:14:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:14:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:14:46 INFO - '--tppagecycles', 08:14:46 INFO - '7'], 08:14:46 INFO - 'tests': ['tsvgm']}}, 08:14:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:14:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:14:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:14:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:14:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:14:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:14:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:46 INFO - 'talos_options': ['--disable-e10s'], 08:14:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:14:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:14:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:46 INFO - 'talos_options': ['--disable-e10s'], 08:14:46 INFO - 'tests': ['damp', 'tps']}, 08:14:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:46 INFO - 'tests': ['damp', 'tps']}, 08:14:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:14:46 INFO - 'tests': ['dromaeo_dom']}, 08:14:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:14:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:14:46 INFO - 'tests': ['a11yr', 08:14:46 INFO - 'ts_paint', 08:14:46 INFO - 'tpaint', 08:14:46 INFO - 'sessionrestore', 08:14:46 INFO - 'sessionrestore_no_auto_restore', 08:14:46 INFO - 'tabpaint']}, 08:14:46 INFO - 'other-e10s': {'tests': ['a11yr', 08:14:46 INFO - 'ts_paint', 08:14:46 INFO - 'tpaint', 08:14:46 INFO - 'sessionrestore', 08:14:46 INFO - 'sessionrestore_no_auto_restore', 08:14:46 INFO - 'tabpaint']}, 08:14:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:14:46 INFO - 'ts_paint', 08:14:46 INFO - 'tpaint', 08:14:46 INFO - 'sessionrestore', 08:14:46 INFO - 'sessionrestore_no_auto_restore', 08:14:46 INFO - 'tabpaint']}, 08:14:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:14:46 INFO - 'ts_paint', 08:14:46 INFO - 'tpaint', 08:14:46 INFO - 'sessionrestore', 08:14:46 INFO - 'sessionrestore_no_auto_restore', 08:14:46 INFO - 'tabpaint']}, 08:14:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:14:46 INFO - 'tests': ['a11yr', 08:14:46 INFO - 'ts_paint', 08:14:46 INFO - 'tpaint', 08:14:46 INFO - 'sessionrestore', 08:14:46 INFO - 'sessionrestore_no_auto_restore', 08:14:46 INFO - 'tabpaint']}, 08:14:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:14:46 INFO - 'tests': ['a11yr', 08:14:46 INFO - 'ts_paint', 08:14:46 INFO - 'tpaint', 08:14:46 INFO - 'sessionrestore', 08:14:46 INFO - 'sessionrestore_no_auto_restore', 08:14:46 INFO - 'tabpaint']}, 08:14:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:14:46 INFO - 'tests': ['tsvgx', 08:14:46 INFO - 'tsvgr_opacity', 08:14:46 INFO - 'tart', 08:14:46 INFO - 'tscrollx', 08:14:46 INFO - 'cart']}, 08:14:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:14:46 INFO - 'tsvgr_opacity', 08:14:46 INFO - 'tart', 08:14:46 INFO - 'tscrollx', 08:14:46 INFO - 'cart']}, 08:14:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:46 INFO - 'talos_options': ['--disable-e10s'], 08:14:46 INFO - 'tests': ['tp5o']}, 08:14:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:46 INFO - 'tests': ['tp5o']}, 08:14:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:46 INFO - 'talos_options': ['--disable-e10s', 08:14:46 INFO - '--xperf_path', 08:14:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:14:46 INFO - 'tests': ['tp5n']}, 08:14:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:46 INFO - 'talos_options': ['--xperf_path', 08:14:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:14:46 INFO - 'tests': ['tp5n']}}, 08:14:46 INFO - 'talos.zip': {'path': '', 08:14:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:14:46 INFO - Running post-action listener: _resource_record_post_action 08:14:46 INFO - ##### 08:14:46 INFO - ##### Running create-virtualenv step. 08:14:46 INFO - ##### 08:14:46 INFO - Running pre-action listener: _resource_record_pre_action 08:14:46 INFO - Running main action method: create_virtualenv 08:14:46 INFO - Creating virtualenv /builds/slave/test/build/venv 08:14:46 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:14:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:14:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:14:46 INFO - Using real prefix '/usr' 08:14:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:14:47 INFO - Installing distribute.............................................................................................................................................................................................done. 08:14:49 INFO - Installing pip.................done. 08:14:49 INFO - Return code: 0 08:14:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:14:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f649fd78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b5b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bea410>, '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 0x1beb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1beb7a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464621275.769637-1846102734', '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:14:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:14:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:14:49 INFO - Using env: {'DISPLAY': ':0', 08:14:49 INFO - 'HOME': '/home/cltbld', 08:14:49 INFO - 'LANG': 'en_US.UTF-8', 08:14:49 INFO - 'LANGUAGE': 'en_US:en', 08:14:49 INFO - 'LOGNAME': 'cltbld', 08:14:49 INFO - 'MAIL': '/var/mail/cltbld', 08:14:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:49 INFO - 'MOZ_NO_REMOTE': '1', 08:14:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:49 INFO - 'NO_EM_RESTART': '1', 08:14:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:49 INFO - 'PWD': '/builds/slave/test', 08:14:49 INFO - 'SHELL': '/bin/bash', 08:14:49 INFO - 'SHLVL': '1', 08:14:49 INFO - 'TERM': 'linux', 08:14:49 INFO - 'TMOUT': '86400', 08:14:49 INFO - 'USER': 'cltbld', 08:14:49 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464621275.769637-1846102734', 08:14:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:49 INFO - '_': '/tools/buildbot/bin/python'} 08:14:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:49 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:14:49 INFO - Cleaning up... 08:14:49 INFO - Return code: 0 08:14:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:14:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f649fd78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b5b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bea410>, '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 0x1beb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1beb7a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464621275.769637-1846102734', '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:14:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:14:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:14:49 INFO - Using env: {'DISPLAY': ':0', 08:14:49 INFO - 'HOME': '/home/cltbld', 08:14:49 INFO - 'LANG': 'en_US.UTF-8', 08:14:49 INFO - 'LANGUAGE': 'en_US:en', 08:14:49 INFO - 'LOGNAME': 'cltbld', 08:14:49 INFO - 'MAIL': '/var/mail/cltbld', 08:14:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:49 INFO - 'MOZ_NO_REMOTE': '1', 08:14:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:49 INFO - 'NO_EM_RESTART': '1', 08:14:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:49 INFO - 'PWD': '/builds/slave/test', 08:14:49 INFO - 'SHELL': '/bin/bash', 08:14:49 INFO - 'SHLVL': '1', 08:14:49 INFO - 'TERM': 'linux', 08:14:49 INFO - 'TMOUT': '86400', 08:14:49 INFO - 'USER': 'cltbld', 08:14:49 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464621275.769637-1846102734', 08:14:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:49 INFO - '_': '/tools/buildbot/bin/python'} 08:14:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:49 INFO - Downloading/unpacking psutil>=0.7.1 08:14:49 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:14:49 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:14:49 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:14:49 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:14:49 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:14:49 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:14:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:14:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:14:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:14:51 INFO - Installing collected packages: psutil 08:14:51 INFO - Running setup.py install for psutil 08:14:52 INFO - building 'psutil._psutil_linux' extension 08:14:52 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:14:52 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:14:52 INFO - building 'psutil._psutil_posix' extension 08:14:52 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:14:52 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:14:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:14:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:14:52 INFO - Successfully installed psutil 08:14:52 INFO - Cleaning up... 08:14:52 INFO - Return code: 0 08:14:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:14:52 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:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:52 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:14:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:52 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 0x7f649fd78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b5b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bea410>, '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 0x1beb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1beb7a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464621275.769637-1846102734', '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:14:52 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:14:52 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:14:52 INFO - Using env: {'DISPLAY': ':0', 08:14:52 INFO - 'HOME': '/home/cltbld', 08:14:52 INFO - 'LANG': 'en_US.UTF-8', 08:14:52 INFO - 'LANGUAGE': 'en_US:en', 08:14:52 INFO - 'LOGNAME': 'cltbld', 08:14:52 INFO - 'MAIL': '/var/mail/cltbld', 08:14:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:52 INFO - 'MOZ_NO_REMOTE': '1', 08:14:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:52 INFO - 'NO_EM_RESTART': '1', 08:14:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:52 INFO - 'PWD': '/builds/slave/test', 08:14:52 INFO - 'SHELL': '/bin/bash', 08:14:52 INFO - 'SHLVL': '1', 08:14:52 INFO - 'TERM': 'linux', 08:14:52 INFO - 'TMOUT': '86400', 08:14:52 INFO - 'USER': 'cltbld', 08:14:52 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464621275.769637-1846102734', 08:14:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:52 INFO - '_': '/tools/buildbot/bin/python'} 08:14:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:14:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:14:54 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:14:54 INFO - Installing collected packages: mozsystemmonitor 08:14:54 INFO - Running setup.py install for mozsystemmonitor 08:14:54 INFO - Successfully installed mozsystemmonitor 08:14:54 INFO - Cleaning up... 08:14:54 INFO - Return code: 0 08:14:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f649fd78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b5b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bea410>, '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 0x1beb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1beb7a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464621275.769637-1846102734', '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:14:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:14:54 INFO - Using env: {'DISPLAY': ':0', 08:14:54 INFO - 'HOME': '/home/cltbld', 08:14:54 INFO - 'LANG': 'en_US.UTF-8', 08:14:54 INFO - 'LANGUAGE': 'en_US:en', 08:14:54 INFO - 'LOGNAME': 'cltbld', 08:14:54 INFO - 'MAIL': '/var/mail/cltbld', 08:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:54 INFO - 'MOZ_NO_REMOTE': '1', 08:14:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:54 INFO - 'NO_EM_RESTART': '1', 08:14:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:54 INFO - 'PWD': '/builds/slave/test', 08:14:54 INFO - 'SHELL': '/bin/bash', 08:14:54 INFO - 'SHLVL': '1', 08:14:54 INFO - 'TERM': 'linux', 08:14:54 INFO - 'TMOUT': '86400', 08:14:54 INFO - 'USER': 'cltbld', 08:14:54 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464621275.769637-1846102734', 08:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:54 INFO - '_': '/tools/buildbot/bin/python'} 08:14:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:54 INFO - Downloading/unpacking blobuploader==1.2.4 08:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:57 INFO - Downloading blobuploader-1.2.4.tar.gz 08:14:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:14:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:14:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:57 INFO - Downloading docopt-0.6.1.tar.gz 08:14:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:14:57 INFO - Installing collected packages: blobuploader, requests, docopt 08:14:57 INFO - Running setup.py install for blobuploader 08:14:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:14:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:14:57 INFO - Running setup.py install for requests 08:14:58 INFO - Running setup.py install for docopt 08:14:58 INFO - Successfully installed blobuploader requests docopt 08:14:58 INFO - Cleaning up... 08:14:58 INFO - Return code: 0 08:14:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:58 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:14:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:58 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:14:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:58 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 0x7f649fd78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b5b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bea410>, '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 0x1beb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1beb7a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464621275.769637-1846102734', '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:14:58 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:14:58 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:14:58 INFO - Using env: {'DISPLAY': ':0', 08:14:58 INFO - 'HOME': '/home/cltbld', 08:14:58 INFO - 'LANG': 'en_US.UTF-8', 08:14:58 INFO - 'LANGUAGE': 'en_US:en', 08:14:58 INFO - 'LOGNAME': 'cltbld', 08:14:58 INFO - 'MAIL': '/var/mail/cltbld', 08:14:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:58 INFO - 'MOZ_NO_REMOTE': '1', 08:14:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:58 INFO - 'NO_EM_RESTART': '1', 08:14:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:58 INFO - 'PWD': '/builds/slave/test', 08:14:58 INFO - 'SHELL': '/bin/bash', 08:14:58 INFO - 'SHLVL': '1', 08:14:58 INFO - 'TERM': 'linux', 08:14:58 INFO - 'TMOUT': '86400', 08:14:58 INFO - 'USER': 'cltbld', 08:14:58 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464621275.769637-1846102734', 08:14:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:58 INFO - '_': '/tools/buildbot/bin/python'} 08:14:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:14:58 INFO - Running setup.py (path:/tmp/pip-2XlZLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:14:58 INFO - Running setup.py (path:/tmp/pip-5rLdIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:14:58 INFO - Running setup.py (path:/tmp/pip-k4aNuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:14:58 INFO - Running setup.py (path:/tmp/pip-STxlCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:14:58 INFO - Running setup.py (path:/tmp/pip-K2aYjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:14:58 INFO - Running setup.py (path:/tmp/pip-UXv7_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:14:59 INFO - Running setup.py (path:/tmp/pip-tngZcc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:14:59 INFO - Running setup.py (path:/tmp/pip-iiensR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:14:59 INFO - Running setup.py (path:/tmp/pip-FEBy9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:14:59 INFO - Running setup.py (path:/tmp/pip-XgvAjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:14:59 INFO - Running setup.py (path:/tmp/pip-TtUoW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:14:59 INFO - Running setup.py (path:/tmp/pip-DjKJA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:14:59 INFO - Running setup.py (path:/tmp/pip-Avn1db-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:14:59 INFO - Running setup.py (path:/tmp/pip-H0m7Hr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:59 INFO - Running setup.py (path:/tmp/pip-kcLcXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:14:59 INFO - Running setup.py (path:/tmp/pip-bgAp2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:14:59 INFO - Running setup.py (path:/tmp/pip-UYSLR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:14:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:14:59 INFO - Running setup.py install for manifestparser 08:14:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:14:59 INFO - Running setup.py install for mozcrash 08:15:00 INFO - Running setup.py install for mozdebug 08:15:00 INFO - Running setup.py install for mozdevice 08:15:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:15:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:15:00 INFO - Running setup.py install for mozfile 08:15:00 INFO - Running setup.py install for mozhttpd 08:15:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:15:00 INFO - Running setup.py install for mozinfo 08:15:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:15:00 INFO - Running setup.py install for mozInstall 08:15:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:15:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:15:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:15:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:15:00 INFO - Running setup.py install for mozleak 08:15:00 INFO - Running setup.py install for mozlog 08:15:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:15:00 INFO - Running setup.py install for moznetwork 08:15:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:15:00 INFO - Running setup.py install for mozprocess 08:15:01 INFO - Running setup.py install for mozprofile 08:15:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:15:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:15:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:15:01 INFO - Running setup.py install for mozrunner 08:15:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:15:01 INFO - Running setup.py install for mozscreenshot 08:15:01 INFO - Running setup.py install for moztest 08:15:01 INFO - Running setup.py install for mozversion 08:15:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:15:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:15:01 INFO - Cleaning up... 08:15:01 INFO - Return code: 0 08:15:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:15:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:01 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 0x7f649fd78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b5b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bea410>, '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 0x1beb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1beb7a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464621275.769637-1846102734', '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:15:01 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:15:01 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:15:01 INFO - Using env: {'DISPLAY': ':0', 08:15:01 INFO - 'HOME': '/home/cltbld', 08:15:01 INFO - 'LANG': 'en_US.UTF-8', 08:15:01 INFO - 'LANGUAGE': 'en_US:en', 08:15:01 INFO - 'LOGNAME': 'cltbld', 08:15:01 INFO - 'MAIL': '/var/mail/cltbld', 08:15:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:01 INFO - 'MOZ_NO_REMOTE': '1', 08:15:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:01 INFO - 'NO_EM_RESTART': '1', 08:15:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:01 INFO - 'PWD': '/builds/slave/test', 08:15:01 INFO - 'SHELL': '/bin/bash', 08:15:01 INFO - 'SHLVL': '1', 08:15:01 INFO - 'TERM': 'linux', 08:15:01 INFO - 'TMOUT': '86400', 08:15:01 INFO - 'USER': 'cltbld', 08:15:01 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464621275.769637-1846102734', 08:15:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:01 INFO - '_': '/tools/buildbot/bin/python'} 08:15:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:15:01 INFO - Running setup.py (path:/tmp/pip-t1T8eJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:15:01 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:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:15:01 INFO - Running setup.py (path:/tmp/pip-TFxexG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:15:02 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:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:15:02 INFO - Running setup.py (path:/tmp/pip-a150G2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:15:02 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:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:15:02 INFO - Running setup.py (path:/tmp/pip-HS4op6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:15:02 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:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:15:02 INFO - Running setup.py (path:/tmp/pip-HlXueZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:15:02 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:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:15:02 INFO - Running setup.py (path:/tmp/pip-2ehGyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:15:02 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:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:15:02 INFO - Running setup.py (path:/tmp/pip-EEomSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:15:02 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:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:15:02 INFO - Running setup.py (path:/tmp/pip-xIGQxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:15:02 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:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:15:02 INFO - Running setup.py (path:/tmp/pip-aYnczA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:15:02 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:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:15:02 INFO - Running setup.py (path:/tmp/pip-5bOZtO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:15:02 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:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:15:02 INFO - Running setup.py (path:/tmp/pip-4_FC4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:15:02 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:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:15:02 INFO - Running setup.py (path:/tmp/pip-SxOOAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:15:02 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:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:15:02 INFO - Running setup.py (path:/tmp/pip-StVEIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:15:02 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:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:15:02 INFO - Running setup.py (path:/tmp/pip-Ob6mYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:15:02 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:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:15:02 INFO - Running setup.py (path:/tmp/pip-Q3_AEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:15:02 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:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:15:02 INFO - Running setup.py (path:/tmp/pip-Gygeoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:15:03 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:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:15:03 INFO - Running setup.py (path:/tmp/pip-LZocp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:15:03 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:15:03 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:15:03 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:15:03 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:15:03 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:15:03 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:15:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:04 INFO - Downloading blessings-1.6.tar.gz 08:15:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:15:05 INFO - Installing collected packages: blessings 08:15:05 INFO - Running setup.py install for blessings 08:15:05 INFO - Successfully installed blessings 08:15:05 INFO - Cleaning up... 08:15:05 INFO - Return code: 0 08:15:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:15:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:15:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:15:05 INFO - Reading from file tmpfile_stdout 08:15:05 INFO - Current package versions: 08:15:05 INFO - argparse == 1.2.1 08:15:05 INFO - blessings == 1.6 08:15:05 INFO - blobuploader == 1.2.4 08:15:05 INFO - docopt == 0.6.1 08:15:05 INFO - manifestparser == 1.1 08:15:05 INFO - mozInstall == 1.12 08:15:05 INFO - mozcrash == 0.17 08:15:05 INFO - mozdebug == 0.1 08:15:05 INFO - mozdevice == 0.48 08:15:05 INFO - mozfile == 1.2 08:15:05 INFO - mozhttpd == 0.7 08:15:05 INFO - mozinfo == 0.9 08:15:05 INFO - mozleak == 0.1 08:15:05 INFO - mozlog == 3.1 08:15:05 INFO - moznetwork == 0.27 08:15:05 INFO - mozprocess == 0.22 08:15:05 INFO - mozprofile == 0.28 08:15:05 INFO - mozrunner == 6.11 08:15:05 INFO - mozscreenshot == 0.1 08:15:05 INFO - mozsystemmonitor == 0.0 08:15:05 INFO - moztest == 0.7 08:15:05 INFO - mozversion == 1.4 08:15:05 INFO - psutil == 3.1.1 08:15:05 INFO - requests == 1.2.3 08:15:05 INFO - wsgiref == 0.1.2 08:15:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:15:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:05 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 0x7f649fd78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b5b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bea410>, '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 0x1beb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1beb7a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464621275.769637-1846102734', '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:15:05 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:15:05 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:15:05 INFO - Using env: {'DISPLAY': ':0', 08:15:05 INFO - 'HOME': '/home/cltbld', 08:15:05 INFO - 'LANG': 'en_US.UTF-8', 08:15:05 INFO - 'LANGUAGE': 'en_US:en', 08:15:05 INFO - 'LOGNAME': 'cltbld', 08:15:05 INFO - 'MAIL': '/var/mail/cltbld', 08:15:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:05 INFO - 'MOZ_NO_REMOTE': '1', 08:15:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:05 INFO - 'NO_EM_RESTART': '1', 08:15:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:05 INFO - 'PWD': '/builds/slave/test', 08:15:05 INFO - 'SHELL': '/bin/bash', 08:15:05 INFO - 'SHLVL': '1', 08:15:05 INFO - 'TERM': 'linux', 08:15:05 INFO - 'TMOUT': '86400', 08:15:05 INFO - 'USER': 'cltbld', 08:15:05 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464621275.769637-1846102734', 08:15:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:05 INFO - '_': '/tools/buildbot/bin/python'} 08:15:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:05 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:15:05 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:15:05 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:15:05 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:15:05 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:15:05 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:15:05 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:15:05 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:15:05 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:15:05 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:15:05 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:15:05 INFO - Cleaning up... 08:15:05 INFO - Return code: 0 08:15:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:15:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:05 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 0x7f649fd78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b5b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bea410>, '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 0x1beb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1beb7a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464621275.769637-1846102734', '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:15:05 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:15:05 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:15:05 INFO - Using env: {'DISPLAY': ':0', 08:15:05 INFO - 'HOME': '/home/cltbld', 08:15:05 INFO - 'LANG': 'en_US.UTF-8', 08:15:05 INFO - 'LANGUAGE': 'en_US:en', 08:15:05 INFO - 'LOGNAME': 'cltbld', 08:15:05 INFO - 'MAIL': '/var/mail/cltbld', 08:15:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:05 INFO - 'MOZ_NO_REMOTE': '1', 08:15:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:05 INFO - 'NO_EM_RESTART': '1', 08:15:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:05 INFO - 'PWD': '/builds/slave/test', 08:15:05 INFO - 'SHELL': '/bin/bash', 08:15:05 INFO - 'SHLVL': '1', 08:15:05 INFO - 'TERM': 'linux', 08:15:05 INFO - 'TMOUT': '86400', 08:15:05 INFO - 'USER': 'cltbld', 08:15:05 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464621275.769637-1846102734', 08:15:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:05 INFO - '_': '/tools/buildbot/bin/python'} 08:15:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:05 INFO - Downloading/unpacking jsonschema 08:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:15:07 INFO - Downloading/unpacking functools32 (from jsonschema) 08:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:07 INFO - Downloading functools32-3.2.3-2.tar.gz 08:15:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:15:08 INFO - warning: no files found matching '*.txt' 08:15:08 INFO - no previously-included directories found matching 'build' 08:15:08 INFO - no previously-included directories found matching 'dist' 08:15:08 INFO - no previously-included directories found matching '.git*' 08:15:08 INFO - Installing collected packages: jsonschema, functools32 08:15:08 INFO - Running setup.py install for functools32 08:15:08 INFO - warning: no files found matching '*.txt' 08:15:08 INFO - no previously-included directories found matching 'build' 08:15:08 INFO - no previously-included directories found matching 'dist' 08:15:08 INFO - no previously-included directories found matching '.git*' 08:15:08 INFO - Successfully installed jsonschema functools32 08:15:08 INFO - Cleaning up... 08:15:08 INFO - Return code: 0 08:15:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:15:08 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:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:08 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:15:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:08 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 0x7f649fd78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b5b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bea410>, '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 0x1beb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1beb7a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464621275.769637-1846102734', '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:15:08 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:15:08 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:15:08 INFO - Using env: {'DISPLAY': ':0', 08:15:08 INFO - 'HOME': '/home/cltbld', 08:15:08 INFO - 'LANG': 'en_US.UTF-8', 08:15:08 INFO - 'LANGUAGE': 'en_US:en', 08:15:08 INFO - 'LOGNAME': 'cltbld', 08:15:08 INFO - 'MAIL': '/var/mail/cltbld', 08:15:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:08 INFO - 'MOZ_NO_REMOTE': '1', 08:15:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:08 INFO - 'NO_EM_RESTART': '1', 08:15:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:08 INFO - 'PWD': '/builds/slave/test', 08:15:08 INFO - 'SHELL': '/bin/bash', 08:15:08 INFO - 'SHLVL': '1', 08:15:08 INFO - 'TERM': 'linux', 08:15:08 INFO - 'TMOUT': '86400', 08:15:08 INFO - 'USER': 'cltbld', 08:15:08 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464621275.769637-1846102734', 08:15:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:08 INFO - '_': '/tools/buildbot/bin/python'} 08:15:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:08 INFO - Downloading/unpacking flake8 08:15:08 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:15:08 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:15:08 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:15:08 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:15:08 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:15:08 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:15:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:15:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:15:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:15:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:15:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:15:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:15:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:15:11 INFO - no previously-included directories found matching 'docs/_build' 08:15:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:15:11 INFO - Running setup.py install for pep8 08:15:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:15:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:15:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:15:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:15:11 INFO - no previously-included directories found matching 'docs/_build' 08:15:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:15:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:15:11 INFO - Cleaning up... 08:15:11 INFO - Return code: 0 08:15:11 INFO - Running post-action listener: _resource_record_post_action 08:15:11 INFO - Running post-action listener: _start_resource_monitoring 08:15:11 INFO - Starting resource monitoring. 08:15:11 INFO - ##### 08:15:11 INFO - ##### Running install step. 08:15:11 INFO - ##### 08:15:11 INFO - Running pre-action listener: _resource_record_pre_action 08:15:11 INFO - Running main action method: install 08:15:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:15:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:15:11 INFO - Reading from file tmpfile_stdout 08:15:11 INFO - Detecting whether we're running mozinstall >=1.0... 08:15:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:15:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:15:11 INFO - Reading from file tmpfile_stdout 08:15:11 INFO - Output received: 08:15:11 INFO - Usage: mozinstall [options] installer 08:15:11 INFO - Options: 08:15:11 INFO - -h, --help show this help message and exit 08:15:11 INFO - -d DEST, --destination=DEST 08:15:11 INFO - Directory to install application into. [default: 08:15:11 INFO - "/builds/slave/test"] 08:15:11 INFO - --app=APP Application being installed. [default: firefox] 08:15:11 INFO - mkdir: /builds/slave/test/build/application 08:15:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:15:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:15:27 INFO - Reading from file tmpfile_stdout 08:15:27 INFO - Output received: 08:15:27 INFO - /builds/slave/test/build/application/firefox/firefox 08:15:27 INFO - Running post-action listener: _resource_record_post_action 08:15:27 INFO - ##### 08:15:27 INFO - ##### Running run-tests step. 08:15:27 INFO - ##### 08:15:27 INFO - Running pre-action listener: _resource_record_pre_action 08:15:27 INFO - Running main action method: run_tests 08:15:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:15:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:15:27 INFO - Python 2.7.3 08:15:27 INFO - Return code: 0 08:15:27 INFO - grabbing minidump binary from tooltool 08:15: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:15:27 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 0x1bea410>, '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 0x1beb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1beb7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:15:27 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:15:27 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:15:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:15:27 INFO - Return code: 0 08:15:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:15:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:15:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:15:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:15:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:15:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:15:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:15:28 INFO - Return code: 0 08:15:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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:15:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --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:15:28 INFO - Using env: {'DISPLAY': ':0', 08:15:28 INFO - 'HOME': '/home/cltbld', 08:15:28 INFO - 'LANG': 'en_US.UTF-8', 08:15:28 INFO - 'LANGUAGE': 'en_US:en', 08:15:28 INFO - 'LOGNAME': 'cltbld', 08:15:28 INFO - 'MAIL': '/var/mail/cltbld', 08:15:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:15:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:15:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:28 INFO - 'MOZ_NO_REMOTE': '1', 08:15:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:15:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:28 INFO - 'NO_EM_RESTART': '1', 08:15:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:28 INFO - 'PWD': '/builds/slave/test', 08:15:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:15:28 INFO - 'SHELL': '/bin/bash', 08:15:28 INFO - 'SHLVL': '1', 08:15:28 INFO - 'TERM': 'linux', 08:15:28 INFO - 'TMOUT': '86400', 08:15:28 INFO - 'USER': 'cltbld', 08:15:28 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464621275.769637-1846102734', 08:15:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:28 INFO - '_': '/tools/buildbot/bin/python'} 08:15:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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:15:28 INFO - mozversion application_buildid: 20160530035543 08:15:28 INFO - mozversion application_changeset: 04934785596476f6dd8baccc355202aeba59af35 08:15:28 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:15:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:15:28 INFO - mozversion application_name: Firefox 08:15:28 INFO - mozversion application_remotingname: firefox-dev 08:15:28 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:15:28 INFO - mozversion application_vendor: Mozilla 08:15:28 INFO - mozversion application_version: 48.0a2 08:15:28 INFO - mozversion platform_buildid: 20160530035543 08:15:28 INFO - mozversion platform_changeset: 04934785596476f6dd8baccc355202aeba59af35 08:15:28 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:15:28 INFO - mozversion platform_version: 48.0a2 08:15:28 INFO - using testdate: 1464621328 08:15:28 INFO - actual date: 1464621328 08:15:28 INFO - starting webserver on 'localhost:40639' 08:15:28 INFO - SUITE-START | Running 2 tests 08:15:28 INFO - TEST-START | dromaeo_css 08:15:28 INFO - operating with platform_type : linux_ 08:15:28 INFO - Initialising browser for dromaeo_css test... 08:15:28 INFO - TEST-INFO | started process 12597 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5RQM7l/profile http://localhost:40639/getInfo.html) 08:15:32 INFO - PROCESS | 12597 | __metrics Screen width/height:1600/1200 08:15:32 INFO - PROCESS | 12597 | colorDepth:24 08:15:32 INFO - PROCESS | 12597 | Browser inner width/height: 1024/697 08:15:32 INFO - PROCESS | 12597 | __metrics 08:15:33 ERROR - PROCESS | 12597 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:15:34 INFO - TEST-INFO | 12597: exit 0 08:15:34 INFO - Browser initialized. 08:15:34 INFO - Running cycle 1/1 for dromaeo_css test... 08:15:34 INFO - TEST-INFO | started process 12685 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5RQM7l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:15:46 INFO - PROCESS | 12685 | RSS: Main: 142135296 08:15:46 INFO - PROCESS | 12685 | 08:16:37 INFO - PROCESS | 12685 | 1464621397825 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:18:44 INFO - PROCESS | 12685 | Cycle 1(1): loaded http://localhost:40639/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40639/tests/dromaeo/cssquery-ext.html) 08:18:45 INFO - PROCESS | 12685 | RSS: Main: 244490240 08:18:45 INFO - PROCESS | 12685 | 08:21:48 INFO - PROCESS | 12685 | Cycle 1(1): loaded http://localhost:40639/tests/dromaeo/cssquery-ext.html (next: http://localhost:40639/tests/dromaeo/cssquery-jquery.html) 08:21:48 INFO - PROCESS | 12685 | RSS: Main: 226496512 08:21:48 INFO - PROCESS | 12685 | 08:24:50 INFO - PROCESS | 12685 | Cycle 1(1): loaded http://localhost:40639/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40639/tests/dromaeo/cssquery-mootools.html) 08:24:51 INFO - PROCESS | 12685 | RSS: Main: 221261824 08:24:51 INFO - PROCESS | 12685 | 08:27:52 INFO - PROCESS | 12685 | Cycle 1(1): loaded http://localhost:40639/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40639/tests/dromaeo/cssquery-prototype.html) 08:27:53 INFO - PROCESS | 12685 | RSS: Main: 216182784 08:27:53 INFO - PROCESS | 12685 | 08:30:56 INFO - PROCESS | 12685 | Cycle 1(1): loaded http://localhost:40639/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40639/tests/dromaeo/cssquery-yui.html) 08:30:56 INFO - PROCESS | 12685 | RSS: Main: 183275520 08:30:56 INFO - PROCESS | 12685 | 08:33:58 INFO - PROCESS | 12685 | Cycle 1(1): loaded http://localhost:40639/tests/dromaeo/cssquery-yui.html (next: http://localhost:40639/tests/dromaeo/cssquery-dojo.html) 08:33:59 INFO - PROCESS | 12685 | RSS: Main: 238981120 08:33:59 INFO - PROCESS | 12685 | 08:33:59 INFO - PROCESS | 12685 | __start_tp_report 08:33:59 INFO - PROCESS | 12685 | _x_x_mozilla_page_load 08:33:59 INFO - PROCESS | 12685 | _x_x_mozilla_page_load_details 08:33:59 INFO - PROCESS | 12685 | |i|pagename|runs| 08:33:59 INFO - PROCESS | 12685 | |0;dojo.html;3303.9834800825993;3372.6290108088106;3380.0873764083703;3400.2009527760956;3412.556367672202;5510.228568000483;5513.586481013925;5519.978803921273;5527.50252477277;5538.280023596937;5505.229267902497;5508.862278443041;5530.391656917735;5541.390447050831;5568.16477528371;4890.266460030988;4954.281629163778;5042.47054059324;5086.440491545927;5122.206058061007;4955.702657840523;5008.524190201943;5033.7734801934;5036.395632524102;5099.668521546107;5116.283720279164;5146.047981123485;5153.330067091273;5160.587153027749;5163.199704045879;5151.896962060757;5152.252923326116;5153.2270159476375;5160.948390516084;5187.896242075175;4885.413750349945;4979.47715489872;5056.165732654108;5080.847574572732;5082.288479612857;5457.699826509541;5466.890662186774;5469.808556700536;5480.616356855022;5489.286392768954;5923.496502797268;5933.643981361132;5955.166276721263;5960.642361458326;5969.820905372846;5791.247137872049;5806.361300256968;5911.172435858984;5934.1098835174635;5943.078822782476;5501.834944951658;5504.752286147133;5508.724563771795;5510.256115424407;5513.2005859150195;5991.670458124845;5992.610480318853;5998.280206375263;5999.430054144849;6000.399960003964;5640.661560306395;5756.42435756421;5808.651480911159;5819.0689489681445;5840.445157710095;5857.560682948796;5863.149843272701;5864.120381942743;5865.941340586625;5866.560007999417;5687.857803554944;5802.970985145132;5850.5904586678525;5852.15143804146;5857.619254748428;5881.147233651097;5938.762449501972;5952.196453478811;5979.312379076375;5984.790532331347;4509.909801803946;4513.232750432434;4514.548545145459;4518.977405113019;4525.298578720303;3945.861894833667;4065.2479291331197;4066.1461093170174;4074.0629655179473;4099.487564054493;5551.1673249012165;5605.887882242332;5612.1581762735095;5641.661500309912;5654.802081927195;5898.085796701518;5903.35063143054;5903.3801450847905;5909.379515150933;5910.290765108214;5421.05131601976;5624.100143977026;5628.493435590816;5641.576881733804;5646.830595082154;4997.525235102659;5016.924746128811;5021.020900924358;5022.974885125551;5050.166722490748;6143.846403839851;6145.631262124198;6153.630782153085;6154.046122850965;6154.969225153845;5813.360530341574;5892.823215303548;5987.401259874065;5996.310424301261;6004.0693692477735;6118.893302669218;6138.58022223998;6144.556029333014;6146.016637338004;6147.323794382703;5835.095560188178;5835.183074369676;5839.0949402842625;5840.853978650568;5882.176495290748;5691.857703557444;5854.209681692917;5944.197533332945;5955.076963070731;5980.372060933713;5805;5821.912671310019;5847.561432892635;5849.795257165979;5850.327212370632;5759.078547432391;5824.155497452761;5825.854353641193;5827.329857066492;5828;5549.833504994856;5697.259356283656;5748;5756.798512052058;5788.13178023283;5841.50347220474;5859.00396932514;5859.970700146472;5867.383924687846;5879.20630714848;5513.42109078557;5700.230468886647;5757.9424205757405;5758.539316854725;5765.279340082489 08:33:59 INFO - PROCESS | 12685 | |1;ext.html;605.3613437823097;657.4805903336364;661.361785876629;668.1881513960539;668.2815972829206;31847.52228716568;39571.20857582847;40502.189956200855;40539.79730101345;40544;43299.78350108245;43803;43859;43867.341989870176;43945.560544394546;7942.086660034083;8669.133086691329;8801.207891289783;8865.379423440361;10456.947715261413;10351.844722329171;10475.685729428129;10486.68539943799;10489.842652360221;10497.4226417547;10518.737031574234;10578.947105264502;10579.84130238047;10582.047615714584;10583.10043646291;10468.842967355535;10490.213234007442;10508.894911050944;10531.104856087242;10536.525856336484;10486.895131048668;10855.51150198243;10864.674059778219;10869.456527173688;10889.128869690485;44104.77947610273;44165.558344416466;44438.77780611109;44471.11057778859;44539.77730111361;3859.286032084073;3952.1107750756137;3977.204559088165;4324.567543245682;4625.699329543602;33817.32365352704;33864.49203261953;34022;35370;35390.64609353899;4512.075024619945;4524.886877828048;4546.977265113686;4600.516945720685;4804.303376010494;313359;314317;314682;314934;317275.9999999977;38741.2251754969;39297.607023929966;39444;63138;63767.68116159389;37076.81461592675;37116.628833711315;37258.44112338317;37262;37295.62704372976;15457.381704731684;17126.14369281531;17327.047012414187;17334.306627735;17346.739798903025;14947.177905215318;15098.471553495576;15140.318685659171;15145.469908553368;15157.772633410508;9195.586198621078;9197.356185066981;9222.631094756134;9268.073192680678;9303.162715355515;3543.8936831895085;3592.748507604495;3600.369935261319;3607.567091948983;3636.472711456824;1024.36489376587;1110.6001839337832;1134.8694900086596;1191.6961174900518;1258.4337048328289;33725.66274337225;34961.65038349584;35467.29065418677;35606;35716.82141589275;1168.9123315751183;1175.9176857619884;1190.190670344157;1236.6475554466933;1281.557862537423;17407.71058358447;17550.648987020442;17911.641767164583;17987.83079099854;18161.545961351072;484600;673088;680932;684608;684700;63230.68384658139;63558.36441635617;63785.68107159434;63849;63984.68007659932;1479.5857159995003;1480.8519148085106;1546.7447871101367;1548.79865617469;1571.300771156847;32103.197420064684;32410.83794581012;32514.349713006082;32766.344673105927;33221.50167747437;54277.72861135669;55848.72075639596;55906;55977;55984.72007639936;422596;430441;430993;431835;432178;40506.39240411337;46546.76726616345;46744.53255467402;47025.29462058003;47903.646744727535;46972.7651361741;47038.76480617575;47453.762731187504;47604.04791904212;47871.52128478671;39698;40343.596564033985;44052.33921491116;44696;45034.77482612566;43128.13743725171;43441;44425.77787111044;44530.66408007765;44548.33177502275;43954;45034.0993180128;45257.094858103315;45290.09419811519;45445.31832022589;36625.63374366222;38389.424158637084;38865.41701874418;39408.80295598504;39675.2064958705;29304.853475732485;29536.704632953395;29891.701082988893;29969;30078.398432031674 08:33:59 INFO - PROCESS | 12685 | |2;jquery.html;420.17855093292616;421.936709493576;427.48488071873373;435.2904765232671;442.2525931176312;17800.46598602041;18985;19551.706724399126;19567.902160489197;19702.211911523522;11714.531418743261;12201.572944946929;12220.816687749668;18674;18883.52791180221;5328.893422131565;5406.729663516828;5456.317960254968;5459.426760190182;5474.343078830546;5183.067047931371;5267.789288428477;5275.973620131894;5276.1030624793875;5280.498352656491;5256.894862102756;5258.211268309746;5262.105442074837;5278.6568873023325;5280.260763493114;5298.046351656701;5426.538744206747;5776.364599894008;5910.911336329937;5958.106284057383;5319.707416092114;5330.600204984642;5332.546733527654;5332.573394128499;5351.759170837283;23108;23518.176863809684;24313.878430607732;24510.632340514905;24526.754732452624;2545.52907712072;2589.59861221511;2641.867906604681;2689;2988.4770165221;10619.840702389392;11051.613193538187;14905.403783848633;14933.956330308196;15451.536453906401;2030.8679935804125;2096.8951552422473;2121.8090371866606;2169.7287839020123;2190.9014094365793;60351.69824150895;61768.382316176714;63947;74059.62970185114;81010.59494702489;10549.789004219872;10734.463276836126;11047.226694131494;11051.613193538187;11289.096872250364;14194.503192388216;15103.39586416531;15583.922080389526;16215.756763648555;16227.350905963629;8373.958130209432;8442.915570844212;8457.323414126979;8460.788480288042;8752.606132724042;8123.822045803326;8157.836843263101;8172.264496195371;8262.091169971298;8774.210321071007;4738.786754596052;4819.855404337875;4846.975765121152;4904.2860403497;4910.361652985089;1981.7126516655292;2003.1386503803503;2014.4460273424631;2021.2824447320988;2041.3773798991451;1000.7197984564334;1055.1664185293685;1076.5155679944057;1101.427257825942;1149.1438878035917;18466.446006619823;19470;19526.902588272525;19604.803951960585;19887;1026.6663334416344;1081.507913899174;1086.7554800170058;1092.4810714910514;1094.2012330998416;10833.566657333777;11167.106631469625;11205.887941120647;11256.437178141061;11372;473825;479206;483483;505853;507833;87919;92998;93006;93650;93801.53099234597;1074.0762943868267;1076.4187338836941;1096.0135877709965;1104.320842681761;1111.9666410007712;16985.660286794442;17340.612750980144;17406.216720247874;17669.646607068044;18008.819911800714;31463.37073258476;38233;39141.41287880627;39281;41108.38337425001;55600;55629.1655625174;55718.44281557295;55743.442565575446;55997.72001139968;8542.44474109181;8853.335999799912;8867.467951922905;9112.817743645222;9215.86176207344;12915.741685166056;13279.269640169883;13761.449542018207;13794.172349659053;14177.14937103777;11937.940310298392;12308;12477.812832807334;12483.56307529232;12487;11573.652790416301;11900.464479098287;12331.9383403086;12365;12683.873161268639;12546.560870369492;12594.118411711092;12733;12819.743605128031;12858;8723.127687231226;8751.606177721891;8817.07420720815;8907.777305567413;8973.28213742912;9007.189352958265;12001.279923204636;12594.433250503565;12688.429020693906;12741.55404560836 08:33:59 INFO - PROCESS | 12685 | |3;mootools.html;1392.7005693775836;1535.0789526284232;1544.7914531538247;1725.0770837601885;1844.880082794619;8013.439059265854;8127.5529845858455;8158.5104893706275;8164.591770411485;8166.469179503328;8012.1186669466315;8177.836443271131;8184.9768778902635;8186.79533011675;8191.672333106669;2071.347525529461;2401.1715957994506;2409.4217387826884;2429.259075981825;2452.080469823816;2429.866357350345;2445.3153117127144;2445.3397582652674;2447.204658485999;2447.241355179891;2355.1168311883043;2406.95186096278;2410.963835542468;2413.1553956115395;2413.408714864852;2041.918323267075;2351.8236132290062;2400.4838959623676;2405.446747248125;2409.8915548800346;2379.3694670912223;2416.275117464771;2426.8665223412704;2427.0291883246664;2427.2354208424467;8057.113717491071;8110.3511719062335;8126;8128.227818357305;8128.674853005873;5230.764615592308;5355.571554275649;5361.490658387447;5367.409584945653;5465.480779325958;3565.4295312750096;3642.8178591070605;3677.613850545681;3682;3699.223163135745;1129.8700649425339;1133.5465813674514;1137.397179494869;1155.3183621663175;1177.8233265010317;11966.82049769254;11971.580994665232;11989.940050299692;11997.34014629195;12030.33833139177;4697.859064228079;4738.64460165489;4798.448178459452;4829.589484893753;4837.661363704507;10100.393976361442;10110.949445252727;10137.543810528545;10145.188384929188;10156;4759.381280433521;5427.701476418756;5433.320834895638;5434.64674796137;5436.728163591804;4889.828855990095;4932.284818701268;4956.801727930914;4995.375578052744;5016.774245158977;4066.064805094845;4076.9796151019054;4125.876223713293;4128.958710412858;4148.854790082332;1315.6908126590245;1351.8242628458434;1352.0468070010618;1355.1327150623608;1356.7422189783908;977.94621295828;1064.7125276175389;1074.1514203779084;1087.2063393722626;1088.4612117001977;6117.571769976059;6164.352742962014;6201.658908759971;6266.968665156645;6294.15028971083;478.40438653876146;483.0941983780412;483.79438738536686;1096.3257596578046;1102.9889701102886;4190.832366705297;4214.30463973441;4219.2194444027955;4222.873313800591;4223.429836972031;10386.740331491774;10729.78540429187;10782.191335649857;10805.783884322427;10820;10352.792944141074;10414.479276036167;10502.05481506668;10508.106810921005;10518.368897866;7604.277593628707;8024.157463466368;8283.668653253802;8287.917120828835;8296.128906464855;5798.420157984167;5816.36020037804;5859.062549991981;5943.346231914573;5971.701414929149;9358.11097945694;9373.765655858659;9459.621615135318;9513.23894088485;9609.087136722;9194.95402522983;9447.858282125912;9449.48027858447;9450.291228158054;9910.554025068745;6963.825904352431;7506.099268087864;7661.655225514976;7767.650455729618;7783.066032076187;8112.513249205066;8117.350611951148;8138.389620778347;8145.104038555635;8211.58942052907;7189.7483588074165;7395.223501532261;7403.66683499233;7415.2214017527385;7584.772456826304;7062.894056589258;7164.426845852215;7258.383037441877;7350.7427240046345;7376.631168441664;6580.144581204413;6592.80221593353;6619.4373478252965;6644.568103073285;6688.063671085954;4919.655624106422;5048.318477005704;5067.290579318825;5108.514691104339;5113.8721531962;5123.231515272739;5178.61160412963;5200.401953775213;5212.270282160424;5283.392409872914 08:33:59 INFO - PROCESS | 12685 | |4;prototype.html;356.47953987178715;356.7039357333413;358.7363287983333;360.95848977367604;370.2908929400199;6257.0927215553775;6317.52618553608;6377.521685873555;6400.103985442041;6408.2950875403785;6007.519398448125;6150.723217455214;6314;6330.556861019731;6334;4864.173090574611;4879.292502587123;4899.877503062426;4903.313536104948;4920.901581968358;4865.41615006198;4865.902681946377;4883.169861123618;4885.267209918505;4886.047220791947;4642.303654451825;4699.976500117512;4714.976425117887;4802.9039419211595;4846.200376937801;4832.202686556714;4840.830570930036;4844.1038407894475;4846.515348465161;4861.659683822134;4269.146170765828;4272.893177670552;4277.850275240383;4283.764392958386;4286.292761694317;6041.093835924603;6050;6051.1225872248715;6053.061775424816;6053.122297266916;5616.606837521375;5624.128260119647;5630.887382252332;5631.1271752878365;5631.8028868989795;6346.048092786073;6581.868362632768;6607.933920660828;6608.2730899601;6640.634765087918;4568.725876447391;4599.563041511051;4603.5166307537565;4607.424071991001;4608.124456353282;6865.759698410581;6887.655617219119;6939.514234003622;6954.582725036514;6960.65196740166;4588.357629931812;4594.035252596926;4608.216603177468;4616.60758835496;4634.119517291704;4661.510541393172;4673.252279635242;4674.789634466457;4676.321933319649;4677.32178834074;5320.228566857862;5464.453554644583;5465.371482279509;5475.479829416199;5550.639208451518;6685.532012759158;6697.7655782047395;6728.966355168291;6736.5284430090405;6745.898811517733;1549.8217704964075;1631.9347226110822;1652.264742189714;1672.9794825156644;1679.1520282257381;1076.05844885725;1095;1097.6542389147394;1102.2945314998408;1108.8891110889008;6458.61248325102;6465.806025819233;6471.611703297817;6475.935240647627;6482.12491313676;6849;6850.0752398426575;6853.109095817512;6853.314668533107;6874.862502749917;6412;6484.708188131545;6531.0856480092825;6549.967250163719;6552.213734351908;3670.064133645903;3697.1681371691157;3698.0385099874225;3703.981480092636;3704.629537046274;6955.930440695528;7065.43476521877;7233.421326293989;7247.23903990084;7256.7822965311125;7111;7117.822054448577;7123.358897699129;7132.251113632994;7132.465065120136;7193;7209.6034718091005;7213.170485394142;7215.96392018026;7218.530795498275;6949.131358580177;6958.269381715049;6967.8258043547285;6968;6982.441404687715;6788.950276243094;6835.043093966948;6876.862462750817;6889.862202755817;6892.379685828299;7153.4992550520965;7161.176464706626;7162.570245785269;7181.24596917337;7182.676779544829;4695.671303008893;4737.644676649334;4739;4742.407199100113;4751.9287210692555;6602.042703807825;6916.757913473004;6924.7576334830055;6935.965320173367;6936.930630693629;6594.802155935329;6732.091167692299;6738.427233685192;6740.359665831738;6746.886763683937;6672.165979252593;6687.765928192684;6704.966475167788;6711.731530738716;6715.1941766988275;6593.241777195492;6601.471882249312;6603.570767900071;6605.834854128685;6607.900881486878;6605.207375114825;6740.191177058784;6749.595024298558;6757.290484499057;6762.526623136333;6552.901706474311;6579.769708060195;6595.934040659532;6599.835004124935;6600.405963463311 08:33:59 INFO - PROCESS | 12685 | |5;yui.html;821.704186492862;833.687367237286;841.69698908393;920.3281604428769;942.9500296227701;15036.548903532885;15085.245737713112;15532.378704851806;17046.488605341827;17592.384266550675;16286.755698664529;16368.508944731677;16405.67188656226;16423.753643695323;16445.671086578262;746.779699988502;851.4210336970857;863.5034854958393;880.9779755506099;884.1777147253052;905.8912930448355;909.4316052467208;912.5893347993397;914.9222316103139;915.2906497464485;946.7207173883721;950.3157726436955;950.7575568230092;951.8381875081253;952.2857856607544;778.4823092643385;907.5280853955906;928.5264515097282;928.6517555916531;931.5481991234246;688.0333131949569;689.0731965506436;689.2246222999127;689.334791925789;689.8585789913055;15333.539993800205;15389.384424623002;15415.15216663083;15449.922750386177;15485.535433937;14794.704105917821;15138.394464221417;15139.091654500655;15192.392304307814;15214.239288035555;12269.28230047794;12378.319192444413;12399.194052386567;12460.12779105463;12549.435275412628;4124.938125928114;4809.374781278411;4811.4707382187935;4811.975940120312;4982.053409852117;60456.39543604552;60506.69746651283;60566.69716651433;60628.696856515875;61534.384656153314;11275.830862536905;11406.657800266004;11452.370119643332;11532.88467115335;11599.536018559163;20736.377908662766;20764.58470830605;20804.063817128266;20829.895850520952;20852.47868803292;8494.915050849537;8760.299176065899;8767.386282960259;8810;8863.468191908507;5020.648554601143;5038.319826823332;5160.561352285098;5186.714730689849;5275.155975043975;3732.720045996561;3785.716071294664;3793.867214647474;3795.753276037104;3797.0697179190724;682.8839097353462;686.5571706249441;706.2090458686304;715.7530651925077;727.0076345787961;684.2985939412142;759.2521366454039;777.9572123533147;828.0849661124491;844.3076677124822;9938;10007.899921000842;10020.749481263027;10249.897501024894;10342.482875856178;826.1490664615455;831.3079708347776;833.0752864320599;834.3450391442689;860.4278155026963;4694.389729335233;4758.976205118952;4819.108464933998;4824.49342819006;4894.583960363409;59797.103043454386;60143.699281503315;60497.69751151304;61137.38862611406;61372.693136534035;53737.731311343974;55290;55489;55714;55785;48773.51226487761;49283;49536.75231623891;49783.751081244365;49865;9428.292878034037;9450.574724137568;9450.810983780148;9490.667826626035;9542.475163866055;36877.63122368742;37441;38267.808660956514;38785.418218726176;38804.87271715537;45213.773931130134;46826.06347872956;47324.290135648684;47436;47824.282635761185;11538.480768365276;11566.826497602711;11605.245659032136;11812;11899;12488;12798;13052.673683157996;13130.277834719182;13259.801102983656;12015.158938874194;12054.337011464453;12058.216215945935;12491;12556.183848049848;12336.198147120409;12472;12532.122751407314;12534.87465125337;12578.811317830423;11677.941610291895;11951.880481195076;12038.337891416057;12285.201461905304;12512.937435312766;10045.849312260469;10260.486975651038;10275.7431064224;10416.739581510523;10530.262881598215;9828.361156524803;10116.576966615716;10160.441175735405;10166.644167454104;10285.74285642835 08:33:59 INFO - PROCESS | 12685 | __end_tp_report 08:33:59 INFO - PROCESS | 12685 | __start_cc_report 08:33:59 INFO - PROCESS | 12685 | _x_x_mozilla_cycle_collect,790 08:33:59 INFO - PROCESS | 12685 | __end_cc_report 08:33:59 INFO - PROCESS | 12685 | __startTimestamp1464622439124__endTimestamp 08:33:59 INFO - PROCESS | 12685 | 08:33:59 INFO - PROCESS | 12685 | ------- Summary: start ------- 08:33:59 INFO - PROCESS | 12685 | Number of tests: 6 08:33:59 INFO - PROCESS | 12685 | 08:33:59 INFO - PROCESS | 12685 | [#0] dojo.html Cycles:165 Average:5502.13 Median:5748.00 stddev:600.35 (10.4%) stddev-sans-first:576.89 08:33:59 INFO - PROCESS | 12685 | Values: 3304.0 3372.6 3380.1 3400.2 3412.6 5510.2 5513.6 5520.0 5527.5 5538.3 5505.2 5508.9 5530.4 5541.4 5568.2 4890.3 4954.3 5042.5 5086.4 5122.2 4955.7 5008.5 5033.8 5036.4 5099.7 5116.3 5146.0 5153.3 5160.6 5163.2 5151.9 5152.3 5153.2 5160.9 5187.9 4885.4 4979.5 5056.2 5080.8 5082.3 5457.7 5466.9 5469.8 5480.6 5489.3 5923.5 5933.6 5955.2 5960.6 5969.8 5791.2 5806.4 5911.2 5934.1 5943.1 5501.8 5504.8 5508.7 5510.3 5513.2 5991.7 5992.6 5998.3 5999.4 6000.4 5640.7 5756.4 5808.7 5819.1 5840.4 5857.6 5863.1 5864.1 5865.9 5866.6 5687.9 5803.0 5850.6 5852.2 5857.6 5881.1 5938.8 5952.2 5979.3 5984.8 4509.9 4513.2 4514.5 4519.0 4525.3 3945.9 4065.2 4066.1 4074.1 4099.5 5551.2 5605.9 5612.2 5641.7 5654.8 5898.1 5903.4 5903.4 5909.4 5910.3 5421.1 5624.1 5628.5 5641.6 5646.8 4997.5 5016.9 5021.0 5023.0 5050.2 6143.8 6145.6 6153.6 6154.0 6155.0 5813.4 5892.8 5987.4 5996.3 6004.1 6118.9 6138.6 6144.6 6146.0 6147.3 5835.1 5835.2 5839.1 5840.9 5882.2 5691.9 5854.2 5944.2 5955.1 5980.4 5805.0 5821.9 5847.6 5849.8 5850.3 5759.1 5824.2 5825.9 5827.3 5828.0 5549.8 5697.3 5748.0 5756.8 5788.1 5841.5 5859.0 5860.0 5867.4 5879.2 5513.4 5700.2 5757.9 5758.5 5765.3 08:33:59 INFO - PROCESS | 12685 | 08:33:59 INFO - PROCESS | 12685 | [#1] ext.html Cycles:180 Average:62245.14 Median:38803.32 stddev:129030.55 (332.5%) stddev-sans-first:129309.51 08:33:59 INFO - PROCESS | 12685 | Values: 605.4 657.5 661.4 668.2 668.3 31847.5 39571.2 40502.2 40539.8 40544.0 43299.8 43803.0 43859.0 43867.3 43945.6 7942.1 8669.1 8801.2 8865.4 10456.9 10351.8 10475.7 10486.7 10489.8 10497.4 10518.7 10578.9 10579.8 10582.0 10583.1 10468.8 10490.2 10508.9 10531.1 10536.5 10486.9 10855.5 10864.7 10869.5 10889.1 44104.8 44165.6 44438.8 44471.1 44539.8 3859.3 3952.1 3977.2 4324.6 4625.7 33817.3 33864.5 34022.0 35370.0 35390.6 4512.1 4524.9 4547.0 4600.5 4804.3 313359.0 314317.0 314682.0 314934.0 317276.0 38741.2 39297.6 39444.0 63138.0 63767.7 37076.8 37116.6 37258.4 37262.0 37295.6 15457.4 17126.1 17327.0 17334.3 17346.7 14947.2 15098.5 15140.3 15145.5 15157.8 9195.6 9197.4 9222.6 9268.1 9303.2 3543.9 3592.7 3600.4 3607.6 3636.5 1024.4 1110.6 1134.9 1191.7 1258.4 33725.7 34961.7 35467.3 35606.0 35716.8 1168.9 1175.9 1190.2 1236.6 1281.6 17407.7 17550.6 17911.6 17987.8 18161.5 484600.0 673088.0 680932.0 684608.0 684700.0 63230.7 63558.4 63785.7 63849.0 63984.7 1479.6 1480.9 1546.7 1548.8 1571.3 32103.2 32410.8 32514.3 32766.3 33221.5 54277.7 55848.7 55906.0 55977.0 55984.7 422596.0 430441.0 430993.0 431835.0 432178.0 40506.4 46546.8 46744.5 47025.3 47903.6 46972.8 47038.8 47453.8 47604.0 47871.5 39698.0 40343.6 44052.3 44696.0 45034.8 43128.1 43441.0 44425.8 44530.7 44548.3 43954.0 45034.1 45257.1 45290.1 45445.3 36625.6 38389.4 38865.4 39408.8 39675.2 29304.9 29536.7 29891.7 29969.0 30078.4 08:33:59 INFO - PROCESS | 12685 | 08:33:59 INFO - PROCESS | 12685 | [#2] jquery.html Cycles:180 Average:28590.97 Median:23916.03 stddev:80586.81 (337.0%) stddev-sans-first:80785.11 08:33:59 INFO - PROCESS | 12685 | Values: 420.2 421.9 427.5 435.3 442.3 17800.5 18985.0 19551.7 19567.9 19702.2 11714.5 12201.6 12220.8 18674.0 18883.5 5328.9 5406.7 5456.3 5459.4 5474.3 5183.1 5267.8 5276.0 5276.1 5280.5 5256.9 5258.2 5262.1 5278.7 5280.3 5298.0 5426.5 5776.4 5910.9 5958.1 5319.7 5330.6 5332.5 5332.6 5351.8 23108.0 23518.2 24313.9 24510.6 24526.8 2545.5 2589.6 2641.9 2689.0 2988.5 10619.8 11051.6 14905.4 14934.0 15451.5 2030.9 2096.9 2121.8 2169.7 2190.9 60351.7 61768.4 63947.0 74059.6 81010.6 10549.8 10734.5 11047.2 11051.6 11289.1 14194.5 15103.4 15583.9 16215.8 16227.4 8374.0 8442.9 8457.3 8460.8 8752.6 8123.8 8157.8 8172.3 8262.1 8774.2 4738.8 4819.9 4847.0 4904.3 4910.4 1981.7 2003.1 2014.4 2021.3 2041.4 1000.7 1055.2 1076.5 1101.4 1149.1 18466.4 19470.0 19526.9 19604.8 19887.0 1026.7 1081.5 1086.8 1092.5 1094.2 10833.6 11167.1 11205.9 11256.4 11372.0 473825.0 479206.0 483483.0 505853.0 507833.0 87919.0 92998.0 93006.0 93650.0 93801.5 1074.1 1076.4 1096.0 1104.3 1112.0 16985.7 17340.6 17406.2 17669.6 18008.8 31463.4 38233.0 39141.4 39281.0 41108.4 55600.0 55629.2 55718.4 55743.4 55997.7 8542.4 8853.3 8867.5 9112.8 9215.9 12915.7 13279.3 13761.4 13794.2 14177.1 11937.9 12308.0 12477.8 12483.6 12487.0 11573.7 11900.5 12331.9 12365.0 12683.9 12546.6 12594.1 12733.0 12819.7 12858.0 8723.1 8751.6 8817.1 8907.8 8973.3 9007.2 12001.3 12594.4 12688.4 12741.6 08:33:59 INFO - PROCESS | 12685 | 08:33:59 INFO - PROCESS | 12685 | [#3] mootools.html Cycles:180 Average:5672.26 Median:4904.74 stddev:3100.00 (63.2%) stddev-sans-first:3092.01 08:33:59 INFO - PROCESS | 12685 | Values: 1392.7 1535.1 1544.8 1725.1 1844.9 8013.4 8127.6 8158.5 8164.6 8166.5 8012.1 8177.8 8185.0 8186.8 8191.7 2071.3 2401.2 2409.4 2429.3 2452.1 2429.9 2445.3 2445.3 2447.2 2447.2 2355.1 2407.0 2411.0 2413.2 2413.4 2041.9 2351.8 2400.5 2405.4 2409.9 2379.4 2416.3 2426.9 2427.0 2427.2 8057.1 8110.4 8126.0 8128.2 8128.7 5230.8 5355.6 5361.5 5367.4 5465.5 3565.4 3642.8 3677.6 3682.0 3699.2 1129.9 1133.5 1137.4 1155.3 1177.8 11966.8 11971.6 11989.9 11997.3 12030.3 4697.9 4738.6 4798.4 4829.6 4837.7 10100.4 10110.9 10137.5 10145.2 10156.0 4759.4 5427.7 5433.3 5434.6 5436.7 4889.8 4932.3 4956.8 4995.4 5016.8 4066.1 4077.0 4125.9 4129.0 4148.9 1315.7 1351.8 1352.0 1355.1 1356.7 977.9 1064.7 1074.2 1087.2 1088.5 6117.6 6164.4 6201.7 6267.0 6294.2 478.4 483.1 483.8 1096.3 1103.0 4190.8 4214.3 4219.2 4222.9 4223.4 10386.7 10729.8 10782.2 10805.8 10820.0 10352.8 10414.5 10502.1 10508.1 10518.4 7604.3 8024.2 8283.7 8287.9 8296.1 5798.4 5816.4 5859.1 5943.3 5971.7 9358.1 9373.8 9459.6 9513.2 9609.1 9195.0 9447.9 9449.5 9450.3 9910.6 6963.8 7506.1 7661.7 7767.7 7783.1 8112.5 8117.4 8138.4 8145.1 8211.6 7189.7 7395.2 7403.7 7415.2 7584.8 7062.9 7164.4 7258.4 7350.7 7376.6 6580.1 6592.8 6619.4 6644.6 6688.1 4919.7 5048.3 5067.3 5108.5 5113.9 5123.2 5178.6 5200.4 5212.3 5283.4 08:33:59 INFO - PROCESS | 12685 | 08:33:59 INFO - PROCESS | 12685 | [#4] prototype.html Cycles:180 Average:5595.43 Median:6410.15 stddev:1701.05 (26.5%) stddev-sans-first:1659.75 08:33:59 INFO - PROCESS | 12685 | Values: 356.5 356.7 358.7 361.0 370.3 6257.1 6317.5 6377.5 6400.1 6408.3 6007.5 6150.7 6314.0 6330.6 6334.0 4864.2 4879.3 4899.9 4903.3 4920.9 4865.4 4865.9 4883.2 4885.3 4886.0 4642.3 4700.0 4715.0 4802.9 4846.2 4832.2 4840.8 4844.1 4846.5 4861.7 4269.1 4272.9 4277.9 4283.8 4286.3 6041.1 6050.0 6051.1 6053.1 6053.1 5616.6 5624.1 5630.9 5631.1 5631.8 6346.0 6581.9 6607.9 6608.3 6640.6 4568.7 4599.6 4603.5 4607.4 4608.1 6865.8 6887.7 6939.5 6954.6 6960.7 4588.4 4594.0 4608.2 4616.6 4634.1 4661.5 4673.3 4674.8 4676.3 4677.3 5320.2 5464.5 5465.4 5475.5 5550.6 6685.5 6697.8 6729.0 6736.5 6745.9 1549.8 1631.9 1652.3 1673.0 1679.2 1076.1 1095.0 1097.7 1102.3 1108.9 6458.6 6465.8 6471.6 6475.9 6482.1 6849.0 6850.1 6853.1 6853.3 6874.9 6412.0 6484.7 6531.1 6550.0 6552.2 3670.1 3697.2 3698.0 3704.0 3704.6 6955.9 7065.4 7233.4 7247.2 7256.8 7111.0 7117.8 7123.4 7132.3 7132.5 7193.0 7209.6 7213.2 7216.0 7218.5 6949.1 6958.3 6967.8 6968.0 6982.4 6789.0 6835.0 6876.9 6889.9 6892.4 7153.5 7161.2 7162.6 7181.2 7182.7 4695.7 4737.6 4739.0 4742.4 4751.9 6602.0 6916.8 6924.8 6936.0 6936.9 6594.8 6732.1 6738.4 6740.4 6746.9 6672.2 6687.8 6705.0 6711.7 6715.2 6593.2 6601.5 6603.6 6605.8 6607.9 6605.2 6740.2 6749.6 6757.3 6762.5 6552.9 6579.8 6595.9 6599.8 6600.4 08:33:59 INFO - PROCESS | 12685 | 08:33:59 INFO - PROCESS | 12685 | [#5] yui.html Cycles:180 Average:15407.06 Median:26316.83 stddev:17524.77 (66.6%) stddev-sans-first:17539.70 08:33:59 INFO - PROCESS | 12685 | Values: 821.7 833.7 841.7 920.3 943.0 15036.5 15085.2 15532.4 17046.5 17592.4 16286.8 16368.5 16405.7 16423.8 16445.7 746.8 851.4 863.5 881.0 884.2 905.9 909.4 912.6 914.9 915.3 946.7 950.3 950.8 951.8 952.3 778.5 907.5 928.5 928.7 931.5 688.0 689.1 689.2 689.3 689.9 15333.5 15389.4 15415.2 15449.9 15485.5 14794.7 15138.4 15139.1 15192.4 15214.2 12269.3 12378.3 12399.2 12460.1 12549.4 4124.9 4809.4 4811.5 4812.0 4982.1 60456.4 60506.7 60566.7 60628.7 61534.4 11275.8 11406.7 11452.4 11532.9 11599.5 20736.4 20764.6 20804.1 20829.9 20852.5 8494.9 8760.3 8767.4 8810.0 8863.5 5020.6 5038.3 5160.6 5186.7 5275.2 3732.7 3785.7 3793.9 3795.8 3797.1 682.9 686.6 706.2 715.8 727.0 684.3 759.3 778.0 828.1 844.3 9938.0 10007.9 10020.7 10249.9 10342.5 826.1 831.3 833.1 834.3 860.4 4694.4 4759.0 4819.1 4824.5 4894.6 59797.1 60143.7 60497.7 61137.4 61372.7 53737.7 55290.0 55489.0 55714.0 55785.0 48773.5 49283.0 49536.8 49783.8 49865.0 9428.3 9450.6 9450.8 9490.7 9542.5 36877.6 37441.0 38267.8 38785.4 38804.9 45213.8 46826.1 47324.3 47436.0 47824.3 11538.5 11566.8 11605.2 11812.0 11899.0 12488.0 12798.0 13052.7 13130.3 13259.8 12015.2 12054.3 12058.2 12491.0 12556.2 12336.2 12472.0 12532.1 12534.9 12578.8 11677.9 11951.9 12038.3 12285.2 12512.9 10045.8 10260.5 10275.7 10416.7 10530.3 9828.4 10116.6 10160.4 10166.6 10285.7 08:33:59 INFO - PROCESS | 12685 | -------- Summary: end -------- 08:33:59 INFO - PROCESS | 12685 | 08:33:59 INFO - TEST-INFO | 12685: exit 0 08:33:59 INFO - TEST-OK | dromaeo_css | took 1111329ms 08:33:59 INFO - TEST-START | kraken 08:33:59 INFO - operating with platform_type : linux_ 08:33:59 INFO - Initialising browser for kraken test... 08:33:59 INFO - TEST-INFO | started process 12877 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSdv5D9/profile http://localhost:40639/getInfo.html) 08:34:03 INFO - PROCESS | 12877 | __metrics Screen width/height:1600/1200 08:34:03 INFO - PROCESS | 12877 | colorDepth:24 08:34:03 INFO - PROCESS | 12877 | Browser inner width/height: 1024/697 08:34:03 INFO - PROCESS | 12877 | __metrics 08:34:05 ERROR - PROCESS | 12877 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:34:05 INFO - TEST-INFO | 12877: exit 0 08:34:05 INFO - Browser initialized. 08:34:05 INFO - Running cycle 1/1 for kraken test... 08:34:05 INFO - TEST-INFO | started process 12967 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSdv5D9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:34:17 INFO - PROCESS | 12967 | RSS: Main: 141824000 08:34:17 INFO - PROCESS | 12967 | 08:34:20 INFO - PROCESS | 12967 | Cycle 1(1): loaded http://localhost:40639/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40639/tests/kraken/driver.html?testName=audio-beat-detection) 08:34:20 INFO - PROCESS | 12967 | RSS: Main: 196915200 08:34:20 INFO - PROCESS | 12967 | 08:34:23 INFO - PROCESS | 12967 | Cycle 1(1): loaded http://localhost:40639/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40639/tests/kraken/driver.html?testName=audio-dft) 08:34:24 INFO - PROCESS | 12967 | RSS: Main: 181448704 08:34:24 INFO - PROCESS | 12967 | 08:34:26 INFO - PROCESS | 12967 | Cycle 1(1): loaded http://localhost:40639/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40639/tests/kraken/driver.html?testName=audio-fft) 08:34:27 INFO - PROCESS | 12967 | RSS: Main: 272523264 08:34:27 INFO - PROCESS | 12967 | 08:34:29 INFO - PROCESS | 12967 | Cycle 1(1): loaded http://localhost:40639/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40639/tests/kraken/driver.html?testName=audio-oscillator) 08:34:30 INFO - PROCESS | 12967 | RSS: Main: 179040256 08:34:30 INFO - PROCESS | 12967 | 08:34:32 INFO - PROCESS | 12967 | Cycle 1(1): loaded http://localhost:40639/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40639/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:34:33 INFO - PROCESS | 12967 | RSS: Main: 177393664 08:34:33 INFO - PROCESS | 12967 | 08:34:36 INFO - PROCESS | 12967 | Cycle 1(1): loaded http://localhost:40639/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40639/tests/kraken/driver.html?testName=imaging-darkroom) 08:34:36 INFO - PROCESS | 12967 | RSS: Main: 212316160 08:34:36 INFO - PROCESS | 12967 | 08:34:39 INFO - PROCESS | 12967 | Cycle 1(1): loaded http://localhost:40639/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40639/tests/kraken/driver.html?testName=imaging-desaturate) 08:34:40 INFO - PROCESS | 12967 | RSS: Main: 212942848 08:34:40 INFO - PROCESS | 12967 | 08:34:43 INFO - PROCESS | 12967 | Cycle 1(1): loaded http://localhost:40639/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40639/tests/kraken/driver.html?testName=json-parse-financial) 08:34:43 INFO - PROCESS | 12967 | RSS: Main: 212316160 08:34:43 INFO - PROCESS | 12967 | 08:34:45 INFO - PROCESS | 12967 | Cycle 1(1): loaded http://localhost:40639/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40639/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:34:45 INFO - PROCESS | 12967 | RSS: Main: 189587456 08:34:45 INFO - PROCESS | 12967 | 08:34:47 INFO - PROCESS | 12967 | Cycle 1(1): loaded http://localhost:40639/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40639/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:34:48 INFO - PROCESS | 12967 | RSS: Main: 194658304 08:34:48 INFO - PROCESS | 12967 | 08:34:50 INFO - PROCESS | 12967 | Cycle 1(1): loaded http://localhost:40639/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40639/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:34:50 INFO - PROCESS | 12967 | RSS: Main: 208613376 08:34:50 INFO - PROCESS | 12967 | 08:34:53 INFO - PROCESS | 12967 | Cycle 1(1): loaded http://localhost:40639/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40639/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:34:53 INFO - PROCESS | 12967 | RSS: Main: 213950464 08:34:53 INFO - PROCESS | 12967 | 08:34:56 INFO - PROCESS | 12967 | Cycle 1(1): loaded http://localhost:40639/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40639/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:34:57 INFO - PROCESS | 12967 | RSS: Main: 211161088 08:34:57 INFO - PROCESS | 12967 | 08:34:58 INFO - PROCESS | 12967 | Cycle 1(1): loaded http://localhost:40639/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40639/tests/kraken/driver.html?testName=ai-astar) 08:34:59 INFO - PROCESS | 12967 | RSS: Main: 274661376 08:34:59 INFO - PROCESS | 12967 | 08:34:59 INFO - PROCESS | 12967 | __start_tp_report 08:34:59 INFO - PROCESS | 12967 | _x_x_mozilla_page_load 08:34:59 INFO - PROCESS | 12967 | _x_x_mozilla_page_load_details 08:34:59 INFO - PROCESS | 12967 | |i|pagename|runs| 08:34:59 INFO - PROCESS | 12967 | |0;ai-astar;110;111;109;110;110;111;106;114;108;109 08:34:59 INFO - PROCESS | 12967 | |1;audio-beat-detection;159;126;154;180;135;155;150;130;184;126 08:34:59 INFO - PROCESS | 12967 | |2;audio-dft;161;161;161;161;160;160;161;164;161;161 08:34:59 INFO - PROCESS | 12967 | |3;audio-fft;77;75;76;175;76;75;76;77;172;75 08:34:59 INFO - PROCESS | 12967 | |4;audio-oscillator;92;92;156;91;91;93;152;92;92;148 08:34:59 INFO - PROCESS | 12967 | |5;imaging-gaussian-blur;116;121;117;116;116;116;117;117;117;117 08:34:59 INFO - PROCESS | 12967 | |6;imaging-darkroom;146;145;145;145;146;145;146;145;146;145 08:34:59 INFO - PROCESS | 12967 | |7;imaging-desaturate;95;95;95;94;94;95;95;95;94;94 08:34:59 INFO - PROCESS | 12967 | |8;json-parse-financial;54;53;57;53;54;53;54;73;53;52 08:34:59 INFO - PROCESS | 12967 | |9;json-stringify-tinderbox;60;59;59;59;60;59;59;60;59;58 08:34:59 INFO - PROCESS | 12967 | |10;stanford-crypto-aes;72;71;85;73;73;74;72;74;73;73 08:34:59 INFO - PROCESS | 12967 | |11;stanford-crypto-ccm;115;116;110;114;112;113;112;113;129;131 08:34:59 INFO - PROCESS | 12967 | |12;stanford-crypto-pbkdf2;160;165;164;162;165;169;161;162;159;161 08:34:59 INFO - PROCESS | 12967 | |13;stanford-crypto-sha256-iterative;67;68;67;66;66;67;65;67;65;64 08:34:59 INFO - PROCESS | 12967 | __end_tp_report 08:34:59 INFO - PROCESS | 12967 | __start_cc_report 08:34:59 INFO - PROCESS | 12967 | _x_x_mozilla_cycle_collect,1613 08:34:59 INFO - PROCESS | 12967 | __end_cc_report 08:34:59 INFO - PROCESS | 12967 | __startTimestamp1464622499135__endTimestamp 08:34:59 INFO - PROCESS | 12967 | 08:34:59 INFO - PROCESS | 12967 | ------- Summary: start ------- 08:34:59 INFO - PROCESS | 12967 | Number of tests: 14 08:34:59 INFO - PROCESS | 12967 | 08:34:59 INFO - PROCESS | 12967 | [#0] ai-astar Cycles:10 Average:109.80 Median:110.00 stddev:2.10 (1.9%) stddev-sans-first:2.22 08:34:59 INFO - PROCESS | 12967 | Values: 110.0 111.0 109.0 110.0 110.0 111.0 106.0 114.0 108.0 109.0 08:34:59 INFO - PROCESS | 12967 | 08:34:59 INFO - PROCESS | 12967 | [#1] audio-beat-detection Cycles:10 Average:149.90 Median:154.50 stddev:20.96 (13.6%) stddev-sans-first:21.97 08:34:59 INFO - PROCESS | 12967 | Values: 159.0 126.0 154.0 180.0 135.0 155.0 150.0 130.0 184.0 126.0 08:34:59 INFO - PROCESS | 12967 | 08:34:59 INFO - PROCESS | 12967 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 08:34:59 INFO - PROCESS | 12967 | Values: 161.0 161.0 161.0 161.0 160.0 160.0 161.0 164.0 161.0 161.0 08:34:59 INFO - PROCESS | 12967 | 08:34:59 INFO - PROCESS | 12967 | [#3] audio-fft Cycles:10 Average:95.40 Median:76.00 stddev:41.17 (54.2%) stddev-sans-first:43.13 08:34:59 INFO - PROCESS | 12967 | Values: 77.0 75.0 76.0 175.0 76.0 75.0 76.0 77.0 172.0 75.0 08:34:59 INFO - PROCESS | 12967 | 08:34:59 INFO - PROCESS | 12967 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:92.00 stddev:29.12 (31.7%) stddev-sans-first:30.16 08:34:59 INFO - PROCESS | 12967 | Values: 92.0 92.0 156.0 91.0 91.0 93.0 152.0 92.0 92.0 148.0 08:34:59 INFO - PROCESS | 12967 | 08:34:59 INFO - PROCESS | 12967 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:1.49 (1.3%) stddev-sans-first:1.54 08:34:59 INFO - PROCESS | 12967 | Values: 116.0 121.0 117.0 116.0 116.0 116.0 117.0 117.0 117.0 117.0 08:34:59 INFO - PROCESS | 12967 | 08:34:59 INFO - PROCESS | 12967 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 08:34:59 INFO - PROCESS | 12967 | Values: 146.0 145.0 145.0 145.0 146.0 145.0 146.0 145.0 146.0 145.0 08:34:59 INFO - PROCESS | 12967 | 08:34:59 INFO - PROCESS | 12967 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 08:34:59 INFO - PROCESS | 12967 | Values: 95.0 95.0 95.0 94.0 94.0 95.0 95.0 95.0 94.0 94.0 08:34:59 INFO - PROCESS | 12967 | 08:34:59 INFO - PROCESS | 12967 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:54.00 stddev:6.26 (11.6%) stddev-sans-first:6.61 08:34:59 INFO - PROCESS | 12967 | Values: 54.0 53.0 57.0 53.0 54.0 53.0 54.0 73.0 53.0 52.0 08:34:59 INFO - PROCESS | 12967 | 08:34:59 INFO - PROCESS | 12967 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:59.00 stddev:0.63 (1.1%) stddev-sans-first:0.60 08:34:59 INFO - PROCESS | 12967 | Values: 60.0 59.0 59.0 59.0 60.0 59.0 59.0 60.0 59.0 58.0 08:34:59 INFO - PROCESS | 12967 | 08:34:59 INFO - PROCESS | 12967 | [#10] stanford-crypto-aes Cycles:10 Average:74.00 Median:73.00 stddev:3.97 (5.4%) stddev-sans-first:4.15 08:34:59 INFO - PROCESS | 12967 | Values: 72.0 71.0 85.0 73.0 73.0 74.0 72.0 74.0 73.0 73.0 08:34:59 INFO - PROCESS | 12967 | 08:34:59 INFO - PROCESS | 12967 | [#11] stanford-crypto-ccm Cycles:10 Average:116.50 Median:114.50 stddev:7.32 (6.4%) stddev-sans-first:7.75 08:34:59 INFO - PROCESS | 12967 | Values: 115.0 116.0 110.0 114.0 112.0 113.0 112.0 113.0 129.0 131.0 08:34:59 INFO - PROCESS | 12967 | 08:34:59 INFO - PROCESS | 12967 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.80 Median:163.00 stddev:2.97 (1.8%) stddev-sans-first:2.98 08:34:59 INFO - PROCESS | 12967 | Values: 160.0 165.0 164.0 162.0 165.0 169.0 161.0 162.0 159.0 161.0 08:34:59 INFO - PROCESS | 12967 | 08:34:59 INFO - PROCESS | 12967 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:67.00 stddev:1.23 (1.8%) stddev-sans-first:1.27 08:34:59 INFO - PROCESS | 12967 | Values: 67.0 68.0 67.0 66.0 66.0 67.0 65.0 67.0 65.0 64.0 08:34:59 INFO - PROCESS | 12967 | -------- Summary: end -------- 08:34:59 INFO - PROCESS | 12967 | 08:35:00 INFO - TEST-INFO | 12967: exit 0 08:35:00 INFO - TEST-OK | kraken | took 60344ms 08:35:00 INFO - SUITE-END | took 1171s 08:35:00 INFO - Completed test suite (00:19:31) 08:35:00 INFO - javascript benchmark 08:35:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3303.9834800825993, 3372.6290108088106, 3380.0873764083703, 3400.2009527760956, 3412.556367672202, 5510.228568000483, 5513.586481013925, 5519.978803921273, 5527.50252477277, 5538.280023596937, 5505.229267902497, 5508.862278443041, 5530.391656917735, 5541.390447050831, 5568.16477528371, 4890.266460030988, 4954.281629163778, 5042.47054059324, 5086.440491545927, 5122.206058061007, 4955.702657840523, 5008.524190201943, 5033.7734801934, 5036.395632524102, 5099.668521546107, 5116.283720279164, 5146.047981123485, 5153.330067091273, 5160.587153027749, 5163.199704045879, 5151.896962060757, 5152.252923326116, 5153.2270159476375, 5160.948390516084, 5187.896242075175, 4885.413750349945, 4979.47715489872, 5056.165732654108, 5080.847574572732, 5082.288479612857, 5457.699826509541, 5466.890662186774, 5469.808556700536, 5480.616356855022, 5489.286392768954, 5923.496502797268, 5933.643981361132, 5955.166276721263, 5960.642361458326, 5969.820905372846, 5791.247137872049, 5806.361300256968, 5911.172435858984, 5934.1098835174635, 5943.078822782476, 5501.834944951658, 5504.752286147133, 5508.724563771795, 5510.256115424407, 5513.2005859150195, 5991.670458124845, 5992.610480318853, 5998.280206375263, 5999.430054144849, 6000.399960003964, 5640.661560306395, 5756.42435756421, 5808.651480911159, 5819.0689489681445, 5840.445157710095, 5857.560682948796, 5863.149843272701, 5864.120381942743, 5865.941340586625, 5866.560007999417, 5687.857803554944, 5802.970985145132, 5850.5904586678525, 5852.15143804146, 5857.619254748428, 5881.147233651097, 5938.762449501972, 5952.196453478811, 5979.312379076375, 5984.790532331347, 4509.909801803946, 4513.232750432434, 4514.548545145459, 4518.977405113019, 4525.298578720303, 3945.861894833667, 4065.2479291331197, 4066.1461093170174, 4074.0629655179473, 4099.487564054493, 5551.1673249012165, 5605.887882242332, 5612.1581762735095, 5641.661500309912, 5654.802081927195, 5898.085796701518, 5903.35063143054, 5903.3801450847905, 5909.379515150933, 5910.290765108214, 5421.05131601976, 5624.100143977026, 5628.493435590816, 5641.576881733804, 5646.830595082154, 4997.525235102659, 5016.924746128811, 5021.020900924358, 5022.974885125551, 5050.166722490748, 6143.846403839851, 6145.631262124198, 6153.630782153085, 6154.046122850965, 6154.969225153845, 5813.360530341574, 5892.823215303548, 5987.401259874065, 5996.310424301261, 6004.0693692477735, 6118.893302669218, 6138.58022223998, 6144.556029333014, 6146.016637338004, 6147.323794382703, 5835.095560188178, 5835.183074369676, 5839.0949402842625, 5840.853978650568, 5882.176495290748, 5691.857703557444, 5854.209681692917, 5944.197533332945, 5955.076963070731, 5980.372060933713, 5805.0, 5821.912671310019, 5847.561432892635, 5849.795257165979, 5850.327212370632, 5759.078547432391, 5824.155497452761, 5825.854353641193, 5827.329857066492, 5828.0, 5549.833504994856, 5697.259356283656, 5748.0, 5756.798512052058, 5788.13178023283, 5841.50347220474, 5859.00396932514, 5859.970700146472, 5867.383924687846, 5879.20630714848, 5513.42109078557, 5700.230468886647, 5757.9424205757405, 5758.539316854725, 5765.279340082489], "value": 5463.946346519208, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.3613437823097, 657.4805903336364, 661.361785876629, 668.1881513960539, 668.2815972829206, 31847.52228716568, 39571.20857582847, 40502.189956200855, 40539.79730101345, 40544.0, 43299.78350108245, 43803.0, 43859.0, 43867.341989870176, 43945.560544394546, 7942.086660034083, 8669.133086691329, 8801.207891289783, 8865.379423440361, 10456.947715261413, 10351.844722329171, 10475.685729428129, 10486.68539943799, 10489.842652360221, 10497.4226417547, 10518.737031574234, 10578.947105264502, 10579.84130238047, 10582.047615714584, 10583.10043646291, 10468.842967355535, 10490.213234007442, 10508.894911050944, 10531.104856087242, 10536.525856336484, 10486.895131048668, 10855.51150198243, 10864.674059778219, 10869.456527173688, 10889.128869690485, 44104.77947610273, 44165.558344416466, 44438.77780611109, 44471.11057778859, 44539.77730111361, 3859.286032084073, 3952.1107750756137, 3977.204559088165, 4324.567543245682, 4625.699329543602, 33817.32365352704, 33864.49203261953, 34022.0, 35370.0, 35390.64609353899, 4512.075024619945, 4524.886877828048, 4546.977265113686, 4600.516945720685, 4804.303376010494, 313359.0, 314317.0, 314682.0, 314934.0, 317275.9999999977, 38741.2251754969, 39297.607023929966, 39444.0, 63138.0, 63767.68116159389, 37076.81461592675, 37116.628833711315, 37258.44112338317, 37262.0, 37295.62704372976, 15457.381704731684, 17126.14369281531, 17327.047012414187, 17334.306627735, 17346.739798903025, 14947.177905215318, 15098.471553495576, 15140.318685659171, 15145.469908553368, 15157.772633410508, 9195.586198621078, 9197.356185066981, 9222.631094756134, 9268.073192680678, 9303.162715355515, 3543.8936831895085, 3592.748507604495, 3600.369935261319, 3607.567091948983, 3636.472711456824, 1024.36489376587, 1110.6001839337832, 1134.8694900086596, 1191.6961174900518, 1258.4337048328289, 33725.66274337225, 34961.65038349584, 35467.29065418677, 35606.0, 35716.82141589275, 1168.9123315751183, 1175.9176857619884, 1190.190670344157, 1236.6475554466933, 1281.557862537423, 17407.71058358447, 17550.648987020442, 17911.641767164583, 17987.83079099854, 18161.545961351072, 484600.0, 673088.0, 680932.0, 684608.0, 684700.0, 63230.68384658139, 63558.36441635617, 63785.68107159434, 63849.0, 63984.68007659932, 1479.5857159995003, 1480.8519148085106, 1546.7447871101367, 1548.79865617469, 1571.300771156847, 32103.197420064684, 32410.83794581012, 32514.349713006082, 32766.344673105927, 33221.50167747437, 54277.72861135669, 55848.72075639596, 55906.0, 55977.0, 55984.72007639936, 422596.0, 430441.0, 430993.0, 431835.0, 432178.0, 40506.39240411337, 46546.76726616345, 46744.53255467402, 47025.29462058003, 47903.646744727535, 46972.7651361741, 47038.76480617575, 47453.762731187504, 47604.04791904212, 47871.52128478671, 39698.0, 40343.596564033985, 44052.33921491116, 44696.0, 45034.77482612566, 43128.13743725171, 43441.0, 44425.77787111044, 44530.66408007765, 44548.33177502275, 43954.0, 45034.0993180128, 45257.094858103315, 45290.09419811519, 45445.31832022589, 36625.63374366222, 38389.424158637084, 38865.41701874418, 39408.80295598504, 39675.2064958705, 29304.853475732485, 29536.704632953395, 29891.701082988893, 29969.0, 30078.398432031674], "value": 20459.584887591413, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [420.17855093292616, 421.936709493576, 427.48488071873373, 435.2904765232671, 442.2525931176312, 17800.46598602041, 18985.0, 19551.706724399126, 19567.902160489197, 19702.211911523522, 11714.531418743261, 12201.572944946929, 12220.816687749668, 18674.0, 18883.52791180221, 5328.893422131565, 5406.729663516828, 5456.317960254968, 5459.426760190182, 5474.343078830546, 5183.067047931371, 5267.789288428477, 5275.973620131894, 5276.1030624793875, 5280.498352656491, 5256.894862102756, 5258.211268309746, 5262.105442074837, 5278.6568873023325, 5280.260763493114, 5298.046351656701, 5426.538744206747, 5776.364599894008, 5910.911336329937, 5958.106284057383, 5319.707416092114, 5330.600204984642, 5332.546733527654, 5332.573394128499, 5351.759170837283, 23108.0, 23518.176863809684, 24313.878430607732, 24510.632340514905, 24526.754732452624, 2545.52907712072, 2589.59861221511, 2641.867906604681, 2689.0, 2988.4770165221, 10619.840702389392, 11051.613193538187, 14905.403783848633, 14933.956330308196, 15451.536453906401, 2030.8679935804125, 2096.8951552422473, 2121.8090371866606, 2169.7287839020123, 2190.9014094365793, 60351.69824150895, 61768.382316176714, 63947.0, 74059.62970185114, 81010.59494702489, 10549.789004219872, 10734.463276836126, 11047.226694131494, 11051.613193538187, 11289.096872250364, 14194.503192388216, 15103.39586416531, 15583.922080389526, 16215.756763648555, 16227.350905963629, 8373.958130209432, 8442.915570844212, 8457.323414126979, 8460.788480288042, 8752.606132724042, 8123.822045803326, 8157.836843263101, 8172.264496195371, 8262.091169971298, 8774.210321071007, 4738.786754596052, 4819.855404337875, 4846.975765121152, 4904.2860403497, 4910.361652985089, 1981.7126516655292, 2003.1386503803503, 2014.4460273424631, 2021.2824447320988, 2041.3773798991451, 1000.7197984564334, 1055.1664185293685, 1076.5155679944057, 1101.427257825942, 1149.1438878035917, 18466.446006619823, 19470.0, 19526.902588272525, 19604.803951960585, 19887.0, 1026.6663334416344, 1081.507913899174, 1086.7554800170058, 1092.4810714910514, 1094.2012330998416, 10833.566657333777, 11167.106631469625, 11205.887941120647, 11256.437178141061, 11372.0, 473825.0, 479206.0, 483483.0, 505853.0, 507833.0, 87919.0, 92998.0, 93006.0, 93650.0, 93801.53099234597, 1074.0762943868267, 1076.4187338836941, 1096.0135877709965, 1104.320842681761, 1111.9666410007712, 16985.660286794442, 17340.612750980144, 17406.216720247874, 17669.646607068044, 18008.819911800714, 31463.37073258476, 38233.0, 39141.41287880627, 39281.0, 41108.38337425001, 55600.0, 55629.1655625174, 55718.44281557295, 55743.442565575446, 55997.72001139968, 8542.44474109181, 8853.335999799912, 8867.467951922905, 9112.817743645222, 9215.86176207344, 12915.741685166056, 13279.269640169883, 13761.449542018207, 13794.172349659053, 14177.14937103777, 11937.940310298392, 12308.0, 12477.812832807334, 12483.56307529232, 12487.0, 11573.652790416301, 11900.464479098287, 12331.9383403086, 12365.0, 12683.873161268639, 12546.560870369492, 12594.118411711092, 12733.0, 12819.743605128031, 12858.0, 8723.127687231226, 8751.606177721891, 8817.07420720815, 8907.777305567413, 8973.28213742912, 9007.189352958265, 12001.279923204636, 12594.433250503565, 12688.429020693906, 12741.55404560836], "value": 9349.3748103553, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1392.7005693775836, 1535.0789526284232, 1544.7914531538247, 1725.0770837601885, 1844.880082794619, 8013.439059265854, 8127.5529845858455, 8158.5104893706275, 8164.591770411485, 8166.469179503328, 8012.1186669466315, 8177.836443271131, 8184.9768778902635, 8186.79533011675, 8191.672333106669, 2071.347525529461, 2401.1715957994506, 2409.4217387826884, 2429.259075981825, 2452.080469823816, 2429.866357350345, 2445.3153117127144, 2445.3397582652674, 2447.204658485999, 2447.241355179891, 2355.1168311883043, 2406.95186096278, 2410.963835542468, 2413.1553956115395, 2413.408714864852, 2041.918323267075, 2351.8236132290062, 2400.4838959623676, 2405.446747248125, 2409.8915548800346, 2379.3694670912223, 2416.275117464771, 2426.8665223412704, 2427.0291883246664, 2427.2354208424467, 8057.113717491071, 8110.3511719062335, 8126.0, 8128.227818357305, 8128.674853005873, 5230.764615592308, 5355.571554275649, 5361.490658387447, 5367.409584945653, 5465.480779325958, 3565.4295312750096, 3642.8178591070605, 3677.613850545681, 3682.0, 3699.223163135745, 1129.8700649425339, 1133.5465813674514, 1137.397179494869, 1155.3183621663175, 1177.8233265010317, 11966.82049769254, 11971.580994665232, 11989.940050299692, 11997.34014629195, 12030.33833139177, 4697.859064228079, 4738.64460165489, 4798.448178459452, 4829.589484893753, 4837.661363704507, 10100.393976361442, 10110.949445252727, 10137.543810528545, 10145.188384929188, 10156.0, 4759.381280433521, 5427.701476418756, 5433.320834895638, 5434.64674796137, 5436.728163591804, 4889.828855990095, 4932.284818701268, 4956.801727930914, 4995.375578052744, 5016.774245158977, 4066.064805094845, 4076.9796151019054, 4125.876223713293, 4128.958710412858, 4148.854790082332, 1315.6908126590245, 1351.8242628458434, 1352.0468070010618, 1355.1327150623608, 1356.7422189783908, 977.94621295828, 1064.7125276175389, 1074.1514203779084, 1087.2063393722626, 1088.4612117001977, 6117.571769976059, 6164.352742962014, 6201.658908759971, 6266.968665156645, 6294.15028971083, 478.40438653876146, 483.0941983780412, 483.79438738536686, 1096.3257596578046, 1102.9889701102886, 4190.832366705297, 4214.30463973441, 4219.2194444027955, 4222.873313800591, 4223.429836972031, 10386.740331491774, 10729.78540429187, 10782.191335649857, 10805.783884322427, 10820.0, 10352.792944141074, 10414.479276036167, 10502.05481506668, 10508.106810921005, 10518.368897866, 7604.277593628707, 8024.157463466368, 8283.668653253802, 8287.917120828835, 8296.128906464855, 5798.420157984167, 5816.36020037804, 5859.062549991981, 5943.346231914573, 5971.701414929149, 9358.11097945694, 9373.765655858659, 9459.621615135318, 9513.23894088485, 9609.087136722, 9194.95402522983, 9447.858282125912, 9449.48027858447, 9450.291228158054, 9910.554025068745, 6963.825904352431, 7506.099268087864, 7661.655225514976, 7767.650455729618, 7783.066032076187, 8112.513249205066, 8117.350611951148, 8138.389620778347, 8145.104038555635, 8211.58942052907, 7189.7483588074165, 7395.223501532261, 7403.66683499233, 7415.2214017527385, 7584.772456826304, 7062.894056589258, 7164.426845852215, 7258.383037441877, 7350.7427240046345, 7376.631168441664, 6580.144581204413, 6592.80221593353, 6619.4373478252965, 6644.568103073285, 6688.063671085954, 4919.655624106422, 5048.318477005704, 5067.290579318825, 5108.514691104339, 5113.8721531962, 5123.231515272739, 5178.61160412963, 5200.401953775213, 5212.270282160424, 5283.392409872914], "value": 4596.207019478536, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.47953987178715, 356.7039357333413, 358.7363287983333, 360.95848977367604, 370.2908929400199, 6257.0927215553775, 6317.52618553608, 6377.521685873555, 6400.103985442041, 6408.2950875403785, 6007.519398448125, 6150.723217455214, 6314.0, 6330.556861019731, 6334.0, 4864.173090574611, 4879.292502587123, 4899.877503062426, 4903.313536104948, 4920.901581968358, 4865.41615006198, 4865.902681946377, 4883.169861123618, 4885.267209918505, 4886.047220791947, 4642.303654451825, 4699.976500117512, 4714.976425117887, 4802.9039419211595, 4846.200376937801, 4832.202686556714, 4840.830570930036, 4844.1038407894475, 4846.515348465161, 4861.659683822134, 4269.146170765828, 4272.893177670552, 4277.850275240383, 4283.764392958386, 4286.292761694317, 6041.093835924603, 6050.0, 6051.1225872248715, 6053.061775424816, 6053.122297266916, 5616.606837521375, 5624.128260119647, 5630.887382252332, 5631.1271752878365, 5631.8028868989795, 6346.048092786073, 6581.868362632768, 6607.933920660828, 6608.2730899601, 6640.634765087918, 4568.725876447391, 4599.563041511051, 4603.5166307537565, 4607.424071991001, 4608.124456353282, 6865.759698410581, 6887.655617219119, 6939.514234003622, 6954.582725036514, 6960.65196740166, 4588.357629931812, 4594.035252596926, 4608.216603177468, 4616.60758835496, 4634.119517291704, 4661.510541393172, 4673.252279635242, 4674.789634466457, 4676.321933319649, 4677.32178834074, 5320.228566857862, 5464.453554644583, 5465.371482279509, 5475.479829416199, 5550.639208451518, 6685.532012759158, 6697.7655782047395, 6728.966355168291, 6736.5284430090405, 6745.898811517733, 1549.8217704964075, 1631.9347226110822, 1652.264742189714, 1672.9794825156644, 1679.1520282257381, 1076.05844885725, 1095.0, 1097.6542389147394, 1102.2945314998408, 1108.8891110889008, 6458.61248325102, 6465.806025819233, 6471.611703297817, 6475.935240647627, 6482.12491313676, 6849.0, 6850.0752398426575, 6853.109095817512, 6853.314668533107, 6874.862502749917, 6412.0, 6484.708188131545, 6531.0856480092825, 6549.967250163719, 6552.213734351908, 3670.064133645903, 3697.1681371691157, 3698.0385099874225, 3703.981480092636, 3704.629537046274, 6955.930440695528, 7065.43476521877, 7233.421326293989, 7247.23903990084, 7256.7822965311125, 7111.0, 7117.822054448577, 7123.358897699129, 7132.251113632994, 7132.465065120136, 7193.0, 7209.6034718091005, 7213.170485394142, 7215.96392018026, 7218.530795498275, 6949.131358580177, 6958.269381715049, 6967.8258043547285, 6968.0, 6982.441404687715, 6788.950276243094, 6835.043093966948, 6876.862462750817, 6889.862202755817, 6892.379685828299, 7153.4992550520965, 7161.176464706626, 7162.570245785269, 7181.24596917337, 7182.676779544829, 4695.671303008893, 4737.644676649334, 4739.0, 4742.407199100113, 4751.9287210692555, 6602.042703807825, 6916.757913473004, 6924.7576334830055, 6935.965320173367, 6936.930630693629, 6594.802155935329, 6732.091167692299, 6738.427233685192, 6740.359665831738, 6746.886763683937, 6672.165979252593, 6687.765928192684, 6704.966475167788, 6711.731530738716, 6715.1941766988275, 6593.241777195492, 6601.471882249312, 6603.570767900071, 6605.834854128685, 6607.900881486878, 6605.207375114825, 6740.191177058784, 6749.595024298558, 6757.290484499057, 6762.526623136333, 6552.901706474311, 6579.769708060195, 6595.934040659532, 6599.835004124935, 6600.405963463311], "value": 5039.521453947251, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [821.704186492862, 833.687367237286, 841.69698908393, 920.3281604428769, 942.9500296227701, 15036.548903532885, 15085.245737713112, 15532.378704851806, 17046.488605341827, 17592.384266550675, 16286.755698664529, 16368.508944731677, 16405.67188656226, 16423.753643695323, 16445.671086578262, 746.779699988502, 851.4210336970857, 863.5034854958393, 880.9779755506099, 884.1777147253052, 905.8912930448355, 909.4316052467208, 912.5893347993397, 914.9222316103139, 915.2906497464485, 946.7207173883721, 950.3157726436955, 950.7575568230092, 951.8381875081253, 952.2857856607544, 778.4823092643385, 907.5280853955906, 928.5264515097282, 928.6517555916531, 931.5481991234246, 688.0333131949569, 689.0731965506436, 689.2246222999127, 689.334791925789, 689.8585789913055, 15333.539993800205, 15389.384424623002, 15415.15216663083, 15449.922750386177, 15485.535433937, 14794.704105917821, 15138.394464221417, 15139.091654500655, 15192.392304307814, 15214.239288035555, 12269.28230047794, 12378.319192444413, 12399.194052386567, 12460.12779105463, 12549.435275412628, 4124.938125928114, 4809.374781278411, 4811.4707382187935, 4811.975940120312, 4982.053409852117, 60456.39543604552, 60506.69746651283, 60566.69716651433, 60628.696856515875, 61534.384656153314, 11275.830862536905, 11406.657800266004, 11452.370119643332, 11532.88467115335, 11599.536018559163, 20736.377908662766, 20764.58470830605, 20804.063817128266, 20829.895850520952, 20852.47868803292, 8494.915050849537, 8760.299176065899, 8767.386282960259, 8810.0, 8863.468191908507, 5020.648554601143, 5038.319826823332, 5160.561352285098, 5186.714730689849, 5275.155975043975, 3732.720045996561, 3785.716071294664, 3793.867214647474, 3795.753276037104, 3797.0697179190724, 682.8839097353462, 686.5571706249441, 706.2090458686304, 715.7530651925077, 727.0076345787961, 684.2985939412142, 759.2521366454039, 777.9572123533147, 828.0849661124491, 844.3076677124822, 9938.0, 10007.899921000842, 10020.749481263027, 10249.897501024894, 10342.482875856178, 826.1490664615455, 831.3079708347776, 833.0752864320599, 834.3450391442689, 860.4278155026963, 4694.389729335233, 4758.976205118952, 4819.108464933998, 4824.49342819006, 4894.583960363409, 59797.103043454386, 60143.699281503315, 60497.69751151304, 61137.38862611406, 61372.693136534035, 53737.731311343974, 55290.0, 55489.0, 55714.0, 55785.0, 48773.51226487761, 49283.0, 49536.75231623891, 49783.751081244365, 49865.0, 9428.292878034037, 9450.574724137568, 9450.810983780148, 9490.667826626035, 9542.475163866055, 36877.63122368742, 37441.0, 38267.808660956514, 38785.418218726176, 38804.87271715537, 45213.773931130134, 46826.06347872956, 47324.290135648684, 47436.0, 47824.282635761185, 11538.480768365276, 11566.826497602711, 11605.245659032136, 11812.0, 11899.0, 12488.0, 12798.0, 13052.673683157996, 13130.277834719182, 13259.801102983656, 12015.158938874194, 12054.337011464453, 12058.216215945935, 12491.0, 12556.183848049848, 12336.198147120409, 12472.0, 12532.122751407314, 12534.87465125337, 12578.811317830423, 11677.941610291895, 11951.880481195076, 12038.337891416057, 12285.201461905304, 12512.937435312766, 10045.849312260469, 10260.486975651038, 10275.7431064224, 10416.739581510523, 10530.262881598215, 9828.361156524803, 10116.576966615716, 10160.441175735405, 10166.644167454104, 10285.74285642835], "value": 7171.142124199236, "unit": "score"}], "name": "dromaeo_css", "value": 7469.079613858313, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 109.0, 110.0, 110.0, 111.0, 106.0, 114.0, 108.0, 109.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 126.0, 154.0, 180.0, 135.0, 155.0, 150.0, 130.0, 184.0, 126.0], "value": 149.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 160.0, 160.0, 161.0, 164.0, 161.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 76.0, 175.0, 76.0, 75.0, 76.0, 77.0, 172.0, 75.0], "value": 95.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 156.0, 91.0, 91.0, 93.0, 152.0, 92.0, 92.0, 148.0], "value": 109.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 121.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 57.0, 53.0, 54.0, 53.0, 54.0, 73.0, 53.0, 52.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 59.0, 59.0, 60.0, 59.0, 59.0, 60.0, 59.0, 58.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 85.0, 73.0, 73.0, 74.0, 72.0, 74.0, 73.0, 73.0], "value": 74.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 110.0, 114.0, 112.0, 113.0, 112.0, 113.0, 129.0, 131.0], "value": 116.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 165.0, 164.0, 162.0, 165.0, 169.0, 161.0, 162.0, 159.0, 161.0], "value": 162.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 66.0, 66.0, 67.0, 65.0, 67.0, 65.0, 64.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1517.3999999999999, "alertThreshold": 2.0}]} 08:35:00 INFO - Return code: 0 08:35:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:35:00 ERROR - # TBPL SUCCESS # 08:35:00 INFO - Running post-action listener: _resource_record_post_action 08:35:00 INFO - Running post-run listener: _resource_record_post_run 08:35:01 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 262144; Write bytes: 509427712; Read time: 12; Write time: 560544 08:35:01 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 256598016; Read time: 0; Write time: 357392 08:35:01 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 262144; Write bytes: 248881152; Read time: 12; Write time: 202356 08:35:01 INFO - Running post-run listener: _upload_blobber_files 08:35:01 INFO - Blob upload gear active. 08:35:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:35:01 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 08:35:01 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:35:01 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:35:01 INFO - (blobuploader) - INFO - Open directory for files ... 08:35:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:35:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:35:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:35:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:35:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:35:02 INFO - (blobuploader) - INFO - Done attempting. 08:35:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:35:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:35:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:35:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:35:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:35:03 INFO - (blobuploader) - INFO - Done attempting. 08:35:03 INFO - (blobuploader) - INFO - Iteration through files over. 08:35:03 INFO - Return code: 0 08:35:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:35:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:35:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dff7f82ee2528e698d774f37c0e06255702c93d6f8b2105c40300f6ee39f3b805a4add1ebf7ca10c05c9b37478e9ca54daf3fe1d97b685e54b384b22a1d56397", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/604eff0031c059b286fc2f5faac74206dcc38e66bbe076d6858103e8fc52d8a2e2c04093eb5c81868e6a32331f299cad8b972e3dd931364eb1c70119b033ca55"} 08:35:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:35:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:35:03 INFO - Contents: 08:35:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dff7f82ee2528e698d774f37c0e06255702c93d6f8b2105c40300f6ee39f3b805a4add1ebf7ca10c05c9b37478e9ca54daf3fe1d97b685e54b384b22a1d56397", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/604eff0031c059b286fc2f5faac74206dcc38e66bbe076d6858103e8fc52d8a2e2c04093eb5c81868e6a32331f299cad8b972e3dd931364eb1c70119b033ca55"} 08:35:03 INFO - Running post-run listener: copy_logs_to_upload_dir 08:35:03 INFO - Copying logs to upload dir... 08:35:03 INFO - mkdir: /builds/slave/test/build/upload/logs 08:35:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.443295 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-05-30 08:35:03.307090) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 08:35:03.311078) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1464621275.769637-1846102734 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-Aurora/sha512/dff7f82ee2528e698d774f37c0e06255702c93d6f8b2105c40300f6ee39f3b805a4add1ebf7ca10c05c9b37478e9ca54daf3fe1d97b685e54b384b22a1d56397", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/604eff0031c059b286fc2f5faac74206dcc38e66bbe076d6858103e8fc52d8a2e2c04093eb5c81868e6a32331f299cad8b972e3dd931364eb1c70119b033ca55"} build_url:https://queue.taskcluster.net/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011228 build_url: 'https://queue.taskcluster.net/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dff7f82ee2528e698d774f37c0e06255702c93d6f8b2105c40300f6ee39f3b805a4add1ebf7ca10c05c9b37478e9ca54daf3fe1d97b685e54b384b22a1d56397", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/604eff0031c059b286fc2f5faac74206dcc38e66bbe076d6858103e8fc52d8a2e2c04093eb5c81868e6a32331f299cad8b972e3dd931364eb1c70119b033ca55"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 08:35:03.337579) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 08:35:03.337955) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1464621275.769637-1846102734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004422 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 08:35:03.423778) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 08:35:03.424154) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 08:35:03.424507) ========= ========= Total master_lag: 0.16 =========