builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-014 starttime: 1463135425.98 results: success (0) buildid: 20160513004028 builduid: d56445dd760f49eba684f6309ac6ae2f revision: 898a985fd269aab39ba07cb56ce402ccacd52ee2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 03:30:25.985793) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 03:30:25.986263) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 03:30:25.986583) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 03:30:26.005714) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 03:30:26.006048) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1463134744.268918-2108606967 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-13 03:30:26-- 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% 70.4M=0s 2016-05-13 03:30:26 (70.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.136318 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 03:30:26.156088) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 03:30:26.156380) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1463134744.268918-2108606967 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020089 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 03:30:26.205166) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-13 03:30:26.205512) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 898a985fd269aab39ba07cb56ce402ccacd52ee2 --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 898a985fd269aab39ba07cb56ce402ccacd52ee2 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1463134744.268918-2108606967 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-13 03:30:26,413 truncating revision to first 12 chars 2016-05-13 03:30:26,413 Setting DEBUG logging. 2016-05-13 03:30:26,413 attempt 1/10 2016-05-13 03:30:26,413 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/898a985fd269?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-13 03:30:27,321 unpacking tar archive at: mozilla-aurora-898a985fd269/testing/mozharness/ program finished with exit code 0 elapsedTime=1.152148 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-13 03:30:27.372515) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 03:30:27.372809) ========= script_repo_revision: 898a985fd269aab39ba07cb56ce402ccacd52ee2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 03:30:27.373227) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 03:30:27.373501) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 03:30:27.382952) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-05-13 03:30:27.383314) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1463134744.268918-2108606967 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:30:27 INFO - MultiFileLogger online at 20160513 03:30:27 in /builds/slave/test 03:30:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:30:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:30:27 INFO - {'append_to_log': False, 03:30:27 INFO - 'base_work_dir': '/builds/slave/test', 03:30:27 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:30:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:30:27 INFO - 'branch': 'Mozilla-Aurora', 03:30:27 INFO - 'buildbot_json_path': 'buildprops.json', 03:30:27 INFO - 'config_files': ('talos/linux_config.py',), 03:30:27 INFO - 'default_actions': ('clobber', 03:30:27 INFO - 'read-buildbot-config', 03:30:27 INFO - 'download-and-extract', 03:30:27 INFO - 'populate-webroot', 03:30:27 INFO - 'create-virtualenv', 03:30:27 INFO - 'install', 03:30:27 INFO - 'run-tests'), 03:30:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:30:27 INFO - 'download_minidump_stackwalk': True, 03:30:27 INFO - 'download_symbols': 'ondemand', 03:30:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:30:27 INFO - 'tooltool.py': '/tools/tooltool.py', 03:30:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:30:27 INFO - '/tools/misc-python/virtualenv.py')}, 03:30:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:30:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:30:27 INFO - 'installer_path': 'installer.exe', 03:30:27 INFO - 'log_level': 'info', 03:30:27 INFO - 'log_name': 'talos', 03:30:27 INFO - 'log_to_console': True, 03:30:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:30:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:30:27 INFO - 'opt_config_files': (), 03:30:27 INFO - 'pip_index': False, 03:30:27 INFO - 'sps_profile': False, 03:30:27 INFO - 'sps_profile_interval': 0, 03:30:27 INFO - 'suite': 'dromaeojs', 03:30:27 INFO - 'system_bits': '32', 03:30:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:30:27 INFO - 'title': 'talos-linux64-ix-014', 03:30:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:30:27 INFO - 'use_talos_json': True, 03:30:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:30:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:30:27 INFO - 'work_dir': 'build'} 03:30:27 INFO - ##### 03:30:27 INFO - ##### Running clobber step. 03:30:27 INFO - ##### 03:30:27 INFO - Running pre-action listener: _resource_record_pre_action 03:30:27 INFO - Running main action method: clobber 03:30:27 INFO - rmtree: /builds/slave/test/build 03:30:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:30:28 INFO - Running post-action listener: _resource_record_post_action 03:30:28 INFO - ##### 03:30:28 INFO - ##### Running read-buildbot-config step. 03:30:28 INFO - ##### 03:30:28 INFO - Running pre-action listener: _resource_record_pre_action 03:30:28 INFO - Running main action method: read_buildbot_config 03:30:28 INFO - Using buildbot properties: 03:30:28 INFO - { 03:30:28 INFO - "project": "", 03:30:28 INFO - "product": "firefox", 03:30:28 INFO - "script_repo_revision": "production", 03:30:28 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:30:28 INFO - "repository": "", 03:30:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:30:28 INFO - "buildid": "20160513004028", 03:30:28 INFO - "stage_platform": "linux64-pgo", 03:30:28 INFO - "basedir": "/builds/slave/test", 03:30:28 INFO - "nightly_build": "True", 03:30:28 INFO - "buildnumber": 329, 03:30:28 INFO - "slavename": "talos-linux64-ix-014", 03:30:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:30:28 INFO - "platform": "ubuntu64_hw", 03:30:28 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:30:28 INFO - "branch": "mozilla-aurora", 03:30:28 INFO - "repo_path": "releases/mozilla-aurora", 03:30:28 INFO - "revision": "898a985fd269aab39ba07cb56ce402ccacd52ee2", 03:30:28 INFO - "pgo_build": "True", 03:30:28 INFO - "builduid": "d56445dd760f49eba684f6309ac6ae2f", 03:30:28 INFO - "slavebuilddir": "test" 03:30:28 INFO - } 03:30:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/JfeGISsqQtexHifryKtjPg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 03:30:28 INFO - Running post-action listener: _resource_record_post_action 03:30:28 INFO - ##### 03:30:28 INFO - ##### Running download-and-extract step. 03:30:28 INFO - ##### 03:30:28 INFO - Running pre-action listener: _resource_record_pre_action 03:30:28 INFO - Running main action method: download_and_extract 03:30:28 INFO - mkdir: /builds/slave/test/build/tests 03:30:28 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')]} 03:30:28 INFO - https://queue.taskcluster.net/v1/task/JfeGISsqQtexHifryKtjPg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:30:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JfeGISsqQtexHifryKtjPg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:30:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JfeGISsqQtexHifryKtjPg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:30:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JfeGISsqQtexHifryKtjPg/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 03:30:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JfeGISsqQtexHifryKtjPg/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 03:30:32 INFO - Downloaded 1361 bytes. 03:30:32 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:30:32 INFO - Using the following test package requirements: 03:30:32 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:30:32 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:32 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:30:32 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:32 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:30:32 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:32 INFO - u'jsshell-linux-x86_64.zip'], 03:30:32 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:32 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:30:32 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:30:32 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:32 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:30:32 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:32 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:30:32 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:32 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:30:32 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:32 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:30:32 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:30: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')]} 03:30:32 INFO - https://queue.taskcluster.net/v1/task/JfeGISsqQtexHifryKtjPg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:30:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JfeGISsqQtexHifryKtjPg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:30:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JfeGISsqQtexHifryKtjPg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:30:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JfeGISsqQtexHifryKtjPg/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 03:30:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JfeGISsqQtexHifryKtjPg/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 03:30:33 INFO - Downloaded 23800433 bytes. 03:30:33 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'] 03:30:33 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 03:30:34 INFO - Return code: 0 03:30:34 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 03:30:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:34 INFO - https://queue.taskcluster.net/v1/task/JfeGISsqQtexHifryKtjPg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:30:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JfeGISsqQtexHifryKtjPg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:30:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JfeGISsqQtexHifryKtjPg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:30:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JfeGISsqQtexHifryKtjPg/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 03:30:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JfeGISsqQtexHifryKtjPg/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 03:30:38 INFO - Downloaded 23800433 bytes. 03:30:38 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'] 03:30:38 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 03:30:39 INFO - Return code: 0 03:30:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:39 INFO - https://queue.taskcluster.net/v1/task/JfeGISsqQtexHifryKtjPg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:30:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JfeGISsqQtexHifryKtjPg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:30:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JfeGISsqQtexHifryKtjPg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:30:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JfeGISsqQtexHifryKtjPg/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 03:30:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JfeGISsqQtexHifryKtjPg/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 03:30:40 INFO - Downloaded 10840145 bytes. 03:30:40 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'] 03:30:40 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 03:30:40 INFO - Return code: 0 03:30:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:40 INFO - https://queue.taskcluster.net/v1/task/JfeGISsqQtexHifryKtjPg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:30:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JfeGISsqQtexHifryKtjPg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:30:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JfeGISsqQtexHifryKtjPg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:30:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JfeGISsqQtexHifryKtjPg/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 03:30:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JfeGISsqQtexHifryKtjPg/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 03:30:42 INFO - Downloaded 62693342 bytes. 03:30:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JfeGISsqQtexHifryKtjPg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:30:42 INFO - mkdir: /builds/slave/test/properties 03:30:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:30:42 INFO - Writing to file /builds/slave/test/properties/build_url 03:30:42 INFO - Contents: 03:30:42 INFO - build_url:https://queue.taskcluster.net/v1/task/JfeGISsqQtexHifryKtjPg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:30:43 INFO - Running post-action listener: _resource_record_post_action 03:30:43 INFO - Running post-action listener: set_extra_try_arguments 03:30:43 INFO - ##### 03:30:43 INFO - ##### Running populate-webroot step. 03:30:43 INFO - ##### 03:30:43 INFO - Running pre-action listener: _resource_record_pre_action 03:30:43 INFO - Running main action method: populate_webroot 03:30:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:30:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:30:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:30:43 INFO - '--tppagecycles', 03:30:43 INFO - '7'], 03:30:43 INFO - 'tests': ['tsvgm']}}, 03:30:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:30:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:30:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:30:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:30:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:30:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:30:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:43 INFO - 'talos_options': ['--disable-e10s'], 03:30:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:30:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:30:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:43 INFO - 'talos_options': ['--disable-e10s'], 03:30:43 INFO - 'tests': ['damp', 'tps']}, 03:30:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:43 INFO - 'tests': ['damp', 'tps']}, 03:30:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:30:43 INFO - 'tests': ['dromaeo_dom']}, 03:30:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:30:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:30:43 INFO - 'tests': ['a11yr', 03:30:43 INFO - 'ts_paint', 03:30:43 INFO - 'tpaint', 03:30:43 INFO - 'sessionrestore', 03:30:43 INFO - 'sessionrestore_no_auto_restore', 03:30:43 INFO - 'tabpaint']}, 03:30:43 INFO - 'other-e10s': {'tests': ['a11yr', 03:30:43 INFO - 'ts_paint', 03:30:43 INFO - 'tpaint', 03:30:43 INFO - 'sessionrestore', 03:30:43 INFO - 'sessionrestore_no_auto_restore', 03:30:43 INFO - 'tabpaint']}, 03:30:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:30:43 INFO - 'ts_paint', 03:30:43 INFO - 'tpaint', 03:30:43 INFO - 'sessionrestore', 03:30:43 INFO - 'sessionrestore_no_auto_restore', 03:30:43 INFO - 'tabpaint']}, 03:30:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:30:43 INFO - 'ts_paint', 03:30:43 INFO - 'tpaint', 03:30:43 INFO - 'sessionrestore', 03:30:43 INFO - 'sessionrestore_no_auto_restore', 03:30:43 INFO - 'tabpaint']}, 03:30:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:30:43 INFO - 'tests': ['a11yr', 03:30:43 INFO - 'ts_paint', 03:30:43 INFO - 'tpaint', 03:30:43 INFO - 'sessionrestore', 03:30:43 INFO - 'sessionrestore_no_auto_restore', 03:30:43 INFO - 'tabpaint']}, 03:30:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:30:43 INFO - 'tests': ['a11yr', 03:30:43 INFO - 'ts_paint', 03:30:43 INFO - 'tpaint', 03:30:43 INFO - 'sessionrestore', 03:30:43 INFO - 'sessionrestore_no_auto_restore', 03:30:43 INFO - 'tabpaint']}, 03:30:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:30:43 INFO - 'tests': ['tsvgx', 03:30:43 INFO - 'tsvgr_opacity', 03:30:43 INFO - 'tart', 03:30:43 INFO - 'tscrollx', 03:30:43 INFO - 'cart']}, 03:30:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:30:43 INFO - 'tsvgr_opacity', 03:30:43 INFO - 'tart', 03:30:43 INFO - 'tscrollx', 03:30:43 INFO - 'cart']}, 03:30:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:43 INFO - 'talos_options': ['--disable-e10s'], 03:30:43 INFO - 'tests': ['tp5o']}, 03:30:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:43 INFO - 'tests': ['tp5o']}, 03:30:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:43 INFO - 'talos_options': ['--disable-e10s', 03:30:43 INFO - '--xperf_path', 03:30:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:30:43 INFO - 'tests': ['tp5n']}, 03:30:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:43 INFO - 'talos_options': ['--xperf_path', 03:30:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:30:43 INFO - 'tests': ['tp5n']}}, 03:30:43 INFO - 'talos.zip': {'path': '', 03:30:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:30:43 INFO - Running post-action listener: _resource_record_post_action 03:30:43 INFO - ##### 03:30:43 INFO - ##### Running create-virtualenv step. 03:30:43 INFO - ##### 03:30:43 INFO - Running pre-action listener: _resource_record_pre_action 03:30:43 INFO - Running main action method: create_virtualenv 03:30:43 INFO - Creating virtualenv /builds/slave/test/build/venv 03:30:43 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 03:30:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:30:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:30:43 INFO - Using real prefix '/usr' 03:30:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:30:43 INFO - Installing distribute.............................................................................................................................................................................................done. 03:30:45 INFO - Installing pip.................done. 03:30:45 INFO - Return code: 0 03:30:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:30:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:45 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 0x7f4287210f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a715a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b00410>, '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 0x2b01310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b017a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1463134744.268918-2108606967', '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 03:30:45 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 03:30:45 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 03:30:45 INFO - Using env: {'DISPLAY': ':0', 03:30:45 INFO - 'HOME': '/home/cltbld', 03:30:45 INFO - 'LANG': 'en_US.UTF-8', 03:30:45 INFO - 'LANGUAGE': 'en_US:en', 03:30:45 INFO - 'LOGNAME': 'cltbld', 03:30:45 INFO - 'MAIL': '/var/mail/cltbld', 03:30:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:45 INFO - 'MOZ_NO_REMOTE': '1', 03:30:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:45 INFO - 'NO_EM_RESTART': '1', 03:30:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:45 INFO - 'PWD': '/builds/slave/test', 03:30:45 INFO - 'SHELL': '/bin/bash', 03:30:45 INFO - 'SHLVL': '1', 03:30:45 INFO - 'TERM': 'linux', 03:30:45 INFO - 'TMOUT': '86400', 03:30:45 INFO - 'USER': 'cltbld', 03:30:45 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1463134744.268918-2108606967', 03:30:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:45 INFO - '_': '/tools/buildbot/bin/python'} 03:30:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:45 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 03:30:45 INFO - Cleaning up... 03:30:45 INFO - Return code: 0 03:30:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:30:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:45 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 0x7f4287210f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a715a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b00410>, '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 0x2b01310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b017a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1463134744.268918-2108606967', '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 03:30:45 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 03:30:45 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 03:30:45 INFO - Using env: {'DISPLAY': ':0', 03:30:45 INFO - 'HOME': '/home/cltbld', 03:30:45 INFO - 'LANG': 'en_US.UTF-8', 03:30:45 INFO - 'LANGUAGE': 'en_US:en', 03:30:45 INFO - 'LOGNAME': 'cltbld', 03:30:45 INFO - 'MAIL': '/var/mail/cltbld', 03:30:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:45 INFO - 'MOZ_NO_REMOTE': '1', 03:30:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:45 INFO - 'NO_EM_RESTART': '1', 03:30:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:45 INFO - 'PWD': '/builds/slave/test', 03:30:45 INFO - 'SHELL': '/bin/bash', 03:30:45 INFO - 'SHLVL': '1', 03:30:45 INFO - 'TERM': 'linux', 03:30:45 INFO - 'TMOUT': '86400', 03:30:45 INFO - 'USER': 'cltbld', 03:30:45 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1463134744.268918-2108606967', 03:30:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:45 INFO - '_': '/tools/buildbot/bin/python'} 03:30:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:46 INFO - Downloading/unpacking psutil>=0.7.1 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:30:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:30:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:30:48 INFO - Installing collected packages: psutil 03:30:48 INFO - Running setup.py install for psutil 03:30:48 INFO - building 'psutil._psutil_linux' extension 03:30:48 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 03:30:48 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 03:30:48 INFO - building 'psutil._psutil_posix' extension 03:30:48 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 03:30:48 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 03:30:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:30:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:30:48 INFO - Successfully installed psutil 03:30:48 INFO - Cleaning up... 03:30:48 INFO - Return code: 0 03:30:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:30: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')]} 03:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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')]} 03:30:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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', '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 0x7f4287210f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a715a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b00410>, '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 0x2b01310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b017a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1463134744.268918-2108606967', '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 03:30: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:30: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 mozsystemmonitor==0.0.0 03:30:48 INFO - Using env: {'DISPLAY': ':0', 03:30:48 INFO - 'HOME': '/home/cltbld', 03:30:48 INFO - 'LANG': 'en_US.UTF-8', 03:30:48 INFO - 'LANGUAGE': 'en_US:en', 03:30:48 INFO - 'LOGNAME': 'cltbld', 03:30:48 INFO - 'MAIL': '/var/mail/cltbld', 03:30:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:48 INFO - 'MOZ_NO_REMOTE': '1', 03:30:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:48 INFO - 'NO_EM_RESTART': '1', 03:30:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:48 INFO - 'PWD': '/builds/slave/test', 03:30:48 INFO - 'SHELL': '/bin/bash', 03:30:48 INFO - 'SHLVL': '1', 03:30:48 INFO - 'TERM': 'linux', 03:30:48 INFO - 'TMOUT': '86400', 03:30:48 INFO - 'USER': 'cltbld', 03:30:48 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1463134744.268918-2108606967', 03:30:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:48 INFO - '_': '/tools/buildbot/bin/python'} 03:30:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:30:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:30:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:30:50 INFO - Installing collected packages: mozsystemmonitor 03:30:50 INFO - Running setup.py install for mozsystemmonitor 03:30:50 INFO - Successfully installed mozsystemmonitor 03:30:50 INFO - Cleaning up... 03:30:50 INFO - Return code: 0 03:30:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:30:50 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')]} 03:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:50 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')]} 03:30:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:50 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 0x7f4287210f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a715a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b00410>, '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 0x2b01310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b017a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1463134744.268918-2108606967', '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 03:30:50 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 03:30:50 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 03:30:50 INFO - Using env: {'DISPLAY': ':0', 03:30:50 INFO - 'HOME': '/home/cltbld', 03:30:50 INFO - 'LANG': 'en_US.UTF-8', 03:30:50 INFO - 'LANGUAGE': 'en_US:en', 03:30:50 INFO - 'LOGNAME': 'cltbld', 03:30:50 INFO - 'MAIL': '/var/mail/cltbld', 03:30:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:50 INFO - 'MOZ_NO_REMOTE': '1', 03:30:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:50 INFO - 'NO_EM_RESTART': '1', 03:30:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:50 INFO - 'PWD': '/builds/slave/test', 03:30:50 INFO - 'SHELL': '/bin/bash', 03:30:50 INFO - 'SHLVL': '1', 03:30:50 INFO - 'TERM': 'linux', 03:30:50 INFO - 'TMOUT': '86400', 03:30:50 INFO - 'USER': 'cltbld', 03:30:50 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1463134744.268918-2108606967', 03:30:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:50 INFO - '_': '/tools/buildbot/bin/python'} 03:30:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:51 INFO - Downloading/unpacking blobuploader==1.2.4 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30:53 INFO - Downloading blobuploader-1.2.4.tar.gz 03:30:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:30:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:30:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30:53 INFO - Downloading docopt-0.6.1.tar.gz 03:30:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:30:53 INFO - Installing collected packages: blobuploader, requests, docopt 03:30:53 INFO - Running setup.py install for blobuploader 03:30:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:30:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:30:53 INFO - Running setup.py install for requests 03:30:54 INFO - Running setup.py install for docopt 03:30:54 INFO - Successfully installed blobuploader requests docopt 03:30:54 INFO - Cleaning up... 03:30:54 INFO - Return code: 0 03:30:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:30:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:54 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 0x7f4287210f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a715a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b00410>, '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 0x2b01310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b017a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1463134744.268918-2108606967', '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 03:30:54 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 03:30:54 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 03:30:54 INFO - Using env: {'DISPLAY': ':0', 03:30:54 INFO - 'HOME': '/home/cltbld', 03:30:54 INFO - 'LANG': 'en_US.UTF-8', 03:30:54 INFO - 'LANGUAGE': 'en_US:en', 03:30:54 INFO - 'LOGNAME': 'cltbld', 03:30:54 INFO - 'MAIL': '/var/mail/cltbld', 03:30:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:54 INFO - 'MOZ_NO_REMOTE': '1', 03:30:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:54 INFO - 'NO_EM_RESTART': '1', 03:30:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:54 INFO - 'PWD': '/builds/slave/test', 03:30:54 INFO - 'SHELL': '/bin/bash', 03:30:54 INFO - 'SHLVL': '1', 03:30:54 INFO - 'TERM': 'linux', 03:30:54 INFO - 'TMOUT': '86400', 03:30:54 INFO - 'USER': 'cltbld', 03:30:54 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1463134744.268918-2108606967', 03:30:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:54 INFO - '_': '/tools/buildbot/bin/python'} 03:30:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:30:54 INFO - Running setup.py (path:/tmp/pip-J0keGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:30:54 INFO - Running setup.py (path:/tmp/pip-3kOZks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:30:54 INFO - Running setup.py (path:/tmp/pip-J3EVZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:30:54 INFO - Running setup.py (path:/tmp/pip-RJONHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:30:54 INFO - Running setup.py (path:/tmp/pip-uPSRrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:30:54 INFO - Running setup.py (path:/tmp/pip-VZGwn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:30:55 INFO - Running setup.py (path:/tmp/pip-Aehe8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:30:55 INFO - Running setup.py (path:/tmp/pip-byq3UV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:30:55 INFO - Running setup.py (path:/tmp/pip-KkpbAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:30:55 INFO - Running setup.py (path:/tmp/pip-BST7nC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:30:55 INFO - Running setup.py (path:/tmp/pip-BKjJGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:30:55 INFO - Running setup.py (path:/tmp/pip-xFlrPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:30:55 INFO - Running setup.py (path:/tmp/pip-lKNY_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:30:55 INFO - Running setup.py (path:/tmp/pip-AbOb5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:55 INFO - Running setup.py (path:/tmp/pip-dSq5o4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:30:55 INFO - Running setup.py (path:/tmp/pip-i6byZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:30:55 INFO - Running setup.py (path:/tmp/pip-MsN3oe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:30:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:30:55 INFO - Running setup.py install for manifestparser 03:30:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:30:55 INFO - Running setup.py install for mozcrash 03:30:56 INFO - Running setup.py install for mozdebug 03:30:56 INFO - Running setup.py install for mozdevice 03:30:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:30:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:30:56 INFO - Running setup.py install for mozfile 03:30:56 INFO - Running setup.py install for mozhttpd 03:30:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:30:56 INFO - Running setup.py install for mozinfo 03:30:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:30:56 INFO - Running setup.py install for mozInstall 03:30:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:30:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:30:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:30:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:30:56 INFO - Running setup.py install for mozleak 03:30:56 INFO - Running setup.py install for mozlog 03:30:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:30:56 INFO - Running setup.py install for moznetwork 03:30:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:30:57 INFO - Running setup.py install for mozprocess 03:30:57 INFO - Running setup.py install for mozprofile 03:30:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:30:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:30:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:30:57 INFO - Running setup.py install for mozrunner 03:30:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:30:57 INFO - Running setup.py install for mozscreenshot 03:30:57 INFO - Running setup.py install for moztest 03:30:57 INFO - Running setup.py install for mozversion 03:30:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:30:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:30:57 INFO - Cleaning up... 03:30:57 INFO - Return code: 0 03:30:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:30:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:57 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 0x7f4287210f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a715a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b00410>, '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 0x2b01310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b017a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1463134744.268918-2108606967', '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 03:30:57 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 03:30:57 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 03:30:57 INFO - Using env: {'DISPLAY': ':0', 03:30:57 INFO - 'HOME': '/home/cltbld', 03:30:57 INFO - 'LANG': 'en_US.UTF-8', 03:30:57 INFO - 'LANGUAGE': 'en_US:en', 03:30:57 INFO - 'LOGNAME': 'cltbld', 03:30:57 INFO - 'MAIL': '/var/mail/cltbld', 03:30:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:57 INFO - 'MOZ_NO_REMOTE': '1', 03:30:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:57 INFO - 'NO_EM_RESTART': '1', 03:30:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:57 INFO - 'PWD': '/builds/slave/test', 03:30:57 INFO - 'SHELL': '/bin/bash', 03:30:57 INFO - 'SHLVL': '1', 03:30:57 INFO - 'TERM': 'linux', 03:30:57 INFO - 'TMOUT': '86400', 03:30:57 INFO - 'USER': 'cltbld', 03:30:57 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1463134744.268918-2108606967', 03:30:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:57 INFO - '_': '/tools/buildbot/bin/python'} 03:30:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:30:57 INFO - Running setup.py (path:/tmp/pip-8AX44c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:30:57 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)) 03:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:30:57 INFO - Running setup.py (path:/tmp/pip-5jd8f9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:30:58 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)) 03:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:30:58 INFO - Running setup.py (path:/tmp/pip-4cFv3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:30:58 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)) 03:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:30:58 INFO - Running setup.py (path:/tmp/pip-WfzEcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:30:58 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)) 03:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:30:58 INFO - Running setup.py (path:/tmp/pip-vwVafS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:30:58 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)) 03:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:30:58 INFO - Running setup.py (path:/tmp/pip-gnS8fl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:30:58 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)) 03:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:30:58 INFO - Running setup.py (path:/tmp/pip-RTgt5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:30:58 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)) 03:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:30:58 INFO - Running setup.py (path:/tmp/pip-lABSWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:30:58 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)) 03:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:30:58 INFO - Running setup.py (path:/tmp/pip-Slc4K0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:30:58 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)) 03:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:30:58 INFO - Running setup.py (path:/tmp/pip-BX_mvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:30:58 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)) 03:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:30:58 INFO - Running setup.py (path:/tmp/pip-TzeEZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:30:58 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)) 03:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:30:58 INFO - Running setup.py (path:/tmp/pip-DU_FSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:30:58 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)) 03:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:30:58 INFO - Running setup.py (path:/tmp/pip-1NaarK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:30:58 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)) 03:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:30:58 INFO - Running setup.py (path:/tmp/pip-OKUpNq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:30:58 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)) 03:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:58 INFO - Running setup.py (path:/tmp/pip-yQXZZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:58 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)) 03:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:30:58 INFO - Running setup.py (path:/tmp/pip-aLzKBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:30:59 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)) 03:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:30:59 INFO - Running setup.py (path:/tmp/pip-ETBp4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:30:59 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)) 03:30:59 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)) 03:30:59 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)) 03:30:59 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)) 03:30:59 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)) 03:30:59 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)) 03:30:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:00 INFO - Downloading blessings-1.6.tar.gz 03:31:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:31:01 INFO - Installing collected packages: blessings 03:31:01 INFO - Running setup.py install for blessings 03:31:01 INFO - Successfully installed blessings 03:31:01 INFO - Cleaning up... 03:31:01 INFO - Return code: 0 03:31:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:31:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:31:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:31:01 INFO - Reading from file tmpfile_stdout 03:31:01 INFO - Current package versions: 03:31:01 INFO - argparse == 1.2.1 03:31:01 INFO - blessings == 1.6 03:31:01 INFO - blobuploader == 1.2.4 03:31:01 INFO - docopt == 0.6.1 03:31:01 INFO - manifestparser == 1.1 03:31:01 INFO - mozInstall == 1.12 03:31:01 INFO - mozcrash == 0.17 03:31:01 INFO - mozdebug == 0.1 03:31:01 INFO - mozdevice == 0.48 03:31:01 INFO - mozfile == 1.2 03:31:01 INFO - mozhttpd == 0.7 03:31:01 INFO - mozinfo == 0.9 03:31:01 INFO - mozleak == 0.1 03:31:01 INFO - mozlog == 3.1 03:31:01 INFO - moznetwork == 0.27 03:31:01 INFO - mozprocess == 0.22 03:31:01 INFO - mozprofile == 0.28 03:31:01 INFO - mozrunner == 6.11 03:31:01 INFO - mozscreenshot == 0.1 03:31:01 INFO - mozsystemmonitor == 0.0 03:31:01 INFO - moztest == 0.7 03:31:01 INFO - mozversion == 1.4 03:31:01 INFO - psutil == 3.1.1 03:31:01 INFO - requests == 1.2.3 03:31:01 INFO - wsgiref == 0.1.2 03:31:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:01 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 0x7f4287210f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a715a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b00410>, '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 0x2b01310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b017a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1463134744.268918-2108606967', '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 03:31:01 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 03:31:01 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 03:31:01 INFO - Using env: {'DISPLAY': ':0', 03:31:01 INFO - 'HOME': '/home/cltbld', 03:31:01 INFO - 'LANG': 'en_US.UTF-8', 03:31:01 INFO - 'LANGUAGE': 'en_US:en', 03:31:01 INFO - 'LOGNAME': 'cltbld', 03:31:01 INFO - 'MAIL': '/var/mail/cltbld', 03:31:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:01 INFO - 'MOZ_NO_REMOTE': '1', 03:31:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:01 INFO - 'NO_EM_RESTART': '1', 03:31:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:01 INFO - 'PWD': '/builds/slave/test', 03:31:01 INFO - 'SHELL': '/bin/bash', 03:31:01 INFO - 'SHLVL': '1', 03:31:01 INFO - 'TERM': 'linux', 03:31:01 INFO - 'TMOUT': '86400', 03:31:01 INFO - 'USER': 'cltbld', 03:31:01 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1463134744.268918-2108606967', 03:31:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:01 INFO - '_': '/tools/buildbot/bin/python'} 03:31:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:01 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)) 03:31:01 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)) 03:31:01 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)) 03:31:01 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)) 03:31:01 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)) 03:31:01 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)) 03:31:01 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)) 03:31:01 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)) 03:31:01 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)) 03:31:01 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)) 03:31:01 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)) 03:31:01 INFO - Cleaning up... 03:31:01 INFO - Return code: 0 03:31:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:31:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:01 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 0x7f4287210f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a715a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b00410>, '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 0x2b01310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b017a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1463134744.268918-2108606967', '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 03:31:01 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 03:31:01 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 03:31:01 INFO - Using env: {'DISPLAY': ':0', 03:31:01 INFO - 'HOME': '/home/cltbld', 03:31:01 INFO - 'LANG': 'en_US.UTF-8', 03:31:01 INFO - 'LANGUAGE': 'en_US:en', 03:31:01 INFO - 'LOGNAME': 'cltbld', 03:31:01 INFO - 'MAIL': '/var/mail/cltbld', 03:31:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:01 INFO - 'MOZ_NO_REMOTE': '1', 03:31:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:01 INFO - 'NO_EM_RESTART': '1', 03:31:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:01 INFO - 'PWD': '/builds/slave/test', 03:31:01 INFO - 'SHELL': '/bin/bash', 03:31:01 INFO - 'SHLVL': '1', 03:31:01 INFO - 'TERM': 'linux', 03:31:01 INFO - 'TMOUT': '86400', 03:31:01 INFO - 'USER': 'cltbld', 03:31:01 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1463134744.268918-2108606967', 03:31:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:01 INFO - '_': '/tools/buildbot/bin/python'} 03:31:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:01 INFO - Downloading/unpacking jsonschema 03:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:31:03 INFO - Downloading/unpacking functools32 (from jsonschema) 03:31:03 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 03:31:03 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 03:31:03 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 03:31:03 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 03:31:03 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 03:31:03 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 03:31:03 INFO - Downloading functools32-3.2.3-2.tar.gz 03:31:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:31:04 INFO - warning: no files found matching '*.txt' 03:31:04 INFO - no previously-included directories found matching 'build' 03:31:04 INFO - no previously-included directories found matching 'dist' 03:31:04 INFO - no previously-included directories found matching '.git*' 03:31:04 INFO - Installing collected packages: jsonschema, functools32 03:31:04 INFO - Running setup.py install for functools32 03:31:04 INFO - warning: no files found matching '*.txt' 03:31:04 INFO - no previously-included directories found matching 'build' 03:31:04 INFO - no previously-included directories found matching 'dist' 03:31:04 INFO - no previously-included directories found matching '.git*' 03:31:04 INFO - Successfully installed jsonschema functools32 03:31:04 INFO - Cleaning up... 03:31:04 INFO - Return code: 0 03:31:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:31:04 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')]} 03:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:04 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')]} 03:31:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:04 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 0x7f4287210f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a715a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b00410>, '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 0x2b01310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b017a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1463134744.268918-2108606967', '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 03:31:04 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 03:31:04 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 03:31:04 INFO - Using env: {'DISPLAY': ':0', 03:31:04 INFO - 'HOME': '/home/cltbld', 03:31:04 INFO - 'LANG': 'en_US.UTF-8', 03:31:04 INFO - 'LANGUAGE': 'en_US:en', 03:31:04 INFO - 'LOGNAME': 'cltbld', 03:31:04 INFO - 'MAIL': '/var/mail/cltbld', 03:31:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:04 INFO - 'MOZ_NO_REMOTE': '1', 03:31:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:04 INFO - 'NO_EM_RESTART': '1', 03:31:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:04 INFO - 'PWD': '/builds/slave/test', 03:31:04 INFO - 'SHELL': '/bin/bash', 03:31:04 INFO - 'SHLVL': '1', 03:31:04 INFO - 'TERM': 'linux', 03:31:04 INFO - 'TMOUT': '86400', 03:31:04 INFO - 'USER': 'cltbld', 03:31:04 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1463134744.268918-2108606967', 03:31:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:04 INFO - '_': '/tools/buildbot/bin/python'} 03:31:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:04 INFO - Downloading/unpacking flake8 03:31:04 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 03:31:04 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 03:31:04 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 03:31:04 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 03:31:04 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 03:31:04 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 03:31:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:31:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:31:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:31:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:31:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:31:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:31:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:31:07 INFO - no previously-included directories found matching 'docs/_build' 03:31:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:31:07 INFO - Running setup.py install for pep8 03:31:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:31:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:31:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:31:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:31:07 INFO - no previously-included directories found matching 'docs/_build' 03:31:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:31:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:31:07 INFO - Cleaning up... 03:31:07 INFO - Return code: 0 03:31:07 INFO - Running post-action listener: _resource_record_post_action 03:31:07 INFO - Running post-action listener: _start_resource_monitoring 03:31:07 INFO - Starting resource monitoring. 03:31:07 INFO - ##### 03:31:07 INFO - ##### Running install step. 03:31:07 INFO - ##### 03:31:07 INFO - Running pre-action listener: _resource_record_pre_action 03:31:07 INFO - Running main action method: install 03:31:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:31:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:31:07 INFO - Reading from file tmpfile_stdout 03:31:07 INFO - Detecting whether we're running mozinstall >=1.0... 03:31:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:31:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:31:07 INFO - Reading from file tmpfile_stdout 03:31:07 INFO - Output received: 03:31:07 INFO - Usage: mozinstall [options] installer 03:31:07 INFO - Options: 03:31:07 INFO - -h, --help show this help message and exit 03:31:07 INFO - -d DEST, --destination=DEST 03:31:07 INFO - Directory to install application into. [default: 03:31:07 INFO - "/builds/slave/test"] 03:31:07 INFO - --app=APP Application being installed. [default: firefox] 03:31:07 INFO - mkdir: /builds/slave/test/build/application 03:31:07 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'] 03:31:07 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 03:31:23 INFO - Reading from file tmpfile_stdout 03:31:23 INFO - Output received: 03:31:23 INFO - /builds/slave/test/build/application/firefox/firefox 03:31:23 INFO - Running post-action listener: _resource_record_post_action 03:31:23 INFO - ##### 03:31:23 INFO - ##### Running run-tests step. 03:31:23 INFO - ##### 03:31:23 INFO - Running pre-action listener: _resource_record_pre_action 03:31:23 INFO - Running main action method: run_tests 03:31:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:31:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:31:23 INFO - Python 2.7.3 03:31:23 INFO - Return code: 0 03:31:23 INFO - grabbing minidump binary from tooltool 03:31:23 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')]} 03:31:23 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 0x2b00410>, '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 0x2b01310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b017a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:31:23 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 03:31:23 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 03:31:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:31:23 INFO - Return code: 0 03:31:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:31:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:31:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:31:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:31:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:31:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:31:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:31:24 INFO - Return code: 0 03:31:24 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JfeGISsqQtexHifryKtjPg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:31:24 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JfeGISsqQtexHifryKtjPg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:31:24 INFO - Using env: {'DISPLAY': ':0', 03:31:24 INFO - 'HOME': '/home/cltbld', 03:31:24 INFO - 'LANG': 'en_US.UTF-8', 03:31:24 INFO - 'LANGUAGE': 'en_US:en', 03:31:24 INFO - 'LOGNAME': 'cltbld', 03:31:24 INFO - 'MAIL': '/var/mail/cltbld', 03:31:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:31:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:31:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:24 INFO - 'MOZ_NO_REMOTE': '1', 03:31:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:31:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:24 INFO - 'NO_EM_RESTART': '1', 03:31:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:24 INFO - 'PWD': '/builds/slave/test', 03:31:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:31:24 INFO - 'SHELL': '/bin/bash', 03:31:24 INFO - 'SHLVL': '1', 03:31:24 INFO - 'TERM': 'linux', 03:31:24 INFO - 'TMOUT': '86400', 03:31:24 INFO - 'USER': 'cltbld', 03:31:24 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1463134744.268918-2108606967', 03:31:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:24 INFO - '_': '/tools/buildbot/bin/python'} 03:31:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JfeGISsqQtexHifryKtjPg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:31:24 INFO - mozversion application_buildid: 20160513004028 03:31:24 INFO - mozversion application_changeset: 898a985fd269aab39ba07cb56ce402ccacd52ee2 03:31:24 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:31:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:31:24 INFO - mozversion application_name: Firefox 03:31:24 INFO - mozversion application_remotingname: firefox-dev 03:31:24 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:31:24 INFO - mozversion application_vendor: Mozilla 03:31:24 INFO - mozversion application_version: 48.0a2 03:31:24 INFO - mozversion platform_buildid: 20160513004028 03:31:24 INFO - mozversion platform_changeset: 898a985fd269aab39ba07cb56ce402ccacd52ee2 03:31:24 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:31:24 INFO - mozversion platform_version: 48.0a2 03:31:24 INFO - using testdate: 1463135484 03:31:24 INFO - actual date: 1463135484 03:31:24 INFO - starting webserver on 'localhost:52018' 03:31:24 INFO - SUITE-START | Running 2 tests 03:31:24 INFO - TEST-START | dromaeo_css 03:31:24 INFO - operating with platform_type : linux_ 03:31:24 INFO - Initialising browser for dromaeo_css test... 03:31:24 INFO - TEST-INFO | started process 8308 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA4qmxU/profile http://localhost:52018/getInfo.html) 03:31:28 INFO - PROCESS | 8308 | __metrics Screen width/height:1600/1200 03:31:28 INFO - PROCESS | 8308 | colorDepth:24 03:31:28 INFO - PROCESS | 8308 | Browser inner width/height: 1024/697 03:31:28 INFO - PROCESS | 8308 | __metrics 03:31:29 ERROR - PROCESS | 8308 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:31:29 INFO - TEST-INFO | 8308: exit 0 03:31:29 INFO - Browser initialized. 03:31:29 INFO - Running cycle 1/1 for dromaeo_css test... 03:31:29 INFO - TEST-INFO | started process 8398 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA4qmxU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:31:41 INFO - PROCESS | 8398 | RSS: Main: 141975552 03:31:41 INFO - PROCESS | 8398 | 03:32:32 INFO - PROCESS | 8398 | 1463135552841 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] 03:34:40 INFO - PROCESS | 8398 | Cycle 1(1): loaded http://localhost:52018/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52018/tests/dromaeo/cssquery-ext.html) 03:34:41 INFO - PROCESS | 8398 | RSS: Main: 249470976 03:34:41 INFO - PROCESS | 8398 | 03:37:43 INFO - PROCESS | 8398 | Cycle 1(1): loaded http://localhost:52018/tests/dromaeo/cssquery-ext.html (next: http://localhost:52018/tests/dromaeo/cssquery-jquery.html) 03:37:43 INFO - PROCESS | 8398 | RSS: Main: 228995072 03:37:43 INFO - PROCESS | 8398 | 03:40:45 INFO - PROCESS | 8398 | Cycle 1(1): loaded http://localhost:52018/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52018/tests/dromaeo/cssquery-mootools.html) 03:40:46 INFO - PROCESS | 8398 | RSS: Main: 218750976 03:40:46 INFO - PROCESS | 8398 | 03:43:48 INFO - PROCESS | 8398 | Cycle 1(1): loaded http://localhost:52018/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52018/tests/dromaeo/cssquery-prototype.html) 03:43:48 INFO - PROCESS | 8398 | RSS: Main: 216141824 03:43:48 INFO - PROCESS | 8398 | 03:46:51 INFO - PROCESS | 8398 | Cycle 1(1): loaded http://localhost:52018/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52018/tests/dromaeo/cssquery-yui.html) 03:46:51 INFO - PROCESS | 8398 | RSS: Main: 210145280 03:46:51 INFO - PROCESS | 8398 | 03:49:54 INFO - PROCESS | 8398 | Cycle 1(1): loaded http://localhost:52018/tests/dromaeo/cssquery-yui.html (next: http://localhost:52018/tests/dromaeo/cssquery-dojo.html) 03:49:54 INFO - PROCESS | 8398 | RSS: Main: 253997056 03:49:54 INFO - PROCESS | 8398 | 03:49:54 INFO - PROCESS | 8398 | __start_tp_report 03:49:54 INFO - PROCESS | 8398 | _x_x_mozilla_page_load 03:49:54 INFO - PROCESS | 8398 | _x_x_mozilla_page_load_details 03:49:54 INFO - PROCESS | 8398 | |i|pagename|runs| 03:49:54 INFO - PROCESS | 8398 | |0;dojo.html;3262.820544870032;3331.90004299871;3335.7998520088795;3345.8327083645813;3382.8985130446094;5369.301990741203;5387.164989426636;5391.649542779716;5397.271368365269;5398.217258497525;5391.78432862686;5419.701916394597;5420.891582168354;5425.186222066692;5431.2396264522995;4840.104580652573;4932.358793356859;5015.523525265094;5045.470225626312;5123.666961647499;4972.303877457159;5038.7228702421535;5042.294078828967;5044.596432285409;5047.520485553867;5027.371578552681;5043.722595257259;5096.668716533432;5115.641905066647;5158.92261616076;5083.61872859537;5108.540231379194;5120.769565369567;5122.92315615266;5150.562202212816;4905.337779399771;4922.852314430573;5013.47358527353;5018.347614810088;5019.949800502021;5246.7901283948595;5281.947180528223;5284.233786100994;5293.735313234323;5305.867353316159;5817.505512031483;5872.236609240771;5877.118432235156;5877.118432235199;5879.617824841372;5773.913391299134;5809.941900580982;5813.302403711539;5845.415458454163;5917.733701983421;5443;5472.589555783293;5486.259354987065;5487.149491828773;5494.80768173112;5880.529557635379;5958.523318134538;5976.073708575178;5978.970105149533;5983.042713165873;5706.3722990471015;5714.399988001283;5739.684317362502;5753.510951569164;5768.3366412862215;5861.677607731615;5892.322382925932;5893.381194974551;5908.05471124618;5908.113782932509;5726.3128424588485;5769.913451298234;5845.532357411397;5867.882642347215;5869.031609784338;5798.159266906359;5876.206712093898;5878.5003274721275;5882.705864706748;5921.940780592139;4498.910021799611;4517.909641807146;4521.525239849834;4522.29904364824;4553.2942393929;3974.0462289050997;3980.8208630611693;4035.071933455263;4044.170944956277;4093.6111069448357;5542.473465020817;5564.026295398289;5568.443155684399;5570.944290557123;5586.720663966786;5841.824745257564;5842.036064049385;5845.532357411397;5846.269216347957;5868.501177399883;5426.864328391743;5496.725163741797;5568.638038527482;5571.9721401392735;5581.972090139605;5009.298698182258;5043.52086551777;5043.899122017539;5045.091883460939;5050.848474545696;5948.2862056553495;5950.19672344228;5962.046072628359;5970.194023806817;5975.073863551156;5810.0994345875615;5853.209816674695;5910.911336329872;5929.911051334319;5933.169356290036;5963.3142188647125;5974.551908606785;5984.820455386345;5988.041913293852;5991.370906054975;5613.045782217115;5700;5701.372848986691;5704.657720536781;5709.115087161496;5816.621919575214;5860.853478663067;5869.383714710065;5873.119032145212;5912.763489460545;5651.745671444877;5659.547236221175;5660.094384898396;5662.688552129673;5664.122061080539;5485.040117979417;5652.7738890443925;5652.802151924663;5663.32040155184;5668.716564171693;5552.639078459887;5582.218489411404;5583.972080139573;5612.775488980558;5621.381648018796;5681.772729090955;5690.630109042899;5694.402087780889;5710.200571919851;5722.055860782924;5517.2551705519245;5611.8877622448135;5631.746571404215;5659.886802264014;5678.261825962763 03:49:54 INFO - PROCESS | 8398 | |1;ext.html;601.9969900150502;661.5931202310579;669.6383952665561;670.0819876768827;672.7443571442851;34011.31977360451;34666.48000279998;34757;34815.47776783347;34822.99999999997;41521.37717934234;42100.78949605255;42289.154216915646;42321.57678423215;42372.78813605935;8626.223639872425;8784.429012114224;8803.911960880405;8806.515641639708;8812.030676625565;8708.17272359125;8862.86705699415;8868.290536757044;8882.822343553125;8897.110288971116;8927.508987005713;8974.237189838872;8975.820483590323;9196.586153623102;9211.861822072675;9120.133587309228;9123.908760912373;9178.128077832594;9179.816403671955;9183.265338772882;9154.725358239264;9255.305852061123;9258.583363748647;9259.074092590754;9269.582868770854;43931.78034109841;44374.778126109166;44430.77784611088;44437.55562444399;44439.55560444386;3704.518412606371;3790.6209379062147;3825.464434979105;3903.960960390388;3910.902227444337;33810.83094584536;33994.83002584996;34370;34846.6515334846;35900;4526.54734526548;4573.336866154422;4576.839810606612;4592.540745925414;4597.7011494252765;325530;326734;327322;328239;328978.9999999976;39773.80113099474;40905.59094409018;64113.35886641074;64896.35103648903;64907.35092649013;38271.61728382736;38273.425898611546;38491.61508384936;38522;38568.807155964605;15963.760543591856;16063.598410039842;16090.51728448125;16092.275847586887;16101.19494025294;14434.206118663364;14567.490137845125;14575.198364090076;14576.271186440636;14580.343884525222;9376.343655944018;9522.333436659368;9584.424934503952;9647.372920760128;9658.71023869285;3609.873654422135;3613.6205698401814;3635.927281454356;3655.305491956573;3685.1155722626377;1130.9208355415205;1137.8577677790277;1164.1210885781181;1184.798584240681;1207.957721479744;34209.31581368409;34332.31335373279;34651.30697386038;34678.03880492803;34760.82619586886;1301.8698130186906;1304.341307639636;1322.4313545175476;1325.8475275343267;1354.5191457032809;18248.178831952595;18393.172307246205;18514.44456666302;18526.258949641862;18591.44225673232;487155;488311;491592;491724;493089;64311.356886430534;65112.34887651063;65154;65199.348006520275;65333.346666533675;1496.7156240314305;1539.9846001540066;1558.2053152892106;1645.3418632547077;1656.7988208548707;30076.5488517668;31074.22314442157;31656.683433165374;31688;31739.04782856518;48191.75904120457;48721;48838;48894.75552622214;48934;242775;243207;244414;244580;244746;26840.194794156207;28368.858155709913;31653.68189208202;31890;33330.666693333726;51235.74382128065;54191;54242.728786355816;54265.45734542604;55245.44754552403;38080;39447.802760986015;39548.40677389784;39601.603983960944;40457.59542404538;40312.3953140709;41576.79211603923;42170;42610.147797044505;42684.359734603386;43566.56433435625;44267.778661107775;44975.550244497135;44978;45008.549914501746;35664.28671426609;37439.43840842335;37448.812755936044;38116.618833811306;38344.6165538341;28602.427951440437;28785;28981.13056608305;29022.854885725435;29613.5557966635 03:49:54 INFO - PROCESS | 8398 | |2;jquery.html;431.3099041533546;433.4105616361749;440.6597987256594;443.7049362174154;452.26281161706413;18860;19211.423657290285;19547.706784398244;21676;21716.565668686617;20248.797512024874;20601;20747.792522074775;20954.685679714818;20965.37103886886;5860.619059761112;6027.0658048002415;6081.1790408294755;6089.634621922677;6092.177556029946;4474.709143905636;5965.522758179335;6037.516998640098;6251.874962500748;6714.294999025105;6606.8678626427445;6670.6331151786635;6692.799216023527;6694.029365741964;6697.531172817905;6327.335629758878;6578.572392794477;6632.668366581652;6646.501512386542;6653.600783952954;4091.284025295561;4239.978800106011;5721.256236689245;5935.872184284972;5938.881222375571;23745.762542374527;23820.285391438112;24130.39674008164;25704;25704.357391065187;2447.6328550717535;2466.7779899808925;2471.8516888986537;2476.925692229236;2602.3364042169314;14971.101733896001;15004.24978751058;15419.61450963735;15447;15873;1987.960240795176;2039.2149022626395;2055.3659840426894;2064.494198921259;2072.896355182235;83744.58127709384;83853.16146838576;84421.57789211014;85078;85941.57029214814;11169.106471482262;11474.885251147549;11494.712632184095;11499.310041397375;11922.463489143009;16833.747493787603;16919.577010574834;16960;16969.490915272563;16986.06576638272;8829.735107946772;9074.183323500916;9105.726828195166;9158.267338612895;9267.907320926839;8994.685186018589;9002.05478424769;9003.414778039407;9029.142231487998;9119.772005699911;5004.624653151028;5089.745512724349;5103.106956282636;5108.335916330853;5173.120569503193;1879.1074239736015;1991.681330987064;2024.6760518316999;2080.0951586060114;2098.5802839432176;1030.891756365571;1072.5388083124176;1090.1442367741442;1193.1543269302776;1213.5995121609847;18197.768894117242;18677.906610467133;18901.43295701131;19862.60274794496;20044.69932951007;1055.9229585822573;1109.6338208391212;1151.447305293447;1152.2049785647876;1176.5470293936896;10976.396298203676;11421.314721116594;11431.485583148611;11451.370174640475;11465.713357166138;390624;391955;397083;515235;515601;81318.59340703259;84545.57727211325;85097.57451212704;98802.5059874696;99815.50092249492;1148.018444230188;1185.3480585677842;1189.7679952409371;1193.164784650748;1200.33981310279;13710.931445342709;16726.832731672526;17101.23044462977;17137.571560710585;17317.56706082358;39259.41110883282;39499;40253.39619905762;40752.59247407607;41790.373144403464;50520.747396262785;55762.44237557572;56091;56397.43602563922;56558;8825;9066.863997039918;9177.311701622271;9339;9433.764155896157;13159.144655597356;13985.720285594027;14131.858681413054;14388.712225755216;14705.264736763333;12487.438065286902;12521.937390313355;12550.309732964775;12554.748905021666;12674.493020279455;12506.499740010298;12610.495580177057;12726.427310771223;12761.234325940473;12972.481100755864;10902.890971090188;11624.767504650028;12579.874201258237;12629.747405051663;12852.678683032998;9185.954070229605;9456.810863782548;9487.762805929908;9580.56887440053;9601.32790704672;9919.702408927744;12720.600733919446;12809.42357593892;12859.871401285867;12944.546940857024 03:49:54 INFO - PROCESS | 8398 | |3;mootools.html;1408.1902905829152;1549.6125968507872;1564.507180238225;1793.5516120969758;1925.4801203675;8167.509949403033;8377.16228377162;8392.076871544134;8395.202455766708;8404.285635720971;8161.510309381441;8315.251627353537;8318.83362332753;8324.95837520813;8327.875081873777;2124.40516655336;2360.4806942472715;2380.1074597026113;2418.069043418279;2430.8419952703107;2429.259075981825;2440.0605766779827;2444.1934161726676;2445.951080978379;2449.35092200567;2364.9645255321097;2443.1815341860497;2443.2670198940336;2444.8899799509063;2445.572024895645;2141.3468891987936;2334.5914464968564;2389.0802041214083;2389.9880500597387;2392.067093833415;2347.542229265294;2348.4481146930457;2362.2558893948353;2365.29041287613;2414.251582009565;8279.37904657147;8336.374771892133;8338.541380224086;8342.62458189383;8352.03951545574;5201.713905735183;5294.444083371268;5324.201369794523;5326.041312563737;5395.622306438551;3496.5978912425144;3520.647935206459;3558.057114864563;3601.7118630509494;3604.8377822998027;1131.4738646529322;1143.9485223164977;1158.0388277729464;1172.9061675065975;1187.584345479084;11645.18483706141;11669.59156429521;11689.123315751352;11731.94134029333;11755.764884702257;4491.528389519119;4573;4620.607248383925;4636.675432719745;4640.6751527393435;10001.949990250003;10005.749856253651;10011.149052330633;10016.949915250378;10018.3488073275;4560.726356418625;5325.201219816981;5328.280682107943;5331.413544510101;5334.706591137525;4174.248635245624;4768.427788665313;4877.975625118694;4922.483139270396;4922.50774922512;4057.878263652095;4098.590140985878;4105.876823695294;4122.319817230124;4158.896027599274;1349.291621898511;1365.1740696878246;1373.7458570164551;1375.8142650742222;1377.0360747476807;1049.511976930731;1053.8629978102797;1066.440118937564;1072.903438690506;1078.2991055813784;5974.223350964434;6013.54898382623;6104.481119104926;6127.877442451215;6138.1713468681155;472.6077355794682;476.5568021739815;481.40786832196596;482.4765129834099;484.48886424821444;4053.148838743838;4238.321868501025;4296.849610263625;4344.56554344563;4345.695801293879;10295.794084118426;10632.68101956927;10742.409167495707;10748.946255268673;10758.731031724114;10178.440185789705;10362.637307694195;10395.84406233907;10582.365058096539;10589.311694739818;8157.061937877102;8165.428420010542;8232;8234.876476852853;8249.133840946733;5815.651060936358;5947.524198064058;5956.851078723066;6040.728167232397;6135.417135372132;9363.578638961399;9405.576749046173;9650.903490965;9652.565634546321;9654.855177172489;9416.246700264099;9611.711648650551;9648.71053868385;9767.658131965347;9771.169450596495;6621.702023408862;6908.620025898624;7107;7584.810379740551;7646.9617651911385;7736.497127686683;7766.339861111643;7779.533228006338;7799.49303295284;7818.218178182136;6932.410745086724;7137.678804453916;7173.24680908518;7228.96385518069;7276.854462910818;7188.28117188277;7220.277972202948;7236.96381518089;7279.745208917662;7311.378532824557;6611.636360000246;6766.93233067663;6775.525713200029;6782;6783.050372947692;4995.125852975787;5075.314832497713;5178.71517066565;5320.600954928318;5363.222332761806;5024.070546948826;5077.796888124433;5207.609429292743;5254.42201357858;5321.36143662763 03:49:54 INFO - PROCESS | 8398 | |4;prototype.html;343.3579206883128;348.1123136003193;351.68524170867073;372.3260897775029;375.5437143870197;6133.907991380127;6140.877182456348;6168.907466388002;6209.596376235541;6216.906746398797;5844.707764611774;5945.781114871452;5991.940080599193;6037.2755269367735;6122.908156377647;4673.556012178846;4729.834455794048;4739.928901066487;4746.24060150376;4757.762111894409;4746.596539294164;4777.880552986186;4782.856514304576;4784.9521504785025;4796.856094317176;4465.285554311311;4612.815487380501;4752.382190315254;4755.239161734106;4762.190427627312;4756.310335001405;4757.26262429324;4757.857264282077;4776.761161941924;4777.9761101194445;4201.810918508644;4207.053412982085;4209.936850947238;4211.515675697304;4227.365895115727;5902.2622172228475;5903.76384944606;5909;5909.202257695242;5913.940860591382;5509.256250406184;5521.861953451155;5522.6134170608075;5523.4752698493985;5529.806456773994;6207.627542347428;6457.547971641987;6476.546641735081;6480.611163330168;6480.74077036918;4522.479914809806;4549.021960278556;4558.612517935946;4561.178987782231;4561.178987782231;6742.898856517108;6827.829304267383;6880.862382752317;6902.723891044352;6905.861882762367;4577.610903073276;4581.473130589959;4584.701994370355;4587.357769912215;4592.012717265804;4619.9769001155455;4632.235681112578;4633.096546173464;4633.2818413146015;4637.443506779208;5284.550813180846;5387;5396.784128634889;5400.513953744182;5407.242985981966;6566.080748695091;6566.4418524425;6584.6378449184795;6588.505862060365;6593.142891424084;1592.164113840243;1633.6732653469353;1636.9345226191058;1637.025969548117;1637.7461493468293;982.5529384130203;1090.574675876409;1100.8293714474269;1104.089126470665;1105.5190991918541;6200.81397558074;6206;6214.5960512566535;6219.284782250009;6225.408586184305;6680.3987641112535;6689.5986240825705;6692.096566963495;6695.263521012685;6696.296888826603;6313.842153946096;6316.589421687576;6316.873662526724;6319.052142178618;6320.336364681734;3551.1818392265263;3572.1248294167576;3608.1701208721615;3611.3499570077115;3613.512175856278;6769.966150169218;6905.861882762317;6912.861742765116;6927.7228910844005;6930.30696930313;6772.288909664513;6794.218664853605;6797.5581587196675;6809.829754256084;6810.557313774589;6886.449084073262;6890.793276201722;6893.689783959734;6896.310368963063;6902.930970690229;6658.167729033871;6668.699908504032;6672.299408562031;6676;6678.83302917431;6430.16407866993;6526.086347911201;6541.6402097885075;6580.21037475506;6588.538802283986;6794.966025169842;6829.93170068293;6833.384995350442;6851.862962740817;6863.622500762306;4619.792109355019;4621.168189725881;4622.214223581932;4623.653226007996;4635.953640463552;6633.9668301658185;6637.070810086495;6643.60138391698;6646.867062658816;6649.700763465559;6309.148264984168;6394.104825324552;6441.967790161019;6443.613383197023;6499;6351.714172862325;6384.233891932998;6388.616682999035;6403.167588213502;6406.807795766134;6310.684465776784;6313.842153946188;6331.430171284606;6332.335104813928;6336.144620476177;6473.352664733489;6477.417032466912;6486;6490.935090649033;6491.578047426902;6177.505799536116;6330.841728956813;6352.428281454691;6448.774292899726;6503.252126005381 03:49:54 INFO - PROCESS | 8398 | |5;yui.html;770.5299767142043;788.9013873265842;844.9155084491548;877.7191298784387;881.907399723029;14900.254987250635;15663.60840978976;16200.513984580452;16205.108719020449;16245.350185992576;14508.129512229274;14518.128912265245;14648.26758662068;14671.339789709462;14683.632909177277;787.6652422720349;878.1701292278799;882.1311008656468;909.8362294786953;914.3005600715458;926.0878035135386;937.9155875971161;938.3056538161779;938.7512309238058;940.0270719805003;961.9759506012371;962.0571839597199;962.129273007929;963.0754475703333;964.903509649033;823.7528741377563;959.2901253072746;966.7631430299587;968.9515524223831;979.5836769372988;714.9142102947627;716.201435399531;716.4268585131925;717.8564287142592;718.5221827484717;15240.314185861664;15426.845731542766;15444.150571718552;15445.613859653486;15466.149361785097;13913.165210087325;14240.216788076652;14340.490414177477;14408.279586020763;14415.063020903608;11935;12084.939575302154;12203.938980305042;12304.81542776859;12355.38223088851;4370.737755734666;4391.912161756779;4424.800883960197;4459.910801783946;4486.730796152241;55381.169282460796;55515.444845551836;55547;55594.722026390016;55978.44021559814;10613.575456981634;10904.61833835812;11182.944085279521;11212.159088068265;11265.436728163722;19796.50508737293;19812;19842.20631174737;20058.197672092952;20069.49826254326;8173.509589424534;8272.17278272168;8360.211842471992;8454.535000575028;8553.61508732096;4749.881252968635;4895.755212239374;4898.191798353303;4954.9009019819405;5051.646384753106;3484.059303987909;3507.2459421224557;3507.5264839246884;3538.6461353864406;3542.6103128655827;599.6611914268425;600.1328080923112;611.1535523300172;612.301975747648;633.9714712837933;700.0689083518907;710.1832892174041;739.1979702023258;744.8100734312716;755.3013462547232;9489.430634161972;9801.16690081351;9830.164436022875;10037.899621003697;10052.145567626834;669.6685140855308;686.4542688562605;689.9931000690029;736.1350413264393;738.6159197217416;4560.156371071363;4587.128445595326;4675.438947326343;4695.3191787191345;4707.905841883143;62858.68570657209;63567.68216158982;63598.68200658967;63886.36113638897;64386;55668.443315567136;56909;56957.43042569604;57097.429025709214;57154.42845571491;50271.49728502668;51327.486725133014;52022;52073.47926520762;53183;8962.372633915824;9065.63737450521;9148.817023659623;9230;9257.444553326823;38616.80691596524;40652.18695626012;40692.1861562773;41201.1759764809;41298.79350603228;45612.543874560826;46522.30216546822;50111;50635.49364506308;50939.49060509347;11276.041536469493;11356.488957997075;11374.31754094757;11606.129540284344;11621.709457263636;12386.938065309616;12493.375331233583;12584.307863067253;12736.363181841056;13157.079004469595;10779.89220107789;11718.70703232426;13153.53962611304;13404.128731632412;13780.65548361299;12865.614031579067;13066.673333166747;13087.345632718136;13331.533396331082;13430.39563219638;12602.810957835824;12692.238465692088;12779.744405112031;12799.80800288015;12905.290209038218;10677.14582833387;10677.199210059121;10740.946295268786;10761.730956726144;11410.600628977945;10804.567817287221;11205;11394.829077563678;11427.60003399877;11448 03:49:54 INFO - PROCESS | 8398 | __end_tp_report 03:49:54 INFO - PROCESS | 8398 | __start_cc_report 03:49:54 INFO - PROCESS | 8398 | _x_x_mozilla_cycle_collect,864 03:49:54 INFO - PROCESS | 8398 | __end_cc_report 03:49:54 INFO - PROCESS | 8398 | __startTimestamp1463136594511__endTimestamp 03:49:54 INFO - PROCESS | 8398 | 03:49:54 INFO - PROCESS | 8398 | ------- Summary: start ------- 03:49:54 INFO - PROCESS | 8398 | Number of tests: 6 03:49:54 INFO - PROCESS | 8398 | 03:49:54 INFO - PROCESS | 8398 | [#0] dojo.html Cycles:165 Average:5429.56 Median:5613.05 stddev:577.96 (10.3%) stddev-sans-first:554.18 03:49:54 INFO - PROCESS | 8398 | Values: 3262.8 3331.9 3335.8 3345.8 3382.9 5369.3 5387.2 5391.6 5397.3 5398.2 5391.8 5419.7 5420.9 5425.2 5431.2 4840.1 4932.4 5015.5 5045.5 5123.7 4972.3 5038.7 5042.3 5044.6 5047.5 5027.4 5043.7 5096.7 5115.6 5158.9 5083.6 5108.5 5120.8 5122.9 5150.6 4905.3 4922.9 5013.5 5018.3 5019.9 5246.8 5281.9 5284.2 5293.7 5305.9 5817.5 5872.2 5877.1 5877.1 5879.6 5773.9 5809.9 5813.3 5845.4 5917.7 5443.0 5472.6 5486.3 5487.1 5494.8 5880.5 5958.5 5976.1 5979.0 5983.0 5706.4 5714.4 5739.7 5753.5 5768.3 5861.7 5892.3 5893.4 5908.1 5908.1 5726.3 5769.9 5845.5 5867.9 5869.0 5798.2 5876.2 5878.5 5882.7 5921.9 4498.9 4517.9 4521.5 4522.3 4553.3 3974.0 3980.8 4035.1 4044.2 4093.6 5542.5 5564.0 5568.4 5570.9 5586.7 5841.8 5842.0 5845.5 5846.3 5868.5 5426.9 5496.7 5568.6 5572.0 5582.0 5009.3 5043.5 5043.9 5045.1 5050.8 5948.3 5950.2 5962.0 5970.2 5975.1 5810.1 5853.2 5910.9 5929.9 5933.2 5963.3 5974.6 5984.8 5988.0 5991.4 5613.0 5700.0 5701.4 5704.7 5709.1 5816.6 5860.9 5869.4 5873.1 5912.8 5651.7 5659.5 5660.1 5662.7 5664.1 5485.0 5652.8 5652.8 5663.3 5668.7 5552.6 5582.2 5584.0 5612.8 5621.4 5681.8 5690.6 5694.4 5710.2 5722.1 5517.3 5611.9 5631.7 5659.9 5678.3 03:49:54 INFO - PROCESS | 8398 | 03:49:54 INFO - PROCESS | 8398 | [#1] ext.html Cycles:180 Average:52420.55 Median:21679.35 stddev:97524.01 (449.8%) stddev-sans-first:97719.98 03:49:54 INFO - PROCESS | 8398 | Values: 602.0 661.6 669.6 670.1 672.7 34011.3 34666.5 34757.0 34815.5 34823.0 41521.4 42100.8 42289.2 42321.6 42372.8 8626.2 8784.4 8803.9 8806.5 8812.0 8708.2 8862.9 8868.3 8882.8 8897.1 8927.5 8974.2 8975.8 9196.6 9211.9 9120.1 9123.9 9178.1 9179.8 9183.3 9154.7 9255.3 9258.6 9259.1 9269.6 43931.8 44374.8 44430.8 44437.6 44439.6 3704.5 3790.6 3825.5 3904.0 3910.9 33810.8 33994.8 34370.0 34846.7 35900.0 4526.5 4573.3 4576.8 4592.5 4597.7 325530.0 326734.0 327322.0 328239.0 328979.0 39773.8 40905.6 64113.4 64896.4 64907.4 38271.6 38273.4 38491.6 38522.0 38568.8 15963.8 16063.6 16090.5 16092.3 16101.2 14434.2 14567.5 14575.2 14576.3 14580.3 9376.3 9522.3 9584.4 9647.4 9658.7 3609.9 3613.6 3635.9 3655.3 3685.1 1130.9 1137.9 1164.1 1184.8 1208.0 34209.3 34332.3 34651.3 34678.0 34760.8 1301.9 1304.3 1322.4 1325.8 1354.5 18248.2 18393.2 18514.4 18526.3 18591.4 487155.0 488311.0 491592.0 491724.0 493089.0 64311.4 65112.3 65154.0 65199.3 65333.3 1496.7 1540.0 1558.2 1645.3 1656.8 30076.5 31074.2 31656.7 31688.0 31739.0 48191.8 48721.0 48838.0 48894.8 48934.0 242775.0 243207.0 244414.0 244580.0 244746.0 26840.2 28368.9 31653.7 31890.0 33330.7 51235.7 54191.0 54242.7 54265.5 55245.4 38080.0 39447.8 39548.4 39601.6 40457.6 40312.4 41576.8 42170.0 42610.1 42684.4 43566.6 44267.8 44975.6 44978.0 45008.5 35664.3 37439.4 37448.8 38116.6 38344.6 28602.4 28785.0 28981.1 29022.9 29613.6 03:49:54 INFO - PROCESS | 8398 | 03:49:54 INFO - PROCESS | 8398 | [#2] jquery.html Cycles:180 Average:28181.39 Median:23975.34 stddev:73740.81 (307.6%) stddev-sans-first:73918.23 03:49:54 INFO - PROCESS | 8398 | Values: 431.3 433.4 440.7 443.7 452.3 18860.0 19211.4 19547.7 21676.0 21716.6 20248.8 20601.0 20747.8 20954.7 20965.4 5860.6 6027.1 6081.2 6089.6 6092.2 4474.7 5965.5 6037.5 6251.9 6714.3 6606.9 6670.6 6692.8 6694.0 6697.5 6327.3 6578.6 6632.7 6646.5 6653.6 4091.3 4240.0 5721.3 5935.9 5938.9 23745.8 23820.3 24130.4 25704.0 25704.4 2447.6 2466.8 2471.9 2476.9 2602.3 14971.1 15004.2 15419.6 15447.0 15873.0 1988.0 2039.2 2055.4 2064.5 2072.9 83744.6 83853.2 84421.6 85078.0 85941.6 11169.1 11474.9 11494.7 11499.3 11922.5 16833.7 16919.6 16960.0 16969.5 16986.1 8829.7 9074.2 9105.7 9158.3 9267.9 8994.7 9002.1 9003.4 9029.1 9119.8 5004.6 5089.7 5103.1 5108.3 5173.1 1879.1 1991.7 2024.7 2080.1 2098.6 1030.9 1072.5 1090.1 1193.2 1213.6 18197.8 18677.9 18901.4 19862.6 20044.7 1055.9 1109.6 1151.4 1152.2 1176.5 10976.4 11421.3 11431.5 11451.4 11465.7 390624.0 391955.0 397083.0 515235.0 515601.0 81318.6 84545.6 85097.6 98802.5 99815.5 1148.0 1185.3 1189.8 1193.2 1200.3 13710.9 16726.8 17101.2 17137.6 17317.6 39259.4 39499.0 40253.4 40752.6 41790.4 50520.7 55762.4 56091.0 56397.4 56558.0 8825.0 9066.9 9177.3 9339.0 9433.8 13159.1 13985.7 14131.9 14388.7 14705.3 12487.4 12521.9 12550.3 12554.7 12674.5 12506.5 12610.5 12726.4 12761.2 12972.5 10902.9 11624.8 12579.9 12629.7 12852.7 9186.0 9456.8 9487.8 9580.6 9601.3 9919.7 12720.6 12809.4 12859.9 12944.5 03:49:54 INFO - PROCESS | 8398 | 03:49:54 INFO - PROCESS | 8398 | [#3] mootools.html Cycles:180 Average:5638.85 Median:481.94 stddev:3096.08 (642.4%) stddev-sans-first:3088.43 03:49:54 INFO - PROCESS | 8398 | Values: 1408.2 1549.6 1564.5 1793.6 1925.5 8167.5 8377.2 8392.1 8395.2 8404.3 8161.5 8315.3 8318.8 8325.0 8327.9 2124.4 2360.5 2380.1 2418.1 2430.8 2429.3 2440.1 2444.2 2446.0 2449.4 2365.0 2443.2 2443.3 2444.9 2445.6 2141.3 2334.6 2389.1 2390.0 2392.1 2347.5 2348.4 2362.3 2365.3 2414.3 8279.4 8336.4 8338.5 8342.6 8352.0 5201.7 5294.4 5324.2 5326.0 5395.6 3496.6 3520.6 3558.1 3601.7 3604.8 1131.5 1143.9 1158.0 1172.9 1187.6 11645.2 11669.6 11689.1 11731.9 11755.8 4491.5 4573.0 4620.6 4636.7 4640.7 10001.9 10005.7 10011.1 10016.9 10018.3 4560.7 5325.2 5328.3 5331.4 5334.7 4174.2 4768.4 4878.0 4922.5 4922.5 4057.9 4098.6 4105.9 4122.3 4158.9 1349.3 1365.2 1373.7 1375.8 1377.0 1049.5 1053.9 1066.4 1072.9 1078.3 5974.2 6013.5 6104.5 6127.9 6138.2 472.6 476.6 481.4 482.5 484.5 4053.1 4238.3 4296.8 4344.6 4345.7 10295.8 10632.7 10742.4 10748.9 10758.7 10178.4 10362.6 10395.8 10582.4 10589.3 8157.1 8165.4 8232.0 8234.9 8249.1 5815.7 5947.5 5956.9 6040.7 6135.4 9363.6 9405.6 9650.9 9652.6 9654.9 9416.2 9611.7 9648.7 9767.7 9771.2 6621.7 6908.6 7107.0 7584.8 7647.0 7736.5 7766.3 7779.5 7799.5 7818.2 6932.4 7137.7 7173.2 7229.0 7276.9 7188.3 7220.3 7237.0 7279.7 7311.4 6611.6 6766.9 6775.5 6782.0 6783.1 4995.1 5075.3 5178.7 5320.6 5363.2 5024.1 5077.8 5207.6 5254.4 5321.4 03:49:54 INFO - PROCESS | 8398 | 03:49:54 INFO - PROCESS | 8398 | [#4] prototype.html Cycles:180 Average:5429.89 Median:6208.61 stddev:1622.25 (26.1%) stddev-sans-first:1581.24 03:49:54 INFO - PROCESS | 8398 | Values: 343.4 348.1 351.7 372.3 375.5 6133.9 6140.9 6168.9 6209.6 6216.9 5844.7 5945.8 5991.9 6037.3 6122.9 4673.6 4729.8 4739.9 4746.2 4757.8 4746.6 4777.9 4782.9 4785.0 4796.9 4465.3 4612.8 4752.4 4755.2 4762.2 4756.3 4757.3 4757.9 4776.8 4778.0 4201.8 4207.1 4209.9 4211.5 4227.4 5902.3 5903.8 5909.0 5909.2 5913.9 5509.3 5521.9 5522.6 5523.5 5529.8 6207.6 6457.5 6476.5 6480.6 6480.7 4522.5 4549.0 4558.6 4561.2 4561.2 6742.9 6827.8 6880.9 6902.7 6905.9 4577.6 4581.5 4584.7 4587.4 4592.0 4620.0 4632.2 4633.1 4633.3 4637.4 5284.6 5387.0 5396.8 5400.5 5407.2 6566.1 6566.4 6584.6 6588.5 6593.1 1592.2 1633.7 1636.9 1637.0 1637.7 982.6 1090.6 1100.8 1104.1 1105.5 6200.8 6206.0 6214.6 6219.3 6225.4 6680.4 6689.6 6692.1 6695.3 6696.3 6313.8 6316.6 6316.9 6319.1 6320.3 3551.2 3572.1 3608.2 3611.3 3613.5 6770.0 6905.9 6912.9 6927.7 6930.3 6772.3 6794.2 6797.6 6809.8 6810.6 6886.4 6890.8 6893.7 6896.3 6902.9 6658.2 6668.7 6672.3 6676.0 6678.8 6430.2 6526.1 6541.6 6580.2 6588.5 6795.0 6829.9 6833.4 6851.9 6863.6 4619.8 4621.2 4622.2 4623.7 4636.0 6634.0 6637.1 6643.6 6646.9 6649.7 6309.1 6394.1 6442.0 6443.6 6499.0 6351.7 6384.2 6388.6 6403.2 6406.8 6310.7 6313.8 6331.4 6332.3 6336.1 6473.4 6477.4 6486.0 6490.9 6491.6 6177.5 6330.8 6352.4 6448.8 6503.3 03:49:54 INFO - PROCESS | 8398 | 03:49:54 INFO - PROCESS | 8398 | [#5] yui.html Cycles:180 Average:15476.37 Median:25598.87 stddev:17834.08 (69.7%) stddev-sans-first:17849.92 03:49:54 INFO - PROCESS | 8398 | Values: 770.5 788.9 844.9 877.7 881.9 14900.3 15663.6 16200.5 16205.1 16245.4 14508.1 14518.1 14648.3 14671.3 14683.6 787.7 878.2 882.1 909.8 914.3 926.1 937.9 938.3 938.8 940.0 962.0 962.1 962.1 963.1 964.9 823.8 959.3 966.8 969.0 979.6 714.9 716.2 716.4 717.9 718.5 15240.3 15426.8 15444.2 15445.6 15466.1 13913.2 14240.2 14340.5 14408.3 14415.1 11935.0 12084.9 12203.9 12304.8 12355.4 4370.7 4391.9 4424.8 4459.9 4486.7 55381.2 55515.4 55547.0 55594.7 55978.4 10613.6 10904.6 11182.9 11212.2 11265.4 19796.5 19812.0 19842.2 20058.2 20069.5 8173.5 8272.2 8360.2 8454.5 8553.6 4749.9 4895.8 4898.2 4954.9 5051.6 3484.1 3507.2 3507.5 3538.6 3542.6 599.7 600.1 611.2 612.3 634.0 700.1 710.2 739.2 744.8 755.3 9489.4 9801.2 9830.2 10037.9 10052.1 669.7 686.5 690.0 736.1 738.6 4560.2 4587.1 4675.4 4695.3 4707.9 62858.7 63567.7 63598.7 63886.4 64386.0 55668.4 56909.0 56957.4 57097.4 57154.4 50271.5 51327.5 52022.0 52073.5 53183.0 8962.4 9065.6 9148.8 9230.0 9257.4 38616.8 40652.2 40692.2 41201.2 41298.8 45612.5 46522.3 50111.0 50635.5 50939.5 11276.0 11356.5 11374.3 11606.1 11621.7 12386.9 12493.4 12584.3 12736.4 13157.1 10779.9 11718.7 13153.5 13404.1 13780.7 12865.6 13066.7 13087.3 13331.5 13430.4 12602.8 12692.2 12779.7 12799.8 12905.3 10677.1 10677.2 10740.9 10761.7 11410.6 10804.6 11205.0 11394.8 11427.6 11448.0 03:49:54 INFO - PROCESS | 8398 | -------- Summary: end -------- 03:49:54 INFO - PROCESS | 8398 | 03:49:55 INFO - TEST-INFO | 8398: exit 0 03:49:55 INFO - TEST-OK | dromaeo_css | took 1110799ms 03:49:55 INFO - TEST-START | kraken 03:49:55 INFO - operating with platform_type : linux_ 03:49:55 INFO - Initialising browser for kraken test... 03:49:55 INFO - TEST-INFO | started process 8588 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJZeC2O/profile http://localhost:52018/getInfo.html) 03:49:58 INFO - PROCESS | 8588 | __metrics Screen width/height:1600/1200 03:49:58 INFO - PROCESS | 8588 | colorDepth:24 03:49:58 INFO - PROCESS | 8588 | Browser inner width/height: 1024/697 03:49:58 INFO - PROCESS | 8588 | __metrics 03:49:59 ERROR - PROCESS | 8588 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:50:00 INFO - TEST-INFO | 8588: exit 0 03:50:00 INFO - Browser initialized. 03:50:00 INFO - Running cycle 1/1 for kraken test... 03:50:00 INFO - TEST-INFO | started process 8682 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJZeC2O/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:50:12 INFO - PROCESS | 8682 | RSS: Main: 142376960 03:50:12 INFO - PROCESS | 8682 | 03:50:14 INFO - PROCESS | 8682 | Cycle 1(1): loaded http://localhost:52018/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52018/tests/kraken/driver.html?testName=audio-beat-detection) 03:50:15 INFO - PROCESS | 8682 | RSS: Main: 196591616 03:50:15 INFO - PROCESS | 8682 | 03:50:18 INFO - PROCESS | 8682 | Cycle 1(1): loaded http://localhost:52018/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52018/tests/kraken/driver.html?testName=audio-dft) 03:50:18 INFO - PROCESS | 8682 | RSS: Main: 182398976 03:50:18 INFO - PROCESS | 8682 | 03:50:21 INFO - PROCESS | 8682 | Cycle 1(1): loaded http://localhost:52018/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52018/tests/kraken/driver.html?testName=audio-fft) 03:50:22 INFO - PROCESS | 8682 | RSS: Main: 273747968 03:50:22 INFO - PROCESS | 8682 | 03:50:24 INFO - PROCESS | 8682 | Cycle 1(1): loaded http://localhost:52018/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52018/tests/kraken/driver.html?testName=audio-oscillator) 03:50:25 INFO - PROCESS | 8682 | RSS: Main: 179286016 03:50:25 INFO - PROCESS | 8682 | 03:50:27 INFO - PROCESS | 8682 | Cycle 1(1): loaded http://localhost:52018/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52018/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:50:27 INFO - PROCESS | 8682 | RSS: Main: 177573888 03:50:27 INFO - PROCESS | 8682 | 03:50:30 INFO - PROCESS | 8682 | Cycle 1(1): loaded http://localhost:52018/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52018/tests/kraken/driver.html?testName=imaging-darkroom) 03:50:31 INFO - PROCESS | 8682 | RSS: Main: 212602880 03:50:31 INFO - PROCESS | 8682 | 03:50:34 INFO - PROCESS | 8682 | Cycle 1(1): loaded http://localhost:52018/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52018/tests/kraken/driver.html?testName=imaging-desaturate) 03:50:35 INFO - PROCESS | 8682 | RSS: Main: 213311488 03:50:35 INFO - PROCESS | 8682 | 03:50:38 INFO - PROCESS | 8682 | Cycle 1(1): loaded http://localhost:52018/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52018/tests/kraken/driver.html?testName=json-parse-financial) 03:50:38 INFO - PROCESS | 8682 | RSS: Main: 213176320 03:50:38 INFO - PROCESS | 8682 | 03:50:40 INFO - PROCESS | 8682 | Cycle 1(1): loaded http://localhost:52018/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52018/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:50:40 INFO - PROCESS | 8682 | RSS: Main: 191668224 03:50:40 INFO - PROCESS | 8682 | 03:50:42 INFO - PROCESS | 8682 | Cycle 1(1): loaded http://localhost:52018/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52018/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:50:43 INFO - PROCESS | 8682 | RSS: Main: 193376256 03:50:43 INFO - PROCESS | 8682 | 03:50:45 INFO - PROCESS | 8682 | Cycle 1(1): loaded http://localhost:52018/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52018/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:50:45 INFO - PROCESS | 8682 | RSS: Main: 208818176 03:50:45 INFO - PROCESS | 8682 | 03:50:48 INFO - PROCESS | 8682 | Cycle 1(1): loaded http://localhost:52018/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52018/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:50:48 INFO - PROCESS | 8682 | RSS: Main: 210554880 03:50:48 INFO - PROCESS | 8682 | 03:50:51 INFO - PROCESS | 8682 | Cycle 1(1): loaded http://localhost:52018/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52018/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:50:52 INFO - PROCESS | 8682 | RSS: Main: 207732736 03:50:52 INFO - PROCESS | 8682 | 03:50:53 INFO - PROCESS | 8682 | Cycle 1(1): loaded http://localhost:52018/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52018/tests/kraken/driver.html?testName=ai-astar) 03:50:54 INFO - PROCESS | 8682 | RSS: Main: 271532032 03:50:54 INFO - PROCESS | 8682 | 03:50:54 INFO - PROCESS | 8682 | __start_tp_report 03:50:54 INFO - PROCESS | 8682 | _x_x_mozilla_page_load 03:50:54 INFO - PROCESS | 8682 | _x_x_mozilla_page_load_details 03:50:54 INFO - PROCESS | 8682 | |i|pagename|runs| 03:50:54 INFO - PROCESS | 8682 | |0;ai-astar;111;111;109;108;109;112;104;108;109;109 03:50:54 INFO - PROCESS | 8682 | |1;audio-beat-detection;156;124;155;174;128;159;164;129;191;126 03:50:54 INFO - PROCESS | 8682 | |2;audio-dft;160;161;161;161;163;160;161;163;159;160 03:50:54 INFO - PROCESS | 8682 | |3;audio-fft;76;72;75;171;76;76;75;77;153;78 03:50:54 INFO - PROCESS | 8682 | |4;audio-oscillator;91;92;151;91;93;92;151;92;91;150 03:50:54 INFO - PROCESS | 8682 | |5;imaging-gaussian-blur;116;117;117;117;117;116;117;116;117;117 03:50:54 INFO - PROCESS | 8682 | |6;imaging-darkroom;144;145;146;146;146;146;146;145;145;144 03:50:54 INFO - PROCESS | 8682 | |7;imaging-desaturate;94;94;94;94;94;94;94;94;95;94 03:50:54 INFO - PROCESS | 8682 | |8;json-parse-financial;56;54;54;53;55;56;55;82;56;54 03:50:54 INFO - PROCESS | 8682 | |9;json-stringify-tinderbox;59;57;57;57;58;58;58;58;58;57 03:50:54 INFO - PROCESS | 8682 | |10;stanford-crypto-aes;73;71;80;72;81;73;74;74;72;73 03:50:54 INFO - PROCESS | 8682 | |11;stanford-crypto-ccm;129;114;112;114;111;114;113;114;136;129 03:50:54 INFO - PROCESS | 8682 | |12;stanford-crypto-pbkdf2;163;164;167;159;163;159;159;163;168;158 03:50:54 INFO - PROCESS | 8682 | |13;stanford-crypto-sha256-iterative;70;69;68;68;67;69;68;67;69;68 03:50:54 INFO - PROCESS | 8682 | __end_tp_report 03:50:54 INFO - PROCESS | 8682 | __start_cc_report 03:50:54 INFO - PROCESS | 8682 | _x_x_mozilla_cycle_collect,1585 03:50:54 INFO - PROCESS | 8682 | __end_cc_report 03:50:54 INFO - PROCESS | 8682 | __startTimestamp1463136654001__endTimestamp 03:50:54 INFO - PROCESS | 8682 | 03:50:54 INFO - PROCESS | 8682 | ------- Summary: start ------- 03:50:54 INFO - PROCESS | 8682 | Number of tests: 14 03:50:54 INFO - PROCESS | 8682 | 03:50:54 INFO - PROCESS | 8682 | [#0] ai-astar Cycles:10 Average:109.00 Median:109.00 stddev:2.21 (2.0%) stddev-sans-first:2.22 03:50:54 INFO - PROCESS | 8682 | Values: 111.0 111.0 109.0 108.0 109.0 112.0 104.0 108.0 109.0 109.0 03:50:54 INFO - PROCESS | 8682 | 03:50:54 INFO - PROCESS | 8682 | [#1] audio-beat-detection Cycles:10 Average:150.60 Median:157.50 stddev:23.02 (14.6%) stddev-sans-first:24.33 03:50:54 INFO - PROCESS | 8682 | Values: 156.0 124.0 155.0 174.0 128.0 159.0 164.0 129.0 191.0 126.0 03:50:54 INFO - PROCESS | 8682 | 03:50:54 INFO - PROCESS | 8682 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.29 (0.8%) stddev-sans-first:1.32 03:50:54 INFO - PROCESS | 8682 | Values: 160.0 161.0 161.0 161.0 163.0 160.0 161.0 163.0 159.0 160.0 03:50:54 INFO - PROCESS | 8682 | 03:50:54 INFO - PROCESS | 8682 | [#3] audio-fft Cycles:10 Average:92.90 Median:76.00 stddev:36.70 (48.3%) stddev-sans-first:38.41 03:50:54 INFO - PROCESS | 8682 | Values: 76.0 72.0 75.0 171.0 76.0 76.0 75.0 77.0 153.0 78.0 03:50:54 INFO - PROCESS | 8682 | 03:50:54 INFO - PROCESS | 8682 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:91.50 stddev:28.48 (31.1%) stddev-sans-first:29.42 03:50:54 INFO - PROCESS | 8682 | Values: 91.0 92.0 151.0 91.0 93.0 92.0 151.0 92.0 91.0 150.0 03:50:54 INFO - PROCESS | 8682 | 03:50:54 INFO - PROCESS | 8682 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 03:50:54 INFO - PROCESS | 8682 | Values: 116.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 03:50:54 INFO - PROCESS | 8682 | 03:50:54 INFO - PROCESS | 8682 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.73 03:50:54 INFO - PROCESS | 8682 | Values: 144.0 145.0 146.0 146.0 146.0 146.0 146.0 145.0 145.0 144.0 03:50:54 INFO - PROCESS | 8682 | 03:50:54 INFO - PROCESS | 8682 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 03:50:54 INFO - PROCESS | 8682 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 95.0 94.0 03:50:54 INFO - PROCESS | 8682 | 03:50:54 INFO - PROCESS | 8682 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:55.50 stddev:8.67 (15.6%) stddev-sans-first:9.18 03:50:54 INFO - PROCESS | 8682 | Values: 56.0 54.0 54.0 53.0 55.0 56.0 55.0 82.0 56.0 54.0 03:50:54 INFO - PROCESS | 8682 | 03:50:54 INFO - PROCESS | 8682 | [#9] json-stringify-tinderbox Cycles:10 Average:57.70 Median:58.00 stddev:0.67 (1.2%) stddev-sans-first:0.53 03:50:54 INFO - PROCESS | 8682 | Values: 59.0 57.0 57.0 57.0 58.0 58.0 58.0 58.0 58.0 57.0 03:50:54 INFO - PROCESS | 8682 | 03:50:54 INFO - PROCESS | 8682 | [#10] stanford-crypto-aes Cycles:10 Average:74.30 Median:73.50 stddev:3.40 (4.6%) stddev-sans-first:3.57 03:50:54 INFO - PROCESS | 8682 | Values: 73.0 71.0 80.0 72.0 81.0 73.0 74.0 74.0 72.0 73.0 03:50:54 INFO - PROCESS | 8682 | 03:50:54 INFO - PROCESS | 8682 | [#11] stanford-crypto-ccm Cycles:10 Average:118.60 Median:114.00 stddev:9.05 (7.9%) stddev-sans-first:8.78 03:50:54 INFO - PROCESS | 8682 | Values: 129.0 114.0 112.0 114.0 111.0 114.0 113.0 114.0 136.0 129.0 03:50:54 INFO - PROCESS | 8682 | 03:50:54 INFO - PROCESS | 8682 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.30 Median:163.00 stddev:3.50 (2.1%) stddev-sans-first:3.70 03:50:54 INFO - PROCESS | 8682 | Values: 163.0 164.0 167.0 159.0 163.0 159.0 159.0 163.0 168.0 158.0 03:50:54 INFO - PROCESS | 8682 | 03:50:54 INFO - PROCESS | 8682 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:0.95 (1.4%) stddev-sans-first:0.78 03:50:54 INFO - PROCESS | 8682 | Values: 70.0 69.0 68.0 68.0 67.0 69.0 68.0 67.0 69.0 68.0 03:50:54 INFO - PROCESS | 8682 | -------- Summary: end -------- 03:50:54 INFO - PROCESS | 8682 | 03:50:55 INFO - TEST-INFO | 8682: exit 0 03:50:55 INFO - TEST-OK | kraken | took 59933ms 03:50:55 INFO - SUITE-END | took 1170s 03:50:55 INFO - Completed test suite (00:19:30) 03:50:55 INFO - javascript benchmark 03:50:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3262.820544870032, 3331.90004299871, 3335.7998520088795, 3345.8327083645813, 3382.8985130446094, 5369.301990741203, 5387.164989426636, 5391.649542779716, 5397.271368365269, 5398.217258497525, 5391.78432862686, 5419.701916394597, 5420.891582168354, 5425.186222066692, 5431.2396264522995, 4840.104580652573, 4932.358793356859, 5015.523525265094, 5045.470225626312, 5123.666961647499, 4972.303877457159, 5038.7228702421535, 5042.294078828967, 5044.596432285409, 5047.520485553867, 5027.371578552681, 5043.722595257259, 5096.668716533432, 5115.641905066647, 5158.92261616076, 5083.61872859537, 5108.540231379194, 5120.769565369567, 5122.92315615266, 5150.562202212816, 4905.337779399771, 4922.852314430573, 5013.47358527353, 5018.347614810088, 5019.949800502021, 5246.7901283948595, 5281.947180528223, 5284.233786100994, 5293.735313234323, 5305.867353316159, 5817.505512031483, 5872.236609240771, 5877.118432235156, 5877.118432235199, 5879.617824841372, 5773.913391299134, 5809.941900580982, 5813.302403711539, 5845.415458454163, 5917.733701983421, 5443.0, 5472.589555783293, 5486.259354987065, 5487.149491828773, 5494.80768173112, 5880.529557635379, 5958.523318134538, 5976.073708575178, 5978.970105149533, 5983.042713165873, 5706.3722990471015, 5714.399988001283, 5739.684317362502, 5753.510951569164, 5768.3366412862215, 5861.677607731615, 5892.322382925932, 5893.381194974551, 5908.05471124618, 5908.113782932509, 5726.3128424588485, 5769.913451298234, 5845.532357411397, 5867.882642347215, 5869.031609784338, 5798.159266906359, 5876.206712093898, 5878.5003274721275, 5882.705864706748, 5921.940780592139, 4498.910021799611, 4517.909641807146, 4521.525239849834, 4522.29904364824, 4553.2942393929, 3974.0462289050997, 3980.8208630611693, 4035.071933455263, 4044.170944956277, 4093.6111069448357, 5542.473465020817, 5564.026295398289, 5568.443155684399, 5570.944290557123, 5586.720663966786, 5841.824745257564, 5842.036064049385, 5845.532357411397, 5846.269216347957, 5868.501177399883, 5426.864328391743, 5496.725163741797, 5568.638038527482, 5571.9721401392735, 5581.972090139605, 5009.298698182258, 5043.52086551777, 5043.899122017539, 5045.091883460939, 5050.848474545696, 5948.2862056553495, 5950.19672344228, 5962.046072628359, 5970.194023806817, 5975.073863551156, 5810.0994345875615, 5853.209816674695, 5910.911336329872, 5929.911051334319, 5933.169356290036, 5963.3142188647125, 5974.551908606785, 5984.820455386345, 5988.041913293852, 5991.370906054975, 5613.045782217115, 5700.0, 5701.372848986691, 5704.657720536781, 5709.115087161496, 5816.621919575214, 5860.853478663067, 5869.383714710065, 5873.119032145212, 5912.763489460545, 5651.745671444877, 5659.547236221175, 5660.094384898396, 5662.688552129673, 5664.122061080539, 5485.040117979417, 5652.7738890443925, 5652.802151924663, 5663.32040155184, 5668.716564171693, 5552.639078459887, 5582.218489411404, 5583.972080139573, 5612.775488980558, 5621.381648018796, 5681.772729090955, 5690.630109042899, 5694.402087780889, 5710.200571919851, 5722.055860782924, 5517.2551705519245, 5611.8877622448135, 5631.746571404215, 5659.886802264014, 5678.261825962763], "value": 5393.530017101896, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.9969900150502, 661.5931202310579, 669.6383952665561, 670.0819876768827, 672.7443571442851, 34011.31977360451, 34666.48000279998, 34757.0, 34815.47776783347, 34822.99999999997, 41521.37717934234, 42100.78949605255, 42289.154216915646, 42321.57678423215, 42372.78813605935, 8626.223639872425, 8784.429012114224, 8803.911960880405, 8806.515641639708, 8812.030676625565, 8708.17272359125, 8862.86705699415, 8868.290536757044, 8882.822343553125, 8897.110288971116, 8927.508987005713, 8974.237189838872, 8975.820483590323, 9196.586153623102, 9211.861822072675, 9120.133587309228, 9123.908760912373, 9178.128077832594, 9179.816403671955, 9183.265338772882, 9154.725358239264, 9255.305852061123, 9258.583363748647, 9259.074092590754, 9269.582868770854, 43931.78034109841, 44374.778126109166, 44430.77784611088, 44437.55562444399, 44439.55560444386, 3704.518412606371, 3790.6209379062147, 3825.464434979105, 3903.960960390388, 3910.902227444337, 33810.83094584536, 33994.83002584996, 34370.0, 34846.6515334846, 35900.0, 4526.54734526548, 4573.336866154422, 4576.839810606612, 4592.540745925414, 4597.7011494252765, 325530.0, 326734.0, 327322.0, 328239.0, 328978.9999999976, 39773.80113099474, 40905.59094409018, 64113.35886641074, 64896.35103648903, 64907.35092649013, 38271.61728382736, 38273.425898611546, 38491.61508384936, 38522.0, 38568.807155964605, 15963.760543591856, 16063.598410039842, 16090.51728448125, 16092.275847586887, 16101.19494025294, 14434.206118663364, 14567.490137845125, 14575.198364090076, 14576.271186440636, 14580.343884525222, 9376.343655944018, 9522.333436659368, 9584.424934503952, 9647.372920760128, 9658.71023869285, 3609.873654422135, 3613.6205698401814, 3635.927281454356, 3655.305491956573, 3685.1155722626377, 1130.9208355415205, 1137.8577677790277, 1164.1210885781181, 1184.798584240681, 1207.957721479744, 34209.31581368409, 34332.31335373279, 34651.30697386038, 34678.03880492803, 34760.82619586886, 1301.8698130186906, 1304.341307639636, 1322.4313545175476, 1325.8475275343267, 1354.5191457032809, 18248.178831952595, 18393.172307246205, 18514.44456666302, 18526.258949641862, 18591.44225673232, 487155.0, 488311.0, 491592.0, 491724.0, 493089.0, 64311.356886430534, 65112.34887651063, 65154.0, 65199.348006520275, 65333.346666533675, 1496.7156240314305, 1539.9846001540066, 1558.2053152892106, 1645.3418632547077, 1656.7988208548707, 30076.5488517668, 31074.22314442157, 31656.683433165374, 31688.0, 31739.04782856518, 48191.75904120457, 48721.0, 48838.0, 48894.75552622214, 48934.0, 242775.0, 243207.0, 244414.0, 244580.0, 244746.0, 26840.194794156207, 28368.858155709913, 31653.68189208202, 31890.0, 33330.666693333726, 51235.74382128065, 54191.0, 54242.728786355816, 54265.45734542604, 55245.44754552403, 38080.0, 39447.802760986015, 39548.40677389784, 39601.603983960944, 40457.59542404538, 40312.3953140709, 41576.79211603923, 42170.0, 42610.147797044505, 42684.359734603386, 43566.56433435625, 44267.778661107775, 44975.550244497135, 44978.0, 45008.549914501746, 35664.28671426609, 37439.43840842335, 37448.812755936044, 38116.618833811306, 38344.6165538341, 28602.427951440437, 28785.0, 28981.13056608305, 29022.854885725435, 29613.5557966635], "value": 19341.367521354532, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [431.3099041533546, 433.4105616361749, 440.6597987256594, 443.7049362174154, 452.26281161706413, 18860.0, 19211.423657290285, 19547.706784398244, 21676.0, 21716.565668686617, 20248.797512024874, 20601.0, 20747.792522074775, 20954.685679714818, 20965.37103886886, 5860.619059761112, 6027.0658048002415, 6081.1790408294755, 6089.634621922677, 6092.177556029946, 4474.709143905636, 5965.522758179335, 6037.516998640098, 6251.874962500748, 6714.294999025105, 6606.8678626427445, 6670.6331151786635, 6692.799216023527, 6694.029365741964, 6697.531172817905, 6327.335629758878, 6578.572392794477, 6632.668366581652, 6646.501512386542, 6653.600783952954, 4091.284025295561, 4239.978800106011, 5721.256236689245, 5935.872184284972, 5938.881222375571, 23745.762542374527, 23820.285391438112, 24130.39674008164, 25704.0, 25704.357391065187, 2447.6328550717535, 2466.7779899808925, 2471.8516888986537, 2476.925692229236, 2602.3364042169314, 14971.101733896001, 15004.24978751058, 15419.61450963735, 15447.0, 15873.0, 1987.960240795176, 2039.2149022626395, 2055.3659840426894, 2064.494198921259, 2072.896355182235, 83744.58127709384, 83853.16146838576, 84421.57789211014, 85078.0, 85941.57029214814, 11169.106471482262, 11474.885251147549, 11494.712632184095, 11499.310041397375, 11922.463489143009, 16833.747493787603, 16919.577010574834, 16960.0, 16969.490915272563, 16986.06576638272, 8829.735107946772, 9074.183323500916, 9105.726828195166, 9158.267338612895, 9267.907320926839, 8994.685186018589, 9002.05478424769, 9003.414778039407, 9029.142231487998, 9119.772005699911, 5004.624653151028, 5089.745512724349, 5103.106956282636, 5108.335916330853, 5173.120569503193, 1879.1074239736015, 1991.681330987064, 2024.6760518316999, 2080.0951586060114, 2098.5802839432176, 1030.891756365571, 1072.5388083124176, 1090.1442367741442, 1193.1543269302776, 1213.5995121609847, 18197.768894117242, 18677.906610467133, 18901.43295701131, 19862.60274794496, 20044.69932951007, 1055.9229585822573, 1109.6338208391212, 1151.447305293447, 1152.2049785647876, 1176.5470293936896, 10976.396298203676, 11421.314721116594, 11431.485583148611, 11451.370174640475, 11465.713357166138, 390624.0, 391955.0, 397083.0, 515235.0, 515601.0, 81318.59340703259, 84545.57727211325, 85097.57451212704, 98802.5059874696, 99815.50092249492, 1148.018444230188, 1185.3480585677842, 1189.7679952409371, 1193.164784650748, 1200.33981310279, 13710.931445342709, 16726.832731672526, 17101.23044462977, 17137.571560710585, 17317.56706082358, 39259.41110883282, 39499.0, 40253.39619905762, 40752.59247407607, 41790.373144403464, 50520.747396262785, 55762.44237557572, 56091.0, 56397.43602563922, 56558.0, 8825.0, 9066.863997039918, 9177.311701622271, 9339.0, 9433.764155896157, 13159.144655597356, 13985.720285594027, 14131.858681413054, 14388.712225755216, 14705.264736763333, 12487.438065286902, 12521.937390313355, 12550.309732964775, 12554.748905021666, 12674.493020279455, 12506.499740010298, 12610.495580177057, 12726.427310771223, 12761.234325940473, 12972.481100755864, 10902.890971090188, 11624.767504650028, 12579.874201258237, 12629.747405051663, 12852.678683032998, 9185.954070229605, 9456.810863782548, 9487.762805929908, 9580.56887440053, 9601.32790704672, 9919.702408927744, 12720.600733919446, 12809.42357593892, 12859.871401285867, 12944.546940857024], "value": 9832.24367687238, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1408.1902905829152, 1549.6125968507872, 1564.507180238225, 1793.5516120969758, 1925.4801203675, 8167.509949403033, 8377.16228377162, 8392.076871544134, 8395.202455766708, 8404.285635720971, 8161.510309381441, 8315.251627353537, 8318.83362332753, 8324.95837520813, 8327.875081873777, 2124.40516655336, 2360.4806942472715, 2380.1074597026113, 2418.069043418279, 2430.8419952703107, 2429.259075981825, 2440.0605766779827, 2444.1934161726676, 2445.951080978379, 2449.35092200567, 2364.9645255321097, 2443.1815341860497, 2443.2670198940336, 2444.8899799509063, 2445.572024895645, 2141.3468891987936, 2334.5914464968564, 2389.0802041214083, 2389.9880500597387, 2392.067093833415, 2347.542229265294, 2348.4481146930457, 2362.2558893948353, 2365.29041287613, 2414.251582009565, 8279.37904657147, 8336.374771892133, 8338.541380224086, 8342.62458189383, 8352.03951545574, 5201.713905735183, 5294.444083371268, 5324.201369794523, 5326.041312563737, 5395.622306438551, 3496.5978912425144, 3520.647935206459, 3558.057114864563, 3601.7118630509494, 3604.8377822998027, 1131.4738646529322, 1143.9485223164977, 1158.0388277729464, 1172.9061675065975, 1187.584345479084, 11645.18483706141, 11669.59156429521, 11689.123315751352, 11731.94134029333, 11755.764884702257, 4491.528389519119, 4573.0, 4620.607248383925, 4636.675432719745, 4640.6751527393435, 10001.949990250003, 10005.749856253651, 10011.149052330633, 10016.949915250378, 10018.3488073275, 4560.726356418625, 5325.201219816981, 5328.280682107943, 5331.413544510101, 5334.706591137525, 4174.248635245624, 4768.427788665313, 4877.975625118694, 4922.483139270396, 4922.50774922512, 4057.878263652095, 4098.590140985878, 4105.876823695294, 4122.319817230124, 4158.896027599274, 1349.291621898511, 1365.1740696878246, 1373.7458570164551, 1375.8142650742222, 1377.0360747476807, 1049.511976930731, 1053.8629978102797, 1066.440118937564, 1072.903438690506, 1078.2991055813784, 5974.223350964434, 6013.54898382623, 6104.481119104926, 6127.877442451215, 6138.1713468681155, 472.6077355794682, 476.5568021739815, 481.40786832196596, 482.4765129834099, 484.48886424821444, 4053.148838743838, 4238.321868501025, 4296.849610263625, 4344.56554344563, 4345.695801293879, 10295.794084118426, 10632.68101956927, 10742.409167495707, 10748.946255268673, 10758.731031724114, 10178.440185789705, 10362.637307694195, 10395.84406233907, 10582.365058096539, 10589.311694739818, 8157.061937877102, 8165.428420010542, 8232.0, 8234.876476852853, 8249.133840946733, 5815.651060936358, 5947.524198064058, 5956.851078723066, 6040.728167232397, 6135.417135372132, 9363.578638961399, 9405.576749046173, 9650.903490965, 9652.565634546321, 9654.855177172489, 9416.246700264099, 9611.711648650551, 9648.71053868385, 9767.658131965347, 9771.169450596495, 6621.702023408862, 6908.620025898624, 7107.0, 7584.810379740551, 7646.9617651911385, 7736.497127686683, 7766.339861111643, 7779.533228006338, 7799.49303295284, 7818.218178182136, 6932.410745086724, 7137.678804453916, 7173.24680908518, 7228.96385518069, 7276.854462910818, 7188.28117188277, 7220.277972202948, 7236.96381518089, 7279.745208917662, 7311.378532824557, 6611.636360000246, 6766.93233067663, 6775.525713200029, 6782.0, 6783.050372947692, 4995.125852975787, 5075.314832497713, 5178.71517066565, 5320.600954928318, 5363.222332761806, 5024.070546948826, 5077.796888124433, 5207.609429292743, 5254.42201357858, 5321.36143662763], "value": 4527.793256530269, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.3579206883128, 348.1123136003193, 351.68524170867073, 372.3260897775029, 375.5437143870197, 6133.907991380127, 6140.877182456348, 6168.907466388002, 6209.596376235541, 6216.906746398797, 5844.707764611774, 5945.781114871452, 5991.940080599193, 6037.2755269367735, 6122.908156377647, 4673.556012178846, 4729.834455794048, 4739.928901066487, 4746.24060150376, 4757.762111894409, 4746.596539294164, 4777.880552986186, 4782.856514304576, 4784.9521504785025, 4796.856094317176, 4465.285554311311, 4612.815487380501, 4752.382190315254, 4755.239161734106, 4762.190427627312, 4756.310335001405, 4757.26262429324, 4757.857264282077, 4776.761161941924, 4777.9761101194445, 4201.810918508644, 4207.053412982085, 4209.936850947238, 4211.515675697304, 4227.365895115727, 5902.2622172228475, 5903.76384944606, 5909.0, 5909.202257695242, 5913.940860591382, 5509.256250406184, 5521.861953451155, 5522.6134170608075, 5523.4752698493985, 5529.806456773994, 6207.627542347428, 6457.547971641987, 6476.546641735081, 6480.611163330168, 6480.74077036918, 4522.479914809806, 4549.021960278556, 4558.612517935946, 4561.178987782231, 4561.178987782231, 6742.898856517108, 6827.829304267383, 6880.862382752317, 6902.723891044352, 6905.861882762367, 4577.610903073276, 4581.473130589959, 4584.701994370355, 4587.357769912215, 4592.012717265804, 4619.9769001155455, 4632.235681112578, 4633.096546173464, 4633.2818413146015, 4637.443506779208, 5284.550813180846, 5387.0, 5396.784128634889, 5400.513953744182, 5407.242985981966, 6566.080748695091, 6566.4418524425, 6584.6378449184795, 6588.505862060365, 6593.142891424084, 1592.164113840243, 1633.6732653469353, 1636.9345226191058, 1637.025969548117, 1637.7461493468293, 982.5529384130203, 1090.574675876409, 1100.8293714474269, 1104.089126470665, 1105.5190991918541, 6200.81397558074, 6206.0, 6214.5960512566535, 6219.284782250009, 6225.408586184305, 6680.3987641112535, 6689.5986240825705, 6692.096566963495, 6695.263521012685, 6696.296888826603, 6313.842153946096, 6316.589421687576, 6316.873662526724, 6319.052142178618, 6320.336364681734, 3551.1818392265263, 3572.1248294167576, 3608.1701208721615, 3611.3499570077115, 3613.512175856278, 6769.966150169218, 6905.861882762317, 6912.861742765116, 6927.7228910844005, 6930.30696930313, 6772.288909664513, 6794.218664853605, 6797.5581587196675, 6809.829754256084, 6810.557313774589, 6886.449084073262, 6890.793276201722, 6893.689783959734, 6896.310368963063, 6902.930970690229, 6658.167729033871, 6668.699908504032, 6672.299408562031, 6676.0, 6678.83302917431, 6430.16407866993, 6526.086347911201, 6541.6402097885075, 6580.21037475506, 6588.538802283986, 6794.966025169842, 6829.93170068293, 6833.384995350442, 6851.862962740817, 6863.622500762306, 4619.792109355019, 4621.168189725881, 4622.214223581932, 4623.653226007996, 4635.953640463552, 6633.9668301658185, 6637.070810086495, 6643.60138391698, 6646.867062658816, 6649.700763465559, 6309.148264984168, 6394.104825324552, 6441.967790161019, 6443.613383197023, 6499.0, 6351.714172862325, 6384.233891932998, 6388.616682999035, 6403.167588213502, 6406.807795766134, 6310.684465776784, 6313.842153946188, 6331.430171284606, 6332.335104813928, 6336.144620476177, 6473.352664733489, 6477.417032466912, 6486.0, 6490.935090649033, 6491.578047426902, 6177.505799536116, 6330.841728956813, 6352.428281454691, 6448.774292899726, 6503.252126005381], "value": 4903.233417376547, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [770.5299767142043, 788.9013873265842, 844.9155084491548, 877.7191298784387, 881.907399723029, 14900.254987250635, 15663.60840978976, 16200.513984580452, 16205.108719020449, 16245.350185992576, 14508.129512229274, 14518.128912265245, 14648.26758662068, 14671.339789709462, 14683.632909177277, 787.6652422720349, 878.1701292278799, 882.1311008656468, 909.8362294786953, 914.3005600715458, 926.0878035135386, 937.9155875971161, 938.3056538161779, 938.7512309238058, 940.0270719805003, 961.9759506012371, 962.0571839597199, 962.129273007929, 963.0754475703333, 964.903509649033, 823.7528741377563, 959.2901253072746, 966.7631430299587, 968.9515524223831, 979.5836769372988, 714.9142102947627, 716.201435399531, 716.4268585131925, 717.8564287142592, 718.5221827484717, 15240.314185861664, 15426.845731542766, 15444.150571718552, 15445.613859653486, 15466.149361785097, 13913.165210087325, 14240.216788076652, 14340.490414177477, 14408.279586020763, 14415.063020903608, 11935.0, 12084.939575302154, 12203.938980305042, 12304.81542776859, 12355.38223088851, 4370.737755734666, 4391.912161756779, 4424.800883960197, 4459.910801783946, 4486.730796152241, 55381.169282460796, 55515.444845551836, 55547.0, 55594.722026390016, 55978.44021559814, 10613.575456981634, 10904.61833835812, 11182.944085279521, 11212.159088068265, 11265.436728163722, 19796.50508737293, 19812.0, 19842.20631174737, 20058.197672092952, 20069.49826254326, 8173.509589424534, 8272.17278272168, 8360.211842471992, 8454.535000575028, 8553.61508732096, 4749.881252968635, 4895.755212239374, 4898.191798353303, 4954.9009019819405, 5051.646384753106, 3484.059303987909, 3507.2459421224557, 3507.5264839246884, 3538.6461353864406, 3542.6103128655827, 599.6611914268425, 600.1328080923112, 611.1535523300172, 612.301975747648, 633.9714712837933, 700.0689083518907, 710.1832892174041, 739.1979702023258, 744.8100734312716, 755.3013462547232, 9489.430634161972, 9801.16690081351, 9830.164436022875, 10037.899621003697, 10052.145567626834, 669.6685140855308, 686.4542688562605, 689.9931000690029, 736.1350413264393, 738.6159197217416, 4560.156371071363, 4587.128445595326, 4675.438947326343, 4695.3191787191345, 4707.905841883143, 62858.68570657209, 63567.68216158982, 63598.68200658967, 63886.36113638897, 64386.0, 55668.443315567136, 56909.0, 56957.43042569604, 57097.429025709214, 57154.42845571491, 50271.49728502668, 51327.486725133014, 52022.0, 52073.47926520762, 53183.0, 8962.372633915824, 9065.63737450521, 9148.817023659623, 9230.0, 9257.444553326823, 38616.80691596524, 40652.18695626012, 40692.1861562773, 41201.1759764809, 41298.79350603228, 45612.543874560826, 46522.30216546822, 50111.0, 50635.49364506308, 50939.49060509347, 11276.041536469493, 11356.488957997075, 11374.31754094757, 11606.129540284344, 11621.709457263636, 12386.938065309616, 12493.375331233583, 12584.307863067253, 12736.363181841056, 13157.079004469595, 10779.89220107789, 11718.70703232426, 13153.53962611304, 13404.128731632412, 13780.65548361299, 12865.614031579067, 13066.673333166747, 13087.345632718136, 13331.533396331082, 13430.39563219638, 12602.810957835824, 12692.238465692088, 12779.744405112031, 12799.80800288015, 12905.290209038218, 10677.14582833387, 10677.199210059121, 10740.946295268786, 10761.730956726144, 11410.600628977945, 10804.567817287221, 11205.0, 11394.829077563678, 11427.60003399877, 11448.0], "value": 7075.760777521357, "unit": "score"}], "name": "dromaeo_css", "value": 7376.762968302335, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 109.0, 108.0, 109.0, 112.0, 104.0, 108.0, 109.0, 109.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 124.0, 155.0, 174.0, 128.0, 159.0, 164.0, 129.0, 191.0, 126.0], "value": 150.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 161.0, 163.0, 160.0, 161.0, 163.0, 159.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 72.0, 75.0, 171.0, 76.0, 76.0, 75.0, 77.0, 153.0, 78.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 151.0, 91.0, 93.0, 92.0, 151.0, 92.0, 91.0, 150.0], "value": 109.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 144.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 54.0, 53.0, 55.0, 56.0, 55.0, 82.0, 56.0, 54.0], "value": 57.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 57.0, 57.0, 57.0, 58.0, 58.0, 58.0, 58.0, 58.0, 57.0], "value": 57.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 71.0, 80.0, 72.0, 81.0, 73.0, 74.0, 74.0, 72.0, 73.0], "value": 74.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 114.0, 112.0, 114.0, 111.0, 114.0, 113.0, 114.0, 136.0, 129.0], "value": 118.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 167.0, 159.0, 163.0, 159.0, 159.0, 163.0, 168.0, 158.0], "value": 162.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 68.0, 68.0, 67.0, 69.0, 68.0, 67.0, 69.0, 68.0], "value": 68.3, "unit": "score"}], "name": "kraken", "value": 1517.6, "alertThreshold": 2.0}]} 03:50:55 INFO - Return code: 0 03:50:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:50:55 ERROR - # TBPL SUCCESS # 03:50:55 INFO - Running post-action listener: _resource_record_post_action 03:50:55 INFO - Running post-run listener: _resource_record_post_run 03:50:56 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 405504; Write bytes: 498130944; Read time: 48; Write time: 356120 03:50:56 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 248037376; Read time: 0; Write time: 223004 03:50:56 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 405504; Write bytes: 249495552; Read time: 48; Write time: 133116 03:50:56 INFO - Running post-run listener: _upload_blobber_files 03:50:56 INFO - Blob upload gear active. 03:50:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:50:56 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 03:50:56 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'] 03:50:56 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 03:50:56 INFO - (blobuploader) - INFO - Open directory for files ... 03:50:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:50:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:50:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:50:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:50:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:50:57 INFO - (blobuploader) - INFO - Done attempting. 03:50:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:50:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:50:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:50:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:50:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:50:58 INFO - (blobuploader) - INFO - Done attempting. 03:50:58 INFO - (blobuploader) - INFO - Iteration through files over. 03:50:58 INFO - Return code: 0 03:50:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:50:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:50:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1b623fb8df962ee7ed443a512eaa7516faac509907897f8668e24a5abf236e0bb96129d29f11b75d3e0cc3a50425eb69696ccd065b6a5a491aa8ea3ae301a1ef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ca02cc30c8879d956ab54247b906a8a3c8b89ba3633427a000344ec1ced3a7d7ef741f4f4cfe03901b0ff78d2fc347263677f7a37a767b64d0ee6b1b3971d50a"} 03:50:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:50:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:50:58 INFO - Contents: 03:50:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1b623fb8df962ee7ed443a512eaa7516faac509907897f8668e24a5abf236e0bb96129d29f11b75d3e0cc3a50425eb69696ccd065b6a5a491aa8ea3ae301a1ef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ca02cc30c8879d956ab54247b906a8a3c8b89ba3633427a000344ec1ced3a7d7ef741f4f4cfe03901b0ff78d2fc347263677f7a37a767b64d0ee6b1b3971d50a"} 03:50:58 INFO - Running post-run listener: copy_logs_to_upload_dir 03:50:58 INFO - Copying logs to upload dir... 03:50:58 INFO - mkdir: /builds/slave/test/build/upload/logs 03:50:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.237798 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-05-13 03:50:58.640104) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-13 03:50:58.643850) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1463134744.268918-2108606967 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1b623fb8df962ee7ed443a512eaa7516faac509907897f8668e24a5abf236e0bb96129d29f11b75d3e0cc3a50425eb69696ccd065b6a5a491aa8ea3ae301a1ef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ca02cc30c8879d956ab54247b906a8a3c8b89ba3633427a000344ec1ced3a7d7ef741f4f4cfe03901b0ff78d2fc347263677f7a37a767b64d0ee6b1b3971d50a"} build_url:https://queue.taskcluster.net/v1/task/JfeGISsqQtexHifryKtjPg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011192 build_url: 'https://queue.taskcluster.net/v1/task/JfeGISsqQtexHifryKtjPg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1b623fb8df962ee7ed443a512eaa7516faac509907897f8668e24a5abf236e0bb96129d29f11b75d3e0cc3a50425eb69696ccd065b6a5a491aa8ea3ae301a1ef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ca02cc30c8879d956ab54247b906a8a3c8b89ba3633427a000344ec1ced3a7d7ef741f4f4cfe03901b0ff78d2fc347263677f7a37a767b64d0ee6b1b3971d50a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-13 03:50:58.679255) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 03:50:58.679616) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1463134744.268918-2108606967 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004445 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 03:50:58.737141) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 03:50:58.737469) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 03:50:58.737755) ========= ========= Total master_lag: 0.15 =========