builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-003 starttime: 1461053087.04 results: success (0) buildid: 20160418223145 builduid: 1c25958499bf43d595b357ab4331b63d revision: cb65ec85049efa44b18e2e8d06af26768c3bfb94 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 01:04:47.037297) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 01:04:47.037768) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 01:04:47.038073) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 01:04:47.055261) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 01:04:47.055548) ========= 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=7de08804244eb36560b44971000001c3-1461051372.534030-1475585752 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-19 01:04:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-04-19 01:04:47 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.130511 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 01:04:47.199141) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 01:04:47.199424) ========= 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=7de08804244eb36560b44971000001c3-1461051372.534030-1475585752 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018755 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 01:04:47.248855) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 01:04:47.249221) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cb65ec85049efa44b18e2e8d06af26768c3bfb94 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev cb65ec85049efa44b18e2e8d06af26768c3bfb94 --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=7de08804244eb36560b44971000001c3-1461051372.534030-1475585752 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-19 01:04:47,591 truncating revision to first 12 chars 2016-04-19 01:04:47,591 Setting DEBUG logging. 2016-04-19 01:04:47,591 attempt 1/10 2016-04-19 01:04:47,591 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cb65ec85049e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-19 01:04:47,928 unpacking tar archive at: mozilla-central-cb65ec85049e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.624874 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 01:04:47.887317) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 01:04:47.887645) ========= script_repo_revision: cb65ec85049efa44b18e2e8d06af26768c3bfb94 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 01:04:47.888070) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 01:04:47.888393) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 01:04:47.902819) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-04-19 01:04:47.903262) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=7de08804244eb36560b44971000001c3-1461051372.534030-1475585752 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:04:48 INFO - MultiFileLogger online at 20160419 01:04:48 in /builds/slave/test 01:04:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 01:04:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:04:48 INFO - {'append_to_log': False, 01:04:48 INFO - 'base_work_dir': '/builds/slave/test', 01:04:48 INFO - 'blob_upload_branch': 'Firefox', 01:04:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:04:48 INFO - 'branch': 'Firefox', 01:04:48 INFO - 'buildbot_json_path': 'buildprops.json', 01:04:48 INFO - 'config_files': ('talos/linux_config.py',), 01:04:48 INFO - 'default_actions': ('clobber', 01:04:48 INFO - 'read-buildbot-config', 01:04:48 INFO - 'download-and-extract', 01:04:48 INFO - 'populate-webroot', 01:04:48 INFO - 'create-virtualenv', 01:04:48 INFO - 'install', 01:04:48 INFO - 'run-tests'), 01:04:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:04:48 INFO - 'download_minidump_stackwalk': True, 01:04:48 INFO - 'download_symbols': 'ondemand', 01:04:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:04:48 INFO - 'tooltool.py': '/tools/tooltool.py', 01:04:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:04:48 INFO - '/tools/misc-python/virtualenv.py')}, 01:04:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:04:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:04:48 INFO - 'installer_path': 'installer.exe', 01:04:48 INFO - 'log_level': 'info', 01:04:48 INFO - 'log_name': 'talos', 01:04:48 INFO - 'log_to_console': True, 01:04:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:04:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:04:48 INFO - 'opt_config_files': (), 01:04:48 INFO - 'pip_index': False, 01:04:48 INFO - 'sps_profile': False, 01:04:48 INFO - 'sps_profile_interval': 0, 01:04:48 INFO - 'suite': 'dromaeojs-e10s', 01:04:48 INFO - 'system_bits': '32', 01:04:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:04:48 INFO - 'title': 'talos-linux64-ix-003', 01:04:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:04:48 INFO - 'use_talos_json': True, 01:04:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:04:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:04:48 INFO - 'work_dir': 'build'} 01:04:48 INFO - ##### 01:04:48 INFO - ##### Running clobber step. 01:04:48 INFO - ##### 01:04:48 INFO - Running pre-action listener: _resource_record_pre_action 01:04:48 INFO - Running main action method: clobber 01:04:48 INFO - rmtree: /builds/slave/test/build 01:04:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:04:49 INFO - Running post-action listener: _resource_record_post_action 01:04:49 INFO - ##### 01:04:49 INFO - ##### Running read-buildbot-config step. 01:04:49 INFO - ##### 01:04:49 INFO - Running pre-action listener: _resource_record_pre_action 01:04:49 INFO - Running main action method: read_buildbot_config 01:04:49 INFO - Using buildbot properties: 01:04:49 INFO - { 01:04:49 INFO - "project": "", 01:04:49 INFO - "product": "firefox", 01:04:49 INFO - "script_repo_revision": "production", 01:04:49 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 01:04:49 INFO - "repository": "", 01:04:49 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 01:04:49 INFO - "buildid": "20160418223145", 01:04:49 INFO - "pgo_build": "True", 01:04:49 INFO - "basedir": "/builds/slave/test", 01:04:49 INFO - "buildnumber": 703, 01:04:49 INFO - "slavename": "talos-linux64-ix-003", 01:04:49 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:04:49 INFO - "platform": "ubuntu64_hw", 01:04:49 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 01:04:49 INFO - "branch": "mozilla-central", 01:04:49 INFO - "repo_path": "mozilla-central", 01:04:49 INFO - "revision": "cb65ec85049efa44b18e2e8d06af26768c3bfb94", 01:04:49 INFO - "stage_platform": "linux64-pgo", 01:04:49 INFO - "builduid": "1c25958499bf43d595b357ab4331b63d", 01:04:49 INFO - "slavebuilddir": "test" 01:04:49 INFO - } 01:04:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/ACuFSuGBQiyE13TXCnu2QA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 01:04:49 INFO - Running post-action listener: _resource_record_post_action 01:04:49 INFO - ##### 01:04:49 INFO - ##### Running download-and-extract step. 01:04:49 INFO - ##### 01:04:49 INFO - Running pre-action listener: _resource_record_pre_action 01:04:49 INFO - Running main action method: download_and_extract 01:04:49 INFO - mkdir: /builds/slave/test/build/tests 01:04:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:04:49 INFO - https://queue.taskcluster.net/v1/task/ACuFSuGBQiyE13TXCnu2QA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:04:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACuFSuGBQiyE13TXCnu2QA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 01:04:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACuFSuGBQiyE13TXCnu2QA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 01:04:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACuFSuGBQiyE13TXCnu2QA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 01:04:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACuFSuGBQiyE13TXCnu2QA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:04:54 INFO - Downloaded 1361 bytes. 01:04:54 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 01:04:54 INFO - Using the following test package requirements: 01:04:54 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 01:04:54 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:04:54 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:04:54 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:04:54 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:04:54 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:04:54 INFO - u'jsshell-linux-x86_64.zip'], 01:04:54 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:04:54 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:04:54 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 01:04:54 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:04:54 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:04:54 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:04:54 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:04:54 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:04:54 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:04:54 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:04:54 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:04:54 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:04:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:04:54 INFO - https://queue.taskcluster.net/v1/task/ACuFSuGBQiyE13TXCnu2QA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:04:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACuFSuGBQiyE13TXCnu2QA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:04:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACuFSuGBQiyE13TXCnu2QA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:04:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACuFSuGBQiyE13TXCnu2QA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:04:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACuFSuGBQiyE13TXCnu2QA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:04:55 INFO - Downloaded 23780725 bytes. 01:04:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:04:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:04:56 INFO - Return code: 0 01:04:56 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:04:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:04:56 INFO - https://queue.taskcluster.net/v1/task/ACuFSuGBQiyE13TXCnu2QA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:04:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACuFSuGBQiyE13TXCnu2QA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:04:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACuFSuGBQiyE13TXCnu2QA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:04:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACuFSuGBQiyE13TXCnu2QA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:04:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACuFSuGBQiyE13TXCnu2QA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:04:58 INFO - Downloaded 23780725 bytes. 01:04:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:04:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:04:59 INFO - Return code: 0 01:04:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:04:59 INFO - https://queue.taskcluster.net/v1/task/ACuFSuGBQiyE13TXCnu2QA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:04:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACuFSuGBQiyE13TXCnu2QA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 01:04:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACuFSuGBQiyE13TXCnu2QA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 01:04:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACuFSuGBQiyE13TXCnu2QA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 01:04:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACuFSuGBQiyE13TXCnu2QA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:05:00 INFO - Downloaded 10845952 bytes. 01:05:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:05:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 01:05:01 INFO - Return code: 0 01:05:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:05:01 INFO - https://queue.taskcluster.net/v1/task/ACuFSuGBQiyE13TXCnu2QA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:05:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACuFSuGBQiyE13TXCnu2QA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 01:05:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACuFSuGBQiyE13TXCnu2QA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 01:05:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACuFSuGBQiyE13TXCnu2QA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 01:05:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACuFSuGBQiyE13TXCnu2QA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:05:02 INFO - Downloaded 58249108 bytes. 01:05:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ACuFSuGBQiyE13TXCnu2QA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 01:05:02 INFO - mkdir: /builds/slave/test/properties 01:05:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:05:02 INFO - Writing to file /builds/slave/test/properties/build_url 01:05:02 INFO - Contents: 01:05:02 INFO - build_url:https://queue.taskcluster.net/v1/task/ACuFSuGBQiyE13TXCnu2QA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 01:05:03 INFO - Running post-action listener: _resource_record_post_action 01:05:03 INFO - Running post-action listener: set_extra_try_arguments 01:05:03 INFO - ##### 01:05:03 INFO - ##### Running populate-webroot step. 01:05:03 INFO - ##### 01:05:03 INFO - Running pre-action listener: _resource_record_pre_action 01:05:03 INFO - Running main action method: populate_webroot 01:05:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:05:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:05:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:05:03 INFO - '--tppagecycles', 01:05:03 INFO - '7'], 01:05:03 INFO - 'tests': ['tsvgm']}}, 01:05:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:05:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:05:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:05:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:05:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:05:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:05:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:05:03 INFO - 'talos_options': ['--disable-e10s'], 01:05:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:05:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:05:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:05:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:05:03 INFO - 'talos_options': ['--disable-e10s'], 01:05:03 INFO - 'tests': ['damp', 'tps']}, 01:05:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:05:03 INFO - 'tests': ['damp', 'tps']}, 01:05:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:05:03 INFO - 'tests': ['dromaeo_dom']}, 01:05:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:05:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:05:03 INFO - 'tests': ['a11yr', 01:05:03 INFO - 'ts_paint', 01:05:03 INFO - 'tpaint', 01:05:03 INFO - 'sessionrestore', 01:05:03 INFO - 'sessionrestore_no_auto_restore', 01:05:03 INFO - 'tabpaint']}, 01:05:03 INFO - 'other-e10s': {'tests': ['a11yr', 01:05:03 INFO - 'ts_paint', 01:05:03 INFO - 'tpaint', 01:05:03 INFO - 'sessionrestore', 01:05:03 INFO - 'sessionrestore_no_auto_restore', 01:05:03 INFO - 'tabpaint']}, 01:05:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:05:03 INFO - 'ts_paint', 01:05:03 INFO - 'tpaint', 01:05:03 INFO - 'sessionrestore', 01:05:03 INFO - 'sessionrestore_no_auto_restore', 01:05:03 INFO - 'tabpaint']}, 01:05:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:05:03 INFO - 'ts_paint', 01:05:03 INFO - 'tpaint', 01:05:03 INFO - 'sessionrestore', 01:05:03 INFO - 'sessionrestore_no_auto_restore', 01:05:03 INFO - 'tabpaint']}, 01:05:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:05:03 INFO - 'tests': ['a11yr', 01:05:03 INFO - 'ts_paint', 01:05:03 INFO - 'tpaint', 01:05:03 INFO - 'sessionrestore', 01:05:03 INFO - 'sessionrestore_no_auto_restore', 01:05:03 INFO - 'tabpaint']}, 01:05:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:05:03 INFO - 'tests': ['a11yr', 01:05:03 INFO - 'ts_paint', 01:05:03 INFO - 'tpaint', 01:05:03 INFO - 'sessionrestore', 01:05:03 INFO - 'sessionrestore_no_auto_restore', 01:05:03 INFO - 'tabpaint']}, 01:05:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:05:03 INFO - 'tests': ['tsvgx', 01:05:03 INFO - 'tsvgr_opacity', 01:05:03 INFO - 'tart', 01:05:03 INFO - 'tscrollx', 01:05:03 INFO - 'cart']}, 01:05:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:05:03 INFO - 'tsvgr_opacity', 01:05:03 INFO - 'tart', 01:05:03 INFO - 'tscrollx', 01:05:03 INFO - 'cart']}, 01:05:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:05:03 INFO - 'talos_options': ['--disable-e10s'], 01:05:03 INFO - 'tests': ['tp5o']}, 01:05:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:05:03 INFO - 'tests': ['tp5o']}, 01:05:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:05:03 INFO - 'talos_options': ['--disable-e10s', 01:05:03 INFO - '--xperf_path', 01:05:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:05:03 INFO - 'tests': ['tp5n']}, 01:05:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:05:03 INFO - 'talos_options': ['--xperf_path', 01:05:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:05:03 INFO - 'tests': ['tp5n']}}, 01:05:03 INFO - 'talos.zip': {'path': '', 01:05:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:05:03 INFO - Running post-action listener: _resource_record_post_action 01:05:03 INFO - ##### 01:05:03 INFO - ##### Running create-virtualenv step. 01:05:03 INFO - ##### 01:05:03 INFO - Running pre-action listener: _resource_record_pre_action 01:05:03 INFO - Running main action method: create_virtualenv 01:05:03 INFO - Creating virtualenv /builds/slave/test/build/venv 01:05:03 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 01:05:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:05:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:05:03 INFO - Using real prefix '/usr' 01:05:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:05:03 INFO - Installing distribute.............................................................................................................................................................................................done. 01:05:05 INFO - Installing pip.................done. 01:05:05 INFO - Return code: 0 01:05:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:05: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')]} 01:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:05:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05: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')]} 01:05:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:05:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3581e30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20db5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216a410>, '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 0x216b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216b7a0>, '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': '7de08804244eb36560b44971000001c3-1461051372.534030-1475585752', '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 01:05:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:05:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:05:06 INFO - Using env: {'DISPLAY': ':0', 01:05:06 INFO - 'HOME': '/home/cltbld', 01:05:06 INFO - 'LANG': 'en_US.UTF-8', 01:05:06 INFO - 'LANGUAGE': 'en_US:en', 01:05:06 INFO - 'LOGNAME': 'cltbld', 01:05:06 INFO - 'MAIL': '/var/mail/cltbld', 01:05:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:05:06 INFO - 'MOZ_NO_REMOTE': '1', 01:05:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:05:06 INFO - 'NO_EM_RESTART': '1', 01:05:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:05:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:05:06 INFO - 'PWD': '/builds/slave/test', 01:05:06 INFO - 'SHELL': '/bin/bash', 01:05:06 INFO - 'SHLVL': '1', 01:05:06 INFO - 'TERM': 'linux', 01:05:06 INFO - 'TMOUT': '86400', 01:05:06 INFO - 'USER': 'cltbld', 01:05:06 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461051372.534030-1475585752', 01:05:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:05:06 INFO - '_': '/tools/buildbot/bin/python'} 01:05:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:05:06 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 01:05:06 INFO - Cleaning up... 01:05:06 INFO - Return code: 0 01:05:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:05:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:05:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:05:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:05:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:05:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3581e30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20db5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216a410>, '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 0x216b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216b7a0>, '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': '7de08804244eb36560b44971000001c3-1461051372.534030-1475585752', '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 01:05:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 01:05:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 01:05:06 INFO - Using env: {'DISPLAY': ':0', 01:05:06 INFO - 'HOME': '/home/cltbld', 01:05:06 INFO - 'LANG': 'en_US.UTF-8', 01:05:06 INFO - 'LANGUAGE': 'en_US:en', 01:05:06 INFO - 'LOGNAME': 'cltbld', 01:05:06 INFO - 'MAIL': '/var/mail/cltbld', 01:05:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:05:06 INFO - 'MOZ_NO_REMOTE': '1', 01:05:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:05:06 INFO - 'NO_EM_RESTART': '1', 01:05:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:05:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:05:06 INFO - 'PWD': '/builds/slave/test', 01:05:06 INFO - 'SHELL': '/bin/bash', 01:05:06 INFO - 'SHLVL': '1', 01:05:06 INFO - 'TERM': 'linux', 01:05:06 INFO - 'TMOUT': '86400', 01:05:06 INFO - 'USER': 'cltbld', 01:05:06 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461051372.534030-1475585752', 01:05:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:05:06 INFO - '_': '/tools/buildbot/bin/python'} 01:05:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:05:06 INFO - Downloading/unpacking psutil>=0.7.1 01:05:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:05:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:05:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:05:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:05:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:05:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:05:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:05:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:05:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:05:08 INFO - Installing collected packages: psutil 01:05:08 INFO - Running setup.py install for psutil 01:05:08 INFO - building 'psutil._psutil_linux' extension 01:05:08 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 01:05:08 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 01:05:08 INFO - building 'psutil._psutil_posix' extension 01:05:08 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 01:05:08 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 01:05:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:05:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:05:08 INFO - Successfully installed psutil 01:05:08 INFO - Cleaning up... 01:05:08 INFO - Return code: 0 01:05:08 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:05:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:05:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:05:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:05:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3581e30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20db5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216a410>, '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 0x216b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216b7a0>, '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': '7de08804244eb36560b44971000001c3-1461051372.534030-1475585752', '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 01:05:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 01:05:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 01:05:08 INFO - Using env: {'DISPLAY': ':0', 01:05:08 INFO - 'HOME': '/home/cltbld', 01:05:08 INFO - 'LANG': 'en_US.UTF-8', 01:05:08 INFO - 'LANGUAGE': 'en_US:en', 01:05:08 INFO - 'LOGNAME': 'cltbld', 01:05:08 INFO - 'MAIL': '/var/mail/cltbld', 01:05:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:05:08 INFO - 'MOZ_NO_REMOTE': '1', 01:05:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:05:08 INFO - 'NO_EM_RESTART': '1', 01:05:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:05:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:05:08 INFO - 'PWD': '/builds/slave/test', 01:05:08 INFO - 'SHELL': '/bin/bash', 01:05:08 INFO - 'SHLVL': '1', 01:05:08 INFO - 'TERM': 'linux', 01:05:08 INFO - 'TMOUT': '86400', 01:05:08 INFO - 'USER': 'cltbld', 01:05:08 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461051372.534030-1475585752', 01:05:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:05:08 INFO - '_': '/tools/buildbot/bin/python'} 01:05:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:05:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:05:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:05:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:05:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:05:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:05:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:05:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:05:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:05:11 INFO - Installing collected packages: mozsystemmonitor 01:05:11 INFO - Running setup.py install for mozsystemmonitor 01:05:11 INFO - Successfully installed mozsystemmonitor 01:05:11 INFO - Cleaning up... 01:05:11 INFO - Return code: 0 01:05:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:05:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:05:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:05:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:05:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:05:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3581e30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20db5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216a410>, '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 0x216b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216b7a0>, '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': '7de08804244eb36560b44971000001c3-1461051372.534030-1475585752', '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 01:05:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:05:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:05:11 INFO - Using env: {'DISPLAY': ':0', 01:05:11 INFO - 'HOME': '/home/cltbld', 01:05:11 INFO - 'LANG': 'en_US.UTF-8', 01:05:11 INFO - 'LANGUAGE': 'en_US:en', 01:05:11 INFO - 'LOGNAME': 'cltbld', 01:05:11 INFO - 'MAIL': '/var/mail/cltbld', 01:05:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:05:11 INFO - 'MOZ_NO_REMOTE': '1', 01:05:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:05:11 INFO - 'NO_EM_RESTART': '1', 01:05:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:05:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:05:11 INFO - 'PWD': '/builds/slave/test', 01:05:11 INFO - 'SHELL': '/bin/bash', 01:05:11 INFO - 'SHLVL': '1', 01:05:11 INFO - 'TERM': 'linux', 01:05:11 INFO - 'TMOUT': '86400', 01:05:11 INFO - 'USER': 'cltbld', 01:05:11 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461051372.534030-1475585752', 01:05:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:05:11 INFO - '_': '/tools/buildbot/bin/python'} 01:05:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:05:11 INFO - Downloading/unpacking blobuploader==1.2.4 01:05:11 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 01:05:11 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 01:05:11 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 01:05:11 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 01:05:11 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 01:05:11 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 01:05:13 INFO - Downloading blobuploader-1.2.4.tar.gz 01:05:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:05:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:05:13 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 01:05:13 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 01:05:13 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 01:05:13 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 01:05:13 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 01:05:13 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 01:05:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:05:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:05:13 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 01:05:13 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 01:05:13 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 01:05:13 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 01:05:13 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 01:05:13 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 01:05:14 INFO - Downloading docopt-0.6.1.tar.gz 01:05:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:05:14 INFO - Installing collected packages: blobuploader, requests, docopt 01:05:14 INFO - Running setup.py install for blobuploader 01:05:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:05:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:05:14 INFO - Running setup.py install for requests 01:05:14 INFO - Running setup.py install for docopt 01:05:14 INFO - Successfully installed blobuploader requests docopt 01:05:14 INFO - Cleaning up... 01:05:14 INFO - Return code: 0 01:05:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:05:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:05:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:05:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:05:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:14 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 0x7f3581e30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20db5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216a410>, '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 0x216b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216b7a0>, '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': '7de08804244eb36560b44971000001c3-1461051372.534030-1475585752', '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 01:05:14 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 01:05:14 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 01:05:14 INFO - Using env: {'DISPLAY': ':0', 01:05:14 INFO - 'HOME': '/home/cltbld', 01:05:14 INFO - 'LANG': 'en_US.UTF-8', 01:05:14 INFO - 'LANGUAGE': 'en_US:en', 01:05:14 INFO - 'LOGNAME': 'cltbld', 01:05:14 INFO - 'MAIL': '/var/mail/cltbld', 01:05:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:05:14 INFO - 'MOZ_NO_REMOTE': '1', 01:05:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:05:14 INFO - 'NO_EM_RESTART': '1', 01:05:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:05:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:05:14 INFO - 'PWD': '/builds/slave/test', 01:05:14 INFO - 'SHELL': '/bin/bash', 01:05:14 INFO - 'SHLVL': '1', 01:05:14 INFO - 'TERM': 'linux', 01:05:14 INFO - 'TMOUT': '86400', 01:05:14 INFO - 'USER': 'cltbld', 01:05:14 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461051372.534030-1475585752', 01:05:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:05:14 INFO - '_': '/tools/buildbot/bin/python'} 01:05:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:05:14 INFO - Running setup.py (path:/tmp/pip-0hGAww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:05:14 INFO - Running setup.py (path:/tmp/pip-j77Bp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:05:15 INFO - Running setup.py (path:/tmp/pip-YHv3tT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:05:15 INFO - Running setup.py (path:/tmp/pip-rNfI3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:05:15 INFO - Running setup.py (path:/tmp/pip-Rfqgwn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:05:15 INFO - Running setup.py (path:/tmp/pip-yj2BPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:05:15 INFO - Running setup.py (path:/tmp/pip-qBXRTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:05:15 INFO - Running setup.py (path:/tmp/pip-q6ApPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:05:15 INFO - Running setup.py (path:/tmp/pip-XATZ0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:05:15 INFO - Running setup.py (path:/tmp/pip-j1IE5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:05:15 INFO - Running setup.py (path:/tmp/pip-glxyKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:05:15 INFO - Running setup.py (path:/tmp/pip-G7N28S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:05:15 INFO - Running setup.py (path:/tmp/pip-sORNPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:05:15 INFO - Running setup.py (path:/tmp/pip-gOkCvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:05:15 INFO - Running setup.py (path:/tmp/pip-m8Hw3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:05:15 INFO - Running setup.py (path:/tmp/pip-c4h6D4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:05:16 INFO - Running setup.py (path:/tmp/pip-uvOf8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:05:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:05:16 INFO - Running setup.py install for manifestparser 01:05:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:05:16 INFO - Running setup.py install for mozcrash 01:05:16 INFO - Running setup.py install for mozdebug 01:05:16 INFO - Running setup.py install for mozdevice 01:05:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:05:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:05:16 INFO - Running setup.py install for mozfile 01:05:16 INFO - Running setup.py install for mozhttpd 01:05:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:05:16 INFO - Running setup.py install for mozinfo 01:05:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:05:16 INFO - Running setup.py install for mozInstall 01:05:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:05:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:05:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:05:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:05:16 INFO - Running setup.py install for mozleak 01:05:17 INFO - Running setup.py install for mozlog 01:05:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:05:17 INFO - Running setup.py install for moznetwork 01:05:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:05:17 INFO - Running setup.py install for mozprocess 01:05:17 INFO - Running setup.py install for mozprofile 01:05:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:05:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:05:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:05:17 INFO - Running setup.py install for mozrunner 01:05:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:05:17 INFO - Running setup.py install for mozscreenshot 01:05:17 INFO - Running setup.py install for moztest 01:05:17 INFO - Running setup.py install for mozversion 01:05:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:05:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:05:17 INFO - Cleaning up... 01:05:17 INFO - Return code: 0 01:05:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:05:17 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')]} 01:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:05:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:17 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')]} 01:05:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:05:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:17 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 0x7f3581e30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20db5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216a410>, '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 0x216b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216b7a0>, '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': '7de08804244eb36560b44971000001c3-1461051372.534030-1475585752', '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 01:05:17 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 01:05:17 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 01:05:17 INFO - Using env: {'DISPLAY': ':0', 01:05:17 INFO - 'HOME': '/home/cltbld', 01:05:17 INFO - 'LANG': 'en_US.UTF-8', 01:05:17 INFO - 'LANGUAGE': 'en_US:en', 01:05:17 INFO - 'LOGNAME': 'cltbld', 01:05:17 INFO - 'MAIL': '/var/mail/cltbld', 01:05:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:05:17 INFO - 'MOZ_NO_REMOTE': '1', 01:05:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:05:17 INFO - 'NO_EM_RESTART': '1', 01:05:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:05:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:05:17 INFO - 'PWD': '/builds/slave/test', 01:05:17 INFO - 'SHELL': '/bin/bash', 01:05:17 INFO - 'SHLVL': '1', 01:05:17 INFO - 'TERM': 'linux', 01:05:17 INFO - 'TMOUT': '86400', 01:05:17 INFO - 'USER': 'cltbld', 01:05:17 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461051372.534030-1475585752', 01:05:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:05:17 INFO - '_': '/tools/buildbot/bin/python'} 01:05:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:05:18 INFO - Running setup.py (path:/tmp/pip-PwYI3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:05:18 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 01:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:05:18 INFO - Running setup.py (path:/tmp/pip-jkQT2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:05:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:05:18 INFO - Running setup.py (path:/tmp/pip-kDlarm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:05:18 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)) 01:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:05:18 INFO - Running setup.py (path:/tmp/pip-yviJdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:05:18 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)) 01:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:05:18 INFO - Running setup.py (path:/tmp/pip-yaz5Ym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:05:18 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)) 01:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:05:18 INFO - Running setup.py (path:/tmp/pip-GuYCfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:05:18 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)) 01:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:05:18 INFO - Running setup.py (path:/tmp/pip-z8Z1hq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:05:18 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)) 01:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:05:18 INFO - Running setup.py (path:/tmp/pip-DTWONa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:05:18 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)) 01:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:05:18 INFO - Running setup.py (path:/tmp/pip-eiwzuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:05:18 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)) 01:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:05:18 INFO - Running setup.py (path:/tmp/pip-Q3CDmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:05:18 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)) 01:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:05:18 INFO - Running setup.py (path:/tmp/pip-H6UqpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:05:18 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)) 01:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:05:18 INFO - Running setup.py (path:/tmp/pip-tSuYNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:05:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:05:19 INFO - Running setup.py (path:/tmp/pip-e0SMik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:05:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 01:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:05:19 INFO - Running setup.py (path:/tmp/pip-0d087C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:05:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:05:19 INFO - Running setup.py (path:/tmp/pip-CeZ7Ci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:05:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 01:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:05:19 INFO - Running setup.py (path:/tmp/pip-czWdwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:05:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 01:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:05:19 INFO - Running setup.py (path:/tmp/pip-imxer0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:05:19 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)) 01:05:19 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)) 01:05:19 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)) 01:05:19 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)) 01:05:19 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)) 01:05:19 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)) 01:05:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:05:19 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 01:05:19 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 01:05:19 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 01:05:19 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 01:05:19 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 01:05:19 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 01:05:21 INFO - Downloading blessings-1.6.tar.gz 01:05:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:05:21 INFO - Installing collected packages: blessings 01:05:21 INFO - Running setup.py install for blessings 01:05:21 INFO - Successfully installed blessings 01:05:21 INFO - Cleaning up... 01:05:21 INFO - Return code: 0 01:05:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:05:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:05:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:05:21 INFO - Reading from file tmpfile_stdout 01:05:21 INFO - Current package versions: 01:05:21 INFO - argparse == 1.2.1 01:05:21 INFO - blessings == 1.6 01:05:21 INFO - blobuploader == 1.2.4 01:05:21 INFO - docopt == 0.6.1 01:05:21 INFO - manifestparser == 1.1 01:05:21 INFO - mozInstall == 1.12 01:05:21 INFO - mozcrash == 0.17 01:05:21 INFO - mozdebug == 0.1 01:05:21 INFO - mozdevice == 0.48 01:05:21 INFO - mozfile == 1.2 01:05:21 INFO - mozhttpd == 0.7 01:05:21 INFO - mozinfo == 0.9 01:05:21 INFO - mozleak == 0.1 01:05:21 INFO - mozlog == 3.1 01:05:21 INFO - moznetwork == 0.27 01:05:21 INFO - mozprocess == 0.22 01:05:21 INFO - mozprofile == 0.28 01:05:21 INFO - mozrunner == 6.11 01:05:21 INFO - mozscreenshot == 0.1 01:05:21 INFO - mozsystemmonitor == 0.0 01:05:21 INFO - moztest == 0.7 01:05:21 INFO - mozversion == 1.4 01:05:21 INFO - psutil == 3.1.1 01:05:21 INFO - requests == 1.2.3 01:05:21 INFO - wsgiref == 0.1.2 01:05:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:05:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:05:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:05:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:21 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 0x7f3581e30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20db5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216a410>, '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 0x216b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216b7a0>, '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': '7de08804244eb36560b44971000001c3-1461051372.534030-1475585752', '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 01:05:21 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 01:05:21 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 01:05:21 INFO - Using env: {'DISPLAY': ':0', 01:05:21 INFO - 'HOME': '/home/cltbld', 01:05:21 INFO - 'LANG': 'en_US.UTF-8', 01:05:21 INFO - 'LANGUAGE': 'en_US:en', 01:05:21 INFO - 'LOGNAME': 'cltbld', 01:05:21 INFO - 'MAIL': '/var/mail/cltbld', 01:05:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:05:21 INFO - 'MOZ_NO_REMOTE': '1', 01:05:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:05:21 INFO - 'NO_EM_RESTART': '1', 01:05:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:05:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:05:21 INFO - 'PWD': '/builds/slave/test', 01:05:21 INFO - 'SHELL': '/bin/bash', 01:05:21 INFO - 'SHLVL': '1', 01:05:21 INFO - 'TERM': 'linux', 01:05:21 INFO - 'TMOUT': '86400', 01:05:21 INFO - 'USER': 'cltbld', 01:05:21 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461051372.534030-1475585752', 01:05:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:05:21 INFO - '_': '/tools/buildbot/bin/python'} 01:05:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:05:21 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)) 01:05:21 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)) 01:05:21 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)) 01:05:21 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)) 01:05:21 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)) 01:05:21 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)) 01:05:21 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)) 01:05:21 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)) 01:05:21 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)) 01:05:21 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)) 01:05:21 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)) 01:05:21 INFO - Cleaning up... 01:05:21 INFO - Return code: 0 01:05:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:05:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:05:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:05:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:21 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 0x7f3581e30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20db5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216a410>, '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 0x216b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216b7a0>, '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': '7de08804244eb36560b44971000001c3-1461051372.534030-1475585752', '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 01:05:21 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 01:05:21 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 01:05:21 INFO - Using env: {'DISPLAY': ':0', 01:05:21 INFO - 'HOME': '/home/cltbld', 01:05:21 INFO - 'LANG': 'en_US.UTF-8', 01:05:21 INFO - 'LANGUAGE': 'en_US:en', 01:05:21 INFO - 'LOGNAME': 'cltbld', 01:05:21 INFO - 'MAIL': '/var/mail/cltbld', 01:05:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:05:21 INFO - 'MOZ_NO_REMOTE': '1', 01:05:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:05:21 INFO - 'NO_EM_RESTART': '1', 01:05:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:05:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:05:21 INFO - 'PWD': '/builds/slave/test', 01:05:21 INFO - 'SHELL': '/bin/bash', 01:05:21 INFO - 'SHLVL': '1', 01:05:21 INFO - 'TERM': 'linux', 01:05:21 INFO - 'TMOUT': '86400', 01:05:21 INFO - 'USER': 'cltbld', 01:05:21 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461051372.534030-1475585752', 01:05:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:05:21 INFO - '_': '/tools/buildbot/bin/python'} 01:05:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:05:22 INFO - Downloading/unpacking jsonschema 01:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:05:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:05:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:05:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:05:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:05:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:05:24 INFO - Downloading/unpacking functools32 (from jsonschema) 01:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:05:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:05:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:05:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:05:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:05:24 INFO - Downloading functools32-3.2.3-2.tar.gz 01:05:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:05:24 INFO - warning: no files found matching '*.txt' 01:05:24 INFO - no previously-included directories found matching 'build' 01:05:24 INFO - no previously-included directories found matching 'dist' 01:05:24 INFO - no previously-included directories found matching '.git*' 01:05:24 INFO - Installing collected packages: jsonschema, functools32 01:05:24 INFO - Running setup.py install for functools32 01:05:24 INFO - warning: no files found matching '*.txt' 01:05:24 INFO - no previously-included directories found matching 'build' 01:05:24 INFO - no previously-included directories found matching 'dist' 01:05:24 INFO - no previously-included directories found matching '.git*' 01:05:24 INFO - Successfully installed jsonschema functools32 01:05:24 INFO - Cleaning up... 01:05:24 INFO - Return code: 0 01:05:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:05: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')]} 01:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:05:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05: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')]} 01:05:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:05:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3581e30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20db5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216a410>, '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 0x216b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216b7a0>, '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': '7de08804244eb36560b44971000001c3-1461051372.534030-1475585752', '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 01:05: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', 'flake8'] in /builds/slave/test/build 01:05: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 flake8 01:05:24 INFO - Using env: {'DISPLAY': ':0', 01:05:24 INFO - 'HOME': '/home/cltbld', 01:05:24 INFO - 'LANG': 'en_US.UTF-8', 01:05:24 INFO - 'LANGUAGE': 'en_US:en', 01:05:24 INFO - 'LOGNAME': 'cltbld', 01:05:24 INFO - 'MAIL': '/var/mail/cltbld', 01:05:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:05:24 INFO - 'MOZ_NO_REMOTE': '1', 01:05:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:05:24 INFO - 'NO_EM_RESTART': '1', 01:05:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:05:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:05:24 INFO - 'PWD': '/builds/slave/test', 01:05:24 INFO - 'SHELL': '/bin/bash', 01:05:24 INFO - 'SHLVL': '1', 01:05:24 INFO - 'TERM': 'linux', 01:05:24 INFO - 'TMOUT': '86400', 01:05:24 INFO - 'USER': 'cltbld', 01:05:24 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461051372.534030-1475585752', 01:05:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:05:24 INFO - '_': '/tools/buildbot/bin/python'} 01:05:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:05:24 INFO - Downloading/unpacking flake8 01:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:05:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:05:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:05:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:05:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:05:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:05:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:05:26 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 01:05:26 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 01:05:26 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 01:05:26 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 01:05:26 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 01:05:26 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 01:05:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:05:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:05:26 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 01:05:26 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 01:05:26 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 01:05:26 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 01:05:26 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 01:05:26 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 01:05:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:05:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:05:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:05:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:05:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:05:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:05:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:05:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:05:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:05:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:05:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:05:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:05:27 INFO - no previously-included directories found matching 'docs/_build' 01:05:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:05:27 INFO - Running setup.py install for pep8 01:05:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:05:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:05:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:05:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:05:27 INFO - no previously-included directories found matching 'docs/_build' 01:05:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:05:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:05:27 INFO - Cleaning up... 01:05:27 INFO - Return code: 0 01:05:27 INFO - Running post-action listener: _resource_record_post_action 01:05:27 INFO - Running post-action listener: _start_resource_monitoring 01:05:27 INFO - Starting resource monitoring. 01:05:27 INFO - ##### 01:05:27 INFO - ##### Running install step. 01:05:27 INFO - ##### 01:05:27 INFO - Running pre-action listener: _resource_record_pre_action 01:05:27 INFO - Running main action method: install 01:05:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:05:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:05:27 INFO - Reading from file tmpfile_stdout 01:05:27 INFO - Detecting whether we're running mozinstall >=1.0... 01:05:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:05:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:05:27 INFO - Reading from file tmpfile_stdout 01:05:27 INFO - Output received: 01:05:27 INFO - Usage: mozinstall [options] installer 01:05:27 INFO - Options: 01:05:27 INFO - -h, --help show this help message and exit 01:05:27 INFO - -d DEST, --destination=DEST 01:05:27 INFO - Directory to install application into. [default: 01:05:27 INFO - "/builds/slave/test"] 01:05:27 INFO - --app=APP Application being installed. [default: firefox] 01:05:27 INFO - mkdir: /builds/slave/test/build/application 01:05:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:05:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:05:44 INFO - Reading from file tmpfile_stdout 01:05:44 INFO - Output received: 01:05:44 INFO - /builds/slave/test/build/application/firefox/firefox 01:05:44 INFO - Running post-action listener: _resource_record_post_action 01:05:44 INFO - ##### 01:05:44 INFO - ##### Running run-tests step. 01:05:44 INFO - ##### 01:05:44 INFO - Running pre-action listener: _resource_record_pre_action 01:05:44 INFO - Running main action method: run_tests 01:05:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:05:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:05:44 INFO - Python 2.7.3 01:05:44 INFO - Return code: 0 01:05:44 INFO - grabbing minidump binary from tooltool 01:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:05:44 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216a410>, '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 0x216b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216b7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:05:44 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:05:44 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 01:05:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:05:44 INFO - Return code: 0 01:05:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:05:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:05:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:05:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:05:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:05:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:05:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:05:45 INFO - Return code: 0 01:05:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ACuFSuGBQiyE13TXCnu2QA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 01:05:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ACuFSuGBQiyE13TXCnu2QA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 01:05:45 INFO - Using env: {'DISPLAY': ':0', 01:05:45 INFO - 'HOME': '/home/cltbld', 01:05:45 INFO - 'LANG': 'en_US.UTF-8', 01:05:45 INFO - 'LANGUAGE': 'en_US:en', 01:05:45 INFO - 'LOGNAME': 'cltbld', 01:05:45 INFO - 'MAIL': '/var/mail/cltbld', 01:05:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:05:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:05:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:05:45 INFO - 'MOZ_NO_REMOTE': '1', 01:05:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:05:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:05:45 INFO - 'NO_EM_RESTART': '1', 01:05:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:05:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:05:45 INFO - 'PWD': '/builds/slave/test', 01:05:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:05:45 INFO - 'SHELL': '/bin/bash', 01:05:45 INFO - 'SHLVL': '1', 01:05:45 INFO - 'TERM': 'linux', 01:05:45 INFO - 'TMOUT': '86400', 01:05:45 INFO - 'USER': 'cltbld', 01:05:45 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1461051372.534030-1475585752', 01:05:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:05:45 INFO - '_': '/tools/buildbot/bin/python'} 01:05:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ACuFSuGBQiyE13TXCnu2QA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 01:05:45 INFO - mozversion application_buildid: 20160418223145 01:05:45 INFO - mozversion application_changeset: cb65ec85049efa44b18e2e8d06af26768c3bfb94 01:05:45 INFO - mozversion application_display_name: Nightly 01:05:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:05:45 INFO - mozversion application_name: Firefox 01:05:45 INFO - mozversion application_remotingname: firefox 01:05:45 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 01:05:45 INFO - mozversion application_vendor: Mozilla 01:05:45 INFO - mozversion application_version: 48.0a1 01:05:45 INFO - mozversion platform_buildid: 20160418223145 01:05:45 INFO - mozversion platform_changeset: cb65ec85049efa44b18e2e8d06af26768c3bfb94 01:05:45 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 01:05:45 INFO - mozversion platform_version: 48.0a1 01:05:45 INFO - using testdate: 1461053145 01:05:45 INFO - actual date: 1461053145 01:05:45 INFO - starting webserver on 'localhost:58259' 01:05:45 INFO - SUITE-START | Running 2 tests 01:05:45 INFO - TEST-START | dromaeo_css 01:05:45 INFO - operating with platform_type : linux_ 01:05:45 INFO - Initialising browser for dromaeo_css test... 01:05:45 INFO - TEST-INFO | started process 5428 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt_lhZ6/profile http://localhost:58259/getInfo.html) 01:05:49 INFO - PROCESS | 5428 | 01:05:49 INFO - PROCESS | 5428 | (process:5495): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:05:50 INFO - PROCESS | 5428 | __metrics Screen width/height:1600/1200 01:05:50 INFO - PROCESS | 5428 | colorDepth:24 01:05:50 INFO - PROCESS | 5428 | Browser inner width/height: 1024/697 01:05:50 INFO - PROCESS | 5428 | __metrics 01:05:50 ERROR - PROCESS | 5428 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 01:05:51 INFO - TEST-INFO | 5428: exit 0 01:05:51 INFO - Browser initialized. 01:05:51 INFO - Running cycle 1/1 for dromaeo_css test... 01:05:51 INFO - TEST-INFO | started process 5546 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt_lhZ6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:05:53 INFO - PROCESS | 5546 | 01:05:53 INFO - PROCESS | 5546 | (process:5605): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:06:03 INFO - PROCESS | 5546 | RSS: Main: 163840000 01:06:03 INFO - PROCESS | 5546 | 01:06:52 INFO - PROCESS | 5546 | 1461053212974 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] 01:09:00 INFO - PROCESS | 5546 | Cycle 1(1): loaded http://localhost:58259/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58259/tests/dromaeo/cssquery-ext.html) 01:09:01 INFO - PROCESS | 5546 | RSS: Main: 167895040 01:09:01 INFO - PROCESS | 5546 | 01:12:03 INFO - PROCESS | 5546 | Cycle 1(1): loaded http://localhost:58259/tests/dromaeo/cssquery-ext.html (next: http://localhost:58259/tests/dromaeo/cssquery-jquery.html) 01:12:03 INFO - PROCESS | 5546 | RSS: Main: 164978688 01:12:03 INFO - PROCESS | 5546 | 01:15:05 INFO - PROCESS | 5546 | Cycle 1(1): loaded http://localhost:58259/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58259/tests/dromaeo/cssquery-mootools.html) 01:15:06 INFO - PROCESS | 5546 | RSS: Main: 166477824 01:15:06 INFO - PROCESS | 5546 | 01:18:07 INFO - PROCESS | 5546 | Cycle 1(1): loaded http://localhost:58259/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58259/tests/dromaeo/cssquery-prototype.html) 01:18:08 INFO - PROCESS | 5546 | RSS: Main: 163913728 01:18:08 INFO - PROCESS | 5546 | 01:21:10 INFO - PROCESS | 5546 | Cycle 1(1): loaded http://localhost:58259/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58259/tests/dromaeo/cssquery-yui.html) 01:21:11 INFO - PROCESS | 5546 | RSS: Main: 164917248 01:21:11 INFO - PROCESS | 5546 | 01:24:13 INFO - PROCESS | 5546 | Cycle 1(1): loaded http://localhost:58259/tests/dromaeo/cssquery-yui.html (next: http://localhost:58259/tests/dromaeo/cssquery-dojo.html) 01:24:13 INFO - PROCESS | 5546 | RSS: Main: 167100416 01:24:13 INFO - PROCESS | 5546 | 01:24:13 INFO - PROCESS | 5546 | __start_tp_report 01:24:13 INFO - PROCESS | 5546 | _x_x_mozilla_page_load 01:24:13 INFO - PROCESS | 5546 | _x_x_mozilla_page_load_details 01:24:13 INFO - PROCESS | 5546 | |i|pagename|runs| 01:24:13 INFO - PROCESS | 5546 | |0;dojo.html;3096.6748491408407;3209.1014515935544;3220.0339898030584;3236.417444859924;3243.69184927432;5293.497117773815;5345.652532585379;5349.679019258842;5362.919556206651;5411.810586629469;5159.690418574879;5284.867878303045;5387.138057910735;5396.811111611094;5416.07926652469;4846.442659094214;4884.19410797218;4931.235658472942;4966.5778408835295;4985.052839960414;850.3016500474263;4817.253325734517;4845.709257444547;4850.854474365757;4882.2432522959;4819.108464933981;4822.963062941467;4824.372831531913;4846.41842978843;4847.51524847516;4834.927476087862;4839.370881785346;4859;4863.489333619955;4890.535399137077;4813.205821039524;4841.394825646794;4846.806127754886;4879.292502587141;4896.2410826321975;5122.718250496221;5155.226715992593;5168.664036837631;5169.896602067937;5187;5551.195076713894;5634.492895639371;5635.09838425854;5641.323041235037;5655.236543066674;5692.459216374438;5742.368339482696;5767.855803604902;5784.363719990798;5813.709314534256;5402.432744561804;5429.484199001088;5431.8098866539485;5432.239486471897;5436.6194366393975;5748.993926062923;5785.421457854265;5855.443732845373;5861;5866.7653293868625;5670.914936275959;5677.716114194273;5691.288588926384;5694.5159661428415;5724.742386592613;5762.222100016528;5769.711514424346;5771.076627739541;5777.988851950891;5779.711014449261;5530.391656917735;5692.544596432275;5729.656220626775;5756.510696590753;5765.077587585966;5538.335399752055;5547.417521160301;5554.805581804618;5563.610547261653;5621.18492818539;4224.9155016899485;4260.2970509866145;4260.382244574519;4260.692747873375;4288.142371525707;3826.559945606291;3828.5214348206473;3855.0747820522874;3892.4355968384425;3918.3338832398563;5302.416734159239;5475.753591088411;5532.170174473861;5532.972335138379;5555.999920014356;5693.0891057431445;5695.03184458643;5717.028105222123;5720.713964301852;5726.312842458931;5281.471852814765;5422.701751403711;5430.484104010192;5476.12382018883;5569.554435645138;4753.9762301188275;4810.11012962603;4815.590674792612;4838.03239352131;4877.6829506081995;5984.910226346608;6003.249593800775;6016.037434010537;6018.368071352533;6018.909716354258;5664.631798932974;5722.885542289214;5797.36229014808;5804.361520232856;5826;5792.333881603669;5810.76756929735;5815.563832712479;5821.27234095738;5836.387179346278;5537;5537.446255374431;5554.972225138848;5562.276904002454;5564.805231816867;5597;5764.279465066867;5805.245318108618;5828.825135245949;5832.096025116114;5442.727863606725;5448.318960129984;5486.588505862156;5490.121580547093;5495.477929596682;5433.5924805640525;5461.1262198048125;5484.287042684426;5486.945130548644;5539.25220095282;5595.160725891149;5607.663540187602;5624.381318055092;5639.436056394327;5668.348139963792;5512.6968016759465;5526.696031718294;5551.583631227593;5561.249231353715;5580.637258578179;5456.0451920914475;5471.644343117685;5473.042217611823;5483.4516548344845;5518.530924871431 01:24:13 INFO - PROCESS | 5546 | |1;ext.html;606.2997238189889;636.621210379824;646.7994921574312;657.4641667041361;676.9390754832065;35020.12449688759;36074.639253607456;36276;36363.272734545295;36403.27193456129;36174.81912590433;36810.63189368106;37035.629643703556;37060.07349816256;37138.257234855286;8347.123552027026;8597.914020859806;8625.698100566482;8629.266512346458;8633.827323453526;8536.658533658647;8613.784655383633;8634.913650863473;8636.913630863673;8641.65433382664;8525.701600443987;8605.31157507398;8610.612522436506;8668.04651488339;8717.041125476193;8589.742307730778;8669.089745576719;8669.696560620348;8670.566471676422;8689.478631282143;8437.704680336221;8496.787580310542;8532.23209911111;8553.615087321023;8565.571721413904;32771;37619.62380376188;37909.81045094784;37967;38162.618373816185;3319.317118107644;3424.4863270509372;3788.6211378862167;4100.159467309224;4343.261645520269;28314.575281370795;29571.852140739375;29783.25541861449;30006.299433051132;30352.84823575868;4117.07365842686;4228.513720922072;4238.745675259494;4239.894002649928;4285.57144285572;255516;258538;260126.69936650386;261433;261906;34237.486437703454;55413.168802468;57293.713531432906;57311.71344143253;57326.14010789841;33330.83334583312;33472.49791253133;33562.66437335644;33569.83215083909;33750.324993500486;13147.211167329991;13465.259410732504;13527.188368697909;13547.119437236548;13630.1140425872;10701;10715.464226788785;10779.461026948778;10805.351678899291;10815.621453249098;8280.337572994145;8334.874976875351;8358.122397148334;8387.203215694499;8418.663253469915;3265.2979609384097;3269.4278501262183;3271.9509207361907;3309.520119582647;3344.8662053517587;1067.2049323254225;1127.1996882213557;1147.0766033343073;1151.7984352738238;1183.0653783511102;30602.38795224083;30868.53697194544;31308.53037204444;31361;31828.840855795574;1199.3403628004562;1220.0056953582803;1240.4356018011783;1244.1601918705019;1289.2973329535425;16376.426825061304;16573.751393729104;16578.419755308507;16676;16819.15904204785;438548;442699;444142;446424;447403;54638.45361546334;55375.723121384945;55557;55628.72185639046;55704.72147639317;1373.9175649460865;1387.840398354202;1399.986000140006;1427.1223197733111;1430.7782293744485;30545.08364749061;30732.385352293277;31179.532307015867;31381.21546961253;31392.843035784674;46578;47180.52819471761;47190.76404617955;47207.763961179975;47283.05433891372;378615;381354;382880;383116;383947;27177.505237212143;42086.36870447007;43287.63289032348;43543.782281088395;44219.346839189755;43903.34144987891;44451.26722063197;44593;44769.32846007247;45618.543814562756;38330.53059146908;38462.42306365463;39356.409653855786;39488.40767388549;39746.80126599348;38048.619513805614;42317;43825.56174438215;44034.55965440305;44096;39903.40144897771;40182.59817401788;40265;40456.59543404646;40568.594314056485;32691.673083268863;34189.06825715075;34650.48024279688;34847.12882177966;34925.65074349326;27286;27633.723662763114;27877.58183627288;27960.44079118447;28177.43645127127 01:24:13 INFO - PROCESS | 5546 | |2;jquery.html;384.5308723357505;390.2779857264061;393.9606039396061;395.55697618667097;408.68122864165963;14210.218437985906;14549.927250363733;17330.306787728492;17999.370022049214;18123.275068997256;10713.142948564117;11230.382328971904;17755.55611109723;18206.271749130017;18226.908865455654;4869.172240719068;5022.673526220802;5025.120603894322;5033.496650334974;5035.144025515671;4897.436794768594;4981.501849815026;4984.75076246188;5038.949610503903;5044.848654540369;4955.033768415161;4975.2039673652225;5007.32401125847;5018.949810501885;5036.143855544567;5025.497450254982;5036.2193859951585;5160.741962901859;5640.379558248589;5649.293838270216;5067.619928505377;5071.56891664209;5074.543291103819;5095.566876815476;5117.48825117489;12387.75224495505;20347.389578312675;21987.120515179373;22261.888690556443;22327.218547350763;2271.5911135995516;2341.613633750429;2350.6944097267246;2383.547126046063;2421.6004359280696;9549.61801527938;9575.61697532098;9623.230141588656;9712.61149554017;9883.357581757235;1941.1264930781206;1993.8504612154002;1997.4806550296883;2027.4221846773598;2042.2545770793702;73854.26145738528;77526.22473775303;79313;79396;80338.59830700808;8336.666533338599;8954.462732236087;9085.909140908507;9375.249980001583;9482.810343793086;12978;13023.609291721263;13026.47894084245;13030.413631386611;13066.085374023916;7109.751158709524;7366.042414486083;7384.889226661604;7386.815329616803;7432.256774322633;7117.893231601426;7142.750003749844;7208.891866622005;7219.205887352387;7264.927350726531;3874.089588946595;3913.8434462621744;3964.980175099106;4005.7396269242404;4090.079732060263;1942.9805701943083;1946.240966023252;1979.3369221311023;1980.4156674660214;2019.4951262184454;1015.3907655406697;1039.5581877702098;1109.1902910875106;1118.8769235384102;1142.5886680794906;18348.266069357076;18651.720224196648;18910.810891890906;19141.61716765657;19207.231710731416;1017.0998666180336;1082.2802836114054;1090.2749671468384;1108.351614305624;1112.2881355932209;10232.386056836465;10596.788064238672;10728.892711072946;10934.945325273322;10961.780764384668;497651;520947;524982;529340;534706;88447.55776221078;88526.55736721405;88544.5572772145;88549;89366;994.1450352696675;1021.8824835144054;1029.2897900448665;1029.8609687692065;1034.2036631793628;16359.427420040241;16786.58033549171;17002.31990720407;17063.573410664336;17222.483325500256;36236.27527449489;37788.24423511569;38057.42913856239;38831.41752873653;39545.20909581735;51173.744131279105;51375;51817;54346.45653543414;54463.72768136134;7944.880826787487;8096.959515202387;8162.265396114378;8212.384071194565;8399.70601028961;12002.21985570935;13311.600651980456;13346.666333341744;13397.397117129947;13526.120802147829;11728.472218750007;11789.469473873867;11811.645650630495;11826;12082.45628946682;11486.655400338002;11554.711132221426;11790.469428875549;11840.881591184323;11923.403829808649;11639.6508104757;11836.112291578338;11954.880451195377;12038.939805301268;12402.75194496123;8066.9109670193775;8158.224968627971;8274.462159959825;8340.582970851554;8397.37019723511;11115.388653624128;12024.879751202376;12076.637700868989;12155.149139560146;12372.505099795908 01:24:13 INFO - PROCESS | 5546 | |3;mootools.html;1511.5163147792707;1526.2292542266157;1684.6462242928985;1768.0452555619966;1777.893326400416;7489.28851759082;7930.444868859182;8104.756857294291;8221.588920553972;8222.671093156274;8179.713710020151;8181.959090204556;8225.054118776343;8226.136255693156;8228.177182281768;2247.2584047264445;2258.141906075697;2271.2958982715413;2275.1468199425217;2278.453171238907;2221.944451388712;2260.2993072147688;2281;2286.85135466195;2287.1308902616984;2279.806216471602;2299.8275129365366;2309.3302942146756;2332.3119679694532;2333.7899589036983;2223.5997520446313;2230.7546169921297;2232.0513781642817;2233.6091184042807;2235.776422357751;2147.5060736030646;2170.2621108823078;2171.8262538997;2174.5868285025795;2176.4885251965775;8294.129116442748;8295.087540370614;8330.70842520515;8356.415050946376;8369.079401265855;4955.776990035457;5084.7457627118865;5095.949040509585;5127.333446651949;5140.691558506464;3170.7621928355466;3281.2945216778267;3286.3920174767745;3352.2960178362573;3384.170878134848;1089.411717672456;1097.1332647208696;1103.5475455063386;1104.5913012185463;1114.2645853736494;11272.09823214149;11282.943585282103;11291.53210082684;11299;11368.204225704205;4213.87358379243;4338.175746608134;4380.62764665007;4546.931796023062;4548.931766023512;9495.620175192915;9498.382605130644;9551.856722149174;9570.56932438042;9576.521173941275;4998.725070121105;5005.374328208974;5009.824656137091;5014.197728363517;5021.974890125526;4116.115035267432;4483.103379324083;4605.562471565196;4629.745364004944;4640.744759038218;3813.7139714521522;3838.9040273992814;3843.327417701891;3877.6897848172644;3906.5312162540677;1233.481937586216;1240.34881687115;1243.608263397027;1248.9875101248872;1278.5461161287794;944.447498213539;1026.5996261458038;1034.9534270957824;1037.7561273100816;1056.1867362131115;6028.788992385334;6098.664573448503;6101.267847858286;6103.38966103395;6297.307296197415;980.0836218136066;983.6311383231289;996.5067291690659;1030.1912998296302;1037.8391349340864;4036.858709945138;4141.689373297015;4215.747055176699;4221.240176768211;4241.27898257297;9786.510674466248;10122.848157277647;10132.24008199388;10217.795644087077;10262.589496420209;10176.694699159038;10228.59085636581;10238.33450825694;10253.07722304996;10277.126444252173;7523.774286771406;7752.0697516298405;7841.607919604111;7989.600519973978;7996.000499937508;5783.710814459176;5849.1226316052935;5849.356570777126;5909.6158749681135;5919.85200369977;9006;9115.772105697411;9333.206677432494;9347.626094956398;9399.577019034297;9324.347295689236;9438.244940404615;9501.049895010443;9582.185514231369;9618;6885.242623311332;7222.349988501061;7507.174210836913;7517.661705223388;7626.771196864103;7989.440739148204;8031.317338026333;8054.355651547745;8075.273225409741;8092.757217283491;7047.682854271673;7302.123745150616;7385;7387.076615423072;7433.776986690408;7139.571625702474;7145.642717863982;7170.318819712119;7180.856382872418;7200.603966781878;6819.624920629413;6878.965605171942;6899.827504312432;6925.965370173117;6937.7224911002995;4878.219484882544;5055.545000949932;5061.620378471703;5096.949030509796;5115.769790359368;4902.166631672696;4993.950060499348;4999.900002000012;5010.649254552146;5094.15946368845 01:24:13 INFO - PROCESS | 5546 | |4;prototype.html;323.6666233779208;332.52947079881966;338.2389623347469;338.4669146094901;340.3176630855135;5856.941430585698;5994.940050599498;6055.333913269542;6102.481289090421;6126.7549298028025;5945.937842011368;5985.8204253872345;6000.249968753906;6033.09503574463;6038.426349496802;4522.299043648231;4524.253498172798;4534.727916325014;4539.54604539545;4543.1140927519145;4323.589259020404;4501.279795232764;4511.59395654391;4514.4582650081875;4519.932201016971;4437.6671749618745;4467.932981005288;4476.970296831731;4477.149341625097;4499.865004049884;4452.977735111303;4457.219986502365;4472.329150627399;4474.507804141542;4491.169133710274;3816.923661526754;3825.8278377472802;3826.6556009959236;3830.176512049895;3832.559255685604;5645.01212287848;5659.405762394971;5700.287464066992;5727.656340619535;5733.197352370671;5086.135356989321;5118.7696553654805;5137.871553211162;5139.74301284938;5148.176291793295;6032.366601506867;6213.533984951102;6229.09678096678;6244.157038799749;6283.6858157091965;4305.98809279819;4308.9569104309185;4316.740995540277;4323.048929235563;4334.783260836945;5941.979726892877;6488.772892948724;6507.414332710079;6557.180352455943;6563.916953702634;4356.716813407118;4409.140217657526;4427.623651989553;4429.933550996738;4441.089576636782;4466.531014243457;4474.082813023388;4485.708428952108;4485.887852803706;4508.1659892919915;4923.138450771101;5163.870903227449;5211.42674305826;5221.556167725786;5229.163333866563;6260.342664020212;6343.333949935282;6356.45970092538;6372.171617689671;6384.138141350858;1541.0907564536976;1554.3782487005287;1560.7502799552017;1568.3099436248015;1571.9449819256272;1018.6383833739064;1023.7287118913493;1031.3554028732042;1037.6990672704983;1038.8649475568127;6085.1785009023215;6114.74647697221;6146.200993870768;6151.692415379213;6162.568620196544;6471;6476.708548115252;6488.383603557654;6501.44737697301;6514.54398192122;5954.612950158225;6079.385864078488;6132.202813634288;6139.96930015356;6167.506599472032;3452;3465.7227421806197;3496.667816557423;3500.1074725944723;3506.8071256080652;6418.74325027003;6686.899696504556;6702.698378572976;6702.731890724316;6749.763758268437;6585.6707164641575;6596.10952521413;6613.503987200979;6643.335666433415;6664.466842652576;6529.780252560425;6657.900131498031;6701.5979041256705;6760.459163267025;6775.661216939134;6444.420002199825;6462.483001359974;6462.806115816533;6464.773732919325;6498.610083395011;6285.994240921431;6420.711068001858;6425.678716064272;6438.452731517874;6453.612783233021;6728.125343705287;6734.764283250062;6747.561408508432;6754.324567543206;6772.796816095525;4446.844360447369;4448.733076015449;4455.1757924784015;4457.665675074318;4459.933101003423;6315.3053164152825;6534.137770735508;6554.967225163844;6555.606663600009;6569.441597464269;6292.402221788922;6306.747730090745;6313.494920406449;6317.115603815378;6322.620642761449;6158.4261579299555;6179.783707570214;6303.779367722291;6304.275008373912;6324.683765811599;6143.938560614337;6147.784827531015;6172.783952561639;6195.81412557624;6209.875802484015;6149.963339634551;6328.588641738456;6348.269948955929;6354.586951848115;6392.328805475544;6141.26713612456;6143.508519318354;6151.754609567565;6173.56785025044;6189.25550042236 01:24:13 INFO - PROCESS | 5546 | |5;yui.html;669.6383952665558;696.3663066609383;816.1878930464189;857.7512521368803;869.2133619074738;14117.152970821759;14465.421383144689;14495.85504144961;14499.42002319906;14522.636934076654;13735.931320343409;13760.105593136439;13792.862071379282;13803.930980345109;13876.791848122286;665.9533832631705;792.6551949901782;822.9876551851727;825.2407784837964;826.450410477032;815.4047545291941;816.6896579299857;821.8849361089452;823.1110400767157;823.6046697585133;864.8832407624984;865.6277800545763;867.0635713429481;867.4361664917823;871.2246100970142;860.2000139869949;861.4314552395421;866.0343716755804;870.334194341323;871.5598622695561;633.8732253549308;633.9873202535923;634.2325785799188;635.828326351887;636.1253276744476;14355;14385.28073596316;14435.855641443557;14465.349059292252;14467.348969296407;13795.2412617306;13840.238786866717;13960.581182564438;14052.508162214375;14242.287885605678;11747.94126029373;11833.644990650295;11896.643100706993;11994.10044246685;12086.214396064228;3924.607539246081;3943.9014024649614;3956.4065390191413;4022.1151346703973;4113;54179;54905.45094549043;56318.71840640771;56351.154732679046;56901.999999999585;10951.890481095246;11176.27354221973;11268.09855211581;11394.772104557862;11419.828702569468;20493.59012819765;20518.179272829217;20520.486987825425;20545.075471603814;20619.896900515403;8305.95847020761;8375.874361884577;8619.78450538729;8629.654813807503;8641.524716140548;4831.661783675179;4875.756212189376;4913.631477639191;4917.213245880642;4961.677490963076;3265.6244531878665;3354.362671092533;3391.5251864738957;3393.745469089779;3397.3545026444895;572.4161355417451;589.5283772981597;597.5100417657479;598.9371116032754;611.9724612392453;730.8830587106038;733.7175187552831;755.1466842467976;756.4515726098534;783.0994356490082;9009.23421509166;9302.743949668551;9393.107654772786;9507.1918886894;9535.809283814286;677.0183234310269;725.6154238253733;732.5494820685241;770.4799260499141;782.1982467970375;4245.172191422705;4416.889577760582;4435.157320109169;4597.95402045982;4610.53894610543;50911;53001;60989.69505152446;61143;61332.38667613356;47042.294365584545;47378.289325660146;48351.516484834705;51319.74340128276;52663.73668131712;46084;46096;47838.521614784106;48417.27374089321;49268.26097608539;8909.643614255358;8979.326550508607;9022.14289642483;9584.329096963145;9673;31236.219094522818;32402.675973239966;32828.17929551685;32855.342893141526;32932.50601240935;39058.804705977425;40277.194456110126;43698.781506092266;43977.56022439735;44077.33883991807;12439.689007774878;12482.500699972263;12819.294938778457;12855.485780569046;12893.871061289266;13802.930985345009;13881.444742210198;14015.089019213718;14099.718005640036;14251;13154.868451315748;13272.668183295495;13678.247696376795;13753.312334383041;13915.443382265;13194.472221111431;13346.933265333999;13542.661433463849;13665;13772.173669579857;12042.578509752117;13158.60524184276;13334.39995200199;13370.06409551322;13388.799168012682;9999.500024998575;10002.972651605116;10027.247956403446;10050.899491004997;10206.387616743019;10246.948765256126;10760.784784304427;10880.836787448035;10959.671209863716;10986.395748233605 01:24:13 INFO - PROCESS | 5546 | __end_tp_report 01:24:13 INFO - PROCESS | 5546 | __start_cc_report 01:24:13 INFO - PROCESS | 5546 | _x_x_mozilla_cycle_collect,338 01:24:13 INFO - PROCESS | 5546 | __end_cc_report 01:24:13 INFO - PROCESS | 5546 | __startTimestamp1461054253800__endTimestamp 01:24:13 INFO - PROCESS | 5546 | 01:24:13 INFO - PROCESS | 5546 | ------- Summary: start ------- 01:24:13 INFO - PROCESS | 5546 | Number of tests: 6 01:24:13 INFO - PROCESS | 5546 | 01:24:13 INFO - PROCESS | 5546 | [#0] dojo.html Cycles:165 Average:5272.66 Median:5495.48 stddev:691.39 (12.6%) stddev-sans-first:672.10 01:24:13 INFO - PROCESS | 5546 | Values: 3096.7 3209.1 3220.0 3236.4 3243.7 5293.5 5345.7 5349.7 5362.9 5411.8 5159.7 5284.9 5387.1 5396.8 5416.1 4846.4 4884.2 4931.2 4966.6 4985.1 850.3 4817.3 4845.7 4850.9 4882.2 4819.1 4823.0 4824.4 4846.4 4847.5 4834.9 4839.4 4859.0 4863.5 4890.5 4813.2 4841.4 4846.8 4879.3 4896.2 5122.7 5155.2 5168.7 5169.9 5187.0 5551.2 5634.5 5635.1 5641.3 5655.2 5692.5 5742.4 5767.9 5784.4 5813.7 5402.4 5429.5 5431.8 5432.2 5436.6 5749.0 5785.4 5855.4 5861.0 5866.8 5670.9 5677.7 5691.3 5694.5 5724.7 5762.2 5769.7 5771.1 5778.0 5779.7 5530.4 5692.5 5729.7 5756.5 5765.1 5538.3 5547.4 5554.8 5563.6 5621.2 4224.9 4260.3 4260.4 4260.7 4288.1 3826.6 3828.5 3855.1 3892.4 3918.3 5302.4 5475.8 5532.2 5533.0 5556.0 5693.1 5695.0 5717.0 5720.7 5726.3 5281.5 5422.7 5430.5 5476.1 5569.6 4754.0 4810.1 4815.6 4838.0 4877.7 5984.9 6003.2 6016.0 6018.4 6018.9 5664.6 5722.9 5797.4 5804.4 5826.0 5792.3 5810.8 5815.6 5821.3 5836.4 5537.0 5537.4 5555.0 5562.3 5564.8 5597.0 5764.3 5805.2 5828.8 5832.1 5442.7 5448.3 5486.6 5490.1 5495.5 5433.6 5461.1 5484.3 5486.9 5539.3 5595.2 5607.7 5624.4 5639.4 5668.3 5512.7 5526.7 5551.6 5561.2 5580.6 5456.0 5471.6 5473.0 5483.5 5518.5 01:24:13 INFO - PROCESS | 5546 | 01:24:13 INFO - PROCESS | 5546 | [#1] ext.html Cycles:180 Average:51437.47 Median:209701.31 stddev:97838.41 (46.7%) stddev-sans-first:98038.43 01:24:13 INFO - PROCESS | 5546 | Values: 606.3 636.6 646.8 657.5 676.9 35020.1 36074.6 36276.0 36363.3 36403.3 36174.8 36810.6 37035.6 37060.1 37138.3 8347.1 8597.9 8625.7 8629.3 8633.8 8536.7 8613.8 8634.9 8636.9 8641.7 8525.7 8605.3 8610.6 8668.0 8717.0 8589.7 8669.1 8669.7 8670.6 8689.5 8437.7 8496.8 8532.2 8553.6 8565.6 32771.0 37619.6 37909.8 37967.0 38162.6 3319.3 3424.5 3788.6 4100.2 4343.3 28314.6 29571.9 29783.3 30006.3 30352.8 4117.1 4228.5 4238.7 4239.9 4285.6 255516.0 258538.0 260126.7 261433.0 261906.0 34237.5 55413.2 57293.7 57311.7 57326.1 33330.8 33472.5 33562.7 33569.8 33750.3 13147.2 13465.3 13527.2 13547.1 13630.1 10701.0 10715.5 10779.5 10805.4 10815.6 8280.3 8334.9 8358.1 8387.2 8418.7 3265.3 3269.4 3272.0 3309.5 3344.9 1067.2 1127.2 1147.1 1151.8 1183.1 30602.4 30868.5 31308.5 31361.0 31828.8 1199.3 1220.0 1240.4 1244.2 1289.3 16376.4 16573.8 16578.4 16676.0 16819.2 438548.0 442699.0 444142.0 446424.0 447403.0 54638.5 55375.7 55557.0 55628.7 55704.7 1373.9 1387.8 1400.0 1427.1 1430.8 30545.1 30732.4 31179.5 31381.2 31392.8 46578.0 47180.5 47190.8 47207.8 47283.1 378615.0 381354.0 382880.0 383116.0 383947.0 27177.5 42086.4 43287.6 43543.8 44219.3 43903.3 44451.3 44593.0 44769.3 45618.5 38330.5 38462.4 39356.4 39488.4 39746.8 38048.6 42317.0 43825.6 44034.6 44096.0 39903.4 40182.6 40265.0 40456.6 40568.6 32691.7 34189.1 34650.5 34847.1 34925.7 27286.0 27633.7 27877.6 27960.4 28177.4 01:24:13 INFO - PROCESS | 5546 | 01:24:13 INFO - PROCESS | 5546 | [#2] jquery.html Cycles:180 Average:28875.70 Median:37922.84 stddev:85791.23 (226.2%) stddev-sans-first:86005.22 01:24:13 INFO - PROCESS | 5546 | Values: 384.5 390.3 394.0 395.6 408.7 14210.2 14549.9 17330.3 17999.4 18123.3 10713.1 11230.4 17755.6 18206.3 18226.9 4869.2 5022.7 5025.1 5033.5 5035.1 4897.4 4981.5 4984.8 5038.9 5044.8 4955.0 4975.2 5007.3 5018.9 5036.1 5025.5 5036.2 5160.7 5640.4 5649.3 5067.6 5071.6 5074.5 5095.6 5117.5 12387.8 20347.4 21987.1 22261.9 22327.2 2271.6 2341.6 2350.7 2383.5 2421.6 9549.6 9575.6 9623.2 9712.6 9883.4 1941.1 1993.9 1997.5 2027.4 2042.3 73854.3 77526.2 79313.0 79396.0 80338.6 8336.7 8954.5 9085.9 9375.2 9482.8 12978.0 13023.6 13026.5 13030.4 13066.1 7109.8 7366.0 7384.9 7386.8 7432.3 7117.9 7142.8 7208.9 7219.2 7264.9 3874.1 3913.8 3965.0 4005.7 4090.1 1943.0 1946.2 1979.3 1980.4 2019.5 1015.4 1039.6 1109.2 1118.9 1142.6 18348.3 18651.7 18910.8 19141.6 19207.2 1017.1 1082.3 1090.3 1108.4 1112.3 10232.4 10596.8 10728.9 10934.9 10961.8 497651.0 520947.0 524982.0 529340.0 534706.0 88447.6 88526.6 88544.6 88549.0 89366.0 994.1 1021.9 1029.3 1029.9 1034.2 16359.4 16786.6 17002.3 17063.6 17222.5 36236.3 37788.2 38057.4 38831.4 39545.2 51173.7 51375.0 51817.0 54346.5 54463.7 7944.9 8097.0 8162.3 8212.4 8399.7 12002.2 13311.6 13346.7 13397.4 13526.1 11728.5 11789.5 11811.6 11826.0 12082.5 11486.7 11554.7 11790.5 11840.9 11923.4 11639.7 11836.1 11954.9 12038.9 12402.8 8066.9 8158.2 8274.5 8340.6 8397.4 11115.4 12024.9 12076.6 12155.1 12372.5 01:24:13 INFO - PROCESS | 5546 | 01:24:13 INFO - PROCESS | 5546 | [#3] mootools.html Cycles:180 Average:5518.19 Median:5002.64 stddev:3022.47 (60.4%) stddev-sans-first:3015.95 01:24:13 INFO - PROCESS | 5546 | Values: 1511.5 1526.2 1684.6 1768.0 1777.9 7489.3 7930.4 8104.8 8221.6 8222.7 8179.7 8182.0 8225.1 8226.1 8228.2 2247.3 2258.1 2271.3 2275.1 2278.5 2221.9 2260.3 2281.0 2286.9 2287.1 2279.8 2299.8 2309.3 2332.3 2333.8 2223.6 2230.8 2232.1 2233.6 2235.8 2147.5 2170.3 2171.8 2174.6 2176.5 8294.1 8295.1 8330.7 8356.4 8369.1 4955.8 5084.7 5095.9 5127.3 5140.7 3170.8 3281.3 3286.4 3352.3 3384.2 1089.4 1097.1 1103.5 1104.6 1114.3 11272.1 11282.9 11291.5 11299.0 11368.2 4213.9 4338.2 4380.6 4546.9 4548.9 9495.6 9498.4 9551.9 9570.6 9576.5 4998.7 5005.4 5009.8 5014.2 5022.0 4116.1 4483.1 4605.6 4629.7 4640.7 3813.7 3838.9 3843.3 3877.7 3906.5 1233.5 1240.3 1243.6 1249.0 1278.5 944.4 1026.6 1035.0 1037.8 1056.2 6028.8 6098.7 6101.3 6103.4 6297.3 980.1 983.6 996.5 1030.2 1037.8 4036.9 4141.7 4215.7 4221.2 4241.3 9786.5 10122.8 10132.2 10217.8 10262.6 10176.7 10228.6 10238.3 10253.1 10277.1 7523.8 7752.1 7841.6 7989.6 7996.0 5783.7 5849.1 5849.4 5909.6 5919.9 9006.0 9115.8 9333.2 9347.6 9399.6 9324.3 9438.2 9501.0 9582.2 9618.0 6885.2 7222.3 7507.2 7517.7 7626.8 7989.4 8031.3 8054.4 8075.3 8092.8 7047.7 7302.1 7385.0 7387.1 7433.8 7139.6 7145.6 7170.3 7180.9 7200.6 6819.6 6879.0 6899.8 6926.0 6937.7 4878.2 5055.5 5061.6 5096.9 5115.8 4902.2 4994.0 4999.9 5010.6 5094.2 01:24:13 INFO - PROCESS | 5546 | 01:24:13 INFO - PROCESS | 5546 | [#4] prototype.html Cycles:180 Average:5244.94 Median:6067.36 stddev:1597.53 (26.3%) stddev-sans-first:1558.72 01:24:13 INFO - PROCESS | 5546 | Values: 323.7 332.5 338.2 338.5 340.3 5856.9 5994.9 6055.3 6102.5 6126.8 5945.9 5985.8 6000.2 6033.1 6038.4 4522.3 4524.3 4534.7 4539.5 4543.1 4323.6 4501.3 4511.6 4514.5 4519.9 4437.7 4467.9 4477.0 4477.1 4499.9 4453.0 4457.2 4472.3 4474.5 4491.2 3816.9 3825.8 3826.7 3830.2 3832.6 5645.0 5659.4 5700.3 5727.7 5733.2 5086.1 5118.8 5137.9 5139.7 5148.2 6032.4 6213.5 6229.1 6244.2 6283.7 4306.0 4309.0 4316.7 4323.0 4334.8 5942.0 6488.8 6507.4 6557.2 6563.9 4356.7 4409.1 4427.6 4429.9 4441.1 4466.5 4474.1 4485.7 4485.9 4508.2 4923.1 5163.9 5211.4 5221.6 5229.2 6260.3 6343.3 6356.5 6372.2 6384.1 1541.1 1554.4 1560.8 1568.3 1571.9 1018.6 1023.7 1031.4 1037.7 1038.9 6085.2 6114.7 6146.2 6151.7 6162.6 6471.0 6476.7 6488.4 6501.4 6514.5 5954.6 6079.4 6132.2 6140.0 6167.5 3452.0 3465.7 3496.7 3500.1 3506.8 6418.7 6686.9 6702.7 6702.7 6749.8 6585.7 6596.1 6613.5 6643.3 6664.5 6529.8 6657.9 6701.6 6760.5 6775.7 6444.4 6462.5 6462.8 6464.8 6498.6 6286.0 6420.7 6425.7 6438.5 6453.6 6728.1 6734.8 6747.6 6754.3 6772.8 4446.8 4448.7 4455.2 4457.7 4459.9 6315.3 6534.1 6555.0 6555.6 6569.4 6292.4 6306.7 6313.5 6317.1 6322.6 6158.4 6179.8 6303.8 6304.3 6324.7 6143.9 6147.8 6172.8 6195.8 6209.9 6150.0 6328.6 6348.3 6354.6 6392.3 6141.3 6143.5 6151.8 6173.6 6189.3 01:24:13 INFO - PROCESS | 5546 | 01:24:13 INFO - PROCESS | 5546 | [#5] yui.html Cycles:180 Average:14538.25 Median:4426.02 stddev:16109.10 (364.0%) stddev-sans-first:16120.62 01:24:13 INFO - PROCESS | 5546 | Values: 669.6 696.4 816.2 857.8 869.2 14117.2 14465.4 14495.9 14499.4 14522.6 13735.9 13760.1 13792.9 13803.9 13876.8 666.0 792.7 823.0 825.2 826.5 815.4 816.7 821.9 823.1 823.6 864.9 865.6 867.1 867.4 871.2 860.2 861.4 866.0 870.3 871.6 633.9 634.0 634.2 635.8 636.1 14355.0 14385.3 14435.9 14465.3 14467.3 13795.2 13840.2 13960.6 14052.5 14242.3 11747.9 11833.6 11896.6 11994.1 12086.2 3924.6 3943.9 3956.4 4022.1 4113.0 54179.0 54905.5 56318.7 56351.2 56902.0 10951.9 11176.3 11268.1 11394.8 11419.8 20493.6 20518.2 20520.5 20545.1 20619.9 8306.0 8375.9 8619.8 8629.7 8641.5 4831.7 4875.8 4913.6 4917.2 4961.7 3265.6 3354.4 3391.5 3393.7 3397.4 572.4 589.5 597.5 598.9 612.0 730.9 733.7 755.1 756.5 783.1 9009.2 9302.7 9393.1 9507.2 9535.8 677.0 725.6 732.5 770.5 782.2 4245.2 4416.9 4435.2 4598.0 4610.5 50911.0 53001.0 60989.7 61143.0 61332.4 47042.3 47378.3 48351.5 51319.7 52663.7 46084.0 46096.0 47838.5 48417.3 49268.3 8909.6 8979.3 9022.1 9584.3 9673.0 31236.2 32402.7 32828.2 32855.3 32932.5 39058.8 40277.2 43698.8 43977.6 44077.3 12439.7 12482.5 12819.3 12855.5 12893.9 13802.9 13881.4 14015.1 14099.7 14251.0 13154.9 13272.7 13678.2 13753.3 13915.4 13194.5 13346.9 13542.7 13665.0 13772.2 12042.6 13158.6 13334.4 13370.1 13388.8 9999.5 10003.0 10027.2 10050.9 10206.4 10246.9 10760.8 10880.8 10959.7 10986.4 01:24:13 INFO - PROCESS | 5546 | -------- Summary: end -------- 01:24:13 INFO - PROCESS | 5546 | 01:24:14 INFO - TEST-INFO | 5546: exit 0 01:24:14 INFO - TEST-OK | dromaeo_css | took 1108730ms 01:24:14 INFO - TEST-START | kraken 01:24:14 INFO - operating with platform_type : linux_ 01:24:14 INFO - Initialising browser for kraken test... 01:24:14 INFO - TEST-INFO | started process 5782 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6qm9br/profile http://localhost:58259/getInfo.html) 01:24:18 INFO - PROCESS | 5782 | 01:24:18 INFO - PROCESS | 5782 | (process:5848): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:24:19 INFO - PROCESS | 5782 | __metrics Screen width/height:1600/1200 01:24:19 INFO - PROCESS | 5782 | colorDepth:24 01:24:19 INFO - PROCESS | 5782 | Browser inner width/height: 1024/697 01:24:19 INFO - PROCESS | 5782 | __metrics 01:24:19 ERROR - PROCESS | 5782 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 01:24:20 INFO - TEST-INFO | 5782: exit 0 01:24:20 INFO - Browser initialized. 01:24:20 INFO - Running cycle 1/1 for kraken test... 01:24:20 INFO - TEST-INFO | started process 5899 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6qm9br/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:24:22 INFO - PROCESS | 5899 | 01:24:22 INFO - PROCESS | 5899 | (process:5960): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:24:32 INFO - PROCESS | 5899 | RSS: Main: 163717120 01:24:32 INFO - PROCESS | 5899 | 01:24:35 INFO - PROCESS | 5899 | Cycle 1(1): loaded http://localhost:58259/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58259/tests/kraken/driver.html?testName=audio-beat-detection) 01:24:35 INFO - PROCESS | 5899 | RSS: Main: 167968768 01:24:35 INFO - PROCESS | 5899 | 01:24:38 INFO - PROCESS | 5899 | Cycle 1(1): loaded http://localhost:58259/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58259/tests/kraken/driver.html?testName=audio-dft) 01:24:39 INFO - PROCESS | 5899 | RSS: Main: 172019712 01:24:39 INFO - PROCESS | 5899 | 01:24:42 INFO - PROCESS | 5899 | Cycle 1(1): loaded http://localhost:58259/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58259/tests/kraken/driver.html?testName=audio-fft) 01:24:42 INFO - PROCESS | 5899 | RSS: Main: 163102720 01:24:42 INFO - PROCESS | 5899 | 01:24:44 INFO - PROCESS | 5899 | Cycle 1(1): loaded http://localhost:58259/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58259/tests/kraken/driver.html?testName=audio-oscillator) 01:24:45 INFO - PROCESS | 5899 | RSS: Main: 162779136 01:24:45 INFO - PROCESS | 5899 | 01:24:47 INFO - PROCESS | 5899 | Cycle 1(1): loaded http://localhost:58259/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58259/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:24:48 INFO - PROCESS | 5899 | RSS: Main: 163086336 01:24:48 INFO - PROCESS | 5899 | 01:24:51 INFO - PROCESS | 5899 | Cycle 1(1): loaded http://localhost:58259/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58259/tests/kraken/driver.html?testName=imaging-darkroom) 01:24:52 INFO - PROCESS | 5899 | RSS: Main: 163561472 01:24:52 INFO - PROCESS | 5899 | 01:24:55 INFO - PROCESS | 5899 | Cycle 1(1): loaded http://localhost:58259/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58259/tests/kraken/driver.html?testName=imaging-desaturate) 01:24:56 INFO - PROCESS | 5899 | RSS: Main: 163880960 01:24:56 INFO - PROCESS | 5899 | 01:24:59 INFO - PROCESS | 5899 | Cycle 1(1): loaded http://localhost:58259/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58259/tests/kraken/driver.html?testName=json-parse-financial) 01:24:59 INFO - PROCESS | 5899 | RSS: Main: 164659200 01:24:59 INFO - PROCESS | 5899 | 01:25:01 INFO - PROCESS | 5899 | Cycle 1(1): loaded http://localhost:58259/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58259/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:25:01 INFO - PROCESS | 5899 | RSS: Main: 164675584 01:25:01 INFO - PROCESS | 5899 | 01:25:03 INFO - PROCESS | 5899 | Cycle 1(1): loaded http://localhost:58259/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58259/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:25:04 INFO - PROCESS | 5899 | RSS: Main: 165093376 01:25:04 INFO - PROCESS | 5899 | 01:25:06 INFO - PROCESS | 5899 | Cycle 1(1): loaded http://localhost:58259/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58259/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:25:07 INFO - PROCESS | 5899 | RSS: Main: 164954112 01:25:07 INFO - PROCESS | 5899 | 01:25:09 INFO - PROCESS | 5899 | Cycle 1(1): loaded http://localhost:58259/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58259/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:25:10 INFO - PROCESS | 5899 | RSS: Main: 166068224 01:25:10 INFO - PROCESS | 5899 | 01:25:13 INFO - PROCESS | 5899 | Cycle 1(1): loaded http://localhost:58259/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58259/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:25:13 INFO - PROCESS | 5899 | RSS: Main: 165687296 01:25:13 INFO - PROCESS | 5899 | 01:25:15 INFO - PROCESS | 5899 | Cycle 1(1): loaded http://localhost:58259/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58259/tests/kraken/driver.html?testName=ai-astar) 01:25:15 INFO - PROCESS | 5899 | RSS: Main: 167542784 01:25:15 INFO - PROCESS | 5899 | 01:25:15 INFO - PROCESS | 5899 | __start_tp_report 01:25:15 INFO - PROCESS | 5899 | _x_x_mozilla_page_load 01:25:15 INFO - PROCESS | 5899 | _x_x_mozilla_page_load_details 01:25:15 INFO - PROCESS | 5899 | |i|pagename|runs| 01:25:15 INFO - PROCESS | 5899 | |0;ai-astar;112;108;112;112;111;122;113;113;112;112 01:25:15 INFO - PROCESS | 5899 | |1;audio-beat-detection;153;128;157;183;137;156;157;129;187;130 01:25:15 INFO - PROCESS | 5899 | |2;audio-dft;162;161;162;162;162;165;167;162;166;163 01:25:15 INFO - PROCESS | 5899 | |3;audio-fft;73;75;73;148;76;76;76;77;100;77 01:25:15 INFO - PROCESS | 5899 | |4;audio-oscillator;93;94;146;93;94;94;162;93;93;138 01:25:15 INFO - PROCESS | 5899 | |5;imaging-gaussian-blur;117;119;117;118;118;118;120;118;118;118 01:25:15 INFO - PROCESS | 5899 | |6;imaging-darkroom;146;146;145;147;146;146;146;147;145;146 01:25:15 INFO - PROCESS | 5899 | |7;imaging-desaturate;96;95;95;95;95;95;95;94;95;95 01:25:15 INFO - PROCESS | 5899 | |8;json-parse-financial;59;61;64;56;61;58;58;78;64;58 01:25:15 INFO - PROCESS | 5899 | |9;json-stringify-tinderbox;61;60;60;61;61;60;66;60;61;61 01:25:15 INFO - PROCESS | 5899 | |10;stanford-crypto-aes;83;76;75;76;79;78;77;77;77;78 01:25:15 INFO - PROCESS | 5899 | |11;stanford-crypto-ccm;135;131;127;124;127;124;129;130;168;125 01:25:15 INFO - PROCESS | 5899 | |12;stanford-crypto-pbkdf2;168;165;165;171;165;165;168;165;164;172 01:25:15 INFO - PROCESS | 5899 | |13;stanford-crypto-sha256-iterative;68;69;75;72;69;69;67;66;67;67 01:25:15 INFO - PROCESS | 5899 | __end_tp_report 01:25:15 INFO - PROCESS | 5899 | __start_cc_report 01:25:15 INFO - PROCESS | 5899 | _x_x_mozilla_cycle_collect,832 01:25:15 INFO - PROCESS | 5899 | __end_cc_report 01:25:15 INFO - PROCESS | 5899 | __startTimestamp1461054315612__endTimestamp 01:25:15 INFO - PROCESS | 5899 | 01:25:15 INFO - PROCESS | 5899 | ------- Summary: start ------- 01:25:15 INFO - PROCESS | 5899 | Number of tests: 14 01:25:15 INFO - PROCESS | 5899 | 01:25:15 INFO - PROCESS | 5899 | [#0] ai-astar Cycles:10 Average:112.70 Median:112.00 stddev:3.56 (3.2%) stddev-sans-first:3.77 01:25:15 INFO - PROCESS | 5899 | Values: 112.0 108.0 112.0 112.0 111.0 122.0 113.0 113.0 112.0 112.0 01:25:15 INFO - PROCESS | 5899 | 01:25:15 INFO - PROCESS | 5899 | [#1] audio-beat-detection Cycles:10 Average:151.70 Median:156.50 stddev:21.26 (13.6%) stddev-sans-first:22.54 01:25:15 INFO - PROCESS | 5899 | Values: 153.0 128.0 157.0 183.0 137.0 156.0 157.0 129.0 187.0 130.0 01:25:15 INFO - PROCESS | 5899 | 01:25:15 INFO - PROCESS | 5899 | [#2] audio-dft Cycles:10 Average:163.20 Median:162.50 stddev:2.04 (1.3%) stddev-sans-first:2.12 01:25:15 INFO - PROCESS | 5899 | Values: 162.0 161.0 162.0 162.0 162.0 165.0 167.0 162.0 166.0 163.0 01:25:15 INFO - PROCESS | 5899 | 01:25:15 INFO - PROCESS | 5899 | [#3] audio-fft Cycles:10 Average:85.10 Median:76.00 stddev:23.46 (30.9%) stddev-sans-first:24.47 01:25:15 INFO - PROCESS | 5899 | Values: 73.0 75.0 73.0 148.0 76.0 76.0 76.0 77.0 100.0 77.0 01:25:15 INFO - PROCESS | 5899 | 01:25:15 INFO - PROCESS | 5899 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:93.00 stddev:27.30 (29.4%) stddev-sans-first:28.26 01:25:15 INFO - PROCESS | 5899 | Values: 93.0 94.0 146.0 93.0 94.0 94.0 162.0 93.0 93.0 138.0 01:25:15 INFO - PROCESS | 5899 | 01:25:15 INFO - PROCESS | 5899 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.88 (0.7%) stddev-sans-first:0.83 01:25:15 INFO - PROCESS | 5899 | Values: 117.0 119.0 117.0 118.0 118.0 118.0 120.0 118.0 118.0 118.0 01:25:15 INFO - PROCESS | 5899 | 01:25:15 INFO - PROCESS | 5899 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 01:25:15 INFO - PROCESS | 5899 | Values: 146.0 146.0 145.0 147.0 146.0 146.0 146.0 147.0 145.0 146.0 01:25:15 INFO - PROCESS | 5899 | 01:25:15 INFO - PROCESS | 5899 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 01:25:15 INFO - PROCESS | 5899 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 01:25:15 INFO - PROCESS | 5899 | 01:25:15 INFO - PROCESS | 5899 | [#8] json-parse-financial Cycles:10 Average:61.70 Median:61.00 stddev:6.31 (10.3%) stddev-sans-first:6.61 01:25:15 INFO - PROCESS | 5899 | Values: 59.0 61.0 64.0 56.0 61.0 58.0 58.0 78.0 64.0 58.0 01:25:15 INFO - PROCESS | 5899 | 01:25:15 INFO - PROCESS | 5899 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:1.79 (2.9%) stddev-sans-first:1.90 01:25:15 INFO - PROCESS | 5899 | Values: 61.0 60.0 60.0 61.0 61.0 60.0 66.0 60.0 61.0 61.0 01:25:15 INFO - PROCESS | 5899 | 01:25:15 INFO - PROCESS | 5899 | [#10] stanford-crypto-aes Cycles:10 Average:77.60 Median:77.50 stddev:2.22 (2.9%) stddev-sans-first:1.22 01:25:15 INFO - PROCESS | 5899 | Values: 83.0 76.0 75.0 76.0 79.0 78.0 77.0 77.0 77.0 78.0 01:25:15 INFO - PROCESS | 5899 | 01:25:15 INFO - PROCESS | 5899 | [#11] stanford-crypto-ccm Cycles:10 Average:132.00 Median:129.50 stddev:13.11 (10.1%) stddev-sans-first:13.86 01:25:15 INFO - PROCESS | 5899 | Values: 135.0 131.0 127.0 124.0 127.0 124.0 129.0 130.0 168.0 125.0 01:25:15 INFO - PROCESS | 5899 | 01:25:15 INFO - PROCESS | 5899 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.80 Median:166.50 stddev:2.82 (1.7%) stddev-sans-first:2.96 01:25:15 INFO - PROCESS | 5899 | Values: 168.0 165.0 165.0 171.0 165.0 165.0 168.0 165.0 164.0 172.0 01:25:15 INFO - PROCESS | 5899 | 01:25:15 INFO - PROCESS | 5899 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:2.73 (4.0%) stddev-sans-first:2.87 01:25:15 INFO - PROCESS | 5899 | Values: 68.0 69.0 75.0 72.0 69.0 69.0 67.0 66.0 67.0 67.0 01:25:15 INFO - PROCESS | 5899 | -------- Summary: end -------- 01:25:15 INFO - PROCESS | 5899 | 01:25:16 INFO - TEST-INFO | 5899: exit 0 01:25:16 INFO - TEST-OK | kraken | took 61977ms 01:25:16 INFO - SUITE-END | took 1170s 01:25:16 INFO - Completed test suite (00:19:30) 01:25:16 INFO - javascript benchmark 01:25:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3096.6748491408407, 3209.1014515935544, 3220.0339898030584, 3236.417444859924, 3243.69184927432, 5293.497117773815, 5345.652532585379, 5349.679019258842, 5362.919556206651, 5411.810586629469, 5159.690418574879, 5284.867878303045, 5387.138057910735, 5396.811111611094, 5416.07926652469, 4846.442659094214, 4884.19410797218, 4931.235658472942, 4966.5778408835295, 4985.052839960414, 850.3016500474263, 4817.253325734517, 4845.709257444547, 4850.854474365757, 4882.2432522959, 4819.108464933981, 4822.963062941467, 4824.372831531913, 4846.41842978843, 4847.51524847516, 4834.927476087862, 4839.370881785346, 4859.0, 4863.489333619955, 4890.535399137077, 4813.205821039524, 4841.394825646794, 4846.806127754886, 4879.292502587141, 4896.2410826321975, 5122.718250496221, 5155.226715992593, 5168.664036837631, 5169.896602067937, 5187.0, 5551.195076713894, 5634.492895639371, 5635.09838425854, 5641.323041235037, 5655.236543066674, 5692.459216374438, 5742.368339482696, 5767.855803604902, 5784.363719990798, 5813.709314534256, 5402.432744561804, 5429.484199001088, 5431.8098866539485, 5432.239486471897, 5436.6194366393975, 5748.993926062923, 5785.421457854265, 5855.443732845373, 5861.0, 5866.7653293868625, 5670.914936275959, 5677.716114194273, 5691.288588926384, 5694.5159661428415, 5724.742386592613, 5762.222100016528, 5769.711514424346, 5771.076627739541, 5777.988851950891, 5779.711014449261, 5530.391656917735, 5692.544596432275, 5729.656220626775, 5756.510696590753, 5765.077587585966, 5538.335399752055, 5547.417521160301, 5554.805581804618, 5563.610547261653, 5621.18492818539, 4224.9155016899485, 4260.2970509866145, 4260.382244574519, 4260.692747873375, 4288.142371525707, 3826.559945606291, 3828.5214348206473, 3855.0747820522874, 3892.4355968384425, 3918.3338832398563, 5302.416734159239, 5475.753591088411, 5532.170174473861, 5532.972335138379, 5555.999920014356, 5693.0891057431445, 5695.03184458643, 5717.028105222123, 5720.713964301852, 5726.312842458931, 5281.471852814765, 5422.701751403711, 5430.484104010192, 5476.12382018883, 5569.554435645138, 4753.9762301188275, 4810.11012962603, 4815.590674792612, 4838.03239352131, 4877.6829506081995, 5984.910226346608, 6003.249593800775, 6016.037434010537, 6018.368071352533, 6018.909716354258, 5664.631798932974, 5722.885542289214, 5797.36229014808, 5804.361520232856, 5826.0, 5792.333881603669, 5810.76756929735, 5815.563832712479, 5821.27234095738, 5836.387179346278, 5537.0, 5537.446255374431, 5554.972225138848, 5562.276904002454, 5564.805231816867, 5597.0, 5764.279465066867, 5805.245318108618, 5828.825135245949, 5832.096025116114, 5442.727863606725, 5448.318960129984, 5486.588505862156, 5490.121580547093, 5495.477929596682, 5433.5924805640525, 5461.1262198048125, 5484.287042684426, 5486.945130548644, 5539.25220095282, 5595.160725891149, 5607.663540187602, 5624.381318055092, 5639.436056394327, 5668.348139963792, 5512.6968016759465, 5526.696031718294, 5551.583631227593, 5561.249231353715, 5580.637258578179, 5456.0451920914475, 5471.644343117685, 5473.042217611823, 5483.4516548344845, 5518.530924871431], "value": 5228.602289647994, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [606.2997238189889, 636.621210379824, 646.7994921574312, 657.4641667041361, 676.9390754832065, 35020.12449688759, 36074.639253607456, 36276.0, 36363.272734545295, 36403.27193456129, 36174.81912590433, 36810.63189368106, 37035.629643703556, 37060.07349816256, 37138.257234855286, 8347.123552027026, 8597.914020859806, 8625.698100566482, 8629.266512346458, 8633.827323453526, 8536.658533658647, 8613.784655383633, 8634.913650863473, 8636.913630863673, 8641.65433382664, 8525.701600443987, 8605.31157507398, 8610.612522436506, 8668.04651488339, 8717.041125476193, 8589.742307730778, 8669.089745576719, 8669.696560620348, 8670.566471676422, 8689.478631282143, 8437.704680336221, 8496.787580310542, 8532.23209911111, 8553.615087321023, 8565.571721413904, 32771.0, 37619.62380376188, 37909.81045094784, 37967.0, 38162.618373816185, 3319.317118107644, 3424.4863270509372, 3788.6211378862167, 4100.159467309224, 4343.261645520269, 28314.575281370795, 29571.852140739375, 29783.25541861449, 30006.299433051132, 30352.84823575868, 4117.07365842686, 4228.513720922072, 4238.745675259494, 4239.894002649928, 4285.57144285572, 255516.0, 258538.0, 260126.69936650386, 261433.0, 261906.0, 34237.486437703454, 55413.168802468, 57293.713531432906, 57311.71344143253, 57326.14010789841, 33330.83334583312, 33472.49791253133, 33562.66437335644, 33569.83215083909, 33750.324993500486, 13147.211167329991, 13465.259410732504, 13527.188368697909, 13547.119437236548, 13630.1140425872, 10701.0, 10715.464226788785, 10779.461026948778, 10805.351678899291, 10815.621453249098, 8280.337572994145, 8334.874976875351, 8358.122397148334, 8387.203215694499, 8418.663253469915, 3265.2979609384097, 3269.4278501262183, 3271.9509207361907, 3309.520119582647, 3344.8662053517587, 1067.2049323254225, 1127.1996882213557, 1147.0766033343073, 1151.7984352738238, 1183.0653783511102, 30602.38795224083, 30868.53697194544, 31308.53037204444, 31361.0, 31828.840855795574, 1199.3403628004562, 1220.0056953582803, 1240.4356018011783, 1244.1601918705019, 1289.2973329535425, 16376.426825061304, 16573.751393729104, 16578.419755308507, 16676.0, 16819.15904204785, 438548.0, 442699.0, 444142.0, 446424.0, 447403.0, 54638.45361546334, 55375.723121384945, 55557.0, 55628.72185639046, 55704.72147639317, 1373.9175649460865, 1387.840398354202, 1399.986000140006, 1427.1223197733111, 1430.7782293744485, 30545.08364749061, 30732.385352293277, 31179.532307015867, 31381.21546961253, 31392.843035784674, 46578.0, 47180.52819471761, 47190.76404617955, 47207.763961179975, 47283.05433891372, 378615.0, 381354.0, 382880.0, 383116.0, 383947.0, 27177.505237212143, 42086.36870447007, 43287.63289032348, 43543.782281088395, 44219.346839189755, 43903.34144987891, 44451.26722063197, 44593.0, 44769.32846007247, 45618.543814562756, 38330.53059146908, 38462.42306365463, 39356.409653855786, 39488.40767388549, 39746.80126599348, 38048.619513805614, 42317.0, 43825.56174438215, 44034.55965440305, 44096.0, 39903.40144897771, 40182.59817401788, 40265.0, 40456.59543404646, 40568.594314056485, 32691.673083268863, 34189.06825715075, 34650.48024279688, 34847.12882177966, 34925.65074349326, 27286.0, 27633.723662763114, 27877.58183627288, 27960.44079118447, 28177.43645127127], "value": 18140.247541454122, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.5308723357505, 390.2779857264061, 393.9606039396061, 395.55697618667097, 408.68122864165963, 14210.218437985906, 14549.927250363733, 17330.306787728492, 17999.370022049214, 18123.275068997256, 10713.142948564117, 11230.382328971904, 17755.55611109723, 18206.271749130017, 18226.908865455654, 4869.172240719068, 5022.673526220802, 5025.120603894322, 5033.496650334974, 5035.144025515671, 4897.436794768594, 4981.501849815026, 4984.75076246188, 5038.949610503903, 5044.848654540369, 4955.033768415161, 4975.2039673652225, 5007.32401125847, 5018.949810501885, 5036.143855544567, 5025.497450254982, 5036.2193859951585, 5160.741962901859, 5640.379558248589, 5649.293838270216, 5067.619928505377, 5071.56891664209, 5074.543291103819, 5095.566876815476, 5117.48825117489, 12387.75224495505, 20347.389578312675, 21987.120515179373, 22261.888690556443, 22327.218547350763, 2271.5911135995516, 2341.613633750429, 2350.6944097267246, 2383.547126046063, 2421.6004359280696, 9549.61801527938, 9575.61697532098, 9623.230141588656, 9712.61149554017, 9883.357581757235, 1941.1264930781206, 1993.8504612154002, 1997.4806550296883, 2027.4221846773598, 2042.2545770793702, 73854.26145738528, 77526.22473775303, 79313.0, 79396.0, 80338.59830700808, 8336.666533338599, 8954.462732236087, 9085.909140908507, 9375.249980001583, 9482.810343793086, 12978.0, 13023.609291721263, 13026.47894084245, 13030.413631386611, 13066.085374023916, 7109.751158709524, 7366.042414486083, 7384.889226661604, 7386.815329616803, 7432.256774322633, 7117.893231601426, 7142.750003749844, 7208.891866622005, 7219.205887352387, 7264.927350726531, 3874.089588946595, 3913.8434462621744, 3964.980175099106, 4005.7396269242404, 4090.079732060263, 1942.9805701943083, 1946.240966023252, 1979.3369221311023, 1980.4156674660214, 2019.4951262184454, 1015.3907655406697, 1039.5581877702098, 1109.1902910875106, 1118.8769235384102, 1142.5886680794906, 18348.266069357076, 18651.720224196648, 18910.810891890906, 19141.61716765657, 19207.231710731416, 1017.0998666180336, 1082.2802836114054, 1090.2749671468384, 1108.351614305624, 1112.2881355932209, 10232.386056836465, 10596.788064238672, 10728.892711072946, 10934.945325273322, 10961.780764384668, 497651.0, 520947.0, 524982.0, 529340.0, 534706.0, 88447.55776221078, 88526.55736721405, 88544.5572772145, 88549.0, 89366.0, 994.1450352696675, 1021.8824835144054, 1029.2897900448665, 1029.8609687692065, 1034.2036631793628, 16359.427420040241, 16786.58033549171, 17002.31990720407, 17063.573410664336, 17222.483325500256, 36236.27527449489, 37788.24423511569, 38057.42913856239, 38831.41752873653, 39545.20909581735, 51173.744131279105, 51375.0, 51817.0, 54346.45653543414, 54463.72768136134, 7944.880826787487, 8096.959515202387, 8162.265396114378, 8212.384071194565, 8399.70601028961, 12002.21985570935, 13311.600651980456, 13346.666333341744, 13397.397117129947, 13526.120802147829, 11728.472218750007, 11789.469473873867, 11811.645650630495, 11826.0, 12082.45628946682, 11486.655400338002, 11554.711132221426, 11790.469428875549, 11840.881591184323, 11923.403829808649, 11639.6508104757, 11836.112291578338, 11954.880451195377, 12038.939805301268, 12402.75194496123, 8066.9109670193775, 8158.224968627971, 8274.462159959825, 8340.582970851554, 8397.37019723511, 11115.388653624128, 12024.879751202376, 12076.637700868989, 12155.149139560146, 12372.505099795908], "value": 8733.291565961787, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1511.5163147792707, 1526.2292542266157, 1684.6462242928985, 1768.0452555619966, 1777.893326400416, 7489.28851759082, 7930.444868859182, 8104.756857294291, 8221.588920553972, 8222.671093156274, 8179.713710020151, 8181.959090204556, 8225.054118776343, 8226.136255693156, 8228.177182281768, 2247.2584047264445, 2258.141906075697, 2271.2958982715413, 2275.1468199425217, 2278.453171238907, 2221.944451388712, 2260.2993072147688, 2281.0, 2286.85135466195, 2287.1308902616984, 2279.806216471602, 2299.8275129365366, 2309.3302942146756, 2332.3119679694532, 2333.7899589036983, 2223.5997520446313, 2230.7546169921297, 2232.0513781642817, 2233.6091184042807, 2235.776422357751, 2147.5060736030646, 2170.2621108823078, 2171.8262538997, 2174.5868285025795, 2176.4885251965775, 8294.129116442748, 8295.087540370614, 8330.70842520515, 8356.415050946376, 8369.079401265855, 4955.776990035457, 5084.7457627118865, 5095.949040509585, 5127.333446651949, 5140.691558506464, 3170.7621928355466, 3281.2945216778267, 3286.3920174767745, 3352.2960178362573, 3384.170878134848, 1089.411717672456, 1097.1332647208696, 1103.5475455063386, 1104.5913012185463, 1114.2645853736494, 11272.09823214149, 11282.943585282103, 11291.53210082684, 11299.0, 11368.204225704205, 4213.87358379243, 4338.175746608134, 4380.62764665007, 4546.931796023062, 4548.931766023512, 9495.620175192915, 9498.382605130644, 9551.856722149174, 9570.56932438042, 9576.521173941275, 4998.725070121105, 5005.374328208974, 5009.824656137091, 5014.197728363517, 5021.974890125526, 4116.115035267432, 4483.103379324083, 4605.562471565196, 4629.745364004944, 4640.744759038218, 3813.7139714521522, 3838.9040273992814, 3843.327417701891, 3877.6897848172644, 3906.5312162540677, 1233.481937586216, 1240.34881687115, 1243.608263397027, 1248.9875101248872, 1278.5461161287794, 944.447498213539, 1026.5996261458038, 1034.9534270957824, 1037.7561273100816, 1056.1867362131115, 6028.788992385334, 6098.664573448503, 6101.267847858286, 6103.38966103395, 6297.307296197415, 980.0836218136066, 983.6311383231289, 996.5067291690659, 1030.1912998296302, 1037.8391349340864, 4036.858709945138, 4141.689373297015, 4215.747055176699, 4221.240176768211, 4241.27898257297, 9786.510674466248, 10122.848157277647, 10132.24008199388, 10217.795644087077, 10262.589496420209, 10176.694699159038, 10228.59085636581, 10238.33450825694, 10253.07722304996, 10277.126444252173, 7523.774286771406, 7752.0697516298405, 7841.607919604111, 7989.600519973978, 7996.000499937508, 5783.710814459176, 5849.1226316052935, 5849.356570777126, 5909.6158749681135, 5919.85200369977, 9006.0, 9115.772105697411, 9333.206677432494, 9347.626094956398, 9399.577019034297, 9324.347295689236, 9438.244940404615, 9501.049895010443, 9582.185514231369, 9618.0, 6885.242623311332, 7222.349988501061, 7507.174210836913, 7517.661705223388, 7626.771196864103, 7989.440739148204, 8031.317338026333, 8054.355651547745, 8075.273225409741, 8092.757217283491, 7047.682854271673, 7302.123745150616, 7385.0, 7387.076615423072, 7433.776986690408, 7139.571625702474, 7145.642717863982, 7170.318819712119, 7180.856382872418, 7200.603966781878, 6819.624920629413, 6878.965605171942, 6899.827504312432, 6925.965370173117, 6937.7224911002995, 4878.219484882544, 5055.545000949932, 5061.620378471703, 5096.949030509796, 5115.769790359368, 4902.166631672696, 4993.950060499348, 4999.900002000012, 5010.649254552146, 5094.15946368845], "value": 4484.910385892473, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.6666233779208, 332.52947079881966, 338.2389623347469, 338.4669146094901, 340.3176630855135, 5856.941430585698, 5994.940050599498, 6055.333913269542, 6102.481289090421, 6126.7549298028025, 5945.937842011368, 5985.8204253872345, 6000.249968753906, 6033.09503574463, 6038.426349496802, 4522.299043648231, 4524.253498172798, 4534.727916325014, 4539.54604539545, 4543.1140927519145, 4323.589259020404, 4501.279795232764, 4511.59395654391, 4514.4582650081875, 4519.932201016971, 4437.6671749618745, 4467.932981005288, 4476.970296831731, 4477.149341625097, 4499.865004049884, 4452.977735111303, 4457.219986502365, 4472.329150627399, 4474.507804141542, 4491.169133710274, 3816.923661526754, 3825.8278377472802, 3826.6556009959236, 3830.176512049895, 3832.559255685604, 5645.01212287848, 5659.405762394971, 5700.287464066992, 5727.656340619535, 5733.197352370671, 5086.135356989321, 5118.7696553654805, 5137.871553211162, 5139.74301284938, 5148.176291793295, 6032.366601506867, 6213.533984951102, 6229.09678096678, 6244.157038799749, 6283.6858157091965, 4305.98809279819, 4308.9569104309185, 4316.740995540277, 4323.048929235563, 4334.783260836945, 5941.979726892877, 6488.772892948724, 6507.414332710079, 6557.180352455943, 6563.916953702634, 4356.716813407118, 4409.140217657526, 4427.623651989553, 4429.933550996738, 4441.089576636782, 4466.531014243457, 4474.082813023388, 4485.708428952108, 4485.887852803706, 4508.1659892919915, 4923.138450771101, 5163.870903227449, 5211.42674305826, 5221.556167725786, 5229.163333866563, 6260.342664020212, 6343.333949935282, 6356.45970092538, 6372.171617689671, 6384.138141350858, 1541.0907564536976, 1554.3782487005287, 1560.7502799552017, 1568.3099436248015, 1571.9449819256272, 1018.6383833739064, 1023.7287118913493, 1031.3554028732042, 1037.6990672704983, 1038.8649475568127, 6085.1785009023215, 6114.74647697221, 6146.200993870768, 6151.692415379213, 6162.568620196544, 6471.0, 6476.708548115252, 6488.383603557654, 6501.44737697301, 6514.54398192122, 5954.612950158225, 6079.385864078488, 6132.202813634288, 6139.96930015356, 6167.506599472032, 3452.0, 3465.7227421806197, 3496.667816557423, 3500.1074725944723, 3506.8071256080652, 6418.74325027003, 6686.899696504556, 6702.698378572976, 6702.731890724316, 6749.763758268437, 6585.6707164641575, 6596.10952521413, 6613.503987200979, 6643.335666433415, 6664.466842652576, 6529.780252560425, 6657.900131498031, 6701.5979041256705, 6760.459163267025, 6775.661216939134, 6444.420002199825, 6462.483001359974, 6462.806115816533, 6464.773732919325, 6498.610083395011, 6285.994240921431, 6420.711068001858, 6425.678716064272, 6438.452731517874, 6453.612783233021, 6728.125343705287, 6734.764283250062, 6747.561408508432, 6754.324567543206, 6772.796816095525, 4446.844360447369, 4448.733076015449, 4455.1757924784015, 4457.665675074318, 4459.933101003423, 6315.3053164152825, 6534.137770735508, 6554.967225163844, 6555.606663600009, 6569.441597464269, 6292.402221788922, 6306.747730090745, 6313.494920406449, 6317.115603815378, 6322.620642761449, 6158.4261579299555, 6179.783707570214, 6303.779367722291, 6304.275008373912, 6324.683765811599, 6143.938560614337, 6147.784827531015, 6172.783952561639, 6195.81412557624, 6209.875802484015, 6149.963339634551, 6328.588641738456, 6348.269948955929, 6354.586951848115, 6392.328805475544, 6141.26713612456, 6143.508519318354, 6151.754609567565, 6173.56785025044, 6189.25550042236], "value": 4723.043002610746, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [669.6383952665558, 696.3663066609383, 816.1878930464189, 857.7512521368803, 869.2133619074738, 14117.152970821759, 14465.421383144689, 14495.85504144961, 14499.42002319906, 14522.636934076654, 13735.931320343409, 13760.105593136439, 13792.862071379282, 13803.930980345109, 13876.791848122286, 665.9533832631705, 792.6551949901782, 822.9876551851727, 825.2407784837964, 826.450410477032, 815.4047545291941, 816.6896579299857, 821.8849361089452, 823.1110400767157, 823.6046697585133, 864.8832407624984, 865.6277800545763, 867.0635713429481, 867.4361664917823, 871.2246100970142, 860.2000139869949, 861.4314552395421, 866.0343716755804, 870.334194341323, 871.5598622695561, 633.8732253549308, 633.9873202535923, 634.2325785799188, 635.828326351887, 636.1253276744476, 14355.0, 14385.28073596316, 14435.855641443557, 14465.349059292252, 14467.348969296407, 13795.2412617306, 13840.238786866717, 13960.581182564438, 14052.508162214375, 14242.287885605678, 11747.94126029373, 11833.644990650295, 11896.643100706993, 11994.10044246685, 12086.214396064228, 3924.607539246081, 3943.9014024649614, 3956.4065390191413, 4022.1151346703973, 4113.0, 54179.0, 54905.45094549043, 56318.71840640771, 56351.154732679046, 56901.999999999585, 10951.890481095246, 11176.27354221973, 11268.09855211581, 11394.772104557862, 11419.828702569468, 20493.59012819765, 20518.179272829217, 20520.486987825425, 20545.075471603814, 20619.896900515403, 8305.95847020761, 8375.874361884577, 8619.78450538729, 8629.654813807503, 8641.524716140548, 4831.661783675179, 4875.756212189376, 4913.631477639191, 4917.213245880642, 4961.677490963076, 3265.6244531878665, 3354.362671092533, 3391.5251864738957, 3393.745469089779, 3397.3545026444895, 572.4161355417451, 589.5283772981597, 597.5100417657479, 598.9371116032754, 611.9724612392453, 730.8830587106038, 733.7175187552831, 755.1466842467976, 756.4515726098534, 783.0994356490082, 9009.23421509166, 9302.743949668551, 9393.107654772786, 9507.1918886894, 9535.809283814286, 677.0183234310269, 725.6154238253733, 732.5494820685241, 770.4799260499141, 782.1982467970375, 4245.172191422705, 4416.889577760582, 4435.157320109169, 4597.95402045982, 4610.53894610543, 50911.0, 53001.0, 60989.69505152446, 61143.0, 61332.38667613356, 47042.294365584545, 47378.289325660146, 48351.516484834705, 51319.74340128276, 52663.73668131712, 46084.0, 46096.0, 47838.521614784106, 48417.27374089321, 49268.26097608539, 8909.643614255358, 8979.326550508607, 9022.14289642483, 9584.329096963145, 9673.0, 31236.219094522818, 32402.675973239966, 32828.17929551685, 32855.342893141526, 32932.50601240935, 39058.804705977425, 40277.194456110126, 43698.781506092266, 43977.56022439735, 44077.33883991807, 12439.689007774878, 12482.500699972263, 12819.294938778457, 12855.485780569046, 12893.871061289266, 13802.930985345009, 13881.444742210198, 14015.089019213718, 14099.718005640036, 14251.0, 13154.868451315748, 13272.668183295495, 13678.247696376795, 13753.312334383041, 13915.443382265, 13194.472221111431, 13346.933265333999, 13542.661433463849, 13665.0, 13772.173669579857, 12042.578509752117, 13158.60524184276, 13334.39995200199, 13370.06409551322, 13388.799168012682, 9999.500024998575, 10002.972651605116, 10027.247956403446, 10050.899491004997, 10206.387616743019, 10246.948765256126, 10760.784784304427, 10880.836787448035, 10959.671209863716, 10986.395748233605], "value": 6793.27144385222, "unit": "score"}], "name": "dromaeo_css", "value": 7015.359037302592, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 108.0, 112.0, 112.0, 111.0, 122.0, 113.0, 113.0, 112.0, 112.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 128.0, 157.0, 183.0, 137.0, 156.0, 157.0, 129.0, 187.0, 130.0], "value": 151.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 162.0, 162.0, 165.0, 167.0, 162.0, 166.0, 163.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 73.0, 148.0, 76.0, 76.0, 76.0, 77.0, 100.0, 77.0], "value": 85.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 146.0, 93.0, 94.0, 94.0, 162.0, 93.0, 93.0, 138.0], "value": 110.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 117.0, 118.0, 118.0, 118.0, 120.0, 118.0, 118.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 147.0, 146.0, 146.0, 146.0, 147.0, 145.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 64.0, 56.0, 61.0, 58.0, 58.0, 78.0, 64.0, 58.0], "value": 61.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 61.0, 61.0, 60.0, 66.0, 60.0, 61.0, 61.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 76.0, 75.0, 76.0, 79.0, 78.0, 77.0, 77.0, 77.0, 78.0], "value": 77.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 131.0, 127.0, 124.0, 127.0, 124.0, 129.0, 130.0, 168.0, 125.0], "value": 132.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 165.0, 165.0, 171.0, 165.0, 165.0, 168.0, 165.0, 164.0, 172.0], "value": 166.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 75.0, 72.0, 69.0, 69.0, 67.0, 66.0, 67.0, 67.0], "value": 68.9, "unit": "score"}], "name": "kraken", "value": 1549.8999999999999, "alertThreshold": 2.0}]} 01:25:16 INFO - Return code: 0 01:25:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:25:16 ERROR - # TBPL SUCCESS # 01:25:16 INFO - Running post-action listener: _resource_record_post_action 01:25:16 INFO - Running post-run listener: _resource_record_post_run 01:25:18 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 533184512; Read time: 0; Write time: 535992 01:25:18 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244097024; Read time: 0; Write time: 310728 01:25:18 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 288972800; Read time: 0; Write time: 225264 01:25:18 INFO - Running post-run listener: _upload_blobber_files 01:25:18 INFO - Blob upload gear active. 01:25:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:25:18 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 01:25:18 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:25:18 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:25:18 INFO - (blobuploader) - INFO - Open directory for files ... 01:25:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:25:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:25:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:25:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:25:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:25:19 INFO - (blobuploader) - INFO - Done attempting. 01:25:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:25:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:25:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:25:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:25:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:25:20 INFO - (blobuploader) - INFO - Done attempting. 01:25:20 INFO - (blobuploader) - INFO - Iteration through files over. 01:25:20 INFO - Return code: 0 01:25:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:25:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:25:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08ace997994378890d1483a34585d259a7d8dc1c21392b0d7d050baf52c83855cbc50add7a9d86adcc6dd45a7606f0e0c61c8de20df453b2e0960b02ca9fd5ad", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc8d572bedc0f79bac397dd476432e14f9277fdde26d7941f8903d28affab6936224151bef6c73d58b29aa7e8386ba6725f2a6e8fad95ae07e38774a16c8b6cb"} 01:25:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:25:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:25:20 INFO - Contents: 01:25:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08ace997994378890d1483a34585d259a7d8dc1c21392b0d7d050baf52c83855cbc50add7a9d86adcc6dd45a7606f0e0c61c8de20df453b2e0960b02ca9fd5ad", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc8d572bedc0f79bac397dd476432e14f9277fdde26d7941f8903d28affab6936224151bef6c73d58b29aa7e8386ba6725f2a6e8fad95ae07e38774a16c8b6cb"} 01:25:20 INFO - Running post-run listener: copy_logs_to_upload_dir 01:25:20 INFO - Copying logs to upload dir... 01:25:20 INFO - mkdir: /builds/slave/test/build/upload/logs 01:25:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.937796 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-04-19 01:25:19.861000) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 01:25:19.864555) ========= 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=7de08804244eb36560b44971000001c3-1461051372.534030-1475585752 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/Firefox/sha512/08ace997994378890d1483a34585d259a7d8dc1c21392b0d7d050baf52c83855cbc50add7a9d86adcc6dd45a7606f0e0c61c8de20df453b2e0960b02ca9fd5ad", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc8d572bedc0f79bac397dd476432e14f9277fdde26d7941f8903d28affab6936224151bef6c73d58b29aa7e8386ba6725f2a6e8fad95ae07e38774a16c8b6cb"} build_url:https://queue.taskcluster.net/v1/task/ACuFSuGBQiyE13TXCnu2QA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011318 build_url: 'https://queue.taskcluster.net/v1/task/ACuFSuGBQiyE13TXCnu2QA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08ace997994378890d1483a34585d259a7d8dc1c21392b0d7d050baf52c83855cbc50add7a9d86adcc6dd45a7606f0e0c61c8de20df453b2e0960b02ca9fd5ad", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc8d572bedc0f79bac397dd476432e14f9277fdde26d7941f8903d28affab6936224151bef6c73d58b29aa7e8386ba6725f2a6e8fad95ae07e38774a16c8b6cb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 01:25:19.889692) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 01:25:19.890040) ========= 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=7de08804244eb36560b44971000001c3-1461051372.534030-1475585752 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004375 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 01:25:19.975906) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 01:25:19.976256) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 01:25:19.976569) ========= ========= Total master_lag: 0.17 =========