builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-051 starttime: 1465051095.34 results: success (0) buildid: 20160604051125 builduid: b3e475dab5d94bf89be646eca3f3a552 revision: 7eb468713fd5d88f0992eee5ab463432c204334f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-04 07:38:15.337308) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-04 07:38:15.337709) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-04 07:38:15.337980) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-04 07:38:15.379382) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 07:38:15.379669) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1465049267.899387-22348930 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-04 07:38:15-- 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% 90.1M=0s 2016-06-04 07:38:15 (90.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.150529 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 07:38:15.556069) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 07:38:15.556347) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1465049267.899387-22348930 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018200 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 07:38:15.605970) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 07:38:15.606284) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7eb468713fd5d88f0992eee5ab463432c204334f --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 7eb468713fd5d88f0992eee5ab463432c204334f --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=5ac5dba3e01a12f1ff77ab15000001b1-1465049267.899387-22348930 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-04 07:38:15,760 truncating revision to first 12 chars 2016-06-04 07:38:15,760 Setting DEBUG logging. 2016-06-04 07:38:15,760 attempt 1/10 2016-06-04 07:38:15,760 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7eb468713fd5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-04 07:38:16,051 unpacking tar archive at: mozilla-aurora-7eb468713fd5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.614876 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 07:38:16.236550) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-04 07:38:16.236821) ========= script_repo_revision: 7eb468713fd5d88f0992eee5ab463432c204334f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-04 07:38:16.237188) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-04 07:38:16.237456) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-04 07:38:16.251641) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-06-04 07:38:16.251912) ========= /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=5ac5dba3e01a12f1ff77ab15000001b1-1465049267.899387-22348930 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:38:16 INFO - MultiFileLogger online at 20160604 07:38:16 in /builds/slave/test 07:38:16 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 07:38:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:38:16 INFO - {'append_to_log': False, 07:38:16 INFO - 'base_work_dir': '/builds/slave/test', 07:38:16 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:38:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:38:16 INFO - 'branch': 'Mozilla-Aurora', 07:38:16 INFO - 'buildbot_json_path': 'buildprops.json', 07:38:16 INFO - 'config_files': ('talos/linux_config.py',), 07:38:16 INFO - 'default_actions': ('clobber', 07:38:16 INFO - 'read-buildbot-config', 07:38:16 INFO - 'download-and-extract', 07:38:16 INFO - 'populate-webroot', 07:38:16 INFO - 'create-virtualenv', 07:38:16 INFO - 'install', 07:38:16 INFO - 'run-tests'), 07:38:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:38:16 INFO - 'download_minidump_stackwalk': True, 07:38:16 INFO - 'download_symbols': 'ondemand', 07:38:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:38:16 INFO - 'tooltool.py': '/tools/tooltool.py', 07:38:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:38:16 INFO - '/tools/misc-python/virtualenv.py')}, 07:38:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:38:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:38:16 INFO - 'installer_path': 'installer.exe', 07:38:16 INFO - 'log_level': 'info', 07:38:16 INFO - 'log_name': 'talos', 07:38:16 INFO - 'log_to_console': True, 07:38:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:38:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:38:16 INFO - 'opt_config_files': (), 07:38:16 INFO - 'pip_index': False, 07:38:16 INFO - 'sps_profile': False, 07:38:16 INFO - 'sps_profile_interval': 0, 07:38:16 INFO - 'suite': 'dromaeojs', 07:38:16 INFO - 'system_bits': '32', 07:38:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:38:16 INFO - 'title': 'talos-linux64-ix-051', 07:38:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:38:16 INFO - 'use_talos_json': True, 07:38:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:38:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:38:16 INFO - 'work_dir': 'build'} 07:38:16 INFO - ##### 07:38:16 INFO - ##### Running clobber step. 07:38:16 INFO - ##### 07:38:16 INFO - Running pre-action listener: _resource_record_pre_action 07:38:16 INFO - Running main action method: clobber 07:38:16 INFO - rmtree: /builds/slave/test/build 07:38:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:38:17 INFO - Running post-action listener: _resource_record_post_action 07:38:17 INFO - ##### 07:38:17 INFO - ##### Running read-buildbot-config step. 07:38:17 INFO - ##### 07:38:17 INFO - Running pre-action listener: _resource_record_pre_action 07:38:17 INFO - Running main action method: read_buildbot_config 07:38:17 INFO - Using buildbot properties: 07:38:17 INFO - { 07:38:17 INFO - "project": "", 07:38:17 INFO - "product": "firefox", 07:38:17 INFO - "script_repo_revision": "production", 07:38:17 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 07:38:17 INFO - "repository": "", 07:38:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 07:38:17 INFO - "buildid": "20160604051125", 07:38:17 INFO - "pgo_build": "True", 07:38:17 INFO - "basedir": "/builds/slave/test", 07:38:17 INFO - "buildnumber": 282, 07:38:17 INFO - "slavename": "talos-linux64-ix-051", 07:38:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:38:17 INFO - "platform": "ubuntu64_hw", 07:38:17 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 07:38:17 INFO - "branch": "mozilla-aurora", 07:38:17 INFO - "repo_path": "releases/mozilla-aurora", 07:38:17 INFO - "revision": "7eb468713fd5d88f0992eee5ab463432c204334f", 07:38:17 INFO - "stage_platform": "linux64-pgo", 07:38:17 INFO - "builduid": "b3e475dab5d94bf89be646eca3f3a552", 07:38:17 INFO - "slavebuilddir": "test" 07:38:17 INFO - } 07:38:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ykk4DjLvSfycvghfshHlkg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 07:38:17 INFO - Running post-action listener: _resource_record_post_action 07:38:17 INFO - ##### 07:38:17 INFO - ##### Running download-and-extract step. 07:38:17 INFO - ##### 07:38:17 INFO - Running pre-action listener: _resource_record_pre_action 07:38:17 INFO - Running main action method: download_and_extract 07:38:17 INFO - mkdir: /builds/slave/test/build/tests 07:38:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:17 INFO - https://queue.taskcluster.net/v1/task/Ykk4DjLvSfycvghfshHlkg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:38:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ykk4DjLvSfycvghfshHlkg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 07:38:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ykk4DjLvSfycvghfshHlkg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 07:38:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ykk4DjLvSfycvghfshHlkg/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 07:38:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ykk4DjLvSfycvghfshHlkg/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 07:38:27 INFO - Downloaded 1361 bytes. 07:38:27 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 07:38:27 INFO - Using the following test package requirements: 07:38:27 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 07:38:27 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:38:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 07:38:27 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:38:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 07:38:27 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:38:27 INFO - u'jsshell-linux-x86_64.zip'], 07:38:27 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:38:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 07:38:27 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 07:38:27 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:38:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 07:38:27 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:38:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 07:38:27 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:38:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 07:38:27 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:38:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 07:38:27 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:38:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:27 INFO - https://queue.taskcluster.net/v1/task/Ykk4DjLvSfycvghfshHlkg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:38:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ykk4DjLvSfycvghfshHlkg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 07:38:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ykk4DjLvSfycvghfshHlkg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 07:38:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ykk4DjLvSfycvghfshHlkg/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 07:38:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ykk4DjLvSfycvghfshHlkg/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 07:38:32 INFO - Downloaded 24177762 bytes. 07:38:32 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'] 07:38:32 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 07:38:33 INFO - Return code: 0 07:38:33 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 07:38:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:33 INFO - https://queue.taskcluster.net/v1/task/Ykk4DjLvSfycvghfshHlkg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:38:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ykk4DjLvSfycvghfshHlkg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 07:38:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ykk4DjLvSfycvghfshHlkg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 07:38:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ykk4DjLvSfycvghfshHlkg/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 07:38:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ykk4DjLvSfycvghfshHlkg/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 07:38:35 INFO - Downloaded 24177762 bytes. 07:38:35 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'] 07:38:35 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 07:38:37 INFO - Return code: 0 07:38:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:37 INFO - https://queue.taskcluster.net/v1/task/Ykk4DjLvSfycvghfshHlkg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:38:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ykk4DjLvSfycvghfshHlkg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 07:38:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ykk4DjLvSfycvghfshHlkg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 07:38:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ykk4DjLvSfycvghfshHlkg/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 07:38:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ykk4DjLvSfycvghfshHlkg/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 07:38:38 INFO - Downloaded 10840145 bytes. 07:38:38 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'] 07:38:38 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 07:38:38 INFO - Return code: 0 07:38:38 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')]} 07:38:38 INFO - https://queue.taskcluster.net/v1/task/Ykk4DjLvSfycvghfshHlkg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:38:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ykk4DjLvSfycvghfshHlkg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 07:38:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ykk4DjLvSfycvghfshHlkg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 07:38:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ykk4DjLvSfycvghfshHlkg/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 07:38:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ykk4DjLvSfycvghfshHlkg/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 07:38:41 INFO - Downloaded 62811750 bytes. 07:38:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ykk4DjLvSfycvghfshHlkg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 07:38:41 INFO - mkdir: /builds/slave/test/properties 07:38:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:38:41 INFO - Writing to file /builds/slave/test/properties/build_url 07:38:41 INFO - Contents: 07:38:41 INFO - build_url:https://queue.taskcluster.net/v1/task/Ykk4DjLvSfycvghfshHlkg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 07:38:42 INFO - Running post-action listener: _resource_record_post_action 07:38:42 INFO - Running post-action listener: set_extra_try_arguments 07:38:42 INFO - ##### 07:38:42 INFO - ##### Running populate-webroot step. 07:38:42 INFO - ##### 07:38:42 INFO - Running pre-action listener: _resource_record_pre_action 07:38:42 INFO - Running main action method: populate_webroot 07:38:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:38:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:38:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:38:42 INFO - '--tppagecycles', 07:38:42 INFO - '7'], 07:38:42 INFO - 'tests': ['tsvgm']}}, 07:38:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:38:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:38:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:38:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:38:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:38:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:38:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:42 INFO - 'talos_options': ['--disable-e10s'], 07:38:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:38:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:38:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:42 INFO - 'talos_options': ['--disable-e10s'], 07:38:42 INFO - 'tests': ['damp', 'tps']}, 07:38:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:42 INFO - 'tests': ['damp', 'tps']}, 07:38:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:38:42 INFO - 'tests': ['dromaeo_dom']}, 07:38:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:38:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:38:42 INFO - 'tests': ['a11yr', 07:38:42 INFO - 'ts_paint', 07:38:42 INFO - 'tpaint', 07:38:42 INFO - 'sessionrestore', 07:38:42 INFO - 'sessionrestore_no_auto_restore', 07:38:42 INFO - 'tabpaint']}, 07:38:42 INFO - 'other-e10s': {'tests': ['a11yr', 07:38:42 INFO - 'ts_paint', 07:38:42 INFO - 'tpaint', 07:38:42 INFO - 'sessionrestore', 07:38:42 INFO - 'sessionrestore_no_auto_restore', 07:38:42 INFO - 'tabpaint']}, 07:38:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:38:42 INFO - 'ts_paint', 07:38:42 INFO - 'tpaint', 07:38:42 INFO - 'sessionrestore', 07:38:42 INFO - 'sessionrestore_no_auto_restore', 07:38:42 INFO - 'tabpaint']}, 07:38:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:38:42 INFO - 'ts_paint', 07:38:42 INFO - 'tpaint', 07:38:42 INFO - 'sessionrestore', 07:38:42 INFO - 'sessionrestore_no_auto_restore', 07:38:42 INFO - 'tabpaint']}, 07:38:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:38:42 INFO - 'tests': ['a11yr', 07:38:42 INFO - 'ts_paint', 07:38:42 INFO - 'tpaint', 07:38:42 INFO - 'sessionrestore', 07:38:42 INFO - 'sessionrestore_no_auto_restore', 07:38:42 INFO - 'tabpaint']}, 07:38:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:38:42 INFO - 'tests': ['a11yr', 07:38:42 INFO - 'ts_paint', 07:38:42 INFO - 'tpaint', 07:38:42 INFO - 'sessionrestore', 07:38:42 INFO - 'sessionrestore_no_auto_restore', 07:38:42 INFO - 'tabpaint']}, 07:38:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:38:42 INFO - 'tests': ['tsvgx', 07:38:42 INFO - 'tsvgr_opacity', 07:38:42 INFO - 'tart', 07:38:42 INFO - 'tscrollx', 07:38:42 INFO - 'cart']}, 07:38:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:38:42 INFO - 'tsvgr_opacity', 07:38:42 INFO - 'tart', 07:38:42 INFO - 'tscrollx', 07:38:42 INFO - 'cart']}, 07:38:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:42 INFO - 'talos_options': ['--disable-e10s'], 07:38:42 INFO - 'tests': ['tp5o']}, 07:38:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:42 INFO - 'tests': ['tp5o']}, 07:38:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:42 INFO - 'talos_options': ['--disable-e10s', 07:38:42 INFO - '--xperf_path', 07:38:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:38:42 INFO - 'tests': ['tp5n']}, 07:38:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:42 INFO - 'talos_options': ['--xperf_path', 07:38:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:38:42 INFO - 'tests': ['tp5n']}}, 07:38:42 INFO - 'talos.zip': {'path': '', 07:38:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:38:42 INFO - Running post-action listener: _resource_record_post_action 07:38:42 INFO - ##### 07:38:42 INFO - ##### Running create-virtualenv step. 07:38:42 INFO - ##### 07:38:42 INFO - Running pre-action listener: _resource_record_pre_action 07:38:42 INFO - Running main action method: create_virtualenv 07:38:42 INFO - Creating virtualenv /builds/slave/test/build/venv 07:38:42 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 07:38:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:38:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:38:43 INFO - Using real prefix '/usr' 07:38:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:38:43 INFO - Installing distribute.............................................................................................................................................................................................done. 07:38:45 INFO - Installing pip.................done. 07:38:45 INFO - Return code: 0 07:38:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:38: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')]} 07:38:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38: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')]} 07:38:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38: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 0x7f392270ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dda7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e69640>, '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 0x1e6a540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a9d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465049267.899387-22348930', '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 07:38: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 07:38: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 07:38:45 INFO - Using env: {'DISPLAY': ':0', 07:38:45 INFO - 'HOME': '/home/cltbld', 07:38:45 INFO - 'LANG': 'en_US.UTF-8', 07:38:45 INFO - 'LANGUAGE': 'en_US:en', 07:38:45 INFO - 'LOGNAME': 'cltbld', 07:38:45 INFO - 'MAIL': '/var/mail/cltbld', 07:38:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:45 INFO - 'MOZ_NO_REMOTE': '1', 07:38:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:45 INFO - 'NO_EM_RESTART': '1', 07:38:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:45 INFO - 'PWD': '/builds/slave/test', 07:38:45 INFO - 'SHELL': '/bin/bash', 07:38:45 INFO - 'SHLVL': '1', 07:38:45 INFO - 'TERM': 'linux', 07:38:45 INFO - 'TMOUT': '86400', 07:38:45 INFO - 'USER': 'cltbld', 07:38:45 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465049267.899387-22348930', 07:38:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:45 INFO - '_': '/tools/buildbot/bin/python'} 07:38:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38: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 07:38:45 INFO - Cleaning up... 07:38:46 INFO - Return code: 0 07:38:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:38:46 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')]} 07:38:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:46 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')]} 07:38:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:46 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 0x7f392270ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dda7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e69640>, '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 0x1e6a540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a9d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465049267.899387-22348930', '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 07:38:46 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 07:38:46 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 07:38:46 INFO - Using env: {'DISPLAY': ':0', 07:38:46 INFO - 'HOME': '/home/cltbld', 07:38:46 INFO - 'LANG': 'en_US.UTF-8', 07:38:46 INFO - 'LANGUAGE': 'en_US:en', 07:38:46 INFO - 'LOGNAME': 'cltbld', 07:38:46 INFO - 'MAIL': '/var/mail/cltbld', 07:38:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:46 INFO - 'MOZ_NO_REMOTE': '1', 07:38:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:46 INFO - 'NO_EM_RESTART': '1', 07:38:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:46 INFO - 'PWD': '/builds/slave/test', 07:38:46 INFO - 'SHELL': '/bin/bash', 07:38:46 INFO - 'SHLVL': '1', 07:38:46 INFO - 'TERM': 'linux', 07:38:46 INFO - 'TMOUT': '86400', 07:38:46 INFO - 'USER': 'cltbld', 07:38:46 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465049267.899387-22348930', 07:38:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:46 INFO - '_': '/tools/buildbot/bin/python'} 07:38:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:46 INFO - Downloading/unpacking psutil>=0.7.1 07:38: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 07:38: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 07:38: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 07:38: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 07:38: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 07:38: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 07:38:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:38:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:38:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:38:48 INFO - Installing collected packages: psutil 07:38:48 INFO - Running setup.py install for psutil 07:38:48 INFO - building 'psutil._psutil_linux' extension 07:38: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 07:38:49 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 07:38:49 INFO - building 'psutil._psutil_posix' extension 07:38:49 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 07:38:49 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 07:38:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:38:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:38:49 INFO - Successfully installed psutil 07:38:49 INFO - Cleaning up... 07:38:49 INFO - Return code: 0 07:38:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:38:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:49 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 0x7f392270ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dda7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e69640>, '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 0x1e6a540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a9d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465049267.899387-22348930', '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 07:38:49 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 07:38:49 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 07:38:49 INFO - Using env: {'DISPLAY': ':0', 07:38:49 INFO - 'HOME': '/home/cltbld', 07:38:49 INFO - 'LANG': 'en_US.UTF-8', 07:38:49 INFO - 'LANGUAGE': 'en_US:en', 07:38:49 INFO - 'LOGNAME': 'cltbld', 07:38:49 INFO - 'MAIL': '/var/mail/cltbld', 07:38:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:49 INFO - 'MOZ_NO_REMOTE': '1', 07:38:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:49 INFO - 'NO_EM_RESTART': '1', 07:38:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:49 INFO - 'PWD': '/builds/slave/test', 07:38:49 INFO - 'SHELL': '/bin/bash', 07:38:49 INFO - 'SHLVL': '1', 07:38:49 INFO - 'TERM': 'linux', 07:38:49 INFO - 'TMOUT': '86400', 07:38:49 INFO - 'USER': 'cltbld', 07:38:49 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465049267.899387-22348930', 07:38:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:49 INFO - '_': '/tools/buildbot/bin/python'} 07:38:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:38:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:38:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:38:52 INFO - Installing collected packages: mozsystemmonitor 07:38:52 INFO - Running setup.py install for mozsystemmonitor 07:38:52 INFO - Successfully installed mozsystemmonitor 07:38:52 INFO - Cleaning up... 07:38:52 INFO - Return code: 0 07:38:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:38:52 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')]} 07:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:52 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')]} 07:38:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:52 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 0x7f392270ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dda7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e69640>, '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 0x1e6a540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a9d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465049267.899387-22348930', '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 07:38:52 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 07:38:52 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 07:38:52 INFO - Using env: {'DISPLAY': ':0', 07:38:52 INFO - 'HOME': '/home/cltbld', 07:38:52 INFO - 'LANG': 'en_US.UTF-8', 07:38:52 INFO - 'LANGUAGE': 'en_US:en', 07:38:52 INFO - 'LOGNAME': 'cltbld', 07:38:52 INFO - 'MAIL': '/var/mail/cltbld', 07:38:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:52 INFO - 'MOZ_NO_REMOTE': '1', 07:38:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:52 INFO - 'NO_EM_RESTART': '1', 07:38:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:52 INFO - 'PWD': '/builds/slave/test', 07:38:52 INFO - 'SHELL': '/bin/bash', 07:38:52 INFO - 'SHLVL': '1', 07:38:52 INFO - 'TERM': 'linux', 07:38:52 INFO - 'TMOUT': '86400', 07:38:52 INFO - 'USER': 'cltbld', 07:38:52 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465049267.899387-22348930', 07:38:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:52 INFO - '_': '/tools/buildbot/bin/python'} 07:38:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:52 INFO - Downloading/unpacking blobuploader==1.2.4 07:38:52 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 07:38:52 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 07:38:52 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 07:38:52 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 07:38:52 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 07:38:52 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 07:38:54 INFO - Downloading blobuploader-1.2.4.tar.gz 07:38:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:38:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:38:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:38:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:38:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:54 INFO - Downloading docopt-0.6.1.tar.gz 07:38:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:38:55 INFO - Installing collected packages: blobuploader, requests, docopt 07:38:55 INFO - Running setup.py install for blobuploader 07:38:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:38:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:38:55 INFO - Running setup.py install for requests 07:38:55 INFO - Running setup.py install for docopt 07:38:55 INFO - Successfully installed blobuploader requests docopt 07:38:55 INFO - Cleaning up... 07:38:55 INFO - Return code: 0 07:38:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:38:55 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')]} 07:38:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:55 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')]} 07:38:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:55 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 0x7f392270ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dda7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e69640>, '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 0x1e6a540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a9d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465049267.899387-22348930', '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 07:38:55 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 07:38:55 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 07:38:55 INFO - Using env: {'DISPLAY': ':0', 07:38:55 INFO - 'HOME': '/home/cltbld', 07:38:55 INFO - 'LANG': 'en_US.UTF-8', 07:38:55 INFO - 'LANGUAGE': 'en_US:en', 07:38:55 INFO - 'LOGNAME': 'cltbld', 07:38:55 INFO - 'MAIL': '/var/mail/cltbld', 07:38:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:55 INFO - 'MOZ_NO_REMOTE': '1', 07:38:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:55 INFO - 'NO_EM_RESTART': '1', 07:38:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:55 INFO - 'PWD': '/builds/slave/test', 07:38:55 INFO - 'SHELL': '/bin/bash', 07:38:55 INFO - 'SHLVL': '1', 07:38:55 INFO - 'TERM': 'linux', 07:38:55 INFO - 'TMOUT': '86400', 07:38:55 INFO - 'USER': 'cltbld', 07:38:55 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465049267.899387-22348930', 07:38:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:55 INFO - '_': '/tools/buildbot/bin/python'} 07:38:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:38:55 INFO - Running setup.py (path:/tmp/pip-klbaYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:38:55 INFO - Running setup.py (path:/tmp/pip-c40b7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:38:55 INFO - Running setup.py (path:/tmp/pip-iaf2pC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:38:56 INFO - Running setup.py (path:/tmp/pip-29MTam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:38:56 INFO - Running setup.py (path:/tmp/pip-tBygkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:38:56 INFO - Running setup.py (path:/tmp/pip-HoSD_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:38:56 INFO - Running setup.py (path:/tmp/pip-mtJvYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:38:56 INFO - Running setup.py (path:/tmp/pip-WWMgQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:38:56 INFO - Running setup.py (path:/tmp/pip-o8oP7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:38:56 INFO - Running setup.py (path:/tmp/pip-AamZ0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:38:56 INFO - Running setup.py (path:/tmp/pip-lwXsJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:38:56 INFO - Running setup.py (path:/tmp/pip-hQdLL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:38:56 INFO - Running setup.py (path:/tmp/pip-DJoxbS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:38:56 INFO - Running setup.py (path:/tmp/pip-lNXqbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:56 INFO - Running setup.py (path:/tmp/pip-3QkkY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:38:56 INFO - Running setup.py (path:/tmp/pip-XX8Pd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:38:56 INFO - Running setup.py (path:/tmp/pip-qnUiAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:38:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:38:57 INFO - Running setup.py install for manifestparser 07:38:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:38:57 INFO - Running setup.py install for mozcrash 07:38:57 INFO - Running setup.py install for mozdebug 07:38:57 INFO - Running setup.py install for mozdevice 07:38:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:38:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:38:57 INFO - Running setup.py install for mozfile 07:38:57 INFO - Running setup.py install for mozhttpd 07:38:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:38:57 INFO - Running setup.py install for mozinfo 07:38:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:38:57 INFO - Running setup.py install for mozInstall 07:38:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:38:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:38:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:38:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:38:57 INFO - Running setup.py install for mozleak 07:38:57 INFO - Running setup.py install for mozlog 07:38:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:38:58 INFO - Running setup.py install for moznetwork 07:38:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:38:58 INFO - Running setup.py install for mozprocess 07:38:58 INFO - Running setup.py install for mozprofile 07:38:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:38:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:38:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:38:58 INFO - Running setup.py install for mozrunner 07:38:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:38:58 INFO - Running setup.py install for mozscreenshot 07:38:58 INFO - Running setup.py install for moztest 07:38:58 INFO - Running setup.py install for mozversion 07:38:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:38:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:38:58 INFO - Cleaning up... 07:38:58 INFO - Return code: 0 07:38:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:38:58 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')]} 07:38:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:58 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')]} 07:38:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:58 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 0x7f392270ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dda7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e69640>, '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 0x1e6a540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a9d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465049267.899387-22348930', '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 07:38:58 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 07:38:58 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 07:38:58 INFO - Using env: {'DISPLAY': ':0', 07:38:58 INFO - 'HOME': '/home/cltbld', 07:38:58 INFO - 'LANG': 'en_US.UTF-8', 07:38:58 INFO - 'LANGUAGE': 'en_US:en', 07:38:58 INFO - 'LOGNAME': 'cltbld', 07:38:58 INFO - 'MAIL': '/var/mail/cltbld', 07:38:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:58 INFO - 'MOZ_NO_REMOTE': '1', 07:38:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:58 INFO - 'NO_EM_RESTART': '1', 07:38:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:58 INFO - 'PWD': '/builds/slave/test', 07:38:58 INFO - 'SHELL': '/bin/bash', 07:38:58 INFO - 'SHLVL': '1', 07:38:58 INFO - 'TERM': 'linux', 07:38:58 INFO - 'TMOUT': '86400', 07:38:58 INFO - 'USER': 'cltbld', 07:38:58 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465049267.899387-22348930', 07:38:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:58 INFO - '_': '/tools/buildbot/bin/python'} 07:38:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:38:59 INFO - Running setup.py (path:/tmp/pip-ZRgyZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:38:59 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)) 07:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:38:59 INFO - Running setup.py (path:/tmp/pip-d2ar59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:38:59 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)) 07:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:38:59 INFO - Running setup.py (path:/tmp/pip-5Q7Zld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:38:59 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)) 07:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:38:59 INFO - Running setup.py (path:/tmp/pip-Pt9jCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:38:59 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)) 07:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:38:59 INFO - Running setup.py (path:/tmp/pip-Tbyl43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:38:59 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)) 07:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:38:59 INFO - Running setup.py (path:/tmp/pip-ZTmsDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:38:59 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)) 07:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:38:59 INFO - Running setup.py (path:/tmp/pip-1PF1mf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:38:59 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)) 07:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:38:59 INFO - Running setup.py (path:/tmp/pip-k0VACj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:38:59 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)) 07:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:38:59 INFO - Running setup.py (path:/tmp/pip-5GJ0KG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:38:59 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)) 07:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:38:59 INFO - Running setup.py (path:/tmp/pip-QcSfYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:38:59 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)) 07:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:38:59 INFO - Running setup.py (path:/tmp/pip-n9N7rT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:38:59 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)) 07:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:38:59 INFO - Running setup.py (path:/tmp/pip-fE79Eq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:38:59 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)) 07:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:38:59 INFO - Running setup.py (path:/tmp/pip-1p2ter-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:38:59 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)) 07:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:39:00 INFO - Running setup.py (path:/tmp/pip-qumVXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:39:00 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)) 07:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:39:00 INFO - Running setup.py (path:/tmp/pip-2NHdwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:39:00 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)) 07:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:39:00 INFO - Running setup.py (path:/tmp/pip-M1FjTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:39:00 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)) 07:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:39:00 INFO - Running setup.py (path:/tmp/pip-XCLHxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:39:00 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)) 07:39:00 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)) 07:39:00 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)) 07:39:00 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)) 07:39:00 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)) 07:39:00 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)) 07:39:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:39:00 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 07:39:00 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 07:39:00 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 07:39:00 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 07:39:00 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 07:39:00 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 07:39:02 INFO - Downloading blessings-1.6.tar.gz 07:39:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:39:02 INFO - Installing collected packages: blessings 07:39:02 INFO - Running setup.py install for blessings 07:39:02 INFO - Successfully installed blessings 07:39:02 INFO - Cleaning up... 07:39:02 INFO - Return code: 0 07:39:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:39:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:39:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:39:02 INFO - Reading from file tmpfile_stdout 07:39:02 INFO - Current package versions: 07:39:02 INFO - argparse == 1.2.1 07:39:02 INFO - blessings == 1.6 07:39:02 INFO - blobuploader == 1.2.4 07:39:02 INFO - docopt == 0.6.1 07:39:02 INFO - manifestparser == 1.1 07:39:02 INFO - mozInstall == 1.12 07:39:02 INFO - mozcrash == 0.17 07:39:02 INFO - mozdebug == 0.1 07:39:02 INFO - mozdevice == 0.48 07:39:02 INFO - mozfile == 1.2 07:39:02 INFO - mozhttpd == 0.7 07:39:02 INFO - mozinfo == 0.9 07:39:02 INFO - mozleak == 0.1 07:39:02 INFO - mozlog == 3.1 07:39:02 INFO - moznetwork == 0.27 07:39:02 INFO - mozprocess == 0.22 07:39:02 INFO - mozprofile == 0.28 07:39:02 INFO - mozrunner == 6.11 07:39:02 INFO - mozscreenshot == 0.1 07:39:02 INFO - mozsystemmonitor == 0.0 07:39:02 INFO - moztest == 0.7 07:39:02 INFO - mozversion == 1.4 07:39:02 INFO - psutil == 3.1.1 07:39:02 INFO - requests == 1.2.3 07:39:02 INFO - wsgiref == 0.1.2 07:39:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:39:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:39:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:39:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:39:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:39:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39:02 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 0x7f392270ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dda7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e69640>, '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 0x1e6a540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a9d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465049267.899387-22348930', '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 07:39:02 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 07:39:02 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 07:39:02 INFO - Using env: {'DISPLAY': ':0', 07:39:02 INFO - 'HOME': '/home/cltbld', 07:39:02 INFO - 'LANG': 'en_US.UTF-8', 07:39:02 INFO - 'LANGUAGE': 'en_US:en', 07:39:02 INFO - 'LOGNAME': 'cltbld', 07:39:02 INFO - 'MAIL': '/var/mail/cltbld', 07:39:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:39:02 INFO - 'MOZ_NO_REMOTE': '1', 07:39:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:39:02 INFO - 'NO_EM_RESTART': '1', 07:39:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:39:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:39:02 INFO - 'PWD': '/builds/slave/test', 07:39:02 INFO - 'SHELL': '/bin/bash', 07:39:02 INFO - 'SHLVL': '1', 07:39:02 INFO - 'TERM': 'linux', 07:39:02 INFO - 'TMOUT': '86400', 07:39:02 INFO - 'USER': 'cltbld', 07:39:02 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465049267.899387-22348930', 07:39:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:39:02 INFO - '_': '/tools/buildbot/bin/python'} 07:39:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:39:02 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)) 07:39:02 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)) 07:39:02 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)) 07:39:02 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)) 07:39:02 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)) 07:39:02 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)) 07:39:02 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)) 07:39:02 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)) 07:39:02 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)) 07:39:02 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)) 07:39:02 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)) 07:39:02 INFO - Cleaning up... 07:39:02 INFO - Return code: 0 07:39:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:39:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:39:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:39:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:39:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:39:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39:02 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 0x7f392270ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dda7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e69640>, '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 0x1e6a540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a9d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465049267.899387-22348930', '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 07:39:02 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 07:39:02 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 07:39:02 INFO - Using env: {'DISPLAY': ':0', 07:39:02 INFO - 'HOME': '/home/cltbld', 07:39:02 INFO - 'LANG': 'en_US.UTF-8', 07:39:02 INFO - 'LANGUAGE': 'en_US:en', 07:39:02 INFO - 'LOGNAME': 'cltbld', 07:39:02 INFO - 'MAIL': '/var/mail/cltbld', 07:39:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:39:02 INFO - 'MOZ_NO_REMOTE': '1', 07:39:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:39:02 INFO - 'NO_EM_RESTART': '1', 07:39:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:39:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:39:02 INFO - 'PWD': '/builds/slave/test', 07:39:02 INFO - 'SHELL': '/bin/bash', 07:39:02 INFO - 'SHLVL': '1', 07:39:02 INFO - 'TERM': 'linux', 07:39:02 INFO - 'TMOUT': '86400', 07:39:02 INFO - 'USER': 'cltbld', 07:39:02 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465049267.899387-22348930', 07:39:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:39:02 INFO - '_': '/tools/buildbot/bin/python'} 07:39:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:39:03 INFO - Downloading/unpacking jsonschema 07:39: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 07:39: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 07:39: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 07:39: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 07:39: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 07:39: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 07:39:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:39:05 INFO - Downloading/unpacking functools32 (from jsonschema) 07:39:05 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 07:39:05 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 07:39:05 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 07:39:05 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 07:39:05 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 07:39:05 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 07:39:05 INFO - Downloading functools32-3.2.3-2.tar.gz 07:39:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:39:05 INFO - warning: no files found matching '*.txt' 07:39:05 INFO - no previously-included directories found matching 'build' 07:39:05 INFO - no previously-included directories found matching 'dist' 07:39:05 INFO - no previously-included directories found matching '.git*' 07:39:05 INFO - Installing collected packages: jsonschema, functools32 07:39:05 INFO - Running setup.py install for functools32 07:39:05 INFO - warning: no files found matching '*.txt' 07:39:05 INFO - no previously-included directories found matching 'build' 07:39:05 INFO - no previously-included directories found matching 'dist' 07:39:05 INFO - no previously-included directories found matching '.git*' 07:39:05 INFO - Successfully installed jsonschema functools32 07:39:05 INFO - Cleaning up... 07:39:05 INFO - Return code: 0 07:39:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:39:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:39:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:39:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39:05 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 0x7f392270ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dda7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e69640>, '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 0x1e6a540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a9d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465049267.899387-22348930', '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 07:39:05 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 07:39:05 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 07:39:05 INFO - Using env: {'DISPLAY': ':0', 07:39:05 INFO - 'HOME': '/home/cltbld', 07:39:05 INFO - 'LANG': 'en_US.UTF-8', 07:39:05 INFO - 'LANGUAGE': 'en_US:en', 07:39:05 INFO - 'LOGNAME': 'cltbld', 07:39:05 INFO - 'MAIL': '/var/mail/cltbld', 07:39:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:39:05 INFO - 'MOZ_NO_REMOTE': '1', 07:39:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:39:05 INFO - 'NO_EM_RESTART': '1', 07:39:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:39:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:39:05 INFO - 'PWD': '/builds/slave/test', 07:39:05 INFO - 'SHELL': '/bin/bash', 07:39:05 INFO - 'SHLVL': '1', 07:39:05 INFO - 'TERM': 'linux', 07:39:05 INFO - 'TMOUT': '86400', 07:39:05 INFO - 'USER': 'cltbld', 07:39:05 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465049267.899387-22348930', 07:39:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:39:05 INFO - '_': '/tools/buildbot/bin/python'} 07:39:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:39:05 INFO - Downloading/unpacking flake8 07:39:05 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 07:39:05 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 07:39:05 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 07:39:05 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 07:39:05 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 07:39:05 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 07:39:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:39:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:39:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:39:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:39:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:39:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:39:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:39:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:39:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:39:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:39:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:39:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:39:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:39:08 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 07:39:08 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 07:39:08 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 07:39:08 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 07:39:08 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 07:39:08 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 07:39:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:39:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:39:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:39:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:39:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:39:08 INFO - no previously-included directories found matching 'docs/_build' 07:39:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:39:08 INFO - Running setup.py install for pep8 07:39:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:39:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:39:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:39:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:39:08 INFO - no previously-included directories found matching 'docs/_build' 07:39:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:39:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:39:08 INFO - Cleaning up... 07:39:08 INFO - Return code: 0 07:39:08 INFO - Running post-action listener: _resource_record_post_action 07:39:08 INFO - Running post-action listener: _start_resource_monitoring 07:39:08 INFO - Starting resource monitoring. 07:39:08 INFO - ##### 07:39:08 INFO - ##### Running install step. 07:39:08 INFO - ##### 07:39:08 INFO - Running pre-action listener: _resource_record_pre_action 07:39:08 INFO - Running main action method: install 07:39:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:39:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:39:08 INFO - Reading from file tmpfile_stdout 07:39:08 INFO - Detecting whether we're running mozinstall >=1.0... 07:39:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:39:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:39:08 INFO - Reading from file tmpfile_stdout 07:39:08 INFO - Output received: 07:39:08 INFO - Usage: mozinstall [options] installer 07:39:08 INFO - Options: 07:39:08 INFO - -h, --help show this help message and exit 07:39:08 INFO - -d DEST, --destination=DEST 07:39:08 INFO - Directory to install application into. [default: 07:39:08 INFO - "/builds/slave/test"] 07:39:08 INFO - --app=APP Application being installed. [default: firefox] 07:39:08 INFO - mkdir: /builds/slave/test/build/application 07:39:08 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'] 07:39:08 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 07:39:24 INFO - Reading from file tmpfile_stdout 07:39:24 INFO - Output received: 07:39:24 INFO - /builds/slave/test/build/application/firefox/firefox 07:39:24 INFO - Running post-action listener: _resource_record_post_action 07:39:24 INFO - ##### 07:39:24 INFO - ##### Running run-tests step. 07:39:24 INFO - ##### 07:39:24 INFO - Running pre-action listener: _resource_record_pre_action 07:39:24 INFO - Running main action method: run_tests 07:39:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:39:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:39:24 INFO - Python 2.7.3 07:39:24 INFO - Return code: 0 07:39:24 INFO - grabbing minidump binary from tooltool 07:39:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:39:24 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 0x1e69640>, '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 0x1e6a540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a9d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:39:24 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 07:39:24 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 07:39:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:39:24 INFO - Return code: 0 07:39:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:39:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:39:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:39:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:39:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:39:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:39:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:39:25 INFO - Return code: 0 07:39:25 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/Ykk4DjLvSfycvghfshHlkg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 07:39:25 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/Ykk4DjLvSfycvghfshHlkg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 07:39:25 INFO - Using env: {'DISPLAY': ':0', 07:39:25 INFO - 'HOME': '/home/cltbld', 07:39:25 INFO - 'LANG': 'en_US.UTF-8', 07:39:25 INFO - 'LANGUAGE': 'en_US:en', 07:39:25 INFO - 'LOGNAME': 'cltbld', 07:39:25 INFO - 'MAIL': '/var/mail/cltbld', 07:39:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:39:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:39:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:39:25 INFO - 'MOZ_NO_REMOTE': '1', 07:39:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:39:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:39:25 INFO - 'NO_EM_RESTART': '1', 07:39:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:39:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:39:25 INFO - 'PWD': '/builds/slave/test', 07:39:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:39:25 INFO - 'SHELL': '/bin/bash', 07:39:25 INFO - 'SHLVL': '1', 07:39:25 INFO - 'TERM': 'linux', 07:39:25 INFO - 'TMOUT': '86400', 07:39:25 INFO - 'USER': 'cltbld', 07:39:25 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465049267.899387-22348930', 07:39:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:39:25 INFO - '_': '/tools/buildbot/bin/python'} 07:39:25 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/Ykk4DjLvSfycvghfshHlkg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 07:39:25 INFO - mozversion application_buildid: 20160604051125 07:39:25 INFO - mozversion application_changeset: 7eb468713fd5d88f0992eee5ab463432c204334f 07:39:25 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:39:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:39:25 INFO - mozversion application_name: Firefox 07:39:25 INFO - mozversion application_remotingname: firefox-dev 07:39:25 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:39:25 INFO - mozversion application_vendor: Mozilla 07:39:25 INFO - mozversion application_version: 48.0a2 07:39:25 INFO - mozversion platform_buildid: 20160604051125 07:39:25 INFO - mozversion platform_changeset: 7eb468713fd5d88f0992eee5ab463432c204334f 07:39:25 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:39:25 INFO - mozversion platform_version: 48.0a2 07:39:25 INFO - using testdate: 1465051165 07:39:25 INFO - actual date: 1465051165 07:39:25 INFO - starting webserver on 'localhost:55963' 07:39:25 INFO - SUITE-START | Running 2 tests 07:39:25 INFO - TEST-START | dromaeo_css 07:39:25 INFO - operating with platform_type : linux_ 07:39:25 INFO - Initialising browser for dromaeo_css test... 07:39:25 INFO - TEST-INFO | started process 3295 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgskzly/profile http://localhost:55963/getInfo.html) 07:39:31 INFO - PROCESS | 3295 | __metrics Screen width/height:1600/1200 07:39:31 INFO - PROCESS | 3295 | colorDepth:24 07:39:31 INFO - PROCESS | 3295 | Browser inner width/height: 1024/697 07:39:31 INFO - PROCESS | 3295 | __metrics 07:39:33 ERROR - PROCESS | 3295 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:39:34 INFO - TEST-INFO | 3295: exit 0 07:39:34 INFO - Browser initialized. 07:39:34 INFO - Running cycle 1/1 for dromaeo_css test... 07:39:34 INFO - TEST-INFO | started process 3390 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgskzly/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:39:45 INFO - PROCESS | 3390 | RSS: Main: 142454784 07:39:45 INFO - PROCESS | 3390 | 07:40:37 INFO - PROCESS | 3390 | 1465051237070 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] 07:42:45 INFO - PROCESS | 3390 | Cycle 1(1): loaded http://localhost:55963/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55963/tests/dromaeo/cssquery-ext.html) 07:42:46 INFO - PROCESS | 3390 | RSS: Main: 251838464 07:42:46 INFO - PROCESS | 3390 | 07:45:48 INFO - PROCESS | 3390 | Cycle 1(1): loaded http://localhost:55963/tests/dromaeo/cssquery-ext.html (next: http://localhost:55963/tests/dromaeo/cssquery-jquery.html) 07:45:48 INFO - PROCESS | 3390 | RSS: Main: 222633984 07:45:48 INFO - PROCESS | 3390 | 07:48:50 INFO - PROCESS | 3390 | Cycle 1(1): loaded http://localhost:55963/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55963/tests/dromaeo/cssquery-mootools.html) 07:48:51 INFO - PROCESS | 3390 | RSS: Main: 220672000 07:48:51 INFO - PROCESS | 3390 | 07:51:53 INFO - PROCESS | 3390 | Cycle 1(1): loaded http://localhost:55963/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55963/tests/dromaeo/cssquery-prototype.html) 07:51:53 INFO - PROCESS | 3390 | RSS: Main: 217522176 07:51:53 INFO - PROCESS | 3390 | 07:54:56 INFO - PROCESS | 3390 | Cycle 1(1): loaded http://localhost:55963/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55963/tests/dromaeo/cssquery-yui.html) 07:54:56 INFO - PROCESS | 3390 | RSS: Main: 212717568 07:54:56 INFO - PROCESS | 3390 | 07:57:59 INFO - PROCESS | 3390 | Cycle 1(1): loaded http://localhost:55963/tests/dromaeo/cssquery-yui.html (next: http://localhost:55963/tests/dromaeo/cssquery-dojo.html) 07:57:59 INFO - PROCESS | 3390 | RSS: Main: 252301312 07:57:59 INFO - PROCESS | 3390 | 07:57:59 INFO - PROCESS | 3390 | __start_tp_report 07:57:59 INFO - PROCESS | 3390 | _x_x_mozilla_page_load 07:57:59 INFO - PROCESS | 3390 | _x_x_mozilla_page_load_details 07:57:59 INFO - PROCESS | 3390 | |i|pagename|runs| 07:57:59 INFO - PROCESS | 3390 | |0;dojo.html;3333.9666603333967;3377.223238655109;3388.779729317595;3404.4893266010113;3414.146463384154;5594.216809646648;5595.4684304991015;5614.242077319561;5617.354004289508;5622.0161471742485;5605.075162598167;5638.718064096789;5644.915326270109;5652.123920792284;5655.943440565593;4999.625028122887;5056;5082.186850103984;5171.0692075426405;5224.869378265555;5136.075506408845;5151.098557752397;5151.536361727443;5155.9484405155845;5156.458571849958;5116.360454943132;5118.923216151761;5152.407473140581;5193.039287731763;5195.740212989335;5170.482951704837;5189.844304670866;5191.351081114861;5199.012187684328;5224;5092.898142037138;5101.744912754348;5106.744662766884;5123.436421993578;5196.142636464979;5492.615516913817;5495.313085864267;5552.11166213408;5555.472230138171;5555.611107222496;6092.055731361646;6121.265448146207;6125.387461253884;6130.570860039799;6131.202943617346;6058.0610005449225;6097.3597772233725;6102.816915492543;6122.785702500391;6145.078238264251;5591.189277554772;5630.5495560355075;5648.858778530528;5655.830325090254;5656.971715141439;6078.088286757022;6192.318844927055;6201.906971395432;6202.162708034448;6204.3795620437595;5905.734241959122;5971.313298970674;5987.101934709828;6007.669578173155;6008.519318454513;5994.880102397928;6001.669908155006;6006.579539432198;6010.278766548042;6034;5947.37552556984;5976.193213916153;5989.490893274034;5992.850178745566;6007.699615019232;6067.150598916155;6092.5430592705725;6104.084387341934;6106.316485067061;6126.6017708848785;4514.029483660963;4524.977375113103;4536.478304994902;4554.908901821945;4570.428696412949;3992.181602771425;4007.7996100194873;4057.391391291271;4086;4105.44576482177;5744.913826292609;5748.798792042258;5759.971200144057;5782.190493330937;5798.739056742456;6020.397960203944;6043.758249669964;6044.727987240584;6046.818595442144;6055.182550355734;5605.943940560624;5693.800716974886;5764.221830052889;5764.510016648548;5781.53747700183;4986.052649996489;4987.600991920638;4992.176290912032;4992.5756310714;5009.173486374781;6107.9083813741945;6120.602160859619;6120.816375508742;6151.200343955346;6221.5333849961435;6012.669303188367;6033.487153591818;6049.122877182695;6082.695865206811;6132.816015519542;6204.410580994799;6249.093881387264;6281.937180628135;6287.937120628735;6288.465480434214;5985.610935289193;5987.670678112746;5998.0103282957825;6004.246833523208;6019.187409699634;5886.646801191942;6049.51603871698;6122.571420000557;6129.632222066691;6141.754329826936;5947.494462970696;5950.137230101524;5956.5532585055425;5961.403859614177;5968.970155149196;5736.942630573808;5904.557158213065;5913.113033045078;5950.077737950624;5966.612170208922;5779.36426993022;5811.27359080115;5812.505936995233;5836.9416305838095;5842.357340692605;5926.822195334147;5970.731317090828;5981.222441082806;5985.700714964321;5988.251468566429;5728.369879313189;5854.560907931837;5860.443257890493;5867.9413205867395;5895.41045895407 07:57:59 INFO - PROCESS | 3390 | |1;ext.html;669.7977131049765;678.3047376439149;684.1584850633717;737.2921994884911;757.7310054930502;31706.36587268256;39104.80447597762;39621;39718.80140599296;39763;41895.162096758126;42595;42597.7870110649;42613.57386426135;42614.57385426145;7808.336291415237;8658.740237792861;8824.8676269856;10255.077043066123;10417.218708596847;10016.399016059024;10150.0864922157;10152.746181345488;10156.39061656303;10161.390316580992;10170;10220.335678180933;10221.48892555373;10223.335483193607;10227.488625568729;7910.841783164333;10353.689389318295;10497.4226417547;10505.52725127371;10506.947465262701;10418.843717344245;10543.789124217472;10544.051035406774;10544.630937917136;10552.366857988545;40285.194296114205;40862.79568602168;40868.59131408678;40873;40888.1822363554;3676.7977761223124;3700.5929347771726;3830.885073447801;3907.5115610548683;4188;31654;31916.361672766416;31970;32352;32925.01224963255;4429.712068715556;4513.684042117053;4545.318202269653;4564.885877853047;4584.263824982629;315360;317151;318299;318437;318453;40318.39522407166;68372.658136709;68372.658136709;68984;69092;38244.61755382466;38662.613373866465;38716.806415968305;38726.61273387286;38753.41869871954;16041.358345666044;16631.6673666526;16780.83219167817;16807.075610841275;16821.747673784903;14385.352659130363;14734.778978315333;14743.336549855283;14750.114993100447;14913.627159321104;9275;9372;9386.249100071978;9406.05939406054;9439.103285187895;3593.2454184621;3696.8890933272046;3735.869244576427;3738.6074462181623;3757.7181711371754;1056.3081181825762;1121.0269924932015;1148.758760660254;1162.9941850290695;1165.9650210493528;32275.35449291001;32603;32719.672803271664;33532.664673352956;33598.66401335955;1148.26511032939;1162.9011534019535;1181.704573856536;1185.624675376559;1200.1478949945636;16280.592985175228;16306.347746090023;16382.426615068416;16436;16702.331906723593;346581;349673;350664;350667;350725;57317.14024289639;57903.97336093216;57947.420525795045;57974.7101264491;58071;1330.8269924909894;1471.4040813470563;1484.6511069898565;1529.8699610533006;1621.8459246371576;29318.853405732836;30337.696623033487;30585.847070764503;31350.481511651877;32339.191520211243;50887;51912.221316679526;51919;51924.480755191966;51990.22014669707;379449;380938;381055;381155;381298.65454708954;26869.328266793487;30185.849070755383;30570.694293056786;30889.536656949713;31039.689603104584;41667.37498937458;42339.788301058295;43175;43407.13185736331;43930.56069439265;39121.6087839118;39129.02177445587;39690.40464392979;40120.1975960485;40615;37817;38557;38768.418473722355;38959;39519.407208891316;40095;40154.39768403535;44708;45515.089698205185;45612;34591.616335346305;36606.450903237004;36774.44838327481;37483.250334993696;37715;28299.15102546927;28390.43219135647;28566.85716571404;28587.857060714563;29096.418071638873 07:57:59 INFO - PROCESS | 3390 | |2;jquery.html;424.3164466417201;429.41385009462095;434.31595237500943;439.9894957462727;443.45233636458966;18453;18565.350212742538;19064.42806715801;19152.521186970316;20025.499362515908;18255.178516966735;18550.628987420278;20286.492837679067;20366.592668146666;20383;5606.887862242753;5680.943190568083;5833.679147646878;5862.9413705863035;5864.970675146618;5820.650760954335;5830.300363956331;5877.118432235156;5884.352721200665;5884.735186916599;5873.353931067579;5962.224910761616;6531.836704082389;6574.375434333754;6578.506612004095;6497.927841906104;6500.05749166373;6517.51118666102;6518.804435866931;6556.967215163918;5723.54211663066;5782.392848750863;5864.618799778001;5915.231019967377;5915.881682366328;14147.080439771382;14298.924175234184;14377.424903003868;23153.652695209585;23805.166819161248;2494.6756921600077;2587.1591732686766;2792.5950737143003;2847.7152284771564;2943.7792165587666;10434.113100386476;10439.47802609874;10490.527926243261;10757.623483178051;10871.728206794893;1993.9900300498405;2020.2928974858828;2049.928252511155;2055.6094342074957;2072.668373060303;61160.08259876105;72583.63708181478;74905;77738.83391749185;79160.60419697923;11146.99677029055;11260.887391126147;11427.771444571063;11489.310641361379;11560.132990025782;16054.678906421806;16143.112128833027;16316.836831631768;16332;16346.100964447069;8897.332700047522;8947.19475247231;9015.77460563478;9035;9148;8798.516081615444;8810.691625793066;8876.911230887737;8877.467351958903;9045.457272563668;4992.600591952635;5001.399832020181;5013.799448022039;5029.974850125726;5040.445550989388;2009.8142096163333;2038.104562756621;2042.816146546818;2078.2726045884124;2084.739407574053;976.1409959235828;1059.3961441978154;1063.5958335832333;1123.4270522033821;1142.9427779304276;18966.620667586572;19129.13918873654;19212.231510739413;19474.415767526996;19725.210991560463;1025.3079171559316;1059.502034043998;1069.9732506687394;1072.8498010278568;1104.779044191165;10447.216458765623;10818.513166907507;10867.076298514557;10931.890681093088;11078.002979731862;455253;468736;470330;475882;478215;65131;79482;82013.58993204996;92090;94708;1061.532925512772;1074.0709286467306;1112.8330750387506;1122.180808010157;1141.5662048421714;17088.060156691503;17090.145492725067;17263.654726905643;17436;17470.21384037696;38331.616683832806;39136.2172756549;39434.21131577295;40027.19877605573;40883.59116408798;54654.453455464936;57161.71419142878;57375.13937291027;57470;57554.42445575491;8745.169208925143;8781.385303028726;8982.550872456482;8997.01032886369;12447.751044978868;13617.795733063815;13697.109687870257;13808.926792767179;13838.515651952133;14390.208538530482;11233.887661123612;12332.753344933231;12554.372281386077;12568.434420450918;12622.747545049231;11716;11912.702182445508;12387.814182787446;12393.194442361219;12395.256284622952;12141.69645758863;12200.328981906081;12418.689532761753;12441.191322564004;12523.4364453598;13040.869591303965;13412.463501459832;13425.127366721132;13483.528076517276;13651.590452286448;11661.300321980709;11915.2255103418;11927.642170734893;12094.516219351479;12188.939055304667 07:57:59 INFO - PROCESS | 3390 | |3;mootools.html;1395.4209003263645;1566.4674010836318;1577.321751646792;1736.7308067249573;1847.316492897628;7822.569758663271;8128.512289262649;8292.087870334259;8296.668133274678;8312.210340017704;8445.113263107378;8605.827883442327;8606.61270242839;8611.966564012328;8622.267107295887;2122.066290832029;2406.6630671705975;2415.9637605435887;2445.902163913441;2458.864762438065;2438.0979037756056;2445.1686426614947;2452.4849781545895;2455.2020593307248;2457.7173625033083;2347.2606129069372;2370.6562548430466;2393.234165067179;2397.4845408237225;2398.2085911649115;2002.779694233633;2047.8873661948587;2050.8256798172097;2355.481794005333;2385.3082606044227;2361.9409514762096;2403.254990952793;2406.7111946566347;2408.903643854244;2410.638404239378;8517.574121293972;8601.31189504838;8603.225709686158;8604.31165506758;8613.870791938127;5201.583873290166;5301.310829592167;5333.653312534673;5337.866553336159;5338.119210330329;3442.6385229550788;3490.703290220334;3526.770759900598;3642.453631955201;3706.499622550975;1155.3876445483907;1165.7435364219857;1229.4528934624095;1246.5200897654377;1247.189326937498;12447.190932589443;12450.501979920882;12460.190087644365;12467.688307792196;12485.875141248562;4667;4682.297655351656;4754.881127971759;4759.4764575896625;4773.069251495925;10557.736056598647;10633.5214915329;10651.520681569347;10682.359058456517;10687.946560267148;5500;5519.172124181405;5526.392096869341;5526.613137080446;5528.474794894479;4402.713823601455;4851.854444366674;4958.925616115761;4964.131277026506;4969.428515720666;4232.936505952413;4243.151369726067;4277.144571085795;4310.676699247569;4335.436393268855;1361.918284902909;1391.6590435343203;1393.2337214531967;1399.0626280392162;1401.88084012858;847.4068152293419;911.8814554108056;920.5903372998952;939.0984654731398;966.9758256043515;5671.801486947937;5691;5717.371089180187;5728.455796699391;5827.125931110282;971.2084651009546;1030.7886883188928;1036.2953191829477;1045.6549338718205;1082.24783775277;3880.1851611161974;3883.320418926733;3913.471681323042;3923.9215215695526;3977.125032492847;10822.080123189617;11066.612668556561;11119.499622517005;11167.05080068187;11171;11081.5567377304;11110.333379997226;11160.107191424666;11183.496742646601;11197.832032519518;8279.917200828035;8492.363072769567;8599.26906212979;8621.568921554022;8667.219950204511;5800.6809625471005;5808.332041815245;5813.6221145625395;5873.119032145041;6074.997625391761;9855.556499957662;9917.702468925943;10106.191504679755;10108.39349639024;10145.34055286404;9685.176759975198;10050.99490050989;10117.949410252902;10226.28416010872;10240.846387304047;6877.277885821916;7263.055802745609;7440.3675687567165;7648.655810488653;7808.180141085104;8526.78683032929;8552.957235213784;8574.699885503978;8590.82818343642;8613.48319100856;7083.964580177066;7155.785326440215;7207.603581802841;7268.672909719181;7312.012878261579;6909.378155965987;7020.297970202939;7060.752873649603;7149.964250178716;7238.420926325776;6635.701393437404;6670.533062685566;6685.598864068172;6688.2977287386075;6691.498137639794;4892.363992680928;4893.339399181065;4930.531599498042;4938.975305123595;5062.164742817541;4795.712257264575;4812.687175333592;4848;4928.8767780805765;4964.503549645006 07:57:59 INFO - PROCESS | 3390 | |4;prototype.html;357.20165430263376;357.7889045463176;362.21038136861637;365.45182226659995;366.93211755825166;6204.25548934128;6223;6286.371362863722;6291.087792270118;6337.588056776306;5973.163757074002;6188.47397971173;6194.907076393846;6206.720697568609;6214.03682429223;4761.547652972962;4843.4187897452175;4849.975750121244;4865.732384718839;4869.586085182764;4820.963492849037;4848.466668666444;4849.393825771778;4858.927116093261;4860.659753817235;4625.907481850378;4693.812247510113;4805.774527495484;4816.157172494817;4819.156647586676;4787.329773831666;4787.353707249529;4793.7363445010515;4799.472058073609;4808.966072294438;4227.556106608823;4237.576242375738;4240.088380998101;4244.0663054128045;4257.127288905767;6039.637621742666;6046.909296360558;6047.818565443044;6049.909251361233;6051.062085376773;5595.160725891149;5595.468430499096;5598.384177740445;5602.075657516505;5607.130894711327;6376.840578985516;6554.836129096763;6589.538732288742;6599.967000164968;6604.339566043357;4673.11210869937;4682.1338052460405;4686.812527498896;4692.835750748742;4704.647151463654;6894.310568943066;6899.517033807636;6900.137482814648;6903.068085808452;6905.965470172617;4764.928526072112;4787.928181077286;4789.233722604366;4794.496577859344;4797.064572408347;4849.345338379274;4852.95147048525;4853.611711063107;4857.1742803723455;4857.805687772449;5440.537554307849;5550.056490396642;5555.2222688823595;5557.666540007613;5566.526845218121;6654.866902662016;6662.935049877014;6670.199576050808;6677.332266773381;6679.064930909676;1694.593297608565;1726.1973182470213;1727.1709579401706;1728.3777839977597;1731.826817318258;1085.2023762534532;1126.830975353687;1132.6432173865371;1159.9826002609968;1172.6013155527162;6369.777057802955;6432.549721519542;6439.774607888701;6444.323346048597;6454.1609590752905;6827.761028363983;6832.624205668637;6835.350641689031;6839.863202736017;6846.486513511407;6426.485881129498;6432.71052802625;6433.195850518685;6434.485241180694;6444.162258906312;3615.2769446110883;3648.5986541480415;3695.334839728821;3700.7039436845525;3701.574318953355;7038.964805175941;7052;7060.470464715167;7066.081409416743;7070.257622949619;6843.213030501456;6857.142857142857;6893.345132212432;6902.275261097613;6913.032175495435;6970.198427180838;7029.9648501757165;7052.823679407953;7053.8236544085785;7054.294570542905;6659.966700166468;6737.427318677967;6742.25835158142;6797.150356205474;6821.965890170517;6706.865862682816;6711.295313991961;6714.194296684429;6719.092922455406;6719.932800672126;6996.860062798817;7018.649067546704;7019.964900175671;7022.262662420372;7034.366906978396;4812.085703716282;4816;4816.54242846929;4819.1566475867285;4822.373091498082;6711.295313992156;6764.830879228059;6771.492138089761;6784.084148640068;6785.5250132490255;6466.773662921775;6559.573627714183;6672.933270667231;6724.596524208563;6724.93275067243;6656.600603963778;6667.866642667216;6683.899741503784;6687.063811066552;6691.899621505584;6571.178602674666;6587.077809106825;6597.27429982692;6648.235452922782;6666.833329166616;6746;6752.527323087336;6752.662366881735;6753.088333074972;6773;6452.774152904626;6575.868482630416;6578.111954886029;6580.967095164494;6612.867742645217 07:57:59 INFO - PROCESS | 3390 | |5;yui.html;800.8878756974025;865.4201684871132;900.1403659505175;934.439336398161;955.2739917662574;14956.626084347898;15079.924600376997;15109.168995705246;15159.848401515981;15205.011674241166;14874.181919994397;14884.702305953902;14936.701265974702;15042.172680502568;15099.92450037751;748.4424104042496;897.1745993685809;902.5848109869435;911.4303560274828;919.7608621758324;902.8781114549517;909.9272058235325;913.3834661603424;914.2274777812737;914.7027216154743;945.3524335829944;948.5778828421321;951.3958636265986;951.5480146930188;952.6046690623383;775.0931410249993;782.8434313137367;913.4975763330142;929.6746138851415;948.3266880514808;686.0532465198045;686.4817063117364;686.5606012152226;686.8866637004888;687.4534744877784;14374.35315410809;14421.27893605326;14439.494617688331;14441.277936103153;14451.638709032253;14290.071145375518;14654.168228971379;14685.265736713121;14730.926345368312;14971.401143954228;11404.144689148265;11866.169368144234;12311.75376492474;12465.065120116027;12492.437840297118;4628.861134165981;4690.390249267608;4709.858704238878;4739.549742774431;4749.311349854286;50367.24449133229;50411.49588504105;50748.23877641838;50770;50984.49015509872;11014.44927753625;11056.557737690402;11292.491837867316;11349.886501135048;12122.818157727641;20534.897325513277;20584.073716682786;20658.380248592566;20673.89663051705;20688.379348619565;8866.069062748318;8912.821743565093;8971.730848074569;8997.100289970951;9228.354015219005;5077.1876499759865;5088.821891233789;5108.770105345268;5168.61235407346;5336.4129945705945;3540.7875527468436;3573.428251479803;3593.9820300898327;3594.406922857699;3602.5316708827686;629.6568370238231;636.3763511758502;678.9694463749144;691.5435812363917;700.7757517594423;627.9183706118267;748.5882764479514;786.7403756760256;831.6964308027526;835.8119423129747;8982.32632552548;9126.49804260772;9281.58232879522;9351.719448416557;9384.671536496326;665.6838001949036;715;799.4084377560563;803.0884945586685;808.7614153824636;4729.0541891621815;4754.548317909793;4764.356811830358;4856.902861942812;4886.706797592155;53635.731821341426;60928.695356522934;61571;61897;61917;53840.999999999214;54486.45513544893;54640.453595463536;55146;55326.72336638291;48863.755681221366;48935.755321223165;49252.50747492551;50299;50332;9260.583273752563;9340.53297335117;9421.057894210524;9455.527223638928;9456.243500520079;35828.462573060904;36001.09997249985;36776.44835327526;37933.81033094817;38110.23779524338;41110.177796443306;44054.33918491161;45048.324275136554;45504;46392.76803615961;11842.111841612086;11965.521379144737;11986.880131198577;12037.157398982337;12327.75344493123;12703.872961270268;12709.428075736429;12711.74576508446;12947.093703440669;13133.277669728257;11493.482793274155;11877.881221188023;12094;12166.635000949986;12603;12071.637850864488;12472.68818279514;12539.435725392561;12814.743705125658;12984.740305194033;12333.814992774936;12387.814182787086;12390.876091238972;12637.17858339205;12922.935385323013;10323.277370583986;10437.895621043996;10545.52545135486;10547.472626368804;10869.78260434771;10244.282900196915;10316.27786054999;10566.630167944086;10581.15350771921;10585.788284234426 07:57:59 INFO - PROCESS | 3390 | __end_tp_report 07:57:59 INFO - PROCESS | 3390 | __start_cc_report 07:57:59 INFO - PROCESS | 3390 | _x_x_mozilla_cycle_collect,827 07:57:59 INFO - PROCESS | 3390 | __end_cc_report 07:57:59 INFO - PROCESS | 3390 | __startTimestamp1465052279412__endTimestamp 07:57:59 INFO - PROCESS | 3390 | 07:57:59 INFO - PROCESS | 3390 | ------- Summary: start ------- 07:57:59 INFO - PROCESS | 3390 | Number of tests: 6 07:57:59 INFO - PROCESS | 3390 | 07:57:59 INFO - PROCESS | 3390 | [#0] dojo.html Cycles:165 Average:5609.90 Median:5854.56 stddev:641.00 (10.9%) stddev-sans-first:617.60 07:57:59 INFO - PROCESS | 3390 | Values: 3334.0 3377.2 3388.8 3404.5 3414.1 5594.2 5595.5 5614.2 5617.4 5622.0 5605.1 5638.7 5644.9 5652.1 5655.9 4999.6 5056.0 5082.2 5171.1 5224.9 5136.1 5151.1 5151.5 5155.9 5156.5 5116.4 5118.9 5152.4 5193.0 5195.7 5170.5 5189.8 5191.4 5199.0 5224.0 5092.9 5101.7 5106.7 5123.4 5196.1 5492.6 5495.3 5552.1 5555.5 5555.6 6092.1 6121.3 6125.4 6130.6 6131.2 6058.1 6097.4 6102.8 6122.8 6145.1 5591.2 5630.5 5648.9 5655.8 5657.0 6078.1 6192.3 6201.9 6202.2 6204.4 5905.7 5971.3 5987.1 6007.7 6008.5 5994.9 6001.7 6006.6 6010.3 6034.0 5947.4 5976.2 5989.5 5992.9 6007.7 6067.2 6092.5 6104.1 6106.3 6126.6 4514.0 4525.0 4536.5 4554.9 4570.4 3992.2 4007.8 4057.4 4086.0 4105.4 5744.9 5748.8 5760.0 5782.2 5798.7 6020.4 6043.8 6044.7 6046.8 6055.2 5605.9 5693.8 5764.2 5764.5 5781.5 4986.1 4987.6 4992.2 4992.6 5009.2 6107.9 6120.6 6120.8 6151.2 6221.5 6012.7 6033.5 6049.1 6082.7 6132.8 6204.4 6249.1 6281.9 6287.9 6288.5 5985.6 5987.7 5998.0 6004.2 6019.2 5886.6 6049.5 6122.6 6129.6 6141.8 5947.5 5950.1 5956.6 5961.4 5969.0 5736.9 5904.6 5913.1 5950.1 5966.6 5779.4 5811.3 5812.5 5836.9 5842.4 5926.8 5970.7 5981.2 5985.7 5988.3 5728.4 5854.6 5860.4 5867.9 5895.4 07:57:59 INFO - PROCESS | 3390 | 07:57:59 INFO - PROCESS | 3390 | [#1] ext.html Cycles:180 Average:51659.18 Median:20225.62 stddev:91980.27 (454.8%) stddev-sans-first:92158.63 07:57:59 INFO - PROCESS | 3390 | Values: 669.8 678.3 684.2 737.3 757.7 31706.4 39104.8 39621.0 39718.8 39763.0 41895.2 42595.0 42597.8 42613.6 42614.6 7808.3 8658.7 8824.9 10255.1 10417.2 10016.4 10150.1 10152.7 10156.4 10161.4 10170.0 10220.3 10221.5 10223.3 10227.5 7910.8 10353.7 10497.4 10505.5 10506.9 10418.8 10543.8 10544.1 10544.6 10552.4 40285.2 40862.8 40868.6 40873.0 40888.2 3676.8 3700.6 3830.9 3907.5 4188.0 31654.0 31916.4 31970.0 32352.0 32925.0 4429.7 4513.7 4545.3 4564.9 4584.3 315360.0 317151.0 318299.0 318437.0 318453.0 40318.4 68372.7 68372.7 68984.0 69092.0 38244.6 38662.6 38716.8 38726.6 38753.4 16041.4 16631.7 16780.8 16807.1 16821.7 14385.4 14734.8 14743.3 14750.1 14913.6 9275.0 9372.0 9386.2 9406.1 9439.1 3593.2 3696.9 3735.9 3738.6 3757.7 1056.3 1121.0 1148.8 1163.0 1166.0 32275.4 32603.0 32719.7 33532.7 33598.7 1148.3 1162.9 1181.7 1185.6 1200.1 16280.6 16306.3 16382.4 16436.0 16702.3 346581.0 349673.0 350664.0 350667.0 350725.0 57317.1 57904.0 57947.4 57974.7 58071.0 1330.8 1471.4 1484.7 1529.9 1621.8 29318.9 30337.7 30585.8 31350.5 32339.2 50887.0 51912.2 51919.0 51924.5 51990.2 379449.0 380938.0 381055.0 381155.0 381298.7 26869.3 30185.8 30570.7 30889.5 31039.7 41667.4 42339.8 43175.0 43407.1 43930.6 39121.6 39129.0 39690.4 40120.2 40615.0 37817.0 38557.0 38768.4 38959.0 39519.4 40095.0 40154.4 44708.0 45515.1 45612.0 34591.6 36606.5 36774.4 37483.3 37715.0 28299.2 28390.4 28566.9 28587.9 29096.4 07:57:59 INFO - PROCESS | 3390 | 07:57:59 INFO - PROCESS | 3390 | [#2] jquery.html Cycles:180 Average:28148.92 Median:11210.55 stddev:77153.54 (688.2%) stddev-sans-first:77341.89 07:57:59 INFO - PROCESS | 3390 | Values: 424.3 429.4 434.3 440.0 443.5 18453.0 18565.4 19064.4 19152.5 20025.5 18255.2 18550.6 20286.5 20366.6 20383.0 5606.9 5680.9 5833.7 5862.9 5865.0 5820.7 5830.3 5877.1 5884.4 5884.7 5873.4 5962.2 6531.8 6574.4 6578.5 6497.9 6500.1 6517.5 6518.8 6557.0 5723.5 5782.4 5864.6 5915.2 5915.9 14147.1 14298.9 14377.4 23153.7 23805.2 2494.7 2587.2 2792.6 2847.7 2943.8 10434.1 10439.5 10490.5 10757.6 10871.7 1994.0 2020.3 2049.9 2055.6 2072.7 61160.1 72583.6 74905.0 77738.8 79160.6 11147.0 11260.9 11427.8 11489.3 11560.1 16054.7 16143.1 16316.8 16332.0 16346.1 8897.3 8947.2 9015.8 9035.0 9148.0 8798.5 8810.7 8876.9 8877.5 9045.5 4992.6 5001.4 5013.8 5030.0 5040.4 2009.8 2038.1 2042.8 2078.3 2084.7 976.1 1059.4 1063.6 1123.4 1142.9 18966.6 19129.1 19212.2 19474.4 19725.2 1025.3 1059.5 1070.0 1072.8 1104.8 10447.2 10818.5 10867.1 10931.9 11078.0 455253.0 468736.0 470330.0 475882.0 478215.0 65131.0 79482.0 82013.6 92090.0 94708.0 1061.5 1074.1 1112.8 1122.2 1141.6 17088.1 17090.1 17263.7 17436.0 17470.2 38331.6 39136.2 39434.2 40027.2 40883.6 54654.5 57161.7 57375.1 57470.0 57554.4 8745.2 8781.4 8982.6 8997.0 12447.8 13617.8 13697.1 13808.9 13838.5 14390.2 11233.9 12332.8 12554.4 12568.4 12622.7 11716.0 11912.7 12387.8 12393.2 12395.3 12141.7 12200.3 12418.7 12441.2 12523.4 13040.9 13412.5 13425.1 13483.5 13651.6 11661.3 11915.2 11927.6 12094.5 12188.9 07:57:59 INFO - PROCESS | 3390 | 07:57:59 INFO - PROCESS | 3390 | [#3] mootools.html Cycles:180 Average:5769.67 Median:4766.27 stddev:3269.54 (68.6%) stddev-sans-first:3262.18 07:57:59 INFO - PROCESS | 3390 | Values: 1395.4 1566.5 1577.3 1736.7 1847.3 7822.6 8128.5 8292.1 8296.7 8312.2 8445.1 8605.8 8606.6 8612.0 8622.3 2122.1 2406.7 2416.0 2445.9 2458.9 2438.1 2445.2 2452.5 2455.2 2457.7 2347.3 2370.7 2393.2 2397.5 2398.2 2002.8 2047.9 2050.8 2355.5 2385.3 2361.9 2403.3 2406.7 2408.9 2410.6 8517.6 8601.3 8603.2 8604.3 8613.9 5201.6 5301.3 5333.7 5337.9 5338.1 3442.6 3490.7 3526.8 3642.5 3706.5 1155.4 1165.7 1229.5 1246.5 1247.2 12447.2 12450.5 12460.2 12467.7 12485.9 4667.0 4682.3 4754.9 4759.5 4773.1 10557.7 10633.5 10651.5 10682.4 10687.9 5500.0 5519.2 5526.4 5526.6 5528.5 4402.7 4851.9 4958.9 4964.1 4969.4 4232.9 4243.2 4277.1 4310.7 4335.4 1361.9 1391.7 1393.2 1399.1 1401.9 847.4 911.9 920.6 939.1 967.0 5671.8 5691.0 5717.4 5728.5 5827.1 971.2 1030.8 1036.3 1045.7 1082.2 3880.2 3883.3 3913.5 3923.9 3977.1 10822.1 11066.6 11119.5 11167.1 11171.0 11081.6 11110.3 11160.1 11183.5 11197.8 8279.9 8492.4 8599.3 8621.6 8667.2 5800.7 5808.3 5813.6 5873.1 6075.0 9855.6 9917.7 10106.2 10108.4 10145.3 9685.2 10051.0 10117.9 10226.3 10240.8 6877.3 7263.1 7440.4 7648.7 7808.2 8526.8 8553.0 8574.7 8590.8 8613.5 7084.0 7155.8 7207.6 7268.7 7312.0 6909.4 7020.3 7060.8 7150.0 7238.4 6635.7 6670.5 6685.6 6688.3 6691.5 4892.4 4893.3 4930.5 4939.0 5062.2 4795.7 4812.7 4848.0 4928.9 4964.5 07:57:59 INFO - PROCESS | 3390 | 07:57:59 INFO - PROCESS | 3390 | [#4] prototype.html Cycles:180 Average:5566.28 Median:6373.31 stddev:1654.66 (26.0%) stddev-sans-first:1612.45 07:57:59 INFO - PROCESS | 3390 | Values: 357.2 357.8 362.2 365.5 366.9 6204.3 6223.0 6286.4 6291.1 6337.6 5973.2 6188.5 6194.9 6206.7 6214.0 4761.5 4843.4 4850.0 4865.7 4869.6 4821.0 4848.5 4849.4 4858.9 4860.7 4625.9 4693.8 4805.8 4816.2 4819.2 4787.3 4787.4 4793.7 4799.5 4809.0 4227.6 4237.6 4240.1 4244.1 4257.1 6039.6 6046.9 6047.8 6049.9 6051.1 5595.2 5595.5 5598.4 5602.1 5607.1 6376.8 6554.8 6589.5 6600.0 6604.3 4673.1 4682.1 4686.8 4692.8 4704.6 6894.3 6899.5 6900.1 6903.1 6906.0 4764.9 4787.9 4789.2 4794.5 4797.1 4849.3 4853.0 4853.6 4857.2 4857.8 5440.5 5550.1 5555.2 5557.7 5566.5 6654.9 6662.9 6670.2 6677.3 6679.1 1694.6 1726.2 1727.2 1728.4 1731.8 1085.2 1126.8 1132.6 1160.0 1172.6 6369.8 6432.5 6439.8 6444.3 6454.2 6827.8 6832.6 6835.4 6839.9 6846.5 6426.5 6432.7 6433.2 6434.5 6444.2 3615.3 3648.6 3695.3 3700.7 3701.6 7039.0 7052.0 7060.5 7066.1 7070.3 6843.2 6857.1 6893.3 6902.3 6913.0 6970.2 7030.0 7052.8 7053.8 7054.3 6660.0 6737.4 6742.3 6797.2 6822.0 6706.9 6711.3 6714.2 6719.1 6719.9 6996.9 7018.6 7020.0 7022.3 7034.4 4812.1 4816.0 4816.5 4819.2 4822.4 6711.3 6764.8 6771.5 6784.1 6785.5 6466.8 6559.6 6672.9 6724.6 6724.9 6656.6 6667.9 6683.9 6687.1 6691.9 6571.2 6587.1 6597.3 6648.2 6666.8 6746.0 6752.5 6752.7 6753.1 6773.0 6452.8 6575.9 6578.1 6581.0 6612.9 07:57:59 INFO - PROCESS | 3390 | 07:57:59 INFO - PROCESS | 3390 | [#5] yui.html Cycles:180 Average:14881.81 Median:4751.93 stddev:16631.02 (350.0%) stddev-sans-first:16644.05 07:57:59 INFO - PROCESS | 3390 | Values: 800.9 865.4 900.1 934.4 955.3 14956.6 15079.9 15109.2 15159.8 15205.0 14874.2 14884.7 14936.7 15042.2 15099.9 748.4 897.2 902.6 911.4 919.8 902.9 909.9 913.4 914.2 914.7 945.4 948.6 951.4 951.5 952.6 775.1 782.8 913.5 929.7 948.3 686.1 686.5 686.6 686.9 687.5 14374.4 14421.3 14439.5 14441.3 14451.6 14290.1 14654.2 14685.3 14730.9 14971.4 11404.1 11866.2 12311.8 12465.1 12492.4 4628.9 4690.4 4709.9 4739.5 4749.3 50367.2 50411.5 50748.2 50770.0 50984.5 11014.4 11056.6 11292.5 11349.9 12122.8 20534.9 20584.1 20658.4 20673.9 20688.4 8866.1 8912.8 8971.7 8997.1 9228.4 5077.2 5088.8 5108.8 5168.6 5336.4 3540.8 3573.4 3594.0 3594.4 3602.5 629.7 636.4 679.0 691.5 700.8 627.9 748.6 786.7 831.7 835.8 8982.3 9126.5 9281.6 9351.7 9384.7 665.7 715.0 799.4 803.1 808.8 4729.1 4754.5 4764.4 4856.9 4886.7 53635.7 60928.7 61571.0 61897.0 61917.0 53841.0 54486.5 54640.5 55146.0 55326.7 48863.8 48935.8 49252.5 50299.0 50332.0 9260.6 9340.5 9421.1 9455.5 9456.2 35828.5 36001.1 36776.4 37933.8 38110.2 41110.2 44054.3 45048.3 45504.0 46392.8 11842.1 11965.5 11986.9 12037.2 12327.8 12703.9 12709.4 12711.7 12947.1 13133.3 11493.5 11877.9 12094.0 12166.6 12603.0 12071.6 12472.7 12539.4 12814.7 12984.7 12333.8 12387.8 12390.9 12637.2 12922.9 10323.3 10437.9 10545.5 10547.5 10869.8 10244.3 10316.3 10566.6 10581.2 10585.8 07:57:59 INFO - PROCESS | 3390 | -------- Summary: end -------- 07:57:59 INFO - PROCESS | 3390 | 07:58:00 INFO - TEST-INFO | 3390: exit 0 07:58:00 INFO - TEST-OK | dromaeo_css | took 1114228ms 07:58:00 INFO - TEST-START | kraken 07:58:00 INFO - operating with platform_type : linux_ 07:58:00 INFO - Initialising browser for kraken test... 07:58:00 INFO - TEST-INFO | started process 3585 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUSKYGD/profile http://localhost:55963/getInfo.html) 07:58:04 INFO - PROCESS | 3585 | __metrics Screen width/height:1600/1200 07:58:04 INFO - PROCESS | 3585 | colorDepth:24 07:58:04 INFO - PROCESS | 3585 | Browser inner width/height: 1024/697 07:58:04 INFO - PROCESS | 3585 | __metrics 07:58:05 ERROR - PROCESS | 3585 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:58:06 INFO - TEST-INFO | 3585: exit 0 07:58:06 INFO - Browser initialized. 07:58:06 INFO - Running cycle 1/1 for kraken test... 07:58:06 INFO - TEST-INFO | started process 3680 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUSKYGD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:58:17 INFO - PROCESS | 3680 | RSS: Main: 142405632 07:58:17 INFO - PROCESS | 3680 | 07:58:20 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:55963/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55963/tests/kraken/driver.html?testName=audio-beat-detection) 07:58:21 INFO - PROCESS | 3680 | RSS: Main: 197349376 07:58:21 INFO - PROCESS | 3680 | 07:58:23 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:55963/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55963/tests/kraken/driver.html?testName=audio-dft) 07:58:24 INFO - PROCESS | 3680 | RSS: Main: 181665792 07:58:24 INFO - PROCESS | 3680 | 07:58:27 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:55963/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55963/tests/kraken/driver.html?testName=audio-fft) 07:58:27 INFO - PROCESS | 3680 | RSS: Main: 272576512 07:58:27 INFO - PROCESS | 3680 | 07:58:30 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:55963/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55963/tests/kraken/driver.html?testName=audio-oscillator) 07:58:30 INFO - PROCESS | 3680 | RSS: Main: 178839552 07:58:30 INFO - PROCESS | 3680 | 07:58:32 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:55963/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55963/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:58:33 INFO - PROCESS | 3680 | RSS: Main: 177156096 07:58:33 INFO - PROCESS | 3680 | 07:58:36 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:55963/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55963/tests/kraken/driver.html?testName=imaging-darkroom) 07:58:37 INFO - PROCESS | 3680 | RSS: Main: 211558400 07:58:37 INFO - PROCESS | 3680 | 07:58:40 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:55963/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55963/tests/kraken/driver.html?testName=imaging-desaturate) 07:58:40 INFO - PROCESS | 3680 | RSS: Main: 211968000 07:58:40 INFO - PROCESS | 3680 | 07:58:43 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:55963/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55963/tests/kraken/driver.html?testName=json-parse-financial) 07:58:44 INFO - PROCESS | 3680 | RSS: Main: 212561920 07:58:44 INFO - PROCESS | 3680 | 07:58:45 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:55963/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55963/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:58:46 INFO - PROCESS | 3680 | RSS: Main: 190889984 07:58:46 INFO - PROCESS | 3680 | 07:58:48 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:55963/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55963/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:58:48 INFO - PROCESS | 3680 | RSS: Main: 195399680 07:58:48 INFO - PROCESS | 3680 | 07:58:51 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:55963/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55963/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:58:51 INFO - PROCESS | 3680 | RSS: Main: 208478208 07:58:51 INFO - PROCESS | 3680 | 07:58:54 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:55963/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55963/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:58:54 INFO - PROCESS | 3680 | RSS: Main: 214102016 07:58:54 INFO - PROCESS | 3680 | 07:58:57 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:55963/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55963/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:58:58 INFO - PROCESS | 3680 | RSS: Main: 209522688 07:58:58 INFO - PROCESS | 3680 | 07:58:59 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:55963/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55963/tests/kraken/driver.html?testName=ai-astar) 07:59:00 INFO - PROCESS | 3680 | RSS: Main: 272728064 07:59:00 INFO - PROCESS | 3680 | 07:59:00 INFO - PROCESS | 3680 | __start_tp_report 07:59:00 INFO - PROCESS | 3680 | _x_x_mozilla_page_load 07:59:00 INFO - PROCESS | 3680 | _x_x_mozilla_page_load_details 07:59:00 INFO - PROCESS | 3680 | |i|pagename|runs| 07:59:00 INFO - PROCESS | 3680 | |0;ai-astar;110;113;113;110;111;109;105;110;110;108 07:59:00 INFO - PROCESS | 3680 | |1;audio-beat-detection;165;124;159;191;132;158;151;129;191;125 07:59:00 INFO - PROCESS | 3680 | |2;audio-dft;160;163;160;162;159;161;160;160;162;159 07:59:00 INFO - PROCESS | 3680 | |3;audio-fft;74;73;75;172;72;75;76;77;157;75 07:59:00 INFO - PROCESS | 3680 | |4;audio-oscillator;91;93;152;91;92;93;155;91;93;154 07:59:00 INFO - PROCESS | 3680 | |5;imaging-gaussian-blur;118;117;116;116;116;117;117;117;117;117 07:59:00 INFO - PROCESS | 3680 | |6;imaging-darkroom;145;145;145;145;145;145;146;145;145;145 07:59:00 INFO - PROCESS | 3680 | |7;imaging-desaturate;94;95;94;95;94;95;94;95;94;95 07:59:00 INFO - PROCESS | 3680 | |8;json-parse-financial;55;53;56;54;53;55;55;74;55;53 07:59:00 INFO - PROCESS | 3680 | |9;json-stringify-tinderbox;57;57;57;63;58;58;57;58;58;58 07:59:00 INFO - PROCESS | 3680 | |10;stanford-crypto-aes;72;72;72;72;73;73;72;73;72;73 07:59:00 INFO - PROCESS | 3680 | |11;stanford-crypto-ccm;111;111;111;109;112;110;111;111;129;113 07:59:00 INFO - PROCESS | 3680 | |12;stanford-crypto-pbkdf2;158;158;161;162;160;158;158;156;156;157 07:59:00 INFO - PROCESS | 3680 | |13;stanford-crypto-sha256-iterative;68;68;67;67;67;66;66;66;66;65 07:59:00 INFO - PROCESS | 3680 | __end_tp_report 07:59:00 INFO - PROCESS | 3680 | __start_cc_report 07:59:00 INFO - PROCESS | 3680 | _x_x_mozilla_cycle_collect,1606 07:59:00 INFO - PROCESS | 3680 | __end_cc_report 07:59:00 INFO - PROCESS | 3680 | __startTimestamp1465052340063__endTimestamp 07:59:00 INFO - PROCESS | 3680 | 07:59:00 INFO - PROCESS | 3680 | ------- Summary: start ------- 07:59:00 INFO - PROCESS | 3680 | Number of tests: 14 07:59:00 INFO - PROCESS | 3680 | 07:59:00 INFO - PROCESS | 3680 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.00 stddev:2.33 (2.1%) stddev-sans-first:2.47 07:59:00 INFO - PROCESS | 3680 | Values: 110.0 113.0 113.0 110.0 111.0 109.0 105.0 110.0 110.0 108.0 07:59:00 INFO - PROCESS | 3680 | 07:59:00 INFO - PROCESS | 3680 | [#1] audio-beat-detection Cycles:10 Average:152.50 Median:158.50 stddev:25.25 (15.9%) stddev-sans-first:26.37 07:59:00 INFO - PROCESS | 3680 | Values: 165.0 124.0 159.0 191.0 132.0 158.0 151.0 129.0 191.0 125.0 07:59:00 INFO - PROCESS | 3680 | 07:59:00 INFO - PROCESS | 3680 | [#2] audio-dft Cycles:10 Average:160.60 Median:160.50 stddev:1.35 (0.8%) stddev-sans-first:1.41 07:59:00 INFO - PROCESS | 3680 | Values: 160.0 163.0 160.0 162.0 159.0 161.0 160.0 160.0 162.0 159.0 07:59:00 INFO - PROCESS | 3680 | 07:59:00 INFO - PROCESS | 3680 | [#3] audio-fft Cycles:10 Average:92.60 Median:75.00 stddev:38.09 (50.8%) stddev-sans-first:39.80 07:59:00 INFO - PROCESS | 3680 | Values: 74.0 73.0 75.0 172.0 72.0 75.0 76.0 77.0 157.0 75.0 07:59:00 INFO - PROCESS | 3680 | 07:59:00 INFO - PROCESS | 3680 | [#4] audio-oscillator Cycles:10 Average:110.50 Median:91.50 stddev:29.81 (32.6%) stddev-sans-first:30.77 07:59:00 INFO - PROCESS | 3680 | Values: 91.0 93.0 152.0 91.0 92.0 93.0 155.0 91.0 93.0 154.0 07:59:00 INFO - PROCESS | 3680 | 07:59:00 INFO - PROCESS | 3680 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.50 07:59:00 INFO - PROCESS | 3680 | Values: 118.0 117.0 116.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 07:59:00 INFO - PROCESS | 3680 | 07:59:00 INFO - PROCESS | 3680 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 07:59:00 INFO - PROCESS | 3680 | Values: 145.0 145.0 145.0 145.0 145.0 145.0 146.0 145.0 145.0 145.0 07:59:00 INFO - PROCESS | 3680 | 07:59:00 INFO - PROCESS | 3680 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 07:59:00 INFO - PROCESS | 3680 | Values: 94.0 95.0 94.0 95.0 94.0 95.0 94.0 95.0 94.0 95.0 07:59:00 INFO - PROCESS | 3680 | 07:59:00 INFO - PROCESS | 3680 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:55.00 stddev:6.31 (11.5%) stddev-sans-first:6.67 07:59:00 INFO - PROCESS | 3680 | Values: 55.0 53.0 56.0 54.0 53.0 55.0 55.0 74.0 55.0 53.0 07:59:00 INFO - PROCESS | 3680 | 07:59:00 INFO - PROCESS | 3680 | [#9] json-stringify-tinderbox Cycles:10 Average:58.10 Median:58.00 stddev:1.79 (3.1%) stddev-sans-first:1.86 07:59:00 INFO - PROCESS | 3680 | Values: 57.0 57.0 57.0 63.0 58.0 58.0 57.0 58.0 58.0 58.0 07:59:00 INFO - PROCESS | 3680 | 07:59:00 INFO - PROCESS | 3680 | [#10] stanford-crypto-aes Cycles:10 Average:72.40 Median:72.50 stddev:0.52 (0.7%) stddev-sans-first:0.53 07:59:00 INFO - PROCESS | 3680 | Values: 72.0 72.0 72.0 72.0 73.0 73.0 72.0 73.0 72.0 73.0 07:59:00 INFO - PROCESS | 3680 | 07:59:00 INFO - PROCESS | 3680 | [#11] stanford-crypto-ccm Cycles:10 Average:112.80 Median:111.00 stddev:5.79 (5.2%) stddev-sans-first:6.10 07:59:00 INFO - PROCESS | 3680 | Values: 111.0 111.0 111.0 109.0 112.0 110.0 111.0 111.0 129.0 113.0 07:59:00 INFO - PROCESS | 3680 | 07:59:00 INFO - PROCESS | 3680 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.40 Median:158.00 stddev:2.01 (1.3%) stddev-sans-first:2.13 07:59:00 INFO - PROCESS | 3680 | Values: 158.0 158.0 161.0 162.0 160.0 158.0 158.0 156.0 156.0 157.0 07:59:00 INFO - PROCESS | 3680 | 07:59:00 INFO - PROCESS | 3680 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:0.97 (1.4%) stddev-sans-first:0.88 07:59:00 INFO - PROCESS | 3680 | Values: 68.0 68.0 67.0 67.0 67.0 66.0 66.0 66.0 66.0 65.0 07:59:00 INFO - PROCESS | 3680 | -------- Summary: end -------- 07:59:00 INFO - PROCESS | 3680 | 07:59:00 INFO - TEST-INFO | 3680: exit 0 07:59:00 INFO - TEST-OK | kraken | took 60855ms 07:59:00 INFO - SUITE-END | took 1175s 07:59:01 INFO - Completed test suite (00:19:35) 07:59:01 INFO - javascript benchmark 07:59:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3333.9666603333967, 3377.223238655109, 3388.779729317595, 3404.4893266010113, 3414.146463384154, 5594.216809646648, 5595.4684304991015, 5614.242077319561, 5617.354004289508, 5622.0161471742485, 5605.075162598167, 5638.718064096789, 5644.915326270109, 5652.123920792284, 5655.943440565593, 4999.625028122887, 5056.0, 5082.186850103984, 5171.0692075426405, 5224.869378265555, 5136.075506408845, 5151.098557752397, 5151.536361727443, 5155.9484405155845, 5156.458571849958, 5116.360454943132, 5118.923216151761, 5152.407473140581, 5193.039287731763, 5195.740212989335, 5170.482951704837, 5189.844304670866, 5191.351081114861, 5199.012187684328, 5224.0, 5092.898142037138, 5101.744912754348, 5106.744662766884, 5123.436421993578, 5196.142636464979, 5492.615516913817, 5495.313085864267, 5552.11166213408, 5555.472230138171, 5555.611107222496, 6092.055731361646, 6121.265448146207, 6125.387461253884, 6130.570860039799, 6131.202943617346, 6058.0610005449225, 6097.3597772233725, 6102.816915492543, 6122.785702500391, 6145.078238264251, 5591.189277554772, 5630.5495560355075, 5648.858778530528, 5655.830325090254, 5656.971715141439, 6078.088286757022, 6192.318844927055, 6201.906971395432, 6202.162708034448, 6204.3795620437595, 5905.734241959122, 5971.313298970674, 5987.101934709828, 6007.669578173155, 6008.519318454513, 5994.880102397928, 6001.669908155006, 6006.579539432198, 6010.278766548042, 6034.0, 5947.37552556984, 5976.193213916153, 5989.490893274034, 5992.850178745566, 6007.699615019232, 6067.150598916155, 6092.5430592705725, 6104.084387341934, 6106.316485067061, 6126.6017708848785, 4514.029483660963, 4524.977375113103, 4536.478304994902, 4554.908901821945, 4570.428696412949, 3992.181602771425, 4007.7996100194873, 4057.391391291271, 4086.0, 4105.44576482177, 5744.913826292609, 5748.798792042258, 5759.971200144057, 5782.190493330937, 5798.739056742456, 6020.397960203944, 6043.758249669964, 6044.727987240584, 6046.818595442144, 6055.182550355734, 5605.943940560624, 5693.800716974886, 5764.221830052889, 5764.510016648548, 5781.53747700183, 4986.052649996489, 4987.600991920638, 4992.176290912032, 4992.5756310714, 5009.173486374781, 6107.9083813741945, 6120.602160859619, 6120.816375508742, 6151.200343955346, 6221.5333849961435, 6012.669303188367, 6033.487153591818, 6049.122877182695, 6082.695865206811, 6132.816015519542, 6204.410580994799, 6249.093881387264, 6281.937180628135, 6287.937120628735, 6288.465480434214, 5985.610935289193, 5987.670678112746, 5998.0103282957825, 6004.246833523208, 6019.187409699634, 5886.646801191942, 6049.51603871698, 6122.571420000557, 6129.632222066691, 6141.754329826936, 5947.494462970696, 5950.137230101524, 5956.5532585055425, 5961.403859614177, 5968.970155149196, 5736.942630573808, 5904.557158213065, 5913.113033045078, 5950.077737950624, 5966.612170208922, 5779.36426993022, 5811.27359080115, 5812.505936995233, 5836.9416305838095, 5842.357340692605, 5926.822195334147, 5970.731317090828, 5981.222441082806, 5985.700714964321, 5988.251468566429, 5728.369879313189, 5854.560907931837, 5860.443257890493, 5867.9413205867395, 5895.41045895407], "value": 5566.939708189109, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [669.7977131049765, 678.3047376439149, 684.1584850633717, 737.2921994884911, 757.7310054930502, 31706.36587268256, 39104.80447597762, 39621.0, 39718.80140599296, 39763.0, 41895.162096758126, 42595.0, 42597.7870110649, 42613.57386426135, 42614.57385426145, 7808.336291415237, 8658.740237792861, 8824.8676269856, 10255.077043066123, 10417.218708596847, 10016.399016059024, 10150.0864922157, 10152.746181345488, 10156.39061656303, 10161.390316580992, 10170.0, 10220.335678180933, 10221.48892555373, 10223.335483193607, 10227.488625568729, 7910.841783164333, 10353.689389318295, 10497.4226417547, 10505.52725127371, 10506.947465262701, 10418.843717344245, 10543.789124217472, 10544.051035406774, 10544.630937917136, 10552.366857988545, 40285.194296114205, 40862.79568602168, 40868.59131408678, 40873.0, 40888.1822363554, 3676.7977761223124, 3700.5929347771726, 3830.885073447801, 3907.5115610548683, 4188.0, 31654.0, 31916.361672766416, 31970.0, 32352.0, 32925.01224963255, 4429.712068715556, 4513.684042117053, 4545.318202269653, 4564.885877853047, 4584.263824982629, 315360.0, 317151.0, 318299.0, 318437.0, 318453.0, 40318.39522407166, 68372.658136709, 68372.658136709, 68984.0, 69092.0, 38244.61755382466, 38662.613373866465, 38716.806415968305, 38726.61273387286, 38753.41869871954, 16041.358345666044, 16631.6673666526, 16780.83219167817, 16807.075610841275, 16821.747673784903, 14385.352659130363, 14734.778978315333, 14743.336549855283, 14750.114993100447, 14913.627159321104, 9275.0, 9372.0, 9386.249100071978, 9406.05939406054, 9439.103285187895, 3593.2454184621, 3696.8890933272046, 3735.869244576427, 3738.6074462181623, 3757.7181711371754, 1056.3081181825762, 1121.0269924932015, 1148.758760660254, 1162.9941850290695, 1165.9650210493528, 32275.35449291001, 32603.0, 32719.672803271664, 33532.664673352956, 33598.66401335955, 1148.26511032939, 1162.9011534019535, 1181.704573856536, 1185.624675376559, 1200.1478949945636, 16280.592985175228, 16306.347746090023, 16382.426615068416, 16436.0, 16702.331906723593, 346581.0, 349673.0, 350664.0, 350667.0, 350725.0, 57317.14024289639, 57903.97336093216, 57947.420525795045, 57974.7101264491, 58071.0, 1330.8269924909894, 1471.4040813470563, 1484.6511069898565, 1529.8699610533006, 1621.8459246371576, 29318.853405732836, 30337.696623033487, 30585.847070764503, 31350.481511651877, 32339.191520211243, 50887.0, 51912.221316679526, 51919.0, 51924.480755191966, 51990.22014669707, 379449.0, 380938.0, 381055.0, 381155.0, 381298.65454708954, 26869.328266793487, 30185.849070755383, 30570.694293056786, 30889.536656949713, 31039.689603104584, 41667.37498937458, 42339.788301058295, 43175.0, 43407.13185736331, 43930.56069439265, 39121.6087839118, 39129.02177445587, 39690.40464392979, 40120.1975960485, 40615.0, 37817.0, 38557.0, 38768.418473722355, 38959.0, 39519.407208891316, 40095.0, 40154.39768403535, 44708.0, 45515.089698205185, 45612.0, 34591.616335346305, 36606.450903237004, 36774.44838327481, 37483.250334993696, 37715.0, 28299.15102546927, 28390.43219135647, 28566.85716571404, 28587.857060714563, 29096.418071638873], "value": 19327.476740214843, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [424.3164466417201, 429.41385009462095, 434.31595237500943, 439.9894957462727, 443.45233636458966, 18453.0, 18565.350212742538, 19064.42806715801, 19152.521186970316, 20025.499362515908, 18255.178516966735, 18550.628987420278, 20286.492837679067, 20366.592668146666, 20383.0, 5606.887862242753, 5680.943190568083, 5833.679147646878, 5862.9413705863035, 5864.970675146618, 5820.650760954335, 5830.300363956331, 5877.118432235156, 5884.352721200665, 5884.735186916599, 5873.353931067579, 5962.224910761616, 6531.836704082389, 6574.375434333754, 6578.506612004095, 6497.927841906104, 6500.05749166373, 6517.51118666102, 6518.804435866931, 6556.967215163918, 5723.54211663066, 5782.392848750863, 5864.618799778001, 5915.231019967377, 5915.881682366328, 14147.080439771382, 14298.924175234184, 14377.424903003868, 23153.652695209585, 23805.166819161248, 2494.6756921600077, 2587.1591732686766, 2792.5950737143003, 2847.7152284771564, 2943.7792165587666, 10434.113100386476, 10439.47802609874, 10490.527926243261, 10757.623483178051, 10871.728206794893, 1993.9900300498405, 2020.2928974858828, 2049.928252511155, 2055.6094342074957, 2072.668373060303, 61160.08259876105, 72583.63708181478, 74905.0, 77738.83391749185, 79160.60419697923, 11146.99677029055, 11260.887391126147, 11427.771444571063, 11489.310641361379, 11560.132990025782, 16054.678906421806, 16143.112128833027, 16316.836831631768, 16332.0, 16346.100964447069, 8897.332700047522, 8947.19475247231, 9015.77460563478, 9035.0, 9148.0, 8798.516081615444, 8810.691625793066, 8876.911230887737, 8877.467351958903, 9045.457272563668, 4992.600591952635, 5001.399832020181, 5013.799448022039, 5029.974850125726, 5040.445550989388, 2009.8142096163333, 2038.104562756621, 2042.816146546818, 2078.2726045884124, 2084.739407574053, 976.1409959235828, 1059.3961441978154, 1063.5958335832333, 1123.4270522033821, 1142.9427779304276, 18966.620667586572, 19129.13918873654, 19212.231510739413, 19474.415767526996, 19725.210991560463, 1025.3079171559316, 1059.502034043998, 1069.9732506687394, 1072.8498010278568, 1104.779044191165, 10447.216458765623, 10818.513166907507, 10867.076298514557, 10931.890681093088, 11078.002979731862, 455253.0, 468736.0, 470330.0, 475882.0, 478215.0, 65131.0, 79482.0, 82013.58993204996, 92090.0, 94708.0, 1061.532925512772, 1074.0709286467306, 1112.8330750387506, 1122.180808010157, 1141.5662048421714, 17088.060156691503, 17090.145492725067, 17263.654726905643, 17436.0, 17470.21384037696, 38331.616683832806, 39136.2172756549, 39434.21131577295, 40027.19877605573, 40883.59116408798, 54654.453455464936, 57161.71419142878, 57375.13937291027, 57470.0, 57554.42445575491, 8745.169208925143, 8781.385303028726, 8982.550872456482, 8997.01032886369, 12447.751044978868, 13617.795733063815, 13697.109687870257, 13808.926792767179, 13838.515651952133, 14390.208538530482, 11233.887661123612, 12332.753344933231, 12554.372281386077, 12568.434420450918, 12622.747545049231, 11716.0, 11912.702182445508, 12387.814182787446, 12393.194442361219, 12395.256284622952, 12141.69645758863, 12200.328981906081, 12418.689532761753, 12441.191322564004, 12523.4364453598, 13040.869591303965, 13412.463501459832, 13425.127366721132, 13483.528076517276, 13651.590452286448, 11661.300321980709, 11915.2255103418, 11927.642170734893, 12094.516219351479, 12188.939055304667], "value": 9614.620206745602, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1395.4209003263645, 1566.4674010836318, 1577.321751646792, 1736.7308067249573, 1847.316492897628, 7822.569758663271, 8128.512289262649, 8292.087870334259, 8296.668133274678, 8312.210340017704, 8445.113263107378, 8605.827883442327, 8606.61270242839, 8611.966564012328, 8622.267107295887, 2122.066290832029, 2406.6630671705975, 2415.9637605435887, 2445.902163913441, 2458.864762438065, 2438.0979037756056, 2445.1686426614947, 2452.4849781545895, 2455.2020593307248, 2457.7173625033083, 2347.2606129069372, 2370.6562548430466, 2393.234165067179, 2397.4845408237225, 2398.2085911649115, 2002.779694233633, 2047.8873661948587, 2050.8256798172097, 2355.481794005333, 2385.3082606044227, 2361.9409514762096, 2403.254990952793, 2406.7111946566347, 2408.903643854244, 2410.638404239378, 8517.574121293972, 8601.31189504838, 8603.225709686158, 8604.31165506758, 8613.870791938127, 5201.583873290166, 5301.310829592167, 5333.653312534673, 5337.866553336159, 5338.119210330329, 3442.6385229550788, 3490.703290220334, 3526.770759900598, 3642.453631955201, 3706.499622550975, 1155.3876445483907, 1165.7435364219857, 1229.4528934624095, 1246.5200897654377, 1247.189326937498, 12447.190932589443, 12450.501979920882, 12460.190087644365, 12467.688307792196, 12485.875141248562, 4667.0, 4682.297655351656, 4754.881127971759, 4759.4764575896625, 4773.069251495925, 10557.736056598647, 10633.5214915329, 10651.520681569347, 10682.359058456517, 10687.946560267148, 5500.0, 5519.172124181405, 5526.392096869341, 5526.613137080446, 5528.474794894479, 4402.713823601455, 4851.854444366674, 4958.925616115761, 4964.131277026506, 4969.428515720666, 4232.936505952413, 4243.151369726067, 4277.144571085795, 4310.676699247569, 4335.436393268855, 1361.918284902909, 1391.6590435343203, 1393.2337214531967, 1399.0626280392162, 1401.88084012858, 847.4068152293419, 911.8814554108056, 920.5903372998952, 939.0984654731398, 966.9758256043515, 5671.801486947937, 5691.0, 5717.371089180187, 5728.455796699391, 5827.125931110282, 971.2084651009546, 1030.7886883188928, 1036.2953191829477, 1045.6549338718205, 1082.24783775277, 3880.1851611161974, 3883.320418926733, 3913.471681323042, 3923.9215215695526, 3977.125032492847, 10822.080123189617, 11066.612668556561, 11119.499622517005, 11167.05080068187, 11171.0, 11081.5567377304, 11110.333379997226, 11160.107191424666, 11183.496742646601, 11197.832032519518, 8279.917200828035, 8492.363072769567, 8599.26906212979, 8621.568921554022, 8667.219950204511, 5800.6809625471005, 5808.332041815245, 5813.6221145625395, 5873.119032145041, 6074.997625391761, 9855.556499957662, 9917.702468925943, 10106.191504679755, 10108.39349639024, 10145.34055286404, 9685.176759975198, 10050.99490050989, 10117.949410252902, 10226.28416010872, 10240.846387304047, 6877.277885821916, 7263.055802745609, 7440.3675687567165, 7648.655810488653, 7808.180141085104, 8526.78683032929, 8552.957235213784, 8574.699885503978, 8590.82818343642, 8613.48319100856, 7083.964580177066, 7155.785326440215, 7207.603581802841, 7268.672909719181, 7312.012878261579, 6909.378155965987, 7020.297970202939, 7060.752873649603, 7149.964250178716, 7238.420926325776, 6635.701393437404, 6670.533062685566, 6685.598864068172, 6688.2977287386075, 6691.498137639794, 4892.363992680928, 4893.339399181065, 4930.531599498042, 4938.975305123595, 5062.164742817541, 4795.712257264575, 4812.687175333592, 4848.0, 4928.8767780805765, 4964.503549645006], "value": 4654.330341614989, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.20165430263376, 357.7889045463176, 362.21038136861637, 365.45182226659995, 366.93211755825166, 6204.25548934128, 6223.0, 6286.371362863722, 6291.087792270118, 6337.588056776306, 5973.163757074002, 6188.47397971173, 6194.907076393846, 6206.720697568609, 6214.03682429223, 4761.547652972962, 4843.4187897452175, 4849.975750121244, 4865.732384718839, 4869.586085182764, 4820.963492849037, 4848.466668666444, 4849.393825771778, 4858.927116093261, 4860.659753817235, 4625.907481850378, 4693.812247510113, 4805.774527495484, 4816.157172494817, 4819.156647586676, 4787.329773831666, 4787.353707249529, 4793.7363445010515, 4799.472058073609, 4808.966072294438, 4227.556106608823, 4237.576242375738, 4240.088380998101, 4244.0663054128045, 4257.127288905767, 6039.637621742666, 6046.909296360558, 6047.818565443044, 6049.909251361233, 6051.062085376773, 5595.160725891149, 5595.468430499096, 5598.384177740445, 5602.075657516505, 5607.130894711327, 6376.840578985516, 6554.836129096763, 6589.538732288742, 6599.967000164968, 6604.339566043357, 4673.11210869937, 4682.1338052460405, 4686.812527498896, 4692.835750748742, 4704.647151463654, 6894.310568943066, 6899.517033807636, 6900.137482814648, 6903.068085808452, 6905.965470172617, 4764.928526072112, 4787.928181077286, 4789.233722604366, 4794.496577859344, 4797.064572408347, 4849.345338379274, 4852.95147048525, 4853.611711063107, 4857.1742803723455, 4857.805687772449, 5440.537554307849, 5550.056490396642, 5555.2222688823595, 5557.666540007613, 5566.526845218121, 6654.866902662016, 6662.935049877014, 6670.199576050808, 6677.332266773381, 6679.064930909676, 1694.593297608565, 1726.1973182470213, 1727.1709579401706, 1728.3777839977597, 1731.826817318258, 1085.2023762534532, 1126.830975353687, 1132.6432173865371, 1159.9826002609968, 1172.6013155527162, 6369.777057802955, 6432.549721519542, 6439.774607888701, 6444.323346048597, 6454.1609590752905, 6827.761028363983, 6832.624205668637, 6835.350641689031, 6839.863202736017, 6846.486513511407, 6426.485881129498, 6432.71052802625, 6433.195850518685, 6434.485241180694, 6444.162258906312, 3615.2769446110883, 3648.5986541480415, 3695.334839728821, 3700.7039436845525, 3701.574318953355, 7038.964805175941, 7052.0, 7060.470464715167, 7066.081409416743, 7070.257622949619, 6843.213030501456, 6857.142857142857, 6893.345132212432, 6902.275261097613, 6913.032175495435, 6970.198427180838, 7029.9648501757165, 7052.823679407953, 7053.8236544085785, 7054.294570542905, 6659.966700166468, 6737.427318677967, 6742.25835158142, 6797.150356205474, 6821.965890170517, 6706.865862682816, 6711.295313991961, 6714.194296684429, 6719.092922455406, 6719.932800672126, 6996.860062798817, 7018.649067546704, 7019.964900175671, 7022.262662420372, 7034.366906978396, 4812.085703716282, 4816.0, 4816.54242846929, 4819.1566475867285, 4822.373091498082, 6711.295313992156, 6764.830879228059, 6771.492138089761, 6784.084148640068, 6785.5250132490255, 6466.773662921775, 6559.573627714183, 6672.933270667231, 6724.596524208563, 6724.93275067243, 6656.600603963778, 6667.866642667216, 6683.899741503784, 6687.063811066552, 6691.899621505584, 6571.178602674666, 6587.077809106825, 6597.27429982692, 6648.235452922782, 6666.833329166616, 6746.0, 6752.527323087336, 6752.662366881735, 6753.088333074972, 6773.0, 6452.774152904626, 6575.868482630416, 6578.111954886029, 6580.967095164494, 6612.867742645217], "value": 5031.159778766603, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [800.8878756974025, 865.4201684871132, 900.1403659505175, 934.439336398161, 955.2739917662574, 14956.626084347898, 15079.924600376997, 15109.168995705246, 15159.848401515981, 15205.011674241166, 14874.181919994397, 14884.702305953902, 14936.701265974702, 15042.172680502568, 15099.92450037751, 748.4424104042496, 897.1745993685809, 902.5848109869435, 911.4303560274828, 919.7608621758324, 902.8781114549517, 909.9272058235325, 913.3834661603424, 914.2274777812737, 914.7027216154743, 945.3524335829944, 948.5778828421321, 951.3958636265986, 951.5480146930188, 952.6046690623383, 775.0931410249993, 782.8434313137367, 913.4975763330142, 929.6746138851415, 948.3266880514808, 686.0532465198045, 686.4817063117364, 686.5606012152226, 686.8866637004888, 687.4534744877784, 14374.35315410809, 14421.27893605326, 14439.494617688331, 14441.277936103153, 14451.638709032253, 14290.071145375518, 14654.168228971379, 14685.265736713121, 14730.926345368312, 14971.401143954228, 11404.144689148265, 11866.169368144234, 12311.75376492474, 12465.065120116027, 12492.437840297118, 4628.861134165981, 4690.390249267608, 4709.858704238878, 4739.549742774431, 4749.311349854286, 50367.24449133229, 50411.49588504105, 50748.23877641838, 50770.0, 50984.49015509872, 11014.44927753625, 11056.557737690402, 11292.491837867316, 11349.886501135048, 12122.818157727641, 20534.897325513277, 20584.073716682786, 20658.380248592566, 20673.89663051705, 20688.379348619565, 8866.069062748318, 8912.821743565093, 8971.730848074569, 8997.100289970951, 9228.354015219005, 5077.1876499759865, 5088.821891233789, 5108.770105345268, 5168.61235407346, 5336.4129945705945, 3540.7875527468436, 3573.428251479803, 3593.9820300898327, 3594.406922857699, 3602.5316708827686, 629.6568370238231, 636.3763511758502, 678.9694463749144, 691.5435812363917, 700.7757517594423, 627.9183706118267, 748.5882764479514, 786.7403756760256, 831.6964308027526, 835.8119423129747, 8982.32632552548, 9126.49804260772, 9281.58232879522, 9351.719448416557, 9384.671536496326, 665.6838001949036, 715.0, 799.4084377560563, 803.0884945586685, 808.7614153824636, 4729.0541891621815, 4754.548317909793, 4764.356811830358, 4856.902861942812, 4886.706797592155, 53635.731821341426, 60928.695356522934, 61571.0, 61897.0, 61917.0, 53840.999999999214, 54486.45513544893, 54640.453595463536, 55146.0, 55326.72336638291, 48863.755681221366, 48935.755321223165, 49252.50747492551, 50299.0, 50332.0, 9260.583273752563, 9340.53297335117, 9421.057894210524, 9455.527223638928, 9456.243500520079, 35828.462573060904, 36001.09997249985, 36776.44835327526, 37933.81033094817, 38110.23779524338, 41110.177796443306, 44054.33918491161, 45048.324275136554, 45504.0, 46392.76803615961, 11842.111841612086, 11965.521379144737, 11986.880131198577, 12037.157398982337, 12327.75344493123, 12703.872961270268, 12709.428075736429, 12711.74576508446, 12947.093703440669, 13133.277669728257, 11493.482793274155, 11877.881221188023, 12094.0, 12166.635000949986, 12603.0, 12071.637850864488, 12472.68818279514, 12539.435725392561, 12814.743705125658, 12984.740305194033, 12333.814992774936, 12387.814182787086, 12390.876091238972, 12637.17858339205, 12922.935385323013, 10323.277370583986, 10437.895621043996, 10545.52545135486, 10547.472626368804, 10869.78260434771, 10244.282900196915, 10316.27786054999, 10566.630167944086, 10581.15350771921, 10585.788284234426], "value": 7026.609672156015, "unit": "score"}], "name": "dromaeo_css", "value": 7444.553730702565, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 113.0, 110.0, 111.0, 109.0, 105.0, 110.0, 110.0, 108.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 124.0, 159.0, 191.0, 132.0, 158.0, 151.0, 129.0, 191.0, 125.0], "value": 152.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 160.0, 162.0, 159.0, 161.0, 160.0, 160.0, 162.0, 159.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 75.0, 172.0, 72.0, 75.0, 76.0, 77.0, 157.0, 75.0], "value": 92.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 93.0, 152.0, 91.0, 92.0, 93.0, 155.0, 91.0, 93.0, 154.0], "value": 110.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0], "value": 145.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 56.0, 54.0, 53.0, 55.0, 55.0, 74.0, 55.0, 53.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 63.0, 58.0, 58.0, 57.0, 58.0, 58.0, 58.0], "value": 58.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 72.0, 72.0, 73.0, 73.0, 72.0, 73.0, 72.0, 73.0], "value": 72.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 111.0, 109.0, 112.0, 110.0, 111.0, 111.0, 129.0, 113.0], "value": 112.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 158.0, 161.0, 162.0, 160.0, 158.0, 158.0, 156.0, 156.0, 157.0], "value": 158.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 67.0, 67.0, 66.0, 66.0, 66.0, 66.0, 65.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1507.1, "alertThreshold": 2.0}]} 07:59:01 INFO - Return code: 0 07:59:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:59:01 ERROR - # TBPL SUCCESS # 07:59:01 INFO - Running post-action listener: _resource_record_post_action 07:59:01 INFO - Running post-run listener: _resource_record_post_run 07:59:02 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 7811072; Write bytes: 393785344; Read time: 1048; Write time: 333748 07:59:02 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 20365312; Read time: 0; Write time: 18136 07:59:02 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 7811072; Write bytes: 373420032; Read time: 1048; Write time: 315612 07:59:02 INFO - Running post-run listener: _upload_blobber_files 07:59:02 INFO - Blob upload gear active. 07:59:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:59:02 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 07:59:02 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'] 07:59:02 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 07:59:02 INFO - (blobuploader) - INFO - Open directory for files ... 07:59:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:59:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:59:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:59:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:59:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:59:03 INFO - (blobuploader) - INFO - Done attempting. 07:59:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:59:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:59:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:59:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:59:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:59:04 INFO - (blobuploader) - INFO - Done attempting. 07:59:04 INFO - (blobuploader) - INFO - Iteration through files over. 07:59:04 INFO - Return code: 0 07:59:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:59:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:59:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/065cd0f100e012c43a9703fc7fbe9a74950e34eb2ca1b4718e1c4250aaae21630e9f437cff6887099ad82b8db3c1dacc3e1d617424fb49b12c13eaa59ffc4cfc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/87ab7f498e775735f3b87758a62ba3f362026b233e12909bfe2773b2b872384e3713b0f363216613cbe97bccb99d22a8390f5bc93b8f73020da674ed035ea0c3"} 07:59:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:59:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:59:04 INFO - Contents: 07:59:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/065cd0f100e012c43a9703fc7fbe9a74950e34eb2ca1b4718e1c4250aaae21630e9f437cff6887099ad82b8db3c1dacc3e1d617424fb49b12c13eaa59ffc4cfc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/87ab7f498e775735f3b87758a62ba3f362026b233e12909bfe2773b2b872384e3713b0f363216613cbe97bccb99d22a8390f5bc93b8f73020da674ed035ea0c3"} 07:59:04 INFO - Running post-run listener: copy_logs_to_upload_dir 07:59:04 INFO - Copying logs to upload dir... 07:59:04 INFO - mkdir: /builds/slave/test/build/upload/logs 07:59:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.123920 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-06-04 07:59:04.384557) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-04 07:59:04.387958) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1465049267.899387-22348930 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/065cd0f100e012c43a9703fc7fbe9a74950e34eb2ca1b4718e1c4250aaae21630e9f437cff6887099ad82b8db3c1dacc3e1d617424fb49b12c13eaa59ffc4cfc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/87ab7f498e775735f3b87758a62ba3f362026b233e12909bfe2773b2b872384e3713b0f363216613cbe97bccb99d22a8390f5bc93b8f73020da674ed035ea0c3"} build_url:https://queue.taskcluster.net/v1/task/Ykk4DjLvSfycvghfshHlkg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011352 build_url: 'https://queue.taskcluster.net/v1/task/Ykk4DjLvSfycvghfshHlkg/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/065cd0f100e012c43a9703fc7fbe9a74950e34eb2ca1b4718e1c4250aaae21630e9f437cff6887099ad82b8db3c1dacc3e1d617424fb49b12c13eaa59ffc4cfc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/87ab7f498e775735f3b87758a62ba3f362026b233e12909bfe2773b2b872384e3713b0f363216613cbe97bccb99d22a8390f5bc93b8f73020da674ed035ea0c3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-04 07:59:04.413352) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 07:59:04.413808) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1465049267.899387-22348930 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004422 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 07:59:04.495476) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-04 07:59:04.495827) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-04 07:59:04.496117) ========= ========= Total master_lag: 0.17 =========