builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-014 starttime: 1464615373.93 results: success (0) buildid: 20160530035543 builduid: 865ed214ad954ae683a81bd20aaeb948 revision: 04934785596476f6dd8baccc355202aeba59af35 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 06:36:13.925815) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 06:36:13.926282) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 06:36:13.926577) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 06:36:13.944155) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 06:36:13.944491) ========= 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=31acecf42b6a79ec49471d4a000001bb-1464615055.95255-1303475682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-30 06:36:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 88.6M=0s 2016-05-30 06:36:14 (88.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119390 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 06:36:14.088932) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 06:36:14.089250) ========= 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=31acecf42b6a79ec49471d4a000001bb-1464615055.95255-1303475682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013684 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 06:36:14.139611) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 06:36:14.140181) ========= 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=31acecf42b6a79ec49471d4a000001bb-1464615055.95255-1303475682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-30 06:36:14,261 truncating revision to first 12 chars 2016-05-30 06:36:14,261 Setting DEBUG logging. 2016-05-30 06:36:14,261 attempt 1/10 2016-05-30 06:36:14,261 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 06:36:14,728 unpacking tar archive at: mozilla-aurora-049347855964/testing/mozharness/ program finished with exit code 0 elapsedTime=0.803454 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 06:36:14.959136) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 06:36:14.959709) ========= script_repo_revision: 04934785596476f6dd8baccc355202aeba59af35 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 06:36:14.960357) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 06:36:14.960770) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 06:36:14.973478) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-05-30 06:36:14.974135) ========= /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=31acecf42b6a79ec49471d4a000001bb-1464615055.95255-1303475682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:36:15 INFO - MultiFileLogger online at 20160530 06:36:15 in /builds/slave/test 06:36:15 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 06:36:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:36:15 INFO - {'append_to_log': False, 06:36:15 INFO - 'base_work_dir': '/builds/slave/test', 06:36:15 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:36:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:36:15 INFO - 'branch': 'Mozilla-Aurora', 06:36:15 INFO - 'buildbot_json_path': 'buildprops.json', 06:36:15 INFO - 'config_files': ('talos/linux_config.py',), 06:36:15 INFO - 'default_actions': ('clobber', 06:36:15 INFO - 'read-buildbot-config', 06:36:15 INFO - 'download-and-extract', 06:36:15 INFO - 'populate-webroot', 06:36:15 INFO - 'create-virtualenv', 06:36:15 INFO - 'install', 06:36:15 INFO - 'run-tests'), 06:36:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:36:15 INFO - 'download_minidump_stackwalk': True, 06:36:15 INFO - 'download_symbols': 'ondemand', 06:36:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:36:15 INFO - 'tooltool.py': '/tools/tooltool.py', 06:36:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:36:15 INFO - '/tools/misc-python/virtualenv.py')}, 06:36:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:36:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:36:15 INFO - 'installer_path': 'installer.exe', 06:36:15 INFO - 'log_level': 'info', 06:36:15 INFO - 'log_name': 'talos', 06:36:15 INFO - 'log_to_console': True, 06:36:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:36:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:36:15 INFO - 'opt_config_files': (), 06:36:15 INFO - 'pip_index': False, 06:36:15 INFO - 'sps_profile': False, 06:36:15 INFO - 'sps_profile_interval': 0, 06:36:15 INFO - 'suite': 'dromaeojs-e10s', 06:36:15 INFO - 'system_bits': '32', 06:36:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:36:15 INFO - 'title': 'talos-linux64-ix-014', 06:36:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:36:15 INFO - 'use_talos_json': True, 06:36:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:36:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:36:15 INFO - 'work_dir': 'build'} 06:36:15 INFO - ##### 06:36:15 INFO - ##### Running clobber step. 06:36:15 INFO - ##### 06:36:15 INFO - Running pre-action listener: _resource_record_pre_action 06:36:15 INFO - Running main action method: clobber 06:36:15 INFO - rmtree: /builds/slave/test/build 06:36:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:36:15 INFO - Running post-action listener: _resource_record_post_action 06:36:15 INFO - ##### 06:36:15 INFO - ##### Running read-buildbot-config step. 06:36:15 INFO - ##### 06:36:15 INFO - Running pre-action listener: _resource_record_pre_action 06:36:15 INFO - Running main action method: read_buildbot_config 06:36:15 INFO - Using buildbot properties: 06:36:15 INFO - { 06:36:15 INFO - "project": "", 06:36:15 INFO - "product": "firefox", 06:36:15 INFO - "script_repo_revision": "production", 06:36:15 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 06:36:15 INFO - "repository": "", 06:36:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 06:36:15 INFO - "buildid": "20160530035543", 06:36:15 INFO - "pgo_build": "True", 06:36:15 INFO - "basedir": "/builds/slave/test", 06:36:15 INFO - "buildnumber": 338, 06:36:15 INFO - "slavename": "talos-linux64-ix-014", 06:36:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:36:15 INFO - "platform": "ubuntu64_hw", 06:36:15 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 06:36:15 INFO - "branch": "mozilla-aurora", 06:36:15 INFO - "repo_path": "releases/mozilla-aurora", 06:36:15 INFO - "revision": "04934785596476f6dd8baccc355202aeba59af35", 06:36:15 INFO - "stage_platform": "linux64-pgo", 06:36:15 INFO - "builduid": "865ed214ad954ae683a81bd20aaeb948", 06:36:15 INFO - "slavebuilddir": "test" 06:36:15 INFO - } 06:36:15 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. 06:36:15 INFO - Running post-action listener: _resource_record_post_action 06:36:15 INFO - ##### 06:36:15 INFO - ##### Running download-and-extract step. 06:36:15 INFO - ##### 06:36:15 INFO - Running pre-action listener: _resource_record_pre_action 06:36:15 INFO - Running main action method: download_and_extract 06:36:15 INFO - mkdir: /builds/slave/test/build/tests 06:36: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')]} 06:36:15 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 06:36:15 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 06:36:15 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 06:36:15 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 06:36:15 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 06:36:16 INFO - Downloaded 1361 bytes. 06:36:16 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 06:36:16 INFO - Using the following test package requirements: 06:36:16 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 06:36:16 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:36:16 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 06:36:16 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:36:16 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 06:36:16 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:36:16 INFO - u'jsshell-linux-x86_64.zip'], 06:36:16 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:36:16 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 06:36:16 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 06:36:16 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:36:16 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 06:36:16 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:36:16 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 06:36:16 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:36:16 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 06:36:16 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:36:16 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 06:36:16 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:36:16 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')]} 06:36:16 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 06:36:16 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 06:36:16 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 06:36:16 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 06:36:16 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 06:36:19 INFO - Downloaded 24135385 bytes. 06:36:19 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'] 06:36:19 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 06:36:21 INFO - Return code: 0 06:36:21 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 06:36:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:21 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 06:36:21 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 06:36:21 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 06:36:21 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 06:36:21 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 06:36:24 INFO - Downloaded 24135385 bytes. 06:36:24 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'] 06:36:24 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 06:36:25 INFO - Return code: 0 06:36: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')]} 06:36:25 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 06:36:25 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 06:36:25 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 06:36:25 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 06:36:25 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 06:36:27 INFO - Downloaded 10840145 bytes. 06:36:27 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'] 06:36:27 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 06:36:27 INFO - Return code: 0 06:36:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:27 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 06:36:27 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 06:36:27 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 06:36:27 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 06:36:27 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 06:36:30 INFO - Downloaded 62736116 bytes. 06:36:30 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 06:36:30 INFO - mkdir: /builds/slave/test/properties 06:36:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:36:30 INFO - Writing to file /builds/slave/test/properties/build_url 06:36:30 INFO - Contents: 06:36:30 INFO - build_url:https://queue.taskcluster.net/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 06:36:31 INFO - Running post-action listener: _resource_record_post_action 06:36:31 INFO - Running post-action listener: set_extra_try_arguments 06:36:31 INFO - ##### 06:36:31 INFO - ##### Running populate-webroot step. 06:36:31 INFO - ##### 06:36:31 INFO - Running pre-action listener: _resource_record_pre_action 06:36:31 INFO - Running main action method: populate_webroot 06:36:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:36:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:36:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:36:31 INFO - '--tppagecycles', 06:36:31 INFO - '7'], 06:36:31 INFO - 'tests': ['tsvgm']}}, 06:36:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:36:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:36:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:36:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:36:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:36:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:36:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:31 INFO - 'talos_options': ['--disable-e10s'], 06:36:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:36:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:36:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:31 INFO - 'talos_options': ['--disable-e10s'], 06:36:31 INFO - 'tests': ['damp', 'tps']}, 06:36:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:31 INFO - 'tests': ['damp', 'tps']}, 06:36:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:36:31 INFO - 'tests': ['dromaeo_dom']}, 06:36:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:36:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:36:31 INFO - 'tests': ['a11yr', 06:36:31 INFO - 'ts_paint', 06:36:31 INFO - 'tpaint', 06:36:31 INFO - 'sessionrestore', 06:36:31 INFO - 'sessionrestore_no_auto_restore', 06:36:31 INFO - 'tabpaint']}, 06:36:31 INFO - 'other-e10s': {'tests': ['a11yr', 06:36:31 INFO - 'ts_paint', 06:36:31 INFO - 'tpaint', 06:36:31 INFO - 'sessionrestore', 06:36:31 INFO - 'sessionrestore_no_auto_restore', 06:36:31 INFO - 'tabpaint']}, 06:36:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:36:31 INFO - 'ts_paint', 06:36:31 INFO - 'tpaint', 06:36:31 INFO - 'sessionrestore', 06:36:31 INFO - 'sessionrestore_no_auto_restore', 06:36:31 INFO - 'tabpaint']}, 06:36:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:36:31 INFO - 'ts_paint', 06:36:31 INFO - 'tpaint', 06:36:31 INFO - 'sessionrestore', 06:36:31 INFO - 'sessionrestore_no_auto_restore', 06:36:31 INFO - 'tabpaint']}, 06:36:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:36:31 INFO - 'tests': ['a11yr', 06:36:31 INFO - 'ts_paint', 06:36:31 INFO - 'tpaint', 06:36:31 INFO - 'sessionrestore', 06:36:31 INFO - 'sessionrestore_no_auto_restore', 06:36:31 INFO - 'tabpaint']}, 06:36:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:36:31 INFO - 'tests': ['a11yr', 06:36:31 INFO - 'ts_paint', 06:36:31 INFO - 'tpaint', 06:36:31 INFO - 'sessionrestore', 06:36:31 INFO - 'sessionrestore_no_auto_restore', 06:36:31 INFO - 'tabpaint']}, 06:36:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:36:31 INFO - 'tests': ['tsvgx', 06:36:31 INFO - 'tsvgr_opacity', 06:36:31 INFO - 'tart', 06:36:31 INFO - 'tscrollx', 06:36:31 INFO - 'cart']}, 06:36:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:36:31 INFO - 'tsvgr_opacity', 06:36:31 INFO - 'tart', 06:36:31 INFO - 'tscrollx', 06:36:31 INFO - 'cart']}, 06:36:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:31 INFO - 'talos_options': ['--disable-e10s'], 06:36:31 INFO - 'tests': ['tp5o']}, 06:36:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:31 INFO - 'tests': ['tp5o']}, 06:36:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:31 INFO - 'talos_options': ['--disable-e10s', 06:36:31 INFO - '--xperf_path', 06:36:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:36:31 INFO - 'tests': ['tp5n']}, 06:36:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:31 INFO - 'talos_options': ['--xperf_path', 06:36:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:36:31 INFO - 'tests': ['tp5n']}}, 06:36:31 INFO - 'talos.zip': {'path': '', 06:36:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:36:31 INFO - Running post-action listener: _resource_record_post_action 06:36:31 INFO - ##### 06:36:31 INFO - ##### Running create-virtualenv step. 06:36:31 INFO - ##### 06:36:31 INFO - Running pre-action listener: _resource_record_pre_action 06:36:31 INFO - Running main action method: create_virtualenv 06:36:31 INFO - Creating virtualenv /builds/slave/test/build/venv 06:36:31 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 06:36:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:36:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:36:31 INFO - Using real prefix '/usr' 06:36:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:36:31 INFO - Installing distribute.............................................................................................................................................................................................done. 06:36:33 INFO - Installing pip.................done. 06:36:33 INFO - Return code: 0 06:36:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:36:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:33 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 0x7f42ed472f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2133410>, '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 0x2134310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21347a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1464615055.95255-1303475682', '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 06:36:33 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 06:36:33 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 06:36:33 INFO - Using env: {'DISPLAY': ':0', 06:36:33 INFO - 'HOME': '/home/cltbld', 06:36:33 INFO - 'LANG': 'en_US.UTF-8', 06:36:33 INFO - 'LANGUAGE': 'en_US:en', 06:36:33 INFO - 'LOGNAME': 'cltbld', 06:36:33 INFO - 'MAIL': '/var/mail/cltbld', 06:36:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:33 INFO - 'MOZ_NO_REMOTE': '1', 06:36:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:33 INFO - 'NO_EM_RESTART': '1', 06:36:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:33 INFO - 'PWD': '/builds/slave/test', 06:36:33 INFO - 'SHELL': '/bin/bash', 06:36:33 INFO - 'SHLVL': '1', 06:36:33 INFO - 'TERM': 'linux', 06:36:33 INFO - 'TMOUT': '86400', 06:36:33 INFO - 'USER': 'cltbld', 06:36:33 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1464615055.95255-1303475682', 06:36:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:33 INFO - '_': '/tools/buildbot/bin/python'} 06:36:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:34 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 06:36:34 INFO - Cleaning up... 06:36:34 INFO - Return code: 0 06:36:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:36:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f42ed472f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2133410>, '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 0x2134310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21347a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1464615055.95255-1303475682', '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 06:36:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 06:36:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:36:34 INFO - Using env: {'DISPLAY': ':0', 06:36:34 INFO - 'HOME': '/home/cltbld', 06:36:34 INFO - 'LANG': 'en_US.UTF-8', 06:36:34 INFO - 'LANGUAGE': 'en_US:en', 06:36:34 INFO - 'LOGNAME': 'cltbld', 06:36:34 INFO - 'MAIL': '/var/mail/cltbld', 06:36:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:34 INFO - 'MOZ_NO_REMOTE': '1', 06:36:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:34 INFO - 'NO_EM_RESTART': '1', 06:36:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:34 INFO - 'PWD': '/builds/slave/test', 06:36:34 INFO - 'SHELL': '/bin/bash', 06:36:34 INFO - 'SHLVL': '1', 06:36:34 INFO - 'TERM': 'linux', 06:36:34 INFO - 'TMOUT': '86400', 06:36:34 INFO - 'USER': 'cltbld', 06:36:34 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1464615055.95255-1303475682', 06:36:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:34 INFO - '_': '/tools/buildbot/bin/python'} 06:36:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:34 INFO - Downloading/unpacking psutil>=0.7.1 06:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:36:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:36:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:36:36 INFO - Installing collected packages: psutil 06:36:36 INFO - Running setup.py install for psutil 06:36:36 INFO - building 'psutil._psutil_linux' extension 06:36:36 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 06:36:36 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 06:36:36 INFO - building 'psutil._psutil_posix' extension 06:36:36 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 06:36:36 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 06:36:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:36:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:36:36 INFO - Successfully installed psutil 06:36:36 INFO - Cleaning up... 06:36:36 INFO - Return code: 0 06:36:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:36:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f42ed472f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2133410>, '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 0x2134310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21347a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1464615055.95255-1303475682', '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 06:36:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 06:36:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:36:36 INFO - Using env: {'DISPLAY': ':0', 06:36:36 INFO - 'HOME': '/home/cltbld', 06:36:36 INFO - 'LANG': 'en_US.UTF-8', 06:36:36 INFO - 'LANGUAGE': 'en_US:en', 06:36:36 INFO - 'LOGNAME': 'cltbld', 06:36:36 INFO - 'MAIL': '/var/mail/cltbld', 06:36:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:36 INFO - 'MOZ_NO_REMOTE': '1', 06:36:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:36 INFO - 'NO_EM_RESTART': '1', 06:36:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:36 INFO - 'PWD': '/builds/slave/test', 06:36:36 INFO - 'SHELL': '/bin/bash', 06:36:36 INFO - 'SHLVL': '1', 06:36:36 INFO - 'TERM': 'linux', 06:36:36 INFO - 'TMOUT': '86400', 06:36:36 INFO - 'USER': 'cltbld', 06:36:36 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1464615055.95255-1303475682', 06:36:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:36 INFO - '_': '/tools/buildbot/bin/python'} 06:36:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:36:37 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 06:36:37 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 06:36:37 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 06:36:37 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 06:36:37 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 06:36:37 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 06:36:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:36:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:36:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:36:39 INFO - Installing collected packages: mozsystemmonitor 06:36:39 INFO - Running setup.py install for mozsystemmonitor 06:36:39 INFO - Successfully installed mozsystemmonitor 06:36:39 INFO - Cleaning up... 06:36:39 INFO - Return code: 0 06:36:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:36:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:39 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 0x7f42ed472f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2133410>, '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 0x2134310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21347a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1464615055.95255-1303475682', '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 06:36:39 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 06:36:39 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 06:36:39 INFO - Using env: {'DISPLAY': ':0', 06:36:39 INFO - 'HOME': '/home/cltbld', 06:36:39 INFO - 'LANG': 'en_US.UTF-8', 06:36:39 INFO - 'LANGUAGE': 'en_US:en', 06:36:39 INFO - 'LOGNAME': 'cltbld', 06:36:39 INFO - 'MAIL': '/var/mail/cltbld', 06:36:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:39 INFO - 'MOZ_NO_REMOTE': '1', 06:36:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:39 INFO - 'NO_EM_RESTART': '1', 06:36:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:39 INFO - 'PWD': '/builds/slave/test', 06:36:39 INFO - 'SHELL': '/bin/bash', 06:36:39 INFO - 'SHLVL': '1', 06:36:39 INFO - 'TERM': 'linux', 06:36:39 INFO - 'TMOUT': '86400', 06:36:39 INFO - 'USER': 'cltbld', 06:36:39 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1464615055.95255-1303475682', 06:36:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:39 INFO - '_': '/tools/buildbot/bin/python'} 06:36:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:39 INFO - Downloading/unpacking blobuploader==1.2.4 06:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:41 INFO - Downloading blobuploader-1.2.4.tar.gz 06:36:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:36:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:36:41 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 06:36:41 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 06:36:41 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 06:36:41 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 06:36:41 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 06:36:41 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 06:36:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:36:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:36:41 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 06:36:41 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 06:36:41 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 06:36:41 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 06:36:41 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 06:36:41 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 06:36:41 INFO - Downloading docopt-0.6.1.tar.gz 06:36:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:36:42 INFO - Installing collected packages: blobuploader, requests, docopt 06:36:42 INFO - Running setup.py install for blobuploader 06:36:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:36:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:36:42 INFO - Running setup.py install for requests 06:36:42 INFO - Running setup.py install for docopt 06:36:42 INFO - Successfully installed blobuploader requests docopt 06:36:42 INFO - Cleaning up... 06:36:42 INFO - Return code: 0 06:36:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:36:42 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')]} 06:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:42 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')]} 06:36:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:42 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 0x7f42ed472f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2133410>, '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 0x2134310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21347a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1464615055.95255-1303475682', '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 06:36:42 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 06:36:42 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 06:36:42 INFO - Using env: {'DISPLAY': ':0', 06:36:42 INFO - 'HOME': '/home/cltbld', 06:36:42 INFO - 'LANG': 'en_US.UTF-8', 06:36:42 INFO - 'LANGUAGE': 'en_US:en', 06:36:42 INFO - 'LOGNAME': 'cltbld', 06:36:42 INFO - 'MAIL': '/var/mail/cltbld', 06:36:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:42 INFO - 'MOZ_NO_REMOTE': '1', 06:36:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:42 INFO - 'NO_EM_RESTART': '1', 06:36:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:42 INFO - 'PWD': '/builds/slave/test', 06:36:42 INFO - 'SHELL': '/bin/bash', 06:36:42 INFO - 'SHLVL': '1', 06:36:42 INFO - 'TERM': 'linux', 06:36:42 INFO - 'TMOUT': '86400', 06:36:42 INFO - 'USER': 'cltbld', 06:36:42 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1464615055.95255-1303475682', 06:36:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:42 INFO - '_': '/tools/buildbot/bin/python'} 06:36:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:36:42 INFO - Running setup.py (path:/tmp/pip-0TpA90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:36:42 INFO - Running setup.py (path:/tmp/pip-pr2v4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:36:42 INFO - Running setup.py (path:/tmp/pip-HDqDGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:36:43 INFO - Running setup.py (path:/tmp/pip-88ocoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:36:43 INFO - Running setup.py (path:/tmp/pip-3YN2b9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:36:43 INFO - Running setup.py (path:/tmp/pip-EhwWHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:36:43 INFO - Running setup.py (path:/tmp/pip-5O8V2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:36:43 INFO - Running setup.py (path:/tmp/pip-_p3nOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:36:43 INFO - Running setup.py (path:/tmp/pip-eZ4yOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:36:43 INFO - Running setup.py (path:/tmp/pip-KXERIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:36:43 INFO - Running setup.py (path:/tmp/pip-M1Cbsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:36:43 INFO - Running setup.py (path:/tmp/pip-IqDToX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:36:43 INFO - Running setup.py (path:/tmp/pip-9zpJ1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:36:43 INFO - Running setup.py (path:/tmp/pip-Pt8nXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:36:43 INFO - Running setup.py (path:/tmp/pip-ROEquH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:36:43 INFO - Running setup.py (path:/tmp/pip-Vel2Xy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:36:43 INFO - Running setup.py (path:/tmp/pip-rLg16T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:36:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:36:44 INFO - Running setup.py install for manifestparser 06:36:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:36:44 INFO - Running setup.py install for mozcrash 06:36:44 INFO - Running setup.py install for mozdebug 06:36:44 INFO - Running setup.py install for mozdevice 06:36:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:36:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:36:44 INFO - Running setup.py install for mozfile 06:36:44 INFO - Running setup.py install for mozhttpd 06:36:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:36:44 INFO - Running setup.py install for mozinfo 06:36:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:36:44 INFO - Running setup.py install for mozInstall 06:36:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:36:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:36:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:36:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:36:44 INFO - Running setup.py install for mozleak 06:36:44 INFO - Running setup.py install for mozlog 06:36:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:36:45 INFO - Running setup.py install for moznetwork 06:36:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:36:45 INFO - Running setup.py install for mozprocess 06:36:45 INFO - Running setup.py install for mozprofile 06:36:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:36:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:36:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:36:45 INFO - Running setup.py install for mozrunner 06:36:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:36:45 INFO - Running setup.py install for mozscreenshot 06:36:45 INFO - Running setup.py install for moztest 06:36:45 INFO - Running setup.py install for mozversion 06:36:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:36:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:36:45 INFO - Cleaning up... 06:36:45 INFO - Return code: 0 06:36:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:36:45 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')]} 06:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:45 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')]} 06:36:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:45 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 0x7f42ed472f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2133410>, '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 0x2134310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21347a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1464615055.95255-1303475682', '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 06:36:45 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 06:36:45 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 06:36:45 INFO - Using env: {'DISPLAY': ':0', 06:36:45 INFO - 'HOME': '/home/cltbld', 06:36:45 INFO - 'LANG': 'en_US.UTF-8', 06:36:45 INFO - 'LANGUAGE': 'en_US:en', 06:36:45 INFO - 'LOGNAME': 'cltbld', 06:36:45 INFO - 'MAIL': '/var/mail/cltbld', 06:36:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:45 INFO - 'MOZ_NO_REMOTE': '1', 06:36:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:45 INFO - 'NO_EM_RESTART': '1', 06:36:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:45 INFO - 'PWD': '/builds/slave/test', 06:36:45 INFO - 'SHELL': '/bin/bash', 06:36:45 INFO - 'SHLVL': '1', 06:36:45 INFO - 'TERM': 'linux', 06:36:45 INFO - 'TMOUT': '86400', 06:36:45 INFO - 'USER': 'cltbld', 06:36:45 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1464615055.95255-1303475682', 06:36:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:45 INFO - '_': '/tools/buildbot/bin/python'} 06:36:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:36:46 INFO - Running setup.py (path:/tmp/pip-RpXozR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:36:46 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)) 06:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:36:46 INFO - Running setup.py (path:/tmp/pip-oTJp5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:36:46 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)) 06:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:36:46 INFO - Running setup.py (path:/tmp/pip-EDxzZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:36:46 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)) 06:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:36:46 INFO - Running setup.py (path:/tmp/pip-MoQ2hr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:36:46 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)) 06:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:36:46 INFO - Running setup.py (path:/tmp/pip-tcDiXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:36:46 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)) 06:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:36:46 INFO - Running setup.py (path:/tmp/pip-JR7Urm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:36:46 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)) 06:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:36:46 INFO - Running setup.py (path:/tmp/pip-cV5UaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:36:46 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)) 06:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:36:46 INFO - Running setup.py (path:/tmp/pip-6L4AFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:36:46 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)) 06:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:36:46 INFO - Running setup.py (path:/tmp/pip-PNikIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:36:46 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)) 06:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:36:46 INFO - Running setup.py (path:/tmp/pip-Y22mU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:36:46 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)) 06:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:36:46 INFO - Running setup.py (path:/tmp/pip-txHfHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:36:46 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)) 06:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:36:46 INFO - Running setup.py (path:/tmp/pip-IljaAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:36:46 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)) 06:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:36:46 INFO - Running setup.py (path:/tmp/pip-qkgnrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:36:47 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)) 06:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:36:47 INFO - Running setup.py (path:/tmp/pip-3C3MAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:36:47 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)) 06:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:36:47 INFO - Running setup.py (path:/tmp/pip-3fbdPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:36:47 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)) 06:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:36:47 INFO - Running setup.py (path:/tmp/pip-Wdrdce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:36:47 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)) 06:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:36:47 INFO - Running setup.py (path:/tmp/pip-w25fLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:36:47 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)) 06:36:47 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)) 06:36:47 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)) 06:36:47 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)) 06:36:47 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)) 06:36:47 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)) 06:36:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:36:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:49 INFO - Downloading blessings-1.6.tar.gz 06:36:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:36:49 INFO - Installing collected packages: blessings 06:36:49 INFO - Running setup.py install for blessings 06:36:49 INFO - Successfully installed blessings 06:36:49 INFO - Cleaning up... 06:36:49 INFO - Return code: 0 06:36:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:36:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:36:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:36:49 INFO - Reading from file tmpfile_stdout 06:36:49 INFO - Current package versions: 06:36:49 INFO - argparse == 1.2.1 06:36:49 INFO - blessings == 1.6 06:36:49 INFO - blobuploader == 1.2.4 06:36:49 INFO - docopt == 0.6.1 06:36:49 INFO - manifestparser == 1.1 06:36:49 INFO - mozInstall == 1.12 06:36:49 INFO - mozcrash == 0.17 06:36:49 INFO - mozdebug == 0.1 06:36:49 INFO - mozdevice == 0.48 06:36:49 INFO - mozfile == 1.2 06:36:49 INFO - mozhttpd == 0.7 06:36:49 INFO - mozinfo == 0.9 06:36:49 INFO - mozleak == 0.1 06:36:49 INFO - mozlog == 3.1 06:36:49 INFO - moznetwork == 0.27 06:36:49 INFO - mozprocess == 0.22 06:36:49 INFO - mozprofile == 0.28 06:36:49 INFO - mozrunner == 6.11 06:36:49 INFO - mozscreenshot == 0.1 06:36:49 INFO - mozsystemmonitor == 0.0 06:36:49 INFO - moztest == 0.7 06:36:49 INFO - mozversion == 1.4 06:36:49 INFO - psutil == 3.1.1 06:36:49 INFO - requests == 1.2.3 06:36:49 INFO - wsgiref == 0.1.2 06:36:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:36:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:49 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 0x7f42ed472f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2133410>, '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 0x2134310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21347a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1464615055.95255-1303475682', '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 06:36:49 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 06:36:49 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 06:36:49 INFO - Using env: {'DISPLAY': ':0', 06:36:49 INFO - 'HOME': '/home/cltbld', 06:36:49 INFO - 'LANG': 'en_US.UTF-8', 06:36:49 INFO - 'LANGUAGE': 'en_US:en', 06:36:49 INFO - 'LOGNAME': 'cltbld', 06:36:49 INFO - 'MAIL': '/var/mail/cltbld', 06:36:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:49 INFO - 'MOZ_NO_REMOTE': '1', 06:36:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:49 INFO - 'NO_EM_RESTART': '1', 06:36:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:49 INFO - 'PWD': '/builds/slave/test', 06:36:49 INFO - 'SHELL': '/bin/bash', 06:36:49 INFO - 'SHLVL': '1', 06:36:49 INFO - 'TERM': 'linux', 06:36:49 INFO - 'TMOUT': '86400', 06:36:49 INFO - 'USER': 'cltbld', 06:36:49 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1464615055.95255-1303475682', 06:36:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:49 INFO - '_': '/tools/buildbot/bin/python'} 06:36:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:49 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)) 06:36:49 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)) 06:36:49 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)) 06:36:49 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)) 06:36:49 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)) 06:36:49 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)) 06:36:49 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)) 06:36:49 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)) 06:36:49 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)) 06:36:49 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)) 06:36:49 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)) 06:36:49 INFO - Cleaning up... 06:36:49 INFO - Return code: 0 06:36:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:36:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f42ed472f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2133410>, '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 0x2134310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21347a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1464615055.95255-1303475682', '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 06:36:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:36:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:36:49 INFO - Using env: {'DISPLAY': ':0', 06:36:49 INFO - 'HOME': '/home/cltbld', 06:36:49 INFO - 'LANG': 'en_US.UTF-8', 06:36:49 INFO - 'LANGUAGE': 'en_US:en', 06:36:49 INFO - 'LOGNAME': 'cltbld', 06:36:49 INFO - 'MAIL': '/var/mail/cltbld', 06:36:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:49 INFO - 'MOZ_NO_REMOTE': '1', 06:36:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:49 INFO - 'NO_EM_RESTART': '1', 06:36:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:49 INFO - 'PWD': '/builds/slave/test', 06:36:49 INFO - 'SHELL': '/bin/bash', 06:36:49 INFO - 'SHLVL': '1', 06:36:49 INFO - 'TERM': 'linux', 06:36:49 INFO - 'TMOUT': '86400', 06:36:49 INFO - 'USER': 'cltbld', 06:36:49 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1464615055.95255-1303475682', 06:36:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:49 INFO - '_': '/tools/buildbot/bin/python'} 06:36:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:50 INFO - Downloading/unpacking jsonschema 06:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:36:51 INFO - Downloading/unpacking functools32 (from jsonschema) 06:36:51 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 06:36:51 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 06:36:51 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 06:36:51 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 06:36:51 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 06:36:51 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 06:36:52 INFO - Downloading functools32-3.2.3-2.tar.gz 06:36:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:36:52 INFO - warning: no files found matching '*.txt' 06:36:52 INFO - no previously-included directories found matching 'build' 06:36:52 INFO - no previously-included directories found matching 'dist' 06:36:52 INFO - no previously-included directories found matching '.git*' 06:36:52 INFO - Installing collected packages: jsonschema, functools32 06:36:52 INFO - Running setup.py install for functools32 06:36:52 INFO - warning: no files found matching '*.txt' 06:36:52 INFO - no previously-included directories found matching 'build' 06:36:52 INFO - no previously-included directories found matching 'dist' 06:36:52 INFO - no previously-included directories found matching '.git*' 06:36:52 INFO - Successfully installed jsonschema functools32 06:36:52 INFO - Cleaning up... 06:36:52 INFO - Return code: 0 06:36:52 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:36:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:36:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f42ed472f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2133410>, '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 0x2134310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21347a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1464615055.95255-1303475682', '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 06:36:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 06:36:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:36:52 INFO - Using env: {'DISPLAY': ':0', 06:36:52 INFO - 'HOME': '/home/cltbld', 06:36:52 INFO - 'LANG': 'en_US.UTF-8', 06:36:52 INFO - 'LANGUAGE': 'en_US:en', 06:36:52 INFO - 'LOGNAME': 'cltbld', 06:36:52 INFO - 'MAIL': '/var/mail/cltbld', 06:36:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:52 INFO - 'MOZ_NO_REMOTE': '1', 06:36:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:52 INFO - 'NO_EM_RESTART': '1', 06:36:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:52 INFO - 'PWD': '/builds/slave/test', 06:36:52 INFO - 'SHELL': '/bin/bash', 06:36:52 INFO - 'SHLVL': '1', 06:36:52 INFO - 'TERM': 'linux', 06:36:52 INFO - 'TMOUT': '86400', 06:36:52 INFO - 'USER': 'cltbld', 06:36:52 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1464615055.95255-1303475682', 06:36:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:52 INFO - '_': '/tools/buildbot/bin/python'} 06:36:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:52 INFO - Downloading/unpacking flake8 06:36:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:36:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:36:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:36:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:36:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:36:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:36:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:36:55 INFO - no previously-included directories found matching 'docs/_build' 06:36:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:36:55 INFO - Running setup.py install for pep8 06:36:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:36:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:36:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:36:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:36:55 INFO - no previously-included directories found matching 'docs/_build' 06:36:55 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:36:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:36:55 INFO - Cleaning up... 06:36:55 INFO - Return code: 0 06:36:55 INFO - Running post-action listener: _resource_record_post_action 06:36:55 INFO - Running post-action listener: _start_resource_monitoring 06:36:55 INFO - Starting resource monitoring. 06:36:55 INFO - ##### 06:36:55 INFO - ##### Running install step. 06:36:55 INFO - ##### 06:36:55 INFO - Running pre-action listener: _resource_record_pre_action 06:36:55 INFO - Running main action method: install 06:36:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:36:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:36:55 INFO - Reading from file tmpfile_stdout 06:36:55 INFO - Detecting whether we're running mozinstall >=1.0... 06:36:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:36:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:36:55 INFO - Reading from file tmpfile_stdout 06:36:55 INFO - Output received: 06:36:55 INFO - Usage: mozinstall [options] installer 06:36:55 INFO - Options: 06:36:55 INFO - -h, --help show this help message and exit 06:36:55 INFO - -d DEST, --destination=DEST 06:36:55 INFO - Directory to install application into. [default: 06:36:55 INFO - "/builds/slave/test"] 06:36:55 INFO - --app=APP Application being installed. [default: firefox] 06:36:55 INFO - mkdir: /builds/slave/test/build/application 06:36:55 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'] 06:36:55 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 06:37:11 INFO - Reading from file tmpfile_stdout 06:37:11 INFO - Output received: 06:37:11 INFO - /builds/slave/test/build/application/firefox/firefox 06:37:11 INFO - Running post-action listener: _resource_record_post_action 06:37:11 INFO - ##### 06:37:11 INFO - ##### Running run-tests step. 06:37:11 INFO - ##### 06:37:11 INFO - Running pre-action listener: _resource_record_pre_action 06:37:11 INFO - Running main action method: run_tests 06:37:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:37:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:37:11 INFO - Python 2.7.3 06:37:11 INFO - Return code: 0 06:37:11 INFO - grabbing minidump binary from tooltool 06:37: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')]} 06:37:11 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 0x2133410>, '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 0x2134310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21347a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:37:11 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 06:37:11 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 06:37:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:37:11 INFO - Return code: 0 06:37:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:37:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:37:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:37:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:37:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:37:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:37:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:37:12 INFO - Return code: 0 06:37:12 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-014', '--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 06:37:12 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-014 --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 06:37:12 INFO - Using env: {'DISPLAY': ':0', 06:37:12 INFO - 'HOME': '/home/cltbld', 06:37:12 INFO - 'LANG': 'en_US.UTF-8', 06:37:12 INFO - 'LANGUAGE': 'en_US:en', 06:37:12 INFO - 'LOGNAME': 'cltbld', 06:37:12 INFO - 'MAIL': '/var/mail/cltbld', 06:37:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:37:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:37:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:12 INFO - 'MOZ_NO_REMOTE': '1', 06:37:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:37:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:37:12 INFO - 'NO_EM_RESTART': '1', 06:37:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:37:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:12 INFO - 'PWD': '/builds/slave/test', 06:37:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:37:12 INFO - 'SHELL': '/bin/bash', 06:37:12 INFO - 'SHLVL': '1', 06:37:12 INFO - 'TERM': 'linux', 06:37:12 INFO - 'TMOUT': '86400', 06:37:12 INFO - 'USER': 'cltbld', 06:37:12 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1464615055.95255-1303475682', 06:37:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:12 INFO - '_': '/tools/buildbot/bin/python'} 06:37:12 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-014', '--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 06:37:12 INFO - mozversion application_buildid: 20160530035543 06:37:12 INFO - mozversion application_changeset: 04934785596476f6dd8baccc355202aeba59af35 06:37:12 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:37:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:37:12 INFO - mozversion application_name: Firefox 06:37:12 INFO - mozversion application_remotingname: firefox-dev 06:37:12 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:37:12 INFO - mozversion application_vendor: Mozilla 06:37:12 INFO - mozversion application_version: 48.0a2 06:37:12 INFO - mozversion platform_buildid: 20160530035543 06:37:12 INFO - mozversion platform_changeset: 04934785596476f6dd8baccc355202aeba59af35 06:37:12 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:37:12 INFO - mozversion platform_version: 48.0a2 06:37:12 INFO - using testdate: 1464615432 06:37:12 INFO - actual date: 1464615432 06:37:12 INFO - starting webserver on 'localhost:50738' 06:37:12 INFO - SUITE-START | Running 2 tests 06:37:12 INFO - TEST-START | dromaeo_css 06:37:12 INFO - operating with platform_type : linux_ 06:37:12 INFO - Initialising browser for dromaeo_css test... 06:37:12 INFO - TEST-INFO | started process 9214 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYNzDia/profile http://localhost:50738/getInfo.html) 06:37:15 INFO - PROCESS | 9214 | 06:37:15 INFO - PROCESS | 9214 | (process:9292): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:37:16 INFO - PROCESS | 9214 | __metrics Screen width/height:1600/1200 06:37:16 INFO - PROCESS | 9214 | colorDepth:24 06:37:16 INFO - PROCESS | 9214 | Browser inner width/height: 1024/697 06:37:16 INFO - PROCESS | 9214 | __metrics 06:37:17 ERROR - PROCESS | 9214 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 06:37:18 INFO - TEST-INFO | 9214: exit 0 06:37:18 INFO - Browser initialized. 06:37:18 INFO - Running cycle 1/1 for dromaeo_css test... 06:37:18 INFO - TEST-INFO | started process 9343 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYNzDia/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:37:20 INFO - PROCESS | 9343 | 06:37:20 INFO - PROCESS | 9343 | (process:9410): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:37:30 INFO - PROCESS | 9343 | RSS: Main: 152231936 06:37:30 INFO - PROCESS | 9343 | 06:38:19 INFO - PROCESS | 9343 | 1464615499590 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] 06:40:27 INFO - PROCESS | 9343 | Cycle 1(1): loaded http://localhost:50738/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50738/tests/dromaeo/cssquery-ext.html) 06:40:28 INFO - PROCESS | 9343 | RSS: Main: 156311552 06:40:28 INFO - PROCESS | 9343 | 06:43:30 INFO - PROCESS | 9343 | Cycle 1(1): loaded http://localhost:50738/tests/dromaeo/cssquery-ext.html (next: http://localhost:50738/tests/dromaeo/cssquery-jquery.html) 06:43:30 INFO - PROCESS | 9343 | RSS: Main: 153677824 06:43:30 INFO - PROCESS | 9343 | 06:46:32 INFO - PROCESS | 9343 | Cycle 1(1): loaded http://localhost:50738/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50738/tests/dromaeo/cssquery-mootools.html) 06:46:32 INFO - PROCESS | 9343 | RSS: Main: 153395200 06:46:32 INFO - PROCESS | 9343 | 06:49:34 INFO - PROCESS | 9343 | Cycle 1(1): loaded http://localhost:50738/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50738/tests/dromaeo/cssquery-prototype.html) 06:49:35 INFO - PROCESS | 9343 | RSS: Main: 153223168 06:49:35 INFO - PROCESS | 9343 | 06:52:37 INFO - PROCESS | 9343 | Cycle 1(1): loaded http://localhost:50738/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50738/tests/dromaeo/cssquery-yui.html) 06:52:38 INFO - PROCESS | 9343 | RSS: Main: 154517504 06:52:38 INFO - PROCESS | 9343 | 06:55:40 INFO - PROCESS | 9343 | Cycle 1(1): loaded http://localhost:50738/tests/dromaeo/cssquery-yui.html (next: http://localhost:50738/tests/dromaeo/cssquery-dojo.html) 06:55:40 INFO - PROCESS | 9343 | RSS: Main: 156008448 06:55:40 INFO - PROCESS | 9343 | 06:55:40 INFO - PROCESS | 9343 | __start_tp_report 06:55:40 INFO - PROCESS | 9343 | _x_x_mozilla_page_load 06:55:40 INFO - PROCESS | 9343 | _x_x_mozilla_page_load_details 06:55:40 INFO - PROCESS | 9343 | |i|pagename|runs| 06:55:40 INFO - PROCESS | 9343 | |0;dojo.html;3339.4489909164986;3401.2857299967013;3443.3629778490995;3464.514967904494;3474.5656792900886;5640.238567793342;5646.802361917334;5653.180288858113;5658.0381335173015;5682.034054210783;5615.410381909902;5690.772369105231;5706.914396284059;5709.229254050712;5723.771049158039;5184.688918664882;5195.116830138885;5242.423333433319;5277.70972596507;5309.203619457093;5068.5438310552045;5230.92153617696;5377.139657654776;5377.516023557879;5390.299261096072;5179.559737422323;5263.1578947368425;5264.473552644724;5275.551578115846;5291.735413229323;5213.58291336694;5236.7119808410525;5280.445553216895;5288.497592728723;5299.311089558371;4986.950130498685;5116.923246151311;5164.8967020659375;5189.455107213764;5196.506331898464;5454.481824226692;5468.699221542814;5486.835394938158;5496.697681627509;5512.145617429305;5981.760729570812;5988.520918326523;5997.310309314441;6000.729967151488;6003;5847.8245652630485;6019.187409699722;6051.001584738513;6068.059450785136;6140.6929653517145;5661.433856614347;5672.489475947144;5676.233708449389;5686.260786097822;5701.77192912283;6167.290761562478;6197.5351848611535;6213.2233470816145;6234.2830574483605;6253.46845518127;5937.317208521075;6014.1580178775;6035.366286539938;6037.366076561898;6072.635641861414;6057.757689692451;6091.543134264948;6098.1157732128595;6098.32918378978;6108.053251745987;5733.77064917407;6003.039513677791;6051.334353221142;6066.181065556182;6070.392960703983;6007.429294217042;6032.4570788629235;6035.155078288955;6045.425684559959;6089.482393996472;4546.772661366918;4580.633549316047;4603.263477843529;4614.307853821886;4621.792019359137;4047.453593764863;4139.8965025874595;4141;4145.481814773153;4182.393552934807;5624.29696287964;5703.116017017369;5721.914171287434;5807.941920580824;5819.359870414251;5929.318128415288;6008.3390827009;6032.185654936615;6111.008868573017;6137.723802428902;5808.651480911074;5826.1552074948895;5862.853428664317;5864.296284445809;5865;4915.65590408668;4984.700917944935;4998.500149984972;5080.54275115234;5087.643864929493;6286.151369565142;6299.401556852092;6305.211848518935;6305.991041433349;6315.36846315374;6059.727312271047;6138.048602466625;6144.631322120687;6144.815655530341;6152.261728592597;6111.083337499411;6181.783637572664;6280.8429789253805;6296;6299.779507717391;6044.727987240497;6045.21412216409;6054.3642917493025;6056.7274472649715;6090.512758979183;5909.468147866713;6137.1101190328045;6157.415045570664;6159.353267906805;6165.784197553064;5934.762609495745;5972.581919265784;5988.311344195473;5998.1002849572915;6046.939530604637;5914.260717410324;5928.258967629046;5981.880362392815;5983.461488466059;5991.910121348096;5657.462541058593;5786.971065144648;5889.941100589111;5914.497267732118;5919.644821310735;5955.583109182316;5991.161237426677;6004.939950600613;6028.909566356596;6038.456538911519;5857.297124345106;5869.148973398918;5870.765169393177;5876.647401155944;5888.676122813286 06:55:40 INFO - PROCESS | 9343 | |1;ext.html;612.1216054961131;649.7206201333424;662.1524448705657;665.4875745675827;673.0207548017635;39400;39416.80291598541;39491.60508394919;39601.60398396022;39650.40524392133;41943.370849437204;42511.78744106275;42557.78721106398;42682.359764603476;42709.14581708364;8745.956270218656;8886.289096872235;8902;8910.910890891106;8920.286377089817;8609.225169734722;8703.738887833344;8718.564071796385;8718.956405217965;8739.300855931542;8982.955085224565;8999.5050272235;9015.95492022539;9017.053209412983;9021.323400744937;8891.42205756627;8940.284777217872;8942.55287235639;8945.910540894572;8964.50695211763;8951.507667078307;9014.774630634287;9015.143561361725;9033.322500812465;9064.229540489066;42156.578434215575;43076.78461607672;43087.13825723468;43129.56870431287;43136.56863431388;3648.6351364863303;3905.160390516024;4278.951656844062;4348.130373925228;4685.554872287127;32520.5121923169;32612.510812337834;32988.67011329904;33345;33819.661803381896;4463.419755431773;4549.09018196362;4566.360709500673;4590.74750888701;4648.140094082605;272091;274660;275193;275261.62369188224;275900;38418.80790596029;39166.804165979556;61525;63020.68489657614;63034.36965630377;36991.260174796356;37096.629033709854;37158.8142059288;37194.8140259297;37299.62700372961;16656;16694.833051669328;16827.158642067847;16895.07077110746;16898;14832.258387080603;14865.2567371631;14904.403823847142;14911.627209319637;14919.552413427615;9199.77000574991;9223.815523689489;9309.95345023284;9329.440233586007;9362.06379362072;3483.494893240466;3612.223371975038;3640.5631324241263;3672.5225720656144;3696.039029852258;1094.392612100292;1133.5182547417314;1158.0330424095805;1181.5037684172669;1235.9073069519823;32352.867849075647;32448.675513245038;32872.83563582167;33274.3345133096;33530.66469335324;1202.0623913347604;1231.3043130631165;1242.3601845049807;1256.39065053449;1326.522451917309;16815.91592042032;17158.771602635832;17299.913500432416;17387.304507819797;17395.56511087233;479816;499213;585173;601083;602942;62072.37927620666;63324.36675633277;63340.683296584146;63495;63552.682236588524;1482.1551715522048;1517.5826647671759;1533.4326299269342;1547.860692537677;1553.650428653544;33184.834075829465;33594.32811343808;33828.815991440184;33962;34340.313193735485;54472.45527544674;54869.72565137149;55107.44892551023;55483.445165547826;55520.72239638776;460186;461984;462805;466083;466585;30469.23826904345;47126.76436617795;47306.76346618245;47450.52549474461;47588.28617570808;45698.77150614226;47468.52531474641;48307.275390869865;49458;50434.243486347;43297.35053974256;43770.343444848986;44083.779581103176;44250;45303;41323.58676413318;41695.37456938209;41990.79004604957;42103.36844947267;43148.78425607852;37859.24281514409;38138.0465488365;38458.80770596129;38848.80575597217;39109;32982.67017329892;33407.49888751719;33568.16079597932;33628;34042.31915361728;26709.332266692712;27009.189724308304;27141.86429067842;27405.31486712848;27738.583921240795 06:55:40 INFO - PROCESS | 9343 | |2;jquery.html;429.446014641113;431.2302539966161;431.7884236724006;436.4958472963726;440.80604534005033;18521.536961575966;18948;19165.520861978457;20176.495587610316;20843;19428.41714748556;19832.90083549584;19890.10494527746;19982.400527984184;19983.50041248966;5397.62216644835;5574.777008919638;5630.211770352154;5633.60564760467;5818.8254352369495;5559.63862348946;5622.212890195356;5655.4061823508555;5660.518855897254;5684.516816070618;5790.420957904218;5853.941460585404;5860.384659610722;5876.882462350751;5898.7640494380385;5382.6232163748555;5794.159846822208;5844.152597873306;5847.56143289255;5857.15071314657;5456.045192091368;5503.229547863302;5533.778648854041;5536.335639723259;5544.556435485151;20612.896935515375;21707.782922170732;23465.648015279785;23511.647325289963;23527.647085293735;2458.8370983137256;2471.2462698876834;2473.703155621319;2536.315194897386;2566.781823544982;10208.183345332356;10257.43584102874;10348.637797677045;10618.7257529097;10758.569657213702;2012.597480503905;2036.8166864982222;2037.9388618341472;2062.175129948018;2064.3600483849905;79583.60208198921;79637.60181199115;83838;84242.15757842404;84335.57832210799;10072.74818129538;10399.168066554657;10503.002214789583;10505.737356565995;10545;14653.633659158393;14761.114333140045;14798.112113273239;14874.256287185597;14925.850741492663;8063.354931605575;8357.495650782796;8373.204545568162;8482.915170848213;8518.23335899772;8181;8209.8358032839;8227.341812655093;8323.250907418362;8381.28759055475;4647.024124933734;4688.765561721901;4761.166795810719;4810.42274927011;4813.109574728686;1931.8749375686914;1954.0425191655986;1987.7415935928525;1990.5023744063983;2004.3586052463072;1003.5383723487132;1060.9814578005048;1110.3892858927557;1175.048210949134;1194.552042983881;18713.251469941322;18993.62012759737;19067.427977160707;19319.517012074528;19494.80505194958;1075.172117469544;1094.682542062793;1096.8848270931596;1111.644273832382;1144.5250221158126;10613.734656633645;10716.517756700967;10806.297590656739;10809.78380432387;10824.512896919658;472601;483692;490455;497944;504424;77081.61459192669;81519;81732;95082;96623.51688241513;1091.2688498705886;1108.4014632098576;1128.8983991440646;1156.4449064448943;1163.953441862333;17109.74335384995;17188.570285742957;17222.311107555557;17397.21712522914;17547.47357579275;38230.61769382271;38353;38988.41517377185;39805.80097099496;40384.3942340871;55436.16845747398;55758.72120639371;56564;56611.71694141503;56807.43192568021;8698.652053917773;8800.251978581637;8808.383413161017;8811.471311721318;8854.158854908774;11791.29252244868;13025.739485210432;13095.934520327719;13401.128926619738;13492.460301587827;11124.721881953015;11210.047145992681;11265.831012534982;11273.098152147644;11508.309501429942;11212.27120237182;11339.092872570009;11437.199396042197;11730.70673233176;11853.111016673956;11306;11585.6524304271;11680.123990700562;11758.176927614984;11800.409979500819;8306;8396.1603839618;8421.284190843848;8432.578371081545;8536.658533658832;11028.62142232221;11699.415029248334;11829.408529573315;11887.583934562248;11895.643130706092 06:55:40 INFO - PROCESS | 9343 | |3;mootools.html;1576.471881919557;1604.9746228359543;1767.4167524716845;1856.4616261284227;1866.1415748755571;7533.849323013536;8206.630701618427;8284.834303313937;8573.099824518422;8676.305895528358;8214.91785082149;8391.202835730612;8405.243528082487;8523.147685231474;8565.571721413935;2362.681038059857;2382.6664267002634;2401.7117945846435;2402.5795485790004;2404.062415657886;2426.211481268586;2426.3934016495878;2452.766987136219;2468.691413573303;2470.6047032474808;2423.612222044473;2435.208557218902;2437.6831011968507;2440.9511809763794;2446.926592202237;2436.634504824273;2441.292025312657;2469.950600987979;2472.752724727522;2480.2063339731203;2428.3322086426197;2476.603743401065;2515.283144303883;2526.280010197085;2526.759957804006;8583.699570515002;8688.826223475558;8710.564471776386;8712.78218044554;8736.126387361277;5197.506236907488;5270.789168433296;5302.73486325686;5345.518903298683;5348.679079255257;3546.3261980223674;3593.8921832345072;3603.7117030637487;3617.782933024027;3651.963480365189;1123.0622430270735;1130.2766229613055;1132.5356603792407;1146.6330774152275;1154.6766905266538;11361.772764544663;11437.199396042364;11475.196736228467;11525.884741152566;11535.134864885167;4640.860774176713;4665.510121437268;4748.19280722278;4792.2092854678585;4816.325714399987;9950.35322704022;9963.551640176209;9966.750831229132;9973.202143828476;10017.69946901594;5336.67979921206;5360.91958620621;5372.973135134299;5406.216098665672;5412.107002344569;4172.311568591149;4808.3989501312335;4879.609631229493;4925.187344088257;4927.531884470969;4178.080822219107;4181.644560212355;4196.748195108242;4207.200631879933;4260.424842646203;1314.7830607949772;1317.2096741954942;1326.1380102932978;1357.2128165663892;1384.3216823756286;1020.9030142136485;1024.5645600619707;1026.5124066068706;1027.4965267019106;1039.73486760877;5704.1443783432815;5874.265716785402;5939.465448109604;5977.073553599199;6116.052011938156;983.7343917142332;1034.7775228325795;1067.9199060070525;1100.7908497385472;1122.5117074072805;4303.655707543389;4324.610785029363;4366.716163449366;4369.69412141147;4384.846530371422;10363.170946324275;10866.565337386415;10868.076213521781;10885.564577416815;10888.510017049251;9911.355761875455;10162.898371016343;10611.363318200933;10624.415657138932;10630.840537391945;7826.647800848976;7845.960770196112;7881.330086942674;7911.011123609664;7924.128345881948;5635.605507614428;5679.858003549944;5741.885162296814;5789.218455508452;5879.235699359056;9007.819843603222;9095.272378209595;9122.179003889682;9195.218406435528;9202.401843880127;9121.270298375981;9210.263178945803;9247.583858726239;9277.536123193948;9311.72064838056;7078.858422831411;7773;7814.804629884298;7888.684452621831;8021.639026243716;7985.680572777024;7989.201079891965;8017.238362355567;8024.317932975762;8028.036635603765;7030.753923612649;7166.283371662792;7304.707811687473;7421;7434.888476672746;6950.20072691647;6993.580385176906;7051;7127.322904324081;7134.714611415485;6472.126262954441;6528.836779080371;6596.637184954873;6603.867922641424;6618.933810661832;4952.4057113146655;5015.874603134951;5068.543831055223;5068.771905264346;5130.333056702605;5097.235414687826;5150.742462876916;5181.455947125498;5232.816851410183;5276.841694749163 06:55:40 INFO - PROCESS | 9343 | |4;prototype.html;346.9757117001811;347.6558207374698;359.148817302992;362.3550080856076;363.8562767706756;6518.989556618726;6631.204255489342;6729.7308107675635;6734.191896972358;6739.797806065813;6594.703238354274;6599.505037122211;6615.272320044791;6618.007298905167;6622.337766223375;4806.591439727627;4931.926021109668;5012.573931215851;5037.622178336621;5038.8488345349515;5008.123578373788;5019.498050194988;5022.59819214462;5025.14572522672;5038.093143234217;4952.158133117378;4977.825776097838;4984.053029924321;4984.950150498503;4989.476105008976;5010.298558201855;5066.97466512667;5070.467600901908;5070.923936140961;5091.694498330112;4456.9331460028125;4477.462704475452;4478.8432404866;4479.865604031885;4484.058347746977;6060.848478788022;6335.809925702236;6358.173437453148;6387.4251317381195;6394.072859435356;5722;5722.055860782966;5734.541236701054;5758.078707406837;5781.739821708034;6823.795286141423;6919.757808476729;6935.68789404473;6947.096877405956;6958.5824850508625;4719.433667959833;4721.645876559238;4745.667803253774;4759.547842954914;4767.976160119212;7182.856342873166;7240.855182896313;7287.344139027513;7306.744263950736;7314.707411703525;4849.636277279218;4863.70817750929;4898.681585696918;4907.288443175719;4923.5814955729165;4926.8275610354185;4975.950240497621;4976.0794253063295;4976.178930476503;4986.252062190628;5731;5736.483716465538;5788.652680839163;5792.536597072224;5807.651540907559;7014.22843487216;7027.5080744348425;7032.296770322927;7032.824179395454;7036.92963070373;1736.2447335409138;1738.9043602601978;1757.349780581193;1757.3585641240854;1761.3747119772552;1108.9001989820792;1126.3129491010477;1131.5926266544038;1143.9542418303174;1152.6023521884936;6635.341164708822;6740.629265390353;6761.695723692347;6766.7969960901255;6768.661566921634;6964.233934267227;7082.752103676346;7147.463940204506;7175.605341706152;7187;6873.828154296182;6876.484263680144;6886.8622627547165;6888.207856096613;6893.827654308582;3922.3332033554366;3939.3106206413763;3968.3849003404516;3971.900702482461;3973.3642617181113;7519.285667861544;7524.435667324972;7574.583397913168;7576.090869095744;7590.544567325978;7327.487075904742;7455.739049133254;7464.664090115958;7464.850702986018;7471.8505629887095;7490.101187857492;7510;7534.924650753423;7554.055743032121;7554.773356799305;7313.341799238094;7319.45104117204;7319.707211711472;7319.817004574928;7322.524035937647;7175.703774792017;7186.1376634804155;7200.855982880418;7211.963940180265;7232.855342893007;7421;7450.180480147288;7541.698332066656;7545.207753185837;7554.697812087675;4904.730239836843;4923.261510773269;4933.679310844784;4936.2102063669645;4945.530174633404;7202.89195662076;7259.12890453149;7273;7277.126744790659;7285.2714728528845;7083.6812343443635;7083.964580177272;7085.39774119185;7090.149182098181;7112.502124851418;6915.170179578483;7014.614196219257;7036.964815175891;7045.577265364094;7070.292970702889;6843.8973415399805;6908.965455172692;6919;6929.549579277331;6947.548409353376;7095.645217739196;7104.218535961144;7105.857882842418;7110.288971102848;7128.649534718674;6908.205556361083;6910.654467276516;6924.376806087476;6937.132858392701;6938.479614029069 06:55:40 INFO - PROCESS | 9343 | |5;yui.html;826.2935190412198;858.7209157023965;889.5107690770075;897.811459593485;941.6986564299427;14829.480968166117;14914.925425372885;15020.624484387896;17426.3029478821;17727;14713.337899794507;14834.48079317224;14837.554873353789;14907.105573665587;14934.925325373359;734.7354952217197;870.5342641686683;879.4898958604026;887.5961437545933;898.4339865884483;890.1009979920294;890.8530092534724;895.5880295064246;895.7581453007684;897.1208215948375;934.3739694404732;936.3352020065762;936.9625214991393;942.3309450290302;942.4109931292942;925.9259259259243;930.2093220762332;931.9906800932006;935.4060171790894;936.4662142578733;681.4378138036091;684.4421796236102;685.1504134872772;686.1217641418991;686.2417029182731;16061.759073613905;16150.919245403698;16215.756763648555;16216.189190540426;16235.512934611981;14361.640958976004;14469.565913022521;14634.121952682766;14653.853461465356;14672.26638668073;12274.202176858476;12449.066320026035;12510;12525.43635536403;12758.936205319007;4044.090079732066;4052.5744796796207;4103.199876024177;4169.499660040815;4229.450171477688;57810.13284800731;58362;59555;59809.70095149496;60108.699456502436;11355.48900299472;11524.308541487537;11633.185677002528;11860.703482413008;11917.582884598998;20549.38351849447;20583.38249852507;20603;20610.175592976113;20679.17283308681;8628.741137765877;8643.438176518506;8716;8732.8690069649;8858.468491890508;4989.775460104304;5041.6470847040355;5067.619928505377;5089.643724939218;5104.668196567211;3723.255348930171;3756.8121593920196;3759.887203383903;3772.038130276817;3791.1469919267943;641.3490307338055;654.8068319845657;668.0313545359248;671.7648822912039;677.7797215904851;732.9890051649229;777.8833175023678;807.9757607271791;824.6330382979517;829.7925518620345;10081.395116293046;10416.270861039806;10428.478576071166;10470.947645261725;10523.947380263202;806.4596720197482;811.6778156317632;820.8399362124447;824.9133840946735;846.9661213551389;4770.976145119322;4789.936054503097;4794.232922732346;4855.854324370204;4963.379577552806;64205.357946420874;64541.35458645353;65000;65018;65516.67241663857;55828.441715582325;57424.712876436184;57602;57744.71127644335;57971.710141449024;49504;50131.74934125306;50862;52085;52745.73627131917;9927.40435573868;10289.639862604772;10332.845007325046;10396.792064158826;10652.946735266274;40140.3978940322;40248.396274055325;40346.59653403428;40493.1901361977;41073;44529.33206001978;47062;51959.48040519546;52672;53365.19952200643;12456.875431245571;12655.87344126547;12710.872891270968;12938.482460701467;12982.15615984958;13873.514426995007;14019.158850469004;14292.42830286777;14437.278136093364;14762.704745905237;13607.79588306196;13630.931845341107;13695.931520342334;13740.175589464665;13765.38055787472;13882.375293111632;13938.512152074629;14009.509667162009;14150.292485375485;14242.359093840594;12398.938005309916;13447.529336473177;13758.518451854137;13762.24307663088;14067.507637233057;10969.561217551527;11150.442477876237;11220.326780393203;11283.153763467937;11399.943000284946;11080.944595276973;11112.388818615054;11220.66338009861;11510.194286399872;11535.769284614093 06:55:40 INFO - PROCESS | 9343 | __end_tp_report 06:55:40 INFO - PROCESS | 9343 | __start_cc_report 06:55:40 INFO - PROCESS | 9343 | _x_x_mozilla_cycle_collect,317 06:55:40 INFO - PROCESS | 9343 | __end_cc_report 06:55:40 INFO - PROCESS | 9343 | __startTimestamp1464616540502__endTimestamp 06:55:40 INFO - PROCESS | 9343 | 06:55:40 INFO - PROCESS | 9343 | ------- Summary: start ------- 06:55:40 INFO - PROCESS | 9343 | Number of tests: 6 06:55:40 INFO - PROCESS | 9343 | 06:55:40 INFO - PROCESS | 9343 | [#0] dojo.html Cycles:165 Average:5646.43 Median:5876.65 stddev:628.43 (10.7%) stddev-sans-first:603.73 06:55:40 INFO - PROCESS | 9343 | Values: 3339.4 3401.3 3443.4 3464.5 3474.6 5640.2 5646.8 5653.2 5658.0 5682.0 5615.4 5690.8 5706.9 5709.2 5723.8 5184.7 5195.1 5242.4 5277.7 5309.2 5068.5 5230.9 5377.1 5377.5 5390.3 5179.6 5263.2 5264.5 5275.6 5291.7 5213.6 5236.7 5280.4 5288.5 5299.3 4987.0 5116.9 5164.9 5189.5 5196.5 5454.5 5468.7 5486.8 5496.7 5512.1 5981.8 5988.5 5997.3 6000.7 6003.0 5847.8 6019.2 6051.0 6068.1 6140.7 5661.4 5672.5 5676.2 5686.3 5701.8 6167.3 6197.5 6213.2 6234.3 6253.5 5937.3 6014.2 6035.4 6037.4 6072.6 6057.8 6091.5 6098.1 6098.3 6108.1 5733.8 6003.0 6051.3 6066.2 6070.4 6007.4 6032.5 6035.2 6045.4 6089.5 4546.8 4580.6 4603.3 4614.3 4621.8 4047.5 4139.9 4141.0 4145.5 4182.4 5624.3 5703.1 5721.9 5807.9 5819.4 5929.3 6008.3 6032.2 6111.0 6137.7 5808.7 5826.2 5862.9 5864.3 5865.0 4915.7 4984.7 4998.5 5080.5 5087.6 6286.2 6299.4 6305.2 6306.0 6315.4 6059.7 6138.0 6144.6 6144.8 6152.3 6111.1 6181.8 6280.8 6296.0 6299.8 6044.7 6045.2 6054.4 6056.7 6090.5 5909.5 6137.1 6157.4 6159.4 6165.8 5934.8 5972.6 5988.3 5998.1 6046.9 5914.3 5928.3 5981.9 5983.5 5991.9 5657.5 5787.0 5889.9 5914.5 5919.6 5955.6 5991.2 6004.9 6028.9 6038.5 5857.3 5869.1 5870.8 5876.6 5888.7 06:55:40 INFO - PROCESS | 9343 | 06:55:40 INFO - PROCESS | 9343 | [#1] ext.html Cycles:180 Average:58949.78 Median:42334.18 stddev:119017.74 (281.1%) stddev-sans-first:119271.02 06:55:40 INFO - PROCESS | 9343 | Values: 612.1 649.7 662.2 665.5 673.0 39400.0 39416.8 39491.6 39601.6 39650.4 41943.4 42511.8 42557.8 42682.4 42709.1 8746.0 8886.3 8902.0 8910.9 8920.3 8609.2 8703.7 8718.6 8719.0 8739.3 8983.0 8999.5 9016.0 9017.1 9021.3 8891.4 8940.3 8942.6 8945.9 8964.5 8951.5 9014.8 9015.1 9033.3 9064.2 42156.6 43076.8 43087.1 43129.6 43136.6 3648.6 3905.2 4279.0 4348.1 4685.6 32520.5 32612.5 32988.7 33345.0 33819.7 4463.4 4549.1 4566.4 4590.7 4648.1 272091.0 274660.0 275193.0 275261.6 275900.0 38418.8 39166.8 61525.0 63020.7 63034.4 36991.3 37096.6 37158.8 37194.8 37299.6 16656.0 16694.8 16827.2 16895.1 16898.0 14832.3 14865.3 14904.4 14911.6 14919.6 9199.8 9223.8 9310.0 9329.4 9362.1 3483.5 3612.2 3640.6 3672.5 3696.0 1094.4 1133.5 1158.0 1181.5 1235.9 32352.9 32448.7 32872.8 33274.3 33530.7 1202.1 1231.3 1242.4 1256.4 1326.5 16815.9 17158.8 17299.9 17387.3 17395.6 479816.0 499213.0 585173.0 601083.0 602942.0 62072.4 63324.4 63340.7 63495.0 63552.7 1482.2 1517.6 1533.4 1547.9 1553.7 33184.8 33594.3 33828.8 33962.0 34340.3 54472.5 54869.7 55107.4 55483.4 55520.7 460186.0 461984.0 462805.0 466083.0 466585.0 30469.2 47126.8 47306.8 47450.5 47588.3 45698.8 47468.5 48307.3 49458.0 50434.2 43297.4 43770.3 44083.8 44250.0 45303.0 41323.6 41695.4 41990.8 42103.4 43148.8 37859.2 38138.0 38458.8 38848.8 39109.0 32982.7 33407.5 33568.2 33628.0 34042.3 26709.3 27009.2 27141.9 27405.3 27738.6 06:55:40 INFO - PROCESS | 9343 | 06:55:40 INFO - PROCESS | 9343 | [#2] jquery.html Cycles:180 Average:28748.96 Median:21275.39 stddev:80673.43 (379.2%) stddev-sans-first:80871.71 06:55:40 INFO - PROCESS | 9343 | Values: 429.4 431.2 431.8 436.5 440.8 18521.5 18948.0 19165.5 20176.5 20843.0 19428.4 19832.9 19890.1 19982.4 19983.5 5397.6 5574.8 5630.2 5633.6 5818.8 5559.6 5622.2 5655.4 5660.5 5684.5 5790.4 5853.9 5860.4 5876.9 5898.8 5382.6 5794.2 5844.2 5847.6 5857.2 5456.0 5503.2 5533.8 5536.3 5544.6 20612.9 21707.8 23465.6 23511.6 23527.6 2458.8 2471.2 2473.7 2536.3 2566.8 10208.2 10257.4 10348.6 10618.7 10758.6 2012.6 2036.8 2037.9 2062.2 2064.4 79583.6 79637.6 83838.0 84242.2 84335.6 10072.7 10399.2 10503.0 10505.7 10545.0 14653.6 14761.1 14798.1 14874.3 14925.9 8063.4 8357.5 8373.2 8482.9 8518.2 8181.0 8209.8 8227.3 8323.3 8381.3 4647.0 4688.8 4761.2 4810.4 4813.1 1931.9 1954.0 1987.7 1990.5 2004.4 1003.5 1061.0 1110.4 1175.0 1194.6 18713.3 18993.6 19067.4 19319.5 19494.8 1075.2 1094.7 1096.9 1111.6 1144.5 10613.7 10716.5 10806.3 10809.8 10824.5 472601.0 483692.0 490455.0 497944.0 504424.0 77081.6 81519.0 81732.0 95082.0 96623.5 1091.3 1108.4 1128.9 1156.4 1164.0 17109.7 17188.6 17222.3 17397.2 17547.5 38230.6 38353.0 38988.4 39805.8 40384.4 55436.2 55758.7 56564.0 56611.7 56807.4 8698.7 8800.3 8808.4 8811.5 8854.2 11791.3 13025.7 13095.9 13401.1 13492.5 11124.7 11210.0 11265.8 11273.1 11508.3 11212.3 11339.1 11437.2 11730.7 11853.1 11306.0 11585.7 11680.1 11758.2 11800.4 8306.0 8396.2 8421.3 8432.6 8536.7 11028.6 11699.4 11829.4 11887.6 11895.6 06:55:40 INFO - PROCESS | 9343 | 06:55:40 INFO - PROCESS | 9343 | [#3] mootools.html Cycles:180 Average:5654.20 Median:5042.21 stddev:3032.35 (60.1%) stddev-sans-first:3025.37 06:55:40 INFO - PROCESS | 9343 | Values: 1576.5 1605.0 1767.4 1856.5 1866.1 7533.8 8206.6 8284.8 8573.1 8676.3 8214.9 8391.2 8405.2 8523.1 8565.6 2362.7 2382.7 2401.7 2402.6 2404.1 2426.2 2426.4 2452.8 2468.7 2470.6 2423.6 2435.2 2437.7 2441.0 2446.9 2436.6 2441.3 2470.0 2472.8 2480.2 2428.3 2476.6 2515.3 2526.3 2526.8 8583.7 8688.8 8710.6 8712.8 8736.1 5197.5 5270.8 5302.7 5345.5 5348.7 3546.3 3593.9 3603.7 3617.8 3652.0 1123.1 1130.3 1132.5 1146.6 1154.7 11361.8 11437.2 11475.2 11525.9 11535.1 4640.9 4665.5 4748.2 4792.2 4816.3 9950.4 9963.6 9966.8 9973.2 10017.7 5336.7 5360.9 5373.0 5406.2 5412.1 4172.3 4808.4 4879.6 4925.2 4927.5 4178.1 4181.6 4196.7 4207.2 4260.4 1314.8 1317.2 1326.1 1357.2 1384.3 1020.9 1024.6 1026.5 1027.5 1039.7 5704.1 5874.3 5939.5 5977.1 6116.1 983.7 1034.8 1067.9 1100.8 1122.5 4303.7 4324.6 4366.7 4369.7 4384.8 10363.2 10866.6 10868.1 10885.6 10888.5 9911.4 10162.9 10611.4 10624.4 10630.8 7826.6 7846.0 7881.3 7911.0 7924.1 5635.6 5679.9 5741.9 5789.2 5879.2 9007.8 9095.3 9122.2 9195.2 9202.4 9121.3 9210.3 9247.6 9277.5 9311.7 7078.9 7773.0 7814.8 7888.7 8021.6 7985.7 7989.2 8017.2 8024.3 8028.0 7030.8 7166.3 7304.7 7421.0 7434.9 6950.2 6993.6 7051.0 7127.3 7134.7 6472.1 6528.8 6596.6 6603.9 6618.9 4952.4 5015.9 5068.5 5068.8 5130.3 5097.2 5150.7 5181.5 5232.8 5276.8 06:55:40 INFO - PROCESS | 9343 | 06:55:40 INFO - PROCESS | 9343 | [#4] prototype.html Cycles:180 Average:5864.62 Median:6740.21 stddev:1788.98 (26.5%) stddev-sans-first:1745.40 06:55:40 INFO - PROCESS | 9343 | Values: 347.0 347.7 359.1 362.4 363.9 6519.0 6631.2 6729.7 6734.2 6739.8 6594.7 6599.5 6615.3 6618.0 6622.3 4806.6 4931.9 5012.6 5037.6 5038.8 5008.1 5019.5 5022.6 5025.1 5038.1 4952.2 4977.8 4984.1 4985.0 4989.5 5010.3 5067.0 5070.5 5070.9 5091.7 4456.9 4477.5 4478.8 4479.9 4484.1 6060.8 6335.8 6358.2 6387.4 6394.1 5722.0 5722.1 5734.5 5758.1 5781.7 6823.8 6919.8 6935.7 6947.1 6958.6 4719.4 4721.6 4745.7 4759.5 4768.0 7182.9 7240.9 7287.3 7306.7 7314.7 4849.6 4863.7 4898.7 4907.3 4923.6 4926.8 4976.0 4976.1 4976.2 4986.3 5731.0 5736.5 5788.7 5792.5 5807.7 7014.2 7027.5 7032.3 7032.8 7036.9 1736.2 1738.9 1757.3 1757.4 1761.4 1108.9 1126.3 1131.6 1144.0 1152.6 6635.3 6740.6 6761.7 6766.8 6768.7 6964.2 7082.8 7147.5 7175.6 7187.0 6873.8 6876.5 6886.9 6888.2 6893.8 3922.3 3939.3 3968.4 3971.9 3973.4 7519.3 7524.4 7574.6 7576.1 7590.5 7327.5 7455.7 7464.7 7464.9 7471.9 7490.1 7510.0 7534.9 7554.1 7554.8 7313.3 7319.5 7319.7 7319.8 7322.5 7175.7 7186.1 7200.9 7212.0 7232.9 7421.0 7450.2 7541.7 7545.2 7554.7 4904.7 4923.3 4933.7 4936.2 4945.5 7202.9 7259.1 7273.0 7277.1 7285.3 7083.7 7084.0 7085.4 7090.1 7112.5 6915.2 7014.6 7037.0 7045.6 7070.3 6843.9 6909.0 6919.0 6929.5 6947.5 7095.6 7104.2 7105.9 7110.3 7128.6 6908.2 6910.7 6924.4 6937.1 6938.5 06:55:40 INFO - PROCESS | 9343 | 06:55:40 INFO - PROCESS | 9343 | [#5] yui.html Cycles:180 Average:15957.65 Median:22588.10 stddev:18157.73 (80.4%) stddev-sans-first:18173.11 06:55:40 INFO - PROCESS | 9343 | Values: 826.3 858.7 889.5 897.8 941.7 14829.5 14914.9 15020.6 17426.3 17727.0 14713.3 14834.5 14837.6 14907.1 14934.9 734.7 870.5 879.5 887.6 898.4 890.1 890.9 895.6 895.8 897.1 934.4 936.3 937.0 942.3 942.4 925.9 930.2 932.0 935.4 936.5 681.4 684.4 685.2 686.1 686.2 16061.8 16150.9 16215.8 16216.2 16235.5 14361.6 14469.6 14634.1 14653.9 14672.3 12274.2 12449.1 12510.0 12525.4 12758.9 4044.1 4052.6 4103.2 4169.5 4229.5 57810.1 58362.0 59555.0 59809.7 60108.7 11355.5 11524.3 11633.2 11860.7 11917.6 20549.4 20583.4 20603.0 20610.2 20679.2 8628.7 8643.4 8716.0 8732.9 8858.5 4989.8 5041.6 5067.6 5089.6 5104.7 3723.3 3756.8 3759.9 3772.0 3791.1 641.3 654.8 668.0 671.8 677.8 733.0 777.9 808.0 824.6 829.8 10081.4 10416.3 10428.5 10470.9 10523.9 806.5 811.7 820.8 824.9 847.0 4771.0 4789.9 4794.2 4855.9 4963.4 64205.4 64541.4 65000.0 65018.0 65516.7 55828.4 57424.7 57602.0 57744.7 57971.7 49504.0 50131.7 50862.0 52085.0 52745.7 9927.4 10289.6 10332.8 10396.8 10652.9 40140.4 40248.4 40346.6 40493.2 41073.0 44529.3 47062.0 51959.5 52672.0 53365.2 12456.9 12655.9 12710.9 12938.5 12982.2 13873.5 14019.2 14292.4 14437.3 14762.7 13607.8 13630.9 13695.9 13740.2 13765.4 13882.4 13938.5 14009.5 14150.3 14242.4 12398.9 13447.5 13758.5 13762.2 14067.5 10969.6 11150.4 11220.3 11283.2 11399.9 11080.9 11112.4 11220.7 11510.2 11535.8 06:55:40 INFO - PROCESS | 9343 | -------- Summary: end -------- 06:55:40 INFO - PROCESS | 9343 | 06:55:41 INFO - TEST-INFO | 9343: exit 0 06:55:41 INFO - TEST-OK | dromaeo_css | took 1108566ms 06:55:41 INFO - TEST-START | kraken 06:55:41 INFO - operating with platform_type : linux_ 06:55:41 INFO - Initialising browser for kraken test... 06:55:41 INFO - TEST-INFO | started process 9579 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpleBFdZ/profile http://localhost:50738/getInfo.html) 06:55:44 INFO - PROCESS | 9579 | 06:55:44 INFO - PROCESS | 9579 | (process:9657): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:55:45 INFO - PROCESS | 9579 | __metrics Screen width/height:1600/1200 06:55:45 INFO - PROCESS | 9579 | colorDepth:24 06:55:45 INFO - PROCESS | 9579 | Browser inner width/height: 1024/697 06:55:45 INFO - PROCESS | 9579 | __metrics 06:55:45 ERROR - PROCESS | 9579 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 06:55:46 INFO - TEST-INFO | 9579: exit 0 06:55:46 INFO - Browser initialized. 06:55:46 INFO - Running cycle 1/1 for kraken test... 06:55:46 INFO - TEST-INFO | started process 9708 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpleBFdZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:55:48 INFO - PROCESS | 9708 | 06:55:48 INFO - PROCESS | 9708 | (process:9773): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:55:58 INFO - PROCESS | 9708 | RSS: Main: 151875584 06:55:58 INFO - PROCESS | 9708 | 06:56:00 INFO - PROCESS | 9708 | Cycle 1(1): loaded http://localhost:50738/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50738/tests/kraken/driver.html?testName=audio-beat-detection) 06:56:01 INFO - PROCESS | 9708 | RSS: Main: 156372992 06:56:01 INFO - PROCESS | 9708 | 06:56:04 INFO - PROCESS | 9708 | Cycle 1(1): loaded http://localhost:50738/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50738/tests/kraken/driver.html?testName=audio-dft) 06:56:04 INFO - PROCESS | 9708 | RSS: Main: 157200384 06:56:04 INFO - PROCESS | 9708 | 06:56:07 INFO - PROCESS | 9708 | Cycle 1(1): loaded http://localhost:50738/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50738/tests/kraken/driver.html?testName=audio-fft) 06:56:08 INFO - PROCESS | 9708 | RSS: Main: 157237248 06:56:08 INFO - PROCESS | 9708 | 06:56:10 INFO - PROCESS | 9708 | Cycle 1(1): loaded http://localhost:50738/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50738/tests/kraken/driver.html?testName=audio-oscillator) 06:56:11 INFO - PROCESS | 9708 | RSS: Main: 157155328 06:56:11 INFO - PROCESS | 9708 | 06:56:13 INFO - PROCESS | 9708 | Cycle 1(1): loaded http://localhost:50738/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50738/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:56:13 INFO - PROCESS | 9708 | RSS: Main: 157196288 06:56:13 INFO - PROCESS | 9708 | 06:56:16 INFO - PROCESS | 9708 | Cycle 1(1): loaded http://localhost:50738/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50738/tests/kraken/driver.html?testName=imaging-darkroom) 06:56:17 INFO - PROCESS | 9708 | RSS: Main: 157405184 06:56:17 INFO - PROCESS | 9708 | 06:56:20 INFO - PROCESS | 9708 | Cycle 1(1): loaded http://localhost:50738/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50738/tests/kraken/driver.html?testName=imaging-desaturate) 06:56:21 INFO - PROCESS | 9708 | RSS: Main: 157433856 06:56:21 INFO - PROCESS | 9708 | 06:56:24 INFO - PROCESS | 9708 | Cycle 1(1): loaded http://localhost:50738/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50738/tests/kraken/driver.html?testName=json-parse-financial) 06:56:24 INFO - PROCESS | 9708 | RSS: Main: 157503488 06:56:24 INFO - PROCESS | 9708 | 06:56:26 INFO - PROCESS | 9708 | Cycle 1(1): loaded http://localhost:50738/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50738/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:56:27 INFO - PROCESS | 9708 | RSS: Main: 157339648 06:56:27 INFO - PROCESS | 9708 | 06:56:28 INFO - PROCESS | 9708 | Cycle 1(1): loaded http://localhost:50738/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50738/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:56:29 INFO - PROCESS | 9708 | RSS: Main: 157376512 06:56:29 INFO - PROCESS | 9708 | 06:56:31 INFO - PROCESS | 9708 | Cycle 1(1): loaded http://localhost:50738/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50738/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:56:32 INFO - PROCESS | 9708 | RSS: Main: 157380608 06:56:32 INFO - PROCESS | 9708 | 06:56:34 INFO - PROCESS | 9708 | Cycle 1(1): loaded http://localhost:50738/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50738/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:56:35 INFO - PROCESS | 9708 | RSS: Main: 157843456 06:56:35 INFO - PROCESS | 9708 | 06:56:37 INFO - PROCESS | 9708 | Cycle 1(1): loaded http://localhost:50738/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50738/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:56:38 INFO - PROCESS | 9708 | RSS: Main: 157528064 06:56:38 INFO - PROCESS | 9708 | 06:56:40 INFO - PROCESS | 9708 | Cycle 1(1): loaded http://localhost:50738/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50738/tests/kraken/driver.html?testName=ai-astar) 06:56:40 INFO - PROCESS | 9708 | RSS: Main: 159391744 06:56:40 INFO - PROCESS | 9708 | 06:56:40 INFO - PROCESS | 9708 | __start_tp_report 06:56:40 INFO - PROCESS | 9708 | _x_x_mozilla_page_load 06:56:40 INFO - PROCESS | 9708 | _x_x_mozilla_page_load_details 06:56:40 INFO - PROCESS | 9708 | |i|pagename|runs| 06:56:40 INFO - PROCESS | 9708 | |0;ai-astar;108;112;104;109;110;110;101;110;111;109 06:56:40 INFO - PROCESS | 9708 | |1;audio-beat-detection;164;126;161;170;133;155;155;129;176;133 06:56:40 INFO - PROCESS | 9708 | |2;audio-dft;162;162;160;162;162;161;161;162;161;160 06:56:40 INFO - PROCESS | 9708 | |3;audio-fft;76;76;76;166;76;74;75;74;161;73 06:56:40 INFO - PROCESS | 9708 | |4;audio-oscillator;92;94;146;92;92;92;147;93;92;155 06:56:40 INFO - PROCESS | 9708 | |5;imaging-gaussian-blur;118;120;118;118;118;117;117;118;118;118 06:56:40 INFO - PROCESS | 9708 | |6;imaging-darkroom;147;148;146;147;146;147;146;147;148;147 06:56:40 INFO - PROCESS | 9708 | |7;imaging-desaturate;96;95;95;96;95;95;94;94;95;94 06:56:40 INFO - PROCESS | 9708 | |8;json-parse-financial;53;54;59;54;58;56;55;78;54;55 06:56:40 INFO - PROCESS | 9708 | |9;json-stringify-tinderbox;62;59;61;60;60;59;60;61;60;59 06:56:40 INFO - PROCESS | 9708 | |10;stanford-crypto-aes;81;74;72;72;73;81;75;76;75;73 06:56:40 INFO - PROCESS | 9708 | |11;stanford-crypto-ccm;116;116;114;126;122;115;113;116;134;129 06:56:40 INFO - PROCESS | 9708 | |12;stanford-crypto-pbkdf2;175;163;162;169;168;159;162;164;159;163 06:56:40 INFO - PROCESS | 9708 | |13;stanford-crypto-sha256-iterative;69;68;66;71;68;65;67;72;72;66 06:56:40 INFO - PROCESS | 9708 | __end_tp_report 06:56:40 INFO - PROCESS | 9708 | __start_cc_report 06:56:40 INFO - PROCESS | 9708 | _x_x_mozilla_cycle_collect,859 06:56:40 INFO - PROCESS | 9708 | __end_cc_report 06:56:40 INFO - PROCESS | 9708 | __startTimestamp1464616600457__endTimestamp 06:56:40 INFO - PROCESS | 9708 | 06:56:40 INFO - PROCESS | 9708 | ------- Summary: start ------- 06:56:40 INFO - PROCESS | 9708 | Number of tests: 14 06:56:40 INFO - PROCESS | 9708 | 06:56:40 INFO - PROCESS | 9708 | [#0] ai-astar Cycles:10 Average:108.40 Median:110.00 stddev:3.37 (3.1%) stddev-sans-first:3.57 06:56:40 INFO - PROCESS | 9708 | Values: 108.0 112.0 104.0 109.0 110.0 110.0 101.0 110.0 111.0 109.0 06:56:40 INFO - PROCESS | 9708 | 06:56:40 INFO - PROCESS | 9708 | [#1] audio-beat-detection Cycles:10 Average:150.20 Median:158.00 stddev:18.37 (11.6%) stddev-sans-first:18.79 06:56:40 INFO - PROCESS | 9708 | Values: 164.0 126.0 161.0 170.0 133.0 155.0 155.0 129.0 176.0 133.0 06:56:40 INFO - PROCESS | 9708 | 06:56:40 INFO - PROCESS | 9708 | [#2] audio-dft Cycles:10 Average:161.30 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 06:56:40 INFO - PROCESS | 9708 | Values: 162.0 162.0 160.0 162.0 162.0 161.0 161.0 162.0 161.0 160.0 06:56:40 INFO - PROCESS | 9708 | 06:56:40 INFO - PROCESS | 9708 | [#3] audio-fft Cycles:10 Average:92.70 Median:75.50 stddev:37.35 (49.5%) stddev-sans-first:39.12 06:56:40 INFO - PROCESS | 9708 | Values: 76.0 76.0 76.0 166.0 76.0 74.0 75.0 74.0 161.0 73.0 06:56:40 INFO - PROCESS | 9708 | 06:56:40 INFO - PROCESS | 9708 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:92.00 stddev:27.59 (30.0%) stddev-sans-first:28.53 06:56:40 INFO - PROCESS | 9708 | Values: 92.0 94.0 146.0 92.0 92.0 92.0 147.0 93.0 92.0 155.0 06:56:40 INFO - PROCESS | 9708 | 06:56:40 INFO - PROCESS | 9708 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 06:56:40 INFO - PROCESS | 9708 | Values: 118.0 120.0 118.0 118.0 118.0 117.0 117.0 118.0 118.0 118.0 06:56:40 INFO - PROCESS | 9708 | 06:56:40 INFO - PROCESS | 9708 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 06:56:40 INFO - PROCESS | 9708 | Values: 147.0 148.0 146.0 147.0 146.0 147.0 146.0 147.0 148.0 147.0 06:56:40 INFO - PROCESS | 9708 | 06:56:40 INFO - PROCESS | 9708 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 06:56:40 INFO - PROCESS | 9708 | Values: 96.0 95.0 95.0 96.0 95.0 95.0 94.0 94.0 95.0 94.0 06:56:40 INFO - PROCESS | 9708 | 06:56:40 INFO - PROCESS | 9708 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:55.50 stddev:7.41 (13.4%) stddev-sans-first:7.67 06:56:40 INFO - PROCESS | 9708 | Values: 53.0 54.0 59.0 54.0 58.0 56.0 55.0 78.0 54.0 55.0 06:56:40 INFO - PROCESS | 9708 | 06:56:40 INFO - PROCESS | 9708 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:60.00 stddev:0.99 (1.7%) stddev-sans-first:0.78 06:56:40 INFO - PROCESS | 9708 | Values: 62.0 59.0 61.0 60.0 60.0 59.0 60.0 61.0 60.0 59.0 06:56:40 INFO - PROCESS | 9708 | 06:56:40 INFO - PROCESS | 9708 | [#10] stanford-crypto-aes Cycles:10 Average:75.20 Median:75.00 stddev:3.33 (4.4%) stddev-sans-first:2.79 06:56:40 INFO - PROCESS | 9708 | Values: 81.0 74.0 72.0 72.0 73.0 81.0 75.0 76.0 75.0 73.0 06:56:40 INFO - PROCESS | 9708 | 06:56:40 INFO - PROCESS | 9708 | [#11] stanford-crypto-ccm Cycles:10 Average:120.10 Median:119.00 stddev:7.26 (6.1%) stddev-sans-first:7.55 06:56:40 INFO - PROCESS | 9708 | Values: 116.0 116.0 114.0 126.0 122.0 115.0 113.0 116.0 134.0 129.0 06:56:40 INFO - PROCESS | 9708 | 06:56:40 INFO - PROCESS | 9708 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.40 Median:163.50 stddev:4.95 (3.0%) stddev-sans-first:3.46 06:56:40 INFO - PROCESS | 9708 | Values: 175.0 163.0 162.0 169.0 168.0 159.0 162.0 164.0 159.0 163.0 06:56:40 INFO - PROCESS | 9708 | 06:56:40 INFO - PROCESS | 9708 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.50 stddev:2.55 (3.7%) stddev-sans-first:2.69 06:56:40 INFO - PROCESS | 9708 | Values: 69.0 68.0 66.0 71.0 68.0 65.0 67.0 72.0 72.0 66.0 06:56:40 INFO - PROCESS | 9708 | -------- Summary: end -------- 06:56:40 INFO - PROCESS | 9708 | 06:56:41 INFO - TEST-INFO | 9708: exit 0 06:56:41 INFO - TEST-OK | kraken | took 60179ms 06:56:41 INFO - SUITE-END | took 1168s 06:56:41 INFO - Completed test suite (00:19:29) 06:56:41 INFO - javascript benchmark 06:56:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3339.4489909164986, 3401.2857299967013, 3443.3629778490995, 3464.514967904494, 3474.5656792900886, 5640.238567793342, 5646.802361917334, 5653.180288858113, 5658.0381335173015, 5682.034054210783, 5615.410381909902, 5690.772369105231, 5706.914396284059, 5709.229254050712, 5723.771049158039, 5184.688918664882, 5195.116830138885, 5242.423333433319, 5277.70972596507, 5309.203619457093, 5068.5438310552045, 5230.92153617696, 5377.139657654776, 5377.516023557879, 5390.299261096072, 5179.559737422323, 5263.1578947368425, 5264.473552644724, 5275.551578115846, 5291.735413229323, 5213.58291336694, 5236.7119808410525, 5280.445553216895, 5288.497592728723, 5299.311089558371, 4986.950130498685, 5116.923246151311, 5164.8967020659375, 5189.455107213764, 5196.506331898464, 5454.481824226692, 5468.699221542814, 5486.835394938158, 5496.697681627509, 5512.145617429305, 5981.760729570812, 5988.520918326523, 5997.310309314441, 6000.729967151488, 6003.0, 5847.8245652630485, 6019.187409699722, 6051.001584738513, 6068.059450785136, 6140.6929653517145, 5661.433856614347, 5672.489475947144, 5676.233708449389, 5686.260786097822, 5701.77192912283, 6167.290761562478, 6197.5351848611535, 6213.2233470816145, 6234.2830574483605, 6253.46845518127, 5937.317208521075, 6014.1580178775, 6035.366286539938, 6037.366076561898, 6072.635641861414, 6057.757689692451, 6091.543134264948, 6098.1157732128595, 6098.32918378978, 6108.053251745987, 5733.77064917407, 6003.039513677791, 6051.334353221142, 6066.181065556182, 6070.392960703983, 6007.429294217042, 6032.4570788629235, 6035.155078288955, 6045.425684559959, 6089.482393996472, 4546.772661366918, 4580.633549316047, 4603.263477843529, 4614.307853821886, 4621.792019359137, 4047.453593764863, 4139.8965025874595, 4141.0, 4145.481814773153, 4182.393552934807, 5624.29696287964, 5703.116017017369, 5721.914171287434, 5807.941920580824, 5819.359870414251, 5929.318128415288, 6008.3390827009, 6032.185654936615, 6111.008868573017, 6137.723802428902, 5808.651480911074, 5826.1552074948895, 5862.853428664317, 5864.296284445809, 5865.0, 4915.65590408668, 4984.700917944935, 4998.500149984972, 5080.54275115234, 5087.643864929493, 6286.151369565142, 6299.401556852092, 6305.211848518935, 6305.991041433349, 6315.36846315374, 6059.727312271047, 6138.048602466625, 6144.631322120687, 6144.815655530341, 6152.261728592597, 6111.083337499411, 6181.783637572664, 6280.8429789253805, 6296.0, 6299.779507717391, 6044.727987240497, 6045.21412216409, 6054.3642917493025, 6056.7274472649715, 6090.512758979183, 5909.468147866713, 6137.1101190328045, 6157.415045570664, 6159.353267906805, 6165.784197553064, 5934.762609495745, 5972.581919265784, 5988.311344195473, 5998.1002849572915, 6046.939530604637, 5914.260717410324, 5928.258967629046, 5981.880362392815, 5983.461488466059, 5991.910121348096, 5657.462541058593, 5786.971065144648, 5889.941100589111, 5914.497267732118, 5919.644821310735, 5955.583109182316, 5991.161237426677, 6004.939950600613, 6028.909566356596, 6038.456538911519, 5857.297124345106, 5869.148973398918, 5870.765169393177, 5876.647401155944, 5888.676122813286], "value": 5605.557709930339, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [612.1216054961131, 649.7206201333424, 662.1524448705657, 665.4875745675827, 673.0207548017635, 39400.0, 39416.80291598541, 39491.60508394919, 39601.60398396022, 39650.40524392133, 41943.370849437204, 42511.78744106275, 42557.78721106398, 42682.359764603476, 42709.14581708364, 8745.956270218656, 8886.289096872235, 8902.0, 8910.910890891106, 8920.286377089817, 8609.225169734722, 8703.738887833344, 8718.564071796385, 8718.956405217965, 8739.300855931542, 8982.955085224565, 8999.5050272235, 9015.95492022539, 9017.053209412983, 9021.323400744937, 8891.42205756627, 8940.284777217872, 8942.55287235639, 8945.910540894572, 8964.50695211763, 8951.507667078307, 9014.774630634287, 9015.143561361725, 9033.322500812465, 9064.229540489066, 42156.578434215575, 43076.78461607672, 43087.13825723468, 43129.56870431287, 43136.56863431388, 3648.6351364863303, 3905.160390516024, 4278.951656844062, 4348.130373925228, 4685.554872287127, 32520.5121923169, 32612.510812337834, 32988.67011329904, 33345.0, 33819.661803381896, 4463.419755431773, 4549.09018196362, 4566.360709500673, 4590.74750888701, 4648.140094082605, 272091.0, 274660.0, 275193.0, 275261.62369188224, 275900.0, 38418.80790596029, 39166.804165979556, 61525.0, 63020.68489657614, 63034.36965630377, 36991.260174796356, 37096.629033709854, 37158.8142059288, 37194.8140259297, 37299.62700372961, 16656.0, 16694.833051669328, 16827.158642067847, 16895.07077110746, 16898.0, 14832.258387080603, 14865.2567371631, 14904.403823847142, 14911.627209319637, 14919.552413427615, 9199.77000574991, 9223.815523689489, 9309.95345023284, 9329.440233586007, 9362.06379362072, 3483.494893240466, 3612.223371975038, 3640.5631324241263, 3672.5225720656144, 3696.039029852258, 1094.392612100292, 1133.5182547417314, 1158.0330424095805, 1181.5037684172669, 1235.9073069519823, 32352.867849075647, 32448.675513245038, 32872.83563582167, 33274.3345133096, 33530.66469335324, 1202.0623913347604, 1231.3043130631165, 1242.3601845049807, 1256.39065053449, 1326.522451917309, 16815.91592042032, 17158.771602635832, 17299.913500432416, 17387.304507819797, 17395.56511087233, 479816.0, 499213.0, 585173.0, 601083.0, 602942.0, 62072.37927620666, 63324.36675633277, 63340.683296584146, 63495.0, 63552.682236588524, 1482.1551715522048, 1517.5826647671759, 1533.4326299269342, 1547.860692537677, 1553.650428653544, 33184.834075829465, 33594.32811343808, 33828.815991440184, 33962.0, 34340.313193735485, 54472.45527544674, 54869.72565137149, 55107.44892551023, 55483.445165547826, 55520.72239638776, 460186.0, 461984.0, 462805.0, 466083.0, 466585.0, 30469.23826904345, 47126.76436617795, 47306.76346618245, 47450.52549474461, 47588.28617570808, 45698.77150614226, 47468.52531474641, 48307.275390869865, 49458.0, 50434.243486347, 43297.35053974256, 43770.343444848986, 44083.779581103176, 44250.0, 45303.0, 41323.58676413318, 41695.37456938209, 41990.79004604957, 42103.36844947267, 43148.78425607852, 37859.24281514409, 38138.0465488365, 38458.80770596129, 38848.80575597217, 39109.0, 32982.67017329892, 33407.49888751719, 33568.16079597932, 33628.0, 34042.31915361728, 26709.332266692712, 27009.189724308304, 27141.86429067842, 27405.31486712848, 27738.583921240795], "value": 19696.99933401249, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.446014641113, 431.2302539966161, 431.7884236724006, 436.4958472963726, 440.80604534005033, 18521.536961575966, 18948.0, 19165.520861978457, 20176.495587610316, 20843.0, 19428.41714748556, 19832.90083549584, 19890.10494527746, 19982.400527984184, 19983.50041248966, 5397.62216644835, 5574.777008919638, 5630.211770352154, 5633.60564760467, 5818.8254352369495, 5559.63862348946, 5622.212890195356, 5655.4061823508555, 5660.518855897254, 5684.516816070618, 5790.420957904218, 5853.941460585404, 5860.384659610722, 5876.882462350751, 5898.7640494380385, 5382.6232163748555, 5794.159846822208, 5844.152597873306, 5847.56143289255, 5857.15071314657, 5456.045192091368, 5503.229547863302, 5533.778648854041, 5536.335639723259, 5544.556435485151, 20612.896935515375, 21707.782922170732, 23465.648015279785, 23511.647325289963, 23527.647085293735, 2458.8370983137256, 2471.2462698876834, 2473.703155621319, 2536.315194897386, 2566.781823544982, 10208.183345332356, 10257.43584102874, 10348.637797677045, 10618.7257529097, 10758.569657213702, 2012.597480503905, 2036.8166864982222, 2037.9388618341472, 2062.175129948018, 2064.3600483849905, 79583.60208198921, 79637.60181199115, 83838.0, 84242.15757842404, 84335.57832210799, 10072.74818129538, 10399.168066554657, 10503.002214789583, 10505.737356565995, 10545.0, 14653.633659158393, 14761.114333140045, 14798.112113273239, 14874.256287185597, 14925.850741492663, 8063.354931605575, 8357.495650782796, 8373.204545568162, 8482.915170848213, 8518.23335899772, 8181.0, 8209.8358032839, 8227.341812655093, 8323.250907418362, 8381.28759055475, 4647.024124933734, 4688.765561721901, 4761.166795810719, 4810.42274927011, 4813.109574728686, 1931.8749375686914, 1954.0425191655986, 1987.7415935928525, 1990.5023744063983, 2004.3586052463072, 1003.5383723487132, 1060.9814578005048, 1110.3892858927557, 1175.048210949134, 1194.552042983881, 18713.251469941322, 18993.62012759737, 19067.427977160707, 19319.517012074528, 19494.80505194958, 1075.172117469544, 1094.682542062793, 1096.8848270931596, 1111.644273832382, 1144.5250221158126, 10613.734656633645, 10716.517756700967, 10806.297590656739, 10809.78380432387, 10824.512896919658, 472601.0, 483692.0, 490455.0, 497944.0, 504424.0, 77081.61459192669, 81519.0, 81732.0, 95082.0, 96623.51688241513, 1091.2688498705886, 1108.4014632098576, 1128.8983991440646, 1156.4449064448943, 1163.953441862333, 17109.74335384995, 17188.570285742957, 17222.311107555557, 17397.21712522914, 17547.47357579275, 38230.61769382271, 38353.0, 38988.41517377185, 39805.80097099496, 40384.3942340871, 55436.16845747398, 55758.72120639371, 56564.0, 56611.71694141503, 56807.43192568021, 8698.652053917773, 8800.251978581637, 8808.383413161017, 8811.471311721318, 8854.158854908774, 11791.29252244868, 13025.739485210432, 13095.934520327719, 13401.128926619738, 13492.460301587827, 11124.721881953015, 11210.047145992681, 11265.831012534982, 11273.098152147644, 11508.309501429942, 11212.27120237182, 11339.092872570009, 11437.199396042197, 11730.70673233176, 11853.111016673956, 11306.0, 11585.6524304271, 11680.123990700562, 11758.176927614984, 11800.409979500819, 8306.0, 8396.1603839618, 8421.284190843848, 8432.578371081545, 8536.658533658832, 11028.62142232221, 11699.415029248334, 11829.408529573315, 11887.583934562248, 11895.643130706092], "value": 9308.564065703813, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1576.471881919557, 1604.9746228359543, 1767.4167524716845, 1856.4616261284227, 1866.1415748755571, 7533.849323013536, 8206.630701618427, 8284.834303313937, 8573.099824518422, 8676.305895528358, 8214.91785082149, 8391.202835730612, 8405.243528082487, 8523.147685231474, 8565.571721413935, 2362.681038059857, 2382.6664267002634, 2401.7117945846435, 2402.5795485790004, 2404.062415657886, 2426.211481268586, 2426.3934016495878, 2452.766987136219, 2468.691413573303, 2470.6047032474808, 2423.612222044473, 2435.208557218902, 2437.6831011968507, 2440.9511809763794, 2446.926592202237, 2436.634504824273, 2441.292025312657, 2469.950600987979, 2472.752724727522, 2480.2063339731203, 2428.3322086426197, 2476.603743401065, 2515.283144303883, 2526.280010197085, 2526.759957804006, 8583.699570515002, 8688.826223475558, 8710.564471776386, 8712.78218044554, 8736.126387361277, 5197.506236907488, 5270.789168433296, 5302.73486325686, 5345.518903298683, 5348.679079255257, 3546.3261980223674, 3593.8921832345072, 3603.7117030637487, 3617.782933024027, 3651.963480365189, 1123.0622430270735, 1130.2766229613055, 1132.5356603792407, 1146.6330774152275, 1154.6766905266538, 11361.772764544663, 11437.199396042364, 11475.196736228467, 11525.884741152566, 11535.134864885167, 4640.860774176713, 4665.510121437268, 4748.19280722278, 4792.2092854678585, 4816.325714399987, 9950.35322704022, 9963.551640176209, 9966.750831229132, 9973.202143828476, 10017.69946901594, 5336.67979921206, 5360.91958620621, 5372.973135134299, 5406.216098665672, 5412.107002344569, 4172.311568591149, 4808.3989501312335, 4879.609631229493, 4925.187344088257, 4927.531884470969, 4178.080822219107, 4181.644560212355, 4196.748195108242, 4207.200631879933, 4260.424842646203, 1314.7830607949772, 1317.2096741954942, 1326.1380102932978, 1357.2128165663892, 1384.3216823756286, 1020.9030142136485, 1024.5645600619707, 1026.5124066068706, 1027.4965267019106, 1039.73486760877, 5704.1443783432815, 5874.265716785402, 5939.465448109604, 5977.073553599199, 6116.052011938156, 983.7343917142332, 1034.7775228325795, 1067.9199060070525, 1100.7908497385472, 1122.5117074072805, 4303.655707543389, 4324.610785029363, 4366.716163449366, 4369.69412141147, 4384.846530371422, 10363.170946324275, 10866.565337386415, 10868.076213521781, 10885.564577416815, 10888.510017049251, 9911.355761875455, 10162.898371016343, 10611.363318200933, 10624.415657138932, 10630.840537391945, 7826.647800848976, 7845.960770196112, 7881.330086942674, 7911.011123609664, 7924.128345881948, 5635.605507614428, 5679.858003549944, 5741.885162296814, 5789.218455508452, 5879.235699359056, 9007.819843603222, 9095.272378209595, 9122.179003889682, 9195.218406435528, 9202.401843880127, 9121.270298375981, 9210.263178945803, 9247.583858726239, 9277.536123193948, 9311.72064838056, 7078.858422831411, 7773.0, 7814.804629884298, 7888.684452621831, 8021.639026243716, 7985.680572777024, 7989.201079891965, 8017.238362355567, 8024.317932975762, 8028.036635603765, 7030.753923612649, 7166.283371662792, 7304.707811687473, 7421.0, 7434.888476672746, 6950.20072691647, 6993.580385176906, 7051.0, 7127.322904324081, 7134.714611415485, 6472.126262954441, 6528.836779080371, 6596.637184954873, 6603.867922641424, 6618.933810661832, 4952.4057113146655, 5015.874603134951, 5068.543831055223, 5068.771905264346, 5130.333056702605, 5097.235414687826, 5150.742462876916, 5181.455947125498, 5232.816851410183, 5276.841694749163], "value": 4643.304188060284, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.9757117001811, 347.6558207374698, 359.148817302992, 362.3550080856076, 363.8562767706756, 6518.989556618726, 6631.204255489342, 6729.7308107675635, 6734.191896972358, 6739.797806065813, 6594.703238354274, 6599.505037122211, 6615.272320044791, 6618.007298905167, 6622.337766223375, 4806.591439727627, 4931.926021109668, 5012.573931215851, 5037.622178336621, 5038.8488345349515, 5008.123578373788, 5019.498050194988, 5022.59819214462, 5025.14572522672, 5038.093143234217, 4952.158133117378, 4977.825776097838, 4984.053029924321, 4984.950150498503, 4989.476105008976, 5010.298558201855, 5066.97466512667, 5070.467600901908, 5070.923936140961, 5091.694498330112, 4456.9331460028125, 4477.462704475452, 4478.8432404866, 4479.865604031885, 4484.058347746977, 6060.848478788022, 6335.809925702236, 6358.173437453148, 6387.4251317381195, 6394.072859435356, 5722.0, 5722.055860782966, 5734.541236701054, 5758.078707406837, 5781.739821708034, 6823.795286141423, 6919.757808476729, 6935.68789404473, 6947.096877405956, 6958.5824850508625, 4719.433667959833, 4721.645876559238, 4745.667803253774, 4759.547842954914, 4767.976160119212, 7182.856342873166, 7240.855182896313, 7287.344139027513, 7306.744263950736, 7314.707411703525, 4849.636277279218, 4863.70817750929, 4898.681585696918, 4907.288443175719, 4923.5814955729165, 4926.8275610354185, 4975.950240497621, 4976.0794253063295, 4976.178930476503, 4986.252062190628, 5731.0, 5736.483716465538, 5788.652680839163, 5792.536597072224, 5807.651540907559, 7014.22843487216, 7027.5080744348425, 7032.296770322927, 7032.824179395454, 7036.92963070373, 1736.2447335409138, 1738.9043602601978, 1757.349780581193, 1757.3585641240854, 1761.3747119772552, 1108.9001989820792, 1126.3129491010477, 1131.5926266544038, 1143.9542418303174, 1152.6023521884936, 6635.341164708822, 6740.629265390353, 6761.695723692347, 6766.7969960901255, 6768.661566921634, 6964.233934267227, 7082.752103676346, 7147.463940204506, 7175.605341706152, 7187.0, 6873.828154296182, 6876.484263680144, 6886.8622627547165, 6888.207856096613, 6893.827654308582, 3922.3332033554366, 3939.3106206413763, 3968.3849003404516, 3971.900702482461, 3973.3642617181113, 7519.285667861544, 7524.435667324972, 7574.583397913168, 7576.090869095744, 7590.544567325978, 7327.487075904742, 7455.739049133254, 7464.664090115958, 7464.850702986018, 7471.8505629887095, 7490.101187857492, 7510.0, 7534.924650753423, 7554.055743032121, 7554.773356799305, 7313.341799238094, 7319.45104117204, 7319.707211711472, 7319.817004574928, 7322.524035937647, 7175.703774792017, 7186.1376634804155, 7200.855982880418, 7211.963940180265, 7232.855342893007, 7421.0, 7450.180480147288, 7541.698332066656, 7545.207753185837, 7554.697812087675, 4904.730239836843, 4923.261510773269, 4933.679310844784, 4936.2102063669645, 4945.530174633404, 7202.89195662076, 7259.12890453149, 7273.0, 7277.126744790659, 7285.2714728528845, 7083.6812343443635, 7083.964580177272, 7085.39774119185, 7090.149182098181, 7112.502124851418, 6915.170179578483, 7014.614196219257, 7036.964815175891, 7045.577265364094, 7070.292970702889, 6843.8973415399805, 6908.965455172692, 6919.0, 6929.549579277331, 6947.548409353376, 7095.645217739196, 7104.218535961144, 7105.857882842418, 7110.288971102848, 7128.649534718674, 6908.205556361083, 6910.654467276516, 6924.376806087476, 6937.132858392701, 6938.479614029069], "value": 5273.005358639742, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [826.2935190412198, 858.7209157023965, 889.5107690770075, 897.811459593485, 941.6986564299427, 14829.480968166117, 14914.925425372885, 15020.624484387896, 17426.3029478821, 17727.0, 14713.337899794507, 14834.48079317224, 14837.554873353789, 14907.105573665587, 14934.925325373359, 734.7354952217197, 870.5342641686683, 879.4898958604026, 887.5961437545933, 898.4339865884483, 890.1009979920294, 890.8530092534724, 895.5880295064246, 895.7581453007684, 897.1208215948375, 934.3739694404732, 936.3352020065762, 936.9625214991393, 942.3309450290302, 942.4109931292942, 925.9259259259243, 930.2093220762332, 931.9906800932006, 935.4060171790894, 936.4662142578733, 681.4378138036091, 684.4421796236102, 685.1504134872772, 686.1217641418991, 686.2417029182731, 16061.759073613905, 16150.919245403698, 16215.756763648555, 16216.189190540426, 16235.512934611981, 14361.640958976004, 14469.565913022521, 14634.121952682766, 14653.853461465356, 14672.26638668073, 12274.202176858476, 12449.066320026035, 12510.0, 12525.43635536403, 12758.936205319007, 4044.090079732066, 4052.5744796796207, 4103.199876024177, 4169.499660040815, 4229.450171477688, 57810.13284800731, 58362.0, 59555.0, 59809.70095149496, 60108.699456502436, 11355.48900299472, 11524.308541487537, 11633.185677002528, 11860.703482413008, 11917.582884598998, 20549.38351849447, 20583.38249852507, 20603.0, 20610.175592976113, 20679.17283308681, 8628.741137765877, 8643.438176518506, 8716.0, 8732.8690069649, 8858.468491890508, 4989.775460104304, 5041.6470847040355, 5067.619928505377, 5089.643724939218, 5104.668196567211, 3723.255348930171, 3756.8121593920196, 3759.887203383903, 3772.038130276817, 3791.1469919267943, 641.3490307338055, 654.8068319845657, 668.0313545359248, 671.7648822912039, 677.7797215904851, 732.9890051649229, 777.8833175023678, 807.9757607271791, 824.6330382979517, 829.7925518620345, 10081.395116293046, 10416.270861039806, 10428.478576071166, 10470.947645261725, 10523.947380263202, 806.4596720197482, 811.6778156317632, 820.8399362124447, 824.9133840946735, 846.9661213551389, 4770.976145119322, 4789.936054503097, 4794.232922732346, 4855.854324370204, 4963.379577552806, 64205.357946420874, 64541.35458645353, 65000.0, 65018.0, 65516.67241663857, 55828.441715582325, 57424.712876436184, 57602.0, 57744.71127644335, 57971.710141449024, 49504.0, 50131.74934125306, 50862.0, 52085.0, 52745.73627131917, 9927.40435573868, 10289.639862604772, 10332.845007325046, 10396.792064158826, 10652.946735266274, 40140.3978940322, 40248.396274055325, 40346.59653403428, 40493.1901361977, 41073.0, 44529.33206001978, 47062.0, 51959.48040519546, 52672.0, 53365.19952200643, 12456.875431245571, 12655.87344126547, 12710.872891270968, 12938.482460701467, 12982.15615984958, 13873.514426995007, 14019.158850469004, 14292.42830286777, 14437.278136093364, 14762.704745905237, 13607.79588306196, 13630.931845341107, 13695.931520342334, 13740.175589464665, 13765.38055787472, 13882.375293111632, 13938.512152074629, 14009.509667162009, 14150.292485375485, 14242.359093840594, 12398.938005309916, 13447.529336473177, 13758.518451854137, 13762.24307663088, 14067.507637233057, 10969.561217551527, 11150.442477876237, 11220.326780393203, 11283.153763467937, 11399.943000284946, 11080.944595276973, 11112.388818615054, 11220.66338009861, 11510.194286399872, 11535.769284614093], "value": 7333.61434299475, "unit": "score"}], "name": "dromaeo_css", "value": 7545.537096078311, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 112.0, 104.0, 109.0, 110.0, 110.0, 101.0, 110.0, 111.0, 109.0], "value": 108.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 126.0, 161.0, 170.0, 133.0, 155.0, 155.0, 129.0, 176.0, 133.0], "value": 150.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 160.0, 162.0, 162.0, 161.0, 161.0, 162.0, 161.0, 160.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 166.0, 76.0, 74.0, 75.0, 74.0, 161.0, 73.0], "value": 92.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 146.0, 92.0, 92.0, 92.0, 147.0, 93.0, 92.0, 155.0], "value": 109.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 120.0, 118.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 148.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 59.0, 54.0, 58.0, 56.0, 55.0, 78.0, 54.0, 55.0], "value": 57.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 59.0, 61.0, 60.0, 60.0, 59.0, 60.0, 61.0, 60.0, 59.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 74.0, 72.0, 72.0, 73.0, 81.0, 75.0, 76.0, 75.0, 73.0], "value": 75.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 114.0, 126.0, 122.0, 115.0, 113.0, 116.0, 134.0, 129.0], "value": 120.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 163.0, 162.0, 169.0, 168.0, 159.0, 162.0, 164.0, 159.0, 163.0], "value": 164.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 66.0, 71.0, 68.0, 65.0, 67.0, 72.0, 72.0, 66.0], "value": 68.4, "unit": "score"}], "name": "kraken", "value": 1527.7, "alertThreshold": 2.0}]} 06:56:41 INFO - Return code: 0 06:56:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:56:41 ERROR - # TBPL SUCCESS # 06:56:41 INFO - Running post-action listener: _resource_record_post_action 06:56:41 INFO - Running post-run listener: _resource_record_post_run 06:56:42 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 262144; Write bytes: 501977088; Read time: 16; Write time: 415980 06:56:42 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 249122816; Read time: 0; Write time: 262804 06:56:42 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 262144; Write bytes: 252854272; Read time: 16; Write time: 153176 06:56:42 INFO - Running post-run listener: _upload_blobber_files 06:56:42 INFO - Blob upload gear active. 06:56:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:56:42 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 06:56:42 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'] 06:56:42 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 06:56:43 INFO - (blobuploader) - INFO - Open directory for files ... 06:56:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:56:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:56:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:56:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:56:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:56:43 INFO - (blobuploader) - INFO - Done attempting. 06:56:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:56:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:56:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:56:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:56:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:56:44 INFO - (blobuploader) - INFO - Done attempting. 06:56:44 INFO - (blobuploader) - INFO - Iteration through files over. 06:56:44 INFO - Return code: 0 06:56:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:56:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:56:44 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9f399035d47dd644a970cd244c8a3e34c82abec9c3c1dac2e1ea6a6173c423143d608f3d451247b3880371ee35d9b43cf62e4b377450f0000f741fe220b85f00", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c721f2242e8cf971f1268a58f7f0e87d4449d618931fe1e8ba2009715c2562518f62fd1eec828b7586575f8726ddd8bd1587d40658da1d19df5d2c6242fd8dc8"} 06:56:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:56:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:56:44 INFO - Contents: 06:56:44 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9f399035d47dd644a970cd244c8a3e34c82abec9c3c1dac2e1ea6a6173c423143d608f3d451247b3880371ee35d9b43cf62e4b377450f0000f741fe220b85f00", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c721f2242e8cf971f1268a58f7f0e87d4449d618931fe1e8ba2009715c2562518f62fd1eec828b7586575f8726ddd8bd1587d40658da1d19df5d2c6242fd8dc8"} 06:56:44 INFO - Running post-run listener: copy_logs_to_upload_dir 06:56:44 INFO - Copying logs to upload dir... 06:56:44 INFO - mkdir: /builds/slave/test/build/upload/logs 06:56:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.928102 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-05-30 06:56:44.926450) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 06:56:44.930067) ========= 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=31acecf42b6a79ec49471d4a000001bb-1464615055.95255-1303475682 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/9f399035d47dd644a970cd244c8a3e34c82abec9c3c1dac2e1ea6a6173c423143d608f3d451247b3880371ee35d9b43cf62e4b377450f0000f741fe220b85f00", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c721f2242e8cf971f1268a58f7f0e87d4449d618931fe1e8ba2009715c2562518f62fd1eec828b7586575f8726ddd8bd1587d40658da1d19df5d2c6242fd8dc8"} 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.011496 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/9f399035d47dd644a970cd244c8a3e34c82abec9c3c1dac2e1ea6a6173c423143d608f3d451247b3880371ee35d9b43cf62e4b377450f0000f741fe220b85f00", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c721f2242e8cf971f1268a58f7f0e87d4449d618931fe1e8ba2009715c2562518f62fd1eec828b7586575f8726ddd8bd1587d40658da1d19df5d2c6242fd8dc8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 06:56:44.962091) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 06:56:44.962425) ========= 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=31acecf42b6a79ec49471d4a000001bb-1464615055.95255-1303475682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004752 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 06:56:45.048378) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 06:56:45.048941) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 06:56:45.049478) ========= ========= Total master_lag: 0.20 =========