builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-033 starttime: 1468962115.04 results: success (0) buildid: 20160719110521 builduid: b50f924069754df69847add88ada5d36 revision: 55cd3b01ca013495afc1f583e4eb9a9392199025 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 14:01:55.039254) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 14:01:55.039865) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 14:01:55.040816) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 14:01:55.058897) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 14:01:55.059682) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1468961583.2326-30875764 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-19 14:01:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.3M=0s 2016-07-19 14:01:55 (69.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127189 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 14:01:55.201547) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 14:01:55.201856) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1468961583.2326-30875764 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014816 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 14:01:55.252818) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-19 14:01:55.253181) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 55cd3b01ca013495afc1f583e4eb9a9392199025 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 55cd3b01ca013495afc1f583e4eb9a9392199025 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1468961583.2326-30875764 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-19 14:01:55,310 truncating revision to first 12 chars 2016-07-19 14:01:55,310 Setting DEBUG logging. 2016-07-19 14:01:55,310 attempt 1/10 2016-07-19 14:01:55,310 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/55cd3b01ca01?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-19 14:01:55,998 unpacking tar archive at: mozilla-beta-55cd3b01ca01/testing/mozharness/ program finished with exit code 0 elapsedTime=1.005661 ========= master_lag: 0.45 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-19 14:01:56.713098) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 14:01:56.713397) ========= script_repo_revision: 55cd3b01ca013495afc1f583e4eb9a9392199025 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 14:01:56.713785) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 14:01:56.714093) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 14:01:56.737921) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-19 14:01:56.738250) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1468961583.2326-30875764 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:01:56 INFO - MultiFileLogger online at 20160719 14:01:56 in /builds/slave/test 14:01:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 14:01:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:01:56 INFO - {'append_to_log': False, 14:01:56 INFO - 'base_work_dir': '/builds/slave/test', 14:01:56 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:01:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:01:56 INFO - 'branch': 'Mozilla-Beta', 14:01:56 INFO - 'buildbot_json_path': 'buildprops.json', 14:01:56 INFO - 'config_files': ('talos/linux_config.py',), 14:01:56 INFO - 'default_actions': ('clobber', 14:01:56 INFO - 'read-buildbot-config', 14:01:56 INFO - 'download-and-extract', 14:01:56 INFO - 'populate-webroot', 14:01:56 INFO - 'create-virtualenv', 14:01:56 INFO - 'install', 14:01:56 INFO - 'run-tests'), 14:01:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:01:56 INFO - 'download_minidump_stackwalk': True, 14:01:56 INFO - 'download_symbols': 'ondemand', 14:01:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:01:56 INFO - 'tooltool.py': '/tools/tooltool.py', 14:01:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:01:56 INFO - '/tools/misc-python/virtualenv.py')}, 14:01:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:01:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:01:56 INFO - 'installer_path': 'installer.exe', 14:01:56 INFO - 'log_level': 'info', 14:01:56 INFO - 'log_name': 'talos', 14:01:56 INFO - 'log_to_console': True, 14:01:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:01:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:01:56 INFO - 'opt_config_files': (), 14:01:56 INFO - 'pip_index': False, 14:01:56 INFO - 'sps_profile': False, 14:01:56 INFO - 'sps_profile_interval': 0, 14:01:56 INFO - 'suite': 'dromaeojs-e10s', 14:01:56 INFO - 'system_bits': '32', 14:01:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:01:56 INFO - 'title': 'talos-linux64-ix-033', 14:01:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:01:56 INFO - 'use_talos_json': True, 14:01:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:01:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:01:56 INFO - 'work_dir': 'build'} 14:01:56 INFO - ##### 14:01:56 INFO - ##### Running clobber step. 14:01:56 INFO - ##### 14:01:56 INFO - Running pre-action listener: _resource_record_pre_action 14:01:56 INFO - Running main action method: clobber 14:01:56 INFO - rmtree: /builds/slave/test/build 14:01:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:01:57 INFO - Running post-action listener: _resource_record_post_action 14:01:57 INFO - ##### 14:01:57 INFO - ##### Running read-buildbot-config step. 14:01:57 INFO - ##### 14:01:57 INFO - Running pre-action listener: _resource_record_pre_action 14:01:57 INFO - Running main action method: read_buildbot_config 14:01:57 INFO - Using buildbot properties: 14:01:57 INFO - { 14:01:57 INFO - "project": "", 14:01:57 INFO - "product": "firefox", 14:01:57 INFO - "script_repo_revision": "production", 14:01:57 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 14:01:57 INFO - "repository": "", 14:01:57 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 14:01:57 INFO - "buildid": "20160719110521", 14:01:57 INFO - "pgo_build": "True", 14:01:57 INFO - "basedir": "/builds/slave/test", 14:01:57 INFO - "buildnumber": 56, 14:01:57 INFO - "slavename": "talos-linux64-ix-033", 14:01:57 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:01:57 INFO - "platform": "ubuntu64_hw", 14:01:57 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 14:01:57 INFO - "branch": "mozilla-beta", 14:01:57 INFO - "repo_path": "releases/mozilla-beta", 14:01:57 INFO - "revision": "55cd3b01ca013495afc1f583e4eb9a9392199025", 14:01:57 INFO - "stage_platform": "linux64-pgo", 14:01:57 INFO - "builduid": "b50f924069754df69847add88ada5d36", 14:01:57 INFO - "slavebuilddir": "test" 14:01:57 INFO - } 14:01:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 14:01:57 INFO - Running post-action listener: _resource_record_post_action 14:01:57 INFO - ##### 14:01:57 INFO - ##### Running download-and-extract step. 14:01:57 INFO - ##### 14:01:57 INFO - Running pre-action listener: _resource_record_pre_action 14:01:57 INFO - Running main action method: download_and_extract 14:01:57 INFO - mkdir: /builds/slave/test/build/tests 14:01:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:57 INFO - https://queue.taskcluster.net/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:01:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 14:01:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 14:01:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 14:01:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:02:02 INFO - Downloaded 1327 bytes. 14:02:02 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 14:02:02 INFO - Using the following test package requirements: 14:02:02 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 14:02:02 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:02:02 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 14:02:02 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:02:02 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 14:02:02 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:02:02 INFO - u'jsshell-linux-x86_64.zip'], 14:02:02 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:02:02 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 14:02:02 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 14:02:02 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:02:02 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 14:02:02 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:02:02 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 14:02:02 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:02:02 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 14:02:02 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:02:02 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 14:02:02 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:02:02 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')]} 14:02:02 INFO - https://queue.taskcluster.net/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:02:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 14:02:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 14:02:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 14:02:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:02:04 INFO - Downloaded 24200392 bytes. 14:02:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:02:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:02:05 INFO - Return code: 0 14:02:05 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:02:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:05 INFO - https://queue.taskcluster.net/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:02:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 14:02:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 14:02:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 14:02:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:02:10 INFO - Downloaded 24200392 bytes. 14:02:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:02:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:02:12 INFO - Return code: 0 14:02:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:12 INFO - https://queue.taskcluster.net/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:02:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 14:02:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 14:02:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 14:02:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:02:13 INFO - Downloaded 10840145 bytes. 14:02:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:02:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:02:13 INFO - Return code: 0 14:02:13 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')]} 14:02:13 INFO - https://queue.taskcluster.net/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:02:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 14:02:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 14:02:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 14:02:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:02:21 INFO - Downloaded 56031661 bytes. 14:02:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 14:02:21 INFO - mkdir: /builds/slave/test/properties 14:02:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:02:21 INFO - Writing to file /builds/slave/test/properties/build_url 14:02:21 INFO - Contents: 14:02:21 INFO - build_url:https://queue.taskcluster.net/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 14:02:22 INFO - Running post-action listener: _resource_record_post_action 14:02:22 INFO - Running post-action listener: set_extra_try_arguments 14:02:22 INFO - ##### 14:02:22 INFO - ##### Running populate-webroot step. 14:02:22 INFO - ##### 14:02:22 INFO - Running pre-action listener: _resource_record_pre_action 14:02:22 INFO - Running main action method: populate_webroot 14:02:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:02:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:02:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:02:22 INFO - '--tppagecycles', 14:02:22 INFO - '7'], 14:02:22 INFO - 'tests': ['tsvgm']}}, 14:02:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:02:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:02:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:02:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:02:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:02:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:02:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:22 INFO - 'talos_options': ['--disable-e10s'], 14:02:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:02:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:02:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:22 INFO - 'talos_options': ['--disable-e10s'], 14:02:22 INFO - 'tests': ['damp', 'tps']}, 14:02:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:22 INFO - 'tests': ['damp', 'tps']}, 14:02:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:02:22 INFO - 'tests': ['dromaeo_dom']}, 14:02:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:02:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:02:22 INFO - 'tests': ['a11yr', 14:02:22 INFO - 'ts_paint', 14:02:22 INFO - 'tpaint', 14:02:22 INFO - 'sessionrestore', 14:02:22 INFO - 'sessionrestore_no_auto_restore', 14:02:22 INFO - 'tabpaint']}, 14:02:22 INFO - 'other-e10s': {'tests': ['a11yr', 14:02:22 INFO - 'ts_paint', 14:02:22 INFO - 'tpaint', 14:02:22 INFO - 'sessionrestore', 14:02:22 INFO - 'sessionrestore_no_auto_restore', 14:02:22 INFO - 'tabpaint']}, 14:02:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:02:22 INFO - 'ts_paint', 14:02:22 INFO - 'tpaint', 14:02:22 INFO - 'sessionrestore', 14:02:22 INFO - 'sessionrestore_no_auto_restore', 14:02:22 INFO - 'tabpaint']}, 14:02:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:02:22 INFO - 'ts_paint', 14:02:22 INFO - 'tpaint', 14:02:22 INFO - 'sessionrestore', 14:02:22 INFO - 'sessionrestore_no_auto_restore', 14:02:22 INFO - 'tabpaint']}, 14:02:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:02:22 INFO - 'tests': ['a11yr', 14:02:22 INFO - 'ts_paint', 14:02:22 INFO - 'tpaint', 14:02:22 INFO - 'sessionrestore', 14:02:22 INFO - 'sessionrestore_no_auto_restore', 14:02:22 INFO - 'tabpaint']}, 14:02:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:02:22 INFO - 'tests': ['a11yr', 14:02:22 INFO - 'ts_paint', 14:02:22 INFO - 'tpaint', 14:02:22 INFO - 'sessionrestore', 14:02:22 INFO - 'sessionrestore_no_auto_restore', 14:02:22 INFO - 'tabpaint']}, 14:02:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:02:22 INFO - 'tests': ['tsvgx', 14:02:22 INFO - 'tsvgr_opacity', 14:02:22 INFO - 'tart', 14:02:22 INFO - 'tscrollx', 14:02:22 INFO - 'cart']}, 14:02:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:02:22 INFO - 'tsvgr_opacity', 14:02:22 INFO - 'tart', 14:02:22 INFO - 'tscrollx', 14:02:22 INFO - 'cart']}, 14:02:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:22 INFO - 'talos_options': ['--disable-e10s'], 14:02:22 INFO - 'tests': ['tp5o']}, 14:02:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:22 INFO - 'tests': ['tp5o']}, 14:02:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:22 INFO - 'talos_options': ['--disable-e10s', 14:02:22 INFO - '--xperf_path', 14:02:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:02:22 INFO - 'tests': ['tp5n']}, 14:02:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:22 INFO - 'talos_options': ['--xperf_path', 14:02:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:02:22 INFO - 'tests': ['tp5n']}}, 14:02:22 INFO - 'talos.zip': {'path': '', 14:02:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:02:22 INFO - Running post-action listener: _resource_record_post_action 14:02:22 INFO - ##### 14:02:22 INFO - ##### Running create-virtualenv step. 14:02:22 INFO - ##### 14:02:22 INFO - Running pre-action listener: _resource_record_pre_action 14:02:22 INFO - Running main action method: create_virtualenv 14:02:22 INFO - Creating virtualenv /builds/slave/test/build/venv 14:02:22 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 14:02:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:02:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:02:22 INFO - Using real prefix '/usr' 14:02:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:02:22 INFO - Installing distribute.............................................................................................................................................................................................done. 14:02:24 INFO - Installing pip.................done. 14:02:24 INFO - Return code: 0 14:02:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:02:24 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')]} 14:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:24 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')]} 14:02:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:24 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 0x7f0563ba0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aee640>, '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 0x1aef540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aef9d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1468961583.2326-30875764', '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 14:02:24 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 14:02:24 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 14:02:24 INFO - Using env: {'DISPLAY': ':0', 14:02:24 INFO - 'HOME': '/home/cltbld', 14:02:24 INFO - 'LANG': 'en_US.UTF-8', 14:02:24 INFO - 'LANGUAGE': 'en_US:en', 14:02:24 INFO - 'LOGNAME': 'cltbld', 14:02:24 INFO - 'MAIL': '/var/mail/cltbld', 14:02:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:24 INFO - 'MOZ_NO_REMOTE': '1', 14:02:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:24 INFO - 'NO_EM_RESTART': '1', 14:02:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:24 INFO - 'PWD': '/builds/slave/test', 14:02:24 INFO - 'SHELL': '/bin/bash', 14:02:24 INFO - 'SHLVL': '1', 14:02:24 INFO - 'TERM': 'linux', 14:02:24 INFO - 'TMOUT': '86400', 14:02:24 INFO - 'USER': 'cltbld', 14:02:24 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1468961583.2326-30875764', 14:02:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:24 INFO - '_': '/tools/buildbot/bin/python'} 14:02:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:25 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 14:02:25 INFO - Cleaning up... 14:02:25 INFO - Return code: 0 14:02:25 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:02: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')]} 14:02:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02: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')]} 14:02:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0563ba0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aee640>, '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 0x1aef540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aef9d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1468961583.2326-30875764', '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 14:02:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 14:02:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:02:25 INFO - Using env: {'DISPLAY': ':0', 14:02:25 INFO - 'HOME': '/home/cltbld', 14:02:25 INFO - 'LANG': 'en_US.UTF-8', 14:02:25 INFO - 'LANGUAGE': 'en_US:en', 14:02:25 INFO - 'LOGNAME': 'cltbld', 14:02:25 INFO - 'MAIL': '/var/mail/cltbld', 14:02:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:25 INFO - 'MOZ_NO_REMOTE': '1', 14:02:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:25 INFO - 'NO_EM_RESTART': '1', 14:02:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:25 INFO - 'PWD': '/builds/slave/test', 14:02:25 INFO - 'SHELL': '/bin/bash', 14:02:25 INFO - 'SHLVL': '1', 14:02:25 INFO - 'TERM': 'linux', 14:02:25 INFO - 'TMOUT': '86400', 14:02:25 INFO - 'USER': 'cltbld', 14:02:25 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1468961583.2326-30875764', 14:02:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:25 INFO - '_': '/tools/buildbot/bin/python'} 14:02:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:25 INFO - Downloading/unpacking psutil>=0.7.1 14:02:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:02:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:02:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:02:27 INFO - Installing collected packages: psutil 14:02:27 INFO - Running setup.py install for psutil 14:02:27 INFO - building 'psutil._psutil_linux' extension 14:02:27 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 14:02:27 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 14:02:27 INFO - building 'psutil._psutil_posix' extension 14:02:27 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 14:02:27 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 14:02:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:02:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:02:27 INFO - Successfully installed psutil 14:02:27 INFO - Cleaning up... 14:02:27 INFO - Return code: 0 14:02:27 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:02: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')]} 14:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02: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')]} 14:02:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0563ba0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aee640>, '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 0x1aef540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aef9d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1468961583.2326-30875764', '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 14:02:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:02:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:02:27 INFO - Using env: {'DISPLAY': ':0', 14:02:27 INFO - 'HOME': '/home/cltbld', 14:02:27 INFO - 'LANG': 'en_US.UTF-8', 14:02:27 INFO - 'LANGUAGE': 'en_US:en', 14:02:27 INFO - 'LOGNAME': 'cltbld', 14:02:27 INFO - 'MAIL': '/var/mail/cltbld', 14:02:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:27 INFO - 'MOZ_NO_REMOTE': '1', 14:02:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:27 INFO - 'NO_EM_RESTART': '1', 14:02:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:27 INFO - 'PWD': '/builds/slave/test', 14:02:27 INFO - 'SHELL': '/bin/bash', 14:02:27 INFO - 'SHLVL': '1', 14:02:27 INFO - 'TERM': 'linux', 14:02:27 INFO - 'TMOUT': '86400', 14:02:27 INFO - 'USER': 'cltbld', 14:02:27 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1468961583.2326-30875764', 14:02:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:27 INFO - '_': '/tools/buildbot/bin/python'} 14:02:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:28 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:02:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:30 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:02:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:02:30 INFO - Installing collected packages: mozsystemmonitor 14:02:30 INFO - Running setup.py install for mozsystemmonitor 14:02:30 INFO - Successfully installed mozsystemmonitor 14:02:30 INFO - Cleaning up... 14:02:30 INFO - Return code: 0 14:02:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:02:30 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')]} 14:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:30 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')]} 14:02:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:30 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 0x7f0563ba0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aee640>, '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 0x1aef540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aef9d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1468961583.2326-30875764', '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 14:02:30 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 14:02:30 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 14:02:30 INFO - Using env: {'DISPLAY': ':0', 14:02:30 INFO - 'HOME': '/home/cltbld', 14:02:30 INFO - 'LANG': 'en_US.UTF-8', 14:02:30 INFO - 'LANGUAGE': 'en_US:en', 14:02:30 INFO - 'LOGNAME': 'cltbld', 14:02:30 INFO - 'MAIL': '/var/mail/cltbld', 14:02:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:30 INFO - 'MOZ_NO_REMOTE': '1', 14:02:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:30 INFO - 'NO_EM_RESTART': '1', 14:02:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:30 INFO - 'PWD': '/builds/slave/test', 14:02:30 INFO - 'SHELL': '/bin/bash', 14:02:30 INFO - 'SHLVL': '1', 14:02:30 INFO - 'TERM': 'linux', 14:02:30 INFO - 'TMOUT': '86400', 14:02:30 INFO - 'USER': 'cltbld', 14:02:30 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1468961583.2326-30875764', 14:02:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:30 INFO - '_': '/tools/buildbot/bin/python'} 14:02:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:30 INFO - Downloading/unpacking blobuploader==1.2.4 14:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:32 INFO - Downloading blobuploader-1.2.4.tar.gz 14:02:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:02:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:02:32 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 14:02:32 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 14:02:32 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 14:02:32 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 14:02:32 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 14:02:32 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 14:02:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:02:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:02:32 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 14:02:32 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 14:02:32 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 14:02:32 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 14:02:32 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 14:02:32 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 14:02:33 INFO - Downloading docopt-0.6.1.tar.gz 14:02:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:02:33 INFO - Installing collected packages: blobuploader, requests, docopt 14:02:33 INFO - Running setup.py install for blobuploader 14:02:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:02:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:02:33 INFO - Running setup.py install for requests 14:02:33 INFO - Running setup.py install for docopt 14:02:33 INFO - Successfully installed blobuploader requests docopt 14:02:33 INFO - Cleaning up... 14:02:33 INFO - Return code: 0 14:02:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:02: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')]} 14:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02: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')]} 14:02:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:33 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 0x7f0563ba0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aee640>, '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 0x1aef540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aef9d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1468961583.2326-30875764', '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 14:02:33 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 14:02:33 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 14:02:33 INFO - Using env: {'DISPLAY': ':0', 14:02:33 INFO - 'HOME': '/home/cltbld', 14:02:33 INFO - 'LANG': 'en_US.UTF-8', 14:02:33 INFO - 'LANGUAGE': 'en_US:en', 14:02:33 INFO - 'LOGNAME': 'cltbld', 14:02:33 INFO - 'MAIL': '/var/mail/cltbld', 14:02:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:33 INFO - 'MOZ_NO_REMOTE': '1', 14:02:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:33 INFO - 'NO_EM_RESTART': '1', 14:02:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:33 INFO - 'PWD': '/builds/slave/test', 14:02:33 INFO - 'SHELL': '/bin/bash', 14:02:33 INFO - 'SHLVL': '1', 14:02:33 INFO - 'TERM': 'linux', 14:02:33 INFO - 'TMOUT': '86400', 14:02:33 INFO - 'USER': 'cltbld', 14:02:33 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1468961583.2326-30875764', 14:02:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:33 INFO - '_': '/tools/buildbot/bin/python'} 14:02:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:02:33 INFO - Running setup.py (path:/tmp/pip-tkb5LM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:02:34 INFO - Running setup.py (path:/tmp/pip-KqyUk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:02:34 INFO - Running setup.py (path:/tmp/pip-vZX8YP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:02:34 INFO - Running setup.py (path:/tmp/pip-rueLUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:02:34 INFO - Running setup.py (path:/tmp/pip-CmiixI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:02:34 INFO - Running setup.py (path:/tmp/pip-Lmp99v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:02:34 INFO - Running setup.py (path:/tmp/pip-FTXHhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:02:34 INFO - Running setup.py (path:/tmp/pip-aVta9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:02:34 INFO - Running setup.py (path:/tmp/pip-I_ygQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:02:34 INFO - Running setup.py (path:/tmp/pip-GzCdgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:02:34 INFO - Running setup.py (path:/tmp/pip-_1sUSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:02:34 INFO - Running setup.py (path:/tmp/pip-vGCtHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:02:34 INFO - Running setup.py (path:/tmp/pip-bwjADu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:02:34 INFO - Running setup.py (path:/tmp/pip-WdE7HW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:02:34 INFO - Running setup.py (path:/tmp/pip-tXp10Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:02:35 INFO - Running setup.py (path:/tmp/pip-TRVcqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:02:35 INFO - Running setup.py (path:/tmp/pip-KwYVbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:02:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:02:35 INFO - Running setup.py install for manifestparser 14:02:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:02:35 INFO - Running setup.py install for mozcrash 14:02:35 INFO - Running setup.py install for mozdebug 14:02:35 INFO - Running setup.py install for mozdevice 14:02:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:02:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:02:35 INFO - Running setup.py install for mozfile 14:02:35 INFO - Running setup.py install for mozhttpd 14:02:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:02:35 INFO - Running setup.py install for mozinfo 14:02:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:02:35 INFO - Running setup.py install for mozInstall 14:02:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:02:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:02:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:02:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:02:35 INFO - Running setup.py install for mozleak 14:02:36 INFO - Running setup.py install for mozlog 14:02:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:02:36 INFO - Running setup.py install for moznetwork 14:02:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:02:36 INFO - Running setup.py install for mozprocess 14:02:36 INFO - Running setup.py install for mozprofile 14:02:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:02:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:02:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:02:36 INFO - Running setup.py install for mozrunner 14:02:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:02:36 INFO - Running setup.py install for mozscreenshot 14:02:36 INFO - Running setup.py install for moztest 14:02:36 INFO - Running setup.py install for mozversion 14:02:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:02:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:02:36 INFO - Cleaning up... 14:02:36 INFO - Return code: 0 14:02:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:02: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')]} 14:02:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02: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')]} 14:02:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:36 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 0x7f0563ba0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aee640>, '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 0x1aef540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aef9d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1468961583.2326-30875764', '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 14:02:36 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 14:02:36 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 14:02:36 INFO - Using env: {'DISPLAY': ':0', 14:02:36 INFO - 'HOME': '/home/cltbld', 14:02:36 INFO - 'LANG': 'en_US.UTF-8', 14:02:36 INFO - 'LANGUAGE': 'en_US:en', 14:02:36 INFO - 'LOGNAME': 'cltbld', 14:02:36 INFO - 'MAIL': '/var/mail/cltbld', 14:02:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:36 INFO - 'MOZ_NO_REMOTE': '1', 14:02:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:36 INFO - 'NO_EM_RESTART': '1', 14:02:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:36 INFO - 'PWD': '/builds/slave/test', 14:02:36 INFO - 'SHELL': '/bin/bash', 14:02:36 INFO - 'SHLVL': '1', 14:02:36 INFO - 'TERM': 'linux', 14:02:36 INFO - 'TMOUT': '86400', 14:02:36 INFO - 'USER': 'cltbld', 14:02:36 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1468961583.2326-30875764', 14:02:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:36 INFO - '_': '/tools/buildbot/bin/python'} 14:02:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:02:37 INFO - Running setup.py (path:/tmp/pip-RJ6U7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:02:37 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)) 14:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:02:37 INFO - Running setup.py (path:/tmp/pip-qoqrXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:02:37 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)) 14:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:02:37 INFO - Running setup.py (path:/tmp/pip-EkZ6VO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:02:37 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)) 14:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:02:37 INFO - Running setup.py (path:/tmp/pip-57j33n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:02:37 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)) 14:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:02:37 INFO - Running setup.py (path:/tmp/pip-wHk7mv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:02:37 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)) 14:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:02:37 INFO - Running setup.py (path:/tmp/pip-pU3ft_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:02:37 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)) 14:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:02:37 INFO - Running setup.py (path:/tmp/pip-w9ZV9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:02:37 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)) 14:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:02:37 INFO - Running setup.py (path:/tmp/pip-xxfSia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:02:37 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)) 14:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:02:37 INFO - Running setup.py (path:/tmp/pip-JcLQGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:02:37 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)) 14:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:02:37 INFO - Running setup.py (path:/tmp/pip-wxIAGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:02:37 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)) 14:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:02:37 INFO - Running setup.py (path:/tmp/pip-gvZxdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:02:37 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)) 14:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:02:37 INFO - Running setup.py (path:/tmp/pip-JRYzZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:02:38 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)) 14:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:02:38 INFO - Running setup.py (path:/tmp/pip-wlltbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:02:38 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)) 14:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:02:38 INFO - Running setup.py (path:/tmp/pip-q9xXo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:02:38 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)) 14:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:02:38 INFO - Running setup.py (path:/tmp/pip-slczSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:02:38 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)) 14:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:02:38 INFO - Running setup.py (path:/tmp/pip-eFiM2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:02:38 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)) 14:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:02:38 INFO - Running setup.py (path:/tmp/pip-c_rTo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:02:38 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)) 14:02:38 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)) 14:02:38 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)) 14:02:38 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)) 14:02:38 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)) 14:02:38 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)) 14:02:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:02:38 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 14:02:38 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 14:02:38 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 14:02:38 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 14:02:38 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 14:02:38 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 14:02:40 INFO - Downloading blessings-1.6.tar.gz 14:02:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:02:40 INFO - Installing collected packages: blessings 14:02:40 INFO - Running setup.py install for blessings 14:02:40 INFO - Successfully installed blessings 14:02:40 INFO - Cleaning up... 14:02:40 INFO - Return code: 0 14:02:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:02:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:02:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:02:40 INFO - Reading from file tmpfile_stdout 14:02:40 INFO - Current package versions: 14:02:40 INFO - argparse == 1.2.1 14:02:40 INFO - blessings == 1.6 14:02:40 INFO - blobuploader == 1.2.4 14:02:40 INFO - docopt == 0.6.1 14:02:40 INFO - manifestparser == 1.1 14:02:40 INFO - mozInstall == 1.12 14:02:40 INFO - mozcrash == 0.17 14:02:40 INFO - mozdebug == 0.1 14:02:40 INFO - mozdevice == 0.48 14:02:40 INFO - mozfile == 1.2 14:02:40 INFO - mozhttpd == 0.7 14:02:40 INFO - mozinfo == 0.9 14:02:40 INFO - mozleak == 0.1 14:02:40 INFO - mozlog == 3.1 14:02:40 INFO - moznetwork == 0.27 14:02:40 INFO - mozprocess == 0.22 14:02:40 INFO - mozprofile == 0.28 14:02:40 INFO - mozrunner == 6.11 14:02:40 INFO - mozscreenshot == 0.1 14:02:40 INFO - mozsystemmonitor == 0.0 14:02:40 INFO - moztest == 0.7 14:02:40 INFO - mozversion == 1.4 14:02:40 INFO - psutil == 3.1.1 14:02:40 INFO - requests == 1.2.3 14:02:40 INFO - wsgiref == 0.1.2 14:02:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:02:40 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')]} 14:02:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:40 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')]} 14:02:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:40 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 0x7f0563ba0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aee640>, '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 0x1aef540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aef9d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1468961583.2326-30875764', '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 14:02:40 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 14:02:40 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 14:02:40 INFO - Using env: {'DISPLAY': ':0', 14:02:40 INFO - 'HOME': '/home/cltbld', 14:02:40 INFO - 'LANG': 'en_US.UTF-8', 14:02:40 INFO - 'LANGUAGE': 'en_US:en', 14:02:40 INFO - 'LOGNAME': 'cltbld', 14:02:40 INFO - 'MAIL': '/var/mail/cltbld', 14:02:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:40 INFO - 'MOZ_NO_REMOTE': '1', 14:02:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:40 INFO - 'NO_EM_RESTART': '1', 14:02:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:40 INFO - 'PWD': '/builds/slave/test', 14:02:40 INFO - 'SHELL': '/bin/bash', 14:02:40 INFO - 'SHLVL': '1', 14:02:40 INFO - 'TERM': 'linux', 14:02:40 INFO - 'TMOUT': '86400', 14:02:40 INFO - 'USER': 'cltbld', 14:02:40 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1468961583.2326-30875764', 14:02:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:40 INFO - '_': '/tools/buildbot/bin/python'} 14:02:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:40 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)) 14:02:40 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)) 14:02:40 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)) 14:02:40 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)) 14:02:40 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)) 14:02:40 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)) 14:02:40 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)) 14:02:40 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)) 14:02:40 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)) 14:02:40 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)) 14:02:40 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)) 14:02:40 INFO - Cleaning up... 14:02:40 INFO - Return code: 0 14:02:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:02:40 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')]} 14:02:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:40 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')]} 14:02:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:40 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 0x7f0563ba0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aee640>, '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 0x1aef540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aef9d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1468961583.2326-30875764', '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 14:02:40 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 14:02:40 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 14:02:40 INFO - Using env: {'DISPLAY': ':0', 14:02:40 INFO - 'HOME': '/home/cltbld', 14:02:40 INFO - 'LANG': 'en_US.UTF-8', 14:02:40 INFO - 'LANGUAGE': 'en_US:en', 14:02:40 INFO - 'LOGNAME': 'cltbld', 14:02:40 INFO - 'MAIL': '/var/mail/cltbld', 14:02:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:40 INFO - 'MOZ_NO_REMOTE': '1', 14:02:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:40 INFO - 'NO_EM_RESTART': '1', 14:02:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:40 INFO - 'PWD': '/builds/slave/test', 14:02:40 INFO - 'SHELL': '/bin/bash', 14:02:40 INFO - 'SHLVL': '1', 14:02:40 INFO - 'TERM': 'linux', 14:02:40 INFO - 'TMOUT': '86400', 14:02:40 INFO - 'USER': 'cltbld', 14:02:40 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1468961583.2326-30875764', 14:02:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:40 INFO - '_': '/tools/buildbot/bin/python'} 14:02:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:41 INFO - Downloading/unpacking jsonschema 14:02: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 14:02: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 14:02: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 14:02: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 14:02: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 14:02: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 14:02:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:02:43 INFO - Downloading/unpacking functools32 (from jsonschema) 14:02:43 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 14:02:43 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 14:02:43 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 14:02:43 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 14:02:43 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 14:02:43 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 14:02:43 INFO - Downloading functools32-3.2.3-2.tar.gz 14:02:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:02:43 INFO - warning: no files found matching '*.txt' 14:02:43 INFO - no previously-included directories found matching 'build' 14:02:43 INFO - no previously-included directories found matching 'dist' 14:02:43 INFO - no previously-included directories found matching '.git*' 14:02:43 INFO - Installing collected packages: jsonschema, functools32 14:02:43 INFO - Running setup.py install for functools32 14:02:43 INFO - warning: no files found matching '*.txt' 14:02:43 INFO - no previously-included directories found matching 'build' 14:02:43 INFO - no previously-included directories found matching 'dist' 14:02:43 INFO - no previously-included directories found matching '.git*' 14:02:43 INFO - Successfully installed jsonschema functools32 14:02:43 INFO - Cleaning up... 14:02:43 INFO - Return code: 0 14:02:43 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:02:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:43 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 0x7f0563ba0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aee640>, '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 0x1aef540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aef9d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1468961583.2326-30875764', '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 14:02:43 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 14:02:43 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 14:02:43 INFO - Using env: {'DISPLAY': ':0', 14:02:43 INFO - 'HOME': '/home/cltbld', 14:02:43 INFO - 'LANG': 'en_US.UTF-8', 14:02:43 INFO - 'LANGUAGE': 'en_US:en', 14:02:43 INFO - 'LOGNAME': 'cltbld', 14:02:43 INFO - 'MAIL': '/var/mail/cltbld', 14:02:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:43 INFO - 'MOZ_NO_REMOTE': '1', 14:02:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:43 INFO - 'NO_EM_RESTART': '1', 14:02:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:43 INFO - 'PWD': '/builds/slave/test', 14:02:43 INFO - 'SHELL': '/bin/bash', 14:02:43 INFO - 'SHLVL': '1', 14:02:43 INFO - 'TERM': 'linux', 14:02:43 INFO - 'TMOUT': '86400', 14:02:43 INFO - 'USER': 'cltbld', 14:02:43 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1468961583.2326-30875764', 14:02:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:43 INFO - '_': '/tools/buildbot/bin/python'} 14:02:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:43 INFO - Downloading/unpacking flake8 14:02:43 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 14:02:43 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 14:02:43 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 14:02:43 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 14:02:43 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 14:02:43 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 14:02:45 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:02:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:02:45 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 14:02:45 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 14:02:45 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 14:02:45 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 14:02:45 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 14:02:45 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 14:02:45 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:02:45 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:02:45 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 14:02:45 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 14:02:45 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 14:02:45 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 14:02:45 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 14:02:45 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 14:02:46 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:02:46 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 14:02:46 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 14:02:46 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 14:02:46 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 14:02:46 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 14:02:46 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 14:02:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:02:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:02:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:02:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:02:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:02:46 INFO - no previously-included directories found matching 'docs/_build' 14:02:46 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:02:46 INFO - Running setup.py install for pep8 14:02:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:02:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:02:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:02:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:02:46 INFO - no previously-included directories found matching 'docs/_build' 14:02:46 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:02:46 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:02:46 INFO - Cleaning up... 14:02:46 INFO - Return code: 0 14:02:46 INFO - Running post-action listener: _resource_record_post_action 14:02:46 INFO - Running post-action listener: _start_resource_monitoring 14:02:46 INFO - Starting resource monitoring. 14:02:46 INFO - ##### 14:02:46 INFO - ##### Running install step. 14:02:46 INFO - ##### 14:02:46 INFO - Running pre-action listener: _resource_record_pre_action 14:02:46 INFO - Running main action method: install 14:02:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:02:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:02:46 INFO - Reading from file tmpfile_stdout 14:02:46 INFO - Detecting whether we're running mozinstall >=1.0... 14:02:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:02:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:02:47 INFO - Reading from file tmpfile_stdout 14:02:47 INFO - Output received: 14:02:47 INFO - Usage: mozinstall [options] installer 14:02:47 INFO - Options: 14:02:47 INFO - -h, --help show this help message and exit 14:02:47 INFO - -d DEST, --destination=DEST 14:02:47 INFO - Directory to install application into. [default: 14:02:47 INFO - "/builds/slave/test"] 14:02:47 INFO - --app=APP Application being installed. [default: firefox] 14:02:47 INFO - mkdir: /builds/slave/test/build/application 14:02:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:02:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:03:00 INFO - Reading from file tmpfile_stdout 14:03:00 INFO - Output received: 14:03:00 INFO - /builds/slave/test/build/application/firefox/firefox 14:03:00 INFO - Running post-action listener: _resource_record_post_action 14:03:00 INFO - ##### 14:03:00 INFO - ##### Running run-tests step. 14:03:00 INFO - ##### 14:03:00 INFO - Running pre-action listener: _resource_record_pre_action 14:03:00 INFO - Running main action method: run_tests 14:03:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:03:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:03:00 INFO - Python 2.7.3 14:03:00 INFO - Return code: 0 14:03:00 INFO - grabbing minidump binary from tooltool 14:03:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:00 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 0x1aee640>, '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 0x1aef540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aef9d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:03:00 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 14:03:00 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 14:03:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:03:00 INFO - Return code: 0 14:03:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:03:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:03:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:03:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:03:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:03:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:03:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:03:01 INFO - Return code: 0 14:03:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:03:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:03:01 INFO - Using env: {'DISPLAY': ':0', 14:03:01 INFO - 'HOME': '/home/cltbld', 14:03:01 INFO - 'LANG': 'en_US.UTF-8', 14:03:01 INFO - 'LANGUAGE': 'en_US:en', 14:03:01 INFO - 'LOGNAME': 'cltbld', 14:03:01 INFO - 'MAIL': '/var/mail/cltbld', 14:03:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:03:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:03:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:01 INFO - 'MOZ_NO_REMOTE': '1', 14:03:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:03:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:01 INFO - 'NO_EM_RESTART': '1', 14:03:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:01 INFO - 'PWD': '/builds/slave/test', 14:03:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:03:01 INFO - 'SHELL': '/bin/bash', 14:03:01 INFO - 'SHLVL': '1', 14:03:01 INFO - 'TERM': 'linux', 14:03:01 INFO - 'TMOUT': '86400', 14:03:01 INFO - 'USER': 'cltbld', 14:03:01 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1468961583.2326-30875764', 14:03:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:01 INFO - '_': '/tools/buildbot/bin/python'} 14:03:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:03:01 INFO - mozversion application_buildid: 20160719110521 14:03:01 INFO - mozversion application_changeset: 55cd3b01ca013495afc1f583e4eb9a9392199025 14:03:01 INFO - mozversion application_display_name: Firefox 14:03:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:03:01 INFO - mozversion application_name: Firefox 14:03:01 INFO - mozversion application_remotingname: firefox 14:03:01 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:03:01 INFO - mozversion application_vendor: Mozilla 14:03:01 INFO - mozversion application_version: 48.0 14:03:01 INFO - mozversion platform_buildid: 20160719110521 14:03:01 INFO - mozversion platform_changeset: 55cd3b01ca013495afc1f583e4eb9a9392199025 14:03:01 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:03:01 INFO - mozversion platform_version: 48.0 14:03:01 INFO - using testdate: 1468962181 14:03:01 INFO - actual date: 1468962181 14:03:01 INFO - starting webserver on 'localhost:40045' 14:03:01 INFO - SUITE-START | Running 2 tests 14:03:01 INFO - TEST-START | dromaeo_css 14:03:01 INFO - operating with platform_type : linux_ 14:03:01 INFO - Initialising browser for dromaeo_css test... 14:03:01 INFO - TEST-INFO | started process 5062 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxfThW_/profile http://localhost:40045/getInfo.html) 14:03:05 INFO - PROCESS | 5062 | 14:03:05 INFO - PROCESS | 5062 | (process:5140): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:03:06 INFO - PROCESS | 5062 | __metrics Screen width/height:1600/1200 14:03:06 INFO - PROCESS | 5062 | colorDepth:24 14:03:06 INFO - PROCESS | 5062 | Browser inner width/height: 1024/697 14:03:06 INFO - PROCESS | 5062 | __metrics 14:03:07 ERROR - PROCESS | 5062 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 14:03:08 INFO - TEST-INFO | 5062: exit 0 14:03:08 INFO - Browser initialized. 14:03:08 INFO - Running cycle 1/1 for dromaeo_css test... 14:03:08 INFO - TEST-INFO | started process 5190 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxfThW_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:03:09 INFO - PROCESS | 5190 | 14:03:09 INFO - PROCESS | 5190 | (process:5256): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:03:19 INFO - PROCESS | 5190 | RSS: Main: 150974464 14:03:19 INFO - PROCESS | 5190 | 14:04:09 INFO - PROCESS | 5190 | 1468962249550 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] 14:06:17 INFO - PROCESS | 5190 | Cycle 1(1): loaded http://localhost:40045/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40045/tests/dromaeo/cssquery-ext.html) 14:06:18 INFO - PROCESS | 5190 | RSS: Main: 154882048 14:06:18 INFO - PROCESS | 5190 | 14:09:19 INFO - PROCESS | 5190 | Cycle 1(1): loaded http://localhost:40045/tests/dromaeo/cssquery-ext.html (next: http://localhost:40045/tests/dromaeo/cssquery-jquery.html) 14:09:20 INFO - PROCESS | 5190 | RSS: Main: 152371200 14:09:20 INFO - PROCESS | 5190 | 14:12:22 INFO - PROCESS | 5190 | Cycle 1(1): loaded http://localhost:40045/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40045/tests/dromaeo/cssquery-mootools.html) 14:12:22 INFO - PROCESS | 5190 | RSS: Main: 152399872 14:12:22 INFO - PROCESS | 5190 | 14:15:24 INFO - PROCESS | 5190 | Cycle 1(1): loaded http://localhost:40045/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40045/tests/dromaeo/cssquery-prototype.html) 14:15:25 INFO - PROCESS | 5190 | RSS: Main: 153444352 14:15:25 INFO - PROCESS | 5190 | 14:18:27 INFO - PROCESS | 5190 | Cycle 1(1): loaded http://localhost:40045/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40045/tests/dromaeo/cssquery-yui.html) 14:18:28 INFO - PROCESS | 5190 | RSS: Main: 152072192 14:18:28 INFO - PROCESS | 5190 | 14:21:30 INFO - PROCESS | 5190 | Cycle 1(1): loaded http://localhost:40045/tests/dromaeo/cssquery-yui.html (next: http://localhost:40045/tests/dromaeo/cssquery-dojo.html) 14:21:30 INFO - PROCESS | 5190 | RSS: Main: 155897856 14:21:30 INFO - PROCESS | 5190 | 14:21:30 INFO - PROCESS | 5190 | __start_tp_report 14:21:30 INFO - PROCESS | 5190 | _x_x_mozilla_page_load 14:21:30 INFO - PROCESS | 5190 | _x_x_mozilla_page_load_details 14:21:30 INFO - PROCESS | 5190 | |i|pagename|runs| 14:21:30 INFO - PROCESS | 5190 | |0;dojo.html;3349.2129349602847;3407.7103446207066;3426.3489936912;3447.4311738563138;3471.409860323745;5660.716964151791;5688.089905615097;5704;5723.141528770687;5730.914036289454;5694.4590263924865;5715.142728590714;5721.799737009195;5722.656640601567;5740.167675687033;5133.845984620468;5144.17693169093;5181.740912954356;5203.765830537616;5232.895342093175;5107.540321371076;5112.642115051948;5124.385073791151;5302.840914772563;5342.0651386007485;5124.103281925667;5165.948340516603;5178.223266510016;5210.6613070150315;5231.947680523203;5178.663386879841;5199.740012999335;5220.060389129955;5226.81706140287;5260.053190425722;4979.427365852937;5071.087204303224;5120.564751996085;5141.84574462763;5196.558292545138;5494.395616482184;5527.281453411071;5565.165225216209;5577.05190117681;5616.69108199053;6065.60573562717;6078.908816367758;6080.756769729205;6106;6117.143599896018;6048.092786082079;6084.330723620398;6112.052631842072;6139.324674285825;6144.477719393857;5596.384397716248;5598.1322894951345;5604.327480702301;5608.85977850557;5639.774409023676;6077.270727512727;6079.8480037998515;6090.451859332681;6106.297775755845;6109.75560977556;5842.094475356326;5855.531557475391;5926.614770039933;6020;6045.395460454008;6066.636001839904;6074.301455332605;6081.087836824512;6084.421979911901;6085.665288409092;5996.070609055603;5999.520038396918;6037.45662890342;6042.486388657014;6047;5944.464998150187;5978.491828194565;6014.849628759229;6052.969735151296;6061.515078793686;4615.723056616614;4636.235021221461;4639.420072490939;4646.395968524071;4658.138244424725;4109.630133287958;4154.792260386968;4161.8335266589;4175.290200665894;4190;5684.34630017545;5801.883962320814;5855.853603659857;5863.853403664943;5893.528517718572;5972.104184372379;6013.128096425994;6029.517638588903;6045.848853778691;6054;5767.942320576824;5782.306123265235;5782.65304081748;5789.913151302734;5803.158542011384;5139.049275883974;5195.454477279831;5206.140986737146;5207.947920520822;5234.136367499396;6227.06594010893;6237.4698150656795;6240.563160578807;6261.99808030722;6268.749250029948;5991.071383935497;6001.219841420588;6005.759769609167;6060.848478788065;6143.201383820075;6386.87226255463;6438.259600146043;6444.516661250331;6473.611583305017;6475.222973243241;5959.4934430573885;6009.609375390585;6032.034874420072;6046.274447066205;6075.665838378932;6014.398560143951;6142.877142457215;6143.170671959407;6156.445919867234;6168.228971378578;5911.852203694942;5917.171595976481;5964.642121472725;5968.283805943314;5990.6705131218205;5892.528597712087;5920.3783602722815;5935.109733539831;5960.642361458326;5972;5691.117876729114;5814.244148260868;5854.180414742024;5865.149553314831;5943.465088142088;5931.5847890648965;5984.401559843981;6005.39946005396;6005.699715014144;6009.308929473166;5865.824025279248;5877.177195192591;5877.911831322619;5884.823455296348;5885.352611212677 14:21:30 INFO - PROCESS | 5190 | |1;ext.html;666.8399584099817;677.9593324247281;689.8413364926064;733.8605664923667;746.216472703661;40540.59459405405;41064.38403423951;41135.97160070996;41154.58845411545;41229.3815592766;44790.55209447905;45177;45185.54814451854;45300;45353.31970020452;8965.641374345018;9029.819403611924;9050.411723238001;9092.40899341544;9115.68095116671;8801.735947921541;8954.820903581924;8968.058353872848;8971.147740964598;8975.551222438884;9196.080391960817;9253.537323133816;9259.907400925971;9276.675316363928;9291.163795258426;9178.4034037788;9211.493367864798;9232.261419086457;9232.6306947722;9238.168564829164;9087.273018158532;9139.862902056475;9156.771080722969;9160.587773550205;9163.77090572741;44329.55670443319;44876;44897.326540101596;44990.32514512285;45030;3975.6421922026866;4050.2717189380824;4080.8571699990653;4168.6665066794585;4625.8149674013;31065;33424.66575334264;33878.49182262268;33880.15299617529;35152.12119697002;4565.383673204108;4573.153966516205;4585.426821647294;4612.538746125394;4623.12160689468;296077;296314.99999999785;297519;298633;299851;64295;64568.67715661485;64747;64782.35217647858;64789.352106478334;72765.63617181986;73359.26640733631;73510.63244683742;73783.2621673787;73981.63009185027;17131.143442827808;17281.654366912593;17339.739903901453;17362.91318543399;17366.565835854206;14750.188739619423;14814.703705925822;14897.329620166902;14905.627359316104;14921.40314387434;20670.586588268452;20697.68953465699;20867.8956605216;20884.477888052617;21626;7592.406594010655;7797.972527142871;7810.492317999312;7810.726624568113;8019.478733882279;1128.8306753986967;1148.7415331550335;1157.4039369724599;1162.9418529073682;1224.4306397525193;32132.35735285281;32531.838717076513;32810.50784238238;33496;33574.49638255428;1195.9701007474882;1237.6410840856051;1246.8129780532993;1306.4969986555245;1329.0895736420582;17126.21630801821;17410.825891741173;17742.379016734354;17829;17832.286708531774;479833;875223;923874;943993;944367;64544.67727661425;64622.35377646257;65146;65270.34729652643;65420.34579654143;1546.6906618676085;1556.7042261970416;1559.181429749368;1565.827758946515;1661.5015495351347;33622.495662564594;34404;34437.827810860785;34450.44972976172;34456.65543344535;56391.154132687225;57222.42777572171;57248;57375.71312143413;57384.42615573791;335757;336377;337064;338008;340749;31687.52468713017;32111.67888321087;32135.196620084684;32149.839250803598;32215.194620134684;51697.224541632655;52030;52221;52786.472135278156;52872.471275286756;43031.7848410756;43585;43756.56243437652;43907.78046109749;44990.100197996515;42657.146857062064;42903.57096428996;42941.141177175654;43213.78393108014;43551.346729798446;41022.38466422947;41290;46454.30318545292;47227.29159062548;47250.527494724614;33001.66998329986;35217.47173792344;36122;37000.81499592485;37377;28831.135065948056;29126.854365728035;29294;29477.705222948352;29623.703762962956 14:21:30 INFO - PROCESS | 5190 | |2;jquery.html;420.7433465585992;433.3543020898858;434.7587089165513;435.7516215757018;440.01217267235063;18404.90797546012;19249.326273580446;19256.133473993686;19797.604047919034;20607.484812879648;12700.682482937931;13012.804807927865;13250.933745331284;19610.70583941242;20536.589268214626;5455.099908515091;5637.548996080303;5649.067903795889;5652.547796176316;5666.235058267143;5619.690916999563;5894.440028197314;5896.764129434818;5902.2622172228475;5913.822585322448;5865;5872.207252020987;6124.785632502863;6422.389872962061;6430.93569064308;6254.312025677172;6356.3961423664905;6357.300696923335;6387.425131738142;6613.338666133396;5965.28416590012;5974.880502389928;5985.521158307325;6018.277806663228;6019.969900150471;14611.123332600078;18897.338593149172;21863.797491137982;23904.52190956171;24393.878030609732;2592.157548796649;2599.2202339298324;2616.947661046768;2619;3149.165471150147;10763.300385474997;10827.945860270649;10837.295575787628;10887.673369798918;13515.391807368693;2044.72396226509;2128.2338358191037;2225.6995305633695;2292.33522278539;2352.847064940773;76381;76478.61760691217;77987;78684.60657696732;79238;11787;11895.881041189477;11966.162368634112;12098.395080245953;12133.272003679807;16706.916465417595;16718.41485548;16820.663586728442;16833.747493787603;16853.578660533338;9133;9221.216196623362;9277.860832087525;9353.532323383804;9448.716538503855;8957.283417326598;8964;9002.414843035182;9038.457692538468;9050.592723327467;5118;5164.509371609691;5216;5268.683878967274;5287.365516138011;2081.438011736823;2129.4995676016124;2174.4346469917937;2218.8114010309305;2249.4601295688917;1100.8293714474269;1123.4831977290537;1136.5226604825828;1184.5025089462447;1224.063591352616;18494.907525462288;19136.330228441937;19315.710264346046;19381.4185574433;19744.60510789776;1095.9671209863716;1104.9337039777638;1105.4362275239685;1107.7618312062946;1134;10777.946110269555;11111.38887361203;11123;11129.554817807359;11176.832347514794;490871;491420;496642;510197;510539;72001;87060;91276.54361728282;99618;102016;1163.598558497317;1174.4890972427022;1177.534873724874;1199.6683681113957;1217.3608855350835;18109.818901810813;18137.183826728095;18197.45407637773;18305.359312424;18493.445196644123;40336.59663403328;40572.59427405688;40702.79648601738;41235;41428.79285603553;60131.39868601258;60709;61209.693951531735;61241.69379153076;61446;9029.593668284811;9086.409383390059;9129.5435228237;9305.906940930505;9354.158125768714;11969.820452693042;13267.80098298507;13360.599182024554;13599.52401665937;13887.51393701256;11878.168528202943;12038.157328986887;12191.573294934635;12261.632151035483;12272.140950133406;11630;11661.941690291495;11712.180147389941;11837.526498939946;11918.404079795802;11942.223755455867;12333.383330833602;12468.501259949864;12588.433520491417;12721.427535761099;8929.821403572023;8951.865722014045;9156.725298240797;9300.95349523275;9313.115254050854;9353.906460935303;12330.136890417944;12409.689757756129;12493.875061249635;12582.24506529611 14:21:30 INFO - PROCESS | 5190 | |3;mootools.html;1529.1436795394577;1572.0646215501772;1796.7664203653524;1890.073863806735;1923.5671973805904;7670.348020418257;8463.788405289872;8570.142985701426;8757.16806903344;8773.07882672319;8536.231739143475;8553.272971797405;8585.48487090775;8598;8598.269147122503;2424.8908799104083;2477.6159695247175;2480.255923223035;2480.8015358771345;2481.2755135181055;2395.365228214516;2416.565018296706;2435.3546310227803;2436.5979613363775;2449.644801503781;2481.2432208176497;2492.7382624824404;2525.9242222733346;2532.2529853693204;2538.834975726581;2422.9757702423017;2446.559619268531;2452.9754702453015;2457.803375729937;2478.876056197201;2440.19473573722;2458.840175388594;2464.753524647539;2475.777180053804;2488.4401009772837;8800.515971621558;8813.250873675745;8813.647454101829;8850.601722922484;8873.866891996626;5480.068388373986;5579.944200557983;5617.101263797814;5628.774849006035;5630.127330263816;3628.7641303315463;3631.382664946939;3673.3755261605593;3772.4907137536356;3777.2823163598828;1172.6013155527075;1182.0897908610407;1190.4880901212475;1204.1390405859765;1212.3271584270726;12634.684132896751;12696.17474864131;12731.363431828371;12740.36298185087;12743.681407964783;4740.786664600101;4844.176489996709;4889.462159162489;4899.853004409873;4906.043321552334;10515.94742026285;10599.682009539727;10612.257141999986;10620.575176992834;10636.149108071335;5536.169574563767;5541.667499950016;5555.8888822223325;5576.163575463713;5587.497125258747;4462.866114016585;4950.381202349707;5026.396832380065;5044.419891712427;5082.466341034138;4205.978970105191;4247.341662042327;4248.511421186541;4263.936040959388;4277.2942464493635;1325.9469621215044;1328.103530117167;1329.8869596084442;1330.5941687785319;1338.8125662407272;905.1536813079791;1029.4852573713144;1033.4367769565604;1033.5710680067687;1054.6256079091966;5775.595708300462;5898.793542226002;5933.792317268875;5962.642241465526;6008.759649614054;482.6766066735296;491.7492079039715;493.09270941467156;500.11479680965215;502.2917686062634;4265.573442655709;4281.100968796588;4359.455068116486;4362.563743625676;4366.366876802846;10813.945930270298;10987.725306867233;11103.944480277709;11193.66419007431;11204.66386008421;10874.782504349869;11019.118470522339;11033.889661103447;11039.779204415867;11051.502682379312;8063.314618257514;8315.168483151758;8377.539235342114;8394.412391132684;8455.069942306342;5997.850053748692;6023.548233882389;6033.396660333931;6118.235220597426;6135.601185922901;9607.615695372107;9738.123568878835;9895;9899.455529945923;10123.696289111338;9915.65295214664;10002.349847259904;10039.4478303694;10168.694939151837;10226.948865255923;7796.571188584682;7887.211278872067;7918.722844700408;8017.559034253172;8072.071711753224;8428.957855210685;8455.196756308142;8459.788505287172;8500.14998500145;8505.192006759347;7309.926900730925;7525.548467091992;7526.698932042876;7553.773386798405;7711.922880771121;7680.155182929985;7755.7673269802;7834.138244793182;7835.098963619029;7892.763217103496;7035.753748618774;7039.436845052486;7042.436605071684;7062.0466237057335;7067;5300.337457817773;5308.548773354308;5378.677279363251;5406.7837286509675;5437.429069947599;5178.844634660966;5205.349331333583;5252.711100889335;5303.231031500488;5346.278252436027 14:21:30 INFO - PROCESS | 5190 | |4;prototype.html;353.04325278495276;354.53201773658765;360.8791054996576;365.0508677438658;369.0312928562523;6359.65021923794;6460.644664543448;6533.705983230754;6592.604443733379;6616.636085015316;6493.675316234181;6520.70656820443;6527.5104367172535;6564.967175164117;6569.178852643419;4963.975180124095;4971.627127965399;4979;4981.178105612569;4983.053219888227;4943.961768028718;4975.835511552486;4988.052270068693;4999.775010124535;5005.02402031604;4917.164082106033;4947.1589829728855;4948.7278199699;4954.1330267203275;4958.603311735053;4709.835155769566;4851.708897466128;4940.851774446773;4946.802127914897;4959.57843583294;4247.086876321575;4254.489461264637;4257.084726783725;4261.97869010653;4264.061906380592;6278.4663303619245;6280.623162610258;6289.056641503766;6290.402411770874;6296.716647750816;5692.715364231772;5714.457126572969;5721.485066344049;5722.055860782966;5725.227094342252;6917.13535808024;6917.9308206917785;6923.238443771181;6925.272846351111;6929.3070692930805;4614.100250451163;4749.050189962021;4776.331313616097;4785.090832741768;4785.904281914342;7100.28997100291;7161.856762864765;7193;7215.530990485601;7275.527090739138;4828.203346447796;4828.227483602606;4840.515948405131;4861.756912154378;4869.440014398318;4925.1873440881855;4928.433230178503;4931.161702510582;4934.284528743312;4937.604991600663;5678.602497825195;5681.914771278434;5683.460071293303;5685.658860468302;5687.51656109227;6887.621180835102;6987.336203060701;6997.510174287852;6997.685104170325;7005.964970175219;1714.0658341204073;1730.368415528323;1737.2963949600432;1740.3299729604194;1742.9738553921702;1118.765059337532;1132.0717012050204;1137.4653912661036;1150.9482073306722;1152.1358980764426;6634.96682516594;6751.223609284897;6762.864742705118;6766.323367663194;6767.526273160832;7115.466340024519;7123.608201548861;7129.857402851914;7160.10498687664;7220.169680486706;6659;6697.933020669731;6701.760174367758;6706.463482921355;6753.696083676246;3796.3166630006863;3849.6920246380223;3854.6530812227033;3858.82635281413;3868.01365651757;7439.665215065335;7702;7706.306432421109;7719.729809456642;7795.986521752249;7357.852842943111;7392;7414.777556673308;7415.073115860518;7460.925390746132;7649.082110146706;7656.9234307657325;7664.923350766532;7668.578228197391;7680.3087722104165;7086.114235720535;7197.640117993975;7207.495475316888;7214.098237720285;7230.060092187982;7073.115860517435;7132.821679458055;7140.714371425085;7144;7149.249328820607;7595.962020189863;7619.390448764197;7623.733169339046;7636.847263054597;7644.273793989562;4820.084184005028;4896;4907.214845624683;4910.92633610489;4911.656184067081;6940.722371105099;7222.638868056471;7233.963830180815;7237.276272372721;7254.419646428168;7034.402075823612;7048.118985126859;7056.682449289691;7095.82260443493;7140.321669441395;6941.826454338682;6995.125609298838;6998.545094568837;7000.719971201095;7015.123109611299;6851.725930962905;6856.142982127234;6861.073755043205;6861.965690171517;6869.862602748017;6839.658017099225;6968.303169683194;7000;7013.509054366145;7039.612821294878;6616.503762217949;6800.625965571941;6873.862522749417;6896.551724137915;6915.965420172867 14:21:30 INFO - PROCESS | 5190 | |5;yui.html;929.6746138851407;939.3424602778056;953.4946478366468;964.6189755046752;975.9316847820651;13117.54088606899;13344.666383340422;13438.260895650736;13446.991475639317;13480.056396052256;14347.497837575687;14479.13125212488;14486.637834054154;14495.20276384801;14501;764.4457768118111;914.0356923445762;931.1433481197315;932.6362718539775;938.6386241297082;902.7562558109306;915.4049867586056;918.5131880103556;920.8572671235969;923.3905622289291;979.8824141103078;980.4362491567342;981.7349315684761;982.7641366072127;987.6641941739807;969.0890562870914;976.2385339435252;977.5258999385328;981.7005813226963;984.0356450678339;716.9605671688055;718.0378293087288;718.2099690340583;721.0770214125927;721.3940290156294;14942.850571494255;14950.40198392063;14965.251737413195;15002.849971500254;15049.699006019928;14354.92822535891;14497.42010319586;14561.053531520523;14580.198089105095;14828.629284267872;11944.289248942458;12054.15620906537;12143.817842732366;12329.198602090835;12488.063395245303;4096.139810639769;4101.343784994417;4190.07818279981;4273;4303.978480107611;55720.164197537066;55743.72128139374;56586;57496;57728.13407798886;11614.76770464586;11860.822087668692;11910.821337679941;11912.225705329125;11953.40232988347;20982.265620703507;21289;21580.676289855666;21600.459988500414;21670.241541546286;8590.264499681296;8881.42270752399;8883.289336853037;8916.28669706435;9018.954905225432;4906.852794416173;5026.095302845523;5050.04049230645;5079.8984020319385;5154.7164905929785;3799.981000095037;3836.0601652594733;3845.538535375773;3854.6723528500393;3864.53625564934;694.7915625312386;696.3837004251274;713.5076797010047;713.614648090036;723.5080145501005;835.4694768821842;839.689314953459;848.2704873808519;872.2237208884098;875.4484674655054;9682.128608425135;9720.708378748648;9835.311528192959;10148.797024059477;10247.38515689061;805.1103530598721;808.272554700774;821.765796747924;825.8059356051323;831.4720152702956;4479.820807167742;4490.932636010462;4568.931466028012;4584.312353146988;4599.195140850338;64575.35424645693;66310;66433;66477.66761166163;66567.66716166388;58059.41940580625;58381.70809145927;58437.70781146067;58856.705716471144;59055.70472147612;52757.7362113187;53431.73284133632;53459.46540534545;53564.46435535673;53710.462895371325;9012.504312262889;9039.774005649911;9050;9115.589798459217;9187.03536128697;38384.616153838106;39572;40088.799556002035;40094.79715608536;41068.794656026526;46375.53624463712;47210;49540.75229623829;49777.502224978736;50511.74744126256;11555.422228888354;11663.537999611628;11793;11795.823062653895;12122.575709850113;12761.93619031899;13038.282894440898;13314.733705326033;13409.396577153857;13422.664433389244;11472.541098355972;11828.349440780496;12064.75870482603;12299.200551964093;12495.312757798409;11959.701007474883;12395.566155184526;12456.31490268044;12576.811347829973;12958.546450874552;11536.192466527262;12028.398580071136;12310.446029928495;12463.626091216915;12736.61790146297;10467.685969420929;10733.409662468639;10781.245312828027;11077.279976801483;11318.151138664798;11353.432328383382;11358.375289359165;11360.54557817678;11490.368029758443;11631.185816993067 14:21:30 INFO - PROCESS | 5190 | __end_tp_report 14:21:30 INFO - PROCESS | 5190 | __start_cc_report 14:21:30 INFO - PROCESS | 5190 | _x_x_mozilla_cycle_collect,322 14:21:30 INFO - PROCESS | 5190 | __end_cc_report 14:21:30 INFO - PROCESS | 5190 | __startTimestamp1468963290463__endTimestamp 14:21:30 INFO - PROCESS | 5190 | 14:21:30 INFO - PROCESS | 5190 | ------- Summary: start ------- 14:21:30 INFO - PROCESS | 5190 | Number of tests: 6 14:21:30 INFO - PROCESS | 5190 | 14:21:30 INFO - PROCESS | 5190 | [#0] dojo.html Cycles:165 Average:5645.84 Median:5877.91 stddev:625.48 (10.6%) stddev-sans-first:600.89 14:21:30 INFO - PROCESS | 5190 | Values: 3349.2 3407.7 3426.3 3447.4 3471.4 5660.7 5688.1 5704.0 5723.1 5730.9 5694.5 5715.1 5721.8 5722.7 5740.2 5133.8 5144.2 5181.7 5203.8 5232.9 5107.5 5112.6 5124.4 5302.8 5342.1 5124.1 5165.9 5178.2 5210.7 5231.9 5178.7 5199.7 5220.1 5226.8 5260.1 4979.4 5071.1 5120.6 5141.8 5196.6 5494.4 5527.3 5565.2 5577.1 5616.7 6065.6 6078.9 6080.8 6106.0 6117.1 6048.1 6084.3 6112.1 6139.3 6144.5 5596.4 5598.1 5604.3 5608.9 5639.8 6077.3 6079.8 6090.5 6106.3 6109.8 5842.1 5855.5 5926.6 6020.0 6045.4 6066.6 6074.3 6081.1 6084.4 6085.7 5996.1 5999.5 6037.5 6042.5 6047.0 5944.5 5978.5 6014.8 6053.0 6061.5 4615.7 4636.2 4639.4 4646.4 4658.1 4109.6 4154.8 4161.8 4175.3 4190.0 5684.3 5801.9 5855.9 5863.9 5893.5 5972.1 6013.1 6029.5 6045.8 6054.0 5767.9 5782.3 5782.7 5789.9 5803.2 5139.0 5195.5 5206.1 5207.9 5234.1 6227.1 6237.5 6240.6 6262.0 6268.7 5991.1 6001.2 6005.8 6060.8 6143.2 6386.9 6438.3 6444.5 6473.6 6475.2 5959.5 6009.6 6032.0 6046.3 6075.7 6014.4 6142.9 6143.2 6156.4 6168.2 5911.9 5917.2 5964.6 5968.3 5990.7 5892.5 5920.4 5935.1 5960.6 5972.0 5691.1 5814.2 5854.2 5865.1 5943.5 5931.6 5984.4 6005.4 6005.7 6009.3 5865.8 5877.2 5877.9 5884.8 5885.4 14:21:30 INFO - PROCESS | 5190 | 14:21:30 INFO - PROCESS | 5190 | [#1] ext.html Cycles:180 Average:66088.22 Median:43382.57 stddev:150562.28 (347.1%) stddev-sans-first:150904.53 14:21:30 INFO - PROCESS | 5190 | Values: 666.8 678.0 689.8 733.9 746.2 40540.6 41064.4 41136.0 41154.6 41229.4 44790.6 45177.0 45185.5 45300.0 45353.3 8965.6 9029.8 9050.4 9092.4 9115.7 8801.7 8954.8 8968.1 8971.1 8975.6 9196.1 9253.5 9259.9 9276.7 9291.2 9178.4 9211.5 9232.3 9232.6 9238.2 9087.3 9139.9 9156.8 9160.6 9163.8 44329.6 44876.0 44897.3 44990.3 45030.0 3975.6 4050.3 4080.9 4168.7 4625.8 31065.0 33424.7 33878.5 33880.2 35152.1 4565.4 4573.2 4585.4 4612.5 4623.1 296077.0 296315.0 297519.0 298633.0 299851.0 64295.0 64568.7 64747.0 64782.4 64789.4 72765.6 73359.3 73510.6 73783.3 73981.6 17131.1 17281.7 17339.7 17362.9 17366.6 14750.2 14814.7 14897.3 14905.6 14921.4 20670.6 20697.7 20867.9 20884.5 21626.0 7592.4 7798.0 7810.5 7810.7 8019.5 1128.8 1148.7 1157.4 1162.9 1224.4 32132.4 32531.8 32810.5 33496.0 33574.5 1196.0 1237.6 1246.8 1306.5 1329.1 17126.2 17410.8 17742.4 17829.0 17832.3 479833.0 875223.0 923874.0 943993.0 944367.0 64544.7 64622.4 65146.0 65270.3 65420.3 1546.7 1556.7 1559.2 1565.8 1661.5 33622.5 34404.0 34437.8 34450.4 34456.7 56391.2 57222.4 57248.0 57375.7 57384.4 335757.0 336377.0 337064.0 338008.0 340749.0 31687.5 32111.7 32135.2 32149.8 32215.2 51697.2 52030.0 52221.0 52786.5 52872.5 43031.8 43585.0 43756.6 43907.8 44990.1 42657.1 42903.6 42941.1 43213.8 43551.3 41022.4 41290.0 46454.3 47227.3 47250.5 33001.7 35217.5 36122.0 37000.8 37377.0 28831.1 29126.9 29294.0 29477.7 29623.7 14:21:30 INFO - PROCESS | 5190 | 14:21:30 INFO - PROCESS | 5190 | [#2] jquery.html Cycles:180 Average:29407.76 Median:2270.90 stddev:82282.11 (3623.3%) stddev-sans-first:82484.15 14:21:30 INFO - PROCESS | 5190 | Values: 420.7 433.4 434.8 435.8 440.0 18404.9 19249.3 19256.1 19797.6 20607.5 12700.7 13012.8 13250.9 19610.7 20536.6 5455.1 5637.5 5649.1 5652.5 5666.2 5619.7 5894.4 5896.8 5902.3 5913.8 5865.0 5872.2 6124.8 6422.4 6430.9 6254.3 6356.4 6357.3 6387.4 6613.3 5965.3 5974.9 5985.5 6018.3 6020.0 14611.1 18897.3 21863.8 23904.5 24393.9 2592.2 2599.2 2616.9 2619.0 3149.2 10763.3 10827.9 10837.3 10887.7 13515.4 2044.7 2128.2 2225.7 2292.3 2352.8 76381.0 76478.6 77987.0 78684.6 79238.0 11787.0 11895.9 11966.2 12098.4 12133.3 16706.9 16718.4 16820.7 16833.7 16853.6 9133.0 9221.2 9277.9 9353.5 9448.7 8957.3 8964.0 9002.4 9038.5 9050.6 5118.0 5164.5 5216.0 5268.7 5287.4 2081.4 2129.5 2174.4 2218.8 2249.5 1100.8 1123.5 1136.5 1184.5 1224.1 18494.9 19136.3 19315.7 19381.4 19744.6 1096.0 1104.9 1105.4 1107.8 1134.0 10777.9 11111.4 11123.0 11129.6 11176.8 490871.0 491420.0 496642.0 510197.0 510539.0 72001.0 87060.0 91276.5 99618.0 102016.0 1163.6 1174.5 1177.5 1199.7 1217.4 18109.8 18137.2 18197.5 18305.4 18493.4 40336.6 40572.6 40702.8 41235.0 41428.8 60131.4 60709.0 61209.7 61241.7 61446.0 9029.6 9086.4 9129.5 9305.9 9354.2 11969.8 13267.8 13360.6 13599.5 13887.5 11878.2 12038.2 12191.6 12261.6 12272.1 11630.0 11661.9 11712.2 11837.5 11918.4 11942.2 12333.4 12468.5 12588.4 12721.4 8929.8 8951.9 9156.7 9301.0 9313.1 9353.9 12330.1 12409.7 12493.9 12582.2 14:21:30 INFO - PROCESS | 5190 | 14:21:30 INFO - PROCESS | 5190 | [#3] mootools.html Cycles:180 Average:5892.70 Median:2698.90 stddev:3285.49 (121.7%) stddev-sans-first:3278.34 14:21:30 INFO - PROCESS | 5190 | Values: 1529.1 1572.1 1796.8 1890.1 1923.6 7670.3 8463.8 8570.1 8757.2 8773.1 8536.2 8553.3 8585.5 8598.0 8598.3 2424.9 2477.6 2480.3 2480.8 2481.3 2395.4 2416.6 2435.4 2436.6 2449.6 2481.2 2492.7 2525.9 2532.3 2538.8 2423.0 2446.6 2453.0 2457.8 2478.9 2440.2 2458.8 2464.8 2475.8 2488.4 8800.5 8813.3 8813.6 8850.6 8873.9 5480.1 5579.9 5617.1 5628.8 5630.1 3628.8 3631.4 3673.4 3772.5 3777.3 1172.6 1182.1 1190.5 1204.1 1212.3 12634.7 12696.2 12731.4 12740.4 12743.7 4740.8 4844.2 4889.5 4899.9 4906.0 10515.9 10599.7 10612.3 10620.6 10636.1 5536.2 5541.7 5555.9 5576.2 5587.5 4462.9 4950.4 5026.4 5044.4 5082.5 4206.0 4247.3 4248.5 4263.9 4277.3 1325.9 1328.1 1329.9 1330.6 1338.8 905.2 1029.5 1033.4 1033.6 1054.6 5775.6 5898.8 5933.8 5962.6 6008.8 482.7 491.7 493.1 500.1 502.3 4265.6 4281.1 4359.5 4362.6 4366.4 10813.9 10987.7 11103.9 11193.7 11204.7 10874.8 11019.1 11033.9 11039.8 11051.5 8063.3 8315.2 8377.5 8394.4 8455.1 5997.9 6023.5 6033.4 6118.2 6135.6 9607.6 9738.1 9895.0 9899.5 10123.7 9915.7 10002.3 10039.4 10168.7 10226.9 7796.6 7887.2 7918.7 8017.6 8072.1 8429.0 8455.2 8459.8 8500.1 8505.2 7309.9 7525.5 7526.7 7553.8 7711.9 7680.2 7755.8 7834.1 7835.1 7892.8 7035.8 7039.4 7042.4 7062.0 7067.0 5300.3 5308.5 5378.7 5406.8 5437.4 5178.8 5205.3 5252.7 5303.2 5346.3 14:21:30 INFO - PROCESS | 5190 | 14:21:30 INFO - PROCESS | 5190 | [#4] prototype.html Cycles:180 Average:5819.96 Median:6625.80 stddev:1793.29 (27.1%) stddev-sans-first:1750.75 14:21:30 INFO - PROCESS | 5190 | Values: 353.0 354.5 360.9 365.1 369.0 6359.7 6460.6 6533.7 6592.6 6616.6 6493.7 6520.7 6527.5 6565.0 6569.2 4964.0 4971.6 4979.0 4981.2 4983.1 4944.0 4975.8 4988.1 4999.8 5005.0 4917.2 4947.2 4948.7 4954.1 4958.6 4709.8 4851.7 4940.9 4946.8 4959.6 4247.1 4254.5 4257.1 4262.0 4264.1 6278.5 6280.6 6289.1 6290.4 6296.7 5692.7 5714.5 5721.5 5722.1 5725.2 6917.1 6917.9 6923.2 6925.3 6929.3 4614.1 4749.1 4776.3 4785.1 4785.9 7100.3 7161.9 7193.0 7215.5 7275.5 4828.2 4828.2 4840.5 4861.8 4869.4 4925.2 4928.4 4931.2 4934.3 4937.6 5678.6 5681.9 5683.5 5685.7 5687.5 6887.6 6987.3 6997.5 6997.7 7006.0 1714.1 1730.4 1737.3 1740.3 1743.0 1118.8 1132.1 1137.5 1150.9 1152.1 6635.0 6751.2 6762.9 6766.3 6767.5 7115.5 7123.6 7129.9 7160.1 7220.2 6659.0 6697.9 6701.8 6706.5 6753.7 3796.3 3849.7 3854.7 3858.8 3868.0 7439.7 7702.0 7706.3 7719.7 7796.0 7357.9 7392.0 7414.8 7415.1 7460.9 7649.1 7656.9 7664.9 7668.6 7680.3 7086.1 7197.6 7207.5 7214.1 7230.1 7073.1 7132.8 7140.7 7144.0 7149.2 7596.0 7619.4 7623.7 7636.8 7644.3 4820.1 4896.0 4907.2 4910.9 4911.7 6940.7 7222.6 7234.0 7237.3 7254.4 7034.4 7048.1 7056.7 7095.8 7140.3 6941.8 6995.1 6998.5 7000.7 7015.1 6851.7 6856.1 6861.1 6862.0 6869.9 6839.7 6968.3 7000.0 7013.5 7039.6 6616.5 6800.6 6873.9 6896.6 6916.0 14:21:30 INFO - PROCESS | 5190 | 14:21:30 INFO - PROCESS | 5190 | [#5] yui.html Cycles:180 Average:15648.75 Median:4591.75 stddev:18255.16 (397.6%) stddev-sans-first:18272.90 14:21:30 INFO - PROCESS | 5190 | Values: 929.7 939.3 953.5 964.6 975.9 13117.5 13344.7 13438.3 13447.0 13480.1 14347.5 14479.1 14486.6 14495.2 14501.0 764.4 914.0 931.1 932.6 938.6 902.8 915.4 918.5 920.9 923.4 979.9 980.4 981.7 982.8 987.7 969.1 976.2 977.5 981.7 984.0 717.0 718.0 718.2 721.1 721.4 14942.9 14950.4 14965.3 15002.8 15049.7 14354.9 14497.4 14561.1 14580.2 14828.6 11944.3 12054.2 12143.8 12329.2 12488.1 4096.1 4101.3 4190.1 4273.0 4304.0 55720.2 55743.7 56586.0 57496.0 57728.1 11614.8 11860.8 11910.8 11912.2 11953.4 20982.3 21289.0 21580.7 21600.5 21670.2 8590.3 8881.4 8883.3 8916.3 9019.0 4906.9 5026.1 5050.0 5079.9 5154.7 3800.0 3836.1 3845.5 3854.7 3864.5 694.8 696.4 713.5 713.6 723.5 835.5 839.7 848.3 872.2 875.4 9682.1 9720.7 9835.3 10148.8 10247.4 805.1 808.3 821.8 825.8 831.5 4479.8 4490.9 4568.9 4584.3 4599.2 64575.4 66310.0 66433.0 66477.7 66567.7 58059.4 58381.7 58437.7 58856.7 59055.7 52757.7 53431.7 53459.5 53564.5 53710.5 9012.5 9039.8 9050.0 9115.6 9187.0 38384.6 39572.0 40088.8 40094.8 41068.8 46375.5 47210.0 49540.8 49777.5 50511.7 11555.4 11663.5 11793.0 11795.8 12122.6 12761.9 13038.3 13314.7 13409.4 13422.7 11472.5 11828.3 12064.8 12299.2 12495.3 11959.7 12395.6 12456.3 12576.8 12958.5 11536.2 12028.4 12310.4 12463.6 12736.6 10467.7 10733.4 10781.2 11077.3 11318.2 11353.4 11358.4 11360.5 11490.4 11631.2 14:21:30 INFO - PROCESS | 5190 | -------- Summary: end -------- 14:21:30 INFO - PROCESS | 5190 | 14:21:31 INFO - TEST-INFO | 5190: exit 0 14:21:31 INFO - TEST-OK | dromaeo_css | took 1109782ms 14:21:31 INFO - TEST-START | kraken 14:21:31 INFO - operating with platform_type : linux_ 14:21:31 INFO - Initialising browser for kraken test... 14:21:31 INFO - TEST-INFO | started process 5432 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT7E558/profile http://localhost:40045/getInfo.html) 14:21:35 INFO - PROCESS | 5432 | 14:21:35 INFO - PROCESS | 5432 | (process:5506): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:21:35 INFO - PROCESS | 5432 | __metrics Screen width/height:1600/1200 14:21:35 INFO - PROCESS | 5432 | colorDepth:24 14:21:35 INFO - PROCESS | 5432 | Browser inner width/height: 1024/697 14:21:35 INFO - PROCESS | 5432 | __metrics 14:21:36 ERROR - PROCESS | 5432 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 14:21:37 INFO - TEST-INFO | 5432: exit 0 14:21:37 INFO - Browser initialized. 14:21:37 INFO - Running cycle 1/1 for kraken test... 14:21:37 INFO - TEST-INFO | started process 5556 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT7E558/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:21:39 INFO - PROCESS | 5556 | 14:21:39 INFO - PROCESS | 5556 | (process:5624): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:21:49 INFO - PROCESS | 5556 | RSS: Main: 150949888 14:21:49 INFO - PROCESS | 5556 | 14:21:51 INFO - PROCESS | 5556 | Cycle 1(1): loaded http://localhost:40045/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40045/tests/kraken/driver.html?testName=audio-beat-detection) 14:21:52 INFO - PROCESS | 5556 | RSS: Main: 155934720 14:21:52 INFO - PROCESS | 5556 | 14:21:55 INFO - PROCESS | 5556 | Cycle 1(1): loaded http://localhost:40045/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40045/tests/kraken/driver.html?testName=audio-dft) 14:21:55 INFO - PROCESS | 5556 | RSS: Main: 155889664 14:21:55 INFO - PROCESS | 5556 | 14:21:58 INFO - PROCESS | 5556 | Cycle 1(1): loaded http://localhost:40045/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40045/tests/kraken/driver.html?testName=audio-fft) 14:21:59 INFO - PROCESS | 5556 | RSS: Main: 156106752 14:21:59 INFO - PROCESS | 5556 | 14:22:01 INFO - PROCESS | 5556 | Cycle 1(1): loaded http://localhost:40045/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40045/tests/kraken/driver.html?testName=audio-oscillator) 14:22:02 INFO - PROCESS | 5556 | RSS: Main: 156487680 14:22:02 INFO - PROCESS | 5556 | 14:22:04 INFO - PROCESS | 5556 | Cycle 1(1): loaded http://localhost:40045/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40045/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:22:04 INFO - PROCESS | 5556 | RSS: Main: 156454912 14:22:04 INFO - PROCESS | 5556 | 14:22:07 INFO - PROCESS | 5556 | Cycle 1(1): loaded http://localhost:40045/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40045/tests/kraken/driver.html?testName=imaging-darkroom) 14:22:08 INFO - PROCESS | 5556 | RSS: Main: 155856896 14:22:08 INFO - PROCESS | 5556 | 14:22:11 INFO - PROCESS | 5556 | Cycle 1(1): loaded http://localhost:40045/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40045/tests/kraken/driver.html?testName=imaging-desaturate) 14:22:12 INFO - PROCESS | 5556 | RSS: Main: 156262400 14:22:12 INFO - PROCESS | 5556 | 14:22:15 INFO - PROCESS | 5556 | Cycle 1(1): loaded http://localhost:40045/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40045/tests/kraken/driver.html?testName=json-parse-financial) 14:22:15 INFO - PROCESS | 5556 | RSS: Main: 156725248 14:22:15 INFO - PROCESS | 5556 | 14:22:17 INFO - PROCESS | 5556 | Cycle 1(1): loaded http://localhost:40045/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40045/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:22:18 INFO - PROCESS | 5556 | RSS: Main: 156327936 14:22:18 INFO - PROCESS | 5556 | 14:22:19 INFO - PROCESS | 5556 | Cycle 1(1): loaded http://localhost:40045/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40045/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:22:20 INFO - PROCESS | 5556 | RSS: Main: 156106752 14:22:20 INFO - PROCESS | 5556 | 14:22:22 INFO - PROCESS | 5556 | Cycle 1(1): loaded http://localhost:40045/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40045/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:22:23 INFO - PROCESS | 5556 | RSS: Main: 156880896 14:22:23 INFO - PROCESS | 5556 | 14:22:25 INFO - PROCESS | 5556 | Cycle 1(1): loaded http://localhost:40045/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40045/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:22:26 INFO - PROCESS | 5556 | RSS: Main: 156950528 14:22:26 INFO - PROCESS | 5556 | 14:22:28 INFO - PROCESS | 5556 | Cycle 1(1): loaded http://localhost:40045/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40045/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:22:29 INFO - PROCESS | 5556 | RSS: Main: 156684288 14:22:29 INFO - PROCESS | 5556 | 14:22:31 INFO - PROCESS | 5556 | Cycle 1(1): loaded http://localhost:40045/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40045/tests/kraken/driver.html?testName=ai-astar) 14:22:31 INFO - PROCESS | 5556 | RSS: Main: 158388224 14:22:31 INFO - PROCESS | 5556 | 14:22:31 INFO - PROCESS | 5556 | __start_tp_report 14:22:31 INFO - PROCESS | 5556 | _x_x_mozilla_page_load 14:22:31 INFO - PROCESS | 5556 | _x_x_mozilla_page_load_details 14:22:31 INFO - PROCESS | 5556 | |i|pagename|runs| 14:22:31 INFO - PROCESS | 5556 | |0;ai-astar;110;111;103;108;110;112;100;110;110;110 14:22:31 INFO - PROCESS | 5556 | |1;audio-beat-detection;154;132;156;172;127;154;154;135;172;127 14:22:31 INFO - PROCESS | 5556 | |2;audio-dft;162;162;160;163;161;162;160;162;162;160 14:22:31 INFO - PROCESS | 5556 | |3;audio-fft;76;76;75;164;77;76;76;74;176;76 14:22:31 INFO - PROCESS | 5556 | |4;audio-oscillator;92;92;154;92;91;91;151;91;91;149 14:22:31 INFO - PROCESS | 5556 | |5;imaging-gaussian-blur;117;117;117;117;118;117;117;117;118;118 14:22:31 INFO - PROCESS | 5556 | |6;imaging-darkroom;146;147;145;146;146;146;146;146;146;146 14:22:31 INFO - PROCESS | 5556 | |7;imaging-desaturate;95;94;94;97;95;96;95;95;95;94 14:22:31 INFO - PROCESS | 5556 | |8;json-parse-financial;58;55;55;56;55;58;56;71;58;52 14:22:31 INFO - PROCESS | 5556 | |9;json-stringify-tinderbox;58;58;58;58;58;58;57;58;57;57 14:22:31 INFO - PROCESS | 5556 | |10;stanford-crypto-aes;81;75;73;74;74;83;75;75;75;73 14:22:31 INFO - PROCESS | 5556 | |11;stanford-crypto-ccm;112;134;115;115;117;120;112;115;132;134 14:22:31 INFO - PROCESS | 5556 | |12;stanford-crypto-pbkdf2;167;156;159;161;164;159;157;164;159;162 14:22:31 INFO - PROCESS | 5556 | |13;stanford-crypto-sha256-iterative;70;64;68;66;64;71;64;65;65;68 14:22:31 INFO - PROCESS | 5556 | __end_tp_report 14:22:31 INFO - PROCESS | 5556 | __start_cc_report 14:22:31 INFO - PROCESS | 5556 | _x_x_mozilla_cycle_collect,855 14:22:31 INFO - PROCESS | 5556 | __end_cc_report 14:22:31 INFO - PROCESS | 5556 | __startTimestamp1468963351374__endTimestamp 14:22:31 INFO - PROCESS | 5556 | 14:22:31 INFO - PROCESS | 5556 | ------- Summary: start ------- 14:22:31 INFO - PROCESS | 5556 | Number of tests: 14 14:22:31 INFO - PROCESS | 5556 | 14:22:31 INFO - PROCESS | 5556 | [#0] ai-astar Cycles:10 Average:108.40 Median:110.00 stddev:3.84 (3.5%) stddev-sans-first:4.02 14:22:31 INFO - PROCESS | 5556 | Values: 110.0 111.0 103.0 108.0 110.0 112.0 100.0 110.0 110.0 110.0 14:22:31 INFO - PROCESS | 5556 | 14:22:31 INFO - PROCESS | 5556 | [#1] audio-beat-detection Cycles:10 Average:148.30 Median:154.00 stddev:17.09 (11.1%) stddev-sans-first:18.01 14:22:31 INFO - PROCESS | 5556 | Values: 154.0 132.0 156.0 172.0 127.0 154.0 154.0 135.0 172.0 127.0 14:22:31 INFO - PROCESS | 5556 | 14:22:31 INFO - PROCESS | 5556 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:1.07 (0.7%) stddev-sans-first:1.12 14:22:31 INFO - PROCESS | 5556 | Values: 162.0 162.0 160.0 163.0 161.0 162.0 160.0 162.0 162.0 160.0 14:22:31 INFO - PROCESS | 5556 | 14:22:31 INFO - PROCESS | 5556 | [#3] audio-fft Cycles:10 Average:94.60 Median:76.00 stddev:39.85 (52.4%) stddev-sans-first:41.69 14:22:31 INFO - PROCESS | 5556 | Values: 76.0 76.0 75.0 164.0 77.0 76.0 76.0 74.0 176.0 76.0 14:22:31 INFO - PROCESS | 5556 | 14:22:31 INFO - PROCESS | 5556 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:91.00 stddev:28.96 (31.8%) stddev-sans-first:30.03 14:22:31 INFO - PROCESS | 5556 | Values: 92.0 92.0 154.0 92.0 91.0 91.0 151.0 91.0 91.0 149.0 14:22:31 INFO - PROCESS | 5556 | 14:22:31 INFO - PROCESS | 5556 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 14:22:31 INFO - PROCESS | 5556 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 118.0 118.0 14:22:31 INFO - PROCESS | 5556 | 14:22:31 INFO - PROCESS | 5556 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 14:22:31 INFO - PROCESS | 5556 | Values: 146.0 147.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 14:22:31 INFO - PROCESS | 5556 | 14:22:31 INFO - PROCESS | 5556 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.94 (1.0%) stddev-sans-first:1.00 14:22:31 INFO - PROCESS | 5556 | Values: 95.0 94.0 94.0 97.0 95.0 96.0 95.0 95.0 95.0 94.0 14:22:31 INFO - PROCESS | 5556 | 14:22:31 INFO - PROCESS | 5556 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:57.00 stddev:5.13 (9.0%) stddev-sans-first:5.43 14:22:31 INFO - PROCESS | 5556 | Values: 58.0 55.0 55.0 56.0 55.0 58.0 56.0 71.0 58.0 52.0 14:22:31 INFO - PROCESS | 5556 | 14:22:31 INFO - PROCESS | 5556 | [#9] json-stringify-tinderbox Cycles:10 Average:57.70 Median:58.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 14:22:31 INFO - PROCESS | 5556 | Values: 58.0 58.0 58.0 58.0 58.0 58.0 57.0 58.0 57.0 57.0 14:22:31 INFO - PROCESS | 5556 | 14:22:31 INFO - PROCESS | 5556 | [#10] stanford-crypto-aes Cycles:10 Average:75.80 Median:75.00 stddev:3.39 (4.5%) stddev-sans-first:3.03 14:22:31 INFO - PROCESS | 5556 | Values: 81.0 75.0 73.0 74.0 74.0 83.0 75.0 75.0 75.0 73.0 14:22:31 INFO - PROCESS | 5556 | 14:22:31 INFO - PROCESS | 5556 | [#11] stanford-crypto-ccm Cycles:10 Average:120.60 Median:118.50 stddev:9.09 (7.7%) stddev-sans-first:9.10 14:22:31 INFO - PROCESS | 5556 | Values: 112.0 134.0 115.0 115.0 117.0 120.0 112.0 115.0 132.0 134.0 14:22:31 INFO - PROCESS | 5556 | 14:22:31 INFO - PROCESS | 5556 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.80 Median:161.50 stddev:3.46 (2.1%) stddev-sans-first:2.85 14:22:31 INFO - PROCESS | 5556 | Values: 167.0 156.0 159.0 161.0 164.0 159.0 157.0 164.0 159.0 162.0 14:22:31 INFO - PROCESS | 5556 | 14:22:31 INFO - PROCESS | 5556 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:2.59 (3.9%) stddev-sans-first:2.42 14:22:31 INFO - PROCESS | 5556 | Values: 70.0 64.0 68.0 66.0 64.0 71.0 64.0 65.0 65.0 68.0 14:22:31 INFO - PROCESS | 5556 | -------- Summary: end -------- 14:22:31 INFO - PROCESS | 5556 | 14:22:32 INFO - TEST-INFO | 5556: exit 0 14:22:32 INFO - TEST-OK | kraken | took 61056ms 14:22:32 INFO - SUITE-END | took 1170s 14:22:32 INFO - Completed test suite (00:19:31) 14:22:32 INFO - javascript benchmark 14:22:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3349.2129349602847, 3407.7103446207066, 3426.3489936912, 3447.4311738563138, 3471.409860323745, 5660.716964151791, 5688.089905615097, 5704.0, 5723.141528770687, 5730.914036289454, 5694.4590263924865, 5715.142728590714, 5721.799737009195, 5722.656640601567, 5740.167675687033, 5133.845984620468, 5144.17693169093, 5181.740912954356, 5203.765830537616, 5232.895342093175, 5107.540321371076, 5112.642115051948, 5124.385073791151, 5302.840914772563, 5342.0651386007485, 5124.103281925667, 5165.948340516603, 5178.223266510016, 5210.6613070150315, 5231.947680523203, 5178.663386879841, 5199.740012999335, 5220.060389129955, 5226.81706140287, 5260.053190425722, 4979.427365852937, 5071.087204303224, 5120.564751996085, 5141.84574462763, 5196.558292545138, 5494.395616482184, 5527.281453411071, 5565.165225216209, 5577.05190117681, 5616.69108199053, 6065.60573562717, 6078.908816367758, 6080.756769729205, 6106.0, 6117.143599896018, 6048.092786082079, 6084.330723620398, 6112.052631842072, 6139.324674285825, 6144.477719393857, 5596.384397716248, 5598.1322894951345, 5604.327480702301, 5608.85977850557, 5639.774409023676, 6077.270727512727, 6079.8480037998515, 6090.451859332681, 6106.297775755845, 6109.75560977556, 5842.094475356326, 5855.531557475391, 5926.614770039933, 6020.0, 6045.395460454008, 6066.636001839904, 6074.301455332605, 6081.087836824512, 6084.421979911901, 6085.665288409092, 5996.070609055603, 5999.520038396918, 6037.45662890342, 6042.486388657014, 6047.0, 5944.464998150187, 5978.491828194565, 6014.849628759229, 6052.969735151296, 6061.515078793686, 4615.723056616614, 4636.235021221461, 4639.420072490939, 4646.395968524071, 4658.138244424725, 4109.630133287958, 4154.792260386968, 4161.8335266589, 4175.290200665894, 4190.0, 5684.34630017545, 5801.883962320814, 5855.853603659857, 5863.853403664943, 5893.528517718572, 5972.104184372379, 6013.128096425994, 6029.517638588903, 6045.848853778691, 6054.0, 5767.942320576824, 5782.306123265235, 5782.65304081748, 5789.913151302734, 5803.158542011384, 5139.049275883974, 5195.454477279831, 5206.140986737146, 5207.947920520822, 5234.136367499396, 6227.06594010893, 6237.4698150656795, 6240.563160578807, 6261.99808030722, 6268.749250029948, 5991.071383935497, 6001.219841420588, 6005.759769609167, 6060.848478788065, 6143.201383820075, 6386.87226255463, 6438.259600146043, 6444.516661250331, 6473.611583305017, 6475.222973243241, 5959.4934430573885, 6009.609375390585, 6032.034874420072, 6046.274447066205, 6075.665838378932, 6014.398560143951, 6142.877142457215, 6143.170671959407, 6156.445919867234, 6168.228971378578, 5911.852203694942, 5917.171595976481, 5964.642121472725, 5968.283805943314, 5990.6705131218205, 5892.528597712087, 5920.3783602722815, 5935.109733539831, 5960.642361458326, 5972.0, 5691.117876729114, 5814.244148260868, 5854.180414742024, 5865.149553314831, 5943.465088142088, 5931.5847890648965, 5984.401559843981, 6005.39946005396, 6005.699715014144, 6009.308929473166, 5865.824025279248, 5877.177195192591, 5877.911831322619, 5884.823455296348, 5885.352611212677], "value": 5605.296957300758, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [666.8399584099817, 677.9593324247281, 689.8413364926064, 733.8605664923667, 746.216472703661, 40540.59459405405, 41064.38403423951, 41135.97160070996, 41154.58845411545, 41229.3815592766, 44790.55209447905, 45177.0, 45185.54814451854, 45300.0, 45353.31970020452, 8965.641374345018, 9029.819403611924, 9050.411723238001, 9092.40899341544, 9115.68095116671, 8801.735947921541, 8954.820903581924, 8968.058353872848, 8971.147740964598, 8975.551222438884, 9196.080391960817, 9253.537323133816, 9259.907400925971, 9276.675316363928, 9291.163795258426, 9178.4034037788, 9211.493367864798, 9232.261419086457, 9232.6306947722, 9238.168564829164, 9087.273018158532, 9139.862902056475, 9156.771080722969, 9160.587773550205, 9163.77090572741, 44329.55670443319, 44876.0, 44897.326540101596, 44990.32514512285, 45030.0, 3975.6421922026866, 4050.2717189380824, 4080.8571699990653, 4168.6665066794585, 4625.8149674013, 31065.0, 33424.66575334264, 33878.49182262268, 33880.15299617529, 35152.12119697002, 4565.383673204108, 4573.153966516205, 4585.426821647294, 4612.538746125394, 4623.12160689468, 296077.0, 296314.99999999785, 297519.0, 298633.0, 299851.0, 64295.0, 64568.67715661485, 64747.0, 64782.35217647858, 64789.352106478334, 72765.63617181986, 73359.26640733631, 73510.63244683742, 73783.2621673787, 73981.63009185027, 17131.143442827808, 17281.654366912593, 17339.739903901453, 17362.91318543399, 17366.565835854206, 14750.188739619423, 14814.703705925822, 14897.329620166902, 14905.627359316104, 14921.40314387434, 20670.586588268452, 20697.68953465699, 20867.8956605216, 20884.477888052617, 21626.0, 7592.406594010655, 7797.972527142871, 7810.492317999312, 7810.726624568113, 8019.478733882279, 1128.8306753986967, 1148.7415331550335, 1157.4039369724599, 1162.9418529073682, 1224.4306397525193, 32132.35735285281, 32531.838717076513, 32810.50784238238, 33496.0, 33574.49638255428, 1195.9701007474882, 1237.6410840856051, 1246.8129780532993, 1306.4969986555245, 1329.0895736420582, 17126.21630801821, 17410.825891741173, 17742.379016734354, 17829.0, 17832.286708531774, 479833.0, 875223.0, 923874.0, 943993.0, 944367.0, 64544.67727661425, 64622.35377646257, 65146.0, 65270.34729652643, 65420.34579654143, 1546.6906618676085, 1556.7042261970416, 1559.181429749368, 1565.827758946515, 1661.5015495351347, 33622.495662564594, 34404.0, 34437.827810860785, 34450.44972976172, 34456.65543344535, 56391.154132687225, 57222.42777572171, 57248.0, 57375.71312143413, 57384.42615573791, 335757.0, 336377.0, 337064.0, 338008.0, 340749.0, 31687.52468713017, 32111.67888321087, 32135.196620084684, 32149.839250803598, 32215.194620134684, 51697.224541632655, 52030.0, 52221.0, 52786.472135278156, 52872.471275286756, 43031.7848410756, 43585.0, 43756.56243437652, 43907.78046109749, 44990.100197996515, 42657.146857062064, 42903.57096428996, 42941.141177175654, 43213.78393108014, 43551.346729798446, 41022.38466422947, 41290.0, 46454.30318545292, 47227.29159062548, 47250.527494724614, 33001.66998329986, 35217.47173792344, 36122.0, 37000.81499592485, 37377.0, 28831.135065948056, 29126.854365728035, 29294.0, 29477.705222948352, 29623.703762962956], "value": 21547.055036312395, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [420.7433465585992, 433.3543020898858, 434.7587089165513, 435.7516215757018, 440.01217267235063, 18404.90797546012, 19249.326273580446, 19256.133473993686, 19797.604047919034, 20607.484812879648, 12700.682482937931, 13012.804807927865, 13250.933745331284, 19610.70583941242, 20536.589268214626, 5455.099908515091, 5637.548996080303, 5649.067903795889, 5652.547796176316, 5666.235058267143, 5619.690916999563, 5894.440028197314, 5896.764129434818, 5902.2622172228475, 5913.822585322448, 5865.0, 5872.207252020987, 6124.785632502863, 6422.389872962061, 6430.93569064308, 6254.312025677172, 6356.3961423664905, 6357.300696923335, 6387.425131738142, 6613.338666133396, 5965.28416590012, 5974.880502389928, 5985.521158307325, 6018.277806663228, 6019.969900150471, 14611.123332600078, 18897.338593149172, 21863.797491137982, 23904.52190956171, 24393.878030609732, 2592.157548796649, 2599.2202339298324, 2616.947661046768, 2619.0, 3149.165471150147, 10763.300385474997, 10827.945860270649, 10837.295575787628, 10887.673369798918, 13515.391807368693, 2044.72396226509, 2128.2338358191037, 2225.6995305633695, 2292.33522278539, 2352.847064940773, 76381.0, 76478.61760691217, 77987.0, 78684.60657696732, 79238.0, 11787.0, 11895.881041189477, 11966.162368634112, 12098.395080245953, 12133.272003679807, 16706.916465417595, 16718.41485548, 16820.663586728442, 16833.747493787603, 16853.578660533338, 9133.0, 9221.216196623362, 9277.860832087525, 9353.532323383804, 9448.716538503855, 8957.283417326598, 8964.0, 9002.414843035182, 9038.457692538468, 9050.592723327467, 5118.0, 5164.509371609691, 5216.0, 5268.683878967274, 5287.365516138011, 2081.438011736823, 2129.4995676016124, 2174.4346469917937, 2218.8114010309305, 2249.4601295688917, 1100.8293714474269, 1123.4831977290537, 1136.5226604825828, 1184.5025089462447, 1224.063591352616, 18494.907525462288, 19136.330228441937, 19315.710264346046, 19381.4185574433, 19744.60510789776, 1095.9671209863716, 1104.9337039777638, 1105.4362275239685, 1107.7618312062946, 1134.0, 10777.946110269555, 11111.38887361203, 11123.0, 11129.554817807359, 11176.832347514794, 490871.0, 491420.0, 496642.0, 510197.0, 510539.0, 72001.0, 87060.0, 91276.54361728282, 99618.0, 102016.0, 1163.598558497317, 1174.4890972427022, 1177.534873724874, 1199.6683681113957, 1217.3608855350835, 18109.818901810813, 18137.183826728095, 18197.45407637773, 18305.359312424, 18493.445196644123, 40336.59663403328, 40572.59427405688, 40702.79648601738, 41235.0, 41428.79285603553, 60131.39868601258, 60709.0, 61209.693951531735, 61241.69379153076, 61446.0, 9029.593668284811, 9086.409383390059, 9129.5435228237, 9305.906940930505, 9354.158125768714, 11969.820452693042, 13267.80098298507, 13360.599182024554, 13599.52401665937, 13887.51393701256, 11878.168528202943, 12038.157328986887, 12191.573294934635, 12261.632151035483, 12272.140950133406, 11630.0, 11661.941690291495, 11712.180147389941, 11837.526498939946, 11918.404079795802, 11942.223755455867, 12333.383330833602, 12468.501259949864, 12588.433520491417, 12721.427535761099, 8929.821403572023, 8951.865722014045, 9156.725298240797, 9300.95349523275, 9313.115254050854, 9353.906460935303, 12330.136890417944, 12409.689757756129, 12493.875061249635, 12582.24506529611], "value": 9698.779873407693, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1529.1436795394577, 1572.0646215501772, 1796.7664203653524, 1890.073863806735, 1923.5671973805904, 7670.348020418257, 8463.788405289872, 8570.142985701426, 8757.16806903344, 8773.07882672319, 8536.231739143475, 8553.272971797405, 8585.48487090775, 8598.0, 8598.269147122503, 2424.8908799104083, 2477.6159695247175, 2480.255923223035, 2480.8015358771345, 2481.2755135181055, 2395.365228214516, 2416.565018296706, 2435.3546310227803, 2436.5979613363775, 2449.644801503781, 2481.2432208176497, 2492.7382624824404, 2525.9242222733346, 2532.2529853693204, 2538.834975726581, 2422.9757702423017, 2446.559619268531, 2452.9754702453015, 2457.803375729937, 2478.876056197201, 2440.19473573722, 2458.840175388594, 2464.753524647539, 2475.777180053804, 2488.4401009772837, 8800.515971621558, 8813.250873675745, 8813.647454101829, 8850.601722922484, 8873.866891996626, 5480.068388373986, 5579.944200557983, 5617.101263797814, 5628.774849006035, 5630.127330263816, 3628.7641303315463, 3631.382664946939, 3673.3755261605593, 3772.4907137536356, 3777.2823163598828, 1172.6013155527075, 1182.0897908610407, 1190.4880901212475, 1204.1390405859765, 1212.3271584270726, 12634.684132896751, 12696.17474864131, 12731.363431828371, 12740.36298185087, 12743.681407964783, 4740.786664600101, 4844.176489996709, 4889.462159162489, 4899.853004409873, 4906.043321552334, 10515.94742026285, 10599.682009539727, 10612.257141999986, 10620.575176992834, 10636.149108071335, 5536.169574563767, 5541.667499950016, 5555.8888822223325, 5576.163575463713, 5587.497125258747, 4462.866114016585, 4950.381202349707, 5026.396832380065, 5044.419891712427, 5082.466341034138, 4205.978970105191, 4247.341662042327, 4248.511421186541, 4263.936040959388, 4277.2942464493635, 1325.9469621215044, 1328.103530117167, 1329.8869596084442, 1330.5941687785319, 1338.8125662407272, 905.1536813079791, 1029.4852573713144, 1033.4367769565604, 1033.5710680067687, 1054.6256079091966, 5775.595708300462, 5898.793542226002, 5933.792317268875, 5962.642241465526, 6008.759649614054, 482.6766066735296, 491.7492079039715, 493.09270941467156, 500.11479680965215, 502.2917686062634, 4265.573442655709, 4281.100968796588, 4359.455068116486, 4362.563743625676, 4366.366876802846, 10813.945930270298, 10987.725306867233, 11103.944480277709, 11193.66419007431, 11204.66386008421, 10874.782504349869, 11019.118470522339, 11033.889661103447, 11039.779204415867, 11051.502682379312, 8063.314618257514, 8315.168483151758, 8377.539235342114, 8394.412391132684, 8455.069942306342, 5997.850053748692, 6023.548233882389, 6033.396660333931, 6118.235220597426, 6135.601185922901, 9607.615695372107, 9738.123568878835, 9895.0, 9899.455529945923, 10123.696289111338, 9915.65295214664, 10002.349847259904, 10039.4478303694, 10168.694939151837, 10226.948865255923, 7796.571188584682, 7887.211278872067, 7918.722844700408, 8017.559034253172, 8072.071711753224, 8428.957855210685, 8455.196756308142, 8459.788505287172, 8500.14998500145, 8505.192006759347, 7309.926900730925, 7525.548467091992, 7526.698932042876, 7553.773386798405, 7711.922880771121, 7680.155182929985, 7755.7673269802, 7834.138244793182, 7835.098963619029, 7892.763217103496, 7035.753748618774, 7039.436845052486, 7042.436605071684, 7062.0466237057335, 7067.0, 5300.337457817773, 5308.548773354308, 5378.677279363251, 5406.7837286509675, 5437.429069947599, 5178.844634660966, 5205.349331333583, 5252.711100889335, 5303.231031500488, 5346.278252436027], "value": 4698.298562535467, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.04325278495276, 354.53201773658765, 360.8791054996576, 365.0508677438658, 369.0312928562523, 6359.65021923794, 6460.644664543448, 6533.705983230754, 6592.604443733379, 6616.636085015316, 6493.675316234181, 6520.70656820443, 6527.5104367172535, 6564.967175164117, 6569.178852643419, 4963.975180124095, 4971.627127965399, 4979.0, 4981.178105612569, 4983.053219888227, 4943.961768028718, 4975.835511552486, 4988.052270068693, 4999.775010124535, 5005.02402031604, 4917.164082106033, 4947.1589829728855, 4948.7278199699, 4954.1330267203275, 4958.603311735053, 4709.835155769566, 4851.708897466128, 4940.851774446773, 4946.802127914897, 4959.57843583294, 4247.086876321575, 4254.489461264637, 4257.084726783725, 4261.97869010653, 4264.061906380592, 6278.4663303619245, 6280.623162610258, 6289.056641503766, 6290.402411770874, 6296.716647750816, 5692.715364231772, 5714.457126572969, 5721.485066344049, 5722.055860782966, 5725.227094342252, 6917.13535808024, 6917.9308206917785, 6923.238443771181, 6925.272846351111, 6929.3070692930805, 4614.100250451163, 4749.050189962021, 4776.331313616097, 4785.090832741768, 4785.904281914342, 7100.28997100291, 7161.856762864765, 7193.0, 7215.530990485601, 7275.527090739138, 4828.203346447796, 4828.227483602606, 4840.515948405131, 4861.756912154378, 4869.440014398318, 4925.1873440881855, 4928.433230178503, 4931.161702510582, 4934.284528743312, 4937.604991600663, 5678.602497825195, 5681.914771278434, 5683.460071293303, 5685.658860468302, 5687.51656109227, 6887.621180835102, 6987.336203060701, 6997.510174287852, 6997.685104170325, 7005.964970175219, 1714.0658341204073, 1730.368415528323, 1737.2963949600432, 1740.3299729604194, 1742.9738553921702, 1118.765059337532, 1132.0717012050204, 1137.4653912661036, 1150.9482073306722, 1152.1358980764426, 6634.96682516594, 6751.223609284897, 6762.864742705118, 6766.323367663194, 6767.526273160832, 7115.466340024519, 7123.608201548861, 7129.857402851914, 7160.10498687664, 7220.169680486706, 6659.0, 6697.933020669731, 6701.760174367758, 6706.463482921355, 6753.696083676246, 3796.3166630006863, 3849.6920246380223, 3854.6530812227033, 3858.82635281413, 3868.01365651757, 7439.665215065335, 7702.0, 7706.306432421109, 7719.729809456642, 7795.986521752249, 7357.852842943111, 7392.0, 7414.777556673308, 7415.073115860518, 7460.925390746132, 7649.082110146706, 7656.9234307657325, 7664.923350766532, 7668.578228197391, 7680.3087722104165, 7086.114235720535, 7197.640117993975, 7207.495475316888, 7214.098237720285, 7230.060092187982, 7073.115860517435, 7132.821679458055, 7140.714371425085, 7144.0, 7149.249328820607, 7595.962020189863, 7619.390448764197, 7623.733169339046, 7636.847263054597, 7644.273793989562, 4820.084184005028, 4896.0, 4907.214845624683, 4910.92633610489, 4911.656184067081, 6940.722371105099, 7222.638868056471, 7233.963830180815, 7237.276272372721, 7254.419646428168, 7034.402075823612, 7048.118985126859, 7056.682449289691, 7095.82260443493, 7140.321669441395, 6941.826454338682, 6995.125609298838, 6998.545094568837, 7000.719971201095, 7015.123109611299, 6851.725930962905, 6856.142982127234, 6861.073755043205, 6861.965690171517, 6869.862602748017, 6839.658017099225, 6968.303169683194, 7000.0, 7013.509054366145, 7039.612821294878, 6616.503762217949, 6800.625965571941, 6873.862522749417, 6896.551724137915, 6915.965420172867], "value": 5231.672382819066, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [929.6746138851407, 939.3424602778056, 953.4946478366468, 964.6189755046752, 975.9316847820651, 13117.54088606899, 13344.666383340422, 13438.260895650736, 13446.991475639317, 13480.056396052256, 14347.497837575687, 14479.13125212488, 14486.637834054154, 14495.20276384801, 14501.0, 764.4457768118111, 914.0356923445762, 931.1433481197315, 932.6362718539775, 938.6386241297082, 902.7562558109306, 915.4049867586056, 918.5131880103556, 920.8572671235969, 923.3905622289291, 979.8824141103078, 980.4362491567342, 981.7349315684761, 982.7641366072127, 987.6641941739807, 969.0890562870914, 976.2385339435252, 977.5258999385328, 981.7005813226963, 984.0356450678339, 716.9605671688055, 718.0378293087288, 718.2099690340583, 721.0770214125927, 721.3940290156294, 14942.850571494255, 14950.40198392063, 14965.251737413195, 15002.849971500254, 15049.699006019928, 14354.92822535891, 14497.42010319586, 14561.053531520523, 14580.198089105095, 14828.629284267872, 11944.289248942458, 12054.15620906537, 12143.817842732366, 12329.198602090835, 12488.063395245303, 4096.139810639769, 4101.343784994417, 4190.07818279981, 4273.0, 4303.978480107611, 55720.164197537066, 55743.72128139374, 56586.0, 57496.0, 57728.13407798886, 11614.76770464586, 11860.822087668692, 11910.821337679941, 11912.225705329125, 11953.40232988347, 20982.265620703507, 21289.0, 21580.676289855666, 21600.459988500414, 21670.241541546286, 8590.264499681296, 8881.42270752399, 8883.289336853037, 8916.28669706435, 9018.954905225432, 4906.852794416173, 5026.095302845523, 5050.04049230645, 5079.8984020319385, 5154.7164905929785, 3799.981000095037, 3836.0601652594733, 3845.538535375773, 3854.6723528500393, 3864.53625564934, 694.7915625312386, 696.3837004251274, 713.5076797010047, 713.614648090036, 723.5080145501005, 835.4694768821842, 839.689314953459, 848.2704873808519, 872.2237208884098, 875.4484674655054, 9682.128608425135, 9720.708378748648, 9835.311528192959, 10148.797024059477, 10247.38515689061, 805.1103530598721, 808.272554700774, 821.765796747924, 825.8059356051323, 831.4720152702956, 4479.820807167742, 4490.932636010462, 4568.931466028012, 4584.312353146988, 4599.195140850338, 64575.35424645693, 66310.0, 66433.0, 66477.66761166163, 66567.66716166388, 58059.41940580625, 58381.70809145927, 58437.70781146067, 58856.705716471144, 59055.70472147612, 52757.7362113187, 53431.73284133632, 53459.46540534545, 53564.46435535673, 53710.462895371325, 9012.504312262889, 9039.774005649911, 9050.0, 9115.589798459217, 9187.03536128697, 38384.616153838106, 39572.0, 40088.799556002035, 40094.79715608536, 41068.794656026526, 46375.53624463712, 47210.0, 49540.75229623829, 49777.502224978736, 50511.74744126256, 11555.422228888354, 11663.537999611628, 11793.0, 11795.823062653895, 12122.575709850113, 12761.93619031899, 13038.282894440898, 13314.733705326033, 13409.396577153857, 13422.664433389244, 11472.541098355972, 11828.349440780496, 12064.75870482603, 12299.200551964093, 12495.312757798409, 11959.701007474883, 12395.566155184526, 12456.31490268044, 12576.811347829973, 12958.546450874552, 11536.192466527262, 12028.398580071136, 12310.446029928495, 12463.626091216915, 12736.61790146297, 10467.685969420929, 10733.409662468639, 10781.245312828027, 11077.279976801483, 11318.151138664798, 11353.432328383382, 11358.375289359165, 11360.54557817678, 11490.368029758443, 11631.185816993067], "value": 7226.58687680126, "unit": "score"}], "name": "dromaeo_css", "value": 7697.97056648963, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 103.0, 108.0, 110.0, 112.0, 100.0, 110.0, 110.0, 110.0], "value": 108.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 132.0, 156.0, 172.0, 127.0, 154.0, 154.0, 135.0, 172.0, 127.0], "value": 148.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 160.0, 163.0, 161.0, 162.0, 160.0, 162.0, 162.0, 160.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 164.0, 77.0, 76.0, 76.0, 74.0, 176.0, 76.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 154.0, 92.0, 91.0, 91.0, 151.0, 91.0, 91.0, 149.0], "value": 109.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 97.0, 95.0, 96.0, 95.0, 95.0, 95.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 55.0, 55.0, 56.0, 55.0, 58.0, 56.0, 71.0, 58.0, 52.0], "value": 57.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 58.0, 58.0, 58.0, 57.0, 58.0, 57.0, 57.0], "value": 57.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 75.0, 73.0, 74.0, 74.0, 83.0, 75.0, 75.0, 75.0, 73.0], "value": 75.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 134.0, 115.0, 115.0, 117.0, 120.0, 112.0, 115.0, 132.0, 134.0], "value": 120.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 156.0, 159.0, 161.0, 164.0, 159.0, 157.0, 164.0, 159.0, 162.0], "value": 160.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 64.0, 68.0, 66.0, 64.0, 71.0, 64.0, 65.0, 65.0, 68.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1519.1999999999998, "alertThreshold": 2.0}]} 14:22:32 INFO - Return code: 0 14:22:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:22:32 ERROR - # TBPL SUCCESS # 14:22:32 INFO - Running post-action listener: _resource_record_post_action 14:22:32 INFO - Running post-run listener: _resource_record_post_run 14:22:33 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 684032; Write bytes: 286007296; Read time: 176; Write time: 205768 14:22:33 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 69292032; Read time: 0; Write time: 50464 14:22:33 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 659456; Write bytes: 216715264; Read time: 156; Write time: 155304 14:22:33 INFO - Running post-run listener: _upload_blobber_files 14:22:33 INFO - Blob upload gear active. 14:22:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:22:33 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 14:22:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:22:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:22:34 INFO - (blobuploader) - INFO - Open directory for files ... 14:22:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:22:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:22:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:22:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:22:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:22:35 INFO - (blobuploader) - INFO - Done attempting. 14:22:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:22:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:22:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:22:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:22:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:22:35 INFO - (blobuploader) - INFO - Done attempting. 14:22:35 INFO - (blobuploader) - INFO - Iteration through files over. 14:22:35 INFO - Return code: 0 14:22:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:22:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:22:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3cb6c05dbb697bf13a5512a92872b6e506adb7978675836d411e6c4ad1907d6087b9a81d033ba823143a13fe4648c2a7795e9f5d2e0249a2487179664397e16e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/03c664362244be9f4b9b466114891a6a95f0c8d8be6004a65180e7157d3463f4b9bcd62f61b0acee11e8bb106625d4e30fae9298f00189c3c6a162d5c22e7a3f"} 14:22:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:22:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:22:35 INFO - Contents: 14:22:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3cb6c05dbb697bf13a5512a92872b6e506adb7978675836d411e6c4ad1907d6087b9a81d033ba823143a13fe4648c2a7795e9f5d2e0249a2487179664397e16e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/03c664362244be9f4b9b466114891a6a95f0c8d8be6004a65180e7157d3463f4b9bcd62f61b0acee11e8bb106625d4e30fae9298f00189c3c6a162d5c22e7a3f"} 14:22:35 INFO - Running post-run listener: copy_logs_to_upload_dir 14:22:35 INFO - Copying logs to upload dir... 14:22:35 INFO - mkdir: /builds/slave/test/build/upload/logs 14:22:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.999254 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-19 14:22:35.773562) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 14:22:35.777574) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1468961583.2326-30875764 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-Beta/sha512/3cb6c05dbb697bf13a5512a92872b6e506adb7978675836d411e6c4ad1907d6087b9a81d033ba823143a13fe4648c2a7795e9f5d2e0249a2487179664397e16e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/03c664362244be9f4b9b466114891a6a95f0c8d8be6004a65180e7157d3463f4b9bcd62f61b0acee11e8bb106625d4e30fae9298f00189c3c6a162d5c22e7a3f"} build_url:https://queue.taskcluster.net/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011351 build_url: 'https://queue.taskcluster.net/v1/task/FSXhqL_XTtiCH69dZm-sAw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3cb6c05dbb697bf13a5512a92872b6e506adb7978675836d411e6c4ad1907d6087b9a81d033ba823143a13fe4648c2a7795e9f5d2e0249a2487179664397e16e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/03c664362244be9f4b9b466114891a6a95f0c8d8be6004a65180e7157d3463f4b9bcd62f61b0acee11e8bb106625d4e30fae9298f00189c3c6a162d5c22e7a3f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 14:22:35.808007) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 14:22:35.808725) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1468961583.2326-30875764 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004429 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 14:22:35.892359) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 14:22:35.892864) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 14:22:35.893348) ========= ========= Total master_lag: 0.64 =========