builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-031 starttime: 1464621472.17 results: success (0) buildid: 20160530035543 builduid: 865ed214ad954ae683a81bd20aaeb948 revision: 04934785596476f6dd8baccc355202aeba59af35 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 08:17:52.175045) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 08:17:52.175549) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 08:17:52.175846) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 08:17:52.191147) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 08:17:52.191554) ========= 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=db0483c52d987ecb441a263b000001ad-1464621471.910958-297576215 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-30 08:17:52-- 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% 225M=0s 2016-05-30 08:17:52 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.068876 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 08:17:52.275060) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 08:17:52.275653) ========= 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=db0483c52d987ecb441a263b000001ad-1464621471.910958-297576215 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016264 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 08:17:52.328095) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 08:17:52.328721) ========= 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=db0483c52d987ecb441a263b000001ad-1464621471.910958-297576215 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-30 08:17:52,787 truncating revision to first 12 chars 2016-05-30 08:17:52,787 Setting DEBUG logging. 2016-05-30 08:17:52,787 attempt 1/10 2016-05-30 08:17:52,787 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:17:53,107 unpacking tar archive at: mozilla-aurora-049347855964/testing/mozharness/ program finished with exit code 0 elapsedTime=0.655432 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 08:17:52.999024) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 08:17:52.999422) ========= script_repo_revision: 04934785596476f6dd8baccc355202aeba59af35 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 08:17:52.999908) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 08:17:53.000197) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 08:17:53.010605) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-05-30 08:17:53.011020) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=db0483c52d987ecb441a263b000001ad-1464621471.910958-297576215 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:17:53 INFO - MultiFileLogger online at 20160530 08:17:53 in /builds/slave/test 08:17:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:17:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:17:53 INFO - {'append_to_log': False, 08:17:53 INFO - 'base_work_dir': '/builds/slave/test', 08:17:53 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:17:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:17:53 INFO - 'branch': 'Mozilla-Aurora', 08:17:53 INFO - 'buildbot_json_path': 'buildprops.json', 08:17:53 INFO - 'config_files': ('talos/linux_config.py',), 08:17:53 INFO - 'default_actions': ('clobber', 08:17:53 INFO - 'read-buildbot-config', 08:17:53 INFO - 'download-and-extract', 08:17:53 INFO - 'populate-webroot', 08:17:53 INFO - 'create-virtualenv', 08:17:53 INFO - 'install', 08:17:53 INFO - 'run-tests'), 08:17:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:17:53 INFO - 'download_minidump_stackwalk': True, 08:17:53 INFO - 'download_symbols': 'ondemand', 08:17:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:17:53 INFO - 'tooltool.py': '/tools/tooltool.py', 08:17:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:17:53 INFO - '/tools/misc-python/virtualenv.py')}, 08:17:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:17:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:17:53 INFO - 'installer_path': 'installer.exe', 08:17:53 INFO - 'log_level': 'info', 08:17:53 INFO - 'log_name': 'talos', 08:17:53 INFO - 'log_to_console': True, 08:17:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:17:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:17:53 INFO - 'opt_config_files': (), 08:17:53 INFO - 'pip_index': False, 08:17:53 INFO - 'sps_profile': False, 08:17:53 INFO - 'sps_profile_interval': 0, 08:17:53 INFO - 'suite': 'dromaeojs-e10s', 08:17:53 INFO - 'system_bits': '32', 08:17:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:17:53 INFO - 'title': 'talos-linux64-ix-031', 08:17:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:17:53 INFO - 'use_talos_json': True, 08:17:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:17:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:17:53 INFO - 'work_dir': 'build'} 08:17:53 INFO - ##### 08:17:53 INFO - ##### Running clobber step. 08:17:53 INFO - ##### 08:17:53 INFO - Running pre-action listener: _resource_record_pre_action 08:17:53 INFO - Running main action method: clobber 08:17:53 INFO - rmtree: /builds/slave/test/build 08:17:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:17:54 INFO - Running post-action listener: _resource_record_post_action 08:17:54 INFO - ##### 08:17:54 INFO - ##### Running read-buildbot-config step. 08:17:54 INFO - ##### 08:17:54 INFO - Running pre-action listener: _resource_record_pre_action 08:17:54 INFO - Running main action method: read_buildbot_config 08:17:54 INFO - Using buildbot properties: 08:17:54 INFO - { 08:17:54 INFO - "project": "", 08:17:54 INFO - "product": "firefox", 08:17:54 INFO - "script_repo_revision": "production", 08:17:54 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 08:17:54 INFO - "repository": "", 08:17:54 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 08:17:54 INFO - "buildid": "20160530035543", 08:17:54 INFO - "pgo_build": "True", 08:17:54 INFO - "basedir": "/builds/slave/test", 08:17:54 INFO - "buildnumber": 341, 08:17:54 INFO - "slavename": "talos-linux64-ix-031", 08:17:54 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:17:54 INFO - "platform": "ubuntu64_hw", 08:17:54 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 08:17:54 INFO - "branch": "mozilla-aurora", 08:17:54 INFO - "repo_path": "releases/mozilla-aurora", 08:17:54 INFO - "revision": "04934785596476f6dd8baccc355202aeba59af35", 08:17:54 INFO - "stage_platform": "linux64-pgo", 08:17:54 INFO - "builduid": "865ed214ad954ae683a81bd20aaeb948", 08:17:54 INFO - "slavebuilddir": "test" 08:17:54 INFO - } 08:17:54 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:17:54 INFO - Running post-action listener: _resource_record_post_action 08:17:54 INFO - ##### 08:17:54 INFO - ##### Running download-and-extract step. 08:17:54 INFO - ##### 08:17:54 INFO - Running pre-action listener: _resource_record_pre_action 08:17:54 INFO - Running main action method: download_and_extract 08:17:54 INFO - mkdir: /builds/slave/test/build/tests 08:17: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:17:54 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:17:54 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:17:54 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:17:54 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:17:54 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:17:55 INFO - Downloaded 1361 bytes. 08:17:55 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 08:17:55 INFO - Using the following test package requirements: 08:17:55 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 08:17:55 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 08:17:55 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 08:17:55 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 08:17:55 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 08:17:55 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 08:17:55 INFO - u'jsshell-linux-x86_64.zip'], 08:17:55 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 08:17:55 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 08:17:55 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 08:17:55 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 08:17:55 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 08:17:55 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 08:17:55 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 08:17:55 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 08:17:55 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 08:17:55 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 08:17:55 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 08:17:55 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:17:55 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:17:55 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:17:55 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:17:55 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:17:55 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:17:55 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:17:56 INFO - Downloaded 24135385 bytes. 08:17:56 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:17:56 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:17:57 INFO - Return code: 0 08:17:57 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:17:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:17:57 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:17:57 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:17:57 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:17:57 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:17:57 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:17:58 INFO - Downloaded 24135385 bytes. 08:17:58 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:17:58 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:18:00 INFO - Return code: 0 08:18:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:18:00 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:18:00 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:18:00 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:18:00 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:18:00 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:18:01 INFO - Downloaded 10840145 bytes. 08:18:01 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:18:01 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:18:01 INFO - Return code: 0 08:18: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:18:01 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:18:01 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:18:01 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:18:01 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:18:01 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:18:03 INFO - Downloaded 62736116 bytes. 08:18:03 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:18:03 INFO - mkdir: /builds/slave/test/properties 08:18:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:18:03 INFO - Writing to file /builds/slave/test/properties/build_url 08:18:03 INFO - Contents: 08:18:03 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:18:03 INFO - Running post-action listener: _resource_record_post_action 08:18:03 INFO - Running post-action listener: set_extra_try_arguments 08:18:03 INFO - ##### 08:18:03 INFO - ##### Running populate-webroot step. 08:18:03 INFO - ##### 08:18:03 INFO - Running pre-action listener: _resource_record_pre_action 08:18:03 INFO - Running main action method: populate_webroot 08:18:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:18:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:18:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:18:03 INFO - '--tppagecycles', 08:18:03 INFO - '7'], 08:18:03 INFO - 'tests': ['tsvgm']}}, 08:18:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:18:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:18:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:18:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:18:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:18:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:18:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:18:03 INFO - 'talos_options': ['--disable-e10s'], 08:18:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:18:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:18:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:18:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:18:03 INFO - 'talos_options': ['--disable-e10s'], 08:18:03 INFO - 'tests': ['damp', 'tps']}, 08:18:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:18:03 INFO - 'tests': ['damp', 'tps']}, 08:18:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:18:03 INFO - 'tests': ['dromaeo_dom']}, 08:18:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:18:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:18:03 INFO - 'tests': ['a11yr', 08:18:03 INFO - 'ts_paint', 08:18:03 INFO - 'tpaint', 08:18:03 INFO - 'sessionrestore', 08:18:03 INFO - 'sessionrestore_no_auto_restore', 08:18:03 INFO - 'tabpaint']}, 08:18:03 INFO - 'other-e10s': {'tests': ['a11yr', 08:18:03 INFO - 'ts_paint', 08:18:03 INFO - 'tpaint', 08:18:03 INFO - 'sessionrestore', 08:18:03 INFO - 'sessionrestore_no_auto_restore', 08:18:03 INFO - 'tabpaint']}, 08:18:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:18:03 INFO - 'ts_paint', 08:18:03 INFO - 'tpaint', 08:18:03 INFO - 'sessionrestore', 08:18:03 INFO - 'sessionrestore_no_auto_restore', 08:18:03 INFO - 'tabpaint']}, 08:18:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:18:03 INFO - 'ts_paint', 08:18:03 INFO - 'tpaint', 08:18:03 INFO - 'sessionrestore', 08:18:03 INFO - 'sessionrestore_no_auto_restore', 08:18:03 INFO - 'tabpaint']}, 08:18:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:18:03 INFO - 'tests': ['a11yr', 08:18:03 INFO - 'ts_paint', 08:18:03 INFO - 'tpaint', 08:18:03 INFO - 'sessionrestore', 08:18:03 INFO - 'sessionrestore_no_auto_restore', 08:18:03 INFO - 'tabpaint']}, 08:18:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:18:03 INFO - 'tests': ['a11yr', 08:18:03 INFO - 'ts_paint', 08:18:03 INFO - 'tpaint', 08:18:03 INFO - 'sessionrestore', 08:18:03 INFO - 'sessionrestore_no_auto_restore', 08:18:03 INFO - 'tabpaint']}, 08:18:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:18:03 INFO - 'tests': ['tsvgx', 08:18:03 INFO - 'tsvgr_opacity', 08:18:03 INFO - 'tart', 08:18:03 INFO - 'tscrollx', 08:18:03 INFO - 'cart']}, 08:18:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:18:03 INFO - 'tsvgr_opacity', 08:18:03 INFO - 'tart', 08:18:03 INFO - 'tscrollx', 08:18:03 INFO - 'cart']}, 08:18:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:18:03 INFO - 'talos_options': ['--disable-e10s'], 08:18:03 INFO - 'tests': ['tp5o']}, 08:18:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:18:03 INFO - 'tests': ['tp5o']}, 08:18:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:18:03 INFO - 'talos_options': ['--disable-e10s', 08:18:03 INFO - '--xperf_path', 08:18:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:18:03 INFO - 'tests': ['tp5n']}, 08:18:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:18:03 INFO - 'talos_options': ['--xperf_path', 08:18:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:18:03 INFO - 'tests': ['tp5n']}}, 08:18:03 INFO - 'talos.zip': {'path': '', 08:18:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:18:03 INFO - Running post-action listener: _resource_record_post_action 08:18:03 INFO - ##### 08:18:03 INFO - ##### Running create-virtualenv step. 08:18:03 INFO - ##### 08:18:03 INFO - Running pre-action listener: _resource_record_pre_action 08:18:03 INFO - Running main action method: create_virtualenv 08:18:03 INFO - Creating virtualenv /builds/slave/test/build/venv 08:18:03 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:18:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:18:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:18:04 INFO - Using real prefix '/usr' 08:18:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:18:04 INFO - Installing distribute.............................................................................................................................................................................................done. 08:18:06 INFO - Installing pip.................done. 08:18:06 INFO - Return code: 0 08:18:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:18:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:18:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:06 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 0x7f714993bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f675a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff6410>, '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 0x1ff7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff77a0>, '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': 'db0483c52d987ecb441a263b000001ad-1464621471.910958-297576215', '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:18:06 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:18:06 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:18:06 INFO - Using env: {'DISPLAY': ':0', 08:18:06 INFO - 'HOME': '/home/cltbld', 08:18:06 INFO - 'LANG': 'en_US.UTF-8', 08:18:06 INFO - 'LANGUAGE': 'en_US:en', 08:18:06 INFO - 'LOGNAME': 'cltbld', 08:18:06 INFO - 'MAIL': '/var/mail/cltbld', 08:18:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:06 INFO - 'MOZ_NO_REMOTE': '1', 08:18:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:06 INFO - 'NO_EM_RESTART': '1', 08:18:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:06 INFO - 'PWD': '/builds/slave/test', 08:18:06 INFO - 'SHELL': '/bin/bash', 08:18:06 INFO - 'SHLVL': '1', 08:18:06 INFO - 'TERM': 'linux', 08:18:06 INFO - 'TMOUT': '86400', 08:18:06 INFO - 'USER': 'cltbld', 08:18:06 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464621471.910958-297576215', 08:18:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:06 INFO - '_': '/tools/buildbot/bin/python'} 08:18:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:06 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:18:06 INFO - Cleaning up... 08:18:06 INFO - Return code: 0 08:18:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:18:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:18:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:06 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 0x7f714993bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f675a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff6410>, '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 0x1ff7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff77a0>, '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': 'db0483c52d987ecb441a263b000001ad-1464621471.910958-297576215', '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:18:06 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:18:06 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:18:06 INFO - Using env: {'DISPLAY': ':0', 08:18:06 INFO - 'HOME': '/home/cltbld', 08:18:06 INFO - 'LANG': 'en_US.UTF-8', 08:18:06 INFO - 'LANGUAGE': 'en_US:en', 08:18:06 INFO - 'LOGNAME': 'cltbld', 08:18:06 INFO - 'MAIL': '/var/mail/cltbld', 08:18:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:06 INFO - 'MOZ_NO_REMOTE': '1', 08:18:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:06 INFO - 'NO_EM_RESTART': '1', 08:18:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:06 INFO - 'PWD': '/builds/slave/test', 08:18:06 INFO - 'SHELL': '/bin/bash', 08:18:06 INFO - 'SHLVL': '1', 08:18:06 INFO - 'TERM': 'linux', 08:18:06 INFO - 'TMOUT': '86400', 08:18:06 INFO - 'USER': 'cltbld', 08:18:06 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464621471.910958-297576215', 08:18:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:06 INFO - '_': '/tools/buildbot/bin/python'} 08:18:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:06 INFO - Downloading/unpacking psutil>=0.7.1 08:18:06 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:18:06 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:18:06 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:18:06 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:18:06 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:18:06 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:18:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:18:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:18:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:18:08 INFO - Installing collected packages: psutil 08:18:08 INFO - Running setup.py install for psutil 08:18:09 INFO - building 'psutil._psutil_linux' extension 08:18:09 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:18:09 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:18:09 INFO - building 'psutil._psutil_posix' extension 08:18:09 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:18:09 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:18:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:18:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:18:09 INFO - Successfully installed psutil 08:18:09 INFO - Cleaning up... 08:18:09 INFO - Return code: 0 08:18:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:18:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:18:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f714993bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f675a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff6410>, '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 0x1ff7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff77a0>, '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': 'db0483c52d987ecb441a263b000001ad-1464621471.910958-297576215', '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:18:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:18:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:18:09 INFO - Using env: {'DISPLAY': ':0', 08:18:09 INFO - 'HOME': '/home/cltbld', 08:18:09 INFO - 'LANG': 'en_US.UTF-8', 08:18:09 INFO - 'LANGUAGE': 'en_US:en', 08:18:09 INFO - 'LOGNAME': 'cltbld', 08:18:09 INFO - 'MAIL': '/var/mail/cltbld', 08:18:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:09 INFO - 'MOZ_NO_REMOTE': '1', 08:18:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:09 INFO - 'NO_EM_RESTART': '1', 08:18:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:09 INFO - 'PWD': '/builds/slave/test', 08:18:09 INFO - 'SHELL': '/bin/bash', 08:18:09 INFO - 'SHLVL': '1', 08:18:09 INFO - 'TERM': 'linux', 08:18:09 INFO - 'TMOUT': '86400', 08:18:09 INFO - 'USER': 'cltbld', 08:18:09 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464621471.910958-297576215', 08:18:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:09 INFO - '_': '/tools/buildbot/bin/python'} 08:18:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:18:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:18:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:18:11 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:18:11 INFO - Installing collected packages: mozsystemmonitor 08:18:11 INFO - Running setup.py install for mozsystemmonitor 08:18:11 INFO - Successfully installed mozsystemmonitor 08:18:11 INFO - Cleaning up... 08:18:11 INFO - Return code: 0 08:18:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:18:11 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:18:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:11 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:18:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:11 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 0x7f714993bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f675a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff6410>, '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 0x1ff7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff77a0>, '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': 'db0483c52d987ecb441a263b000001ad-1464621471.910958-297576215', '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:18:11 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:18:11 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:18:11 INFO - Using env: {'DISPLAY': ':0', 08:18:11 INFO - 'HOME': '/home/cltbld', 08:18:11 INFO - 'LANG': 'en_US.UTF-8', 08:18:11 INFO - 'LANGUAGE': 'en_US:en', 08:18:11 INFO - 'LOGNAME': 'cltbld', 08:18:11 INFO - 'MAIL': '/var/mail/cltbld', 08:18:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:11 INFO - 'MOZ_NO_REMOTE': '1', 08:18:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:11 INFO - 'NO_EM_RESTART': '1', 08:18:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:11 INFO - 'PWD': '/builds/slave/test', 08:18:11 INFO - 'SHELL': '/bin/bash', 08:18:11 INFO - 'SHLVL': '1', 08:18:11 INFO - 'TERM': 'linux', 08:18:11 INFO - 'TMOUT': '86400', 08:18:11 INFO - 'USER': 'cltbld', 08:18:11 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464621471.910958-297576215', 08:18:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:11 INFO - '_': '/tools/buildbot/bin/python'} 08:18:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:12 INFO - Downloading/unpacking blobuploader==1.2.4 08:18:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:18:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:18:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:13 INFO - Downloading blobuploader-1.2.4.tar.gz 08:18:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:18:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:18:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:18:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:18:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:18:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:18:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:18:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:18:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:14 INFO - Downloading docopt-0.6.1.tar.gz 08:18:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:18:14 INFO - Installing collected packages: blobuploader, requests, docopt 08:18:14 INFO - Running setup.py install for blobuploader 08:18:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:18:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:18:14 INFO - Running setup.py install for requests 08:18:15 INFO - Running setup.py install for docopt 08:18:15 INFO - Successfully installed blobuploader requests docopt 08:18:15 INFO - Cleaning up... 08:18:15 INFO - Return code: 0 08:18:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:18:15 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:18:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:15 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:18:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:15 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 0x7f714993bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f675a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff6410>, '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 0x1ff7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff77a0>, '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': 'db0483c52d987ecb441a263b000001ad-1464621471.910958-297576215', '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:18:15 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:18:15 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:18:15 INFO - Using env: {'DISPLAY': ':0', 08:18:15 INFO - 'HOME': '/home/cltbld', 08:18:15 INFO - 'LANG': 'en_US.UTF-8', 08:18:15 INFO - 'LANGUAGE': 'en_US:en', 08:18:15 INFO - 'LOGNAME': 'cltbld', 08:18:15 INFO - 'MAIL': '/var/mail/cltbld', 08:18:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:15 INFO - 'MOZ_NO_REMOTE': '1', 08:18:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:15 INFO - 'NO_EM_RESTART': '1', 08:18:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:15 INFO - 'PWD': '/builds/slave/test', 08:18:15 INFO - 'SHELL': '/bin/bash', 08:18:15 INFO - 'SHLVL': '1', 08:18:15 INFO - 'TERM': 'linux', 08:18:15 INFO - 'TMOUT': '86400', 08:18:15 INFO - 'USER': 'cltbld', 08:18:15 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464621471.910958-297576215', 08:18:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:15 INFO - '_': '/tools/buildbot/bin/python'} 08:18:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:18:15 INFO - Running setup.py (path:/tmp/pip-iLfW6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:18:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:18:15 INFO - Running setup.py (path:/tmp/pip-VtnbCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:18:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:18:15 INFO - Running setup.py (path:/tmp/pip-Ft2lfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:18:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:18:15 INFO - Running setup.py (path:/tmp/pip-8EpO47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:18:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:18:15 INFO - Running setup.py (path:/tmp/pip-8DsJbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:18:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:18:15 INFO - Running setup.py (path:/tmp/pip-uhp1Bo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:18:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:18:15 INFO - Running setup.py (path:/tmp/pip-wq6i4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:18:16 INFO - Running setup.py (path:/tmp/pip-3a64ET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:18:16 INFO - Running setup.py (path:/tmp/pip-ej6s70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:18:16 INFO - Running setup.py (path:/tmp/pip-wLomBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:18:16 INFO - Running setup.py (path:/tmp/pip-V9ks4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:18:16 INFO - Running setup.py (path:/tmp/pip-kjASfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:18:16 INFO - Running setup.py (path:/tmp/pip-x08KDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:18:16 INFO - Running setup.py (path:/tmp/pip-xTN3TP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:18:16 INFO - Running setup.py (path:/tmp/pip-9OQYn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:18:16 INFO - Running setup.py (path:/tmp/pip-65Gkgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:18:16 INFO - Running setup.py (path:/tmp/pip-_pSTbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:18:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:18:16 INFO - Running setup.py install for manifestparser 08:18:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:18:16 INFO - Running setup.py install for mozcrash 08:18:16 INFO - Running setup.py install for mozdebug 08:18:17 INFO - Running setup.py install for mozdevice 08:18:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:18:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:18:17 INFO - Running setup.py install for mozfile 08:18:17 INFO - Running setup.py install for mozhttpd 08:18:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:18:17 INFO - Running setup.py install for mozinfo 08:18:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:18:17 INFO - Running setup.py install for mozInstall 08:18:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:18:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:18:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:18:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:18:17 INFO - Running setup.py install for mozleak 08:18:17 INFO - Running setup.py install for mozlog 08:18:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:18:17 INFO - Running setup.py install for moznetwork 08:18:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:18:17 INFO - Running setup.py install for mozprocess 08:18:18 INFO - Running setup.py install for mozprofile 08:18:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:18:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:18:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:18:18 INFO - Running setup.py install for mozrunner 08:18:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:18:18 INFO - Running setup.py install for mozscreenshot 08:18:18 INFO - Running setup.py install for moztest 08:18:18 INFO - Running setup.py install for mozversion 08:18:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:18:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:18:18 INFO - Cleaning up... 08:18:18 INFO - Return code: 0 08:18:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:18:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:18:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:18 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 0x7f714993bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f675a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff6410>, '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 0x1ff7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff77a0>, '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': 'db0483c52d987ecb441a263b000001ad-1464621471.910958-297576215', '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:18:18 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:18:18 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:18:18 INFO - Using env: {'DISPLAY': ':0', 08:18:18 INFO - 'HOME': '/home/cltbld', 08:18:18 INFO - 'LANG': 'en_US.UTF-8', 08:18:18 INFO - 'LANGUAGE': 'en_US:en', 08:18:18 INFO - 'LOGNAME': 'cltbld', 08:18:18 INFO - 'MAIL': '/var/mail/cltbld', 08:18:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:18 INFO - 'MOZ_NO_REMOTE': '1', 08:18:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:18 INFO - 'NO_EM_RESTART': '1', 08:18:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:18 INFO - 'PWD': '/builds/slave/test', 08:18:18 INFO - 'SHELL': '/bin/bash', 08:18:18 INFO - 'SHLVL': '1', 08:18:18 INFO - 'TERM': 'linux', 08:18:18 INFO - 'TMOUT': '86400', 08:18:18 INFO - 'USER': 'cltbld', 08:18:18 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464621471.910958-297576215', 08:18:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:18 INFO - '_': '/tools/buildbot/bin/python'} 08:18:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:18:18 INFO - Running setup.py (path:/tmp/pip-GSBXbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:18:18 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:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:18:18 INFO - Running setup.py (path:/tmp/pip-5NirqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:18:18 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:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:18:18 INFO - Running setup.py (path:/tmp/pip-cJGY5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:18:19 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:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:18:19 INFO - Running setup.py (path:/tmp/pip-Wszyym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:18:19 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:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:18:19 INFO - Running setup.py (path:/tmp/pip-KKTr0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:18:19 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:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:18:19 INFO - Running setup.py (path:/tmp/pip-YjwN77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:18:19 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:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:18:19 INFO - Running setup.py (path:/tmp/pip-6ApW82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:18:19 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:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:18:19 INFO - Running setup.py (path:/tmp/pip-ICLNYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:18:19 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:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:18:19 INFO - Running setup.py (path:/tmp/pip-4oQdLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:18:19 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:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:18:19 INFO - Running setup.py (path:/tmp/pip-XBWbXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:18:19 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:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:18:19 INFO - Running setup.py (path:/tmp/pip-c1fZ3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:18:19 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:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:18:19 INFO - Running setup.py (path:/tmp/pip-Kstw3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:18:19 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:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:18:19 INFO - Running setup.py (path:/tmp/pip-quM1KE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:18:19 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:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:18:19 INFO - Running setup.py (path:/tmp/pip-TVSGOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:18:19 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:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:18:19 INFO - Running setup.py (path:/tmp/pip-A4rLgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:18:19 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:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:18:19 INFO - Running setup.py (path:/tmp/pip-I7PWzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:18:19 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:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:18:19 INFO - Running setup.py (path:/tmp/pip-4YHi72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:18:20 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:18:20 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:18:20 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:18:20 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:18:20 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:18:20 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:18:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:18:20 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:18:20 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:18:20 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:18:20 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:18:20 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:18:20 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:18:21 INFO - Downloading blessings-1.6.tar.gz 08:18:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:18:22 INFO - Installing collected packages: blessings 08:18:22 INFO - Running setup.py install for blessings 08:18:22 INFO - Successfully installed blessings 08:18:22 INFO - Cleaning up... 08:18:22 INFO - Return code: 0 08:18:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:18:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:18:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:18:22 INFO - Reading from file tmpfile_stdout 08:18:22 INFO - Current package versions: 08:18:22 INFO - argparse == 1.2.1 08:18:22 INFO - blessings == 1.6 08:18:22 INFO - blobuploader == 1.2.4 08:18:22 INFO - docopt == 0.6.1 08:18:22 INFO - manifestparser == 1.1 08:18:22 INFO - mozInstall == 1.12 08:18:22 INFO - mozcrash == 0.17 08:18:22 INFO - mozdebug == 0.1 08:18:22 INFO - mozdevice == 0.48 08:18:22 INFO - mozfile == 1.2 08:18:22 INFO - mozhttpd == 0.7 08:18:22 INFO - mozinfo == 0.9 08:18:22 INFO - mozleak == 0.1 08:18:22 INFO - mozlog == 3.1 08:18:22 INFO - moznetwork == 0.27 08:18:22 INFO - mozprocess == 0.22 08:18:22 INFO - mozprofile == 0.28 08:18:22 INFO - mozrunner == 6.11 08:18:22 INFO - mozscreenshot == 0.1 08:18:22 INFO - mozsystemmonitor == 0.0 08:18:22 INFO - moztest == 0.7 08:18:22 INFO - mozversion == 1.4 08:18:22 INFO - psutil == 3.1.1 08:18:22 INFO - requests == 1.2.3 08:18:22 INFO - wsgiref == 0.1.2 08:18:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:18:22 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:18:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:22 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:18:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:22 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 0x7f714993bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f675a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff6410>, '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 0x1ff7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff77a0>, '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': 'db0483c52d987ecb441a263b000001ad-1464621471.910958-297576215', '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:18:22 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:18:22 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:18:22 INFO - Using env: {'DISPLAY': ':0', 08:18:22 INFO - 'HOME': '/home/cltbld', 08:18:22 INFO - 'LANG': 'en_US.UTF-8', 08:18:22 INFO - 'LANGUAGE': 'en_US:en', 08:18:22 INFO - 'LOGNAME': 'cltbld', 08:18:22 INFO - 'MAIL': '/var/mail/cltbld', 08:18:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:22 INFO - 'MOZ_NO_REMOTE': '1', 08:18:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:22 INFO - 'NO_EM_RESTART': '1', 08:18:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:22 INFO - 'PWD': '/builds/slave/test', 08:18:22 INFO - 'SHELL': '/bin/bash', 08:18:22 INFO - 'SHLVL': '1', 08:18:22 INFO - 'TERM': 'linux', 08:18:22 INFO - 'TMOUT': '86400', 08:18:22 INFO - 'USER': 'cltbld', 08:18:22 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464621471.910958-297576215', 08:18:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:22 INFO - '_': '/tools/buildbot/bin/python'} 08:18:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:22 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:18:22 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:18:22 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:18:22 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:18:22 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:18:22 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:18:22 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:18:22 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:18:22 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:18:22 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:18:22 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:18:22 INFO - Cleaning up... 08:18:22 INFO - Return code: 0 08:18:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:18:22 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:18:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:22 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:18:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:22 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 0x7f714993bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f675a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff6410>, '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 0x1ff7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff77a0>, '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': 'db0483c52d987ecb441a263b000001ad-1464621471.910958-297576215', '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:18:22 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:18:22 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:18:22 INFO - Using env: {'DISPLAY': ':0', 08:18:22 INFO - 'HOME': '/home/cltbld', 08:18:22 INFO - 'LANG': 'en_US.UTF-8', 08:18:22 INFO - 'LANGUAGE': 'en_US:en', 08:18:22 INFO - 'LOGNAME': 'cltbld', 08:18:22 INFO - 'MAIL': '/var/mail/cltbld', 08:18:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:22 INFO - 'MOZ_NO_REMOTE': '1', 08:18:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:22 INFO - 'NO_EM_RESTART': '1', 08:18:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:22 INFO - 'PWD': '/builds/slave/test', 08:18:22 INFO - 'SHELL': '/bin/bash', 08:18:22 INFO - 'SHLVL': '1', 08:18:22 INFO - 'TERM': 'linux', 08:18:22 INFO - 'TMOUT': '86400', 08:18:22 INFO - 'USER': 'cltbld', 08:18:22 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464621471.910958-297576215', 08:18:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:22 INFO - '_': '/tools/buildbot/bin/python'} 08:18:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:22 INFO - Downloading/unpacking jsonschema 08:18:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:18:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:18:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:18:24 INFO - Downloading/unpacking functools32 (from jsonschema) 08:18:24 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:18:24 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:18:24 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:18:24 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:18:24 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:18:24 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:18:24 INFO - Downloading functools32-3.2.3-2.tar.gz 08:18:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:18:25 INFO - warning: no files found matching '*.txt' 08:18:25 INFO - no previously-included directories found matching 'build' 08:18:25 INFO - no previously-included directories found matching 'dist' 08:18:25 INFO - no previously-included directories found matching '.git*' 08:18:25 INFO - Installing collected packages: jsonschema, functools32 08:18:25 INFO - Running setup.py install for functools32 08:18:25 INFO - warning: no files found matching '*.txt' 08:18:25 INFO - no previously-included directories found matching 'build' 08:18:25 INFO - no previously-included directories found matching 'dist' 08:18:25 INFO - no previously-included directories found matching '.git*' 08:18:25 INFO - Successfully installed jsonschema functools32 08:18:25 INFO - Cleaning up... 08:18:25 INFO - Return code: 0 08:18:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:18:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:18:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f714993bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f675a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff6410>, '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 0x1ff7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff77a0>, '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': 'db0483c52d987ecb441a263b000001ad-1464621471.910958-297576215', '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:18:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:18:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:18:25 INFO - Using env: {'DISPLAY': ':0', 08:18:25 INFO - 'HOME': '/home/cltbld', 08:18:25 INFO - 'LANG': 'en_US.UTF-8', 08:18:25 INFO - 'LANGUAGE': 'en_US:en', 08:18:25 INFO - 'LOGNAME': 'cltbld', 08:18:25 INFO - 'MAIL': '/var/mail/cltbld', 08:18:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:25 INFO - 'MOZ_NO_REMOTE': '1', 08:18:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:25 INFO - 'NO_EM_RESTART': '1', 08:18:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:25 INFO - 'PWD': '/builds/slave/test', 08:18:25 INFO - 'SHELL': '/bin/bash', 08:18:25 INFO - 'SHLVL': '1', 08:18:25 INFO - 'TERM': 'linux', 08:18:25 INFO - 'TMOUT': '86400', 08:18:25 INFO - 'USER': 'cltbld', 08:18:25 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464621471.910958-297576215', 08:18:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:25 INFO - '_': '/tools/buildbot/bin/python'} 08:18:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:25 INFO - Downloading/unpacking flake8 08:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:18:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:18:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:18:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:18:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:18:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:18:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:18:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:18:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:18:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:18:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:18:28 INFO - no previously-included directories found matching 'docs/_build' 08:18:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:18:28 INFO - Running setup.py install for pep8 08:18:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:18:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:18:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:18:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:18:28 INFO - no previously-included directories found matching 'docs/_build' 08:18:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:18:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:18:28 INFO - Cleaning up... 08:18:28 INFO - Return code: 0 08:18:28 INFO - Running post-action listener: _resource_record_post_action 08:18:28 INFO - Running post-action listener: _start_resource_monitoring 08:18:28 INFO - Starting resource monitoring. 08:18:28 INFO - ##### 08:18:28 INFO - ##### Running install step. 08:18:28 INFO - ##### 08:18:28 INFO - Running pre-action listener: _resource_record_pre_action 08:18:28 INFO - Running main action method: install 08:18:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:18:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:18:28 INFO - Reading from file tmpfile_stdout 08:18:28 INFO - Detecting whether we're running mozinstall >=1.0... 08:18:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:18:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:18:28 INFO - Reading from file tmpfile_stdout 08:18:28 INFO - Output received: 08:18:28 INFO - Usage: mozinstall [options] installer 08:18:28 INFO - Options: 08:18:28 INFO - -h, --help show this help message and exit 08:18:28 INFO - -d DEST, --destination=DEST 08:18:28 INFO - Directory to install application into. [default: 08:18:28 INFO - "/builds/slave/test"] 08:18:28 INFO - --app=APP Application being installed. [default: firefox] 08:18:28 INFO - mkdir: /builds/slave/test/build/application 08:18:28 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:18:28 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:18:44 INFO - Reading from file tmpfile_stdout 08:18:44 INFO - Output received: 08:18:44 INFO - /builds/slave/test/build/application/firefox/firefox 08:18:44 INFO - Running post-action listener: _resource_record_post_action 08:18:44 INFO - ##### 08:18:44 INFO - ##### Running run-tests step. 08:18:44 INFO - ##### 08:18:44 INFO - Running pre-action listener: _resource_record_pre_action 08:18:44 INFO - Running main action method: run_tests 08:18:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:18:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:18:44 INFO - Python 2.7.3 08:18:44 INFO - Return code: 0 08:18:44 INFO - grabbing minidump binary from tooltool 08:18: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:18:44 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 0x1ff6410>, '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 0x1ff7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff77a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:18:44 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:18:44 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:18:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:18:44 INFO - Return code: 0 08:18:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:18:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:18:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:18:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:18:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:18:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:18:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:18:45 INFO - Return code: 0 08:18:45 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-e10s', '--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-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:18:45 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-e10s --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-031 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:18:45 INFO - Using env: {'DISPLAY': ':0', 08:18:45 INFO - 'HOME': '/home/cltbld', 08:18:45 INFO - 'LANG': 'en_US.UTF-8', 08:18:45 INFO - 'LANGUAGE': 'en_US:en', 08:18:45 INFO - 'LOGNAME': 'cltbld', 08:18:45 INFO - 'MAIL': '/var/mail/cltbld', 08:18:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:18:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:18:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:45 INFO - 'MOZ_NO_REMOTE': '1', 08:18:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:18:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:45 INFO - 'NO_EM_RESTART': '1', 08:18:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:45 INFO - 'PWD': '/builds/slave/test', 08:18:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:18:45 INFO - 'SHELL': '/bin/bash', 08:18:45 INFO - 'SHLVL': '1', 08:18:45 INFO - 'TERM': 'linux', 08:18:45 INFO - 'TMOUT': '86400', 08:18:45 INFO - 'USER': 'cltbld', 08:18:45 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464621471.910958-297576215', 08:18:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:45 INFO - '_': '/tools/buildbot/bin/python'} 08:18:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--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-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:18:45 INFO - mozversion application_buildid: 20160530035543 08:18:45 INFO - mozversion application_changeset: 04934785596476f6dd8baccc355202aeba59af35 08:18:45 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:18:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:18:45 INFO - mozversion application_name: Firefox 08:18:45 INFO - mozversion application_remotingname: firefox-dev 08:18:45 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:18:45 INFO - mozversion application_vendor: Mozilla 08:18:45 INFO - mozversion application_version: 48.0a2 08:18:45 INFO - mozversion platform_buildid: 20160530035543 08:18:45 INFO - mozversion platform_changeset: 04934785596476f6dd8baccc355202aeba59af35 08:18:45 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:18:45 INFO - mozversion platform_version: 48.0a2 08:18:45 INFO - using testdate: 1464621525 08:18:45 INFO - actual date: 1464621525 08:18:45 INFO - starting webserver on 'localhost:50642' 08:18:45 INFO - SUITE-START | Running 2 tests 08:18:45 INFO - TEST-START | dromaeo_css 08:18:45 INFO - operating with platform_type : linux_ 08:18:45 INFO - Initialising browser for dromaeo_css test... 08:18:45 INFO - TEST-INFO | started process 7800 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqInBQA/profile http://localhost:50642/getInfo.html) 08:18:49 INFO - PROCESS | 7800 | 08:18:49 INFO - PROCESS | 7800 | (process:7881): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:18:49 INFO - PROCESS | 7800 | __metrics Screen width/height:1600/1200 08:18:49 INFO - PROCESS | 7800 | colorDepth:24 08:18:49 INFO - PROCESS | 7800 | Browser inner width/height: 1024/697 08:18:49 INFO - PROCESS | 7800 | __metrics 08:18:50 ERROR - PROCESS | 7800 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 08:18:51 INFO - TEST-INFO | 7800: exit 0 08:18:51 INFO - Browser initialized. 08:18:51 INFO - Running cycle 1/1 for dromaeo_css test... 08:18:51 INFO - TEST-INFO | started process 7932 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqInBQA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:18:53 INFO - PROCESS | 7932 | 08:18:53 INFO - PROCESS | 7932 | (process:8002): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:19:03 INFO - PROCESS | 7932 | RSS: Main: 151945216 08:19:03 INFO - PROCESS | 7932 | 08:19:52 INFO - PROCESS | 7932 | 1464621592806 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:22:00 INFO - PROCESS | 7932 | Cycle 1(1): loaded http://localhost:50642/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50642/tests/dromaeo/cssquery-ext.html) 08:22:01 INFO - PROCESS | 7932 | RSS: Main: 155443200 08:22:01 INFO - PROCESS | 7932 | 08:25:03 INFO - PROCESS | 7932 | Cycle 1(1): loaded http://localhost:50642/tests/dromaeo/cssquery-ext.html (next: http://localhost:50642/tests/dromaeo/cssquery-jquery.html) 08:25:03 INFO - PROCESS | 7932 | RSS: Main: 153313280 08:25:03 INFO - PROCESS | 7932 | 08:28:05 INFO - PROCESS | 7932 | Cycle 1(1): loaded http://localhost:50642/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50642/tests/dromaeo/cssquery-mootools.html) 08:28:06 INFO - PROCESS | 7932 | RSS: Main: 152637440 08:28:06 INFO - PROCESS | 7932 | 08:31:07 INFO - PROCESS | 7932 | Cycle 1(1): loaded http://localhost:50642/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50642/tests/dromaeo/cssquery-prototype.html) 08:31:08 INFO - PROCESS | 7932 | RSS: Main: 153034752 08:31:08 INFO - PROCESS | 7932 | 08:34:10 INFO - PROCESS | 7932 | Cycle 1(1): loaded http://localhost:50642/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50642/tests/dromaeo/cssquery-yui.html) 08:34:11 INFO - PROCESS | 7932 | RSS: Main: 154476544 08:34:11 INFO - PROCESS | 7932 | 08:37:13 INFO - PROCESS | 7932 | Cycle 1(1): loaded http://localhost:50642/tests/dromaeo/cssquery-yui.html (next: http://localhost:50642/tests/dromaeo/cssquery-dojo.html) 08:37:13 INFO - PROCESS | 7932 | RSS: Main: 155774976 08:37:13 INFO - PROCESS | 7932 | 08:37:13 INFO - PROCESS | 7932 | __start_tp_report 08:37:13 INFO - PROCESS | 7932 | _x_x_mozilla_page_load 08:37:13 INFO - PROCESS | 7932 | _x_x_mozilla_page_load_details 08:37:13 INFO - PROCESS | 7932 | |i|pagename|runs| 08:37:13 INFO - PROCESS | 7932 | |0;dojo.html;3360.9831950840244;3414.385410626088;3418.52140700302;3435.2442462658205;3462.1171601241695;5664.291963504562;5672.773089076432;5674.829755107348;5684.488396044355;5713.885722285562;5637.577181711367;5722.427757224275;5730.283714535683;5736.053551164064;5765.682887441189;5184.792608295664;5221.71280579568;5254.159334506479;5280.996610643965;5297.178937264711;5043.218301163325;5154.819581314655;5176.456472070435;5391.81128660497;5410.675359478424;5202.297689811884;5203.739813009353;5255.08036093682;5325.680459172462;5336.332958380202;5258.053550360953;5266;5266.104762190437;5267.183586544092;5273.709945952971;5113.948860511385;5158.7420628968775;5245.6852588844795;5247;5270.262163297103;5446.7276636168035;5534.4742249486235;5577.944220557783;5589.413111623302;5607.074832652607;5879.206307148523;5892.086726557391;5914.2015827863115;5916.852078698024;5924.200232968537;5891.3814049525035;5915.615484993462;5925.703714814242;5936.821895343103;5951.3751056139345;5603.551715862721;5698.1452782083015;5726.427357264281;5746.885062298772;5757.309122905236;6207.689615519296;6219.502439804804;6220.626762394271;6232.439080482688;6234.127222188898;5973.074173503114;5988.461038506555;5999.670018148957;6010;6066.696665166724;6113.537117903944;6150.569460137747;6152.077188421683;6158.04550294705;6160.784372546939;6065.302490213682;6081.401205906835;6104.542159338067;6120.265568131853;6123.6019658722935;5906.675132867647;6079.088136779518;6114.996965385453;6123.295820980555;6127.097902969301;4536.274196128604;4541.296099104644;4545.454545454567;4575.313702944519;4592.265237561974;4106.260873042881;4107.199096176217;4112.897177570585;4123.567025462343;4157.334826427757;5803.7968671096305;5856.063029915278;5861.062230043172;5873.030949893306;5891.675957822275;5941.613795103391;6106;6127.785527506605;6148;6172.444479996821;5672.319321681342;5873.20711703923;5879.970600147058;5884.588078834526;5886.676232807151;5049.141645920203;5085.898282034339;5096.311997880239;5107.259447380184;5131.97434012835;6277.18396608438;6300.684965751694;6311.526635502356;6322.589031712924;6333.746650134035;5944.048952167633;6090.299615544269;6162.722677479434;6168.19813424252;6173.043178307369;6250.4374606285655;6308.842278943063;6313.779017734358;6318.652474113968;6327.303996560283;6003.489703375262;6023.1266466363;6026.337102918587;6037.45662890342;6060.151578778887;5807.0998995155815;6062.42406971337;6129.478994285358;6143.754249829957;6157.53818463626;5948.315943666534;5952.76188952437;5966.105084237399;5969.015112506388;5988.401159883977;5901.970490147522;5921.467067963904;5936.614120082181;5937.109433584997;5938.2280303560265;5631.88736225265;5758.856028599319;5787.9131813021995;5819.5053420459735;5871.442212989759;5874.647521148745;5893.557983151367;5895.9115613266695;5926.851828704317;5934;5764.452377024176;5775.33583637887;5789.044807606866;5791.160281759206;5794.652320860761 08:37:13 INFO - PROCESS | 7932 | |1;ext.html;612.1338306296587;661.5666738286421;665.6671664167916;672.9764458243959;673.5823789250666;38187.80906095469;39042.4143637845;39069.21861562767;39145.80427097864;39301.41047884277;42176.78911605445;42747.57252427475;42890;42898;43028.354574681405;8801.867971980426;8924.776880577972;8938.329625278131;8947.955260223689;8970.461772293651;8685.392022558424;8787.384883058188;8831.514266715329;9020.368574199809;9035;9074.047225041375;9111.72664820053;9144;9148;9158.72523824283;8958.37291389603;8976.147266009719;8987.281017518615;9029.909700903037;9037;8931.240844528224;9028.232600228988;9040.954795226047;9042.909570904272;9045.276377889819;42727.35908961368;42856.78571607153;42893.571064289266;43103.137937241394;43149.35275970863;3805.7335986480957;3864.4589757433982;3882.8058597070035;3887.4168874668744;4232.259354612961;33114.50328245078;33313.16717082068;33342.83328583342;34949.47575786365;35412.64587354145;4379.343098535245;4394.252976993918;4407.581279778416;4471.843485478025;4525.140223357585;308176;309957;310944;312169;312675;38869.22261554753;39689.60310396859;60661.69669151626;61068;61086.389136108955;37220.81389593035;37430.25139497195;37585.81207093947;37645.62354376421;37650.81174594109;17664.91167544154;17942.820571794375;17947.102644867704;17978.37075702344;17984.460466186036;15197.088174709554;15279.236038198045;15294.694106117815;15307.387704491695;15320;9145.0397708241;9169.587368568431;9172.541372931326;9176.632934682539;9204.815903682023;3521.1725244567506;3644;3678.429843374281;3679.9080022999105;3690.0774806298427;1108.6673997800629;1201.9362863865367;1205.7287110400266;1206.9077484876202;1225.7977433723513;33077.17307067294;33127.33745325128;33175.83412082924;33213.75082720926;33393.83303083469;1221.5602383142061;1246.9189502682298;1261.098314704972;1262.9959182449975;1304.9886338088058;17399.652006960045;17531.56171095733;17676.11619419024;17736.29054837792;17839.46481605528;463906;553382;559859;560784;766611;55494;56136.719316403156;56252;56487;56905.14642280369;1529.4111766969797;1535.9555502258347;1537.4157820028317;1540.7457769468137;1553.5184092931227;32109.357812843144;32408.351832962737;32770.1807454806;33013.01460296072;33171.66828331686;53149;53684.46315536794;53775;54001.45998539964;54197.72901135469;427550;429883;433930;434640;436109;30006.099817005525;30060;30509.694903050684;30643.693563064084;30681.8465907669;47185.76407117942;47293.527064728914;47831.5216847827;48115.27827082667;48552.5144748548;40828.38757418701;41393.79303103586;41444;41591;42369.576304236565;40281.1943761129;40618.1876362477;41170.38244426276;42104.3684344729;42207.788961055;41375.37936931009;42320.5767942329;42369.788151059045;42429.363559546015;42629.57370426256;35035.824820876755;35615.22455522062;35835.62191042177;36873.63126368702;37352.43971340486;29024.605842077206;29187.562186566793;29346.119616411543;29563.40873182567;29611.40777184487 08:37:13 INFO - PROCESS | 7932 | |2;jquery.html;420.4303169205728;423.4326003155771;425.71902544320756;433.5187941385062;436.5721592839018;14396.712065758704;18520.166592503338;19025;19029.143688534015;19396.127174277157;18654.25382984679;18684.906575467103;18837.52906177346;18899.62200755984;18936.62126757464;5412.296401467804;5501.14732216507;5691.800786972457;5735.283089613798;5750.453706897838;5679.829605111853;5702.65784052956;5712.343080545749;5713.571482138836;5714.599978001542;5633.267675202238;5665.575081868856;5871.29544454666;5871.88256234875;5890.5582081343855;5820.35976042635;5837.766489340443;5839.357670656224;5841.766329346821;5884.235049443566;5591.245181900432;5654.63244889085;5659.151127330892;5798.536117110621;5809.070548712186;13501.797473037912;13668.589942301747;13733;18202.271909123618;22048.88975555112;2441.6581678565017;2452.9754702452924;2458.21337172105;2472.2336075816556;2567.5763499022637;9944.900550994469;10004.59981600735;10250.436226007567;10278.22913281507;10323.58705651773;2036.8981550922394;2050.302897015022;2070.8446866485074;2122.193566444741;2145.8927053647412;79647.6017619914;82890;83484.58257708672;84989.57505212496;85190;10981.231313808117;11012.559497620166;11027.338359698444;11103.112470879809;11225.382603956697;15409.229538523254;15436.45972390961;15534.533963981099;15564.922175389278;15599.298031588605;8203.466774659628;8453.985521737432;8712.69505567302;8743.868841967376;8934.106589341143;8818.86771698425;8840.160184782564;8856.8671469928;8928.331850909573;8997.775055623662;4689.460712018094;4766.666333356632;4786;4809.951900480951;4840.83057093;1985.1563085688524;1985.1959956217754;2028.8681235719926;2070.7411573553304;2078.002558771798;1023.2070145637191;1063.7074804428844;1102.8400881872083;1120.2606279855256;1132.7621199548187;17047.40334088301;17320.91339543294;18039.188236529386;18837.90581047086;18976.81023189778;1080.5731735964407;1082.929609575375;1085.3325204998869;1122.8708698499777;1144.2905398652888;10462.581496740046;10778.838317425245;10805.729856753487;10829;11017;381289;383662;391090;393466;465414;61376.69311653413;64533;94989;102225.48887255516;106913.72345106109;1090.9727256818485;1118.983215251772;1124.522078116797;1129.7062763681502;1134.5858761551974;17139;17288.481345559652;17321.826781732023;17365.523930466054;17509.912450437667;38599;39148;40496.1900761989;40729.796351018056;40898.59101408948;52677.20984185317;58743.4125658738;59428.40571594229;60445.69777151086;60544;8267.379946504156;8430.15698430152;8497.320214382959;8701.042885282488;8720.215180633773;12196.695082623006;13072.607821765363;13511.594652160451;13839.654008649864;13862.722745545234;11673.12451566119;11689.766204675689;11713.180077394842;12078.33569153705;12238.265704057785;11423.428828558373;11471.426428678365;11494.655160345203;11778.528858845893;11825.290482571074;12006.459709313276;12082.214656047328;12115;12232.816507752568;12510.56213032576;8727.694530691395;8752.124787521198;8903.910960890309;8915.643374265217;8989.41568798026;9940.900590993997;11822.113341499595;11989.34058626749;12008.279503229485;12010.519579216734 08:37:13 INFO - PROCESS | 7932 | |3;mootools.html;1543.1744016950931;1588.6743217640385;1771.2088799796552;1881.3415304643377;1886.0852486544031;7604.543727376361;7886.723964661238;8028.718994835182;8089.5955202239875;8322.625481853316;7576.204498527658;8197.631106600202;8401.57992100394;8454.873176902336;8558.871616925735;2391.473875747337;2414.9758502414925;2421.2736179146273;2426.890789914449;2438.341647755105;2355.9411014724683;2407.5425669122897;2414.263649586875;2430.647556104364;2441.8046556275453;2405.1581946318825;2410.8312418130736;2417.830751847371;2433.537627850703;2440.3533063738123;2436.415260337524;2436.5492383908945;2438.036975394718;2440.0849681369486;2443.9511209775706;2401.3036219496325;2406.5066661334386;2439.9390015249583;2442.658027876099;2449.1795248591743;8756.299496040301;8811;8822.514761688104;8823.955880220621;8857.070007649168;5408.513233808976;5465.9180112298345;5475.151351540518;5518.227448157261;5528.198411230349;3405.0465869556565;3453;3486.18074752433;3517.613062563116;3529.982350088259;1058.8941105889426;1062.4634559547455;1068.0761141612527;1075.0324707762998;1077.978440431187;11796.823047654207;11829.467673954692;11843.526258949632;11859.703507412298;11866;4738.952610473852;4758.1673207188605;4764.547368000034;4789.95210047902;4830.178869592178;10189;10206.336588121749;10209.132223761064;10217.13154381886;10220.693379198636;5402.37872644643;5411.891762164734;5445.809396671098;5451.727413629303;5455.072637651609;4253.234417804825;4916.680415772963;4988.226824842155;5001.024800163933;5007.649464537448;4195.958040419557;4232.851850185229;4236.279832428495;4255.212785634668;4301.311790113629;1347.5418357758408;1383.764759990804;1393.1849867827232;1393.8954578406458;1403.0529392659914;850.2432834777053;926.6154545863391;969.6703120938914;981.7840075183448;1038.8441733739999;5630.8029218977135;5753.108268218432;5796.217510636095;5839.5036421904615;5957.165996760457;446.37730366139056;460.54636183359366;463.98376056838526;466.27028700084935;466.4030041546758;3686.889393318151;3755.6244375562774;3765.077555998798;3765.5104836371643;3799.145192331703;10667.73330666724;10822.512986915608;10912.127029837595;11047.668569942914;11056.336619802838;9939.55272012761;10195.898041019644;10646.574137034588;10715;10729.678109656723;7945.364370850318;7998.680052797823;8098.109207987117;8132.430729848854;8153.633086511121;5802.883942321215;5862.472377486047;5883.441073098049;5944.791932282349;6001.939980600138;8912.643494260416;8978.640854365753;8999;9024.232940200156;9193.954030230074;9234.584443699916;9324.347295689236;9406.623735050522;9592.136707696342;9772.462514561767;7127.322904324081;7509;7712.421568382506;8048.39637027237;8152;7981.082175549654;8019.478733882279;8029.116797152192;8087.595620218848;8088.272055515032;7310.415166786538;7389.556626602421;7497.737579184703;7521.8871716923195;7602.239776022354;7048.083749112788;7087.7164913402885;7109.893351599627;7128.857422851617;7149.177844547944;6505.902411463737;6540.738370465128;6540.771073012422;6593.868122637425;6596.3073877244115;4749.620030397629;4779.641526885428;4780.330753694416;4809.615230781459;4843.249296358929;5024.271480635361;5027;5040.773165207501;5079.517445842639;5156.226566014978 08:37:13 INFO - PROCESS | 7932 | |4;prototype.html;364.04619895872816;365.1091337137385;365.84451608066576;370.7275152762721;373.63943794238537;6351.682415879205;6395.648239346846;6438.8390290242705;6461.418472337488;6482.319356467562;6538.444232240254;6593.142891424108;6607.33926607339;6619.205695316557;6633.734650613969;5064;5070.695758254498;5072.51811077948;5078.847634570969;5079.111155547783;5084.13569693153;5084.898302033957;5087.567556757662;5091.949080509203;5097.515736005093;5037.370328708911;5049.4193167785625;5049.747512624373;5054.620903432239;5057.342545469084;4741.478437371887;4901.730404827733;5039.622028347871;5048.95517315486;5050.166722490784;4215.768132752697;4221.02916329246;4246.384274280243;4248.723832950848;4248.957510424918;6144.0783882417545;6166.784162554334;6218.31598524162;6223.68881555925;6280.937190628081;5572.052751032294;5745.511631511326;5754.568407369464;5770.451807078362;5771.365149833515;6851;6876.518643694943;6889.724411023553;6895.069165662621;6899.103116594861;4758.666893317469;4759.8814278644495;4764.737939413331;4769.54689304519;4770.379850619432;7153.892691609578;7225.674844632004;7252.492325537214;7252.52858564197;7264.8910266346575;4712.387389639325;4746.833860814855;4770.546798054179;4778.283257511332;4788.497207793132;4838.153323168432;4855.684380515326;4856.490068542823;4860.465348811628;4861.683990540603;5685.260916080883;5688.829335119953;5689.118186681071;5694.003549378842;5702.45826646468;6918.5502942308585;6953.374196322254;6997.195322537973;7003.544769590062;7013.2986701329455;1700.8979461232366;1719.243532845569;1729.956751081233;1730.0398278955302;1731.7315816048533;1052.21609900623;1078.1374900079904;1112.2881355932047;1120.9551617935354;1138.8348689439986;6629.1382120325015;6776.593404395752;6791;6799.3200679931615;6846.520743548003;7281.017062696574;7292.598907060163;7304.5982470963545;7304.817379565553;7308.123025237006;6752.291009443938;6782.220044694924;6839.93160068393;6857.622830744357;6923.792286231421;3884.7863367515056;3923.2741942740686;3939.2318497892634;3943.408488726714;3959.425883246913;7397.816349384073;7456.217097204824;7486.925130748623;7499.400047996147;7519.924800751923;7276.490645654859;7376.262373762581;7380.557166570023;7382.409407247407;7395.371393431511;7429.777106686808;7432.405407567381;7432.777016689508;7439.442041846775;7449.366803821627;7086.893696594659;7230.24082471354;7250.274972502919;7263.0921134858145;7265.346118849329;7198.748043818441;7216.3505284524645;7223.916412538161;7238.710451581877;7250.057492525938;7399.741009064657;7532.472726909064;7548.509346892434;7552.8867066995135;7575.280348366897;4786.425628924551;4797.136515427256;4797.616190704665;4803.375561177025;4818.229083346648;6971.128608923885;7200.531965422231;7228.241034691282;7230.566166030055;7261.092363454568;7005.0893383859775;7026.789196324118;7031.191412987572;7033.894491582732;7058.54119482232;7006.544574602838;7011.719531218694;7019.052427922165;7022.824429389306;7069;6843.692033858588;6895.207051189177;6904.13698287714;6905.205901321412;6905.930940690529;6941.271166527644;7072.328128827753;7076.858462830612;7086.255943125898;7091.82270443243;6758.729650814109;6919.308069193041;6920.446364290945;6922.688479018356;6923.446124310144 08:37:13 INFO - PROCESS | 7932 | |5;yui.html;819.30768500617;855.597869001569;866.8959724833016;915.3455279475174;943.8820147481565;15647.53057408278;15935.123568203759;15937;15943;15969.920150399232;14808.703825923476;14810.407583696666;14811.703765924702;14845.92577037116;14852.33164507597;733.7395224695223;863.5811631358786;892.0767006148637;897.4435849773117;900.7027680865332;884.3544212724714;890.8841850559418;894.311380237217;898.9685361012366;899.3704406915153;950.5769932380093;952.1240458777906;952.6951375559823;954.1269738189549;957.0286159548065;935.5462600638684;938.9154976052188;943.3679434778714;943.6131186213654;948.2840455456121;694.1115372323384;694.4444444444475;696.4080531548194;700.3031983176771;701.9754308599225;15583.688326233412;15625.687486250325;15631.062136271747;15637.374505019785;15640;15004.924975375054;15200.923995380062;15222.543323700307;15338.309776060105;15387.230638468032;11901.912682741991;12017.459214335377;12086;12117.151799374047;12389.628311150589;4100.118474527961;4122.154958233555;4175.081482073939;4292.763897985609;4308.095299987007;55106;55725;56255.71872140654;58540.41459585392;59191;12168.269903805623;12313.815292770616;12494.75010499785;12646.367681615882;12653.746925061447;21759.238426654993;21826.89086554557;21845;21850.125994960024;21954.78045219559;9138.314626402913;9262.39794413361;9463.668771592962;9550.235981121494;9597.136257736836;4992.201247800334;5064.873378165576;5117.565006974449;5136.563392111638;5200.869978250574;3558.395072837624;3575.94636080459;3584.874529391459;3589.856405743741;3607.9458808117897;710.2577806192542;727.9708811647474;736.0578459571757;740.9036825212796;749.1871319618275;740.5963749756396;815.7063457155419;825.781167990483;836.4061516323478;857.8927634045745;9725.367851089799;9929.751756206153;10367.481625918674;10521.894781052244;10630.840537391945;762.9810689651799;805.1063319715112;809.1503920883049;809.7813590330578;820.5486982159788;4555.2256116460285;4772.856814295576;4786.569208771228;4834.613230941516;4851.690043688184;63005.36994629995;64141;64456;64712.352876471574;64739.67630161913;54838;56191.43808561862;56764.43235567674;57679;58559;51137.48862511327;51769.48230517722;51982;52715.47284527183;52807.471925281025;9445.527723613654;9508.809823803347;9516.85724714116;9620.230381569598;9659;38552.614473854905;39949;40144.7992760046;40834.1833163341;40883.182336353704;43317.566824331356;48452.7577362111;48675.5132448671;49364.50635493599;49757.50242497674;11066.170037247399;11458.255213411101;11748.35384053851;12192.268463892195;12289.1397602167;12963.092583519441;13513.986451016017;13647;13772.380242888894;14365;12710.936445317715;13254.271015094262;13439.798403023768;13580.253086079965;13860.099093559289;13462.124961877447;13499.527516536875;13574.117682350616;13578.93210533941;13708.451661933412;12138.211016283913;12982.285974271128;13148.03745766066;13728.862711372758;13773.517926872511;11147.944260278648;11274.206119227016;11764.35296058725;11779.352135632622;12045.698857528632;11120.44397780124;11459.484323205643;11656.475458604213;11830.112741544246;11867.109966752356 08:37:13 INFO - PROCESS | 7932 | __end_tp_report 08:37:13 INFO - PROCESS | 7932 | __start_cc_report 08:37:13 INFO - PROCESS | 7932 | _x_x_mozilla_cycle_collect,333 08:37:13 INFO - PROCESS | 7932 | __end_cc_report 08:37:13 INFO - PROCESS | 7932 | __startTimestamp1464622633827__endTimestamp 08:37:13 INFO - PROCESS | 7932 | 08:37:13 INFO - PROCESS | 7932 | ------- Summary: start ------- 08:37:13 INFO - PROCESS | 7932 | Number of tests: 6 08:37:13 INFO - PROCESS | 7932 | 08:37:13 INFO - PROCESS | 7932 | [#0] dojo.html Cycles:165 Average:5648.71 Median:5874.65 stddev:627.63 (10.7%) stddev-sans-first:603.35 08:37:13 INFO - PROCESS | 7932 | Values: 3361.0 3414.4 3418.5 3435.2 3462.1 5664.3 5672.8 5674.8 5684.5 5713.9 5637.6 5722.4 5730.3 5736.1 5765.7 5184.8 5221.7 5254.2 5281.0 5297.2 5043.2 5154.8 5176.5 5391.8 5410.7 5202.3 5203.7 5255.1 5325.7 5336.3 5258.1 5266.0 5266.1 5267.2 5273.7 5113.9 5158.7 5245.7 5247.0 5270.3 5446.7 5534.5 5577.9 5589.4 5607.1 5879.2 5892.1 5914.2 5916.9 5924.2 5891.4 5915.6 5925.7 5936.8 5951.4 5603.6 5698.1 5726.4 5746.9 5757.3 6207.7 6219.5 6220.6 6232.4 6234.1 5973.1 5988.5 5999.7 6010.0 6066.7 6113.5 6150.6 6152.1 6158.0 6160.8 6065.3 6081.4 6104.5 6120.3 6123.6 5906.7 6079.1 6115.0 6123.3 6127.1 4536.3 4541.3 4545.5 4575.3 4592.3 4106.3 4107.2 4112.9 4123.6 4157.3 5803.8 5856.1 5861.1 5873.0 5891.7 5941.6 6106.0 6127.8 6148.0 6172.4 5672.3 5873.2 5880.0 5884.6 5886.7 5049.1 5085.9 5096.3 5107.3 5132.0 6277.2 6300.7 6311.5 6322.6 6333.7 5944.0 6090.3 6162.7 6168.2 6173.0 6250.4 6308.8 6313.8 6318.7 6327.3 6003.5 6023.1 6026.3 6037.5 6060.2 5807.1 6062.4 6129.5 6143.8 6157.5 5948.3 5952.8 5966.1 5969.0 5988.4 5902.0 5921.5 5936.6 5937.1 5938.2 5631.9 5758.9 5787.9 5819.5 5871.4 5874.6 5893.6 5895.9 5926.9 5934.0 5764.5 5775.3 5789.0 5791.2 5794.7 08:37:13 INFO - PROCESS | 7932 | 08:37:13 INFO - PROCESS | 7932 | [#1] ext.html Cycles:180 Average:59409.75 Median:41384.59 stddev:122218.62 (295.3%) stddev-sans-first:122481.75 08:37:13 INFO - PROCESS | 7932 | Values: 612.1 661.6 665.7 673.0 673.6 38187.8 39042.4 39069.2 39145.8 39301.4 42176.8 42747.6 42890.0 42898.0 43028.4 8801.9 8924.8 8938.3 8948.0 8970.5 8685.4 8787.4 8831.5 9020.4 9035.0 9074.0 9111.7 9144.0 9148.0 9158.7 8958.4 8976.1 8987.3 9029.9 9037.0 8931.2 9028.2 9041.0 9042.9 9045.3 42727.4 42856.8 42893.6 43103.1 43149.4 3805.7 3864.5 3882.8 3887.4 4232.3 33114.5 33313.2 33342.8 34949.5 35412.6 4379.3 4394.3 4407.6 4471.8 4525.1 308176.0 309957.0 310944.0 312169.0 312675.0 38869.2 39689.6 60661.7 61068.0 61086.4 37220.8 37430.3 37585.8 37645.6 37650.8 17664.9 17942.8 17947.1 17978.4 17984.5 15197.1 15279.2 15294.7 15307.4 15320.0 9145.0 9169.6 9172.5 9176.6 9204.8 3521.2 3644.0 3678.4 3679.9 3690.1 1108.7 1201.9 1205.7 1206.9 1225.8 33077.2 33127.3 33175.8 33213.8 33393.8 1221.6 1246.9 1261.1 1263.0 1305.0 17399.7 17531.6 17676.1 17736.3 17839.5 463906.0 553382.0 559859.0 560784.0 766611.0 55494.0 56136.7 56252.0 56487.0 56905.1 1529.4 1536.0 1537.4 1540.7 1553.5 32109.4 32408.4 32770.2 33013.0 33171.7 53149.0 53684.5 53775.0 54001.5 54197.7 427550.0 429883.0 433930.0 434640.0 436109.0 30006.1 30060.0 30509.7 30643.7 30681.8 47185.8 47293.5 47831.5 48115.3 48552.5 40828.4 41393.8 41444.0 41591.0 42369.6 40281.2 40618.2 41170.4 42104.4 42207.8 41375.4 42320.6 42369.8 42429.4 42629.6 35035.8 35615.2 35835.6 36873.6 37352.4 29024.6 29187.6 29346.1 29563.4 29611.4 08:37:13 INFO - PROCESS | 7932 | 08:37:13 INFO - PROCESS | 7932 | [#2] jquery.html Cycles:180 Average:26270.35 Median:2074.42 stddev:67201.35 (3239.5%) stddev-sans-first:67361.84 08:37:13 INFO - PROCESS | 7932 | Values: 420.4 423.4 425.7 433.5 436.6 14396.7 18520.2 19025.0 19029.1 19396.1 18654.3 18684.9 18837.5 18899.6 18936.6 5412.3 5501.1 5691.8 5735.3 5750.5 5679.8 5702.7 5712.3 5713.6 5714.6 5633.3 5665.6 5871.3 5871.9 5890.6 5820.4 5837.8 5839.4 5841.8 5884.2 5591.2 5654.6 5659.2 5798.5 5809.1 13501.8 13668.6 13733.0 18202.3 22048.9 2441.7 2453.0 2458.2 2472.2 2567.6 9944.9 10004.6 10250.4 10278.2 10323.6 2036.9 2050.3 2070.8 2122.2 2145.9 79647.6 82890.0 83484.6 84989.6 85190.0 10981.2 11012.6 11027.3 11103.1 11225.4 15409.2 15436.5 15534.5 15564.9 15599.3 8203.5 8454.0 8712.7 8743.9 8934.1 8818.9 8840.2 8856.9 8928.3 8997.8 4689.5 4766.7 4786.0 4810.0 4840.8 1985.2 1985.2 2028.9 2070.7 2078.0 1023.2 1063.7 1102.8 1120.3 1132.8 17047.4 17320.9 18039.2 18837.9 18976.8 1080.6 1082.9 1085.3 1122.9 1144.3 10462.6 10778.8 10805.7 10829.0 11017.0 381289.0 383662.0 391090.0 393466.0 465414.0 61376.7 64533.0 94989.0 102225.5 106913.7 1091.0 1119.0 1124.5 1129.7 1134.6 17139.0 17288.5 17321.8 17365.5 17509.9 38599.0 39148.0 40496.2 40729.8 40898.6 52677.2 58743.4 59428.4 60445.7 60544.0 8267.4 8430.2 8497.3 8701.0 8720.2 12196.7 13072.6 13511.6 13839.7 13862.7 11673.1 11689.8 11713.2 12078.3 12238.3 11423.4 11471.4 11494.7 11778.5 11825.3 12006.5 12082.2 12115.0 12232.8 12510.6 8727.7 8752.1 8903.9 8915.6 8989.4 9940.9 11822.1 11989.3 12008.3 12010.5 08:37:13 INFO - PROCESS | 7932 | 08:37:13 INFO - PROCESS | 7932 | [#3] mootools.html Cycles:180 Average:5642.55 Median:4879.96 stddev:3122.00 (64.0%) stddev-sans-first:3115.56 08:37:13 INFO - PROCESS | 7932 | Values: 1543.2 1588.7 1771.2 1881.3 1886.1 7604.5 7886.7 8028.7 8089.6 8322.6 7576.2 8197.6 8401.6 8454.9 8558.9 2391.5 2415.0 2421.3 2426.9 2438.3 2355.9 2407.5 2414.3 2430.6 2441.8 2405.2 2410.8 2417.8 2433.5 2440.4 2436.4 2436.5 2438.0 2440.1 2444.0 2401.3 2406.5 2439.9 2442.7 2449.2 8756.3 8811.0 8822.5 8824.0 8857.1 5408.5 5465.9 5475.2 5518.2 5528.2 3405.0 3453.0 3486.2 3517.6 3530.0 1058.9 1062.5 1068.1 1075.0 1078.0 11796.8 11829.5 11843.5 11859.7 11866.0 4739.0 4758.2 4764.5 4790.0 4830.2 10189.0 10206.3 10209.1 10217.1 10220.7 5402.4 5411.9 5445.8 5451.7 5455.1 4253.2 4916.7 4988.2 5001.0 5007.6 4196.0 4232.9 4236.3 4255.2 4301.3 1347.5 1383.8 1393.2 1393.9 1403.1 850.2 926.6 969.7 981.8 1038.8 5630.8 5753.1 5796.2 5839.5 5957.2 446.4 460.5 464.0 466.3 466.4 3686.9 3755.6 3765.1 3765.5 3799.1 10667.7 10822.5 10912.1 11047.7 11056.3 9939.6 10195.9 10646.6 10715.0 10729.7 7945.4 7998.7 8098.1 8132.4 8153.6 5802.9 5862.5 5883.4 5944.8 6001.9 8912.6 8978.6 8999.0 9024.2 9194.0 9234.6 9324.3 9406.6 9592.1 9772.5 7127.3 7509.0 7712.4 8048.4 8152.0 7981.1 8019.5 8029.1 8087.6 8088.3 7310.4 7389.6 7497.7 7521.9 7602.2 7048.1 7087.7 7109.9 7128.9 7149.2 6505.9 6540.7 6540.8 6593.9 6596.3 4749.6 4779.6 4780.3 4809.6 4843.2 5024.3 5027.0 5040.8 5079.5 5156.2 08:37:13 INFO - PROCESS | 7932 | 08:37:13 INFO - PROCESS | 7932 | [#4] prototype.html Cycles:180 Average:5823.43 Median:6693.01 stddev:1787.80 (26.7%) stddev-sans-first:1745.22 08:37:13 INFO - PROCESS | 7932 | Values: 364.0 365.1 365.8 370.7 373.6 6351.7 6395.6 6438.8 6461.4 6482.3 6538.4 6593.1 6607.3 6619.2 6633.7 5064.0 5070.7 5072.5 5078.8 5079.1 5084.1 5084.9 5087.6 5091.9 5097.5 5037.4 5049.4 5049.7 5054.6 5057.3 4741.5 4901.7 5039.6 5049.0 5050.2 4215.8 4221.0 4246.4 4248.7 4249.0 6144.1 6166.8 6218.3 6223.7 6280.9 5572.1 5745.5 5754.6 5770.5 5771.4 6851.0 6876.5 6889.7 6895.1 6899.1 4758.7 4759.9 4764.7 4769.5 4770.4 7153.9 7225.7 7252.5 7252.5 7264.9 4712.4 4746.8 4770.5 4778.3 4788.5 4838.2 4855.7 4856.5 4860.5 4861.7 5685.3 5688.8 5689.1 5694.0 5702.5 6918.6 6953.4 6997.2 7003.5 7013.3 1700.9 1719.2 1730.0 1730.0 1731.7 1052.2 1078.1 1112.3 1121.0 1138.8 6629.1 6776.6 6791.0 6799.3 6846.5 7281.0 7292.6 7304.6 7304.8 7308.1 6752.3 6782.2 6839.9 6857.6 6923.8 3884.8 3923.3 3939.2 3943.4 3959.4 7397.8 7456.2 7486.9 7499.4 7519.9 7276.5 7376.3 7380.6 7382.4 7395.4 7429.8 7432.4 7432.8 7439.4 7449.4 7086.9 7230.2 7250.3 7263.1 7265.3 7198.7 7216.4 7223.9 7238.7 7250.1 7399.7 7532.5 7548.5 7552.9 7575.3 4786.4 4797.1 4797.6 4803.4 4818.2 6971.1 7200.5 7228.2 7230.6 7261.1 7005.1 7026.8 7031.2 7033.9 7058.5 7006.5 7011.7 7019.1 7022.8 7069.0 6843.7 6895.2 6904.1 6905.2 6905.9 6941.3 7072.3 7076.9 7086.3 7091.8 6758.7 6919.3 6920.4 6922.7 6923.4 08:37:13 INFO - PROCESS | 7932 | 08:37:13 INFO - PROCESS | 7932 | [#5] yui.html Cycles:180 Average:15808.56 Median:4779.71 stddev:17884.66 (374.2%) stddev-sans-first:17899.41 08:37:13 INFO - PROCESS | 7932 | Values: 819.3 855.6 866.9 915.3 943.9 15647.5 15935.1 15937.0 15943.0 15969.9 14808.7 14810.4 14811.7 14845.9 14852.3 733.7 863.6 892.1 897.4 900.7 884.4 890.9 894.3 899.0 899.4 950.6 952.1 952.7 954.1 957.0 935.5 938.9 943.4 943.6 948.3 694.1 694.4 696.4 700.3 702.0 15583.7 15625.7 15631.1 15637.4 15640.0 15004.9 15200.9 15222.5 15338.3 15387.2 11901.9 12017.5 12086.0 12117.2 12389.6 4100.1 4122.2 4175.1 4292.8 4308.1 55106.0 55725.0 56255.7 58540.4 59191.0 12168.3 12313.8 12494.8 12646.4 12653.7 21759.2 21826.9 21845.0 21850.1 21954.8 9138.3 9262.4 9463.7 9550.2 9597.1 4992.2 5064.9 5117.6 5136.6 5200.9 3558.4 3575.9 3584.9 3589.9 3607.9 710.3 728.0 736.1 740.9 749.2 740.6 815.7 825.8 836.4 857.9 9725.4 9929.8 10367.5 10521.9 10630.8 763.0 805.1 809.2 809.8 820.5 4555.2 4772.9 4786.6 4834.6 4851.7 63005.4 64141.0 64456.0 64712.4 64739.7 54838.0 56191.4 56764.4 57679.0 58559.0 51137.5 51769.5 51982.0 52715.5 52807.5 9445.5 9508.8 9516.9 9620.2 9659.0 38552.6 39949.0 40144.8 40834.2 40883.2 43317.6 48452.8 48675.5 49364.5 49757.5 11066.2 11458.3 11748.4 12192.3 12289.1 12963.1 13514.0 13647.0 13772.4 14365.0 12710.9 13254.3 13439.8 13580.3 13860.1 13462.1 13499.5 13574.1 13578.9 13708.5 12138.2 12982.3 13148.0 13728.9 13773.5 11147.9 11274.2 11764.4 11779.4 12045.7 11120.4 11459.5 11656.5 11830.1 11867.1 08:37:13 INFO - PROCESS | 7932 | -------- Summary: end -------- 08:37:13 INFO - PROCESS | 7932 | 08:37:14 INFO - TEST-INFO | 7932: exit 0 08:37:14 INFO - TEST-OK | dromaeo_css | took 1109009ms 08:37:14 INFO - TEST-START | kraken 08:37:14 INFO - operating with platform_type : linux_ 08:37:14 INFO - Initialising browser for kraken test... 08:37:14 INFO - TEST-INFO | started process 8178 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptbgt17/profile http://localhost:50642/getInfo.html) 08:37:17 INFO - PROCESS | 8178 | 08:37:17 INFO - PROCESS | 8178 | (process:8256): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:37:18 INFO - PROCESS | 8178 | __metrics Screen width/height:1600/1200 08:37:18 INFO - PROCESS | 8178 | colorDepth:24 08:37:18 INFO - PROCESS | 8178 | Browser inner width/height: 1024/697 08:37:18 INFO - PROCESS | 8178 | __metrics 08:37:19 ERROR - PROCESS | 8178 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 08:37:20 INFO - TEST-INFO | 8178: exit 0 08:37:20 INFO - Browser initialized. 08:37:20 INFO - Running cycle 1/1 for kraken test... 08:37:20 INFO - TEST-INFO | started process 8307 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptbgt17/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:37:21 INFO - PROCESS | 8307 | 08:37:21 INFO - PROCESS | 8307 | (process:8375): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:37:32 INFO - PROCESS | 8307 | RSS: Main: 152031232 08:37:32 INFO - PROCESS | 8307 | 08:37:34 INFO - PROCESS | 8307 | Cycle 1(1): loaded http://localhost:50642/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50642/tests/kraken/driver.html?testName=audio-beat-detection) 08:37:35 INFO - PROCESS | 8307 | RSS: Main: 156962816 08:37:35 INFO - PROCESS | 8307 | 08:37:38 INFO - PROCESS | 8307 | Cycle 1(1): loaded http://localhost:50642/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50642/tests/kraken/driver.html?testName=audio-dft) 08:37:38 INFO - PROCESS | 8307 | RSS: Main: 157396992 08:37:38 INFO - PROCESS | 8307 | 08:37:41 INFO - PROCESS | 8307 | Cycle 1(1): loaded http://localhost:50642/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50642/tests/kraken/driver.html?testName=audio-fft) 08:37:42 INFO - PROCESS | 8307 | RSS: Main: 157376512 08:37:42 INFO - PROCESS | 8307 | 08:37:44 INFO - PROCESS | 8307 | Cycle 1(1): loaded http://localhost:50642/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50642/tests/kraken/driver.html?testName=audio-oscillator) 08:37:44 INFO - PROCESS | 8307 | RSS: Main: 156782592 08:37:44 INFO - PROCESS | 8307 | 08:37:47 INFO - PROCESS | 8307 | Cycle 1(1): loaded http://localhost:50642/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50642/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:37:47 INFO - PROCESS | 8307 | RSS: Main: 156635136 08:37:47 INFO - PROCESS | 8307 | 08:37:50 INFO - PROCESS | 8307 | Cycle 1(1): loaded http://localhost:50642/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50642/tests/kraken/driver.html?testName=imaging-darkroom) 08:37:51 INFO - PROCESS | 8307 | RSS: Main: 156553216 08:37:51 INFO - PROCESS | 8307 | 08:37:54 INFO - PROCESS | 8307 | Cycle 1(1): loaded http://localhost:50642/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50642/tests/kraken/driver.html?testName=imaging-desaturate) 08:37:55 INFO - PROCESS | 8307 | RSS: Main: 157200384 08:37:55 INFO - PROCESS | 8307 | 08:37:58 INFO - PROCESS | 8307 | Cycle 1(1): loaded http://localhost:50642/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50642/tests/kraken/driver.html?testName=json-parse-financial) 08:37:58 INFO - PROCESS | 8307 | RSS: Main: 157052928 08:37:58 INFO - PROCESS | 8307 | 08:38:00 INFO - PROCESS | 8307 | Cycle 1(1): loaded http://localhost:50642/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50642/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:38:00 INFO - PROCESS | 8307 | RSS: Main: 156917760 08:38:00 INFO - PROCESS | 8307 | 08:38:02 INFO - PROCESS | 8307 | Cycle 1(1): loaded http://localhost:50642/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50642/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:38:03 INFO - PROCESS | 8307 | RSS: Main: 157319168 08:38:03 INFO - PROCESS | 8307 | 08:38:05 INFO - PROCESS | 8307 | Cycle 1(1): loaded http://localhost:50642/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50642/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:38:05 INFO - PROCESS | 8307 | RSS: Main: 157171712 08:38:05 INFO - PROCESS | 8307 | 08:38:08 INFO - PROCESS | 8307 | Cycle 1(1): loaded http://localhost:50642/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50642/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:38:08 INFO - PROCESS | 8307 | RSS: Main: 157515776 08:38:08 INFO - PROCESS | 8307 | 08:38:11 INFO - PROCESS | 8307 | Cycle 1(1): loaded http://localhost:50642/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50642/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:38:12 INFO - PROCESS | 8307 | RSS: Main: 157507584 08:38:12 INFO - PROCESS | 8307 | 08:38:13 INFO - PROCESS | 8307 | Cycle 1(1): loaded http://localhost:50642/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50642/tests/kraken/driver.html?testName=ai-astar) 08:38:14 INFO - PROCESS | 8307 | RSS: Main: 159084544 08:38:14 INFO - PROCESS | 8307 | 08:38:14 INFO - PROCESS | 8307 | __start_tp_report 08:38:14 INFO - PROCESS | 8307 | _x_x_mozilla_page_load 08:38:14 INFO - PROCESS | 8307 | _x_x_mozilla_page_load_details 08:38:14 INFO - PROCESS | 8307 | |i|pagename|runs| 08:38:14 INFO - PROCESS | 8307 | |0;ai-astar;111;114;102;113;112;113;102;109;109;110 08:38:14 INFO - PROCESS | 8307 | |1;audio-beat-detection;155;131;156;185;132;152;163;143;181;129 08:38:14 INFO - PROCESS | 8307 | |2;audio-dft;162;163;162;162;166;162;164;162;163;162 08:38:14 INFO - PROCESS | 8307 | |3;audio-fft;74;73;77;175;79;78;73;74;167;75 08:38:14 INFO - PROCESS | 8307 | |4;audio-oscillator;92;93;148;91;93;93;140;93;93;142 08:38:14 INFO - PROCESS | 8307 | |5;imaging-gaussian-blur;118;117;117;117;117;117;117;117;117;117 08:38:14 INFO - PROCESS | 8307 | |6;imaging-darkroom;148;147;147;146;146;149;146;146;146;146 08:38:14 INFO - PROCESS | 8307 | |7;imaging-desaturate;96;96;94;95;95;96;95;94;95;95 08:38:14 INFO - PROCESS | 8307 | |8;json-parse-financial;54;56;55;58;61;55;60;79;54;55 08:38:14 INFO - PROCESS | 8307 | |9;json-stringify-tinderbox;59;59;59;60;60;59;60;60;60;59 08:38:14 INFO - PROCESS | 8307 | |10;stanford-crypto-aes;73;81;82;73;75;73;75;73;75;75 08:38:14 INFO - PROCESS | 8307 | |11;stanford-crypto-ccm;116;114;117;117;114;114;123;114;131;128 08:38:14 INFO - PROCESS | 8307 | |12;stanford-crypto-pbkdf2;162;164;168;165;167;164;161;162;166;158 08:38:14 INFO - PROCESS | 8307 | |13;stanford-crypto-sha256-iterative;67;66;67;69;67;68;66;67;66;65 08:38:14 INFO - PROCESS | 8307 | __end_tp_report 08:38:14 INFO - PROCESS | 8307 | __start_cc_report 08:38:14 INFO - PROCESS | 8307 | _x_x_mozilla_cycle_collect,857 08:38:14 INFO - PROCESS | 8307 | __end_cc_report 08:38:14 INFO - PROCESS | 8307 | __startTimestamp1464622694232__endTimestamp 08:38:14 INFO - PROCESS | 8307 | 08:38:14 INFO - PROCESS | 8307 | ------- Summary: start ------- 08:38:14 INFO - PROCESS | 8307 | Number of tests: 14 08:38:14 INFO - PROCESS | 8307 | 08:38:14 INFO - PROCESS | 8307 | [#0] ai-astar Cycles:10 Average:109.50 Median:111.50 stddev:4.30 (3.9%) stddev-sans-first:4.53 08:38:14 INFO - PROCESS | 8307 | Values: 111.0 114.0 102.0 113.0 112.0 113.0 102.0 109.0 109.0 110.0 08:38:14 INFO - PROCESS | 8307 | 08:38:14 INFO - PROCESS | 8307 | [#1] audio-beat-detection Cycles:10 Average:152.70 Median:155.50 stddev:19.78 (12.7%) stddev-sans-first:20.96 08:38:14 INFO - PROCESS | 8307 | Values: 155.0 131.0 156.0 185.0 132.0 152.0 163.0 143.0 181.0 129.0 08:38:14 INFO - PROCESS | 8307 | 08:38:14 INFO - PROCESS | 8307 | [#2] audio-dft Cycles:10 Average:162.80 Median:162.50 stddev:1.32 (0.8%) stddev-sans-first:1.36 08:38:14 INFO - PROCESS | 8307 | Values: 162.0 163.0 162.0 162.0 166.0 162.0 164.0 162.0 163.0 162.0 08:38:14 INFO - PROCESS | 8307 | 08:38:14 INFO - PROCESS | 8307 | [#3] audio-fft Cycles:10 Average:94.50 Median:74.50 stddev:40.42 (54.2%) stddev-sans-first:42.18 08:38:14 INFO - PROCESS | 8307 | Values: 74.0 73.0 77.0 175.0 79.0 78.0 73.0 74.0 167.0 75.0 08:38:14 INFO - PROCESS | 8307 | 08:38:14 INFO - PROCESS | 8307 | [#4] audio-oscillator Cycles:10 Average:107.80 Median:93.00 stddev:24.61 (26.5%) stddev-sans-first:25.43 08:38:14 INFO - PROCESS | 8307 | Values: 92.0 93.0 148.0 91.0 93.0 93.0 140.0 93.0 93.0 142.0 08:38:14 INFO - PROCESS | 8307 | 08:38:14 INFO - PROCESS | 8307 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 08:38:14 INFO - PROCESS | 8307 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 08:38:14 INFO - PROCESS | 8307 | 08:38:14 INFO - PROCESS | 8307 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:146.50 stddev:1.06 (0.7%) stddev-sans-first:1.01 08:38:14 INFO - PROCESS | 8307 | Values: 148.0 147.0 147.0 146.0 146.0 149.0 146.0 146.0 146.0 146.0 08:38:14 INFO - PROCESS | 8307 | 08:38:14 INFO - PROCESS | 8307 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 08:38:14 INFO - PROCESS | 8307 | Values: 96.0 96.0 94.0 95.0 95.0 96.0 95.0 94.0 95.0 95.0 08:38:14 INFO - PROCESS | 8307 | 08:38:14 INFO - PROCESS | 8307 | [#8] json-parse-financial Cycles:10 Average:58.70 Median:57.00 stddev:7.54 (13.2%) stddev-sans-first:7.81 08:38:14 INFO - PROCESS | 8307 | Values: 54.0 56.0 55.0 58.0 61.0 55.0 60.0 79.0 54.0 55.0 08:38:14 INFO - PROCESS | 8307 | 08:38:14 INFO - PROCESS | 8307 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:60.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 08:38:14 INFO - PROCESS | 8307 | Values: 59.0 59.0 59.0 60.0 60.0 59.0 60.0 60.0 60.0 59.0 08:38:14 INFO - PROCESS | 8307 | 08:38:14 INFO - PROCESS | 8307 | [#10] stanford-crypto-aes Cycles:10 Average:75.50 Median:75.00 stddev:3.31 (4.4%) stddev-sans-first:3.38 08:38:14 INFO - PROCESS | 8307 | Values: 73.0 81.0 82.0 73.0 75.0 73.0 75.0 73.0 75.0 75.0 08:38:14 INFO - PROCESS | 8307 | 08:38:14 INFO - PROCESS | 8307 | [#11] stanford-crypto-ccm Cycles:10 Average:118.80 Median:117.00 stddev:6.30 (5.4%) stddev-sans-first:6.60 08:38:14 INFO - PROCESS | 8307 | Values: 116.0 114.0 117.0 117.0 114.0 114.0 123.0 114.0 131.0 128.0 08:38:14 INFO - PROCESS | 8307 | 08:38:14 INFO - PROCESS | 8307 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.70 Median:164.50 stddev:3.02 (1.8%) stddev-sans-first:3.14 08:38:14 INFO - PROCESS | 8307 | Values: 162.0 164.0 168.0 165.0 167.0 164.0 161.0 162.0 166.0 158.0 08:38:14 INFO - PROCESS | 8307 | 08:38:14 INFO - PROCESS | 8307 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.14 (1.7%) stddev-sans-first:1.20 08:38:14 INFO - PROCESS | 8307 | Values: 67.0 66.0 67.0 69.0 67.0 68.0 66.0 67.0 66.0 65.0 08:38:14 INFO - PROCESS | 8307 | -------- Summary: end -------- 08:38:14 INFO - PROCESS | 8307 | 08:38:15 INFO - TEST-INFO | 8307: exit 0 08:38:15 INFO - TEST-OK | kraken | took 60624ms 08:38:15 INFO - SUITE-END | took 1169s 08:38:15 INFO - Completed test suite (00:19:29) 08:38:15 INFO - javascript benchmark 08:38:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3360.9831950840244, 3414.385410626088, 3418.52140700302, 3435.2442462658205, 3462.1171601241695, 5664.291963504562, 5672.773089076432, 5674.829755107348, 5684.488396044355, 5713.885722285562, 5637.577181711367, 5722.427757224275, 5730.283714535683, 5736.053551164064, 5765.682887441189, 5184.792608295664, 5221.71280579568, 5254.159334506479, 5280.996610643965, 5297.178937264711, 5043.218301163325, 5154.819581314655, 5176.456472070435, 5391.81128660497, 5410.675359478424, 5202.297689811884, 5203.739813009353, 5255.08036093682, 5325.680459172462, 5336.332958380202, 5258.053550360953, 5266.0, 5266.104762190437, 5267.183586544092, 5273.709945952971, 5113.948860511385, 5158.7420628968775, 5245.6852588844795, 5247.0, 5270.262163297103, 5446.7276636168035, 5534.4742249486235, 5577.944220557783, 5589.413111623302, 5607.074832652607, 5879.206307148523, 5892.086726557391, 5914.2015827863115, 5916.852078698024, 5924.200232968537, 5891.3814049525035, 5915.615484993462, 5925.703714814242, 5936.821895343103, 5951.3751056139345, 5603.551715862721, 5698.1452782083015, 5726.427357264281, 5746.885062298772, 5757.309122905236, 6207.689615519296, 6219.502439804804, 6220.626762394271, 6232.439080482688, 6234.127222188898, 5973.074173503114, 5988.461038506555, 5999.670018148957, 6010.0, 6066.696665166724, 6113.537117903944, 6150.569460137747, 6152.077188421683, 6158.04550294705, 6160.784372546939, 6065.302490213682, 6081.401205906835, 6104.542159338067, 6120.265568131853, 6123.6019658722935, 5906.675132867647, 6079.088136779518, 6114.996965385453, 6123.295820980555, 6127.097902969301, 4536.274196128604, 4541.296099104644, 4545.454545454567, 4575.313702944519, 4592.265237561974, 4106.260873042881, 4107.199096176217, 4112.897177570585, 4123.567025462343, 4157.334826427757, 5803.7968671096305, 5856.063029915278, 5861.062230043172, 5873.030949893306, 5891.675957822275, 5941.613795103391, 6106.0, 6127.785527506605, 6148.0, 6172.444479996821, 5672.319321681342, 5873.20711703923, 5879.970600147058, 5884.588078834526, 5886.676232807151, 5049.141645920203, 5085.898282034339, 5096.311997880239, 5107.259447380184, 5131.97434012835, 6277.18396608438, 6300.684965751694, 6311.526635502356, 6322.589031712924, 6333.746650134035, 5944.048952167633, 6090.299615544269, 6162.722677479434, 6168.19813424252, 6173.043178307369, 6250.4374606285655, 6308.842278943063, 6313.779017734358, 6318.652474113968, 6327.303996560283, 6003.489703375262, 6023.1266466363, 6026.337102918587, 6037.45662890342, 6060.151578778887, 5807.0998995155815, 6062.42406971337, 6129.478994285358, 6143.754249829957, 6157.53818463626, 5948.315943666534, 5952.76188952437, 5966.105084237399, 5969.015112506388, 5988.401159883977, 5901.970490147522, 5921.467067963904, 5936.614120082181, 5937.109433584997, 5938.2280303560265, 5631.88736225265, 5758.856028599319, 5787.9131813021995, 5819.5053420459735, 5871.442212989759, 5874.647521148745, 5893.557983151367, 5895.9115613266695, 5926.851828704317, 5934.0, 5764.452377024176, 5775.33583637887, 5789.044807606866, 5791.160281759206, 5794.652320860761], "value": 5607.815394356518, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [612.1338306296587, 661.5666738286421, 665.6671664167916, 672.9764458243959, 673.5823789250666, 38187.80906095469, 39042.4143637845, 39069.21861562767, 39145.80427097864, 39301.41047884277, 42176.78911605445, 42747.57252427475, 42890.0, 42898.0, 43028.354574681405, 8801.867971980426, 8924.776880577972, 8938.329625278131, 8947.955260223689, 8970.461772293651, 8685.392022558424, 8787.384883058188, 8831.514266715329, 9020.368574199809, 9035.0, 9074.047225041375, 9111.72664820053, 9144.0, 9148.0, 9158.72523824283, 8958.37291389603, 8976.147266009719, 8987.281017518615, 9029.909700903037, 9037.0, 8931.240844528224, 9028.232600228988, 9040.954795226047, 9042.909570904272, 9045.276377889819, 42727.35908961368, 42856.78571607153, 42893.571064289266, 43103.137937241394, 43149.35275970863, 3805.7335986480957, 3864.4589757433982, 3882.8058597070035, 3887.4168874668744, 4232.259354612961, 33114.50328245078, 33313.16717082068, 33342.83328583342, 34949.47575786365, 35412.64587354145, 4379.343098535245, 4394.252976993918, 4407.581279778416, 4471.843485478025, 4525.140223357585, 308176.0, 309957.0, 310944.0, 312169.0, 312675.0, 38869.22261554753, 39689.60310396859, 60661.69669151626, 61068.0, 61086.389136108955, 37220.81389593035, 37430.25139497195, 37585.81207093947, 37645.62354376421, 37650.81174594109, 17664.91167544154, 17942.820571794375, 17947.102644867704, 17978.37075702344, 17984.460466186036, 15197.088174709554, 15279.236038198045, 15294.694106117815, 15307.387704491695, 15320.0, 9145.0397708241, 9169.587368568431, 9172.541372931326, 9176.632934682539, 9204.815903682023, 3521.1725244567506, 3644.0, 3678.429843374281, 3679.9080022999105, 3690.0774806298427, 1108.6673997800629, 1201.9362863865367, 1205.7287110400266, 1206.9077484876202, 1225.7977433723513, 33077.17307067294, 33127.33745325128, 33175.83412082924, 33213.75082720926, 33393.83303083469, 1221.5602383142061, 1246.9189502682298, 1261.098314704972, 1262.9959182449975, 1304.9886338088058, 17399.652006960045, 17531.56171095733, 17676.11619419024, 17736.29054837792, 17839.46481605528, 463906.0, 553382.0, 559859.0, 560784.0, 766611.0, 55494.0, 56136.719316403156, 56252.0, 56487.0, 56905.14642280369, 1529.4111766969797, 1535.9555502258347, 1537.4157820028317, 1540.7457769468137, 1553.5184092931227, 32109.357812843144, 32408.351832962737, 32770.1807454806, 33013.01460296072, 33171.66828331686, 53149.0, 53684.46315536794, 53775.0, 54001.45998539964, 54197.72901135469, 427550.0, 429883.0, 433930.0, 434640.0, 436109.0, 30006.099817005525, 30060.0, 30509.694903050684, 30643.693563064084, 30681.8465907669, 47185.76407117942, 47293.527064728914, 47831.5216847827, 48115.27827082667, 48552.5144748548, 40828.38757418701, 41393.79303103586, 41444.0, 41591.0, 42369.576304236565, 40281.1943761129, 40618.1876362477, 41170.38244426276, 42104.3684344729, 42207.788961055, 41375.37936931009, 42320.5767942329, 42369.788151059045, 42429.363559546015, 42629.57370426256, 35035.824820876755, 35615.22455522062, 35835.62191042177, 36873.63126368702, 37352.43971340486, 29024.605842077206, 29187.562186566793, 29346.119616411543, 29563.40873182567, 29611.40777184487], "value": 19615.946365379546, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [420.4303169205728, 423.4326003155771, 425.71902544320756, 433.5187941385062, 436.5721592839018, 14396.712065758704, 18520.166592503338, 19025.0, 19029.143688534015, 19396.127174277157, 18654.25382984679, 18684.906575467103, 18837.52906177346, 18899.62200755984, 18936.62126757464, 5412.296401467804, 5501.14732216507, 5691.800786972457, 5735.283089613798, 5750.453706897838, 5679.829605111853, 5702.65784052956, 5712.343080545749, 5713.571482138836, 5714.599978001542, 5633.267675202238, 5665.575081868856, 5871.29544454666, 5871.88256234875, 5890.5582081343855, 5820.35976042635, 5837.766489340443, 5839.357670656224, 5841.766329346821, 5884.235049443566, 5591.245181900432, 5654.63244889085, 5659.151127330892, 5798.536117110621, 5809.070548712186, 13501.797473037912, 13668.589942301747, 13733.0, 18202.271909123618, 22048.88975555112, 2441.6581678565017, 2452.9754702452924, 2458.21337172105, 2472.2336075816556, 2567.5763499022637, 9944.900550994469, 10004.59981600735, 10250.436226007567, 10278.22913281507, 10323.58705651773, 2036.8981550922394, 2050.302897015022, 2070.8446866485074, 2122.193566444741, 2145.8927053647412, 79647.6017619914, 82890.0, 83484.58257708672, 84989.57505212496, 85190.0, 10981.231313808117, 11012.559497620166, 11027.338359698444, 11103.112470879809, 11225.382603956697, 15409.229538523254, 15436.45972390961, 15534.533963981099, 15564.922175389278, 15599.298031588605, 8203.466774659628, 8453.985521737432, 8712.69505567302, 8743.868841967376, 8934.106589341143, 8818.86771698425, 8840.160184782564, 8856.8671469928, 8928.331850909573, 8997.775055623662, 4689.460712018094, 4766.666333356632, 4786.0, 4809.951900480951, 4840.83057093, 1985.1563085688524, 1985.1959956217754, 2028.8681235719926, 2070.7411573553304, 2078.002558771798, 1023.2070145637191, 1063.7074804428844, 1102.8400881872083, 1120.2606279855256, 1132.7621199548187, 17047.40334088301, 17320.91339543294, 18039.188236529386, 18837.90581047086, 18976.81023189778, 1080.5731735964407, 1082.929609575375, 1085.3325204998869, 1122.8708698499777, 1144.2905398652888, 10462.581496740046, 10778.838317425245, 10805.729856753487, 10829.0, 11017.0, 381289.0, 383662.0, 391090.0, 393466.0, 465414.0, 61376.69311653413, 64533.0, 94989.0, 102225.48887255516, 106913.72345106109, 1090.9727256818485, 1118.983215251772, 1124.522078116797, 1129.7062763681502, 1134.5858761551974, 17139.0, 17288.481345559652, 17321.826781732023, 17365.523930466054, 17509.912450437667, 38599.0, 39148.0, 40496.1900761989, 40729.796351018056, 40898.59101408948, 52677.20984185317, 58743.4125658738, 59428.40571594229, 60445.69777151086, 60544.0, 8267.379946504156, 8430.15698430152, 8497.320214382959, 8701.042885282488, 8720.215180633773, 12196.695082623006, 13072.607821765363, 13511.594652160451, 13839.654008649864, 13862.722745545234, 11673.12451566119, 11689.766204675689, 11713.180077394842, 12078.33569153705, 12238.265704057785, 11423.428828558373, 11471.426428678365, 11494.655160345203, 11778.528858845893, 11825.290482571074, 12006.459709313276, 12082.214656047328, 12115.0, 12232.816507752568, 12510.56213032576, 8727.694530691395, 8752.124787521198, 8903.910960890309, 8915.643374265217, 8989.41568798026, 9940.900590993997, 11822.113341499595, 11989.34058626749, 12008.279503229485, 12010.519579216734], "value": 9240.879517787711, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1543.1744016950931, 1588.6743217640385, 1771.2088799796552, 1881.3415304643377, 1886.0852486544031, 7604.543727376361, 7886.723964661238, 8028.718994835182, 8089.5955202239875, 8322.625481853316, 7576.204498527658, 8197.631106600202, 8401.57992100394, 8454.873176902336, 8558.871616925735, 2391.473875747337, 2414.9758502414925, 2421.2736179146273, 2426.890789914449, 2438.341647755105, 2355.9411014724683, 2407.5425669122897, 2414.263649586875, 2430.647556104364, 2441.8046556275453, 2405.1581946318825, 2410.8312418130736, 2417.830751847371, 2433.537627850703, 2440.3533063738123, 2436.415260337524, 2436.5492383908945, 2438.036975394718, 2440.0849681369486, 2443.9511209775706, 2401.3036219496325, 2406.5066661334386, 2439.9390015249583, 2442.658027876099, 2449.1795248591743, 8756.299496040301, 8811.0, 8822.514761688104, 8823.955880220621, 8857.070007649168, 5408.513233808976, 5465.9180112298345, 5475.151351540518, 5518.227448157261, 5528.198411230349, 3405.0465869556565, 3453.0, 3486.18074752433, 3517.613062563116, 3529.982350088259, 1058.8941105889426, 1062.4634559547455, 1068.0761141612527, 1075.0324707762998, 1077.978440431187, 11796.823047654207, 11829.467673954692, 11843.526258949632, 11859.703507412298, 11866.0, 4738.952610473852, 4758.1673207188605, 4764.547368000034, 4789.95210047902, 4830.178869592178, 10189.0, 10206.336588121749, 10209.132223761064, 10217.13154381886, 10220.693379198636, 5402.37872644643, 5411.891762164734, 5445.809396671098, 5451.727413629303, 5455.072637651609, 4253.234417804825, 4916.680415772963, 4988.226824842155, 5001.024800163933, 5007.649464537448, 4195.958040419557, 4232.851850185229, 4236.279832428495, 4255.212785634668, 4301.311790113629, 1347.5418357758408, 1383.764759990804, 1393.1849867827232, 1393.8954578406458, 1403.0529392659914, 850.2432834777053, 926.6154545863391, 969.6703120938914, 981.7840075183448, 1038.8441733739999, 5630.8029218977135, 5753.108268218432, 5796.217510636095, 5839.5036421904615, 5957.165996760457, 446.37730366139056, 460.54636183359366, 463.98376056838526, 466.27028700084935, 466.4030041546758, 3686.889393318151, 3755.6244375562774, 3765.077555998798, 3765.5104836371643, 3799.145192331703, 10667.73330666724, 10822.512986915608, 10912.127029837595, 11047.668569942914, 11056.336619802838, 9939.55272012761, 10195.898041019644, 10646.574137034588, 10715.0, 10729.678109656723, 7945.364370850318, 7998.680052797823, 8098.109207987117, 8132.430729848854, 8153.633086511121, 5802.883942321215, 5862.472377486047, 5883.441073098049, 5944.791932282349, 6001.939980600138, 8912.643494260416, 8978.640854365753, 8999.0, 9024.232940200156, 9193.954030230074, 9234.584443699916, 9324.347295689236, 9406.623735050522, 9592.136707696342, 9772.462514561767, 7127.322904324081, 7509.0, 7712.421568382506, 8048.39637027237, 8152.0, 7981.082175549654, 8019.478733882279, 8029.116797152192, 8087.595620218848, 8088.272055515032, 7310.415166786538, 7389.556626602421, 7497.737579184703, 7521.8871716923195, 7602.239776022354, 7048.083749112788, 7087.7164913402885, 7109.893351599627, 7128.857422851617, 7149.177844547944, 6505.902411463737, 6540.738370465128, 6540.771073012422, 6593.868122637425, 6596.3073877244115, 4749.620030397629, 4779.641526885428, 4780.330753694416, 4809.615230781459, 4843.249296358929, 5024.271480635361, 5027.0, 5040.773165207501, 5079.517445842639, 5156.226566014978], "value": 4509.618386467845, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.04619895872816, 365.1091337137385, 365.84451608066576, 370.7275152762721, 373.63943794238537, 6351.682415879205, 6395.648239346846, 6438.8390290242705, 6461.418472337488, 6482.319356467562, 6538.444232240254, 6593.142891424108, 6607.33926607339, 6619.205695316557, 6633.734650613969, 5064.0, 5070.695758254498, 5072.51811077948, 5078.847634570969, 5079.111155547783, 5084.13569693153, 5084.898302033957, 5087.567556757662, 5091.949080509203, 5097.515736005093, 5037.370328708911, 5049.4193167785625, 5049.747512624373, 5054.620903432239, 5057.342545469084, 4741.478437371887, 4901.730404827733, 5039.622028347871, 5048.95517315486, 5050.166722490784, 4215.768132752697, 4221.02916329246, 4246.384274280243, 4248.723832950848, 4248.957510424918, 6144.0783882417545, 6166.784162554334, 6218.31598524162, 6223.68881555925, 6280.937190628081, 5572.052751032294, 5745.511631511326, 5754.568407369464, 5770.451807078362, 5771.365149833515, 6851.0, 6876.518643694943, 6889.724411023553, 6895.069165662621, 6899.103116594861, 4758.666893317469, 4759.8814278644495, 4764.737939413331, 4769.54689304519, 4770.379850619432, 7153.892691609578, 7225.674844632004, 7252.492325537214, 7252.52858564197, 7264.8910266346575, 4712.387389639325, 4746.833860814855, 4770.546798054179, 4778.283257511332, 4788.497207793132, 4838.153323168432, 4855.684380515326, 4856.490068542823, 4860.465348811628, 4861.683990540603, 5685.260916080883, 5688.829335119953, 5689.118186681071, 5694.003549378842, 5702.45826646468, 6918.5502942308585, 6953.374196322254, 6997.195322537973, 7003.544769590062, 7013.2986701329455, 1700.8979461232366, 1719.243532845569, 1729.956751081233, 1730.0398278955302, 1731.7315816048533, 1052.21609900623, 1078.1374900079904, 1112.2881355932047, 1120.9551617935354, 1138.8348689439986, 6629.1382120325015, 6776.593404395752, 6791.0, 6799.3200679931615, 6846.520743548003, 7281.017062696574, 7292.598907060163, 7304.5982470963545, 7304.817379565553, 7308.123025237006, 6752.291009443938, 6782.220044694924, 6839.93160068393, 6857.622830744357, 6923.792286231421, 3884.7863367515056, 3923.2741942740686, 3939.2318497892634, 3943.408488726714, 3959.425883246913, 7397.816349384073, 7456.217097204824, 7486.925130748623, 7499.400047996147, 7519.924800751923, 7276.490645654859, 7376.262373762581, 7380.557166570023, 7382.409407247407, 7395.371393431511, 7429.777106686808, 7432.405407567381, 7432.777016689508, 7439.442041846775, 7449.366803821627, 7086.893696594659, 7230.24082471354, 7250.274972502919, 7263.0921134858145, 7265.346118849329, 7198.748043818441, 7216.3505284524645, 7223.916412538161, 7238.710451581877, 7250.057492525938, 7399.741009064657, 7532.472726909064, 7548.509346892434, 7552.8867066995135, 7575.280348366897, 4786.425628924551, 4797.136515427256, 4797.616190704665, 4803.375561177025, 4818.229083346648, 6971.128608923885, 7200.531965422231, 7228.241034691282, 7230.566166030055, 7261.092363454568, 7005.0893383859775, 7026.789196324118, 7031.191412987572, 7033.894491582732, 7058.54119482232, 7006.544574602838, 7011.719531218694, 7019.052427922165, 7022.824429389306, 7069.0, 6843.692033858588, 6895.207051189177, 6904.13698287714, 6905.205901321412, 6905.930940690529, 6941.271166527644, 7072.328128827753, 7076.858462830612, 7086.255943125898, 7091.82270443243, 6758.729650814109, 6919.308069193041, 6920.446364290945, 6922.688479018356, 6923.446124310144], "value": 5235.102591042136, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [819.30768500617, 855.597869001569, 866.8959724833016, 915.3455279475174, 943.8820147481565, 15647.53057408278, 15935.123568203759, 15937.0, 15943.0, 15969.920150399232, 14808.703825923476, 14810.407583696666, 14811.703765924702, 14845.92577037116, 14852.33164507597, 733.7395224695223, 863.5811631358786, 892.0767006148637, 897.4435849773117, 900.7027680865332, 884.3544212724714, 890.8841850559418, 894.311380237217, 898.9685361012366, 899.3704406915153, 950.5769932380093, 952.1240458777906, 952.6951375559823, 954.1269738189549, 957.0286159548065, 935.5462600638684, 938.9154976052188, 943.3679434778714, 943.6131186213654, 948.2840455456121, 694.1115372323384, 694.4444444444475, 696.4080531548194, 700.3031983176771, 701.9754308599225, 15583.688326233412, 15625.687486250325, 15631.062136271747, 15637.374505019785, 15640.0, 15004.924975375054, 15200.923995380062, 15222.543323700307, 15338.309776060105, 15387.230638468032, 11901.912682741991, 12017.459214335377, 12086.0, 12117.151799374047, 12389.628311150589, 4100.118474527961, 4122.154958233555, 4175.081482073939, 4292.763897985609, 4308.095299987007, 55106.0, 55725.0, 56255.71872140654, 58540.41459585392, 59191.0, 12168.269903805623, 12313.815292770616, 12494.75010499785, 12646.367681615882, 12653.746925061447, 21759.238426654993, 21826.89086554557, 21845.0, 21850.125994960024, 21954.78045219559, 9138.314626402913, 9262.39794413361, 9463.668771592962, 9550.235981121494, 9597.136257736836, 4992.201247800334, 5064.873378165576, 5117.565006974449, 5136.563392111638, 5200.869978250574, 3558.395072837624, 3575.94636080459, 3584.874529391459, 3589.856405743741, 3607.9458808117897, 710.2577806192542, 727.9708811647474, 736.0578459571757, 740.9036825212796, 749.1871319618275, 740.5963749756396, 815.7063457155419, 825.781167990483, 836.4061516323478, 857.8927634045745, 9725.367851089799, 9929.751756206153, 10367.481625918674, 10521.894781052244, 10630.840537391945, 762.9810689651799, 805.1063319715112, 809.1503920883049, 809.7813590330578, 820.5486982159788, 4555.2256116460285, 4772.856814295576, 4786.569208771228, 4834.613230941516, 4851.690043688184, 63005.36994629995, 64141.0, 64456.0, 64712.352876471574, 64739.67630161913, 54838.0, 56191.43808561862, 56764.43235567674, 57679.0, 58559.0, 51137.48862511327, 51769.48230517722, 51982.0, 52715.47284527183, 52807.471925281025, 9445.527723613654, 9508.809823803347, 9516.85724714116, 9620.230381569598, 9659.0, 38552.614473854905, 39949.0, 40144.7992760046, 40834.1833163341, 40883.182336353704, 43317.566824331356, 48452.7577362111, 48675.5132448671, 49364.50635493599, 49757.50242497674, 11066.170037247399, 11458.255213411101, 11748.35384053851, 12192.268463892195, 12289.1397602167, 12963.092583519441, 13513.986451016017, 13647.0, 13772.380242888894, 14365.0, 12710.936445317715, 13254.271015094262, 13439.798403023768, 13580.253086079965, 13860.099093559289, 13462.124961877447, 13499.527516536875, 13574.117682350616, 13578.93210533941, 13708.451661933412, 12138.211016283913, 12982.285974271128, 13148.03745766066, 13728.862711372758, 13773.517926872511, 11147.944260278648, 11274.206119227016, 11764.35296058725, 11779.352135632622, 12045.698857528632, 11120.44397780124, 11459.484323205643, 11656.475458604213, 11830.112741544246, 11867.109966752356], "value": 7323.995728996348, "unit": "score"}], "name": "dromaeo_css", "value": 7484.470049322329, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 102.0, 113.0, 112.0, 113.0, 102.0, 109.0, 109.0, 110.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 131.0, 156.0, 185.0, 132.0, 152.0, 163.0, 143.0, 181.0, 129.0], "value": 152.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 162.0, 166.0, 162.0, 164.0, 162.0, 163.0, 162.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 77.0, 175.0, 79.0, 78.0, 73.0, 74.0, 167.0, 75.0], "value": 94.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 148.0, 91.0, 93.0, 93.0, 140.0, 93.0, 93.0, 142.0], "value": 107.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 146.0, 146.0, 149.0, 146.0, 146.0, 146.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 94.0, 95.0, 95.0, 96.0, 95.0, 94.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 55.0, 58.0, 61.0, 55.0, 60.0, 79.0, 54.0, 55.0], "value": 58.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 60.0, 60.0, 59.0, 60.0, 60.0, 60.0, 59.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 81.0, 82.0, 73.0, 75.0, 73.0, 75.0, 73.0, 75.0, 75.0], "value": 75.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 114.0, 117.0, 117.0, 114.0, 114.0, 123.0, 114.0, 131.0, 128.0], "value": 118.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 168.0, 165.0, 167.0, 164.0, 161.0, 162.0, 166.0, 158.0], "value": 163.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 69.0, 67.0, 68.0, 66.0, 67.0, 66.0, 65.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1529.1999999999998, "alertThreshold": 2.0}]} 08:38:15 INFO - Return code: 0 08:38:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:38:15 ERROR - # TBPL SUCCESS # 08:38:15 INFO - Running post-action listener: _resource_record_post_action 08:38:15 INFO - Running post-run listener: _resource_record_post_run 08:38:16 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 266240; Write bytes: 499810304; Read time: 32; Write time: 514748 08:38:16 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 240037888; Read time: 0; Write time: 336608 08:38:16 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 266240; Write bytes: 250458112; Read time: 32; Write time: 166220 08:38:16 INFO - Running post-run listener: _upload_blobber_files 08:38:16 INFO - Blob upload gear active. 08:38:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:38:16 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:38:16 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:38:16 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:38:17 INFO - (blobuploader) - INFO - Open directory for files ... 08:38:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:38:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:38:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:38:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:38:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:38:17 INFO - (blobuploader) - INFO - Done attempting. 08:38:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:38:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:38:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:38:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:38:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:38:18 INFO - (blobuploader) - INFO - Done attempting. 08:38:18 INFO - (blobuploader) - INFO - Iteration through files over. 08:38:18 INFO - Return code: 0 08:38:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:38:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:38:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f18daa492881196b9cc168c784c8f46febff7bbb296621fbd803b4f035c5e39396b0acc0c2711b8fc38dc47d745079ffe6860aa2fa55bc5a7388ef8015b66482", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/841b932f0ef7fd1b402f522cf1d2150b78b7dd11c68df875873a0e696372d6ab9f797d4c6e8074b6795401af4ccd3de0d2aeff67593cfafa6ac4a32537bb8345"} 08:38:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:38:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:38:18 INFO - Contents: 08:38:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f18daa492881196b9cc168c784c8f46febff7bbb296621fbd803b4f035c5e39396b0acc0c2711b8fc38dc47d745079ffe6860aa2fa55bc5a7388ef8015b66482", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/841b932f0ef7fd1b402f522cf1d2150b78b7dd11c68df875873a0e696372d6ab9f797d4c6e8074b6795401af4ccd3de0d2aeff67593cfafa6ac4a32537bb8345"} 08:38:18 INFO - Running post-run listener: copy_logs_to_upload_dir 08:38:18 INFO - Copying logs to upload dir... 08:38:18 INFO - mkdir: /builds/slave/test/build/upload/logs 08:38:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1225.544150 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-05-30 08:38:18.581141) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 08:38:18.584999) ========= 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=db0483c52d987ecb441a263b000001ad-1464621471.910958-297576215 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f18daa492881196b9cc168c784c8f46febff7bbb296621fbd803b4f035c5e39396b0acc0c2711b8fc38dc47d745079ffe6860aa2fa55bc5a7388ef8015b66482", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/841b932f0ef7fd1b402f522cf1d2150b78b7dd11c68df875873a0e696372d6ab9f797d4c6e8074b6795401af4ccd3de0d2aeff67593cfafa6ac4a32537bb8345"} 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.011767 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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f18daa492881196b9cc168c784c8f46febff7bbb296621fbd803b4f035c5e39396b0acc0c2711b8fc38dc47d745079ffe6860aa2fa55bc5a7388ef8015b66482", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/841b932f0ef7fd1b402f522cf1d2150b78b7dd11c68df875873a0e696372d6ab9f797d4c6e8074b6795401af4ccd3de0d2aeff67593cfafa6ac4a32537bb8345"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 08:38:18.612199) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 08:38:18.612600) ========= 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=db0483c52d987ecb441a263b000001ad-1464621471.910958-297576215 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004421 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 08:38:18.697876) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 08:38:18.698252) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 08:38:18.698624) ========= ========= Total master_lag: 0.19 =========