builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-022 starttime: 1464384188.11 results: success (0) buildid: 20160527114145 builduid: ec1b1ec38d4d437c8b02dbf9a69d7c5e revision: 2ab4b64da78750d82f120faa25327f25cf11e579 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 14:23:08.106420) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 14:23:08.106867) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 14:23:08.107152) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 14:23:08.152928) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 14:23:08.153201) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1464383393.798968-462684534 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-27 14:23:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 65.6M=0s 2016-05-27 14:23:08 (65.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.071992 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 14:23:08.243869) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 14:23:08.244190) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1464383393.798968-462684534 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015580 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 14:23:08.297222) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-27 14:23:08.297579) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2ab4b64da78750d82f120faa25327f25cf11e579 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2ab4b64da78750d82f120faa25327f25cf11e579 --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=9c43b49b387003dc8f5b4e5c000001c4-1464383393.798968-462684534 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-27 14:23:08,413 truncating revision to first 12 chars 2016-05-27 14:23:08,413 Setting DEBUG logging. 2016-05-27 14:23:08,413 attempt 1/10 2016-05-27 14:23:08,414 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2ab4b64da787?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-27 14:23:09,295 unpacking tar archive at: mozilla-aurora-2ab4b64da787/testing/mozharness/ program finished with exit code 0 elapsedTime=1.227078 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-27 14:23:09.540444) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 14:23:09.540913) ========= script_repo_revision: 2ab4b64da78750d82f120faa25327f25cf11e579 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 14:23:09.541326) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 14:23:09.541623) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 14:23:09.552455) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-27 14:23:09.552772) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1464383393.798968-462684534 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:23:09 INFO - MultiFileLogger online at 20160527 14:23:09 in /builds/slave/test 14:23:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 14:23:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:23:09 INFO - {'append_to_log': False, 14:23:09 INFO - 'base_work_dir': '/builds/slave/test', 14:23:09 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:23:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:23:09 INFO - 'branch': 'Mozilla-Aurora', 14:23:09 INFO - 'buildbot_json_path': 'buildprops.json', 14:23:09 INFO - 'config_files': ('talos/linux_config.py',), 14:23:09 INFO - 'default_actions': ('clobber', 14:23:09 INFO - 'read-buildbot-config', 14:23:09 INFO - 'download-and-extract', 14:23:09 INFO - 'populate-webroot', 14:23:09 INFO - 'create-virtualenv', 14:23:09 INFO - 'install', 14:23:09 INFO - 'run-tests'), 14:23:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:23:09 INFO - 'download_minidump_stackwalk': True, 14:23:09 INFO - 'download_symbols': 'ondemand', 14:23:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:23:09 INFO - 'tooltool.py': '/tools/tooltool.py', 14:23:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:23:09 INFO - '/tools/misc-python/virtualenv.py')}, 14:23:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:23:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:23:09 INFO - 'installer_path': 'installer.exe', 14:23:09 INFO - 'log_level': 'info', 14:23:09 INFO - 'log_name': 'talos', 14:23:09 INFO - 'log_to_console': True, 14:23:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:23:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:23:09 INFO - 'opt_config_files': (), 14:23:09 INFO - 'pip_index': False, 14:23:09 INFO - 'sps_profile': False, 14:23:09 INFO - 'sps_profile_interval': 0, 14:23:09 INFO - 'suite': 'dromaeojs-e10s', 14:23:09 INFO - 'system_bits': '32', 14:23:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:23:09 INFO - 'title': 'talos-linux64-ix-022', 14:23:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:23:09 INFO - 'use_talos_json': True, 14:23:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:23:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:23:09 INFO - 'work_dir': 'build'} 14:23:09 INFO - ##### 14:23:09 INFO - ##### Running clobber step. 14:23:09 INFO - ##### 14:23:09 INFO - Running pre-action listener: _resource_record_pre_action 14:23:09 INFO - Running main action method: clobber 14:23:09 INFO - rmtree: /builds/slave/test/build 14:23:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:23:10 INFO - Running post-action listener: _resource_record_post_action 14:23:10 INFO - ##### 14:23:10 INFO - ##### Running read-buildbot-config step. 14:23:10 INFO - ##### 14:23:10 INFO - Running pre-action listener: _resource_record_pre_action 14:23:10 INFO - Running main action method: read_buildbot_config 14:23:10 INFO - Using buildbot properties: 14:23:10 INFO - { 14:23:10 INFO - "project": "", 14:23:10 INFO - "product": "firefox", 14:23:10 INFO - "script_repo_revision": "production", 14:23:10 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 14:23:10 INFO - "repository": "", 14:23:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 14:23:10 INFO - "buildid": "20160527114145", 14:23:10 INFO - "pgo_build": "True", 14:23:10 INFO - "basedir": "/builds/slave/test", 14:23:10 INFO - "buildnumber": 296, 14:23:10 INFO - "slavename": "talos-linux64-ix-022", 14:23:10 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:23:10 INFO - "platform": "ubuntu64_hw", 14:23:10 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 14:23:10 INFO - "branch": "mozilla-aurora", 14:23:10 INFO - "repo_path": "releases/mozilla-aurora", 14:23:10 INFO - "revision": "2ab4b64da78750d82f120faa25327f25cf11e579", 14:23:10 INFO - "stage_platform": "linux64-pgo", 14:23:10 INFO - "builduid": "ec1b1ec38d4d437c8b02dbf9a69d7c5e", 14:23:10 INFO - "slavebuilddir": "test" 14:23:10 INFO - } 14:23:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/KVuxwz4DSIqVLwYm2b0dEA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 14:23:10 INFO - Running post-action listener: _resource_record_post_action 14:23:10 INFO - ##### 14:23:10 INFO - ##### Running download-and-extract step. 14:23:10 INFO - ##### 14:23:10 INFO - Running pre-action listener: _resource_record_pre_action 14:23:10 INFO - Running main action method: download_and_extract 14:23:10 INFO - mkdir: /builds/slave/test/build/tests 14:23: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')]} 14:23:10 INFO - https://queue.taskcluster.net/v1/task/KVuxwz4DSIqVLwYm2b0dEA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:23:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVuxwz4DSIqVLwYm2b0dEA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 14:23:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVuxwz4DSIqVLwYm2b0dEA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 14:23:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVuxwz4DSIqVLwYm2b0dEA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 14:23:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVuxwz4DSIqVLwYm2b0dEA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:23:12 INFO - Downloaded 1361 bytes. 14:23:12 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 14:23:12 INFO - Using the following test package requirements: 14:23:12 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 14:23:12 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:23:12 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 14:23:12 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:23:12 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 14:23:12 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:23:12 INFO - u'jsshell-linux-x86_64.zip'], 14:23:12 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:23:12 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 14:23:12 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 14:23:12 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:23:12 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 14:23:12 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:23:12 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 14:23:12 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:23:12 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 14:23:12 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:23:12 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 14:23:12 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:23:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:12 INFO - https://queue.taskcluster.net/v1/task/KVuxwz4DSIqVLwYm2b0dEA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:23:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVuxwz4DSIqVLwYm2b0dEA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 14:23:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVuxwz4DSIqVLwYm2b0dEA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 14:23:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVuxwz4DSIqVLwYm2b0dEA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 14:23:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVuxwz4DSIqVLwYm2b0dEA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:23:18 INFO - Downloaded 24136089 bytes. 14:23:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:23:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:23:19 INFO - Return code: 0 14:23:19 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:23:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:19 INFO - https://queue.taskcluster.net/v1/task/KVuxwz4DSIqVLwYm2b0dEA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:23:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVuxwz4DSIqVLwYm2b0dEA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 14:23:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVuxwz4DSIqVLwYm2b0dEA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 14:23:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVuxwz4DSIqVLwYm2b0dEA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 14:23:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVuxwz4DSIqVLwYm2b0dEA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:23:24 INFO - Downloaded 24136089 bytes. 14:23:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:23:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:23:25 INFO - Return code: 0 14:23:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:25 INFO - https://queue.taskcluster.net/v1/task/KVuxwz4DSIqVLwYm2b0dEA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:23:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVuxwz4DSIqVLwYm2b0dEA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 14:23:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVuxwz4DSIqVLwYm2b0dEA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 14:23:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVuxwz4DSIqVLwYm2b0dEA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 14:23:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVuxwz4DSIqVLwYm2b0dEA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:23:27 INFO - Downloaded 10840145 bytes. 14:23:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:23:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:23:27 INFO - Return code: 0 14:23:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:27 INFO - https://queue.taskcluster.net/v1/task/KVuxwz4DSIqVLwYm2b0dEA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:23:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVuxwz4DSIqVLwYm2b0dEA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 14:23:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVuxwz4DSIqVLwYm2b0dEA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 14:23:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVuxwz4DSIqVLwYm2b0dEA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 14:23:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVuxwz4DSIqVLwYm2b0dEA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:23:29 INFO - Downloaded 62744017 bytes. 14:23:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KVuxwz4DSIqVLwYm2b0dEA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 14:23:29 INFO - mkdir: /builds/slave/test/properties 14:23:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:23:29 INFO - Writing to file /builds/slave/test/properties/build_url 14:23:29 INFO - Contents: 14:23:29 INFO - build_url:https://queue.taskcluster.net/v1/task/KVuxwz4DSIqVLwYm2b0dEA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 14:23:29 INFO - Running post-action listener: _resource_record_post_action 14:23:29 INFO - Running post-action listener: set_extra_try_arguments 14:23:29 INFO - ##### 14:23:29 INFO - ##### Running populate-webroot step. 14:23:29 INFO - ##### 14:23:29 INFO - Running pre-action listener: _resource_record_pre_action 14:23:29 INFO - Running main action method: populate_webroot 14:23:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:23:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:23:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:23:29 INFO - '--tppagecycles', 14:23:29 INFO - '7'], 14:23:29 INFO - 'tests': ['tsvgm']}}, 14:23:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:23:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:23:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:23:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:23:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:23:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:23:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:29 INFO - 'talos_options': ['--disable-e10s'], 14:23:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:23:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:23:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:29 INFO - 'talos_options': ['--disable-e10s'], 14:23:29 INFO - 'tests': ['damp', 'tps']}, 14:23:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:29 INFO - 'tests': ['damp', 'tps']}, 14:23:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:23:29 INFO - 'tests': ['dromaeo_dom']}, 14:23:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:23:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:23:29 INFO - 'tests': ['a11yr', 14:23:29 INFO - 'ts_paint', 14:23:29 INFO - 'tpaint', 14:23:29 INFO - 'sessionrestore', 14:23:29 INFO - 'sessionrestore_no_auto_restore', 14:23:29 INFO - 'tabpaint']}, 14:23:29 INFO - 'other-e10s': {'tests': ['a11yr', 14:23:29 INFO - 'ts_paint', 14:23:29 INFO - 'tpaint', 14:23:29 INFO - 'sessionrestore', 14:23:29 INFO - 'sessionrestore_no_auto_restore', 14:23:29 INFO - 'tabpaint']}, 14:23:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:23:29 INFO - 'ts_paint', 14:23:29 INFO - 'tpaint', 14:23:29 INFO - 'sessionrestore', 14:23:29 INFO - 'sessionrestore_no_auto_restore', 14:23:29 INFO - 'tabpaint']}, 14:23:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:23:29 INFO - 'ts_paint', 14:23:29 INFO - 'tpaint', 14:23:29 INFO - 'sessionrestore', 14:23:29 INFO - 'sessionrestore_no_auto_restore', 14:23:29 INFO - 'tabpaint']}, 14:23:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:23:29 INFO - 'tests': ['a11yr', 14:23:29 INFO - 'ts_paint', 14:23:29 INFO - 'tpaint', 14:23:29 INFO - 'sessionrestore', 14:23:29 INFO - 'sessionrestore_no_auto_restore', 14:23:29 INFO - 'tabpaint']}, 14:23:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:23:29 INFO - 'tests': ['a11yr', 14:23:29 INFO - 'ts_paint', 14:23:29 INFO - 'tpaint', 14:23:29 INFO - 'sessionrestore', 14:23:29 INFO - 'sessionrestore_no_auto_restore', 14:23:29 INFO - 'tabpaint']}, 14:23:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:23:29 INFO - 'tests': ['tsvgx', 14:23:29 INFO - 'tsvgr_opacity', 14:23:29 INFO - 'tart', 14:23:29 INFO - 'tscrollx', 14:23:29 INFO - 'cart']}, 14:23:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:23:29 INFO - 'tsvgr_opacity', 14:23:29 INFO - 'tart', 14:23:29 INFO - 'tscrollx', 14:23:29 INFO - 'cart']}, 14:23:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:29 INFO - 'talos_options': ['--disable-e10s'], 14:23:29 INFO - 'tests': ['tp5o']}, 14:23:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:29 INFO - 'tests': ['tp5o']}, 14:23:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:29 INFO - 'talos_options': ['--disable-e10s', 14:23:29 INFO - '--xperf_path', 14:23:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:23:29 INFO - 'tests': ['tp5n']}, 14:23:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:29 INFO - 'talos_options': ['--xperf_path', 14:23:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:23:29 INFO - 'tests': ['tp5n']}}, 14:23:29 INFO - 'talos.zip': {'path': '', 14:23:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:23:29 INFO - Running post-action listener: _resource_record_post_action 14:23:29 INFO - ##### 14:23:29 INFO - ##### Running create-virtualenv step. 14:23:29 INFO - ##### 14:23:29 INFO - Running pre-action listener: _resource_record_pre_action 14:23:29 INFO - Running main action method: create_virtualenv 14:23:29 INFO - Creating virtualenv /builds/slave/test/build/venv 14:23:29 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:23:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:23:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:23:30 INFO - Using real prefix '/usr' 14:23:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:23:30 INFO - Installing distribute.............................................................................................................................................................................................done. 14:23:32 INFO - Installing pip.................done. 14:23:32 INFO - Return code: 0 14:23:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:23: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')]} 14:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23: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')]} 14:23:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:32 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 0x7fe6fd8d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23da5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2469410>, '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 0x246a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246a7a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1464383393.798968-462684534', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:23:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:23:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:23:32 INFO - Using env: {'DISPLAY': ':0', 14:23:32 INFO - 'HOME': '/home/cltbld', 14:23:32 INFO - 'LANG': 'en_US.UTF-8', 14:23:32 INFO - 'LANGUAGE': 'en_US:en', 14:23:32 INFO - 'LOGNAME': 'cltbld', 14:23:32 INFO - 'MAIL': '/var/mail/cltbld', 14:23:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:32 INFO - 'MOZ_NO_REMOTE': '1', 14:23:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:32 INFO - 'NO_EM_RESTART': '1', 14:23:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:32 INFO - 'PWD': '/builds/slave/test', 14:23:32 INFO - 'SHELL': '/bin/bash', 14:23:32 INFO - 'SHLVL': '1', 14:23:32 INFO - 'TERM': 'linux', 14:23:32 INFO - 'TMOUT': '86400', 14:23:32 INFO - 'USER': 'cltbld', 14:23:32 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464383393.798968-462684534', 14:23:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:32 INFO - '_': '/tools/buildbot/bin/python'} 14:23:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:32 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:23:32 INFO - Cleaning up... 14:23:32 INFO - Return code: 0 14:23:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:23: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')]} 14:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23: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')]} 14:23:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:32 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 0x7fe6fd8d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23da5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2469410>, '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 0x246a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246a7a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1464383393.798968-462684534', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:23:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 14:23:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:23:32 INFO - Using env: {'DISPLAY': ':0', 14:23:32 INFO - 'HOME': '/home/cltbld', 14:23:32 INFO - 'LANG': 'en_US.UTF-8', 14:23:32 INFO - 'LANGUAGE': 'en_US:en', 14:23:32 INFO - 'LOGNAME': 'cltbld', 14:23:32 INFO - 'MAIL': '/var/mail/cltbld', 14:23:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:32 INFO - 'MOZ_NO_REMOTE': '1', 14:23:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:32 INFO - 'NO_EM_RESTART': '1', 14:23:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:32 INFO - 'PWD': '/builds/slave/test', 14:23:32 INFO - 'SHELL': '/bin/bash', 14:23:32 INFO - 'SHLVL': '1', 14:23:32 INFO - 'TERM': 'linux', 14:23:32 INFO - 'TMOUT': '86400', 14:23:32 INFO - 'USER': 'cltbld', 14:23:32 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464383393.798968-462684534', 14:23:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:32 INFO - '_': '/tools/buildbot/bin/python'} 14:23:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:32 INFO - Downloading/unpacking psutil>=0.7.1 14:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:23:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:23:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:23:35 INFO - Installing collected packages: psutil 14:23:35 INFO - Running setup.py install for psutil 14:23:35 INFO - building 'psutil._psutil_linux' extension 14:23:35 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:23:35 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:23:35 INFO - building 'psutil._psutil_posix' extension 14:23:35 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:23:35 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:23:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:23:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:23:35 INFO - Successfully installed psutil 14:23:35 INFO - Cleaning up... 14:23:35 INFO - Return code: 0 14:23:35 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:23: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')]} 14:23:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23: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')]} 14:23:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:35 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 0x7fe6fd8d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23da5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2469410>, '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 0x246a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246a7a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1464383393.798968-462684534', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:23:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:23:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:23:35 INFO - Using env: {'DISPLAY': ':0', 14:23:35 INFO - 'HOME': '/home/cltbld', 14:23:35 INFO - 'LANG': 'en_US.UTF-8', 14:23:35 INFO - 'LANGUAGE': 'en_US:en', 14:23:35 INFO - 'LOGNAME': 'cltbld', 14:23:35 INFO - 'MAIL': '/var/mail/cltbld', 14:23:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:35 INFO - 'MOZ_NO_REMOTE': '1', 14:23:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:35 INFO - 'NO_EM_RESTART': '1', 14:23:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:35 INFO - 'PWD': '/builds/slave/test', 14:23:35 INFO - 'SHELL': '/bin/bash', 14:23:35 INFO - 'SHLVL': '1', 14:23:35 INFO - 'TERM': 'linux', 14:23:35 INFO - 'TMOUT': '86400', 14:23:35 INFO - 'USER': 'cltbld', 14:23:35 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464383393.798968-462684534', 14:23:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:35 INFO - '_': '/tools/buildbot/bin/python'} 14:23:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:23:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:37 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:23:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:23:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:23:37 INFO - Installing collected packages: mozsystemmonitor 14:23:37 INFO - Running setup.py install for mozsystemmonitor 14:23:37 INFO - Successfully installed mozsystemmonitor 14:23:37 INFO - Cleaning up... 14:23:37 INFO - Return code: 0 14:23:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:23:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:37 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 0x7fe6fd8d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23da5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2469410>, '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 0x246a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246a7a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1464383393.798968-462684534', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:23:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:23:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:23:37 INFO - Using env: {'DISPLAY': ':0', 14:23:37 INFO - 'HOME': '/home/cltbld', 14:23:37 INFO - 'LANG': 'en_US.UTF-8', 14:23:37 INFO - 'LANGUAGE': 'en_US:en', 14:23:37 INFO - 'LOGNAME': 'cltbld', 14:23:37 INFO - 'MAIL': '/var/mail/cltbld', 14:23:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:37 INFO - 'MOZ_NO_REMOTE': '1', 14:23:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:37 INFO - 'NO_EM_RESTART': '1', 14:23:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:37 INFO - 'PWD': '/builds/slave/test', 14:23:37 INFO - 'SHELL': '/bin/bash', 14:23:37 INFO - 'SHLVL': '1', 14:23:37 INFO - 'TERM': 'linux', 14:23:37 INFO - 'TMOUT': '86400', 14:23:37 INFO - 'USER': 'cltbld', 14:23:37 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464383393.798968-462684534', 14:23:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:37 INFO - '_': '/tools/buildbot/bin/python'} 14:23:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:38 INFO - Downloading/unpacking blobuploader==1.2.4 14:23:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:39 INFO - Downloading blobuploader-1.2.4.tar.gz 14:23:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:23:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:23:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:23:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:23:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:40 INFO - Downloading docopt-0.6.1.tar.gz 14:23:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:23:40 INFO - Installing collected packages: blobuploader, requests, docopt 14:23:40 INFO - Running setup.py install for blobuploader 14:23:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:23:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:23:40 INFO - Running setup.py install for requests 14:23:41 INFO - Running setup.py install for docopt 14:23:41 INFO - Successfully installed blobuploader requests docopt 14:23:41 INFO - Cleaning up... 14:23:41 INFO - Return code: 0 14:23:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:23:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:41 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 0x7fe6fd8d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23da5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2469410>, '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 0x246a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246a7a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1464383393.798968-462684534', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:23:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:23:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:23:41 INFO - Using env: {'DISPLAY': ':0', 14:23:41 INFO - 'HOME': '/home/cltbld', 14:23:41 INFO - 'LANG': 'en_US.UTF-8', 14:23:41 INFO - 'LANGUAGE': 'en_US:en', 14:23:41 INFO - 'LOGNAME': 'cltbld', 14:23:41 INFO - 'MAIL': '/var/mail/cltbld', 14:23:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:41 INFO - 'MOZ_NO_REMOTE': '1', 14:23:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:41 INFO - 'NO_EM_RESTART': '1', 14:23:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:41 INFO - 'PWD': '/builds/slave/test', 14:23:41 INFO - 'SHELL': '/bin/bash', 14:23:41 INFO - 'SHLVL': '1', 14:23:41 INFO - 'TERM': 'linux', 14:23:41 INFO - 'TMOUT': '86400', 14:23:41 INFO - 'USER': 'cltbld', 14:23:41 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464383393.798968-462684534', 14:23:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:41 INFO - '_': '/tools/buildbot/bin/python'} 14:23:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:23:41 INFO - Running setup.py (path:/tmp/pip-ndi0Bd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:23:41 INFO - Running setup.py (path:/tmp/pip-6326yA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:23:41 INFO - Running setup.py (path:/tmp/pip-JfBZKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:23:41 INFO - Running setup.py (path:/tmp/pip-zNthdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:23:41 INFO - Running setup.py (path:/tmp/pip-KMYGJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:23:41 INFO - Running setup.py (path:/tmp/pip-HmkOqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:23:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:23:42 INFO - Running setup.py (path:/tmp/pip-9RxTZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:23:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:23:42 INFO - Running setup.py (path:/tmp/pip-63vBGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:23:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:23:42 INFO - Running setup.py (path:/tmp/pip-eYnGrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:23:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:23:42 INFO - Running setup.py (path:/tmp/pip-TbSxvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:23:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:23:42 INFO - Running setup.py (path:/tmp/pip-8UhIv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:23:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:23:42 INFO - Running setup.py (path:/tmp/pip-eEzq0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:23:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:23:42 INFO - Running setup.py (path:/tmp/pip-8rLuYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:23:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:23:42 INFO - Running setup.py (path:/tmp/pip-wFGMYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:23:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:23:42 INFO - Running setup.py (path:/tmp/pip-ijf9qk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:23:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:23:42 INFO - Running setup.py (path:/tmp/pip-il7PI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:23:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:23:42 INFO - Running setup.py (path:/tmp/pip-_5183Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:23:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:23:42 INFO - Running setup.py install for manifestparser 14:23:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:23:42 INFO - Running setup.py install for mozcrash 14:23:43 INFO - Running setup.py install for mozdebug 14:23:43 INFO - Running setup.py install for mozdevice 14:23:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:23:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:23:43 INFO - Running setup.py install for mozfile 14:23:43 INFO - Running setup.py install for mozhttpd 14:23:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:23:43 INFO - Running setup.py install for mozinfo 14:23:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:23:43 INFO - Running setup.py install for mozInstall 14:23:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:23:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:23:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:23:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:23:43 INFO - Running setup.py install for mozleak 14:23:43 INFO - Running setup.py install for mozlog 14:23:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:23:43 INFO - Running setup.py install for moznetwork 14:23:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:23:43 INFO - Running setup.py install for mozprocess 14:23:44 INFO - Running setup.py install for mozprofile 14:23:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:23:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:23:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:23:44 INFO - Running setup.py install for mozrunner 14:23:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:23:44 INFO - Running setup.py install for mozscreenshot 14:23:44 INFO - Running setup.py install for moztest 14:23:44 INFO - Running setup.py install for mozversion 14:23:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:23:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:23:44 INFO - Cleaning up... 14:23:44 INFO - Return code: 0 14:23:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:23:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:44 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 0x7fe6fd8d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23da5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2469410>, '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 0x246a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246a7a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1464383393.798968-462684534', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:23:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:23:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:23:44 INFO - Using env: {'DISPLAY': ':0', 14:23:44 INFO - 'HOME': '/home/cltbld', 14:23:44 INFO - 'LANG': 'en_US.UTF-8', 14:23:44 INFO - 'LANGUAGE': 'en_US:en', 14:23:44 INFO - 'LOGNAME': 'cltbld', 14:23:44 INFO - 'MAIL': '/var/mail/cltbld', 14:23:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:44 INFO - 'MOZ_NO_REMOTE': '1', 14:23:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:44 INFO - 'NO_EM_RESTART': '1', 14:23:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:44 INFO - 'PWD': '/builds/slave/test', 14:23:44 INFO - 'SHELL': '/bin/bash', 14:23:44 INFO - 'SHLVL': '1', 14:23:44 INFO - 'TERM': 'linux', 14:23:44 INFO - 'TMOUT': '86400', 14:23:44 INFO - 'USER': 'cltbld', 14:23:44 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464383393.798968-462684534', 14:23:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:44 INFO - '_': '/tools/buildbot/bin/python'} 14:23:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:23:44 INFO - Running setup.py (path:/tmp/pip-KAp0a6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:23:44 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:23:44 INFO - Running setup.py (path:/tmp/pip-wqAFUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:23:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:23:44 INFO - Running setup.py (path:/tmp/pip-y7El3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:23:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:23:45 INFO - Running setup.py (path:/tmp/pip-TTwyFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:23:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:23:45 INFO - Running setup.py (path:/tmp/pip-biUwIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:23:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:23:45 INFO - Running setup.py (path:/tmp/pip-qtEFY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:23:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:23:45 INFO - Running setup.py (path:/tmp/pip-khyQsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:23:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:23:45 INFO - Running setup.py (path:/tmp/pip-H105TK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:23:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:23:45 INFO - Running setup.py (path:/tmp/pip-SLvf1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:23:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:23:45 INFO - Running setup.py (path:/tmp/pip-pAeZqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:23:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:23:45 INFO - Running setup.py (path:/tmp/pip-cPbW71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:23:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:23:45 INFO - Running setup.py (path:/tmp/pip-ufmtY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:23:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:23:45 INFO - Running setup.py (path:/tmp/pip-p3pIIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:23:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:23:45 INFO - Running setup.py (path:/tmp/pip-shhMx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:23:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:23:45 INFO - Running setup.py (path:/tmp/pip-Bv0Z0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:23:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:23:45 INFO - Running setup.py (path:/tmp/pip-o_Zd8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:23:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:23:45 INFO - Running setup.py (path:/tmp/pip-UmhOmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:23:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:23:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:23:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:23:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:23:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:23:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:23:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:23:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:47 INFO - Downloading blessings-1.6.tar.gz 14:23:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:23:48 INFO - Installing collected packages: blessings 14:23:48 INFO - Running setup.py install for blessings 14:23:48 INFO - Successfully installed blessings 14:23:48 INFO - Cleaning up... 14:23:48 INFO - Return code: 0 14:23:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:23:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:23:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:23:48 INFO - Reading from file tmpfile_stdout 14:23:48 INFO - Current package versions: 14:23:48 INFO - argparse == 1.2.1 14:23:48 INFO - blessings == 1.6 14:23:48 INFO - blobuploader == 1.2.4 14:23:48 INFO - docopt == 0.6.1 14:23:48 INFO - manifestparser == 1.1 14:23:48 INFO - mozInstall == 1.12 14:23:48 INFO - mozcrash == 0.17 14:23:48 INFO - mozdebug == 0.1 14:23:48 INFO - mozdevice == 0.48 14:23:48 INFO - mozfile == 1.2 14:23:48 INFO - mozhttpd == 0.7 14:23:48 INFO - mozinfo == 0.9 14:23:48 INFO - mozleak == 0.1 14:23:48 INFO - mozlog == 3.1 14:23:48 INFO - moznetwork == 0.27 14:23:48 INFO - mozprocess == 0.22 14:23:48 INFO - mozprofile == 0.28 14:23:48 INFO - mozrunner == 6.11 14:23:48 INFO - mozscreenshot == 0.1 14:23:48 INFO - mozsystemmonitor == 0.0 14:23:48 INFO - moztest == 0.7 14:23:48 INFO - mozversion == 1.4 14:23:48 INFO - psutil == 3.1.1 14:23:48 INFO - requests == 1.2.3 14:23:48 INFO - wsgiref == 0.1.2 14:23:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:23: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')]} 14:23:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23: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')]} 14:23:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:48 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 0x7fe6fd8d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23da5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2469410>, '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 0x246a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246a7a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1464383393.798968-462684534', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:23:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:23:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:23:48 INFO - Using env: {'DISPLAY': ':0', 14:23:48 INFO - 'HOME': '/home/cltbld', 14:23:48 INFO - 'LANG': 'en_US.UTF-8', 14:23:48 INFO - 'LANGUAGE': 'en_US:en', 14:23:48 INFO - 'LOGNAME': 'cltbld', 14:23:48 INFO - 'MAIL': '/var/mail/cltbld', 14:23:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:48 INFO - 'MOZ_NO_REMOTE': '1', 14:23:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:48 INFO - 'NO_EM_RESTART': '1', 14:23:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:48 INFO - 'PWD': '/builds/slave/test', 14:23:48 INFO - 'SHELL': '/bin/bash', 14:23:48 INFO - 'SHLVL': '1', 14:23:48 INFO - 'TERM': 'linux', 14:23:48 INFO - 'TMOUT': '86400', 14:23:48 INFO - 'USER': 'cltbld', 14:23:48 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464383393.798968-462684534', 14:23:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:48 INFO - '_': '/tools/buildbot/bin/python'} 14:23:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:23:48 INFO - Cleaning up... 14:23:48 INFO - Return code: 0 14:23:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:23: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')]} 14:23:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23: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')]} 14:23:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:48 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 0x7fe6fd8d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23da5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2469410>, '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 0x246a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246a7a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1464383393.798968-462684534', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:23:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:23:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:23:48 INFO - Using env: {'DISPLAY': ':0', 14:23:48 INFO - 'HOME': '/home/cltbld', 14:23:48 INFO - 'LANG': 'en_US.UTF-8', 14:23:48 INFO - 'LANGUAGE': 'en_US:en', 14:23:48 INFO - 'LOGNAME': 'cltbld', 14:23:48 INFO - 'MAIL': '/var/mail/cltbld', 14:23:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:48 INFO - 'MOZ_NO_REMOTE': '1', 14:23:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:48 INFO - 'NO_EM_RESTART': '1', 14:23:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:48 INFO - 'PWD': '/builds/slave/test', 14:23:48 INFO - 'SHELL': '/bin/bash', 14:23:48 INFO - 'SHLVL': '1', 14:23:48 INFO - 'TERM': 'linux', 14:23:48 INFO - 'TMOUT': '86400', 14:23:48 INFO - 'USER': 'cltbld', 14:23:48 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464383393.798968-462684534', 14:23:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:48 INFO - '_': '/tools/buildbot/bin/python'} 14:23:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:48 INFO - Downloading/unpacking jsonschema 14:23:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:23:50 INFO - Downloading/unpacking functools32 (from jsonschema) 14:23:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:50 INFO - Downloading functools32-3.2.3-2.tar.gz 14:23:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:23:50 INFO - warning: no files found matching '*.txt' 14:23:50 INFO - no previously-included directories found matching 'build' 14:23:50 INFO - no previously-included directories found matching 'dist' 14:23:50 INFO - no previously-included directories found matching '.git*' 14:23:51 INFO - Installing collected packages: jsonschema, functools32 14:23:51 INFO - Running setup.py install for functools32 14:23:51 INFO - warning: no files found matching '*.txt' 14:23:51 INFO - no previously-included directories found matching 'build' 14:23:51 INFO - no previously-included directories found matching 'dist' 14:23:51 INFO - no previously-included directories found matching '.git*' 14:23:51 INFO - Successfully installed jsonschema functools32 14:23:51 INFO - Cleaning up... 14:23:51 INFO - Return code: 0 14:23:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:23:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:51 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 0x7fe6fd8d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23da5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2469410>, '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 0x246a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246a7a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1464383393.798968-462684534', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:23:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:23:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:23:51 INFO - Using env: {'DISPLAY': ':0', 14:23:51 INFO - 'HOME': '/home/cltbld', 14:23:51 INFO - 'LANG': 'en_US.UTF-8', 14:23:51 INFO - 'LANGUAGE': 'en_US:en', 14:23:51 INFO - 'LOGNAME': 'cltbld', 14:23:51 INFO - 'MAIL': '/var/mail/cltbld', 14:23:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:51 INFO - 'MOZ_NO_REMOTE': '1', 14:23:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:51 INFO - 'NO_EM_RESTART': '1', 14:23:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:51 INFO - 'PWD': '/builds/slave/test', 14:23:51 INFO - 'SHELL': '/bin/bash', 14:23:51 INFO - 'SHLVL': '1', 14:23:51 INFO - 'TERM': 'linux', 14:23:51 INFO - 'TMOUT': '86400', 14:23:51 INFO - 'USER': 'cltbld', 14:23:51 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464383393.798968-462684534', 14:23:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:51 INFO - '_': '/tools/buildbot/bin/python'} 14:23:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:51 INFO - Downloading/unpacking flake8 14:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:23:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:23:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:23:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:23:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:23:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:23:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:23:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:23:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:23:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:23:54 INFO - no previously-included directories found matching 'docs/_build' 14:23:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:23:54 INFO - Running setup.py install for pep8 14:23:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:23:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:23:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:23:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:23:54 INFO - no previously-included directories found matching 'docs/_build' 14:23:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:23:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:23:54 INFO - Cleaning up... 14:23:54 INFO - Return code: 0 14:23:54 INFO - Running post-action listener: _resource_record_post_action 14:23:54 INFO - Running post-action listener: _start_resource_monitoring 14:23:54 INFO - Starting resource monitoring. 14:23:54 INFO - ##### 14:23:54 INFO - ##### Running install step. 14:23:54 INFO - ##### 14:23:54 INFO - Running pre-action listener: _resource_record_pre_action 14:23:54 INFO - Running main action method: install 14:23:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:23:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:23:54 INFO - Reading from file tmpfile_stdout 14:23:54 INFO - Detecting whether we're running mozinstall >=1.0... 14:23:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:23:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:23:54 INFO - Reading from file tmpfile_stdout 14:23:54 INFO - Output received: 14:23:54 INFO - Usage: mozinstall [options] installer 14:23:54 INFO - Options: 14:23:54 INFO - -h, --help show this help message and exit 14:23:54 INFO - -d DEST, --destination=DEST 14:23:54 INFO - Directory to install application into. [default: 14:23:54 INFO - "/builds/slave/test"] 14:23:54 INFO - --app=APP Application being installed. [default: firefox] 14:23:54 INFO - mkdir: /builds/slave/test/build/application 14:23:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:23:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:24:10 INFO - Reading from file tmpfile_stdout 14:24:10 INFO - Output received: 14:24:10 INFO - /builds/slave/test/build/application/firefox/firefox 14:24:10 INFO - Running post-action listener: _resource_record_post_action 14:24:10 INFO - ##### 14:24:10 INFO - ##### Running run-tests step. 14:24:10 INFO - ##### 14:24:10 INFO - Running pre-action listener: _resource_record_pre_action 14:24:10 INFO - Running main action method: run_tests 14:24:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:24:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:24:10 INFO - Python 2.7.3 14:24:10 INFO - Return code: 0 14:24:10 INFO - grabbing minidump binary from tooltool 14:24: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')]} 14:24:10 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 0x2469410>, '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 0x246a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246a7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:24:10 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:24:10 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:24:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:24:10 INFO - Return code: 0 14:24:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:24:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:24:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:24:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:24:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:24:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:24:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:24:11 INFO - Return code: 0 14:24:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KVuxwz4DSIqVLwYm2b0dEA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:24:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KVuxwz4DSIqVLwYm2b0dEA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:24:11 INFO - Using env: {'DISPLAY': ':0', 14:24:11 INFO - 'HOME': '/home/cltbld', 14:24:11 INFO - 'LANG': 'en_US.UTF-8', 14:24:11 INFO - 'LANGUAGE': 'en_US:en', 14:24:11 INFO - 'LOGNAME': 'cltbld', 14:24:11 INFO - 'MAIL': '/var/mail/cltbld', 14:24:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:24:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:24:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:11 INFO - 'MOZ_NO_REMOTE': '1', 14:24:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:24:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:11 INFO - 'NO_EM_RESTART': '1', 14:24:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:11 INFO - 'PWD': '/builds/slave/test', 14:24:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:24:11 INFO - 'SHELL': '/bin/bash', 14:24:11 INFO - 'SHLVL': '1', 14:24:11 INFO - 'TERM': 'linux', 14:24:11 INFO - 'TMOUT': '86400', 14:24:11 INFO - 'USER': 'cltbld', 14:24:11 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1464383393.798968-462684534', 14:24:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:11 INFO - '_': '/tools/buildbot/bin/python'} 14:24:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KVuxwz4DSIqVLwYm2b0dEA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:24:11 INFO - mozversion application_buildid: 20160527114145 14:24:11 INFO - mozversion application_changeset: 2ab4b64da78750d82f120faa25327f25cf11e579 14:24:11 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:24:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:24:11 INFO - mozversion application_name: Firefox 14:24:11 INFO - mozversion application_remotingname: firefox-dev 14:24:11 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:24:11 INFO - mozversion application_vendor: Mozilla 14:24:11 INFO - mozversion application_version: 48.0a2 14:24:11 INFO - mozversion platform_buildid: 20160527114145 14:24:11 INFO - mozversion platform_changeset: 2ab4b64da78750d82f120faa25327f25cf11e579 14:24:11 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:24:11 INFO - mozversion platform_version: 48.0a2 14:24:11 INFO - using testdate: 1464384251 14:24:11 INFO - actual date: 1464384251 14:24:11 INFO - starting webserver on 'localhost:39291' 14:24:11 INFO - SUITE-START | Running 2 tests 14:24:11 INFO - TEST-START | dromaeo_css 14:24:11 INFO - operating with platform_type : linux_ 14:24:11 INFO - Initialising browser for dromaeo_css test... 14:24:11 INFO - TEST-INFO | started process 21982 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmC21zU/profile http://localhost:39291/getInfo.html) 14:24:15 INFO - PROCESS | 21982 | 14:24:15 INFO - PROCESS | 21982 | (process:22061): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:24:16 INFO - PROCESS | 21982 | __metrics Screen width/height:1600/1200 14:24:16 INFO - PROCESS | 21982 | colorDepth:24 14:24:16 INFO - PROCESS | 21982 | Browser inner width/height: 1024/697 14:24:16 INFO - PROCESS | 21982 | __metrics 14:24:17 ERROR - PROCESS | 21982 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 14:24:17 INFO - TEST-INFO | 21982: exit 0 14:24:17 INFO - Browser initialized. 14:24:17 INFO - Running cycle 1/1 for dromaeo_css test... 14:24:17 INFO - TEST-INFO | started process 22112 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmC21zU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:24:19 INFO - PROCESS | 22112 | 14:24:19 INFO - PROCESS | 22112 | (process:22182): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:24:29 INFO - PROCESS | 22112 | RSS: Main: 152174592 14:24:29 INFO - PROCESS | 22112 | 14:25:19 INFO - PROCESS | 22112 | 1464384319441 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:27:27 INFO - PROCESS | 22112 | Cycle 1(1): loaded http://localhost:39291/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39291/tests/dromaeo/cssquery-ext.html) 14:27:28 INFO - PROCESS | 22112 | RSS: Main: 156479488 14:27:28 INFO - PROCESS | 22112 | 14:30:29 INFO - PROCESS | 22112 | Cycle 1(1): loaded http://localhost:39291/tests/dromaeo/cssquery-ext.html (next: http://localhost:39291/tests/dromaeo/cssquery-jquery.html) 14:30:30 INFO - PROCESS | 22112 | RSS: Main: 153452544 14:30:30 INFO - PROCESS | 22112 | 14:33:32 INFO - PROCESS | 22112 | Cycle 1(1): loaded http://localhost:39291/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39291/tests/dromaeo/cssquery-mootools.html) 14:33:32 INFO - PROCESS | 22112 | RSS: Main: 152616960 14:33:32 INFO - PROCESS | 22112 | 14:36:34 INFO - PROCESS | 22112 | Cycle 1(1): loaded http://localhost:39291/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39291/tests/dromaeo/cssquery-prototype.html) 14:36:35 INFO - PROCESS | 22112 | RSS: Main: 152723456 14:36:35 INFO - PROCESS | 22112 | 14:39:37 INFO - PROCESS | 22112 | Cycle 1(1): loaded http://localhost:39291/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39291/tests/dromaeo/cssquery-yui.html) 14:39:38 INFO - PROCESS | 22112 | RSS: Main: 154202112 14:39:38 INFO - PROCESS | 22112 | 14:42:40 INFO - PROCESS | 22112 | Cycle 1(1): loaded http://localhost:39291/tests/dromaeo/cssquery-yui.html (next: http://localhost:39291/tests/dromaeo/cssquery-dojo.html) 14:42:40 INFO - PROCESS | 22112 | RSS: Main: 155774976 14:42:40 INFO - PROCESS | 22112 | 14:42:40 INFO - PROCESS | 22112 | __start_tp_report 14:42:40 INFO - PROCESS | 22112 | _x_x_mozilla_page_load 14:42:40 INFO - PROCESS | 22112 | _x_x_mozilla_page_load_details 14:42:40 INFO - PROCESS | 22112 | |i|pagename|runs| 14:42:40 INFO - PROCESS | 22112 | |0;dojo.html;3385.1706331948667;3423.7945723256607;3444.448888177891;3472.288180922911;3508.3860324443217;5764.913526297109;5785.334686511047;5789.478946894778;5792.449717276862;5807.970960145199;5702.971485142579;5759.68321742304;5828.504577110951;5835.679037652927;5863.296404431463;5090.31280777095;5216.634835561512;5252.921206181911;5261.684298942057;5296.205569164617;5086.898262034757;5282.418933917266;5328.49379308965;5333.333333333333;5406.08096623575;5159.071367153911;5171.327727395452;5181.455947125554;5269.077911365515;5274.393444753845;5119.667221630601;5174.948250517485;5204;5211.661242019257;5216.826214101835;5138.97430512845;5172.948270517284;5201.089809283398;5235.633505654606;5262.842174721555;5464.590155738336;5546.389897111315;5626.240457538262;5635.802746903839;5684.204211410406;6151.200343955257;6162.383761623847;6165.290991535986;6168.691565421711;6185.8144255672405;6198.243914133616;6221.875562488724;6229.25248970122;6236.345183755686;6247.687615619201;5640.5769567282205;5675.829725108253;5711.657300561938;5763.88472230553;5788.623739456922;6222.253329600477;6229.719662615194;6260.060990851318;6266.905996409966;6282.717277722513;6015.759369625166;6025.8192254232445;6028.728707208098;6036.366181550961;6046.788362407295;6098.207233059674;6140.8771824563255;6167.907481387782;6169.907451388232;6182.072689096672;6107.938920610826;6119.342652247476;6120.08198770188;6134.110553969738;6144.846378840475;5817.0983497557945;6054.122152287893;6114.358196333954;6124.441964285689;6137.263528376623;4565.383673204141;4574.565416285448;4574.7941342639;4589;4602.470715867651;4104.630583247522;4108.239975604522;4109.465769449952;4114.053767633461;4146;5850.970745146247;5874.530037596982;5917.349091599921;5980.342162362137;6001.819945401645;6087.786927457518;6112.716259964451;6148.661823599656;6151.72317245725;6214.906776398358;5880.8235752927485;5880.882382352329;5902.1146827976145;5938.079597662369;5948.881022379528;5194.974025129925;5207.869803254949;5288.814891478857;5315.069862773999;5347.465253474699;6322.525810564226;6383.616982981036;6403.519736019724;6419.454346380517;6447.967760161263;6002.849928751816;6208.165498035633;6223.906641400473;6233.407826256498;6272.2159730033745;6358.395952384516;6418.4544313731985;6458.063580780855;6474.611523308617;6477.611343319228;6002.669853157943;6004.459598636144;6006.489448396936;6006.579539432198;6007.249093863267;5968.373320801254;6107.450329470369;6119.602225855483;6122.234720659918;6138.723757430837;6044.184035155374;6063.514918806397;6066.241719785027;6074.696265186812;6087.969560152171;5995.91006134917;6011.128386384037;6038;6042.1843051187525;6044.214252147369;5825.330087040044;5839.970800145972;5875.706214689334;5919.082542205965;5957.49361304294;5969.313528944227;6095.05526643371;6096.116063170904;6101.023836186189;6129.2032035835055;5878.529717622666;5929.258842644669;5940.821775346746;5949.3753155918;5960.672163031075 14:42:40 INFO - PROCESS | 22112 | |1;ext.html;655.8557117434166;677.2989955396165;687.5943193515825;706.8303607134286;727.7962170592234;39618.80190599047;40129.59870401295;40323.59676403235;40323.79838100809;40367.19265614686;43919.3412098818;44622.55377446225;44663.33005004928;44691.553084469146;44894.55105448944;8913.643454261837;9004.549772511382;9054.049324820899;9084.682036128737;9089.27285817133;8689.695860644879;8692.956535217316;8753.518556479392;8772.254358379545;8772.605232764508;8831.867521987175;8858.981217160012;8859.645614175426;8862;8883.600237989305;8809.075047120055;8810.0308966014;8837;8851.911480885174;8853.11468853116;9192.770180745469;9219.815603687955;9261.768455788591;9274.582643781046;9278.443293402417;43562.782186089185;44133.558664413584;44237.77881110606;44246;44248;3790.7156963227867;3792.1657235408443;3843.26977874203;4098.938515922234;4472.9776351118035;33130.171745706306;34799.13002174966;34843.477347839806;35128.47307290393;35286.11784705377;4406.867793966187;4449.243628583116;4494.842680506199;4500.572445617661;4508.661850361236;336010;336121.99999999756;337546;338106;339198;63418.36581634217;64021.679891600244;64206.35793642004;64251.678741605996;64265.35734642687;67907.32092679109;71925;73377.6331118341;73675.63162184154;73707.26292737004;18675.71986420205;18980.905095474434;18998.620027599645;18999.905000474908;19038.33365832189;14741.55775326742;14799.260036998106;14810.259487025605;14838.40646374133;14899.47851825181;20664.793352066587;20713.067911944;20861.165553377694;20909.26817561378;20953;8005.279524842792;8036.397270204758;8274.131216222331;8323;8344.207300306462;1148.6841118692425;1170.1107158559387;1196.6589521986193;1214.3806658604176;1222.9938850305691;33946.49080263798;34129.14677133092;34303.31393372118;34532.30935381278;34586.30827383438;1219.9939000304942;1257.7107265329025;1303.5046682260681;1303.9608811735473;1307.091571357916;17503.38738144159;17811;17813.643727125385;17910.5522361942;18033.18850651724;513160;573279;578244;581581;600499;58926.410735892096;60041.69979150076;60080.39919600748;60202;60587.39412605818;1511.4181040299563;1520.3006616956102;1527.1295361643756;1534.501287081703;1539.907605543671;31917.68082319147;33223.66776332302;33972.49041264432;34482;34947.30105397929;56876.431235687116;57732;57749.422505774404;57789.4221057784;57812.71093644505;462189;465734;466057;467286;467513;31567.36865262728;48618.5138148614;48684.513154868;49268;49273.753631231615;45429;45817.77091114523;46280.53719462897;46310.30534542052;46929.530704692515;38189;38636.03409914662;38781.80609096937;39038.414423784234;39076.21847562976;42390.78804606081;42581;42596.57403425926;43031.35452968271;43916.341254880565;42925.14149716926;43433.78283108564;43889.34165987577;44387.33418998782;44808;36488.452673209395;36560.45159322665;36816;37085.62914370822;37461.81269093746;29298.414031719672;29313.56029659514;29733.25666858259;29817.552736708534;29859.552106717983 14:42:40 INFO - PROCESS | 22112 | |2;jquery.html;425.1030326012115;427.482745877488;428.36601829292664;440.4582363692658;442.14665695208254;18265.26938922443;19129.330473433434;19141;20855.895720521414;21817.563648727017;18971.71542426865;19571.5107122322;19641.41075767726;19713.507162320948;19913.701294480557;5044.924326135102;5246.973765131169;5298.682079075248;5305.310309659739;5306.336707911511;5135.281060651511;5224.138017227172;5236.502532259448;5610.579206559504;5838.153467747175;5797.36229014808;5799.608094057438;5843.912341314884;5860.501857342131;5891.528677705774;5742.598018138732;6012.098185272201;6039.879202415971;6041.3052498962525;6048.485878700316;5829.125631155361;5858.648481091105;5862.179294898718;5878.353381128072;5886.558508111866;14153.787693184611;14395.064320819218;14547.927260363631;14548.70902581953;14570.562883113524;2383.1420688552107;2491.352248415407;2712.8372297662204;2940.6765255821842;3104.58088158098;10884.782304353948;10988.450577471094;11225.38260395678;11301.660950171508;13371.197728136343;2057.40335302762;2063.7833027532192;2147.302126808793;2156.083664442606;2162.6647869580083;78006;78751.606241969;79025.60487197584;82379.58810206031;83271;11375.544978200945;11435.341875428016;11667;11894.286342819458;12028.45871935765;16492.17539123039;16590.50228493147;16607;16642.417515386904;16679.583010424838;8401.453905496122;8778.648854045767;8796.296296296281;9012.27901767857;9029.548522573845;8449.197326253996;8478.3641226907;8493.27807136388;8531.018932822804;8758.255548278468;4956.330895329156;4990.953708979301;5074.67014644047;5090.516400941905;5104.872378190575;2129.5527939132644;2142.30375128084;2148.7206663133693;2175.140819376369;2177.608030554484;901.7880798012462;1038.8753349597946;1121.1647322744607;1123.185690374472;1181.8699943006263;18786.90606546986;19523.121459534355;19688.409347719593;19692.212311507665;20024.299149529696;1063.1335461598771;1088.3198001249218;1094.2777766673958;1103.646833013428;1110.9222354435112;10955.34267943926;11155;11193.49629266685;11193.94403027996;11270.154738394653;466892;474106;478776;496585;516156;93515;99607;100249.49875250724;100416.49791750994;100607.49696251472;1122.5004872831512;1122.5678113926033;1131.2420678145497;1135.2167004766684;1146.4611632532697;16961.830381696025;17123.65752684964;17237.39669111575;17294.394696185573;17573.209205585525;38811.41782873316;39171.2165756689;39719;40547.1890562193;40568.391474128504;54068.72965635147;59772.70113649578;61958.69020654868;62031.689841550506;62257;8395.874061889199;8415.95792021036;8699.478031318142;8715.302775777796;8897.688580899638;12377.752444950871;13081.934590326988;13110.737785244433;13115.672108197372;13218.206907585576;8455.196756308142;8510.48937063778;8963.417377870417;11703.180777345844;12010.279383237033;8338.082810890675;8484.236418722097;8732.65069397217;8905.73282801517;9172.403793753385;9078.81842363136;9174.128457796765;9439.764005899633;9472.242220622196;9501.144896959308;12776.6805829855;13420.127691700398;13422;13425.194488330731;13442.193468391928;12866.29235392025;12868.09923305397;12903.483860645845;12927.806082908575;13002.739945200854 14:42:40 INFO - PROCESS | 22112 | |3;mootools.html;1579.9210039498025;1616.23228966241;1802.9729554056692;1899.0599653171682;1940.40817550647;7429.665665045072;8404.453710508827;8592.91407085929;8708.56457177141;8729.170728780771;7672.923270767291;8466.365022623313;8518.318534517239;8628.611712472939;8632.525211113387;2367.6566897799853;2376.0852071952336;2382.0352757133387;2391.0196819304088;2405.20628192696;2372.110458578033;2404.8076153907646;2452.852828830267;2453.521563295158;2455.1897873701637;2357.163207061494;2370.63255195445;2372.3357459911167;2392.114917480526;2392.138830021191;2403;2418.2140804238693;2431.7811396974357;2435.549423356676;2446.5473887330813;2414.167112346238;2418.6130219165025;2438.5610590093775;2446.47400808827;2446.7186273578586;8562.48625082497;8573.52845593492;8595.699150529765;8627;8661.30709543235;5429.049916264677;5544.112941929272;5546.223528705985;5547.889042219133;5558.277423934863;3573.1960308930543;3580.516630254934;3614.7469677122613;3704.444333349992;3715.758475699071;1117.3798541809292;1128.4696192789377;1152.5159433038143;1178.0693252330648;1179.6814859987842;12356.320402377865;12411.255324680458;12442.688932776662;12449.813252801216;12508;4589.908201836011;4607.76961151941;4650.046740418206;4681.087187998308;4683.695559788603;10623.36259824413;10677.519511621995;10679.89320106789;10685.465726713788;10736.516856741466;5368.114261146945;5382.165764306539;5384.946150538444;5395.892082158335;5396.4603539646505;4370.125974805052;4892.730899800546;4942.703437793672;4950.084234416644;4985.626078044161;4175.728577642504;4181.121964387452;4274.081072569413;4279.914401711948;4283.6144746972295;1351.3851197705021;1353.0393420671237;1356.3353956561411;1359.0350850895777;1375;946.668665966906;1088.4666513408372;1101.1741194104422;1101.2236373356764;1105.2484310668663;6038.30559485656;6103.23709536308;6231.376862313732;6244.2819075805955;6327.936720632735;451.2689443102195;452.47964840433764;454.2799662534853;469.5117078238662;469.9271612900006;4360.607545320936;4392.692511524163;4402.273624851928;4413.624841888475;4443.777811109431;10392;10665.200109991782;10751.83872241917;10778.245522813328;10823.13414926804;10674.786504270027;10682.73293167677;10691.893081069245;10740.140788736882;10847.132229421628;7782.260685234894;7929.881051784343;8391.328693704489;8453.365997550209;8478.491290522588;6023.36754640774;6118.724657390339;6118.847028824315;6213.378662133931;6225.875482490415;9021.233195178484;9022.413543119676;9075.319351048829;9147.679831205876;9224.953875230582;8978.640854366013;8995.460272383416;9223.815523689624;9279.211267042378;9347.205487533636;7009.719611215494;7652.846943061219;7806.531608103532;8000.759977200693;8263.876041859497;8349.914511113517;8360;8386.70646527393;8448.197421244971;8450.154984501502;7427.628618569158;7653.387728981779;7712.190220026816;7723.806904827425;7799.688012479437;7488.213737557696;7567.205443428361;7656.234376562299;7691.1155217150745;7737.032870891138;7101.360877521048;7107.644617768988;7135.714571417293;7141.392981596415;7155.248698886542;5072.289879416959;5171.560417364566;5247.265382846328;5280.894382112259;5328.946710532845;5168.612354073534;5289.894202116013;5298.3906850712665;5342.920630165125;5462.453754624506 14:42:40 INFO - PROCESS | 22112 | |4;prototype.html;359.4500414366019;361.6221049003791;364.62625808546255;364.9361361761691;365.5540240906095;6599.439047680947;6640.867182656344;6656.833579160518;6679.3320667933185;6684.966575167129;6507.869842603145;6517.80446586602;6544.770933017334;6544.803655890319;6558.049082882979;4695.483496815356;4784.282357646363;4896.828610998616;4900.607951363882;4900.950990490085;4881.974785295092;4893.1926232171645;4894.926576101361;4900.142475066867;4951.133551628469;4882.926756098661;4913.8771530711665;4918.852434426973;4919.901601967958;4930.7534623268875;4882.780274887638;4911.4106307243;4927.162382395001;4929.457759646436;4937.975310123445;4318.611324980767;4338.43600331958;4343.761093139908;4347.391365208873;4349.021470169218;6046.637201767908;6225.470834979033;6254.0618907163835;6260.123582698426;6299.181106456177;5748.856278593027;5772.076467765138;5777.797777077824;5780.0751879699465;5782.97108514459;6824.863502729918;6826.112605361321;6838.555493892881;6839.418649414805;6841.692123854438;4797.328374027639;4802.159622066124;4809.783559739785;4820.975895120537;4828.830990915301;7209.2790720928015;7220.92779072213;7227.530210536298;7228.132624085091;7242.420606351479;4811.08589368019;4908.705477671351;4927.236278376858;4929.827456039022;4943.2585112233455;4986.476419975923;5004.074246264453;5004.84985450437;5013.072581572421;5014;5707.571932105026;5727.255456790591;5743.253377060955;5765.88468230633;5780.72823978724;6899.517033807686;6901.413379862667;6932.618705971119;6955.095837541087;6958.8956165657555;1762.8854124482125;1782.857371410284;1793.4081753021471;1795.8563314934775;1795.8922464652162;1152.9423528823525;1189.3102000839492;1193.2840295822612;1197.3354788092693;1210.2315029956042;6770;6780.694868730919;6785.59286442815;6786.117804685458;6797.626130562768;6881.208661004049;7127.572345659173;7131.643417829192;7166.749163779347;7166.892496612555;6695.062691223233;6886.070380498669;6888.345607167411;6890.793276201722;6895.482838787111;3852.8266228019806;3859.2474467478573;3875.302445559826;3901.882943511699;3902.4731661225937;7581.3934885209055;7605.733799317108;7608.505447146029;7615.276548727973;7636.160022397532;7260.056192694916;7389.1502477214735;7411.295926886937;7412.99924510195;7423.777286681408;7555;7587.658555365022;7605.581693006938;7624.733134340271;7640.885386719204;7183.317584829433;7187.425005999403;7191.568505889663;7192.8921066183;7208.207097219197;7053.894191587233;7057.788266352018;7070.36366726997;7077.504574679723;7108.786736397917;7472.813179670552;7582.203868593719;7605;7626.504277221963;7631;4990.650654454299;4994.500549944976;5003.949960500348;5020.397552293748;5023.522765337433;7154.463415243774;7196.8920466192;7209.6034718091005;7209.675564599501;7216.0258365120035;6930.203026652;7013.509054366145;7022.824429389102;7030.191527974348;7041.647917603997;6845.315468453115;6990.720371185095;6995.370416662525;7003.964980175067;7014.964925175342;6809.21694005176;6856.382925536725;6865.253898440664;6881.10545629085;6894.620795856276;7033.472489563201;7036.824079398056;7038.085048943604;7039.964800176172;7046.823829404306;6784.966075169593;6792;6828.863422731617;6833.111695479556;6845.349691779273 14:42:40 INFO - PROCESS | 22112 | |5;yui.html;896.8340856941467;904.5612877754288;912.0833562269922;919.8022425178585;926.7497775600588;14989.700205995887;15265.236738163076;15267.618309542253;15395.461158859414;15440.536783896472;14118.788218176736;14203.78694319586;14323.140611563313;14345.497907573237;14352.067115637476;749.8912657664636;893.1291990309429;916.5921165081542;917.8990311065777;918.4168053286145;896.892372915251;906.026022026321;908.8409528332515;912.4434095201922;912.5118061836919;962.1196605106319;965.1072757699101;965.4593427680486;966.4491239993207;970.3935040599625;949.2358651285713;954.341504361988;955.5317894231846;956.9043095690445;957.4255446731975;700.2402393403164;703.8416356319839;705.6154395854272;706.5619316024047;707.2008630247839;14774.187419691913;15002.24988750558;15026.549203523911;15030;15035;14059.226742529157;14113.153210807384;14261.144331340152;14478.058926169766;14510.927445362811;11633.36016519091;11972.521099156023;11982.64052078439;12058.517659293619;12256.877431225663;4028.738132021409;4032.1129351542613;4039.6768258539246;4088;4138.8344466221315;54164;54300.72849635766;55027.449725502636;55109;55205.447945520435;10807.513661885234;10812.621558245424;11036.282641628268;11169.83245251322;11433.656990290305;19805.504862378555;19900.70148947767;20005.699914501292;20007.299744508873;20079.698804517942;8985.146411090936;9009.954950225207;9058;9086.318526110435;9112.043235460182;4940.357753492023;4987.675801072919;5040.722760248222;5063.822766203165;5069.594432445396;3593.047842321787;3663.487111804296;3669.082729317671;3669.743117981769;3676.1544844685873;665.1851481934591;670.2258890980925;674.4487678339799;679.6262055869253;689.2246222999127;686.7287421468492;819.1849110135335;834.968813515308;842.2461896602506;867.2498288979987;9546.140847323635;9627.085426884434;9704.320697551244;9713.465759383302;9915.355501892354;749.3293502315397;767.7159451003165;779.8050487378156;788.4993029426356;795.4551132474273;4339.240632889232;4435.334699794992;4528.886777830515;4535.707323412811;4630.351750754897;60847;61937.38062619316;62061.37938620646;65007;65401.34598654048;52087.21869171965;52889.73555132277;53036.73481632567;54565.45434545604;55684.72157639186;48835.51164488381;49604.25593616099;50161.74919125381;50167.74916125323;50348.748256258485;9545.28410369239;9545.331826772059;9694.5152742364;9731.61073557078;9830.901690982999;36703.08242293964;37302.626973731;37981.810090949366;38386.42420363753;38995.610043900335;43363;43504.34743478787;45291.32063018991;47903;48807.267890980955;12518.561850335194;12720.263768664478;12735.681607959876;12785.273988011872;12943.417546210254;14217.573472795833;14243.786343205067;14368.137911724913;14411.92794036065;14651.413943442569;13445.529406470727;13625.046246762631;13655.385507651981;13769.586912392644;13843.723125537232;12926.159799612995;12942.288174150512;13022.869771302167;13141.737165256833;13176.60470185896;12553.560625378068;12765.93617031909;12859.871401285867;12878.613641590768;12928.741425171633;11044.502997364978;11231.326120432801;11261.493232804707;11352;11444.713882153013;10462.843057353994;10890.23768336209;11064.778704426028;11280.32318060919;11299.943500282447 14:42:40 INFO - PROCESS | 22112 | __end_tp_report 14:42:40 INFO - PROCESS | 22112 | __start_cc_report 14:42:40 INFO - PROCESS | 22112 | _x_x_mozilla_cycle_collect,345 14:42:40 INFO - PROCESS | 22112 | __end_cc_report 14:42:40 INFO - PROCESS | 22112 | __startTimestamp1464385360421__endTimestamp 14:42:40 INFO - PROCESS | 22112 | 14:42:40 INFO - PROCESS | 22112 | ------- Summary: start ------- 14:42:40 INFO - PROCESS | 22112 | Number of tests: 6 14:42:40 INFO - PROCESS | 22112 | 14:42:40 INFO - PROCESS | 22112 | [#0] dojo.html Cycles:165 Average:5712.26 Median:5957.49 stddev:652.67 (11.0%) stddev-sans-first:628.62 14:42:40 INFO - PROCESS | 22112 | Values: 3385.2 3423.8 3444.4 3472.3 3508.4 5764.9 5785.3 5789.5 5792.4 5808.0 5703.0 5759.7 5828.5 5835.7 5863.3 5090.3 5216.6 5252.9 5261.7 5296.2 5086.9 5282.4 5328.5 5333.3 5406.1 5159.1 5171.3 5181.5 5269.1 5274.4 5119.7 5174.9 5204.0 5211.7 5216.8 5139.0 5172.9 5201.1 5235.6 5262.8 5464.6 5546.4 5626.2 5635.8 5684.2 6151.2 6162.4 6165.3 6168.7 6185.8 6198.2 6221.9 6229.3 6236.3 6247.7 5640.6 5675.8 5711.7 5763.9 5788.6 6222.3 6229.7 6260.1 6266.9 6282.7 6015.8 6025.8 6028.7 6036.4 6046.8 6098.2 6140.9 6167.9 6169.9 6182.1 6107.9 6119.3 6120.1 6134.1 6144.8 5817.1 6054.1 6114.4 6124.4 6137.3 4565.4 4574.6 4574.8 4589.0 4602.5 4104.6 4108.2 4109.5 4114.1 4146.0 5851.0 5874.5 5917.3 5980.3 6001.8 6087.8 6112.7 6148.7 6151.7 6214.9 5880.8 5880.9 5902.1 5938.1 5948.9 5195.0 5207.9 5288.8 5315.1 5347.5 6322.5 6383.6 6403.5 6419.5 6448.0 6002.8 6208.2 6223.9 6233.4 6272.2 6358.4 6418.5 6458.1 6474.6 6477.6 6002.7 6004.5 6006.5 6006.6 6007.2 5968.4 6107.5 6119.6 6122.2 6138.7 6044.2 6063.5 6066.2 6074.7 6088.0 5995.9 6011.1 6038.0 6042.2 6044.2 5825.3 5840.0 5875.7 5919.1 5957.5 5969.3 6095.1 6096.1 6101.0 6129.2 5878.5 5929.3 5940.8 5949.4 5960.7 14:42:40 INFO - PROCESS | 22112 | 14:42:40 INFO - PROCESS | 22112 | [#1] ext.html Cycles:180 Average:63326.81 Median:24270.21 stddev:123982.24 (510.8%) stddev-sans-first:124240.76 14:42:40 INFO - PROCESS | 22112 | Values: 655.9 677.3 687.6 706.8 727.8 39618.8 40129.6 40323.6 40323.8 40367.2 43919.3 44622.6 44663.3 44691.6 44894.6 8913.6 9004.5 9054.0 9084.7 9089.3 8689.7 8693.0 8753.5 8772.3 8772.6 8831.9 8859.0 8859.6 8862.0 8883.6 8809.1 8810.0 8837.0 8851.9 8853.1 9192.8 9219.8 9261.8 9274.6 9278.4 43562.8 44133.6 44237.8 44246.0 44248.0 3790.7 3792.2 3843.3 4098.9 4473.0 33130.2 34799.1 34843.5 35128.5 35286.1 4406.9 4449.2 4494.8 4500.6 4508.7 336010.0 336122.0 337546.0 338106.0 339198.0 63418.4 64021.7 64206.4 64251.7 64265.4 67907.3 71925.0 73377.6 73675.6 73707.3 18675.7 18980.9 18998.6 18999.9 19038.3 14741.6 14799.3 14810.3 14838.4 14899.5 20664.8 20713.1 20861.2 20909.3 20953.0 8005.3 8036.4 8274.1 8323.0 8344.2 1148.7 1170.1 1196.7 1214.4 1223.0 33946.5 34129.1 34303.3 34532.3 34586.3 1220.0 1257.7 1303.5 1304.0 1307.1 17503.4 17811.0 17813.6 17910.6 18033.2 513160.0 573279.0 578244.0 581581.0 600499.0 58926.4 60041.7 60080.4 60202.0 60587.4 1511.4 1520.3 1527.1 1534.5 1539.9 31917.7 33223.7 33972.5 34482.0 34947.3 56876.4 57732.0 57749.4 57789.4 57812.7 462189.0 465734.0 466057.0 467286.0 467513.0 31567.4 48618.5 48684.5 49268.0 49273.8 45429.0 45817.8 46280.5 46310.3 46929.5 38189.0 38636.0 38781.8 39038.4 39076.2 42390.8 42581.0 42596.6 43031.4 43916.3 42925.1 43433.8 43889.3 44387.3 44808.0 36488.5 36560.5 36816.0 37085.6 37461.8 29298.4 29313.6 29733.3 29817.6 29859.6 14:42:40 INFO - PROCESS | 22112 | 14:42:40 INFO - PROCESS | 22112 | [#2] jquery.html Cycles:180 Average:29008.87 Median:2602.09 stddev:80445.73 (3091.6%) stddev-sans-first:80642.77 14:42:40 INFO - PROCESS | 22112 | Values: 425.1 427.5 428.4 440.5 442.1 18265.3 19129.3 19141.0 20855.9 21817.6 18971.7 19571.5 19641.4 19713.5 19913.7 5044.9 5247.0 5298.7 5305.3 5306.3 5135.3 5224.1 5236.5 5610.6 5838.2 5797.4 5799.6 5843.9 5860.5 5891.5 5742.6 6012.1 6039.9 6041.3 6048.5 5829.1 5858.6 5862.2 5878.4 5886.6 14153.8 14395.1 14547.9 14548.7 14570.6 2383.1 2491.4 2712.8 2940.7 3104.6 10884.8 10988.5 11225.4 11301.7 13371.2 2057.4 2063.8 2147.3 2156.1 2162.7 78006.0 78751.6 79025.6 82379.6 83271.0 11375.5 11435.3 11667.0 11894.3 12028.5 16492.2 16590.5 16607.0 16642.4 16679.6 8401.5 8778.6 8796.3 9012.3 9029.5 8449.2 8478.4 8493.3 8531.0 8758.3 4956.3 4991.0 5074.7 5090.5 5104.9 2129.6 2142.3 2148.7 2175.1 2177.6 901.8 1038.9 1121.2 1123.2 1181.9 18786.9 19523.1 19688.4 19692.2 20024.3 1063.1 1088.3 1094.3 1103.6 1110.9 10955.3 11155.0 11193.5 11193.9 11270.2 466892.0 474106.0 478776.0 496585.0 516156.0 93515.0 99607.0 100249.5 100416.5 100607.5 1122.5 1122.6 1131.2 1135.2 1146.5 16961.8 17123.7 17237.4 17294.4 17573.2 38811.4 39171.2 39719.0 40547.2 40568.4 54068.7 59772.7 61958.7 62031.7 62257.0 8395.9 8416.0 8699.5 8715.3 8897.7 12377.8 13081.9 13110.7 13115.7 13218.2 8455.2 8510.5 8963.4 11703.2 12010.3 8338.1 8484.2 8732.7 8905.7 9172.4 9078.8 9174.1 9439.8 9472.2 9501.1 12776.7 13420.1 13422.0 13425.2 13442.2 12866.3 12868.1 12903.5 12927.8 13002.7 14:42:40 INFO - PROCESS | 22112 | 14:42:40 INFO - PROCESS | 22112 | [#3] mootools.html Cycles:180 Average:5786.03 Median:4917.72 stddev:3186.29 (64.8%) stddev-sans-first:3179.55 14:42:40 INFO - PROCESS | 22112 | Values: 1579.9 1616.2 1803.0 1899.1 1940.4 7429.7 8404.5 8592.9 8708.6 8729.2 7672.9 8466.4 8518.3 8628.6 8632.5 2367.7 2376.1 2382.0 2391.0 2405.2 2372.1 2404.8 2452.9 2453.5 2455.2 2357.2 2370.6 2372.3 2392.1 2392.1 2403.0 2418.2 2431.8 2435.5 2446.5 2414.2 2418.6 2438.6 2446.5 2446.7 8562.5 8573.5 8595.7 8627.0 8661.3 5429.0 5544.1 5546.2 5547.9 5558.3 3573.2 3580.5 3614.7 3704.4 3715.8 1117.4 1128.5 1152.5 1178.1 1179.7 12356.3 12411.3 12442.7 12449.8 12508.0 4589.9 4607.8 4650.0 4681.1 4683.7 10623.4 10677.5 10679.9 10685.5 10736.5 5368.1 5382.2 5384.9 5395.9 5396.5 4370.1 4892.7 4942.7 4950.1 4985.6 4175.7 4181.1 4274.1 4279.9 4283.6 1351.4 1353.0 1356.3 1359.0 1375.0 946.7 1088.5 1101.2 1101.2 1105.2 6038.3 6103.2 6231.4 6244.3 6327.9 451.3 452.5 454.3 469.5 469.9 4360.6 4392.7 4402.3 4413.6 4443.8 10392.0 10665.2 10751.8 10778.2 10823.1 10674.8 10682.7 10691.9 10740.1 10847.1 7782.3 7929.9 8391.3 8453.4 8478.5 6023.4 6118.7 6118.8 6213.4 6225.9 9021.2 9022.4 9075.3 9147.7 9225.0 8978.6 8995.5 9223.8 9279.2 9347.2 7009.7 7652.8 7806.5 8000.8 8263.9 8349.9 8360.0 8386.7 8448.2 8450.2 7427.6 7653.4 7712.2 7723.8 7799.7 7488.2 7567.2 7656.2 7691.1 7737.0 7101.4 7107.6 7135.7 7141.4 7155.2 5072.3 5171.6 5247.3 5280.9 5328.9 5168.6 5289.9 5298.4 5342.9 5462.5 14:42:40 INFO - PROCESS | 22112 | 14:42:40 INFO - PROCESS | 22112 | [#4] prototype.html Cycles:180 Average:5828.56 Median:6732.53 stddev:1776.12 (26.4%) stddev-sans-first:1733.01 14:42:40 INFO - PROCESS | 22112 | Values: 359.5 361.6 364.6 364.9 365.6 6599.4 6640.9 6656.8 6679.3 6685.0 6507.9 6517.8 6544.8 6544.8 6558.0 4695.5 4784.3 4896.8 4900.6 4901.0 4882.0 4893.2 4894.9 4900.1 4951.1 4882.9 4913.9 4918.9 4919.9 4930.8 4882.8 4911.4 4927.2 4929.5 4938.0 4318.6 4338.4 4343.8 4347.4 4349.0 6046.6 6225.5 6254.1 6260.1 6299.2 5748.9 5772.1 5777.8 5780.1 5783.0 6824.9 6826.1 6838.6 6839.4 6841.7 4797.3 4802.2 4809.8 4821.0 4828.8 7209.3 7220.9 7227.5 7228.1 7242.4 4811.1 4908.7 4927.2 4929.8 4943.3 4986.5 5004.1 5004.8 5013.1 5014.0 5707.6 5727.3 5743.3 5765.9 5780.7 6899.5 6901.4 6932.6 6955.1 6958.9 1762.9 1782.9 1793.4 1795.9 1795.9 1152.9 1189.3 1193.3 1197.3 1210.2 6770.0 6780.7 6785.6 6786.1 6797.6 6881.2 7127.6 7131.6 7166.7 7166.9 6695.1 6886.1 6888.3 6890.8 6895.5 3852.8 3859.2 3875.3 3901.9 3902.5 7581.4 7605.7 7608.5 7615.3 7636.2 7260.1 7389.2 7411.3 7413.0 7423.8 7555.0 7587.7 7605.6 7624.7 7640.9 7183.3 7187.4 7191.6 7192.9 7208.2 7053.9 7057.8 7070.4 7077.5 7108.8 7472.8 7582.2 7605.0 7626.5 7631.0 4990.7 4994.5 5003.9 5020.4 5023.5 7154.5 7196.9 7209.6 7209.7 7216.0 6930.2 7013.5 7022.8 7030.2 7041.6 6845.3 6990.7 6995.4 7004.0 7015.0 6809.2 6856.4 6865.3 6881.1 6894.6 7033.5 7036.8 7038.1 7040.0 7046.8 6785.0 6792.0 6828.9 6833.1 6845.3 14:42:40 INFO - PROCESS | 22112 | 14:42:40 INFO - PROCESS | 22112 | [#5] yui.html Cycles:180 Average:15246.14 Median:24913.51 stddev:17147.51 (68.8%) stddev-sans-first:17161.75 14:42:40 INFO - PROCESS | 22112 | Values: 896.8 904.6 912.1 919.8 926.7 14989.7 15265.2 15267.6 15395.5 15440.5 14118.8 14203.8 14323.1 14345.5 14352.1 749.9 893.1 916.6 917.9 918.4 896.9 906.0 908.8 912.4 912.5 962.1 965.1 965.5 966.4 970.4 949.2 954.3 955.5 956.9 957.4 700.2 703.8 705.6 706.6 707.2 14774.2 15002.2 15026.5 15030.0 15035.0 14059.2 14113.2 14261.1 14478.1 14510.9 11633.4 11972.5 11982.6 12058.5 12256.9 4028.7 4032.1 4039.7 4088.0 4138.8 54164.0 54300.7 55027.4 55109.0 55205.4 10807.5 10812.6 11036.3 11169.8 11433.7 19805.5 19900.7 20005.7 20007.3 20079.7 8985.1 9010.0 9058.0 9086.3 9112.0 4940.4 4987.7 5040.7 5063.8 5069.6 3593.0 3663.5 3669.1 3669.7 3676.2 665.2 670.2 674.4 679.6 689.2 686.7 819.2 835.0 842.2 867.2 9546.1 9627.1 9704.3 9713.5 9915.4 749.3 767.7 779.8 788.5 795.5 4339.2 4435.3 4528.9 4535.7 4630.4 60847.0 61937.4 62061.4 65007.0 65401.3 52087.2 52889.7 53036.7 54565.5 55684.7 48835.5 49604.3 50161.7 50167.7 50348.7 9545.3 9545.3 9694.5 9731.6 9830.9 36703.1 37302.6 37981.8 38386.4 38995.6 43363.0 43504.3 45291.3 47903.0 48807.3 12518.6 12720.3 12735.7 12785.3 12943.4 14217.6 14243.8 14368.1 14411.9 14651.4 13445.5 13625.0 13655.4 13769.6 13843.7 12926.2 12942.3 13022.9 13141.7 13176.6 12553.6 12765.9 12859.9 12878.6 12928.7 11044.5 11231.3 11261.5 11352.0 11444.7 10462.8 10890.2 11064.8 11280.3 11299.9 14:42:40 INFO - PROCESS | 22112 | -------- Summary: end -------- 14:42:40 INFO - PROCESS | 22112 | 14:42:41 INFO - TEST-INFO | 22112: exit 0 14:42:41 INFO - TEST-OK | dromaeo_css | took 1109651ms 14:42:41 INFO - TEST-START | kraken 14:42:41 INFO - operating with platform_type : linux_ 14:42:41 INFO - Initialising browser for kraken test... 14:42:41 INFO - TEST-INFO | started process 22358 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSLJLbc/profile http://localhost:39291/getInfo.html) 14:42:45 INFO - PROCESS | 22358 | 14:42:45 INFO - PROCESS | 22358 | (process:22431): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:42:45 INFO - PROCESS | 22358 | __metrics Screen width/height:1600/1200 14:42:45 INFO - PROCESS | 22358 | colorDepth:24 14:42:45 INFO - PROCESS | 22358 | Browser inner width/height: 1024/697 14:42:45 INFO - PROCESS | 22358 | __metrics 14:42:46 ERROR - PROCESS | 22358 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 14:42:47 INFO - TEST-INFO | 22358: exit 0 14:42:47 INFO - Browser initialized. 14:42:47 INFO - Running cycle 1/1 for kraken test... 14:42:47 INFO - TEST-INFO | started process 22482 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSLJLbc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:42:49 INFO - PROCESS | 22482 | 14:42:49 INFO - PROCESS | 22482 | (process:22549): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:42:59 INFO - PROCESS | 22482 | RSS: Main: 152510464 14:42:59 INFO - PROCESS | 22482 | 14:43:01 INFO - PROCESS | 22482 | Cycle 1(1): loaded http://localhost:39291/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39291/tests/kraken/driver.html?testName=audio-beat-detection) 14:43:02 INFO - PROCESS | 22482 | RSS: Main: 157196288 14:43:02 INFO - PROCESS | 22482 | 14:43:05 INFO - PROCESS | 22482 | Cycle 1(1): loaded http://localhost:39291/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39291/tests/kraken/driver.html?testName=audio-dft) 14:43:06 INFO - PROCESS | 22482 | RSS: Main: 157806592 14:43:06 INFO - PROCESS | 22482 | 14:43:08 INFO - PROCESS | 22482 | Cycle 1(1): loaded http://localhost:39291/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39291/tests/kraken/driver.html?testName=audio-fft) 14:43:09 INFO - PROCESS | 22482 | RSS: Main: 157528064 14:43:09 INFO - PROCESS | 22482 | 14:43:11 INFO - PROCESS | 22482 | Cycle 1(1): loaded http://localhost:39291/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39291/tests/kraken/driver.html?testName=audio-oscillator) 14:43:12 INFO - PROCESS | 22482 | RSS: Main: 157638656 14:43:12 INFO - PROCESS | 22482 | 14:43:14 INFO - PROCESS | 22482 | Cycle 1(1): loaded http://localhost:39291/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39291/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:43:15 INFO - PROCESS | 22482 | RSS: Main: 157347840 14:43:15 INFO - PROCESS | 22482 | 14:43:18 INFO - PROCESS | 22482 | Cycle 1(1): loaded http://localhost:39291/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39291/tests/kraken/driver.html?testName=imaging-darkroom) 14:43:18 INFO - PROCESS | 22482 | RSS: Main: 157466624 14:43:18 INFO - PROCESS | 22482 | 14:43:22 INFO - PROCESS | 22482 | Cycle 1(1): loaded http://localhost:39291/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39291/tests/kraken/driver.html?testName=imaging-desaturate) 14:43:22 INFO - PROCESS | 22482 | RSS: Main: 157532160 14:43:22 INFO - PROCESS | 22482 | 14:43:25 INFO - PROCESS | 22482 | Cycle 1(1): loaded http://localhost:39291/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39291/tests/kraken/driver.html?testName=json-parse-financial) 14:43:26 INFO - PROCESS | 22482 | RSS: Main: 157298688 14:43:26 INFO - PROCESS | 22482 | 14:43:27 INFO - PROCESS | 22482 | Cycle 1(1): loaded http://localhost:39291/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39291/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:43:28 INFO - PROCESS | 22482 | RSS: Main: 157274112 14:43:28 INFO - PROCESS | 22482 | 14:43:29 INFO - PROCESS | 22482 | Cycle 1(1): loaded http://localhost:39291/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39291/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:43:30 INFO - PROCESS | 22482 | RSS: Main: 157704192 14:43:30 INFO - PROCESS | 22482 | 14:43:32 INFO - PROCESS | 22482 | Cycle 1(1): loaded http://localhost:39291/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39291/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:43:33 INFO - PROCESS | 22482 | RSS: Main: 157544448 14:43:33 INFO - PROCESS | 22482 | 14:43:35 INFO - PROCESS | 22482 | Cycle 1(1): loaded http://localhost:39291/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39291/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:43:36 INFO - PROCESS | 22482 | RSS: Main: 158404608 14:43:36 INFO - PROCESS | 22482 | 14:43:39 INFO - PROCESS | 22482 | Cycle 1(1): loaded http://localhost:39291/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39291/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:43:39 INFO - PROCESS | 22482 | RSS: Main: 157810688 14:43:39 INFO - PROCESS | 22482 | 14:43:41 INFO - PROCESS | 22482 | Cycle 1(1): loaded http://localhost:39291/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39291/tests/kraken/driver.html?testName=ai-astar) 14:43:41 INFO - PROCESS | 22482 | RSS: Main: 159305728 14:43:41 INFO - PROCESS | 22482 | 14:43:41 INFO - PROCESS | 22482 | __start_tp_report 14:43:41 INFO - PROCESS | 22482 | _x_x_mozilla_page_load 14:43:41 INFO - PROCESS | 22482 | _x_x_mozilla_page_load_details 14:43:41 INFO - PROCESS | 22482 | |i|pagename|runs| 14:43:41 INFO - PROCESS | 22482 | |0;ai-astar;109;114;105;111;116;113;102;111;111;112 14:43:41 INFO - PROCESS | 22482 | |1;audio-beat-detection;173;128;153;178;130;163;156;129;179;127 14:43:41 INFO - PROCESS | 22482 | |2;audio-dft;164;163;162;162;162;162;163;163;161;160 14:43:41 INFO - PROCESS | 22482 | |3;audio-fft;77;74;74;178;86;77;73;77;157;73 14:43:41 INFO - PROCESS | 22482 | |4;audio-oscillator;93;92;153;92;93;92;143;91;92;145 14:43:41 INFO - PROCESS | 22482 | |5;imaging-gaussian-blur;118;117;117;117;117;117;117;118;117;117 14:43:41 INFO - PROCESS | 22482 | |6;imaging-darkroom;146;147;147;147;147;147;147;145;147;146 14:43:41 INFO - PROCESS | 22482 | |7;imaging-desaturate;95;95;96;96;96;95;95;98;96;96 14:43:41 INFO - PROCESS | 22482 | |8;json-parse-financial;54;58;58;56;57;65;56;85;55;56 14:43:41 INFO - PROCESS | 22482 | |9;json-stringify-tinderbox;58;57;58;58;58;58;58;58;59;57 14:43:41 INFO - PROCESS | 22482 | |10;stanford-crypto-aes;73;73;74;73;75;74;75;76;76;74 14:43:41 INFO - PROCESS | 22482 | |11;stanford-crypto-ccm;117;112;117;129;124;113;111;121;134;126 14:43:41 INFO - PROCESS | 22482 | |12;stanford-crypto-pbkdf2;164;159;162;164;165;160;160;159;160;160 14:43:41 INFO - PROCESS | 22482 | |13;stanford-crypto-sha256-iterative;68;71;67;66;65;66;65;67;71;63 14:43:41 INFO - PROCESS | 22482 | __end_tp_report 14:43:41 INFO - PROCESS | 22482 | __start_cc_report 14:43:41 INFO - PROCESS | 22482 | _x_x_mozilla_cycle_collect,870 14:43:41 INFO - PROCESS | 22482 | __end_cc_report 14:43:41 INFO - PROCESS | 22482 | __startTimestamp1464385421572__endTimestamp 14:43:41 INFO - PROCESS | 22482 | 14:43:41 INFO - PROCESS | 22482 | ------- Summary: start ------- 14:43:41 INFO - PROCESS | 22482 | Number of tests: 14 14:43:41 INFO - PROCESS | 22482 | 14:43:41 INFO - PROCESS | 22482 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.50 stddev:4.17 (3.7%) stddev-sans-first:4.39 14:43:41 INFO - PROCESS | 22482 | Values: 109.0 114.0 105.0 111.0 116.0 113.0 102.0 111.0 111.0 112.0 14:43:41 INFO - PROCESS | 22482 | 14:43:41 INFO - PROCESS | 22482 | [#1] audio-beat-detection Cycles:10 Average:151.60 Median:159.50 stddev:21.59 (13.5%) stddev-sans-first:21.47 14:43:41 INFO - PROCESS | 22482 | Values: 173.0 128.0 153.0 178.0 130.0 163.0 156.0 129.0 179.0 127.0 14:43:41 INFO - PROCESS | 22482 | 14:43:41 INFO - PROCESS | 22482 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.50 stddev:1.14 (0.7%) stddev-sans-first:1.00 14:43:41 INFO - PROCESS | 22482 | Values: 164.0 163.0 162.0 162.0 162.0 162.0 163.0 163.0 161.0 160.0 14:43:41 INFO - PROCESS | 22482 | 14:43:41 INFO - PROCESS | 22482 | [#3] audio-fft Cycles:10 Average:94.60 Median:75.50 stddev:38.92 (51.6%) stddev-sans-first:40.76 14:43:41 INFO - PROCESS | 22482 | Values: 77.0 74.0 74.0 178.0 86.0 77.0 73.0 77.0 157.0 73.0 14:43:41 INFO - PROCESS | 22482 | 14:43:41 INFO - PROCESS | 22482 | [#4] audio-oscillator Cycles:10 Average:108.60 Median:92.00 stddev:26.62 (28.9%) stddev-sans-first:27.63 14:43:41 INFO - PROCESS | 22482 | Values: 93.0 92.0 153.0 92.0 93.0 92.0 143.0 91.0 92.0 145.0 14:43:41 INFO - PROCESS | 22482 | 14:43:41 INFO - PROCESS | 22482 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 14:43:41 INFO - PROCESS | 22482 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 14:43:41 INFO - PROCESS | 22482 | 14:43:41 INFO - PROCESS | 22482 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 14:43:41 INFO - PROCESS | 22482 | Values: 146.0 147.0 147.0 147.0 147.0 147.0 147.0 145.0 147.0 146.0 14:43:41 INFO - PROCESS | 22482 | 14:43:41 INFO - PROCESS | 22482 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.92 (1.0%) stddev-sans-first:0.93 14:43:41 INFO - PROCESS | 22482 | Values: 95.0 95.0 96.0 96.0 96.0 95.0 95.0 98.0 96.0 96.0 14:43:41 INFO - PROCESS | 22482 | 14:43:41 INFO - PROCESS | 22482 | [#8] json-parse-financial Cycles:10 Average:60.00 Median:57.50 stddev:9.29 (16.1%) stddev-sans-first:9.59 14:43:41 INFO - PROCESS | 22482 | Values: 54.0 58.0 58.0 56.0 57.0 65.0 56.0 85.0 55.0 56.0 14:43:41 INFO - PROCESS | 22482 | 14:43:41 INFO - PROCESS | 22482 | [#9] json-stringify-tinderbox Cycles:10 Average:57.90 Median:58.00 stddev:0.57 (1.0%) stddev-sans-first:0.60 14:43:41 INFO - PROCESS | 22482 | Values: 58.0 57.0 58.0 58.0 58.0 58.0 58.0 58.0 59.0 57.0 14:43:41 INFO - PROCESS | 22482 | 14:43:41 INFO - PROCESS | 22482 | [#10] stanford-crypto-aes Cycles:10 Average:74.30 Median:74.50 stddev:1.16 (1.6%) stddev-sans-first:1.13 14:43:41 INFO - PROCESS | 22482 | Values: 73.0 73.0 74.0 73.0 75.0 74.0 75.0 76.0 76.0 74.0 14:43:41 INFO - PROCESS | 22482 | 14:43:41 INFO - PROCESS | 22482 | [#11] stanford-crypto-ccm Cycles:10 Average:120.40 Median:122.50 stddev:7.75 (6.3%) stddev-sans-first:8.12 14:43:41 INFO - PROCESS | 22482 | Values: 117.0 112.0 117.0 129.0 124.0 113.0 111.0 121.0 134.0 126.0 14:43:41 INFO - PROCESS | 22482 | 14:43:41 INFO - PROCESS | 22482 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.30 Median:161.00 stddev:2.26 (1.4%) stddev-sans-first:2.18 14:43:41 INFO - PROCESS | 22482 | Values: 164.0 159.0 162.0 164.0 165.0 160.0 160.0 159.0 160.0 160.0 14:43:41 INFO - PROCESS | 22482 | 14:43:41 INFO - PROCESS | 22482 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:2.56 (3.8%) stddev-sans-first:2.68 14:43:41 INFO - PROCESS | 22482 | Values: 68.0 71.0 67.0 66.0 65.0 66.0 65.0 67.0 71.0 63.0 14:43:41 INFO - PROCESS | 22482 | -------- Summary: end -------- 14:43:41 INFO - PROCESS | 22482 | 14:43:42 INFO - TEST-INFO | 22482: exit 0 14:43:42 INFO - TEST-OK | kraken | took 61410ms 14:43:42 INFO - SUITE-END | took 1171s 14:43:42 INFO - Completed test suite (00:19:31) 14:43:42 INFO - javascript benchmark 14:43:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3385.1706331948667, 3423.7945723256607, 3444.448888177891, 3472.288180922911, 3508.3860324443217, 5764.913526297109, 5785.334686511047, 5789.478946894778, 5792.449717276862, 5807.970960145199, 5702.971485142579, 5759.68321742304, 5828.504577110951, 5835.679037652927, 5863.296404431463, 5090.31280777095, 5216.634835561512, 5252.921206181911, 5261.684298942057, 5296.205569164617, 5086.898262034757, 5282.418933917266, 5328.49379308965, 5333.333333333333, 5406.08096623575, 5159.071367153911, 5171.327727395452, 5181.455947125554, 5269.077911365515, 5274.393444753845, 5119.667221630601, 5174.948250517485, 5204.0, 5211.661242019257, 5216.826214101835, 5138.97430512845, 5172.948270517284, 5201.089809283398, 5235.633505654606, 5262.842174721555, 5464.590155738336, 5546.389897111315, 5626.240457538262, 5635.802746903839, 5684.204211410406, 6151.200343955257, 6162.383761623847, 6165.290991535986, 6168.691565421711, 6185.8144255672405, 6198.243914133616, 6221.875562488724, 6229.25248970122, 6236.345183755686, 6247.687615619201, 5640.5769567282205, 5675.829725108253, 5711.657300561938, 5763.88472230553, 5788.623739456922, 6222.253329600477, 6229.719662615194, 6260.060990851318, 6266.905996409966, 6282.717277722513, 6015.759369625166, 6025.8192254232445, 6028.728707208098, 6036.366181550961, 6046.788362407295, 6098.207233059674, 6140.8771824563255, 6167.907481387782, 6169.907451388232, 6182.072689096672, 6107.938920610826, 6119.342652247476, 6120.08198770188, 6134.110553969738, 6144.846378840475, 5817.0983497557945, 6054.122152287893, 6114.358196333954, 6124.441964285689, 6137.263528376623, 4565.383673204141, 4574.565416285448, 4574.7941342639, 4589.0, 4602.470715867651, 4104.630583247522, 4108.239975604522, 4109.465769449952, 4114.053767633461, 4146.0, 5850.970745146247, 5874.530037596982, 5917.349091599921, 5980.342162362137, 6001.819945401645, 6087.786927457518, 6112.716259964451, 6148.661823599656, 6151.72317245725, 6214.906776398358, 5880.8235752927485, 5880.882382352329, 5902.1146827976145, 5938.079597662369, 5948.881022379528, 5194.974025129925, 5207.869803254949, 5288.814891478857, 5315.069862773999, 5347.465253474699, 6322.525810564226, 6383.616982981036, 6403.519736019724, 6419.454346380517, 6447.967760161263, 6002.849928751816, 6208.165498035633, 6223.906641400473, 6233.407826256498, 6272.2159730033745, 6358.395952384516, 6418.4544313731985, 6458.063580780855, 6474.611523308617, 6477.611343319228, 6002.669853157943, 6004.459598636144, 6006.489448396936, 6006.579539432198, 6007.249093863267, 5968.373320801254, 6107.450329470369, 6119.602225855483, 6122.234720659918, 6138.723757430837, 6044.184035155374, 6063.514918806397, 6066.241719785027, 6074.696265186812, 6087.969560152171, 5995.91006134917, 6011.128386384037, 6038.0, 6042.1843051187525, 6044.214252147369, 5825.330087040044, 5839.970800145972, 5875.706214689334, 5919.082542205965, 5957.49361304294, 5969.313528944227, 6095.05526643371, 6096.116063170904, 6101.023836186189, 6129.2032035835055, 5878.529717622666, 5929.258842644669, 5940.821775346746, 5949.3753155918, 5960.672163031075], "value": 5668.581664869278, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [655.8557117434166, 677.2989955396165, 687.5943193515825, 706.8303607134286, 727.7962170592234, 39618.80190599047, 40129.59870401295, 40323.59676403235, 40323.79838100809, 40367.19265614686, 43919.3412098818, 44622.55377446225, 44663.33005004928, 44691.553084469146, 44894.55105448944, 8913.643454261837, 9004.549772511382, 9054.049324820899, 9084.682036128737, 9089.27285817133, 8689.695860644879, 8692.956535217316, 8753.518556479392, 8772.254358379545, 8772.605232764508, 8831.867521987175, 8858.981217160012, 8859.645614175426, 8862.0, 8883.600237989305, 8809.075047120055, 8810.0308966014, 8837.0, 8851.911480885174, 8853.11468853116, 9192.770180745469, 9219.815603687955, 9261.768455788591, 9274.582643781046, 9278.443293402417, 43562.782186089185, 44133.558664413584, 44237.77881110606, 44246.0, 44248.0, 3790.7156963227867, 3792.1657235408443, 3843.26977874203, 4098.938515922234, 4472.9776351118035, 33130.171745706306, 34799.13002174966, 34843.477347839806, 35128.47307290393, 35286.11784705377, 4406.867793966187, 4449.243628583116, 4494.842680506199, 4500.572445617661, 4508.661850361236, 336010.0, 336121.99999999756, 337546.0, 338106.0, 339198.0, 63418.36581634217, 64021.679891600244, 64206.35793642004, 64251.678741605996, 64265.35734642687, 67907.32092679109, 71925.0, 73377.6331118341, 73675.63162184154, 73707.26292737004, 18675.71986420205, 18980.905095474434, 18998.620027599645, 18999.905000474908, 19038.33365832189, 14741.55775326742, 14799.260036998106, 14810.259487025605, 14838.40646374133, 14899.47851825181, 20664.793352066587, 20713.067911944, 20861.165553377694, 20909.26817561378, 20953.0, 8005.279524842792, 8036.397270204758, 8274.131216222331, 8323.0, 8344.207300306462, 1148.6841118692425, 1170.1107158559387, 1196.6589521986193, 1214.3806658604176, 1222.9938850305691, 33946.49080263798, 34129.14677133092, 34303.31393372118, 34532.30935381278, 34586.30827383438, 1219.9939000304942, 1257.7107265329025, 1303.5046682260681, 1303.9608811735473, 1307.091571357916, 17503.38738144159, 17811.0, 17813.643727125385, 17910.5522361942, 18033.18850651724, 513160.0, 573279.0, 578244.0, 581581.0, 600499.0, 58926.410735892096, 60041.69979150076, 60080.39919600748, 60202.0, 60587.39412605818, 1511.4181040299563, 1520.3006616956102, 1527.1295361643756, 1534.501287081703, 1539.907605543671, 31917.68082319147, 33223.66776332302, 33972.49041264432, 34482.0, 34947.30105397929, 56876.431235687116, 57732.0, 57749.422505774404, 57789.4221057784, 57812.71093644505, 462189.0, 465734.0, 466057.0, 467286.0, 467513.0, 31567.36865262728, 48618.5138148614, 48684.513154868, 49268.0, 49273.753631231615, 45429.0, 45817.77091114523, 46280.53719462897, 46310.30534542052, 46929.530704692515, 38189.0, 38636.03409914662, 38781.80609096937, 39038.414423784234, 39076.21847562976, 42390.78804606081, 42581.0, 42596.57403425926, 43031.35452968271, 43916.341254880565, 42925.14149716926, 43433.78283108564, 43889.34165987577, 44387.33418998782, 44808.0, 36488.452673209395, 36560.45159322665, 36816.0, 37085.62914370822, 37461.81269093746, 29298.414031719672, 29313.56029659514, 29733.25666858259, 29817.552736708534, 29859.552106717983], "value": 21578.110758365754, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [425.1030326012115, 427.482745877488, 428.36601829292664, 440.4582363692658, 442.14665695208254, 18265.26938922443, 19129.330473433434, 19141.0, 20855.895720521414, 21817.563648727017, 18971.71542426865, 19571.5107122322, 19641.41075767726, 19713.507162320948, 19913.701294480557, 5044.924326135102, 5246.973765131169, 5298.682079075248, 5305.310309659739, 5306.336707911511, 5135.281060651511, 5224.138017227172, 5236.502532259448, 5610.579206559504, 5838.153467747175, 5797.36229014808, 5799.608094057438, 5843.912341314884, 5860.501857342131, 5891.528677705774, 5742.598018138732, 6012.098185272201, 6039.879202415971, 6041.3052498962525, 6048.485878700316, 5829.125631155361, 5858.648481091105, 5862.179294898718, 5878.353381128072, 5886.558508111866, 14153.787693184611, 14395.064320819218, 14547.927260363631, 14548.70902581953, 14570.562883113524, 2383.1420688552107, 2491.352248415407, 2712.8372297662204, 2940.6765255821842, 3104.58088158098, 10884.782304353948, 10988.450577471094, 11225.38260395678, 11301.660950171508, 13371.197728136343, 2057.40335302762, 2063.7833027532192, 2147.302126808793, 2156.083664442606, 2162.6647869580083, 78006.0, 78751.606241969, 79025.60487197584, 82379.58810206031, 83271.0, 11375.544978200945, 11435.341875428016, 11667.0, 11894.286342819458, 12028.45871935765, 16492.17539123039, 16590.50228493147, 16607.0, 16642.417515386904, 16679.583010424838, 8401.453905496122, 8778.648854045767, 8796.296296296281, 9012.27901767857, 9029.548522573845, 8449.197326253996, 8478.3641226907, 8493.27807136388, 8531.018932822804, 8758.255548278468, 4956.330895329156, 4990.953708979301, 5074.67014644047, 5090.516400941905, 5104.872378190575, 2129.5527939132644, 2142.30375128084, 2148.7206663133693, 2175.140819376369, 2177.608030554484, 901.7880798012462, 1038.8753349597946, 1121.1647322744607, 1123.185690374472, 1181.8699943006263, 18786.90606546986, 19523.121459534355, 19688.409347719593, 19692.212311507665, 20024.299149529696, 1063.1335461598771, 1088.3198001249218, 1094.2777766673958, 1103.646833013428, 1110.9222354435112, 10955.34267943926, 11155.0, 11193.49629266685, 11193.94403027996, 11270.154738394653, 466892.0, 474106.0, 478776.0, 496585.0, 516156.0, 93515.0, 99607.0, 100249.49875250724, 100416.49791750994, 100607.49696251472, 1122.5004872831512, 1122.5678113926033, 1131.2420678145497, 1135.2167004766684, 1146.4611632532697, 16961.830381696025, 17123.65752684964, 17237.39669111575, 17294.394696185573, 17573.209205585525, 38811.41782873316, 39171.2165756689, 39719.0, 40547.1890562193, 40568.391474128504, 54068.72965635147, 59772.70113649578, 61958.69020654868, 62031.689841550506, 62257.0, 8395.874061889199, 8415.95792021036, 8699.478031318142, 8715.302775777796, 8897.688580899638, 12377.752444950871, 13081.934590326988, 13110.737785244433, 13115.672108197372, 13218.206907585576, 8455.196756308142, 8510.48937063778, 8963.417377870417, 11703.180777345844, 12010.279383237033, 8338.082810890675, 8484.236418722097, 8732.65069397217, 8905.73282801517, 9172.403793753385, 9078.81842363136, 9174.128457796765, 9439.764005899633, 9472.242220622196, 9501.144896959308, 12776.6805829855, 13420.127691700398, 13422.0, 13425.194488330731, 13442.193468391928, 12866.29235392025, 12868.09923305397, 12903.483860645845, 12927.806082908575, 13002.739945200854], "value": 9397.480106119947, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1579.9210039498025, 1616.23228966241, 1802.9729554056692, 1899.0599653171682, 1940.40817550647, 7429.665665045072, 8404.453710508827, 8592.91407085929, 8708.56457177141, 8729.170728780771, 7672.923270767291, 8466.365022623313, 8518.318534517239, 8628.611712472939, 8632.525211113387, 2367.6566897799853, 2376.0852071952336, 2382.0352757133387, 2391.0196819304088, 2405.20628192696, 2372.110458578033, 2404.8076153907646, 2452.852828830267, 2453.521563295158, 2455.1897873701637, 2357.163207061494, 2370.63255195445, 2372.3357459911167, 2392.114917480526, 2392.138830021191, 2403.0, 2418.2140804238693, 2431.7811396974357, 2435.549423356676, 2446.5473887330813, 2414.167112346238, 2418.6130219165025, 2438.5610590093775, 2446.47400808827, 2446.7186273578586, 8562.48625082497, 8573.52845593492, 8595.699150529765, 8627.0, 8661.30709543235, 5429.049916264677, 5544.112941929272, 5546.223528705985, 5547.889042219133, 5558.277423934863, 3573.1960308930543, 3580.516630254934, 3614.7469677122613, 3704.444333349992, 3715.758475699071, 1117.3798541809292, 1128.4696192789377, 1152.5159433038143, 1178.0693252330648, 1179.6814859987842, 12356.320402377865, 12411.255324680458, 12442.688932776662, 12449.813252801216, 12508.0, 4589.908201836011, 4607.76961151941, 4650.046740418206, 4681.087187998308, 4683.695559788603, 10623.36259824413, 10677.519511621995, 10679.89320106789, 10685.465726713788, 10736.516856741466, 5368.114261146945, 5382.165764306539, 5384.946150538444, 5395.892082158335, 5396.4603539646505, 4370.125974805052, 4892.730899800546, 4942.703437793672, 4950.084234416644, 4985.626078044161, 4175.728577642504, 4181.121964387452, 4274.081072569413, 4279.914401711948, 4283.6144746972295, 1351.3851197705021, 1353.0393420671237, 1356.3353956561411, 1359.0350850895777, 1375.0, 946.668665966906, 1088.4666513408372, 1101.1741194104422, 1101.2236373356764, 1105.2484310668663, 6038.30559485656, 6103.23709536308, 6231.376862313732, 6244.2819075805955, 6327.936720632735, 451.2689443102195, 452.47964840433764, 454.2799662534853, 469.5117078238662, 469.9271612900006, 4360.607545320936, 4392.692511524163, 4402.273624851928, 4413.624841888475, 4443.777811109431, 10392.0, 10665.200109991782, 10751.83872241917, 10778.245522813328, 10823.13414926804, 10674.786504270027, 10682.73293167677, 10691.893081069245, 10740.140788736882, 10847.132229421628, 7782.260685234894, 7929.881051784343, 8391.328693704489, 8453.365997550209, 8478.491290522588, 6023.36754640774, 6118.724657390339, 6118.847028824315, 6213.378662133931, 6225.875482490415, 9021.233195178484, 9022.413543119676, 9075.319351048829, 9147.679831205876, 9224.953875230582, 8978.640854366013, 8995.460272383416, 9223.815523689624, 9279.211267042378, 9347.205487533636, 7009.719611215494, 7652.846943061219, 7806.531608103532, 8000.759977200693, 8263.876041859497, 8349.914511113517, 8360.0, 8386.70646527393, 8448.197421244971, 8450.154984501502, 7427.628618569158, 7653.387728981779, 7712.190220026816, 7723.806904827425, 7799.688012479437, 7488.213737557696, 7567.205443428361, 7656.234376562299, 7691.1155217150745, 7737.032870891138, 7101.360877521048, 7107.644617768988, 7135.714571417293, 7141.392981596415, 7155.248698886542, 5072.289879416959, 5171.560417364566, 5247.265382846328, 5280.894382112259, 5328.946710532845, 5168.612354073534, 5289.894202116013, 5298.3906850712665, 5342.920630165125, 5462.453754624506], "value": 4628.138190064872, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.4500414366019, 361.6221049003791, 364.62625808546255, 364.9361361761691, 365.5540240906095, 6599.439047680947, 6640.867182656344, 6656.833579160518, 6679.3320667933185, 6684.966575167129, 6507.869842603145, 6517.80446586602, 6544.770933017334, 6544.803655890319, 6558.049082882979, 4695.483496815356, 4784.282357646363, 4896.828610998616, 4900.607951363882, 4900.950990490085, 4881.974785295092, 4893.1926232171645, 4894.926576101361, 4900.142475066867, 4951.133551628469, 4882.926756098661, 4913.8771530711665, 4918.852434426973, 4919.901601967958, 4930.7534623268875, 4882.780274887638, 4911.4106307243, 4927.162382395001, 4929.457759646436, 4937.975310123445, 4318.611324980767, 4338.43600331958, 4343.761093139908, 4347.391365208873, 4349.021470169218, 6046.637201767908, 6225.470834979033, 6254.0618907163835, 6260.123582698426, 6299.181106456177, 5748.856278593027, 5772.076467765138, 5777.797777077824, 5780.0751879699465, 5782.97108514459, 6824.863502729918, 6826.112605361321, 6838.555493892881, 6839.418649414805, 6841.692123854438, 4797.328374027639, 4802.159622066124, 4809.783559739785, 4820.975895120537, 4828.830990915301, 7209.2790720928015, 7220.92779072213, 7227.530210536298, 7228.132624085091, 7242.420606351479, 4811.08589368019, 4908.705477671351, 4927.236278376858, 4929.827456039022, 4943.2585112233455, 4986.476419975923, 5004.074246264453, 5004.84985450437, 5013.072581572421, 5014.0, 5707.571932105026, 5727.255456790591, 5743.253377060955, 5765.88468230633, 5780.72823978724, 6899.517033807686, 6901.413379862667, 6932.618705971119, 6955.095837541087, 6958.8956165657555, 1762.8854124482125, 1782.857371410284, 1793.4081753021471, 1795.8563314934775, 1795.8922464652162, 1152.9423528823525, 1189.3102000839492, 1193.2840295822612, 1197.3354788092693, 1210.2315029956042, 6770.0, 6780.694868730919, 6785.59286442815, 6786.117804685458, 6797.626130562768, 6881.208661004049, 7127.572345659173, 7131.643417829192, 7166.749163779347, 7166.892496612555, 6695.062691223233, 6886.070380498669, 6888.345607167411, 6890.793276201722, 6895.482838787111, 3852.8266228019806, 3859.2474467478573, 3875.302445559826, 3901.882943511699, 3902.4731661225937, 7581.3934885209055, 7605.733799317108, 7608.505447146029, 7615.276548727973, 7636.160022397532, 7260.056192694916, 7389.1502477214735, 7411.295926886937, 7412.99924510195, 7423.777286681408, 7555.0, 7587.658555365022, 7605.581693006938, 7624.733134340271, 7640.885386719204, 7183.317584829433, 7187.425005999403, 7191.568505889663, 7192.8921066183, 7208.207097219197, 7053.894191587233, 7057.788266352018, 7070.36366726997, 7077.504574679723, 7108.786736397917, 7472.813179670552, 7582.203868593719, 7605.0, 7626.504277221963, 7631.0, 4990.650654454299, 4994.500549944976, 5003.949960500348, 5020.397552293748, 5023.522765337433, 7154.463415243774, 7196.8920466192, 7209.6034718091005, 7209.675564599501, 7216.0258365120035, 6930.203026652, 7013.509054366145, 7022.824429389102, 7030.191527974348, 7041.647917603997, 6845.315468453115, 6990.720371185095, 6995.370416662525, 7003.964980175067, 7014.964925175342, 6809.21694005176, 6856.382925536725, 6865.253898440664, 6881.10545629085, 6894.620795856276, 7033.472489563201, 7036.824079398056, 7038.085048943604, 7039.964800176172, 7046.823829404306, 6784.966075169593, 6792.0, 6828.863422731617, 6833.111695479556, 6845.349691779273], "value": 5251.258095826632, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [896.8340856941467, 904.5612877754288, 912.0833562269922, 919.8022425178585, 926.7497775600588, 14989.700205995887, 15265.236738163076, 15267.618309542253, 15395.461158859414, 15440.536783896472, 14118.788218176736, 14203.78694319586, 14323.140611563313, 14345.497907573237, 14352.067115637476, 749.8912657664636, 893.1291990309429, 916.5921165081542, 917.8990311065777, 918.4168053286145, 896.892372915251, 906.026022026321, 908.8409528332515, 912.4434095201922, 912.5118061836919, 962.1196605106319, 965.1072757699101, 965.4593427680486, 966.4491239993207, 970.3935040599625, 949.2358651285713, 954.341504361988, 955.5317894231846, 956.9043095690445, 957.4255446731975, 700.2402393403164, 703.8416356319839, 705.6154395854272, 706.5619316024047, 707.2008630247839, 14774.187419691913, 15002.24988750558, 15026.549203523911, 15030.0, 15035.0, 14059.226742529157, 14113.153210807384, 14261.144331340152, 14478.058926169766, 14510.927445362811, 11633.36016519091, 11972.521099156023, 11982.64052078439, 12058.517659293619, 12256.877431225663, 4028.738132021409, 4032.1129351542613, 4039.6768258539246, 4088.0, 4138.8344466221315, 54164.0, 54300.72849635766, 55027.449725502636, 55109.0, 55205.447945520435, 10807.513661885234, 10812.621558245424, 11036.282641628268, 11169.83245251322, 11433.656990290305, 19805.504862378555, 19900.70148947767, 20005.699914501292, 20007.299744508873, 20079.698804517942, 8985.146411090936, 9009.954950225207, 9058.0, 9086.318526110435, 9112.043235460182, 4940.357753492023, 4987.675801072919, 5040.722760248222, 5063.822766203165, 5069.594432445396, 3593.047842321787, 3663.487111804296, 3669.082729317671, 3669.743117981769, 3676.1544844685873, 665.1851481934591, 670.2258890980925, 674.4487678339799, 679.6262055869253, 689.2246222999127, 686.7287421468492, 819.1849110135335, 834.968813515308, 842.2461896602506, 867.2498288979987, 9546.140847323635, 9627.085426884434, 9704.320697551244, 9713.465759383302, 9915.355501892354, 749.3293502315397, 767.7159451003165, 779.8050487378156, 788.4993029426356, 795.4551132474273, 4339.240632889232, 4435.334699794992, 4528.886777830515, 4535.707323412811, 4630.351750754897, 60847.0, 61937.38062619316, 62061.37938620646, 65007.0, 65401.34598654048, 52087.21869171965, 52889.73555132277, 53036.73481632567, 54565.45434545604, 55684.72157639186, 48835.51164488381, 49604.25593616099, 50161.74919125381, 50167.74916125323, 50348.748256258485, 9545.28410369239, 9545.331826772059, 9694.5152742364, 9731.61073557078, 9830.901690982999, 36703.08242293964, 37302.626973731, 37981.810090949366, 38386.42420363753, 38995.610043900335, 43363.0, 43504.34743478787, 45291.32063018991, 47903.0, 48807.267890980955, 12518.561850335194, 12720.263768664478, 12735.681607959876, 12785.273988011872, 12943.417546210254, 14217.573472795833, 14243.786343205067, 14368.137911724913, 14411.92794036065, 14651.413943442569, 13445.529406470727, 13625.046246762631, 13655.385507651981, 13769.586912392644, 13843.723125537232, 12926.159799612995, 12942.288174150512, 13022.869771302167, 13141.737165256833, 13176.60470185896, 12553.560625378068, 12765.93617031909, 12859.871401285867, 12878.613641590768, 12928.741425171633, 11044.502997364978, 11231.326120432801, 11261.493232804707, 11352.0, 11444.713882153013, 10462.843057353994, 10890.23768336209, 11064.778704426028, 11280.32318060919, 11299.943500282447], "value": 7156.670850086648, "unit": "score"}], "name": "dromaeo_css", "value": 7646.9202799538, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 114.0, 105.0, 111.0, 116.0, 113.0, 102.0, 111.0, 111.0, 112.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 128.0, 153.0, 178.0, 130.0, 163.0, 156.0, 129.0, 179.0, 127.0], "value": 151.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 162.0, 162.0, 162.0, 162.0, 163.0, 163.0, 161.0, 160.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 74.0, 178.0, 86.0, 77.0, 73.0, 77.0, 157.0, 73.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 153.0, 92.0, 93.0, 92.0, 143.0, 91.0, 92.0, 145.0], "value": 108.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 145.0, 147.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 98.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 58.0, 58.0, 56.0, 57.0, 65.0, 56.0, 85.0, 55.0, 56.0], "value": 60.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 58.0, 58.0, 58.0, 58.0, 58.0, 58.0, 59.0, 57.0], "value": 57.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 74.0, 73.0, 75.0, 74.0, 75.0, 76.0, 76.0, 74.0], "value": 74.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 112.0, 117.0, 129.0, 124.0, 113.0, 111.0, 121.0, 134.0, 126.0], "value": 120.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 159.0, 162.0, 164.0, 165.0, 160.0, 160.0, 159.0, 160.0, 160.0], "value": 161.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 67.0, 66.0, 65.0, 66.0, 65.0, 67.0, 71.0, 63.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1527.8000000000002, "alertThreshold": 2.0}]} 14:43:42 INFO - Return code: 0 14:43:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:43:42 ERROR - # TBPL SUCCESS # 14:43:42 INFO - Running post-action listener: _resource_record_post_action 14:43:42 INFO - Running post-run listener: _resource_record_post_run 14:43:43 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 266240; Write bytes: 496726016; Read time: 40; Write time: 500476 14:43:43 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 248586240; Read time: 0; Write time: 299832 14:43:43 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 266240; Write bytes: 247541760; Read time: 40; Write time: 200644 14:43:43 INFO - Running post-run listener: _upload_blobber_files 14:43:43 INFO - Blob upload gear active. 14:43:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:43:43 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:43:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:43:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:43:44 INFO - (blobuploader) - INFO - Open directory for files ... 14:43:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:43:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:43:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:43:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:43:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:43:45 INFO - (blobuploader) - INFO - Done attempting. 14:43:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:43:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:43:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:43:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:43:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:43:45 INFO - (blobuploader) - INFO - Done attempting. 14:43:45 INFO - (blobuploader) - INFO - Iteration through files over. 14:43:45 INFO - Return code: 0 14:43:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:43:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:43:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4aa79cf08dafcfd012d784efda77b044ac9182626edaef8539d97e00e834baa7727177fedce10c5e61284994e9ca96b4650df2ab62819f48c4bfd7ebc0fa88c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e4aa20d8d508a06c5efc0622055837237c7c115ebea09d396f32326c137e55565e00b2b9e79fdada465869117005b4b1318a46b88ce8ddc66360f7d8560bc5ea"} 14:43:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:43:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:43:45 INFO - Contents: 14:43:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4aa79cf08dafcfd012d784efda77b044ac9182626edaef8539d97e00e834baa7727177fedce10c5e61284994e9ca96b4650df2ab62819f48c4bfd7ebc0fa88c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e4aa20d8d508a06c5efc0622055837237c7c115ebea09d396f32326c137e55565e00b2b9e79fdada465869117005b4b1318a46b88ce8ddc66360f7d8560bc5ea"} 14:43:45 INFO - Running post-run listener: copy_logs_to_upload_dir 14:43:45 INFO - Copying logs to upload dir... 14:43:45 INFO - mkdir: /builds/slave/test/build/upload/logs 14:43:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.396456 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-27 14:43:45.970788) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 14:43:45.974048) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1464383393.798968-462684534 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4aa79cf08dafcfd012d784efda77b044ac9182626edaef8539d97e00e834baa7727177fedce10c5e61284994e9ca96b4650df2ab62819f48c4bfd7ebc0fa88c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e4aa20d8d508a06c5efc0622055837237c7c115ebea09d396f32326c137e55565e00b2b9e79fdada465869117005b4b1318a46b88ce8ddc66360f7d8560bc5ea"} build_url:https://queue.taskcluster.net/v1/task/KVuxwz4DSIqVLwYm2b0dEA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011340 build_url: 'https://queue.taskcluster.net/v1/task/KVuxwz4DSIqVLwYm2b0dEA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4aa79cf08dafcfd012d784efda77b044ac9182626edaef8539d97e00e834baa7727177fedce10c5e61284994e9ca96b4650df2ab62819f48c4bfd7ebc0fa88c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e4aa20d8d508a06c5efc0622055837237c7c115ebea09d396f32326c137e55565e00b2b9e79fdada465869117005b4b1318a46b88ce8ddc66360f7d8560bc5ea"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 14:43:46.000124) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 14:43:46.000467) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1464383393.798968-462684534 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004577 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 14:43:46.086749) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 14:43:46.087078) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 14:43:46.087385) ========= ========= Total master_lag: 0.19 =========