builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-062 starttime: 1462108472.85 results: success (0) buildid: 20160501030217 builduid: d628f44785ef404384c251c21ad92714 revision: 1461a4071341c282afcf7b72e33036412d2251d4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-01 06:14:32.845718) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-01 06:14:32.846229) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-01 06:14:32.846540) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-01 06:14:32.893324) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-01 06:14:32.893640) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1462105510.99143-11269107 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-01 06:14:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 109M=0s 2016-05-01 06:14:34 (109 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125156 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-01 06:14:33.035954) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-01 06:14:33.036351) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1462105510.99143-11269107 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016792 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-01 06:14:33.104476) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-01 06:14:33.104824) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1461a4071341c282afcf7b72e33036412d2251d4 --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 1461a4071341c282afcf7b72e33036412d2251d4 --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=a4ce256d2ec601f24a60a71e000001bc-1462105510.99143-11269107 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-01 06:14:34,237 truncating revision to first 12 chars 2016-05-01 06:14:34,237 Setting DEBUG logging. 2016-05-01 06:14:34,238 attempt 1/10 2016-05-01 06:14:34,238 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1461a4071341?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-01 06:14:35,015 unpacking tar archive at: mozilla-central-1461a4071341/testing/mozharness/ program finished with exit code 0 elapsedTime=1.056499 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-01 06:14:34.179458) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-01 06:14:34.180257) ========= script_repo_revision: 1461a4071341c282afcf7b72e33036412d2251d4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-01 06:14:34.181345) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-01 06:14:34.181733) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-01 06:14:34.195919) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-05-01 06:14:34.196265) ========= /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=a4ce256d2ec601f24a60a71e000001bc-1462105510.99143-11269107 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:14:35 INFO - MultiFileLogger online at 20160501 06:14:35 in /builds/slave/test 06:14:35 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 06:14:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:14:35 INFO - {'append_to_log': False, 06:14:35 INFO - 'base_work_dir': '/builds/slave/test', 06:14:35 INFO - 'blob_upload_branch': 'Firefox', 06:14:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:14:35 INFO - 'branch': 'Firefox', 06:14:35 INFO - 'buildbot_json_path': 'buildprops.json', 06:14:35 INFO - 'config_files': ('talos/linux_config.py',), 06:14:35 INFO - 'default_actions': ('clobber', 06:14:35 INFO - 'read-buildbot-config', 06:14:35 INFO - 'download-and-extract', 06:14:35 INFO - 'populate-webroot', 06:14:35 INFO - 'create-virtualenv', 06:14:35 INFO - 'install', 06:14:35 INFO - 'run-tests'), 06:14:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:14:35 INFO - 'download_minidump_stackwalk': True, 06:14:35 INFO - 'download_symbols': 'ondemand', 06:14:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:14:35 INFO - 'tooltool.py': '/tools/tooltool.py', 06:14:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:14:35 INFO - '/tools/misc-python/virtualenv.py')}, 06:14:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:14:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:14:35 INFO - 'installer_path': 'installer.exe', 06:14:35 INFO - 'log_level': 'info', 06:14:35 INFO - 'log_name': 'talos', 06:14:35 INFO - 'log_to_console': True, 06:14:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:14:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:14:35 INFO - 'opt_config_files': (), 06:14:35 INFO - 'pip_index': False, 06:14:35 INFO - 'sps_profile': False, 06:14:35 INFO - 'sps_profile_interval': 0, 06:14:35 INFO - 'suite': 'dromaeojs-e10s', 06:14:35 INFO - 'system_bits': '32', 06:14:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:14:35 INFO - 'title': 'talos-linux64-ix-062', 06:14:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:14:35 INFO - 'use_talos_json': True, 06:14:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:14:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:14:35 INFO - 'work_dir': 'build'} 06:14:35 INFO - ##### 06:14:35 INFO - ##### Running clobber step. 06:14:35 INFO - ##### 06:14:35 INFO - Running pre-action listener: _resource_record_pre_action 06:14:35 INFO - Running main action method: clobber 06:14:35 INFO - rmtree: /builds/slave/test/build 06:14:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:14:35 INFO - Running post-action listener: _resource_record_post_action 06:14:35 INFO - ##### 06:14:35 INFO - ##### Running read-buildbot-config step. 06:14:35 INFO - ##### 06:14:35 INFO - Running pre-action listener: _resource_record_pre_action 06:14:35 INFO - Running main action method: read_buildbot_config 06:14:35 INFO - Using buildbot properties: 06:14:35 INFO - { 06:14:35 INFO - "project": "", 06:14:35 INFO - "product": "firefox", 06:14:35 INFO - "script_repo_revision": "production", 06:14:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 06:14:35 INFO - "repository": "", 06:14:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 06:14:35 INFO - "buildid": "20160501030217", 06:14:35 INFO - "stage_platform": "linux64-pgo", 06:14:35 INFO - "basedir": "/builds/slave/test", 06:14:35 INFO - "nightly_build": "True", 06:14:35 INFO - "buildnumber": 15, 06:14:35 INFO - "slavename": "talos-linux64-ix-062", 06:14:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:14:35 INFO - "platform": "ubuntu64_hw", 06:14:35 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 06:14:35 INFO - "branch": "mozilla-central", 06:14:35 INFO - "repo_path": "mozilla-central", 06:14:35 INFO - "revision": "1461a4071341c282afcf7b72e33036412d2251d4", 06:14:35 INFO - "pgo_build": "True", 06:14:35 INFO - "builduid": "d628f44785ef404384c251c21ad92714", 06:14:35 INFO - "slavebuilddir": "test" 06:14:35 INFO - } 06:14:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/NCB4KqDvRHmqukG5s9CiXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 06:14:35 INFO - Running post-action listener: _resource_record_post_action 06:14:35 INFO - ##### 06:14:35 INFO - ##### Running download-and-extract step. 06:14:35 INFO - ##### 06:14:35 INFO - Running pre-action listener: _resource_record_pre_action 06:14:35 INFO - Running main action method: download_and_extract 06:14:35 INFO - mkdir: /builds/slave/test/build/tests 06:14:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:35 INFO - https://queue.taskcluster.net/v1/task/NCB4KqDvRHmqukG5s9CiXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:14:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCB4KqDvRHmqukG5s9CiXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:14:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCB4KqDvRHmqukG5s9CiXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:14:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCB4KqDvRHmqukG5s9CiXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:14:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCB4KqDvRHmqukG5s9CiXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:14:39 INFO - Downloaded 1361 bytes. 06:14:39 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:14:39 INFO - Using the following test package requirements: 06:14:39 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:14:39 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:14:39 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:14:39 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:39 INFO - u'jsshell-linux-x86_64.zip'], 06:14:39 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:14:39 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:14:39 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:14:39 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:14:39 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:14:39 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:14:39 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:14:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:39 INFO - https://queue.taskcluster.net/v1/task/NCB4KqDvRHmqukG5s9CiXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:14:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCB4KqDvRHmqukG5s9CiXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:14:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCB4KqDvRHmqukG5s9CiXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:14:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCB4KqDvRHmqukG5s9CiXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:14:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCB4KqDvRHmqukG5s9CiXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:14:41 INFO - Downloaded 23877171 bytes. 06:14:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:14:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:14:42 INFO - Return code: 0 06:14:42 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:42 INFO - https://queue.taskcluster.net/v1/task/NCB4KqDvRHmqukG5s9CiXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:14:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCB4KqDvRHmqukG5s9CiXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:14:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCB4KqDvRHmqukG5s9CiXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:14:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCB4KqDvRHmqukG5s9CiXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:14:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCB4KqDvRHmqukG5s9CiXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:14:47 INFO - Downloaded 23877171 bytes. 06:14:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:14:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:14:48 INFO - Return code: 0 06:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:48 INFO - https://queue.taskcluster.net/v1/task/NCB4KqDvRHmqukG5s9CiXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:14:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCB4KqDvRHmqukG5s9CiXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:14:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCB4KqDvRHmqukG5s9CiXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:14:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCB4KqDvRHmqukG5s9CiXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:14:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCB4KqDvRHmqukG5s9CiXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:14:49 INFO - Downloaded 10840152 bytes. 06:14:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:14:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:14:49 INFO - Return code: 0 06:14:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:49 INFO - https://queue.taskcluster.net/v1/task/NCB4KqDvRHmqukG5s9CiXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:14:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCB4KqDvRHmqukG5s9CiXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:14:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCB4KqDvRHmqukG5s9CiXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:14:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCB4KqDvRHmqukG5s9CiXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:14:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NCB4KqDvRHmqukG5s9CiXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:14:50 INFO - Downloaded 58598383 bytes. 06:14:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NCB4KqDvRHmqukG5s9CiXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:14:50 INFO - mkdir: /builds/slave/test/properties 06:14:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:14:50 INFO - Writing to file /builds/slave/test/properties/build_url 06:14:50 INFO - Contents: 06:14:50 INFO - build_url:https://queue.taskcluster.net/v1/task/NCB4KqDvRHmqukG5s9CiXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:14:51 INFO - Running post-action listener: _resource_record_post_action 06:14:51 INFO - Running post-action listener: set_extra_try_arguments 06:14:51 INFO - ##### 06:14:51 INFO - ##### Running populate-webroot step. 06:14:51 INFO - ##### 06:14:51 INFO - Running pre-action listener: _resource_record_pre_action 06:14:51 INFO - Running main action method: populate_webroot 06:14:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:14:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:14:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:14:51 INFO - '--tppagecycles', 06:14:51 INFO - '7'], 06:14:51 INFO - 'tests': ['tsvgm']}}, 06:14:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:14:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:14:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:14:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:14:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:14:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:14:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:51 INFO - 'talos_options': ['--disable-e10s'], 06:14:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:14:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:14:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:51 INFO - 'talos_options': ['--disable-e10s'], 06:14:51 INFO - 'tests': ['damp', 'tps']}, 06:14:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:51 INFO - 'tests': ['damp', 'tps']}, 06:14:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:14:51 INFO - 'tests': ['dromaeo_dom']}, 06:14:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:14:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:14:51 INFO - 'tests': ['a11yr', 06:14:51 INFO - 'ts_paint', 06:14:51 INFO - 'tpaint', 06:14:51 INFO - 'sessionrestore', 06:14:51 INFO - 'sessionrestore_no_auto_restore', 06:14:51 INFO - 'tabpaint']}, 06:14:51 INFO - 'other-e10s': {'tests': ['a11yr', 06:14:51 INFO - 'ts_paint', 06:14:51 INFO - 'tpaint', 06:14:51 INFO - 'sessionrestore', 06:14:51 INFO - 'sessionrestore_no_auto_restore', 06:14:51 INFO - 'tabpaint']}, 06:14:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:14:51 INFO - 'ts_paint', 06:14:51 INFO - 'tpaint', 06:14:51 INFO - 'sessionrestore', 06:14:51 INFO - 'sessionrestore_no_auto_restore', 06:14:51 INFO - 'tabpaint']}, 06:14:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:14:51 INFO - 'ts_paint', 06:14:51 INFO - 'tpaint', 06:14:51 INFO - 'sessionrestore', 06:14:51 INFO - 'sessionrestore_no_auto_restore', 06:14:51 INFO - 'tabpaint']}, 06:14:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:14:51 INFO - 'tests': ['a11yr', 06:14:51 INFO - 'ts_paint', 06:14:51 INFO - 'tpaint', 06:14:51 INFO - 'sessionrestore', 06:14:51 INFO - 'sessionrestore_no_auto_restore', 06:14:51 INFO - 'tabpaint']}, 06:14:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:14:51 INFO - 'tests': ['a11yr', 06:14:51 INFO - 'ts_paint', 06:14:51 INFO - 'tpaint', 06:14:51 INFO - 'sessionrestore', 06:14:51 INFO - 'sessionrestore_no_auto_restore', 06:14:51 INFO - 'tabpaint']}, 06:14:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:14:51 INFO - 'tests': ['tsvgx', 06:14:51 INFO - 'tsvgr_opacity', 06:14:51 INFO - 'tart', 06:14:51 INFO - 'tscrollx', 06:14:51 INFO - 'cart']}, 06:14:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:14:51 INFO - 'tsvgr_opacity', 06:14:51 INFO - 'tart', 06:14:51 INFO - 'tscrollx', 06:14:51 INFO - 'cart']}, 06:14:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:51 INFO - 'talos_options': ['--disable-e10s'], 06:14:51 INFO - 'tests': ['tp5o']}, 06:14:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:51 INFO - 'tests': ['tp5o']}, 06:14:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:51 INFO - 'talos_options': ['--disable-e10s', 06:14:51 INFO - '--xperf_path', 06:14:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:14:51 INFO - 'tests': ['tp5n']}, 06:14:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:51 INFO - 'talos_options': ['--xperf_path', 06:14:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:14:51 INFO - 'tests': ['tp5n']}}, 06:14:51 INFO - 'talos.zip': {'path': '', 06:14:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:14:51 INFO - Running post-action listener: _resource_record_post_action 06:14:51 INFO - ##### 06:14:51 INFO - ##### Running create-virtualenv step. 06:14:51 INFO - ##### 06:14:51 INFO - Running pre-action listener: _resource_record_pre_action 06:14:51 INFO - Running main action method: create_virtualenv 06:14:51 INFO - Creating virtualenv /builds/slave/test/build/venv 06:14:51 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:14:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:14:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:14:51 INFO - Using real prefix '/usr' 06:14:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:14:52 INFO - Installing distribute.............................................................................................................................................................................................done. 06:14:54 INFO - Installing pip.................done. 06:14:54 INFO - Return code: 0 06:14:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89c1d13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19157d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a4640>, '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 0x19a5540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a59d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1462105510.99143-11269107', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:14:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:14:54 INFO - Using env: {'DISPLAY': ':0', 06:14:54 INFO - 'HOME': '/home/cltbld', 06:14:54 INFO - 'LANG': 'en_US.UTF-8', 06:14:54 INFO - 'LANGUAGE': 'en_US:en', 06:14:54 INFO - 'LOGNAME': 'cltbld', 06:14:54 INFO - 'MAIL': '/var/mail/cltbld', 06:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:54 INFO - 'MOZ_NO_REMOTE': '1', 06:14:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:14:54 INFO - 'NO_EM_RESTART': '1', 06:14:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:54 INFO - 'PWD': '/builds/slave/test', 06:14:54 INFO - 'SHELL': '/bin/bash', 06:14:54 INFO - 'SHLVL': '1', 06:14:54 INFO - 'TERM': 'linux', 06:14:54 INFO - 'TMOUT': '86400', 06:14:54 INFO - 'USER': 'cltbld', 06:14:54 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462105510.99143-11269107', 06:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:54 INFO - '_': '/tools/buildbot/bin/python'} 06:14:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:54 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:14:54 INFO - Cleaning up... 06:14:54 INFO - Return code: 0 06:14:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f89c1d13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19157d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a4640>, '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 0x19a5540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a59d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1462105510.99143-11269107', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:14:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 06:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:14:54 INFO - Using env: {'DISPLAY': ':0', 06:14:54 INFO - 'HOME': '/home/cltbld', 06:14:54 INFO - 'LANG': 'en_US.UTF-8', 06:14:54 INFO - 'LANGUAGE': 'en_US:en', 06:14:54 INFO - 'LOGNAME': 'cltbld', 06:14:54 INFO - 'MAIL': '/var/mail/cltbld', 06:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:54 INFO - 'MOZ_NO_REMOTE': '1', 06:14:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:14:54 INFO - 'NO_EM_RESTART': '1', 06:14:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:54 INFO - 'PWD': '/builds/slave/test', 06:14:54 INFO - 'SHELL': '/bin/bash', 06:14:54 INFO - 'SHLVL': '1', 06:14:54 INFO - 'TERM': 'linux', 06:14:54 INFO - 'TMOUT': '86400', 06:14:54 INFO - 'USER': 'cltbld', 06:14:54 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462105510.99143-11269107', 06:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:54 INFO - '_': '/tools/buildbot/bin/python'} 06:14:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:54 INFO - Downloading/unpacking psutil>=0.7.1 06:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:14:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:14:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:14:56 INFO - Installing collected packages: psutil 06:14:56 INFO - Running setup.py install for psutil 06:14:56 INFO - building 'psutil._psutil_linux' extension 06:14:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:14:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:14:56 INFO - building 'psutil._psutil_posix' extension 06:14:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:14:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:14:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:14:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:14:57 INFO - Successfully installed psutil 06:14:57 INFO - Cleaning up... 06:14:57 INFO - Return code: 0 06:14:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:14:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:57 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 0x7f89c1d13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19157d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a4640>, '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 0x19a5540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a59d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1462105510.99143-11269107', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:14:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 06:14:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:14:57 INFO - Using env: {'DISPLAY': ':0', 06:14:57 INFO - 'HOME': '/home/cltbld', 06:14:57 INFO - 'LANG': 'en_US.UTF-8', 06:14:57 INFO - 'LANGUAGE': 'en_US:en', 06:14:57 INFO - 'LOGNAME': 'cltbld', 06:14:57 INFO - 'MAIL': '/var/mail/cltbld', 06:14:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:57 INFO - 'MOZ_NO_REMOTE': '1', 06:14:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:14:57 INFO - 'NO_EM_RESTART': '1', 06:14:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:14:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:57 INFO - 'PWD': '/builds/slave/test', 06:14:57 INFO - 'SHELL': '/bin/bash', 06:14:57 INFO - 'SHLVL': '1', 06:14:57 INFO - 'TERM': 'linux', 06:14:57 INFO - 'TMOUT': '86400', 06:14:57 INFO - 'USER': 'cltbld', 06:14:57 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462105510.99143-11269107', 06:14:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:57 INFO - '_': '/tools/buildbot/bin/python'} 06:14:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:14:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:14:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:14:59 INFO - Installing collected packages: mozsystemmonitor 06:14:59 INFO - Running setup.py install for mozsystemmonitor 06:14:59 INFO - Successfully installed mozsystemmonitor 06:14:59 INFO - Cleaning up... 06:14:59 INFO - Return code: 0 06:14:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:14: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')]} 06:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14: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')]} 06:14:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:59 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 0x7f89c1d13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19157d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a4640>, '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 0x19a5540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a59d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1462105510.99143-11269107', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:14:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:14:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:14:59 INFO - Using env: {'DISPLAY': ':0', 06:14:59 INFO - 'HOME': '/home/cltbld', 06:14:59 INFO - 'LANG': 'en_US.UTF-8', 06:14:59 INFO - 'LANGUAGE': 'en_US:en', 06:14:59 INFO - 'LOGNAME': 'cltbld', 06:14:59 INFO - 'MAIL': '/var/mail/cltbld', 06:14:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:59 INFO - 'MOZ_NO_REMOTE': '1', 06:14:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:14:59 INFO - 'NO_EM_RESTART': '1', 06:14:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:14:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:59 INFO - 'PWD': '/builds/slave/test', 06:14:59 INFO - 'SHELL': '/bin/bash', 06:14:59 INFO - 'SHLVL': '1', 06:14:59 INFO - 'TERM': 'linux', 06:14:59 INFO - 'TMOUT': '86400', 06:14:59 INFO - 'USER': 'cltbld', 06:14:59 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462105510.99143-11269107', 06:14:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:59 INFO - '_': '/tools/buildbot/bin/python'} 06:14:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:59 INFO - Downloading/unpacking blobuploader==1.2.4 06:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:01 INFO - Downloading blobuploader-1.2.4.tar.gz 06:15:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:15:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:15:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:02 INFO - Downloading docopt-0.6.1.tar.gz 06:15:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:15:02 INFO - Installing collected packages: blobuploader, requests, docopt 06:15:02 INFO - Running setup.py install for blobuploader 06:15:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:15:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:15:02 INFO - Running setup.py install for requests 06:15:02 INFO - Running setup.py install for docopt 06:15:02 INFO - Successfully installed blobuploader requests docopt 06:15:02 INFO - Cleaning up... 06:15:02 INFO - Return code: 0 06:15:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:15:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:15:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:02 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 0x7f89c1d13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19157d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a4640>, '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 0x19a5540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a59d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1462105510.99143-11269107', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:15:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:15:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:15:02 INFO - Using env: {'DISPLAY': ':0', 06:15:02 INFO - 'HOME': '/home/cltbld', 06:15:02 INFO - 'LANG': 'en_US.UTF-8', 06:15:02 INFO - 'LANGUAGE': 'en_US:en', 06:15:02 INFO - 'LOGNAME': 'cltbld', 06:15:02 INFO - 'MAIL': '/var/mail/cltbld', 06:15:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:02 INFO - 'MOZ_NO_REMOTE': '1', 06:15:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:02 INFO - 'NO_EM_RESTART': '1', 06:15:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:02 INFO - 'PWD': '/builds/slave/test', 06:15:02 INFO - 'SHELL': '/bin/bash', 06:15:02 INFO - 'SHLVL': '1', 06:15:02 INFO - 'TERM': 'linux', 06:15:02 INFO - 'TMOUT': '86400', 06:15:02 INFO - 'USER': 'cltbld', 06:15:02 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462105510.99143-11269107', 06:15:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:02 INFO - '_': '/tools/buildbot/bin/python'} 06:15:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:15:03 INFO - Running setup.py (path:/tmp/pip-kN1XW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:15:03 INFO - Running setup.py (path:/tmp/pip-qqq_tr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:15:03 INFO - Running setup.py (path:/tmp/pip-fJBTXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:15:03 INFO - Running setup.py (path:/tmp/pip-FvBGhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:15:03 INFO - Running setup.py (path:/tmp/pip-fMTEyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:15:03 INFO - Running setup.py (path:/tmp/pip-NRpl4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:15:03 INFO - Running setup.py (path:/tmp/pip-3M04sP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:15:03 INFO - Running setup.py (path:/tmp/pip-CG8PE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:15:03 INFO - Running setup.py (path:/tmp/pip-BCsxN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:15:03 INFO - Running setup.py (path:/tmp/pip-OKKL5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:15:03 INFO - Running setup.py (path:/tmp/pip-gyeRL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:15:03 INFO - Running setup.py (path:/tmp/pip-IolF2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:15:04 INFO - Running setup.py (path:/tmp/pip-HNEcoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:15:04 INFO - Running setup.py (path:/tmp/pip-cq9R_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:15:04 INFO - Running setup.py (path:/tmp/pip-L4_vgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:15:04 INFO - Running setup.py (path:/tmp/pip-XPzHn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:15:04 INFO - Running setup.py (path:/tmp/pip-6OFyow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:15:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:15:04 INFO - Running setup.py install for manifestparser 06:15:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:15:04 INFO - Running setup.py install for mozcrash 06:15:04 INFO - Running setup.py install for mozdebug 06:15:04 INFO - Running setup.py install for mozdevice 06:15:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:15:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:15:04 INFO - Running setup.py install for mozfile 06:15:04 INFO - Running setup.py install for mozhttpd 06:15:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:15:05 INFO - Running setup.py install for mozinfo 06:15:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:15:05 INFO - Running setup.py install for mozInstall 06:15:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:15:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:15:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:15:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:15:05 INFO - Running setup.py install for mozleak 06:15:05 INFO - Running setup.py install for mozlog 06:15:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:15:05 INFO - Running setup.py install for moznetwork 06:15:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:15:05 INFO - Running setup.py install for mozprocess 06:15:05 INFO - Running setup.py install for mozprofile 06:15:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:15:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:15:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:15:05 INFO - Running setup.py install for mozrunner 06:15:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:15:05 INFO - Running setup.py install for mozscreenshot 06:15:05 INFO - Running setup.py install for moztest 06:15:06 INFO - Running setup.py install for mozversion 06:15:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:15:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:15:06 INFO - Cleaning up... 06:15:06 INFO - Return code: 0 06:15:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:15: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')]} 06:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15: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')]} 06:15:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:06 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 0x7f89c1d13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19157d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a4640>, '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 0x19a5540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a59d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1462105510.99143-11269107', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:15:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:15:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:15:06 INFO - Using env: {'DISPLAY': ':0', 06:15:06 INFO - 'HOME': '/home/cltbld', 06:15:06 INFO - 'LANG': 'en_US.UTF-8', 06:15:06 INFO - 'LANGUAGE': 'en_US:en', 06:15:06 INFO - 'LOGNAME': 'cltbld', 06:15:06 INFO - 'MAIL': '/var/mail/cltbld', 06:15:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:06 INFO - 'MOZ_NO_REMOTE': '1', 06:15:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:06 INFO - 'NO_EM_RESTART': '1', 06:15:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:06 INFO - 'PWD': '/builds/slave/test', 06:15:06 INFO - 'SHELL': '/bin/bash', 06:15:06 INFO - 'SHLVL': '1', 06:15:06 INFO - 'TERM': 'linux', 06:15:06 INFO - 'TMOUT': '86400', 06:15:06 INFO - 'USER': 'cltbld', 06:15:06 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462105510.99143-11269107', 06:15:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:06 INFO - '_': '/tools/buildbot/bin/python'} 06:15:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:15:06 INFO - Running setup.py (path:/tmp/pip-Q75K5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:15:06 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:15:06 INFO - Running setup.py (path:/tmp/pip-fBRJS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:15:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:15:06 INFO - Running setup.py (path:/tmp/pip-LmOpGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:15:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:15:06 INFO - Running setup.py (path:/tmp/pip-wZtZuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:15:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:15:06 INFO - Running setup.py (path:/tmp/pip-9YaOUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:15:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:15:06 INFO - Running setup.py (path:/tmp/pip-OFJKEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:15:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:15:06 INFO - Running setup.py (path:/tmp/pip-P6obGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:15:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:15:06 INFO - Running setup.py (path:/tmp/pip-u5apJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:15:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:15:06 INFO - Running setup.py (path:/tmp/pip-GtyRkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:15:07 INFO - Running setup.py (path:/tmp/pip-KFBfYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:15:07 INFO - Running setup.py (path:/tmp/pip-zZ_ZoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:15:07 INFO - Running setup.py (path:/tmp/pip-tibV0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:15:07 INFO - Running setup.py (path:/tmp/pip-S_iWZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:15:07 INFO - Running setup.py (path:/tmp/pip-D9zowB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:15:07 INFO - Running setup.py (path:/tmp/pip-8wezRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:15:07 INFO - Running setup.py (path:/tmp/pip-UZJvE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:15:07 INFO - Running setup.py (path:/tmp/pip-ZRDZ6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:15:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:09 INFO - Downloading blessings-1.6.tar.gz 06:15:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:15:09 INFO - Installing collected packages: blessings 06:15:09 INFO - Running setup.py install for blessings 06:15:09 INFO - Successfully installed blessings 06:15:09 INFO - Cleaning up... 06:15:09 INFO - Return code: 0 06:15:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:15:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:15:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:15:09 INFO - Reading from file tmpfile_stdout 06:15:09 INFO - Current package versions: 06:15:09 INFO - argparse == 1.2.1 06:15:09 INFO - blessings == 1.6 06:15:09 INFO - blobuploader == 1.2.4 06:15:09 INFO - docopt == 0.6.1 06:15:09 INFO - manifestparser == 1.1 06:15:09 INFO - mozInstall == 1.12 06:15:09 INFO - mozcrash == 0.17 06:15:09 INFO - mozdebug == 0.1 06:15:09 INFO - mozdevice == 0.48 06:15:09 INFO - mozfile == 1.2 06:15:09 INFO - mozhttpd == 0.7 06:15:09 INFO - mozinfo == 0.9 06:15:09 INFO - mozleak == 0.1 06:15:09 INFO - mozlog == 3.1 06:15:09 INFO - moznetwork == 0.27 06:15:09 INFO - mozprocess == 0.22 06:15:09 INFO - mozprofile == 0.28 06:15:09 INFO - mozrunner == 6.11 06:15:09 INFO - mozscreenshot == 0.1 06:15:09 INFO - mozsystemmonitor == 0.0 06:15:09 INFO - moztest == 0.7 06:15:09 INFO - mozversion == 1.4 06:15:09 INFO - psutil == 3.1.1 06:15:09 INFO - requests == 1.2.3 06:15:09 INFO - wsgiref == 0.1.2 06:15:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:15:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:15:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:09 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 0x7f89c1d13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19157d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a4640>, '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 0x19a5540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a59d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1462105510.99143-11269107', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:15:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:15:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:15:09 INFO - Using env: {'DISPLAY': ':0', 06:15:09 INFO - 'HOME': '/home/cltbld', 06:15:09 INFO - 'LANG': 'en_US.UTF-8', 06:15:09 INFO - 'LANGUAGE': 'en_US:en', 06:15:09 INFO - 'LOGNAME': 'cltbld', 06:15:09 INFO - 'MAIL': '/var/mail/cltbld', 06:15:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:09 INFO - 'MOZ_NO_REMOTE': '1', 06:15:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:09 INFO - 'NO_EM_RESTART': '1', 06:15:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:09 INFO - 'PWD': '/builds/slave/test', 06:15:09 INFO - 'SHELL': '/bin/bash', 06:15:09 INFO - 'SHLVL': '1', 06:15:09 INFO - 'TERM': 'linux', 06:15:09 INFO - 'TMOUT': '86400', 06:15:09 INFO - 'USER': 'cltbld', 06:15:09 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462105510.99143-11269107', 06:15:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:09 INFO - '_': '/tools/buildbot/bin/python'} 06:15:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:15:10 INFO - Cleaning up... 06:15:10 INFO - Return code: 0 06:15:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:15:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:15:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:10 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 0x7f89c1d13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19157d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a4640>, '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 0x19a5540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a59d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1462105510.99143-11269107', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:15:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:15:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:15:10 INFO - Using env: {'DISPLAY': ':0', 06:15:10 INFO - 'HOME': '/home/cltbld', 06:15:10 INFO - 'LANG': 'en_US.UTF-8', 06:15:10 INFO - 'LANGUAGE': 'en_US:en', 06:15:10 INFO - 'LOGNAME': 'cltbld', 06:15:10 INFO - 'MAIL': '/var/mail/cltbld', 06:15:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:10 INFO - 'MOZ_NO_REMOTE': '1', 06:15:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:10 INFO - 'NO_EM_RESTART': '1', 06:15:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:10 INFO - 'PWD': '/builds/slave/test', 06:15:10 INFO - 'SHELL': '/bin/bash', 06:15:10 INFO - 'SHLVL': '1', 06:15:10 INFO - 'TERM': 'linux', 06:15:10 INFO - 'TMOUT': '86400', 06:15:10 INFO - 'USER': 'cltbld', 06:15:10 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462105510.99143-11269107', 06:15:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:10 INFO - '_': '/tools/buildbot/bin/python'} 06:15:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:10 INFO - Downloading/unpacking jsonschema 06:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:15:12 INFO - Downloading/unpacking functools32 (from jsonschema) 06:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:12 INFO - Downloading functools32-3.2.3-2.tar.gz 06:15:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:15:12 INFO - warning: no files found matching '*.txt' 06:15:12 INFO - no previously-included directories found matching 'build' 06:15:12 INFO - no previously-included directories found matching 'dist' 06:15:12 INFO - no previously-included directories found matching '.git*' 06:15:12 INFO - Installing collected packages: jsonschema, functools32 06:15:12 INFO - Running setup.py install for functools32 06:15:12 INFO - warning: no files found matching '*.txt' 06:15:12 INFO - no previously-included directories found matching 'build' 06:15:12 INFO - no previously-included directories found matching 'dist' 06:15:12 INFO - no previously-included directories found matching '.git*' 06:15:12 INFO - Successfully installed jsonschema functools32 06:15:12 INFO - Cleaning up... 06:15:12 INFO - Return code: 0 06:15:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:15:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:15:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:12 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 0x7f89c1d13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19157d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a4640>, '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 0x19a5540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a59d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1462105510.99143-11269107', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:15:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 06:15:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:15:12 INFO - Using env: {'DISPLAY': ':0', 06:15:12 INFO - 'HOME': '/home/cltbld', 06:15:12 INFO - 'LANG': 'en_US.UTF-8', 06:15:12 INFO - 'LANGUAGE': 'en_US:en', 06:15:12 INFO - 'LOGNAME': 'cltbld', 06:15:12 INFO - 'MAIL': '/var/mail/cltbld', 06:15:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:12 INFO - 'MOZ_NO_REMOTE': '1', 06:15:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:12 INFO - 'NO_EM_RESTART': '1', 06:15:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:12 INFO - 'PWD': '/builds/slave/test', 06:15:12 INFO - 'SHELL': '/bin/bash', 06:15:12 INFO - 'SHLVL': '1', 06:15:12 INFO - 'TERM': 'linux', 06:15:12 INFO - 'TMOUT': '86400', 06:15:12 INFO - 'USER': 'cltbld', 06:15:12 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462105510.99143-11269107', 06:15:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:12 INFO - '_': '/tools/buildbot/bin/python'} 06:15:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:12 INFO - Downloading/unpacking flake8 06:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:15:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:15:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:15:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:15:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:15:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:15:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:15:15 INFO - no previously-included directories found matching 'docs/_build' 06:15:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:15:15 INFO - Running setup.py install for pep8 06:15:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:15:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:15:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:15:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:15:15 INFO - no previously-included directories found matching 'docs/_build' 06:15:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:15:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:15:15 INFO - Cleaning up... 06:15:15 INFO - Return code: 0 06:15:15 INFO - Running post-action listener: _resource_record_post_action 06:15:15 INFO - Running post-action listener: _start_resource_monitoring 06:15:15 INFO - Starting resource monitoring. 06:15:15 INFO - ##### 06:15:15 INFO - ##### Running install step. 06:15:15 INFO - ##### 06:15:15 INFO - Running pre-action listener: _resource_record_pre_action 06:15:15 INFO - Running main action method: install 06:15:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:15:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:15:16 INFO - Reading from file tmpfile_stdout 06:15:16 INFO - Detecting whether we're running mozinstall >=1.0... 06:15:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:15:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:15:16 INFO - Reading from file tmpfile_stdout 06:15:16 INFO - Output received: 06:15:16 INFO - Usage: mozinstall [options] installer 06:15:16 INFO - Options: 06:15:16 INFO - -h, --help show this help message and exit 06:15:16 INFO - -d DEST, --destination=DEST 06:15:16 INFO - Directory to install application into. [default: 06:15:16 INFO - "/builds/slave/test"] 06:15:16 INFO - --app=APP Application being installed. [default: firefox] 06:15:16 INFO - mkdir: /builds/slave/test/build/application 06:15:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:15:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:15:32 INFO - Reading from file tmpfile_stdout 06:15:32 INFO - Output received: 06:15:32 INFO - /builds/slave/test/build/application/firefox/firefox 06:15:32 INFO - Running post-action listener: _resource_record_post_action 06:15:32 INFO - ##### 06:15:32 INFO - ##### Running run-tests step. 06:15:32 INFO - ##### 06:15:32 INFO - Running pre-action listener: _resource_record_pre_action 06:15:32 INFO - Running main action method: run_tests 06:15:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:15:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:15:32 INFO - Python 2.7.3 06:15:32 INFO - Return code: 0 06:15:32 INFO - grabbing minidump binary from tooltool 06:15:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:15:32 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 0x19a4640>, '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 0x19a5540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a59d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:15:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:15:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:15:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:15:32 INFO - Return code: 0 06:15:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:15:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:15:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:15:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:15:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:15:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:15:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:15:33 INFO - Return code: 0 06:15:33 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/NCB4KqDvRHmqukG5s9CiXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:15:33 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/NCB4KqDvRHmqukG5s9CiXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:15:33 INFO - Using env: {'DISPLAY': ':0', 06:15:33 INFO - 'HOME': '/home/cltbld', 06:15:33 INFO - 'LANG': 'en_US.UTF-8', 06:15:33 INFO - 'LANGUAGE': 'en_US:en', 06:15:33 INFO - 'LOGNAME': 'cltbld', 06:15:33 INFO - 'MAIL': '/var/mail/cltbld', 06:15:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:15:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:15:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:33 INFO - 'MOZ_NO_REMOTE': '1', 06:15:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:15:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:33 INFO - 'NO_EM_RESTART': '1', 06:15:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:33 INFO - 'PWD': '/builds/slave/test', 06:15:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:15:33 INFO - 'SHELL': '/bin/bash', 06:15:33 INFO - 'SHLVL': '1', 06:15:33 INFO - 'TERM': 'linux', 06:15:33 INFO - 'TMOUT': '86400', 06:15:33 INFO - 'USER': 'cltbld', 06:15:33 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462105510.99143-11269107', 06:15:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:33 INFO - '_': '/tools/buildbot/bin/python'} 06:15:33 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/NCB4KqDvRHmqukG5s9CiXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:15:33 INFO - mozversion application_buildid: 20160501030217 06:15:33 INFO - mozversion application_changeset: 1461a4071341c282afcf7b72e33036412d2251d4 06:15:33 INFO - mozversion application_display_name: Nightly 06:15:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:15:33 INFO - mozversion application_name: Firefox 06:15:33 INFO - mozversion application_remotingname: firefox 06:15:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:15:33 INFO - mozversion application_vendor: Mozilla 06:15:33 INFO - mozversion application_version: 49.0a1 06:15:33 INFO - mozversion platform_buildid: 20160501030217 06:15:33 INFO - mozversion platform_changeset: 1461a4071341c282afcf7b72e33036412d2251d4 06:15:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:15:33 INFO - mozversion platform_version: 49.0a1 06:15:33 INFO - using testdate: 1462108533 06:15:33 INFO - actual date: 1462108533 06:15:33 INFO - starting webserver on 'localhost:58244' 06:15:33 INFO - SUITE-START | Running 2 tests 06:15:33 INFO - TEST-START | dromaeo_css 06:15:33 INFO - operating with platform_type : linux_ 06:15:33 INFO - Initialising browser for dromaeo_css test... 06:15:33 INFO - TEST-INFO | started process 14834 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp35L46j/profile http://localhost:58244/getInfo.html) 06:15:37 INFO - PROCESS | 14834 | 06:15:37 INFO - PROCESS | 14834 | (process:14903): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:15:38 INFO - PROCESS | 14834 | __metrics Screen width/height:1600/1200 06:15:38 INFO - PROCESS | 14834 | colorDepth:24 06:15:38 INFO - PROCESS | 14834 | Browser inner width/height: 1024/697 06:15:38 INFO - PROCESS | 14834 | __metrics 06:15:38 ERROR - PROCESS | 14834 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 06:15:39 INFO - TEST-INFO | 14834: exit 0 06:15:39 INFO - Browser initialized. 06:15:39 INFO - Running cycle 1/1 for dromaeo_css test... 06:15:39 INFO - TEST-INFO | started process 14954 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp35L46j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:15:41 INFO - PROCESS | 14954 | 06:15:41 INFO - PROCESS | 14954 | (process:15015): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:15:51 INFO - PROCESS | 14954 | RSS: Main: 165212160 06:15:51 INFO - PROCESS | 14954 | 06:16:40 INFO - PROCESS | 14954 | 1462108600779 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:18:47 INFO - PROCESS | 14954 | Cycle 1(1): loaded http://localhost:58244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58244/tests/dromaeo/cssquery-ext.html) 06:18:49 INFO - PROCESS | 14954 | RSS: Main: 169902080 06:18:49 INFO - PROCESS | 14954 | 06:21:50 INFO - PROCESS | 14954 | Cycle 1(1): loaded http://localhost:58244/tests/dromaeo/cssquery-ext.html (next: http://localhost:58244/tests/dromaeo/cssquery-jquery.html) 06:21:51 INFO - PROCESS | 14954 | RSS: Main: 166649856 06:21:51 INFO - PROCESS | 14954 | 06:24:53 INFO - PROCESS | 14954 | Cycle 1(1): loaded http://localhost:58244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58244/tests/dromaeo/cssquery-mootools.html) 06:24:54 INFO - PROCESS | 14954 | RSS: Main: 168034304 06:24:54 INFO - PROCESS | 14954 | 06:27:55 INFO - PROCESS | 14954 | Cycle 1(1): loaded http://localhost:58244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58244/tests/dromaeo/cssquery-prototype.html) 06:27:56 INFO - PROCESS | 14954 | RSS: Main: 165871616 06:27:56 INFO - PROCESS | 14954 | 06:30:58 INFO - PROCESS | 14954 | Cycle 1(1): loaded http://localhost:58244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58244/tests/dromaeo/cssquery-yui.html) 06:30:59 INFO - PROCESS | 14954 | RSS: Main: 167202816 06:30:59 INFO - PROCESS | 14954 | 06:34:01 INFO - PROCESS | 14954 | Cycle 1(1): loaded http://localhost:58244/tests/dromaeo/cssquery-yui.html (next: http://localhost:58244/tests/dromaeo/cssquery-dojo.html) 06:34:01 INFO - PROCESS | 14954 | RSS: Main: 168964096 06:34:01 INFO - PROCESS | 14954 | 06:34:01 INFO - PROCESS | 14954 | __start_tp_report 06:34:01 INFO - PROCESS | 14954 | _x_x_mozilla_page_load 06:34:01 INFO - PROCESS | 14954 | _x_x_mozilla_page_load_details 06:34:01 INFO - PROCESS | 14954 | |i|pagename|runs| 06:34:01 INFO - PROCESS | 14954 | |0;dojo.html;3069.4781887079193;3163.5096560033203;3181.6977387148213;3193.249586347208;3209.2458272306003;5222.817201397952;5295.258663787064;5322.547583455406;5323.254744335792;5358.6516876403;5221.817236396727;5225.111731005729;5255.448177941309;5264.1051021326375;5371.785128594861;4810.110129626013;4841.588464980481;4891.241857512091;4910.06708725341;4949.331840201581;909.4393993470013;4665.7200567965865;4756.571908528232;4766.642501812361;4771.761411929407;4821.6865903716325;4821.999999999983;4823.0353929214125;4852.393450818648;4877.463479017305;4793.904121917577;4837.927431088537;4856.708597484162;4872.220444728827;4894.877628059291;4725.220338644154;4755.072760811643;4837.9516204837855;4841.104395686774;4873.390826146731;5202.557782588447;5204.791808327663;5229.267902493654;5233.21501774733;5234.659747116425;5547.694876781776;5614.9157762633595;5639.605227634067;5643.097104463307;5648.858778530528;5527.198556209368;5578.30271216098;5595.580331475115;5610.382857885629;5646;5261.3686357637325;5276.947230527684;5277.340332458442;5277.8416647500635;5284.550813180885;5572.3870374258795;5663.470862867003;5686.175504551899;5693.345265294462;5749.425057494217;5547.195656629766;5572.777088916398;5577.135543990688;5584.385717571064;5667.404922483162;5611.074172761449;5656.91514627281;5671.773129074791;5679.801206957736;5682;5486.369067557282;5563.916541251884;5592.664440133605;5648;5660.575456840754;5674.120511320752;5714;5753.367129615739;5756.136579513107;5760.51035661965;4284.121755040209;4342.696011279243;4345.543717909637;4350.912981740347;4380.759058251763;3791.7914514701406;3824.101336185994;3871.593482684334;3905.6094390560716;3922.607739226112;5266.8946621068135;5316.282301889273;5375.623706340597;5408.323959505062;5441.374241962225;5635.549156067586;5645;5691.317041954909;5695.117256825199;5712.714364281853;5200.193969934666;5323.041852466516;5385.542228910508;5407.729613519308;5410.729463526886;4775.188218002948;4775.904481910342;4778.474367819537;4789.090072886141;4817.518248175154;5893.116032595145;5908.084246941645;5909.349971503131;5909.674967876722;5927.585069045125;5551.444855514416;5701.201831743476;5722.484976352065;5765.7117144141785;5804.622699524686;5753.712314384347;5772.94227057724;5782.392848750821;5818.214541036906;5880.323762767336;5478.233047373451;5503.504684578407;5536.2249285099315;5569.275994120739;5570.442955704397;5461.890762184814;5781.537477001913;5790.218320526844;5791.247137872049;5864.560157988082;5446.891062178814;5480.588955828249;5512.5589952802875;5517.337919449692;5538.944610553843;5326.36083669962;5500;5506.256655351636;5517.062099443024;5571.860703482445;5418.539424148991;5441.156620723794;5457.426970168075;5494.038543254995;5516.448355164612;5330.253764473055;5387.784488620411;5424.186372044225;5445.727713614383;5457.536109430743;5190.97404512975;5294.100002999577;5337.839864804062;5389.7035663038905;5448.56411487088 06:34:01 INFO - PROCESS | 14954 | |1;ext.html;589.5637228450947;653.0269897852196;654.1267408010306;666.2604508995017;666.9899951500727;31203;31973.36053278933;35839.46240806383;36878.631213687855;37056.81471592645;40148.79925600375;41136;41262;41294.58705412945;41469.170616587726;8505.957470212641;8709.21617054465;8723.60743766532;8724.563771811385;8725.869111963326;8416.495010299372;8590.785230369229;8648;8661.090585488528;8676.739697809044;8771.868421973675;8827.426217295855;8887.466751994869;8897.68858089967;8904.910950890506;8781.34139939504;8820.338474614366;8827.337949653802;8859.734207973803;8884.644614215424;8739.956300218459;8850.336224783103;8852.247558957497;8867.645294188225;8876.600552975067;41212.58787412148;41354.79322603398;41588.58411415877;41749;41890.37164442536;3378.3581119587448;3458.7405944554007;3594.5506811648543;3620.746547741659;4071.3282308419075;30524.77900883962;31073.533896991565;31330.37339253225;31449.842750786327;32572;4132.793360332002;4185.330347144442;4188.539260681323;4202.894927626803;4220.767857767822;301536;302843.9999999978;303133;303549;303727;58779.706101469215;59260;59571.40428595659;59636;59834;56636;57355.13967290494;57556;57583;63133.36866631367;16401.097939613435;16579;16610.58473538171;16621;16677.999320040835;12148.757024859453;12216.572419965258;12244.938775306244;12306.938465307796;12360.567380141652;19269.843809371483;19969.800301997086;19994.70007949882;20071.899640501997;20078.8877723953;6915.688794004282;7395.926040739524;7435.107787065479;7449.813754656177;7511.699532018658;1034.3948789957808;1090.55287332195;1123.1407972900738;1161.0827446317483;1177.9810463948622;31337;31391.529127063113;31502.36995260082;31649;31899;1156.8958793708607;1158.7682463507333;1197.9940100299443;1222.6698791326469;1234.697499112723;16377.590560236089;16660.83339166593;16729.916350418414;16967.74548381775;16969.23638436273;302404;311878;312952;313392;314104;51266.48733512692;52934.73532632389;53129.73435132877;53380.46619533755;53389.66103389708;1398.9300534973413;1411.724713680843;1422.4950142699192;1423.1318895473753;1428.414350116468;28783.5682464759;30311;30697.693023069485;30997.533379270542;31793.841030794698;50170;50835.2374714387;51165.95336186511;51235.23147152721;51343;409166;414787;415337;416981;417849;28577.713562939698;28701.85649071741;28750.424991499636;28933.276668083465;29067;47574.04851903012;47643.285350719074;48470.5152948466;48518.757406212746;48937.75531122321;37431.62568374391;37938.810305949395;38370.80814595909;38579.42130867983;38766.41850372303;36973.44539831851;37879.81060094682;38427.23145537129;38694.80652596719;38757.22485550329;36654.63345366512;37569.81215093907;37570.624293756715;37833.243335133695;40930.79534602308;30189.849050754605;32374.19064523406;32568.34863302768;32648.204348760097;33116.33767324688;27540.586891196246;27578.44843103167;27999.860000700683;28021.43957120887;28200.85899570489 06:34:01 INFO - PROCESS | 14954 | |2;jquery.html;368.7363535072423;370.8794641741433;372.1514945923295;372.2740655721344;375.9887203383896;17440.73838892416;17634.559136021606;18081.8246813957;18221.817781822177;18258.269669213216;17280.56798580033;17292.82707172931;17771.64456710865;17836.64326713465;17843.197056132474;5028.371453568304;5128.8461346159675;5139.177731562951;5184.481551844823;5197.506236907488;4965.950340496585;5084.898302033957;5145.485451454843;5160.432352441228;5177.068127737006;5108.2848401223855;5113.667611605252;5116.309298244745;5126.794928202868;5126.897462050757;5143.434222235551;5200.921986170191;5203.089459344618;5582.27430434041;5583.748731307061;5040.974795126001;5057.772400241961;5059.215821547629;5065.544101030888;5099.056674515226;13565.660858478519;13710.588682339545;13810.723785524233;13833.446662133503;19175.753576017654;2103.1587365053947;2257.24382331919;2288.0962020002007;2489.5020995800915;2529.430878052442;10122.49387530628;10232.43721595312;10293;12923.353832308347;13650.453981840714;1914.7510823592984;1943.5821298420767;1948.6395016921774;1982.266561372287;2019.6768517037203;72873.6356318215;75190.62404687997;76825.23174768237;78815.21184788193;81381;10154.492275386201;10659.626913058006;10858.185636077167;10884.836727449094;10927.508262128224;15260.694786104215;15277.847221527865;15310.923445382701;15362.078275303518;15368.53894383148;7630.122535908442;7832.569208693462;7854.528728276322;7900;7993.160718124629;7326.487145899842;7422.665980030912;7506.474546781782;7522.285382888617;7566.9621651892485;4554.43069616298;4619.122366750306;4629.583337499574;4665.883352916137;4714.269288260325;1928.267258441783;1928.6914093744933;1937.167018182167;1996.5108548405733;2011.8591698580958;967.5549247346299;1021.4790456866903;1062.8830828608848;1093.639099097296;1127.4757237884423;18424.263029478938;18445.53886152857;18469;18741;18852.81147188538;981.8036392721484;1007.7379881230786;1029.4904022508906;1034.849946757731;1060.9522571484301;10029.197664186848;10375.84436233457;10416.479176041319;10428.947855260674;10457.901920298411;347271.163730177;351128;351521;352550;517469;68809.65595171992;85116.57441712751;86146.56926715326;93688;100544;967.1827305926621;1000.2797985450464;1018.3940555369543;1058.6771034834449;1072.1690689715533;16199.838001619833;16738.4141555045;16854;16995.660086797947;17188;39014;39022.60977390303;39528.60471395249;39554.2089158221;40662.79668601638;52887;55757.721211393684;56216.437835621124;56282.71858640681;56593;8275.83448331042;8573.356998225034;8626.827463450822;8650.524221167896;8702.347323950602;12149.81775273354;13218.669533261746;13239.536616218385;13394.531191408254;13396.464141434622;10897.891021089688;11055.557777688802;11208.439578020903;11585.131115166565;11753.294802311888;10876;11070.501827417624;11121.777564448828;11140.944295278472;11369.374684392107;11484.138689598147;11507.597234096766;11729.35488548104;11738.119641027128;12096.455659495168;8295.087540370434;8490.702825401082;8515.318774497902;8542.103079176846;8578.871316930376;8633.223009929137;11008.724781880517;11724.58963936258;11876;11915.94042029819 06:34:01 INFO - PROCESS | 14954 | |3;mootools.html;1507.8793696504276;1508.61530309771;1650.1749125437282;1749.6588165307753;1769.486848813844;7278.599677017762;7790.9220907790905;7899.486533375334;8192.467489613186;8216.38377121716;7777.844443111135;7811.296983271504;7857.449978501507;7879.369650427966;7917.089534703511;2196.978030219693;2225.8219342452567;2239.8320125990535;2246.84272100953;2260.559190957764;2247.4606094537357;2270.6594010898334;2274.4996100857784;2275.6358982562792;2275.7496675365696;2206.977930220701;2211.281333566589;2228.0308065991267;2257.2663884237604;2296.3799774060994;2197.187040794908;2205.9448513787124;2211.436083798629;2213.690083388327;2217.36805010572;2203.7355517338024;2208.977910220893;2230.888455577231;2271.057511132878;2274.40865375002;8032.959835200845;8041.839163216703;8072.112067672551;8139.511629302261;8157.55133467659;4876.951230487721;5104.872378190538;5122.052420302256;5137.717425541594;5149.76826042829;3039.60485136933;3084.599002129731;3259.3807176636365;3273.492608645664;3282.4748040313434;974.1476208317722;974.2498276327259;993.1806259835664;1002.6691191906654;1010.2675560218782;11567.016803571707;11588.478518466689;11638.709032274177;11645.534178632844;11742.178047536676;4433.490148632884;4472.44094488189;4492.101579684077;4542.613877820356;4559.931601025987;9756.46339451337;9764.902350976541;9798.216142708567;9821.803563928825;9833.852492212622;5076.340075790124;5121.667091639031;5141.38303403594;5158.509941555546;5160.148575485003;4066.2883995301295;4455.509893911667;4576.656750743708;4593.6095431888;4719.009008108267;3795.3927371620407;3833.5591406987996;3882.5340959085092;3938.0942383252013;3952.091019065631;1217.4399776103091;1225.7180848404917;1231.9938400307942;1236.71555542224;1240.1133189769357;799.7600719784042;910.9681161159327;925.1627277314042;932.2262522106636;933.9673111441067;5609.803656872072;5632.633878797947;5771.047777116729;5795.391483894215;5906.793262235801;394.83614300065153;397.31859860339654;404.42167700189015;406.63606072564886;407.79903185119537;3752.605976372496;3807.58116607173;3840.7887566183567;3854.3062248795486;3895.6104389561383;10056.34633748804;10266.743331416774;10511.737206569744;10518.73703157412;10548.367097974146;10286;10289.845652315222;10320.948395257976;10344.844827327595;10396.012378824;7495.437842161859;7903.209679032166;7908.130105688369;7953.602319883983;7997.280244777998;5664.235328230801;5750.0512415450985;5779.555111222195;5803.970980145073;5823;9104.408213466104;9154.725358239264;9199.586018629045;9346.766330841783;9360;9248.445093294424;9322;9428.811423771349;9446;9724.076212759777;6655.933440665725;6994.965025174842;7019.754308599175;7156.570605763671;7187.425005999403;7867.370610351272;7873.409494287836;7913.089994650689;7974.043114826258;7990.92009079925;6754.628495432798;6889.827754305982;6944.618046007518;7040.718371265092;7053.858922821412;6802.897956530755;6845.281245469154;6934.618595977269;6956.5478243913985;7023.051887995055;6638.468922486286;6694.698738556874;6758.695858686273;6769.052332673331;6821.249662537018;4886.706797592155;4895.926561101515;4918.803247870045;4936.111499930047;4959;4871.853844384674;4898.069366820293;4904.386951631046;4923;4926.2610608407595 06:34:01 INFO - PROCESS | 14954 | |4;prototype.html;295.88312616516475;296.7092249595396;305.44866515938736;307.60165585566693;310.0945239899493;5283.63014588979;5377.46225377463;5453.182022696593;5499.257600223968;5502.312210973629;5400.216968539559;5420.512153906147;5422.701751403672;5425.9728701356535;5475.233467314579;4130.153318569701;4152.231837110145;4158.688098392633;4164.27125253081;4189.664826813862;4098.077932465187;4102.692298077641;4164.312888373414;4180.163967206556;4184.665226781865;4119.938200926988;4131.6281534661875;4141.544430112685;4144.772037537934;4147.066909945268;4151.813168407429;4151.97924010381;4158.251514727348;4178.12259425521;4186.099988502456;3601.2617413430444;3635.3274644190647;3642.8360723767496;3649.160693040589;3656.634336566349;5111.616628752859;5199;5217.2695822584865;5241.449647786965;5278.392984806758;4722.881927951828;4737.928931066037;4748.169070412699;4757.8096876125255;4774.427068751737;5491.281815501313;5646.548276137899;5686.758547627854;5693.459121383504;5726.112452569859;3979.184267225212;3993.520777506718;3998.5801490843332;4001.359782434826;4009.8797036088963;5902.291724992985;5911.261092363455;5966.717155811478;5987.670678112746;5987.946147464781;4090.877273681794;4106.035081755785;4107.8973025674595;4116.526599441103;4117.773522456294;4060.3300455425115;4060.5127384713433;4118.6499147572795;4118.732282401635;4119.784663524268;4716.316134160527;4735.59747421473;4742.834000809955;4757.762111894392;4765.285207218875;5449.536789372948;5658.971705141448;5690.5447564194765;5722.685252311163;5747.913781293284;1454.6217983324411;1505.473084420466;1511.916844573559;1511.9643044514544;1514.9848501514844;973.464594473037;994.1400688404623;1010.4796030044533;1011.9443430611387;1012.6000229909145;5730.856728581735;5806.622569532967;5809.970950145223;5824.5631577631;5834.912476312858;6200.534959878028;6251.374862513803;6264.525512422659;6278.937210627927;6287.685615719196;5637.661740295595;5819.418058194146;5834.533237341003;5835.824925252249;5861.531077513789;3339.532465454838;3356.5300857879915;3370.8651653934057;3376.729861611065;3381.7801842880135;6300.243970723543;6442.549021568539;6471.644059576674;6488.67556622167;6491.156149700603;6341.841453963595;6349.873002539924;6379.266384365765;6382.297947225801;6409.692510696145;5849.766009359663;6403.455706265019;6417.486601071903;6454.548181627241;6471.7734879279;5811.302643682785;5849.590528662953;5896.233489646319;5930.940690593039;5953.493953014043;5867.9413205867395;5907.143464197753;5926.555508336805;5952.434518720715;5959.837831622792;5807.390224026416;6096.664683442454;6100.420460056288;6122.816315510542;6126.663033533198;3948.8350936473234;3966.3257246267626;4007.559168491405;4018.0557568970685;4027.1140349123148;5611.523020543136;5618.606697531133;5954.345022047658;5958.702064896825;5968.731407086779;5731.713414329351;5733.283339582552;5734.967705812994;5748.87896860125;5764.164196191445;5704.60067795267;5730;5738.368779434342;5741.822926300182;5774;5526.806561770319;5621.74702138413;5690.890276396063;5694.487496125369;5699.575106223444;5751.8562035949435;5756;5781.364049954585;5820.76716931318;5821.883562328814;5444.476481173959;5609.775608975595;5649.745761440663;5658.377578466448;5733.684647344436 06:34:01 INFO - PROCESS | 14954 | |5;yui.html;772.4747171923092;776.5961699916043;785.05793048342;800.8425738245701;806.3790881021614;13688.315584220787;13934.51229206978;13964.650883727913;14059.5079172229;14086.999999999987;12809.423575939081;13726.794098088512;13924.373403196854;13934.51229206978;13967.022308438414;787.8227398835273;800.2077942836579;808.7129069180415;817.5013241922422;824.4146655874337;819.2217393476221;819.6967122164807;823.1069289820551;823.2631794543879;825.4222044568796;848.1518481518482;850.4557083466586;855.3542075732813;856.07543852639;857.746964645428;847.2501835875264;853.4964371021097;853.5220276645099;853.9701110461104;854.4147259127456;616.3189675408654;622.327885883245;622.5704264057786;622.9439350458481;624.4411251929498;12774.808377874338;12901.548445804445;12934.805977910339;13039.087263891532;13094.47622095115;11809.114316426303;12152.635420937386;12157.817632735516;12284.324362160078;12315.75368492625;10485.68542943713;10789.892101078967;10895.83656245157;10940.671779846618;10979.28634638746;3762.9811850940846;3804.600516945736;3826.502554667903;3827.827747751358;3872.3997780344093;48088;48169.277460838115;48567.028659426964;48681.5131848684;48782.7560862197;9813.264005199639;9847.55685994132;9906.157976572073;10133.240006999504;10165.847512287322;15736.449224277096;15946.122963237134;16364.099974501278;16418.83581164197;16531.256093475822;7480.1023877134;7486.737964171337;7798.454108212484;7832;8213.54825484604;4480.865574032719;4498.752568608758;4546.88632784183;4588.747618880993;4734.644901632391;3195.3609278144463;3252.1869532616847;3261.9836900815344;3265.559149514785;3268.509723541488;588.9558283128697;598.5032423088826;599.5892813422819;610.8320211941663;612.8958077126899;574.2821473158551;615.3907631444927;630.5995692735146;652.7323797243107;684.7911387027004;8302;8458.450200737056;8537.487750734852;8566.229039386486;8688.956555217184;625.2059883947361;625.3746253746253;654.7773756922669;667.152716050613;690.4959379652881;3910.7849068300948;4113;4129.595937381305;4238.109996900624;4352.086061927031;60808.695956520816;61494.38505614976;61958;62014.0697889532;65468.34531654623;54387;54397;55928.72035639796;56157;57090.42909570851;49909.25136122961;50721;50984;51128.99999999926;53132.734336328074;8022.478538894953;8214.459918173889;8402.789930251793;8438.873416898874;8615.612297446505;33330.83334583312;33476;33510;34386;36053.63946360503;46224.30663540117;47615.52384476111;48350;48640.75679621579;49650.503494964585;12156.574519891761;12240.449179786752;12472.937635311766;12533.37333133358;12808.807867881802;13023.544175954175;13283.136596121221;13509.797353039909;13525.323733813073;13611.659708507366;11941.104417168573;12016.579419720269;12145.066347400767;12579.496820127093;12679.492820287454;12356.62930112098;12457.439415226156;13112.475500980236;13348.599542013755;13385.531506397228;10884.782304354027;12077.879221207675;12152.513899443924;12195.390230488263;12519.248845069325;9914.900850991686;10058.698239052841;10148.79702405933;10239.232057595858;10461.738456538647;10575.735606609896;10695.400977579404;10846.644169478815;11002.889971100507;11054.723631909266 06:34:01 INFO - PROCESS | 14954 | __end_tp_report 06:34:01 INFO - PROCESS | 14954 | __start_cc_report 06:34:01 INFO - PROCESS | 14954 | _x_x_mozilla_cycle_collect,350 06:34:01 INFO - PROCESS | 14954 | __end_cc_report 06:34:01 INFO - PROCESS | 14954 | __startTimestamp1462109641915__endTimestamp 06:34:01 INFO - PROCESS | 14954 | 06:34:01 INFO - PROCESS | 14954 | ------- Summary: start ------- 06:34:01 INFO - PROCESS | 14954 | Number of tests: 6 06:34:01 INFO - PROCESS | 14954 | 06:34:01 INFO - PROCESS | 14954 | [#0] dojo.html Cycles:165 Average:5221.01 Median:5441.16 stddev:670.72 (12.3%) stddev-sans-first:651.20 06:34:01 INFO - PROCESS | 14954 | Values: 3069.5 3163.5 3181.7 3193.2 3209.2 5222.8 5295.3 5322.5 5323.3 5358.7 5221.8 5225.1 5255.4 5264.1 5371.8 4810.1 4841.6 4891.2 4910.1 4949.3 909.4 4665.7 4756.6 4766.6 4771.8 4821.7 4822.0 4823.0 4852.4 4877.5 4793.9 4837.9 4856.7 4872.2 4894.9 4725.2 4755.1 4838.0 4841.1 4873.4 5202.6 5204.8 5229.3 5233.2 5234.7 5547.7 5614.9 5639.6 5643.1 5648.9 5527.2 5578.3 5595.6 5610.4 5646.0 5261.4 5276.9 5277.3 5277.8 5284.6 5572.4 5663.5 5686.2 5693.3 5749.4 5547.2 5572.8 5577.1 5584.4 5667.4 5611.1 5656.9 5671.8 5679.8 5682.0 5486.4 5563.9 5592.7 5648.0 5660.6 5674.1 5714.0 5753.4 5756.1 5760.5 4284.1 4342.7 4345.5 4350.9 4380.8 3791.8 3824.1 3871.6 3905.6 3922.6 5266.9 5316.3 5375.6 5408.3 5441.4 5635.5 5645.0 5691.3 5695.1 5712.7 5200.2 5323.0 5385.5 5407.7 5410.7 4775.2 4775.9 4778.5 4789.1 4817.5 5893.1 5908.1 5909.3 5909.7 5927.6 5551.4 5701.2 5722.5 5765.7 5804.6 5753.7 5772.9 5782.4 5818.2 5880.3 5478.2 5503.5 5536.2 5569.3 5570.4 5461.9 5781.5 5790.2 5791.2 5864.6 5446.9 5480.6 5512.6 5517.3 5538.9 5326.4 5500.0 5506.3 5517.1 5571.9 5418.5 5441.2 5457.4 5494.0 5516.4 5330.3 5387.8 5424.2 5445.7 5457.5 5191.0 5294.1 5337.8 5389.7 5448.6 06:34:01 INFO - PROCESS | 14954 | 06:34:01 INFO - PROCESS | 14954 | [#1] ext.html Cycles:180 Average:51149.56 Median:37909.31 stddev:91109.94 (240.3%) stddev-sans-first:91286.44 06:34:01 INFO - PROCESS | 14954 | Values: 589.6 653.0 654.1 666.3 667.0 31203.0 31973.4 35839.5 36878.6 37056.8 40148.8 41136.0 41262.0 41294.6 41469.2 8506.0 8709.2 8723.6 8724.6 8725.9 8416.5 8590.8 8648.0 8661.1 8676.7 8771.9 8827.4 8887.5 8897.7 8904.9 8781.3 8820.3 8827.3 8859.7 8884.6 8740.0 8850.3 8852.2 8867.6 8876.6 41212.6 41354.8 41588.6 41749.0 41890.4 3378.4 3458.7 3594.6 3620.7 4071.3 30524.8 31073.5 31330.4 31449.8 32572.0 4132.8 4185.3 4188.5 4202.9 4220.8 301536.0 302844.0 303133.0 303549.0 303727.0 58779.7 59260.0 59571.4 59636.0 59834.0 56636.0 57355.1 57556.0 57583.0 63133.4 16401.1 16579.0 16610.6 16621.0 16678.0 12148.8 12216.6 12244.9 12306.9 12360.6 19269.8 19969.8 19994.7 20071.9 20078.9 6915.7 7395.9 7435.1 7449.8 7511.7 1034.4 1090.6 1123.1 1161.1 1178.0 31337.0 31391.5 31502.4 31649.0 31899.0 1156.9 1158.8 1198.0 1222.7 1234.7 16377.6 16660.8 16729.9 16967.7 16969.2 302404.0 311878.0 312952.0 313392.0 314104.0 51266.5 52934.7 53129.7 53380.5 53389.7 1398.9 1411.7 1422.5 1423.1 1428.4 28783.6 30311.0 30697.7 30997.5 31793.8 50170.0 50835.2 51166.0 51235.2 51343.0 409166.0 414787.0 415337.0 416981.0 417849.0 28577.7 28701.9 28750.4 28933.3 29067.0 47574.0 47643.3 48470.5 48518.8 48937.8 37431.6 37938.8 38370.8 38579.4 38766.4 36973.4 37879.8 38427.2 38694.8 38757.2 36654.6 37569.8 37570.6 37833.2 40930.8 30189.8 32374.2 32568.3 32648.2 33116.3 27540.6 27578.4 27999.9 28021.4 28200.9 06:34:01 INFO - PROCESS | 14954 | 06:34:01 INFO - PROCESS | 14954 | [#2] jquery.html Cycles:180 Average:25200.98 Median:2015.77 stddev:64833.41 (3216.3%) stddev-sans-first:64988.48 06:34:01 INFO - PROCESS | 14954 | Values: 368.7 370.9 372.2 372.3 376.0 17440.7 17634.6 18081.8 18221.8 18258.3 17280.6 17292.8 17771.6 17836.6 17843.2 5028.4 5128.8 5139.2 5184.5 5197.5 4966.0 5084.9 5145.5 5160.4 5177.1 5108.3 5113.7 5116.3 5126.8 5126.9 5143.4 5200.9 5203.1 5582.3 5583.7 5041.0 5057.8 5059.2 5065.5 5099.1 13565.7 13710.6 13810.7 13833.4 19175.8 2103.2 2257.2 2288.1 2489.5 2529.4 10122.5 10232.4 10293.0 12923.4 13650.5 1914.8 1943.6 1948.6 1982.3 2019.7 72873.6 75190.6 76825.2 78815.2 81381.0 10154.5 10659.6 10858.2 10884.8 10927.5 15260.7 15277.8 15310.9 15362.1 15368.5 7630.1 7832.6 7854.5 7900.0 7993.2 7326.5 7422.7 7506.5 7522.3 7567.0 4554.4 4619.1 4629.6 4665.9 4714.3 1928.3 1928.7 1937.2 1996.5 2011.9 967.6 1021.5 1062.9 1093.6 1127.5 18424.3 18445.5 18469.0 18741.0 18852.8 981.8 1007.7 1029.5 1034.8 1061.0 10029.2 10375.8 10416.5 10428.9 10457.9 347271.2 351128.0 351521.0 352550.0 517469.0 68809.7 85116.6 86146.6 93688.0 100544.0 967.2 1000.3 1018.4 1058.7 1072.2 16199.8 16738.4 16854.0 16995.7 17188.0 39014.0 39022.6 39528.6 39554.2 40662.8 52887.0 55757.7 56216.4 56282.7 56593.0 8275.8 8573.4 8626.8 8650.5 8702.3 12149.8 13218.7 13239.5 13394.5 13396.5 10897.9 11055.6 11208.4 11585.1 11753.3 10876.0 11070.5 11121.8 11140.9 11369.4 11484.1 11507.6 11729.4 11738.1 12096.5 8295.1 8490.7 8515.3 8542.1 8578.9 8633.2 11008.7 11724.6 11876.0 11915.9 06:34:01 INFO - PROCESS | 14954 | 06:34:01 INFO - PROCESS | 14954 | [#3] mootools.html Cycles:180 Average:5437.66 Median:4931.19 stddev:3071.67 (62.3%) stddev-sans-first:3066.09 06:34:01 INFO - PROCESS | 14954 | Values: 1507.9 1508.6 1650.2 1749.7 1769.5 7278.6 7790.9 7899.5 8192.5 8216.4 7777.8 7811.3 7857.4 7879.4 7917.1 2197.0 2225.8 2239.8 2246.8 2260.6 2247.5 2270.7 2274.5 2275.6 2275.7 2207.0 2211.3 2228.0 2257.3 2296.4 2197.2 2205.9 2211.4 2213.7 2217.4 2203.7 2209.0 2230.9 2271.1 2274.4 8033.0 8041.8 8072.1 8139.5 8157.6 4877.0 5104.9 5122.1 5137.7 5149.8 3039.6 3084.6 3259.4 3273.5 3282.5 974.1 974.2 993.2 1002.7 1010.3 11567.0 11588.5 11638.7 11645.5 11742.2 4433.5 4472.4 4492.1 4542.6 4559.9 9756.5 9764.9 9798.2 9821.8 9833.9 5076.3 5121.7 5141.4 5158.5 5160.1 4066.3 4455.5 4576.7 4593.6 4719.0 3795.4 3833.6 3882.5 3938.1 3952.1 1217.4 1225.7 1232.0 1236.7 1240.1 799.8 911.0 925.2 932.2 934.0 5609.8 5632.6 5771.0 5795.4 5906.8 394.8 397.3 404.4 406.6 407.8 3752.6 3807.6 3840.8 3854.3 3895.6 10056.3 10266.7 10511.7 10518.7 10548.4 10286.0 10289.8 10320.9 10344.8 10396.0 7495.4 7903.2 7908.1 7953.6 7997.3 5664.2 5750.1 5779.6 5804.0 5823.0 9104.4 9154.7 9199.6 9346.8 9360.0 9248.4 9322.0 9428.8 9446.0 9724.1 6655.9 6995.0 7019.8 7156.6 7187.4 7867.4 7873.4 7913.1 7974.0 7990.9 6754.6 6889.8 6944.6 7040.7 7053.9 6802.9 6845.3 6934.6 6956.5 7023.1 6638.5 6694.7 6758.7 6769.1 6821.2 4886.7 4895.9 4918.8 4936.1 4959.0 4871.9 4898.1 4904.4 4923.0 4926.3 06:34:01 INFO - PROCESS | 14954 | 06:34:01 INFO - PROCESS | 14954 | [#4] prototype.html Cycles:180 Average:4850.48 Median:5514.56 stddev:1471.27 (26.7%) stddev-sans-first:1435.13 06:34:01 INFO - PROCESS | 14954 | Values: 295.9 296.7 305.4 307.6 310.1 5283.6 5377.5 5453.2 5499.3 5502.3 5400.2 5420.5 5422.7 5426.0 5475.2 4130.2 4152.2 4158.7 4164.3 4189.7 4098.1 4102.7 4164.3 4180.2 4184.7 4119.9 4131.6 4141.5 4144.8 4147.1 4151.8 4152.0 4158.3 4178.1 4186.1 3601.3 3635.3 3642.8 3649.2 3656.6 5111.6 5199.0 5217.3 5241.4 5278.4 4722.9 4737.9 4748.2 4757.8 4774.4 5491.3 5646.5 5686.8 5693.5 5726.1 3979.2 3993.5 3998.6 4001.4 4009.9 5902.3 5911.3 5966.7 5987.7 5987.9 4090.9 4106.0 4107.9 4116.5 4117.8 4060.3 4060.5 4118.6 4118.7 4119.8 4716.3 4735.6 4742.8 4757.8 4765.3 5449.5 5659.0 5690.5 5722.7 5747.9 1454.6 1505.5 1511.9 1512.0 1515.0 973.5 994.1 1010.5 1011.9 1012.6 5730.9 5806.6 5810.0 5824.6 5834.9 6200.5 6251.4 6264.5 6278.9 6287.7 5637.7 5819.4 5834.5 5835.8 5861.5 3339.5 3356.5 3370.9 3376.7 3381.8 6300.2 6442.5 6471.6 6488.7 6491.2 6341.8 6349.9 6379.3 6382.3 6409.7 5849.8 6403.5 6417.5 6454.5 6471.8 5811.3 5849.6 5896.2 5930.9 5953.5 5867.9 5907.1 5926.6 5952.4 5959.8 5807.4 6096.7 6100.4 6122.8 6126.7 3948.8 3966.3 4007.6 4018.1 4027.1 5611.5 5618.6 5954.3 5958.7 5968.7 5731.7 5733.3 5735.0 5748.9 5764.2 5704.6 5730.0 5738.4 5741.8 5774.0 5526.8 5621.7 5690.9 5694.5 5699.6 5751.9 5756.0 5781.4 5820.8 5821.9 5444.5 5609.8 5649.7 5658.4 5733.7 06:34:01 INFO - PROCESS | 14954 | 06:34:01 INFO - PROCESS | 14954 | [#5] yui.html Cycles:180 Average:14459.93 Median:25479.48 stddev:17017.63 (66.8%) stddev-sans-first:17034.32 06:34:01 INFO - PROCESS | 14954 | Values: 772.5 776.6 785.1 800.8 806.4 13688.3 13934.5 13964.7 14059.5 14087.0 12809.4 13726.8 13924.4 13934.5 13967.0 787.8 800.2 808.7 817.5 824.4 819.2 819.7 823.1 823.3 825.4 848.2 850.5 855.4 856.1 857.7 847.3 853.5 853.5 854.0 854.4 616.3 622.3 622.6 622.9 624.4 12774.8 12901.5 12934.8 13039.1 13094.5 11809.1 12152.6 12157.8 12284.3 12315.8 10485.7 10789.9 10895.8 10940.7 10979.3 3763.0 3804.6 3826.5 3827.8 3872.4 48088.0 48169.3 48567.0 48681.5 48782.8 9813.3 9847.6 9906.2 10133.2 10165.8 15736.4 15946.1 16364.1 16418.8 16531.3 7480.1 7486.7 7798.5 7832.0 8213.5 4480.9 4498.8 4546.9 4588.7 4734.6 3195.4 3252.2 3262.0 3265.6 3268.5 589.0 598.5 599.6 610.8 612.9 574.3 615.4 630.6 652.7 684.8 8302.0 8458.5 8537.5 8566.2 8689.0 625.2 625.4 654.8 667.2 690.5 3910.8 4113.0 4129.6 4238.1 4352.1 60808.7 61494.4 61958.0 62014.1 65468.3 54387.0 54397.0 55928.7 56157.0 57090.4 49909.3 50721.0 50984.0 51129.0 53132.7 8022.5 8214.5 8402.8 8438.9 8615.6 33330.8 33476.0 33510.0 34386.0 36053.6 46224.3 47615.5 48350.0 48640.8 49650.5 12156.6 12240.4 12472.9 12533.4 12808.8 13023.5 13283.1 13509.8 13525.3 13611.7 11941.1 12016.6 12145.1 12579.5 12679.5 12356.6 12457.4 13112.5 13348.6 13385.5 10884.8 12077.9 12152.5 12195.4 12519.2 9914.9 10058.7 10148.8 10239.2 10461.7 10575.7 10695.4 10846.6 11002.9 11054.7 06:34:01 INFO - PROCESS | 14954 | -------- Summary: end -------- 06:34:01 INFO - PROCESS | 14954 | 06:34:02 INFO - TEST-INFO | 14954: exit 0 06:34:02 INFO - TEST-OK | dromaeo_css | took 1108671ms 06:34:02 INFO - TEST-START | kraken 06:34:02 INFO - operating with platform_type : linux_ 06:34:02 INFO - Initialising browser for kraken test... 06:34:02 INFO - TEST-INFO | started process 15196 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZsJuXM/profile http://localhost:58244/getInfo.html) 06:34:05 INFO - PROCESS | 15196 | 06:34:05 INFO - PROCESS | 15196 | (process:15266): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:34:06 INFO - PROCESS | 15196 | __metrics Screen width/height:1600/1200 06:34:06 INFO - PROCESS | 15196 | colorDepth:24 06:34:06 INFO - PROCESS | 15196 | Browser inner width/height: 1024/697 06:34:06 INFO - PROCESS | 15196 | __metrics 06:34:07 ERROR - PROCESS | 15196 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 06:34:07 INFO - TEST-INFO | 15196: exit 0 06:34:07 INFO - Browser initialized. 06:34:07 INFO - Running cycle 1/1 for kraken test... 06:34:07 INFO - TEST-INFO | started process 15317 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZsJuXM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:34:09 INFO - PROCESS | 15317 | 06:34:09 INFO - PROCESS | 15317 | (process:15382): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:34:19 INFO - PROCESS | 15317 | RSS: Main: 164610048 06:34:19 INFO - PROCESS | 15317 | 06:34:22 INFO - PROCESS | 15317 | Cycle 1(1): loaded http://localhost:58244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58244/tests/kraken/driver.html?testName=audio-beat-detection) 06:34:23 INFO - PROCESS | 15317 | RSS: Main: 169271296 06:34:23 INFO - PROCESS | 15317 | 06:34:25 INFO - PROCESS | 15317 | Cycle 1(1): loaded http://localhost:58244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58244/tests/kraken/driver.html?testName=audio-dft) 06:34:26 INFO - PROCESS | 15317 | RSS: Main: 173203456 06:34:26 INFO - PROCESS | 15317 | 06:34:29 INFO - PROCESS | 15317 | Cycle 1(1): loaded http://localhost:58244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58244/tests/kraken/driver.html?testName=audio-fft) 06:34:30 INFO - PROCESS | 15317 | RSS: Main: 164069376 06:34:30 INFO - PROCESS | 15317 | 06:34:32 INFO - PROCESS | 15317 | Cycle 1(1): loaded http://localhost:58244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58244/tests/kraken/driver.html?testName=audio-oscillator) 06:34:32 INFO - PROCESS | 15317 | RSS: Main: 164589568 06:34:32 INFO - PROCESS | 15317 | 06:34:35 INFO - PROCESS | 15317 | Cycle 1(1): loaded http://localhost:58244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:34:35 INFO - PROCESS | 15317 | RSS: Main: 164864000 06:34:35 INFO - PROCESS | 15317 | 06:34:38 INFO - PROCESS | 15317 | Cycle 1(1): loaded http://localhost:58244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58244/tests/kraken/driver.html?testName=imaging-darkroom) 06:34:39 INFO - PROCESS | 15317 | RSS: Main: 165523456 06:34:39 INFO - PROCESS | 15317 | 06:34:42 INFO - PROCESS | 15317 | Cycle 1(1): loaded http://localhost:58244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58244/tests/kraken/driver.html?testName=imaging-desaturate) 06:34:43 INFO - PROCESS | 15317 | RSS: Main: 167415808 06:34:43 INFO - PROCESS | 15317 | 06:34:46 INFO - PROCESS | 15317 | Cycle 1(1): loaded http://localhost:58244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58244/tests/kraken/driver.html?testName=json-parse-financial) 06:34:46 INFO - PROCESS | 15317 | RSS: Main: 168267776 06:34:46 INFO - PROCESS | 15317 | 06:34:48 INFO - PROCESS | 15317 | Cycle 1(1): loaded http://localhost:58244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:34:49 INFO - PROCESS | 15317 | RSS: Main: 167882752 06:34:49 INFO - PROCESS | 15317 | 06:34:50 INFO - PROCESS | 15317 | Cycle 1(1): loaded http://localhost:58244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58244/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:34:51 INFO - PROCESS | 15317 | RSS: Main: 167510016 06:34:51 INFO - PROCESS | 15317 | 06:34:53 INFO - PROCESS | 15317 | Cycle 1(1): loaded http://localhost:58244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:34:54 INFO - PROCESS | 15317 | RSS: Main: 168206336 06:34:54 INFO - PROCESS | 15317 | 06:34:56 INFO - PROCESS | 15317 | Cycle 1(1): loaded http://localhost:58244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:34:57 INFO - PROCESS | 15317 | RSS: Main: 169160704 06:34:57 INFO - PROCESS | 15317 | 06:35:00 INFO - PROCESS | 15317 | Cycle 1(1): loaded http://localhost:58244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:35:01 INFO - PROCESS | 15317 | RSS: Main: 168271872 06:35:01 INFO - PROCESS | 15317 | 06:35:02 INFO - PROCESS | 15317 | Cycle 1(1): loaded http://localhost:58244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58244/tests/kraken/driver.html?testName=ai-astar) 06:35:02 INFO - PROCESS | 15317 | RSS: Main: 170004480 06:35:02 INFO - PROCESS | 15317 | 06:35:02 INFO - PROCESS | 15317 | __start_tp_report 06:35:02 INFO - PROCESS | 15317 | _x_x_mozilla_page_load 06:35:02 INFO - PROCESS | 15317 | _x_x_mozilla_page_load_details 06:35:02 INFO - PROCESS | 15317 | |i|pagename|runs| 06:35:02 INFO - PROCESS | 15317 | |0;ai-astar;113;108;114;115;113;126;112;114;113;113 06:35:02 INFO - PROCESS | 15317 | |1;audio-beat-detection;154;129;163;185;132;162;169;132;194;132 06:35:02 INFO - PROCESS | 15317 | |2;audio-dft;165;164;164;163;163;177;162;164;165;164 06:35:02 INFO - PROCESS | 15317 | |3;audio-fft;78;79;79;166;78;79;79;76;100;80 06:35:02 INFO - PROCESS | 15317 | |4;audio-oscillator;94;94;147;93;94;94;144;94;94;142 06:35:03 INFO - PROCESS | 15317 | |5;imaging-gaussian-blur;119;119;118;117;119;118;117;118;119;117 06:35:03 INFO - PROCESS | 15317 | |6;imaging-darkroom;149;150;149;149;148;150;150;148;148;151 06:35:03 INFO - PROCESS | 15317 | |7;imaging-desaturate;97;96;97;95;96;95;96;96;97;97 06:35:03 INFO - PROCESS | 15317 | |8;json-parse-financial;58;62;58;59;66;59;59;77;58;58 06:35:03 INFO - PROCESS | 15317 | |9;json-stringify-tinderbox;65;66;66;65;66;65;65;65;66;65 06:35:03 INFO - PROCESS | 15317 | |10;stanford-crypto-aes;78;77;77;80;80;78;82;79;80;86 06:35:03 INFO - PROCESS | 15317 | |11;stanford-crypto-ccm;126;126;130;121;122;128;126;125;163;129 06:35:03 INFO - PROCESS | 15317 | |12;stanford-crypto-pbkdf2;169;176;176;180;171;168;168;171;169;168 06:35:03 INFO - PROCESS | 15317 | |13;stanford-crypto-sha256-iterative;71;71;70;71;70;73;72;69;71;72 06:35:03 INFO - PROCESS | 15317 | __end_tp_report 06:35:03 INFO - PROCESS | 15317 | __start_cc_report 06:35:03 INFO - PROCESS | 15317 | _x_x_mozilla_cycle_collect,857 06:35:03 INFO - PROCESS | 15317 | __end_cc_report 06:35:03 INFO - PROCESS | 15317 | __startTimestamp1462109702995__endTimestamp 06:35:03 INFO - PROCESS | 15317 | 06:35:03 INFO - PROCESS | 15317 | ------- Summary: start ------- 06:35:03 INFO - PROCESS | 15317 | Number of tests: 14 06:35:03 INFO - PROCESS | 15317 | 06:35:03 INFO - PROCESS | 15317 | [#0] ai-astar Cycles:10 Average:114.10 Median:113.50 stddev:4.58 (4.0%) stddev-sans-first:4.84 06:35:03 INFO - PROCESS | 15317 | Values: 113.0 108.0 114.0 115.0 113.0 126.0 112.0 114.0 113.0 113.0 06:35:03 INFO - PROCESS | 15317 | 06:35:03 INFO - PROCESS | 15317 | [#1] audio-beat-detection Cycles:10 Average:155.20 Median:162.50 stddev:23.56 (14.5%) stddev-sans-first:24.98 06:35:03 INFO - PROCESS | 15317 | Values: 154.0 129.0 163.0 185.0 132.0 162.0 169.0 132.0 194.0 132.0 06:35:03 INFO - PROCESS | 15317 | 06:35:03 INFO - PROCESS | 15317 | [#2] audio-dft Cycles:10 Average:165.10 Median:164.00 stddev:4.28 (2.6%) stddev-sans-first:4.54 06:35:03 INFO - PROCESS | 15317 | Values: 165.0 164.0 164.0 163.0 163.0 177.0 162.0 164.0 165.0 164.0 06:35:03 INFO - PROCESS | 15317 | 06:35:03 INFO - PROCESS | 15317 | [#3] audio-fft Cycles:10 Average:89.40 Median:79.00 stddev:27.77 (35.2%) stddev-sans-first:29.15 06:35:03 INFO - PROCESS | 15317 | Values: 78.0 79.0 79.0 166.0 78.0 79.0 79.0 76.0 100.0 80.0 06:35:03 INFO - PROCESS | 15317 | 06:35:03 INFO - PROCESS | 15317 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:94.00 stddev:24.41 (26.0%) stddev-sans-first:25.28 06:35:03 INFO - PROCESS | 15317 | Values: 94.0 94.0 147.0 93.0 94.0 94.0 144.0 94.0 94.0 142.0 06:35:03 INFO - PROCESS | 15317 | 06:35:03 INFO - PROCESS | 15317 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.50 stddev:0.88 (0.7%) stddev-sans-first:0.87 06:35:03 INFO - PROCESS | 15317 | Values: 119.0 119.0 118.0 117.0 119.0 118.0 117.0 118.0 119.0 117.0 06:35:03 INFO - PROCESS | 15317 | 06:35:03 INFO - PROCESS | 15317 | [#6] imaging-darkroom Cycles:10 Average:149.20 Median:149.50 stddev:1.03 (0.7%) stddev-sans-first:1.09 06:35:03 INFO - PROCESS | 15317 | Values: 149.0 150.0 149.0 149.0 148.0 150.0 150.0 148.0 148.0 151.0 06:35:03 INFO - PROCESS | 15317 | 06:35:03 INFO - PROCESS | 15317 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.50 stddev:0.79 (0.8%) stddev-sans-first:0.78 06:35:03 INFO - PROCESS | 15317 | Values: 97.0 96.0 97.0 95.0 96.0 95.0 96.0 96.0 97.0 97.0 06:35:03 INFO - PROCESS | 15317 | 06:35:03 INFO - PROCESS | 15317 | [#8] json-parse-financial Cycles:10 Average:61.40 Median:59.00 stddev:6.04 (10.2%) stddev-sans-first:6.28 06:35:03 INFO - PROCESS | 15317 | Values: 58.0 62.0 58.0 59.0 66.0 59.0 59.0 77.0 58.0 58.0 06:35:03 INFO - PROCESS | 15317 | 06:35:03 INFO - PROCESS | 15317 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 06:35:03 INFO - PROCESS | 15317 | Values: 65.0 66.0 66.0 65.0 66.0 65.0 65.0 65.0 66.0 65.0 06:35:03 INFO - PROCESS | 15317 | 06:35:03 INFO - PROCESS | 15317 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:80.00 stddev:2.71 (3.4%) stddev-sans-first:2.80 06:35:03 INFO - PROCESS | 15317 | Values: 78.0 77.0 77.0 80.0 80.0 78.0 82.0 79.0 80.0 86.0 06:35:03 INFO - PROCESS | 15317 | 06:35:03 INFO - PROCESS | 15317 | [#11] stanford-crypto-ccm Cycles:10 Average:129.60 Median:127.00 stddev:12.07 (9.5%) stddev-sans-first:12.73 06:35:03 INFO - PROCESS | 15317 | Values: 126.0 126.0 130.0 121.0 122.0 128.0 126.0 125.0 163.0 129.0 06:35:03 INFO - PROCESS | 15317 | 06:35:03 INFO - PROCESS | 15317 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.60 Median:171.00 stddev:4.25 (2.5%) stddev-sans-first:4.40 06:35:03 INFO - PROCESS | 15317 | Values: 169.0 176.0 176.0 180.0 171.0 168.0 168.0 171.0 169.0 168.0 06:35:03 INFO - PROCESS | 15317 | 06:35:03 INFO - PROCESS | 15317 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.00 Median:71.00 stddev:1.15 (1.6%) stddev-sans-first:1.22 06:35:03 INFO - PROCESS | 15317 | Values: 71.0 71.0 70.0 71.0 70.0 73.0 72.0 69.0 71.0 72.0 06:35:03 INFO - PROCESS | 15317 | -------- Summary: end -------- 06:35:03 INFO - PROCESS | 15317 | 06:35:03 INFO - TEST-INFO | 15317: exit 0 06:35:03 INFO - TEST-OK | kraken | took 61378ms 06:35:03 INFO - SUITE-END | took 1170s 06:35:04 INFO - Completed test suite (00:19:30) 06:35:04 INFO - javascript benchmark 06:35:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3069.4781887079193, 3163.5096560033203, 3181.6977387148213, 3193.249586347208, 3209.2458272306003, 5222.817201397952, 5295.258663787064, 5322.547583455406, 5323.254744335792, 5358.6516876403, 5221.817236396727, 5225.111731005729, 5255.448177941309, 5264.1051021326375, 5371.785128594861, 4810.110129626013, 4841.588464980481, 4891.241857512091, 4910.06708725341, 4949.331840201581, 909.4393993470013, 4665.7200567965865, 4756.571908528232, 4766.642501812361, 4771.761411929407, 4821.6865903716325, 4821.999999999983, 4823.0353929214125, 4852.393450818648, 4877.463479017305, 4793.904121917577, 4837.927431088537, 4856.708597484162, 4872.220444728827, 4894.877628059291, 4725.220338644154, 4755.072760811643, 4837.9516204837855, 4841.104395686774, 4873.390826146731, 5202.557782588447, 5204.791808327663, 5229.267902493654, 5233.21501774733, 5234.659747116425, 5547.694876781776, 5614.9157762633595, 5639.605227634067, 5643.097104463307, 5648.858778530528, 5527.198556209368, 5578.30271216098, 5595.580331475115, 5610.382857885629, 5646.0, 5261.3686357637325, 5276.947230527684, 5277.340332458442, 5277.8416647500635, 5284.550813180885, 5572.3870374258795, 5663.470862867003, 5686.175504551899, 5693.345265294462, 5749.425057494217, 5547.195656629766, 5572.777088916398, 5577.135543990688, 5584.385717571064, 5667.404922483162, 5611.074172761449, 5656.91514627281, 5671.773129074791, 5679.801206957736, 5682.0, 5486.369067557282, 5563.916541251884, 5592.664440133605, 5648.0, 5660.575456840754, 5674.120511320752, 5714.0, 5753.367129615739, 5756.136579513107, 5760.51035661965, 4284.121755040209, 4342.696011279243, 4345.543717909637, 4350.912981740347, 4380.759058251763, 3791.7914514701406, 3824.101336185994, 3871.593482684334, 3905.6094390560716, 3922.607739226112, 5266.8946621068135, 5316.282301889273, 5375.623706340597, 5408.323959505062, 5441.374241962225, 5635.549156067586, 5645.0, 5691.317041954909, 5695.117256825199, 5712.714364281853, 5200.193969934666, 5323.041852466516, 5385.542228910508, 5407.729613519308, 5410.729463526886, 4775.188218002948, 4775.904481910342, 4778.474367819537, 4789.090072886141, 4817.518248175154, 5893.116032595145, 5908.084246941645, 5909.349971503131, 5909.674967876722, 5927.585069045125, 5551.444855514416, 5701.201831743476, 5722.484976352065, 5765.7117144141785, 5804.622699524686, 5753.712314384347, 5772.94227057724, 5782.392848750821, 5818.214541036906, 5880.323762767336, 5478.233047373451, 5503.504684578407, 5536.2249285099315, 5569.275994120739, 5570.442955704397, 5461.890762184814, 5781.537477001913, 5790.218320526844, 5791.247137872049, 5864.560157988082, 5446.891062178814, 5480.588955828249, 5512.5589952802875, 5517.337919449692, 5538.944610553843, 5326.36083669962, 5500.0, 5506.256655351636, 5517.062099443024, 5571.860703482445, 5418.539424148991, 5441.156620723794, 5457.426970168075, 5494.038543254995, 5516.448355164612, 5330.253764473055, 5387.784488620411, 5424.186372044225, 5445.727713614383, 5457.536109430743, 5190.97404512975, 5294.100002999577, 5337.839864804062, 5389.7035663038905, 5448.56411487088], "value": 5178.895205605544, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.5637228450947, 653.0269897852196, 654.1267408010306, 666.2604508995017, 666.9899951500727, 31203.0, 31973.36053278933, 35839.46240806383, 36878.631213687855, 37056.81471592645, 40148.79925600375, 41136.0, 41262.0, 41294.58705412945, 41469.170616587726, 8505.957470212641, 8709.21617054465, 8723.60743766532, 8724.563771811385, 8725.869111963326, 8416.495010299372, 8590.785230369229, 8648.0, 8661.090585488528, 8676.739697809044, 8771.868421973675, 8827.426217295855, 8887.466751994869, 8897.68858089967, 8904.910950890506, 8781.34139939504, 8820.338474614366, 8827.337949653802, 8859.734207973803, 8884.644614215424, 8739.956300218459, 8850.336224783103, 8852.247558957497, 8867.645294188225, 8876.600552975067, 41212.58787412148, 41354.79322603398, 41588.58411415877, 41749.0, 41890.37164442536, 3378.3581119587448, 3458.7405944554007, 3594.5506811648543, 3620.746547741659, 4071.3282308419075, 30524.77900883962, 31073.533896991565, 31330.37339253225, 31449.842750786327, 32572.0, 4132.793360332002, 4185.330347144442, 4188.539260681323, 4202.894927626803, 4220.767857767822, 301536.0, 302843.9999999978, 303133.0, 303549.0, 303727.0, 58779.706101469215, 59260.0, 59571.40428595659, 59636.0, 59834.0, 56636.0, 57355.13967290494, 57556.0, 57583.0, 63133.36866631367, 16401.097939613435, 16579.0, 16610.58473538171, 16621.0, 16677.999320040835, 12148.757024859453, 12216.572419965258, 12244.938775306244, 12306.938465307796, 12360.567380141652, 19269.843809371483, 19969.800301997086, 19994.70007949882, 20071.899640501997, 20078.8877723953, 6915.688794004282, 7395.926040739524, 7435.107787065479, 7449.813754656177, 7511.699532018658, 1034.3948789957808, 1090.55287332195, 1123.1407972900738, 1161.0827446317483, 1177.9810463948622, 31337.0, 31391.529127063113, 31502.36995260082, 31649.0, 31899.0, 1156.8958793708607, 1158.7682463507333, 1197.9940100299443, 1222.6698791326469, 1234.697499112723, 16377.590560236089, 16660.83339166593, 16729.916350418414, 16967.74548381775, 16969.23638436273, 302404.0, 311878.0, 312952.0, 313392.0, 314104.0, 51266.48733512692, 52934.73532632389, 53129.73435132877, 53380.46619533755, 53389.66103389708, 1398.9300534973413, 1411.724713680843, 1422.4950142699192, 1423.1318895473753, 1428.414350116468, 28783.5682464759, 30311.0, 30697.693023069485, 30997.533379270542, 31793.841030794698, 50170.0, 50835.2374714387, 51165.95336186511, 51235.23147152721, 51343.0, 409166.0, 414787.0, 415337.0, 416981.0, 417849.0, 28577.713562939698, 28701.85649071741, 28750.424991499636, 28933.276668083465, 29067.0, 47574.04851903012, 47643.285350719074, 48470.5152948466, 48518.757406212746, 48937.75531122321, 37431.62568374391, 37938.810305949395, 38370.80814595909, 38579.42130867983, 38766.41850372303, 36973.44539831851, 37879.81060094682, 38427.23145537129, 38694.80652596719, 38757.22485550329, 36654.63345366512, 37569.81215093907, 37570.624293756715, 37833.243335133695, 40930.79534602308, 30189.849050754605, 32374.19064523406, 32568.34863302768, 32648.204348760097, 33116.33767324688, 27540.586891196246, 27578.44843103167, 27999.860000700683, 28021.43957120887, 28200.85899570489], "value": 19364.84662848353, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.7363535072423, 370.8794641741433, 372.1514945923295, 372.2740655721344, 375.9887203383896, 17440.73838892416, 17634.559136021606, 18081.8246813957, 18221.817781822177, 18258.269669213216, 17280.56798580033, 17292.82707172931, 17771.64456710865, 17836.64326713465, 17843.197056132474, 5028.371453568304, 5128.8461346159675, 5139.177731562951, 5184.481551844823, 5197.506236907488, 4965.950340496585, 5084.898302033957, 5145.485451454843, 5160.432352441228, 5177.068127737006, 5108.2848401223855, 5113.667611605252, 5116.309298244745, 5126.794928202868, 5126.897462050757, 5143.434222235551, 5200.921986170191, 5203.089459344618, 5582.27430434041, 5583.748731307061, 5040.974795126001, 5057.772400241961, 5059.215821547629, 5065.544101030888, 5099.056674515226, 13565.660858478519, 13710.588682339545, 13810.723785524233, 13833.446662133503, 19175.753576017654, 2103.1587365053947, 2257.24382331919, 2288.0962020002007, 2489.5020995800915, 2529.430878052442, 10122.49387530628, 10232.43721595312, 10293.0, 12923.353832308347, 13650.453981840714, 1914.7510823592984, 1943.5821298420767, 1948.6395016921774, 1982.266561372287, 2019.6768517037203, 72873.6356318215, 75190.62404687997, 76825.23174768237, 78815.21184788193, 81381.0, 10154.492275386201, 10659.626913058006, 10858.185636077167, 10884.836727449094, 10927.508262128224, 15260.694786104215, 15277.847221527865, 15310.923445382701, 15362.078275303518, 15368.53894383148, 7630.122535908442, 7832.569208693462, 7854.528728276322, 7900.0, 7993.160718124629, 7326.487145899842, 7422.665980030912, 7506.474546781782, 7522.285382888617, 7566.9621651892485, 4554.43069616298, 4619.122366750306, 4629.583337499574, 4665.883352916137, 4714.269288260325, 1928.267258441783, 1928.6914093744933, 1937.167018182167, 1996.5108548405733, 2011.8591698580958, 967.5549247346299, 1021.4790456866903, 1062.8830828608848, 1093.639099097296, 1127.4757237884423, 18424.263029478938, 18445.53886152857, 18469.0, 18741.0, 18852.81147188538, 981.8036392721484, 1007.7379881230786, 1029.4904022508906, 1034.849946757731, 1060.9522571484301, 10029.197664186848, 10375.84436233457, 10416.479176041319, 10428.947855260674, 10457.901920298411, 347271.163730177, 351128.0, 351521.0, 352550.0, 517469.0, 68809.65595171992, 85116.57441712751, 86146.56926715326, 93688.0, 100544.0, 967.1827305926621, 1000.2797985450464, 1018.3940555369543, 1058.6771034834449, 1072.1690689715533, 16199.838001619833, 16738.4141555045, 16854.0, 16995.660086797947, 17188.0, 39014.0, 39022.60977390303, 39528.60471395249, 39554.2089158221, 40662.79668601638, 52887.0, 55757.721211393684, 56216.437835621124, 56282.71858640681, 56593.0, 8275.83448331042, 8573.356998225034, 8626.827463450822, 8650.524221167896, 8702.347323950602, 12149.81775273354, 13218.669533261746, 13239.536616218385, 13394.531191408254, 13396.464141434622, 10897.891021089688, 11055.557777688802, 11208.439578020903, 11585.131115166565, 11753.294802311888, 10876.0, 11070.501827417624, 11121.777564448828, 11140.944295278472, 11369.374684392107, 11484.138689598147, 11507.597234096766, 11729.35488548104, 11738.119641027128, 12096.455659495168, 8295.087540370434, 8490.702825401082, 8515.318774497902, 8542.103079176846, 8578.871316930376, 8633.223009929137, 11008.724781880517, 11724.58963936258, 11876.0, 11915.94042029819], "value": 8773.89301814216, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1507.8793696504276, 1508.61530309771, 1650.1749125437282, 1749.6588165307753, 1769.486848813844, 7278.599677017762, 7790.9220907790905, 7899.486533375334, 8192.467489613186, 8216.38377121716, 7777.844443111135, 7811.296983271504, 7857.449978501507, 7879.369650427966, 7917.089534703511, 2196.978030219693, 2225.8219342452567, 2239.8320125990535, 2246.84272100953, 2260.559190957764, 2247.4606094537357, 2270.6594010898334, 2274.4996100857784, 2275.6358982562792, 2275.7496675365696, 2206.977930220701, 2211.281333566589, 2228.0308065991267, 2257.2663884237604, 2296.3799774060994, 2197.187040794908, 2205.9448513787124, 2211.436083798629, 2213.690083388327, 2217.36805010572, 2203.7355517338024, 2208.977910220893, 2230.888455577231, 2271.057511132878, 2274.40865375002, 8032.959835200845, 8041.839163216703, 8072.112067672551, 8139.511629302261, 8157.55133467659, 4876.951230487721, 5104.872378190538, 5122.052420302256, 5137.717425541594, 5149.76826042829, 3039.60485136933, 3084.599002129731, 3259.3807176636365, 3273.492608645664, 3282.4748040313434, 974.1476208317722, 974.2498276327259, 993.1806259835664, 1002.6691191906654, 1010.2675560218782, 11567.016803571707, 11588.478518466689, 11638.709032274177, 11645.534178632844, 11742.178047536676, 4433.490148632884, 4472.44094488189, 4492.101579684077, 4542.613877820356, 4559.931601025987, 9756.46339451337, 9764.902350976541, 9798.216142708567, 9821.803563928825, 9833.852492212622, 5076.340075790124, 5121.667091639031, 5141.38303403594, 5158.509941555546, 5160.148575485003, 4066.2883995301295, 4455.509893911667, 4576.656750743708, 4593.6095431888, 4719.009008108267, 3795.3927371620407, 3833.5591406987996, 3882.5340959085092, 3938.0942383252013, 3952.091019065631, 1217.4399776103091, 1225.7180848404917, 1231.9938400307942, 1236.71555542224, 1240.1133189769357, 799.7600719784042, 910.9681161159327, 925.1627277314042, 932.2262522106636, 933.9673111441067, 5609.803656872072, 5632.633878797947, 5771.047777116729, 5795.391483894215, 5906.793262235801, 394.83614300065153, 397.31859860339654, 404.42167700189015, 406.63606072564886, 407.79903185119537, 3752.605976372496, 3807.58116607173, 3840.7887566183567, 3854.3062248795486, 3895.6104389561383, 10056.34633748804, 10266.743331416774, 10511.737206569744, 10518.73703157412, 10548.367097974146, 10286.0, 10289.845652315222, 10320.948395257976, 10344.844827327595, 10396.012378824, 7495.437842161859, 7903.209679032166, 7908.130105688369, 7953.602319883983, 7997.280244777998, 5664.235328230801, 5750.0512415450985, 5779.555111222195, 5803.970980145073, 5823.0, 9104.408213466104, 9154.725358239264, 9199.586018629045, 9346.766330841783, 9360.0, 9248.445093294424, 9322.0, 9428.811423771349, 9446.0, 9724.076212759777, 6655.933440665725, 6994.965025174842, 7019.754308599175, 7156.570605763671, 7187.425005999403, 7867.370610351272, 7873.409494287836, 7913.089994650689, 7974.043114826258, 7990.92009079925, 6754.628495432798, 6889.827754305982, 6944.618046007518, 7040.718371265092, 7053.858922821412, 6802.897956530755, 6845.281245469154, 6934.618595977269, 6956.5478243913985, 7023.051887995055, 6638.468922486286, 6694.698738556874, 6758.695858686273, 6769.052332673331, 6821.249662537018, 4886.706797592155, 4895.926561101515, 4918.803247870045, 4936.111499930047, 4959.0, 4871.853844384674, 4898.069366820293, 4904.386951631046, 4923.0, 4926.2610608407595], "value": 4294.020676625277, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.88312616516475, 296.7092249595396, 305.44866515938736, 307.60165585566693, 310.0945239899493, 5283.63014588979, 5377.46225377463, 5453.182022696593, 5499.257600223968, 5502.312210973629, 5400.216968539559, 5420.512153906147, 5422.701751403672, 5425.9728701356535, 5475.233467314579, 4130.153318569701, 4152.231837110145, 4158.688098392633, 4164.27125253081, 4189.664826813862, 4098.077932465187, 4102.692298077641, 4164.312888373414, 4180.163967206556, 4184.665226781865, 4119.938200926988, 4131.6281534661875, 4141.544430112685, 4144.772037537934, 4147.066909945268, 4151.813168407429, 4151.97924010381, 4158.251514727348, 4178.12259425521, 4186.099988502456, 3601.2617413430444, 3635.3274644190647, 3642.8360723767496, 3649.160693040589, 3656.634336566349, 5111.616628752859, 5199.0, 5217.2695822584865, 5241.449647786965, 5278.392984806758, 4722.881927951828, 4737.928931066037, 4748.169070412699, 4757.8096876125255, 4774.427068751737, 5491.281815501313, 5646.548276137899, 5686.758547627854, 5693.459121383504, 5726.112452569859, 3979.184267225212, 3993.520777506718, 3998.5801490843332, 4001.359782434826, 4009.8797036088963, 5902.291724992985, 5911.261092363455, 5966.717155811478, 5987.670678112746, 5987.946147464781, 4090.877273681794, 4106.035081755785, 4107.8973025674595, 4116.526599441103, 4117.773522456294, 4060.3300455425115, 4060.5127384713433, 4118.6499147572795, 4118.732282401635, 4119.784663524268, 4716.316134160527, 4735.59747421473, 4742.834000809955, 4757.762111894392, 4765.285207218875, 5449.536789372948, 5658.971705141448, 5690.5447564194765, 5722.685252311163, 5747.913781293284, 1454.6217983324411, 1505.473084420466, 1511.916844573559, 1511.9643044514544, 1514.9848501514844, 973.464594473037, 994.1400688404623, 1010.4796030044533, 1011.9443430611387, 1012.6000229909145, 5730.856728581735, 5806.622569532967, 5809.970950145223, 5824.5631577631, 5834.912476312858, 6200.534959878028, 6251.374862513803, 6264.525512422659, 6278.937210627927, 6287.685615719196, 5637.661740295595, 5819.418058194146, 5834.533237341003, 5835.824925252249, 5861.531077513789, 3339.532465454838, 3356.5300857879915, 3370.8651653934057, 3376.729861611065, 3381.7801842880135, 6300.243970723543, 6442.549021568539, 6471.644059576674, 6488.67556622167, 6491.156149700603, 6341.841453963595, 6349.873002539924, 6379.266384365765, 6382.297947225801, 6409.692510696145, 5849.766009359663, 6403.455706265019, 6417.486601071903, 6454.548181627241, 6471.7734879279, 5811.302643682785, 5849.590528662953, 5896.233489646319, 5930.940690593039, 5953.493953014043, 5867.9413205867395, 5907.143464197753, 5926.555508336805, 5952.434518720715, 5959.837831622792, 5807.390224026416, 6096.664683442454, 6100.420460056288, 6122.816315510542, 6126.663033533198, 3948.8350936473234, 3966.3257246267626, 4007.559168491405, 4018.0557568970685, 4027.1140349123148, 5611.523020543136, 5618.606697531133, 5954.345022047658, 5958.702064896825, 5968.731407086779, 5731.713414329351, 5733.283339582552, 5734.967705812994, 5748.87896860125, 5764.164196191445, 5704.60067795267, 5730.0, 5738.368779434342, 5741.822926300182, 5774.0, 5526.806561770319, 5621.74702138413, 5690.890276396063, 5694.487496125369, 5699.575106223444, 5751.8562035949435, 5756.0, 5781.364049954585, 5820.76716931318, 5821.883562328814, 5444.476481173959, 5609.775608975595, 5649.745761440663, 5658.377578466448, 5733.684647344436], "value": 4374.775373384627, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [772.4747171923092, 776.5961699916043, 785.05793048342, 800.8425738245701, 806.3790881021614, 13688.315584220787, 13934.51229206978, 13964.650883727913, 14059.5079172229, 14086.999999999987, 12809.423575939081, 13726.794098088512, 13924.373403196854, 13934.51229206978, 13967.022308438414, 787.8227398835273, 800.2077942836579, 808.7129069180415, 817.5013241922422, 824.4146655874337, 819.2217393476221, 819.6967122164807, 823.1069289820551, 823.2631794543879, 825.4222044568796, 848.1518481518482, 850.4557083466586, 855.3542075732813, 856.07543852639, 857.746964645428, 847.2501835875264, 853.4964371021097, 853.5220276645099, 853.9701110461104, 854.4147259127456, 616.3189675408654, 622.327885883245, 622.5704264057786, 622.9439350458481, 624.4411251929498, 12774.808377874338, 12901.548445804445, 12934.805977910339, 13039.087263891532, 13094.47622095115, 11809.114316426303, 12152.635420937386, 12157.817632735516, 12284.324362160078, 12315.75368492625, 10485.68542943713, 10789.892101078967, 10895.83656245157, 10940.671779846618, 10979.28634638746, 3762.9811850940846, 3804.600516945736, 3826.502554667903, 3827.827747751358, 3872.3997780344093, 48088.0, 48169.277460838115, 48567.028659426964, 48681.5131848684, 48782.7560862197, 9813.264005199639, 9847.55685994132, 9906.157976572073, 10133.240006999504, 10165.847512287322, 15736.449224277096, 15946.122963237134, 16364.099974501278, 16418.83581164197, 16531.256093475822, 7480.1023877134, 7486.737964171337, 7798.454108212484, 7832.0, 8213.54825484604, 4480.865574032719, 4498.752568608758, 4546.88632784183, 4588.747618880993, 4734.644901632391, 3195.3609278144463, 3252.1869532616847, 3261.9836900815344, 3265.559149514785, 3268.509723541488, 588.9558283128697, 598.5032423088826, 599.5892813422819, 610.8320211941663, 612.8958077126899, 574.2821473158551, 615.3907631444927, 630.5995692735146, 652.7323797243107, 684.7911387027004, 8302.0, 8458.450200737056, 8537.487750734852, 8566.229039386486, 8688.956555217184, 625.2059883947361, 625.3746253746253, 654.7773756922669, 667.152716050613, 690.4959379652881, 3910.7849068300948, 4113.0, 4129.595937381305, 4238.109996900624, 4352.086061927031, 60808.695956520816, 61494.38505614976, 61958.0, 62014.0697889532, 65468.34531654623, 54387.0, 54397.0, 55928.72035639796, 56157.0, 57090.42909570851, 49909.25136122961, 50721.0, 50984.0, 51128.99999999926, 53132.734336328074, 8022.478538894953, 8214.459918173889, 8402.789930251793, 8438.873416898874, 8615.612297446505, 33330.83334583312, 33476.0, 33510.0, 34386.0, 36053.63946360503, 46224.30663540117, 47615.52384476111, 48350.0, 48640.75679621579, 49650.503494964585, 12156.574519891761, 12240.449179786752, 12472.937635311766, 12533.37333133358, 12808.807867881802, 13023.544175954175, 13283.136596121221, 13509.797353039909, 13525.323733813073, 13611.659708507366, 11941.104417168573, 12016.579419720269, 12145.066347400767, 12579.496820127093, 12679.492820287454, 12356.62930112098, 12457.439415226156, 13112.475500980236, 13348.599542013755, 13385.531506397228, 10884.782304354027, 12077.879221207675, 12152.513899443924, 12195.390230488263, 12519.248845069325, 9914.900850991686, 10058.698239052841, 10148.79702405933, 10239.232057595858, 10461.738456538647, 10575.735606609896, 10695.400977579404, 10846.644169478815, 11002.889971100507, 11054.723631909266], "value": 6513.470465381532, "unit": "score"}], "name": "dromaeo_css", "value": 6897.42237444597, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 108.0, 114.0, 115.0, 113.0, 126.0, 112.0, 114.0, 113.0, 113.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 129.0, 163.0, 185.0, 132.0, 162.0, 169.0, 132.0, 194.0, 132.0], "value": 155.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 164.0, 163.0, 163.0, 177.0, 162.0, 164.0, 165.0, 164.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 79.0, 166.0, 78.0, 79.0, 79.0, 76.0, 100.0, 80.0], "value": 89.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 147.0, 93.0, 94.0, 94.0, 144.0, 94.0, 94.0, 142.0], "value": 109.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 118.0, 117.0, 119.0, 118.0, 117.0, 118.0, 119.0, 117.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 149.0, 149.0, 148.0, 150.0, 150.0, 148.0, 148.0, 151.0], "value": 149.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 97.0, 95.0, 96.0, 95.0, 96.0, 96.0, 97.0, 97.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 62.0, 58.0, 59.0, 66.0, 59.0, 59.0, 77.0, 58.0, 58.0], "value": 61.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 65.0, 66.0, 65.0, 65.0, 65.0, 66.0, 65.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 77.0, 80.0, 80.0, 78.0, 82.0, 79.0, 80.0, 86.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 126.0, 130.0, 121.0, 122.0, 128.0, 126.0, 125.0, 163.0, 129.0], "value": 129.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 176.0, 176.0, 180.0, 171.0, 168.0, 168.0, 171.0, 169.0, 168.0], "value": 171.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 70.0, 71.0, 70.0, 73.0, 72.0, 69.0, 71.0, 72.0], "value": 71.0, "unit": "score"}], "name": "kraken", "value": 1575.0, "alertThreshold": 2.0}]} 06:35:04 INFO - Return code: 0 06:35:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:35:04 ERROR - # TBPL SUCCESS # 06:35:04 INFO - Running post-action listener: _resource_record_post_action 06:35:04 INFO - Running post-run listener: _resource_record_post_run 06:35:05 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 538984448; Read time: 16; Write time: 466764 06:35:05 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244883456; Read time: 0; Write time: 237420 06:35:05 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294100992; Read time: 16; Write time: 229344 06:35:05 INFO - Running post-run listener: _upload_blobber_files 06:35:05 INFO - Blob upload gear active. 06:35:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:35:05 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:35:05 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'] 06:35:05 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 06:35:05 INFO - (blobuploader) - INFO - Open directory for files ... 06:35:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:35:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:35:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:35:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:35:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:35:06 INFO - (blobuploader) - INFO - Done attempting. 06:35:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:35:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:35:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:35:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:35:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:35:07 INFO - (blobuploader) - INFO - Done attempting. 06:35:07 INFO - (blobuploader) - INFO - Iteration through files over. 06:35:07 INFO - Return code: 0 06:35:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:35:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:35:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce9c4d0c1aa3856a6c34d5389ab658e91a4f45392fe4039a22ccff8006d554ed81a2be85115977c3f13e3ec5e9bb3c9d6f663bdc52d617f6147c63594d082125", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3c007dcecf3eeb86ba4e7877dc054d857dec966c0ffbfe7c989498dbbd713fcf52c482fe4cb044c5ea5fc3a0d5f1aa6239983bbb779ae714896d46ccd0b6fb2"} 06:35:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:35:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:35:07 INFO - Contents: 06:35:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce9c4d0c1aa3856a6c34d5389ab658e91a4f45392fe4039a22ccff8006d554ed81a2be85115977c3f13e3ec5e9bb3c9d6f663bdc52d617f6147c63594d082125", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3c007dcecf3eeb86ba4e7877dc054d857dec966c0ffbfe7c989498dbbd713fcf52c482fe4cb044c5ea5fc3a0d5f1aa6239983bbb779ae714896d46ccd0b6fb2"} 06:35:07 INFO - Running post-run listener: copy_logs_to_upload_dir 06:35:07 INFO - Copying logs to upload dir... 06:35:07 INFO - mkdir: /builds/slave/test/build/upload/logs 06:35:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.117972 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-05-01 06:35:06.328963) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-01 06:35:06.332506) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1462105510.99143-11269107 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/ce9c4d0c1aa3856a6c34d5389ab658e91a4f45392fe4039a22ccff8006d554ed81a2be85115977c3f13e3ec5e9bb3c9d6f663bdc52d617f6147c63594d082125", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3c007dcecf3eeb86ba4e7877dc054d857dec966c0ffbfe7c989498dbbd713fcf52c482fe4cb044c5ea5fc3a0d5f1aa6239983bbb779ae714896d46ccd0b6fb2"} build_url:https://queue.taskcluster.net/v1/task/NCB4KqDvRHmqukG5s9CiXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011343 build_url: 'https://queue.taskcluster.net/v1/task/NCB4KqDvRHmqukG5s9CiXQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce9c4d0c1aa3856a6c34d5389ab658e91a4f45392fe4039a22ccff8006d554ed81a2be85115977c3f13e3ec5e9bb3c9d6f663bdc52d617f6147c63594d082125", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3c007dcecf3eeb86ba4e7877dc054d857dec966c0ffbfe7c989498dbbd713fcf52c482fe4cb044c5ea5fc3a0d5f1aa6239983bbb779ae714896d46ccd0b6fb2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-01 06:35:06.357830) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-01 06:35:06.358302) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1462105510.99143-11269107 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004439 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-01 06:35:06.440092) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-01 06:35:06.440454) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-01 06:35:06.440781) ========= ========= Total master_lag: 0.19 =========