builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-063 starttime: 1464644357.74 results: success (0) buildid: 20160530120549 builduid: 7997d47d310b490c9d491deb39fe4327 revision: 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 14:39:17.742603) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 14:39:17.743072) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 14:39:17.743355) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 14:39:17.769834) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 14:39:17.770143) ========= 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=33d5923976266a1c518c4bf7000001ab-1464643868.857785-1470080577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-30 14:39:18-- 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% 43.0M=0s 2016-05-30 14:39:18 (43.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.141942 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 14:39:17.928419) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 14:39:17.928742) ========= 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=33d5923976266a1c518c4bf7000001ab-1464643868.857785-1470080577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016831 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 14:39:17.980440) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 14:39:17.980825) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 --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 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 --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=33d5923976266a1c518c4bf7000001ab-1464643868.857785-1470080577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-30 14:39:18,579 truncating revision to first 12 chars 2016-05-30 14:39:18,579 Setting DEBUG logging. 2016-05-30 14:39:18,579 attempt 1/10 2016-05-30 14:39:18,579 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3c7a33fe0b64?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-30 14:39:18,902 unpacking tar archive at: mozilla-aurora-3c7a33fe0b64/testing/mozharness/ program finished with exit code 0 elapsedTime=0.683023 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 14:39:18.677847) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 14:39:18.678207) ========= script_repo_revision: 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 14:39:18.678667) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 14:39:18.678949) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 14:39:18.688218) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-05-30 14:39:18.688640) ========= /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=33d5923976266a1c518c4bf7000001ab-1464643868.857785-1470080577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:39:19 INFO - MultiFileLogger online at 20160530 14:39:19 in /builds/slave/test 14:39:19 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 14:39:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:39:19 INFO - {'append_to_log': False, 14:39:19 INFO - 'base_work_dir': '/builds/slave/test', 14:39:19 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:39:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:39:19 INFO - 'branch': 'Mozilla-Aurora', 14:39:19 INFO - 'buildbot_json_path': 'buildprops.json', 14:39:19 INFO - 'config_files': ('talos/linux_config.py',), 14:39:19 INFO - 'default_actions': ('clobber', 14:39:19 INFO - 'read-buildbot-config', 14:39:19 INFO - 'download-and-extract', 14:39:19 INFO - 'populate-webroot', 14:39:19 INFO - 'create-virtualenv', 14:39:19 INFO - 'install', 14:39:19 INFO - 'run-tests'), 14:39:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:39:19 INFO - 'download_minidump_stackwalk': True, 14:39:19 INFO - 'download_symbols': 'ondemand', 14:39:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:39:19 INFO - 'tooltool.py': '/tools/tooltool.py', 14:39:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:39:19 INFO - '/tools/misc-python/virtualenv.py')}, 14:39:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:39:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:39:19 INFO - 'installer_path': 'installer.exe', 14:39:19 INFO - 'log_level': 'info', 14:39:19 INFO - 'log_name': 'talos', 14:39:19 INFO - 'log_to_console': True, 14:39:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:39:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:39:19 INFO - 'opt_config_files': (), 14:39:19 INFO - 'pip_index': False, 14:39:19 INFO - 'sps_profile': False, 14:39:19 INFO - 'sps_profile_interval': 0, 14:39:19 INFO - 'suite': 'dromaeojs', 14:39:19 INFO - 'system_bits': '32', 14:39:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:39:19 INFO - 'title': 'talos-linux64-ix-063', 14:39:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:39:19 INFO - 'use_talos_json': True, 14:39:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:39:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:39:19 INFO - 'work_dir': 'build'} 14:39:19 INFO - ##### 14:39:19 INFO - ##### Running clobber step. 14:39:19 INFO - ##### 14:39:19 INFO - Running pre-action listener: _resource_record_pre_action 14:39:19 INFO - Running main action method: clobber 14:39:19 INFO - rmtree: /builds/slave/test/build 14:39:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:39:20 INFO - Running post-action listener: _resource_record_post_action 14:39:20 INFO - ##### 14:39:20 INFO - ##### Running read-buildbot-config step. 14:39:20 INFO - ##### 14:39:20 INFO - Running pre-action listener: _resource_record_pre_action 14:39:20 INFO - Running main action method: read_buildbot_config 14:39:20 INFO - Using buildbot properties: 14:39:20 INFO - { 14:39:20 INFO - "project": "", 14:39:20 INFO - "product": "firefox", 14:39:20 INFO - "script_repo_revision": "production", 14:39:20 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 14:39:20 INFO - "repository": "", 14:39:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 14:39:20 INFO - "buildid": "20160530120549", 14:39:20 INFO - "pgo_build": "True", 14:39:20 INFO - "basedir": "/builds/slave/test", 14:39:20 INFO - "buildnumber": 276, 14:39:20 INFO - "slavename": "talos-linux64-ix-063", 14:39:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:39:20 INFO - "platform": "ubuntu64_hw", 14:39:20 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 14:39:20 INFO - "branch": "mozilla-aurora", 14:39:20 INFO - "repo_path": "releases/mozilla-aurora", 14:39:20 INFO - "revision": "3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4", 14:39:20 INFO - "stage_platform": "linux64-pgo", 14:39:20 INFO - "builduid": "7997d47d310b490c9d491deb39fe4327", 14:39:20 INFO - "slavebuilddir": "test" 14:39:20 INFO - } 14:39:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 14:39:20 INFO - Running post-action listener: _resource_record_post_action 14:39:20 INFO - ##### 14:39:20 INFO - ##### Running download-and-extract step. 14:39:20 INFO - ##### 14:39:20 INFO - Running pre-action listener: _resource_record_pre_action 14:39:20 INFO - Running main action method: download_and_extract 14:39:20 INFO - mkdir: /builds/slave/test/build/tests 14:39:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:20 INFO - https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:39:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 14:39:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 14:39:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 14:39:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:39:27 INFO - Downloaded 1361 bytes. 14:39:27 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 14:39:27 INFO - Using the following test package requirements: 14:39:27 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 14:39:27 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:39:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 14:39:27 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:39:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 14:39:27 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:39:27 INFO - u'jsshell-linux-x86_64.zip'], 14:39:27 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:39:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 14:39:27 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 14:39:27 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:39:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 14:39:27 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:39:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 14:39:27 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:39:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 14:39:27 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:39:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 14:39:27 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:39:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:27 INFO - https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:39:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 14:39:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 14:39:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 14:39:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:39:31 INFO - Downloaded 24173994 bytes. 14:39:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:39:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:39:32 INFO - Return code: 0 14:39:32 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:39:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:32 INFO - https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:39:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 14:39:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 14:39:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 14:39:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:39:39 INFO - Downloaded 24173994 bytes. 14:39:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:39:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:39:41 INFO - Return code: 0 14:39:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:41 INFO - https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:39:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 14:39:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 14:39:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 14:39:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:39:42 INFO - Downloaded 10840145 bytes. 14:39:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:39:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:39:42 INFO - Return code: 0 14:39:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:42 INFO - https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:39:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 14:39:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 14:39:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 14:39:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:39:44 INFO - Downloaded 62800628 bytes. 14:39:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 14:39:44 INFO - mkdir: /builds/slave/test/properties 14:39:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:39:44 INFO - Writing to file /builds/slave/test/properties/build_url 14:39:44 INFO - Contents: 14:39:44 INFO - build_url:https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 14:39:45 INFO - Running post-action listener: _resource_record_post_action 14:39:45 INFO - Running post-action listener: set_extra_try_arguments 14:39:45 INFO - ##### 14:39:45 INFO - ##### Running populate-webroot step. 14:39:45 INFO - ##### 14:39:45 INFO - Running pre-action listener: _resource_record_pre_action 14:39:45 INFO - Running main action method: populate_webroot 14:39:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:39:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:39:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:39:45 INFO - '--tppagecycles', 14:39:45 INFO - '7'], 14:39:45 INFO - 'tests': ['tsvgm']}}, 14:39:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:39:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:39:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:39:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:39:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:39:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:39:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:45 INFO - 'talos_options': ['--disable-e10s'], 14:39:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:39:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:39:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:45 INFO - 'talos_options': ['--disable-e10s'], 14:39:45 INFO - 'tests': ['damp', 'tps']}, 14:39:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:45 INFO - 'tests': ['damp', 'tps']}, 14:39:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:39:45 INFO - 'tests': ['dromaeo_dom']}, 14:39:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:39:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:39:45 INFO - 'tests': ['a11yr', 14:39:45 INFO - 'ts_paint', 14:39:45 INFO - 'tpaint', 14:39:45 INFO - 'sessionrestore', 14:39:45 INFO - 'sessionrestore_no_auto_restore', 14:39:45 INFO - 'tabpaint']}, 14:39:45 INFO - 'other-e10s': {'tests': ['a11yr', 14:39:45 INFO - 'ts_paint', 14:39:45 INFO - 'tpaint', 14:39:45 INFO - 'sessionrestore', 14:39:45 INFO - 'sessionrestore_no_auto_restore', 14:39:45 INFO - 'tabpaint']}, 14:39:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:39:45 INFO - 'ts_paint', 14:39:45 INFO - 'tpaint', 14:39:45 INFO - 'sessionrestore', 14:39:45 INFO - 'sessionrestore_no_auto_restore', 14:39:45 INFO - 'tabpaint']}, 14:39:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:39:45 INFO - 'ts_paint', 14:39:45 INFO - 'tpaint', 14:39:45 INFO - 'sessionrestore', 14:39:45 INFO - 'sessionrestore_no_auto_restore', 14:39:45 INFO - 'tabpaint']}, 14:39:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:39:45 INFO - 'tests': ['a11yr', 14:39:45 INFO - 'ts_paint', 14:39:45 INFO - 'tpaint', 14:39:45 INFO - 'sessionrestore', 14:39:45 INFO - 'sessionrestore_no_auto_restore', 14:39:45 INFO - 'tabpaint']}, 14:39:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:39:45 INFO - 'tests': ['a11yr', 14:39:45 INFO - 'ts_paint', 14:39:45 INFO - 'tpaint', 14:39:45 INFO - 'sessionrestore', 14:39:45 INFO - 'sessionrestore_no_auto_restore', 14:39:45 INFO - 'tabpaint']}, 14:39:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:39:45 INFO - 'tests': ['tsvgx', 14:39:45 INFO - 'tsvgr_opacity', 14:39:45 INFO - 'tart', 14:39:45 INFO - 'tscrollx', 14:39:45 INFO - 'cart']}, 14:39:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:39:45 INFO - 'tsvgr_opacity', 14:39:45 INFO - 'tart', 14:39:45 INFO - 'tscrollx', 14:39:45 INFO - 'cart']}, 14:39:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:45 INFO - 'talos_options': ['--disable-e10s'], 14:39:45 INFO - 'tests': ['tp5o']}, 14:39:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:45 INFO - 'tests': ['tp5o']}, 14:39:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:45 INFO - 'talos_options': ['--disable-e10s', 14:39:45 INFO - '--xperf_path', 14:39:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:39:45 INFO - 'tests': ['tp5n']}, 14:39:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:45 INFO - 'talos_options': ['--xperf_path', 14:39:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:39:45 INFO - 'tests': ['tp5n']}}, 14:39:45 INFO - 'talos.zip': {'path': '', 14:39:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:39:45 INFO - Running post-action listener: _resource_record_post_action 14:39:45 INFO - ##### 14:39:45 INFO - ##### Running create-virtualenv step. 14:39:45 INFO - ##### 14:39:45 INFO - Running pre-action listener: _resource_record_pre_action 14:39:45 INFO - Running main action method: create_virtualenv 14:39:45 INFO - Creating virtualenv /builds/slave/test/build/venv 14:39:45 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:39:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:39:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:39:45 INFO - Using real prefix '/usr' 14:39:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:39:45 INFO - Installing distribute.............................................................................................................................................................................................done. 14:39:47 INFO - Installing pip.................done. 14:39:47 INFO - Return code: 0 14:39:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:39:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:47 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 0x7f6fe0e3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe865a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf15410>, '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 0xf16310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf167a0>, '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': '33d5923976266a1c518c4bf7000001ab-1464643868.857785-1470080577', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:39:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:39:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:39:47 INFO - Using env: {'DISPLAY': ':0', 14:39:47 INFO - 'HOME': '/home/cltbld', 14:39:47 INFO - 'LANG': 'en_US.UTF-8', 14:39:47 INFO - 'LANGUAGE': 'en_US:en', 14:39:47 INFO - 'LOGNAME': 'cltbld', 14:39:47 INFO - 'MAIL': '/var/mail/cltbld', 14:39:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:47 INFO - 'MOZ_NO_REMOTE': '1', 14:39:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:47 INFO - 'NO_EM_RESTART': '1', 14:39:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:47 INFO - 'PWD': '/builds/slave/test', 14:39:47 INFO - 'SHELL': '/bin/bash', 14:39:47 INFO - 'SHLVL': '1', 14:39:47 INFO - 'TERM': 'linux', 14:39:47 INFO - 'TMOUT': '86400', 14:39:47 INFO - 'USER': 'cltbld', 14:39:47 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464643868.857785-1470080577', 14:39:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:47 INFO - '_': '/tools/buildbot/bin/python'} 14:39:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:48 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:39:48 INFO - Cleaning up... 14:39:48 INFO - Return code: 0 14:39:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:39:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6fe0e3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe865a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf15410>, '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 0xf16310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf167a0>, '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': '33d5923976266a1c518c4bf7000001ab-1464643868.857785-1470080577', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:39:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 14:39:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:39:48 INFO - Using env: {'DISPLAY': ':0', 14:39:48 INFO - 'HOME': '/home/cltbld', 14:39:48 INFO - 'LANG': 'en_US.UTF-8', 14:39:48 INFO - 'LANGUAGE': 'en_US:en', 14:39:48 INFO - 'LOGNAME': 'cltbld', 14:39:48 INFO - 'MAIL': '/var/mail/cltbld', 14:39:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:48 INFO - 'MOZ_NO_REMOTE': '1', 14:39:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:48 INFO - 'NO_EM_RESTART': '1', 14:39:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:48 INFO - 'PWD': '/builds/slave/test', 14:39:48 INFO - 'SHELL': '/bin/bash', 14:39:48 INFO - 'SHLVL': '1', 14:39:48 INFO - 'TERM': 'linux', 14:39:48 INFO - 'TMOUT': '86400', 14:39:48 INFO - 'USER': 'cltbld', 14:39:48 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464643868.857785-1470080577', 14:39:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:48 INFO - '_': '/tools/buildbot/bin/python'} 14:39:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:48 INFO - Downloading/unpacking psutil>=0.7.1 14:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:39:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:39:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:39:50 INFO - Installing collected packages: psutil 14:39:50 INFO - Running setup.py install for psutil 14:39:50 INFO - building 'psutil._psutil_linux' extension 14:39:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:39:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:39:50 INFO - building 'psutil._psutil_posix' extension 14:39:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:39:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:39:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:39:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:39:50 INFO - Successfully installed psutil 14:39:50 INFO - Cleaning up... 14:39:50 INFO - Return code: 0 14:39:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:39:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6fe0e3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe865a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf15410>, '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 0xf16310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf167a0>, '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': '33d5923976266a1c518c4bf7000001ab-1464643868.857785-1470080577', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:39:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:39:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:39:50 INFO - Using env: {'DISPLAY': ':0', 14:39:50 INFO - 'HOME': '/home/cltbld', 14:39:50 INFO - 'LANG': 'en_US.UTF-8', 14:39:50 INFO - 'LANGUAGE': 'en_US:en', 14:39:50 INFO - 'LOGNAME': 'cltbld', 14:39:50 INFO - 'MAIL': '/var/mail/cltbld', 14:39:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:50 INFO - 'MOZ_NO_REMOTE': '1', 14:39:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:50 INFO - 'NO_EM_RESTART': '1', 14:39:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:50 INFO - 'PWD': '/builds/slave/test', 14:39:50 INFO - 'SHELL': '/bin/bash', 14:39:50 INFO - 'SHLVL': '1', 14:39:50 INFO - 'TERM': 'linux', 14:39:50 INFO - 'TMOUT': '86400', 14:39:50 INFO - 'USER': 'cltbld', 14:39:50 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464643868.857785-1470080577', 14:39:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:50 INFO - '_': '/tools/buildbot/bin/python'} 14:39:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:39:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:39:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:39:53 INFO - Installing collected packages: mozsystemmonitor 14:39:53 INFO - Running setup.py install for mozsystemmonitor 14:39:53 INFO - Successfully installed mozsystemmonitor 14:39:53 INFO - Cleaning up... 14:39:53 INFO - Return code: 0 14:39:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:39:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:53 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 0x7f6fe0e3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe865a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf15410>, '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 0xf16310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf167a0>, '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': '33d5923976266a1c518c4bf7000001ab-1464643868.857785-1470080577', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:39:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:39:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:39:53 INFO - Using env: {'DISPLAY': ':0', 14:39:53 INFO - 'HOME': '/home/cltbld', 14:39:53 INFO - 'LANG': 'en_US.UTF-8', 14:39:53 INFO - 'LANGUAGE': 'en_US:en', 14:39:53 INFO - 'LOGNAME': 'cltbld', 14:39:53 INFO - 'MAIL': '/var/mail/cltbld', 14:39:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:53 INFO - 'MOZ_NO_REMOTE': '1', 14:39:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:53 INFO - 'NO_EM_RESTART': '1', 14:39:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:53 INFO - 'PWD': '/builds/slave/test', 14:39:53 INFO - 'SHELL': '/bin/bash', 14:39:53 INFO - 'SHLVL': '1', 14:39:53 INFO - 'TERM': 'linux', 14:39:53 INFO - 'TMOUT': '86400', 14:39:53 INFO - 'USER': 'cltbld', 14:39:53 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464643868.857785-1470080577', 14:39:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:53 INFO - '_': '/tools/buildbot/bin/python'} 14:39:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:53 INFO - Downloading/unpacking blobuploader==1.2.4 14:39:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:55 INFO - Downloading blobuploader-1.2.4.tar.gz 14:39:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:39:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:39:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:56 INFO - Downloading docopt-0.6.1.tar.gz 14:39:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:39:56 INFO - Installing collected packages: blobuploader, requests, docopt 14:39:56 INFO - Running setup.py install for blobuploader 14:39:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:39:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:39:56 INFO - Running setup.py install for requests 14:39:56 INFO - Running setup.py install for docopt 14:39:56 INFO - Successfully installed blobuploader requests docopt 14:39:56 INFO - Cleaning up... 14:39:56 INFO - Return code: 0 14:39:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:39:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:56 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 0x7f6fe0e3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe865a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf15410>, '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 0xf16310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf167a0>, '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': '33d5923976266a1c518c4bf7000001ab-1464643868.857785-1470080577', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:39:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:39:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:39:56 INFO - Using env: {'DISPLAY': ':0', 14:39:56 INFO - 'HOME': '/home/cltbld', 14:39:56 INFO - 'LANG': 'en_US.UTF-8', 14:39:56 INFO - 'LANGUAGE': 'en_US:en', 14:39:56 INFO - 'LOGNAME': 'cltbld', 14:39:56 INFO - 'MAIL': '/var/mail/cltbld', 14:39:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:56 INFO - 'MOZ_NO_REMOTE': '1', 14:39:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:56 INFO - 'NO_EM_RESTART': '1', 14:39:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:56 INFO - 'PWD': '/builds/slave/test', 14:39:56 INFO - 'SHELL': '/bin/bash', 14:39:56 INFO - 'SHLVL': '1', 14:39:56 INFO - 'TERM': 'linux', 14:39:56 INFO - 'TMOUT': '86400', 14:39:56 INFO - 'USER': 'cltbld', 14:39:56 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464643868.857785-1470080577', 14:39:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:56 INFO - '_': '/tools/buildbot/bin/python'} 14:39:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:39:56 INFO - Running setup.py (path:/tmp/pip-khYZS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:39:56 INFO - Running setup.py (path:/tmp/pip-MVbfmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:39:57 INFO - Running setup.py (path:/tmp/pip-4AnDI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:39:57 INFO - Running setup.py (path:/tmp/pip-T5hjyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:39:57 INFO - Running setup.py (path:/tmp/pip-CuJrf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:39:57 INFO - Running setup.py (path:/tmp/pip-WHrK_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:39:57 INFO - Running setup.py (path:/tmp/pip-nJKEE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:39:57 INFO - Running setup.py (path:/tmp/pip-FPP55K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:39:57 INFO - Running setup.py (path:/tmp/pip-fsGPp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:39:57 INFO - Running setup.py (path:/tmp/pip-l2to5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:39:57 INFO - Running setup.py (path:/tmp/pip-S2kkfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:39:57 INFO - Running setup.py (path:/tmp/pip-OP_fBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:39:57 INFO - Running setup.py (path:/tmp/pip-AV4nEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:39:57 INFO - Running setup.py (path:/tmp/pip-xHLx9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:39:57 INFO - Running setup.py (path:/tmp/pip-K_gqAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:39:58 INFO - Running setup.py (path:/tmp/pip-Flmw3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:39:58 INFO - Running setup.py (path:/tmp/pip-_CXmGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:39:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:39:58 INFO - Running setup.py install for manifestparser 14:39:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:39:58 INFO - Running setup.py install for mozcrash 14:39:58 INFO - Running setup.py install for mozdebug 14:39:58 INFO - Running setup.py install for mozdevice 14:39:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:39:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:39:58 INFO - Running setup.py install for mozfile 14:39:58 INFO - Running setup.py install for mozhttpd 14:39:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:39:58 INFO - Running setup.py install for mozinfo 14:39:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:39:58 INFO - Running setup.py install for mozInstall 14:39:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:39:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:39:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:39:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:39:58 INFO - Running setup.py install for mozleak 14:39:59 INFO - Running setup.py install for mozlog 14:39:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:39:59 INFO - Running setup.py install for moznetwork 14:39:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:39:59 INFO - Running setup.py install for mozprocess 14:39:59 INFO - Running setup.py install for mozprofile 14:39:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:39:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:39:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:39:59 INFO - Running setup.py install for mozrunner 14:39:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:39:59 INFO - Running setup.py install for mozscreenshot 14:39:59 INFO - Running setup.py install for moztest 14:39:59 INFO - Running setup.py install for mozversion 14:39:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:39:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:39:59 INFO - Cleaning up... 14:39:59 INFO - Return code: 0 14:39:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:39:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:59 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 0x7f6fe0e3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe865a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf15410>, '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 0xf16310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf167a0>, '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': '33d5923976266a1c518c4bf7000001ab-1464643868.857785-1470080577', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:39:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:39:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:40:00 INFO - Using env: {'DISPLAY': ':0', 14:40:00 INFO - 'HOME': '/home/cltbld', 14:40:00 INFO - 'LANG': 'en_US.UTF-8', 14:40:00 INFO - 'LANGUAGE': 'en_US:en', 14:40:00 INFO - 'LOGNAME': 'cltbld', 14:40:00 INFO - 'MAIL': '/var/mail/cltbld', 14:40:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:00 INFO - 'MOZ_NO_REMOTE': '1', 14:40:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:00 INFO - 'NO_EM_RESTART': '1', 14:40:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:00 INFO - 'PWD': '/builds/slave/test', 14:40:00 INFO - 'SHELL': '/bin/bash', 14:40:00 INFO - 'SHLVL': '1', 14:40:00 INFO - 'TERM': 'linux', 14:40:00 INFO - 'TMOUT': '86400', 14:40:00 INFO - 'USER': 'cltbld', 14:40:00 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464643868.857785-1470080577', 14:40:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:00 INFO - '_': '/tools/buildbot/bin/python'} 14:40:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:40:00 INFO - Running setup.py (path:/tmp/pip-ObXinV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:40:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:40:00 INFO - Running setup.py (path:/tmp/pip-uJPP_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:40:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:40:00 INFO - Running setup.py (path:/tmp/pip-UT3pke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:40:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:40:00 INFO - Running setup.py (path:/tmp/pip-U1vPn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:40:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:40:00 INFO - Running setup.py (path:/tmp/pip-ZHq_Op-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:40:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:40:00 INFO - Running setup.py (path:/tmp/pip-SuAW0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:40:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:40:00 INFO - Running setup.py (path:/tmp/pip-IAaB6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:40:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:40:00 INFO - Running setup.py (path:/tmp/pip-ORO4fU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:40:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:40:00 INFO - Running setup.py (path:/tmp/pip-mcBmAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:40:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:40:00 INFO - Running setup.py (path:/tmp/pip-wIWbWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:40:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:40:00 INFO - Running setup.py (path:/tmp/pip-Xd_z4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:40:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:40:01 INFO - Running setup.py (path:/tmp/pip-vbX4YX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:40:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:40:01 INFO - Running setup.py (path:/tmp/pip-uNAGOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:40:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:40:01 INFO - Running setup.py (path:/tmp/pip-N1NE3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:40:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:40:01 INFO - Running setup.py (path:/tmp/pip-KXTMGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:40:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:40:01 INFO - Running setup.py (path:/tmp/pip-m56J0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:40:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:40:01 INFO - Running setup.py (path:/tmp/pip-bNBI1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:40:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:40:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:40:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:40:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:40:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:40:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:40:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:40:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:03 INFO - Downloading blessings-1.6.tar.gz 14:40:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:40:03 INFO - Installing collected packages: blessings 14:40:03 INFO - Running setup.py install for blessings 14:40:03 INFO - Successfully installed blessings 14:40:03 INFO - Cleaning up... 14:40:03 INFO - Return code: 0 14:40:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:40:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:40:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:40:04 INFO - Reading from file tmpfile_stdout 14:40:04 INFO - Current package versions: 14:40:04 INFO - argparse == 1.2.1 14:40:04 INFO - blessings == 1.6 14:40:04 INFO - blobuploader == 1.2.4 14:40:04 INFO - docopt == 0.6.1 14:40:04 INFO - manifestparser == 1.1 14:40:04 INFO - mozInstall == 1.12 14:40:04 INFO - mozcrash == 0.17 14:40:04 INFO - mozdebug == 0.1 14:40:04 INFO - mozdevice == 0.48 14:40:04 INFO - mozfile == 1.2 14:40:04 INFO - mozhttpd == 0.7 14:40:04 INFO - mozinfo == 0.9 14:40:04 INFO - mozleak == 0.1 14:40:04 INFO - mozlog == 3.1 14:40:04 INFO - moznetwork == 0.27 14:40:04 INFO - mozprocess == 0.22 14:40:04 INFO - mozprofile == 0.28 14:40:04 INFO - mozrunner == 6.11 14:40:04 INFO - mozscreenshot == 0.1 14:40:04 INFO - mozsystemmonitor == 0.0 14:40:04 INFO - moztest == 0.7 14:40:04 INFO - mozversion == 1.4 14:40:04 INFO - psutil == 3.1.1 14:40:04 INFO - requests == 1.2.3 14:40:04 INFO - wsgiref == 0.1.2 14:40:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:40:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:40:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:04 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 0x7f6fe0e3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe865a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf15410>, '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 0xf16310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf167a0>, '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': '33d5923976266a1c518c4bf7000001ab-1464643868.857785-1470080577', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:40:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:40:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:40:04 INFO - Using env: {'DISPLAY': ':0', 14:40:04 INFO - 'HOME': '/home/cltbld', 14:40:04 INFO - 'LANG': 'en_US.UTF-8', 14:40:04 INFO - 'LANGUAGE': 'en_US:en', 14:40:04 INFO - 'LOGNAME': 'cltbld', 14:40:04 INFO - 'MAIL': '/var/mail/cltbld', 14:40:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:04 INFO - 'MOZ_NO_REMOTE': '1', 14:40:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:04 INFO - 'NO_EM_RESTART': '1', 14:40:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:04 INFO - 'PWD': '/builds/slave/test', 14:40:04 INFO - 'SHELL': '/bin/bash', 14:40:04 INFO - 'SHLVL': '1', 14:40:04 INFO - 'TERM': 'linux', 14:40:04 INFO - 'TMOUT': '86400', 14:40:04 INFO - 'USER': 'cltbld', 14:40:04 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464643868.857785-1470080577', 14:40:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:04 INFO - '_': '/tools/buildbot/bin/python'} 14:40:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:40:04 INFO - Cleaning up... 14:40:04 INFO - Return code: 0 14:40:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:40:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:40:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6fe0e3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe865a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf15410>, '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 0xf16310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf167a0>, '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': '33d5923976266a1c518c4bf7000001ab-1464643868.857785-1470080577', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:40:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:40:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:40:04 INFO - Using env: {'DISPLAY': ':0', 14:40:04 INFO - 'HOME': '/home/cltbld', 14:40:04 INFO - 'LANG': 'en_US.UTF-8', 14:40:04 INFO - 'LANGUAGE': 'en_US:en', 14:40:04 INFO - 'LOGNAME': 'cltbld', 14:40:04 INFO - 'MAIL': '/var/mail/cltbld', 14:40:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:04 INFO - 'MOZ_NO_REMOTE': '1', 14:40:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:04 INFO - 'NO_EM_RESTART': '1', 14:40:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:04 INFO - 'PWD': '/builds/slave/test', 14:40:04 INFO - 'SHELL': '/bin/bash', 14:40:04 INFO - 'SHLVL': '1', 14:40:04 INFO - 'TERM': 'linux', 14:40:04 INFO - 'TMOUT': '86400', 14:40:04 INFO - 'USER': 'cltbld', 14:40:04 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464643868.857785-1470080577', 14:40:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:04 INFO - '_': '/tools/buildbot/bin/python'} 14:40:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:04 INFO - Downloading/unpacking jsonschema 14:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:40:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:40:06 INFO - Downloading/unpacking functools32 (from jsonschema) 14:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:40:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:06 INFO - Downloading functools32-3.2.3-2.tar.gz 14:40:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:40:06 INFO - warning: no files found matching '*.txt' 14:40:06 INFO - no previously-included directories found matching 'build' 14:40:06 INFO - no previously-included directories found matching 'dist' 14:40:06 INFO - no previously-included directories found matching '.git*' 14:40:06 INFO - Installing collected packages: jsonschema, functools32 14:40:06 INFO - Running setup.py install for functools32 14:40:06 INFO - warning: no files found matching '*.txt' 14:40:06 INFO - no previously-included directories found matching 'build' 14:40:06 INFO - no previously-included directories found matching 'dist' 14:40:06 INFO - no previously-included directories found matching '.git*' 14:40:06 INFO - Successfully installed jsonschema functools32 14:40:06 INFO - Cleaning up... 14:40:06 INFO - Return code: 0 14:40:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:40:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:40:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6fe0e3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe865a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf15410>, '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 0xf16310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf167a0>, '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': '33d5923976266a1c518c4bf7000001ab-1464643868.857785-1470080577', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:40:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:40:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:40:06 INFO - Using env: {'DISPLAY': ':0', 14:40:06 INFO - 'HOME': '/home/cltbld', 14:40:06 INFO - 'LANG': 'en_US.UTF-8', 14:40:06 INFO - 'LANGUAGE': 'en_US:en', 14:40:06 INFO - 'LOGNAME': 'cltbld', 14:40:06 INFO - 'MAIL': '/var/mail/cltbld', 14:40:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:06 INFO - 'MOZ_NO_REMOTE': '1', 14:40:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:06 INFO - 'NO_EM_RESTART': '1', 14:40:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:06 INFO - 'PWD': '/builds/slave/test', 14:40:06 INFO - 'SHELL': '/bin/bash', 14:40:06 INFO - 'SHLVL': '1', 14:40:06 INFO - 'TERM': 'linux', 14:40:06 INFO - 'TMOUT': '86400', 14:40:06 INFO - 'USER': 'cltbld', 14:40:06 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464643868.857785-1470080577', 14:40:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:06 INFO - '_': '/tools/buildbot/bin/python'} 14:40:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:07 INFO - Downloading/unpacking flake8 14:40: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 14:40: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 14:40: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 14:40: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 14:40: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 14:40: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 14:40:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:40:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:40: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 14:40: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 14:40: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 14:40: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 14:40: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 14:40: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 14:40:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:40:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:40:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:40:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:40:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:40:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:40:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:40:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:40:09 INFO - no previously-included directories found matching 'docs/_build' 14:40:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:40:09 INFO - Running setup.py install for pep8 14:40:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:40:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:40:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:40:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:40:09 INFO - no previously-included directories found matching 'docs/_build' 14:40:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:40:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:40:09 INFO - Cleaning up... 14:40:09 INFO - Return code: 0 14:40:09 INFO - Running post-action listener: _resource_record_post_action 14:40:09 INFO - Running post-action listener: _start_resource_monitoring 14:40:09 INFO - Starting resource monitoring. 14:40:09 INFO - ##### 14:40:09 INFO - ##### Running install step. 14:40:09 INFO - ##### 14:40:09 INFO - Running pre-action listener: _resource_record_pre_action 14:40:09 INFO - Running main action method: install 14:40:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:40:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:40:10 INFO - Reading from file tmpfile_stdout 14:40:10 INFO - Detecting whether we're running mozinstall >=1.0... 14:40:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:40:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:40:10 INFO - Reading from file tmpfile_stdout 14:40:10 INFO - Output received: 14:40:10 INFO - Usage: mozinstall [options] installer 14:40:10 INFO - Options: 14:40:10 INFO - -h, --help show this help message and exit 14:40:10 INFO - -d DEST, --destination=DEST 14:40:10 INFO - Directory to install application into. [default: 14:40:10 INFO - "/builds/slave/test"] 14:40:10 INFO - --app=APP Application being installed. [default: firefox] 14:40:10 INFO - mkdir: /builds/slave/test/build/application 14:40:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:40:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:40:27 INFO - Reading from file tmpfile_stdout 14:40:27 INFO - Output received: 14:40:27 INFO - /builds/slave/test/build/application/firefox/firefox 14:40:27 INFO - Running post-action listener: _resource_record_post_action 14:40:27 INFO - ##### 14:40:27 INFO - ##### Running run-tests step. 14:40:27 INFO - ##### 14:40:27 INFO - Running pre-action listener: _resource_record_pre_action 14:40:27 INFO - Running main action method: run_tests 14:40:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:40:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:40:27 INFO - Python 2.7.3 14:40:27 INFO - Return code: 0 14:40:27 INFO - grabbing minidump binary from tooltool 14:40:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:40:27 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 0xf15410>, '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 0xf16310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf167a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:40:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:40:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:40:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:40:27 INFO - Return code: 0 14:40:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:40:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:40:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:40:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:40:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:40:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:40:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:40:34 INFO - Return code: 0 14:40:34 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/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 14:40:34 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/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --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 14:40:34 INFO - Using env: {'DISPLAY': ':0', 14:40:34 INFO - 'HOME': '/home/cltbld', 14:40:34 INFO - 'LANG': 'en_US.UTF-8', 14:40:34 INFO - 'LANGUAGE': 'en_US:en', 14:40:34 INFO - 'LOGNAME': 'cltbld', 14:40:34 INFO - 'MAIL': '/var/mail/cltbld', 14:40:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:40:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:40:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:34 INFO - 'MOZ_NO_REMOTE': '1', 14:40:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:40:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:34 INFO - 'NO_EM_RESTART': '1', 14:40:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:34 INFO - 'PWD': '/builds/slave/test', 14:40:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:40:34 INFO - 'SHELL': '/bin/bash', 14:40:34 INFO - 'SHLVL': '1', 14:40:34 INFO - 'TERM': 'linux', 14:40:34 INFO - 'TMOUT': '86400', 14:40:34 INFO - 'USER': 'cltbld', 14:40:34 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464643868.857785-1470080577', 14:40:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:34 INFO - '_': '/tools/buildbot/bin/python'} 14:40:34 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/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 14:40:35 INFO - mozversion application_buildid: 20160530120549 14:40:35 INFO - mozversion application_changeset: 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 14:40:35 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:40:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:40:35 INFO - mozversion application_name: Firefox 14:40:35 INFO - mozversion application_remotingname: firefox-dev 14:40:35 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:40:35 INFO - mozversion application_vendor: Mozilla 14:40:35 INFO - mozversion application_version: 48.0a2 14:40:35 INFO - mozversion platform_buildid: 20160530120549 14:40:35 INFO - mozversion platform_changeset: 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 14:40:35 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:40:35 INFO - mozversion platform_version: 48.0a2 14:40:35 INFO - using testdate: 1464644435 14:40:35 INFO - actual date: 1464644435 14:40:35 INFO - starting webserver on 'localhost:39145' 14:40:35 INFO - SUITE-START | Running 2 tests 14:40:35 INFO - TEST-START | dromaeo_css 14:40:35 INFO - operating with platform_type : linux_ 14:40:35 INFO - Initialising browser for dromaeo_css test... 14:40:35 INFO - TEST-INFO | started process 31211 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAM5inh/profile http://localhost:39145/getInfo.html) 14:40:42 INFO - PROCESS | 31211 | __metrics Screen width/height:1600/1200 14:40:42 INFO - PROCESS | 31211 | colorDepth:24 14:40:42 INFO - PROCESS | 31211 | Browser inner width/height: 1024/697 14:40:42 INFO - PROCESS | 31211 | __metrics 14:40:44 ERROR - PROCESS | 31211 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:40:45 INFO - TEST-INFO | 31211: exit 0 14:40:45 INFO - Browser initialized. 14:40:45 INFO - Running cycle 1/1 for dromaeo_css test... 14:40:45 INFO - TEST-INFO | started process 31301 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAM5inh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:40:57 INFO - PROCESS | 31301 | RSS: Main: 141750272 14:40:57 INFO - PROCESS | 31301 | 14:41:48 INFO - PROCESS | 31301 | 1464644508449 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:43:56 INFO - PROCESS | 31301 | Cycle 1(1): loaded http://localhost:39145/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39145/tests/dromaeo/cssquery-ext.html) 14:43:57 INFO - PROCESS | 31301 | RSS: Main: 251310080 14:43:57 INFO - PROCESS | 31301 | 14:47:00 INFO - PROCESS | 31301 | Cycle 1(1): loaded http://localhost:39145/tests/dromaeo/cssquery-ext.html (next: http://localhost:39145/tests/dromaeo/cssquery-jquery.html) 14:47:00 INFO - PROCESS | 31301 | RSS: Main: 222732288 14:47:00 INFO - PROCESS | 31301 | 14:50:02 INFO - PROCESS | 31301 | Cycle 1(1): loaded http://localhost:39145/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39145/tests/dromaeo/cssquery-mootools.html) 14:50:02 INFO - PROCESS | 31301 | RSS: Main: 215949312 14:50:02 INFO - PROCESS | 31301 | 14:53:04 INFO - PROCESS | 31301 | Cycle 1(1): loaded http://localhost:39145/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39145/tests/dromaeo/cssquery-prototype.html) 14:53:05 INFO - PROCESS | 31301 | RSS: Main: 220024832 14:53:05 INFO - PROCESS | 31301 | 14:56:07 INFO - PROCESS | 31301 | Cycle 1(1): loaded http://localhost:39145/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39145/tests/dromaeo/cssquery-yui.html) 14:56:08 INFO - PROCESS | 31301 | RSS: Main: 209211392 14:56:08 INFO - PROCESS | 31301 | 14:59:10 INFO - PROCESS | 31301 | Cycle 1(1): loaded http://localhost:39145/tests/dromaeo/cssquery-yui.html (next: http://localhost:39145/tests/dromaeo/cssquery-dojo.html) 14:59:11 INFO - PROCESS | 31301 | RSS: Main: 245051392 14:59:11 INFO - PROCESS | 31301 | 14:59:11 INFO - PROCESS | 31301 | __start_tp_report 14:59:11 INFO - PROCESS | 31301 | _x_x_mozilla_page_load 14:59:11 INFO - PROCESS | 31301 | _x_x_mozilla_page_load_details 14:59:11 INFO - PROCESS | 31301 | |i|pagename|runs| 14:59:11 INFO - PROCESS | 31301 | |0;dojo.html;3361.7478689098316;3395.0324157615087;3411.76117671763;3420.3843308204546;3436.3642726095673;5610.943890561093;5619;5623.268975033245;5624.3813180550105;5626.099824028156;5536.307961504812;5599.356074051485;5608.046632072547;5617.831465056055;5619.185218143367;4886.535779100997;5076.822311219108;5128.230765385185;5185.481451854822;5214.243934629477;4995.850124496271;5022.472640372763;5031.622628302874;5033.6224783141415;5034.924476132861;4896.094222568819;5008.39899212095;5072.670276432039;5108.795648174068;5121.078205922932;5105.387353517564;5106.948930510703;5121.923171152435;5123.333966584358;5154.587632989371;4912.533309335643;4979.0788704089855;5023.296738456619;5044.697318160922;5046.899062018776;5441.945580544183;5463.617546771728;5492.945070549284;5512.476314750093;5513.42109078549;5973.850653733648;5985.820425387245;5986.610870293417;5988.490978266809;6016.067509535985;6024.789132380346;6046.395360463963;6052.983490507438;6067.9696252956555;6090.756369745205;5590.357108932484;5670.376258611549;5674.205611214434;5678.886422271614;5680.460356266148;5993.310769261503;6184.381561843869;6184.8763024739255;6187.566870319124;6191.9690401547705;5895.852603684856;5950.851228719317;5955.37468565803;5964.194833697396;5977.193078934288;5987.101934709828;5996.970015149896;5999.850003749942;6000.0699891516015;6000.969995149996;5834.766609335579;5948.821535353946;5954.047352423591;5957.106434034843;5958.6722730249385;5966.0454327307425;5969.373215812364;5972.820815375546;5976.462118409364;6006.699665016732;4543.045960348364;4550.954490455119;4552.931706024412;4552.954470455253;4582.014866803654;3946.4672269243283;4031.294523458383;4072.75563466193;4096.180763847243;4110.835566577363;5760.308762948389;5780.075187969905;5780.595358324961;5781.132830075522;5782.392848750905;6001.879962400728;6046.425589569072;6052.727627256784;6054.091886217015;6059.0608455689435;5536.474034966672;5728.885422291531;5759.424057594207;5806.970965145148;5808.535317174616;5142.202958541432;5145.871353216199;5147.2279158126585;5148.613853960968;5160.7419629018395;6196.287426945869;6245;6258.43674069336;6264.812055638338;6267.6866156691985;5871.236739224044;5914.970425147847;6002.609830361012;6003.7898673546215;6015.819525414157;6158.291796443466;6158.661273629814;6160.630362178284;6161.4146656067605;6214.475179992559;5918.408159184047;5922;5926.496247818984;5931.792387266425;5964.105384192232;5768.307803063659;5971.044632858721;6012.398760123952;6044.032954727222;6046.7278972445465;5823.563232757645;5853.882922341444;5877.588568800143;5881;5891;5659;5799.791552930599;5840.415958404125;5860.560457965585;5864.618799778001;5712.285964254468;5738.139279108167;5745.741441635053;5764.279465066867;5780.94219057804;5889.970550147222;5928.9407105928385;5931.3178984417345;5948.256467941507;5967.4629283362965;5565.220869078251;5691.800786972602;5807.157962095557;5809.622374545641;5812.33158186797 14:59:11 INFO - PROCESS | 31301 | |1;ext.html;681.1315572644877;690.88945768677;691.2672567078894;736.8010637127973;751.684292597109;32124.67875321249;39588.80205598975;40609.390859137064;40633.39049914254;40661.186776264454;43512.56487435125;43947.56052439474;44017.559824401746;44116;44259.77870110653;7889.684412623488;8831.911680883173;9009.95495022524;9011.909880901172;10452.216083793708;10482;10625.574977000912;10627.202959778047;10632.415217163052;10635.042846143846;10660.893391066107;10731.356118632868;10736.463176841165;10738.516766745515;10740.03339699427;8159.184081591793;10406.9479652602;10606.681799545988;10610.840837387444;10640.840387394195;10538.683839484751;10653.414062226575;10659.360438373646;10668.14654827612;10669.626563070255;41105;41649.1670166595;41663.375049374285;41672.79163604163;41785.58214417847;3776.1692427666144;3832.827522761482;3859.9228015439535;4088.2641124597562;4250.702450828443;34792.47811282833;35197.296054078775;35503;35602;37395;4690.788914498856;4729.952700472985;4793.18515852306;4823.252395878644;4830.299606557065;312157;316296;316561;316841.9999999977;317112;40900;41822.790886045375;68824;69554.65222673854;69942;39030;39110.21779564393;39135.21729565393;39272.21455570873;39369.80315098406;16748.916255418644;16935.91532042332;16938.153092345332;16938.23777929996;16945.661086778196;12366;12463.626091217096;12580.559680411325;12866.67833304175;13165.354330708662;9388.8591671125;9415.340926135104;9422.340436169403;9473.05269473061;9475.715728528156;3566.625504322009;3682.355587772129;3686.9262614747554;3699.611540788232;3758.624137586274;1163.831244469547;1164.6897240604321;1179.8112302031805;1188.085174415695;1204.6085022367765;33713.83143084318;34072.14819629529;34091;34167;35006.47490287648;1217.1193514008712;1294.4822071171418;1300.8048792680984;1301.531448678475;1304.1718508747015;17917.491551182844;18109;18180.45458636243;18267.451976440727;18323.90838045828;479147;481613;485686;487254;492352;64464;65907.67046164739;65930;65993;66026.66986665037;1507.4196434372845;1526.7633516804913;1539.7921280626972;1558.2676142213368;1651.4385109062976;32660.673393266712;33976;34032.229943460414;34385.48421773625;34732.30535389329;45197.77401112973;45234.32148517709;45300.77349613231;45304.77347613241;45445.318320224564;284611;285745;286991;287061;287080;28398;32687;33066.66933330636;33067.338653227285;33355.49966750549;49755.75122124366;50571;50871.74564127304;51086.48913510966;51347.74326128345;40948;41107.177856443304;41144.588554114074;42027;42991.785041074596;39486.80256598699;41368.37947430851;41974;42122.78938605287;42641.14717705567;43302.35046474243;43408.34887476754;44317;44500.777496112314;44600.776996114815;36316.81841590775;36943.26113477769;37184.81407592945;37376.439353410264;38252;28460.857695711387;28868.855655721585;29000.564991524723;29070.12789616315;29095.709042910148 14:59:11 INFO - PROCESS | 31301 | |2;jquery.html;429.1481409402336;437.50343360286087;447;448.41034040237105;460.1418354768358;19109.331173408933;19505.707414388795;19509.12208950597;19523.609527809454;19869;18878.433646990612;18974.146163422643;20562.588748225025;20674.586508269826;20705.68941465879;5687;5880.382559831199;5973.940260597382;5987.580869339148;6042.909356359658;4330.5669433056755;5872.148538461921;5987.730552125143;6274.309825919146;6555.77054803082;6487.540303431737;6548.607083575001;6563.442107420851;6567.967160164192;6569.080328753978;6344.968275158641;6460.709268082924;6538.280789113193;6558.409743123142;6576.375244351779;3925.3326934421216;4139.379093136024;5618.859528511779;5853.941460585383;5895.852603684899;22864.542709145724;22864.54270914589;23084;24153.637695434583;24528.632070518957;2498.612715029173;2503.5493611149986;2513.2711513661015;2558.1941688368292;2830.2924268932766;14992.70014599702;15088.094714317176;15148.697026059528;15265.23673816316;15577.454789082327;1967.5572996075769;2022.5247066939257;2040.0207900207836;2058.95882082359;2211.1818627107914;80579;81032;81776;83351;84094.57952710197;10686.893131068746;10917.672469825919;11222.887771122185;11462.48418821155;12240.81638775419;16052.357905683875;16093.839061609235;16239.675206495804;16241.187940602922;16256.268467918972;8954.597043133075;9091.181793638605;9098.545072746469;9099.954500227457;9155.359124861196;8998.325125615605;9032.729018129467;9062.773430664287;9113.589888455035;9171.266298696222;7028;7146.5354751941995;7200.783976480714;7205.675744591506;7215.60314182725;1840.570447009934;1956.2370675436591;2035.3792093411355;2071.2232912657755;2164.815990640813;1032.7727899862018;1099.279971618575;1099.4228030284005;1103.0734183285917;1162.9825552616717;18394.17226224823;18523.72214416785;18860.811391886178;19642.50893727668;20311.28910488126;1133.4219548030565;1134.2173900008968;1196.1507329795768;1206.0652993929775;1206.240068756695;11417.42912854354;11625.18623696333;11684.18210725241;11781.234219775688;11845.526178952745;538082;542472;543828;564336;568835;81157.18842811615;85374;86002.56998715091;87048;87098;1139.9715007124723;1154.509333533245;1155.318362166309;1157.6353448663644;1160.9013233875214;17591.29634814593;17592.73610895863;18133.36533221331;18153.45539633813;18377.90811045936;39839.20321593494;40224.396634051096;40521.1895762089;41213.79393103015;41292.79353603333;54582.45417545774;55163;55262.17106743482;55293.44706552883;55306.72346638402;9073.77315567116;9097.090290971115;9104.90895091067;9146.588403521724;9225.354225204172;11762.529498819951;13740.381682824096;14146.646333841736;14280.071795333686;14373.209473479059;12135.696607584881;12290.938545307574;12441.502339906303;12628.43172057278;12664.936675316932;12226.633201003984;12331.445084971378;12440.129190956908;12700.745985080432;12794;12631.431585578488;12651.873481265438;12886.48454061827;12978.221306721627;12986.545470908473;8655.56722163902;9027.187553119988;9129.908700912905;9319.301052421231;9585.808283834423;11336.14978876604;11567.132465064986;11640.650780476599;11889.881101188877;11994.520219191134 14:59:11 INFO - PROCESS | 31301 | |3;mootools.html;1332.9333533323331;1585.5481187861462;1609.0989046134162;1808.3218792952644;1931.4591914264001;8413.831723365529;8536.231739143475;8550.315974722023;8557.058723540405;8572.528510931896;8199.91800081999;8352.665893364257;8365.247127758501;8367.623456944437;8369.079401265872;2112.514121751998;2403.038784486202;2423.527412154635;2452.5708001099824;2460.360306320352;2424.806015518754;2435.5981263091567;2449.461118553915;2449.595816690253;2453.1659235859806;2311.919082832101;2387.5344307859973;2388.4387169015267;2389.032441861049;2389.426537630965;2099.9160033598714;2388.10446082719;2458.8155888308447;2461.0770960889668;2466.05057053035;2362.4920642061866;2405.7353691093967;2417.2627348658652;2417.9758202417925;2427.781499665021;8014.599270036475;8067.031956165298;8071.354291656653;8081.595920204025;8082.7171049013;5284.603654725873;5340.679559226459;5374.7850085996515;5380.892382152335;5426.67439953604;3496.4405695088662;3572.07126147201;3572.6605972432576;3573.803440810754;3664.59689434162;1103.5309993252836;1106.0985296982933;1115.263925808962;1185.5376403202758;1211.9818202726967;12570.937145314307;12610.558630447891;12616;12627.43176557057;12651.873481265253;4860.441049279378;4881.438634557071;4882.5605695487575;4887.242477416006;5009.674371165863;10607.469626518643;10609.9469502652;10629.25595208328;10645.254832161829;10650.520726567323;4860.489648586848;5529.336479622471;5546.528545073633;5564.248826408383;5568.916466253009;5026.095302845523;5055.7219352935945;5083.517065878736;5115.846524604268;5145.588352931756;4208.431861698693;4229.767362795014;4242.578736123433;4289.120730250291;4358.847440339573;1349.6086135020735;1392.6657602175608;1406.045596620698;1424.5370254667275;1436.8203974503188;970.3789574672215;1096.5887199549395;1099.9560017599206;1107.839363292318;1123.730304726876;6080.0879868019265;6190.783322583688;6251.093591429218;6252.718627661766;6299.559030867887;995.3977843404781;1002.3033991375924;1051.8211903976342;1067.631667074858;1091.5961094394966;4273.572642735701;4367;4368.6723495737315;4411.955880441219;4413.8234470621455;10245.282830201815;10701.892981070245;10704.839427408595;10899.400532970763;11036.227464077438;10803.675889723321;10880.347179169275;10927.071198948019;10931.508082136323;10967.341959482457;8334.458260213067;8461.280791132822;8505.10696376884;8520.57397130141;8563.871541926876;6065.484433823174;6090.390960904051;6145.754169833157;6161.291451483136;6256.655883926428;9727.124558789743;9864.457454840052;10013.849792253268;10025.248106391904;10038.096571308617;9905.752356191153;10096.394216346749;10164.136048435967;10356.275060745675;10361.067503924683;6373.74505019794;6540.901886471612;7122.074130363019;7527.661255243418;7681.1934746850775;8387.83224335522;8407.95796021016;8451.915480845359;8452.95773521153;8470;7495.812604684927;7742.496737712031;7762.961185194038;7830.725924592612;7852.842943140991;7387.7783666490095;7403.444741644506;7403.962980185064;7510.061242344707;7512.13610434807;7140.250273721393;7203.783886483414;7301.63491825396;7324.5971471567445;7346.742863999734;5376.112941364788;5419.701916394636;5499.092649712753;5575.386707462095;5585.245991791056;5238.842834714965;5334.653247538898;5413.10683737179;5545.334559852843;5590.2453168821685 14:59:11 INFO - PROCESS | 31301 | |4;prototype.html;352.2831038835969;354.33562071116665;360.30461209864967;363.358671944019;364.14062811764234;6282;6286;6321.083442900783;6323.5889667171605;6356.141920840685;6266.686665666722;6270.623762574237;6280.717367718452;6288.654124023177;6301.117843501914;4559;4679.064187162564;4780.067886762083;4819.156647586676;4825.107355139293;4787.521247875219;4795.304680821278;4815.651617547092;4821.228603423453;4824.614030877521;4596.149712303235;4776.235802271637;4778.044391121773;4780.067886762083;4783.808647654089;4621.976890115561;4705.988212534305;4706.5293470653005;4726.2201736713405;4760.738159401231;4195.202911446815;4210.789460526961;4211.91576168478;4219.050713589449;4224.852130175429;6012.669303188323;6022.187004754346;6029.366916473795;6034.6982650867285;6039.275286965549;5546.639468434539;5550.084236101038;5558.610897237195;5562.638428502134;5566.332040155166;6425.389587989133;6563.212414510242;6571.67141642916;6572.868542629169;6578.473722102221;4611.492735799093;4624.28323609841;4626.398568186148;4646.4424269087585;4662.3705799716945;6857.691403886787;6878.105846240007;6882.174139103289;6887.586744795329;6893.20728116268;4716.976415117902;4719.4100737407825;4720.173969555382;4720.527947205252;4727.3854398927915;4796.06476737033;4799.136155492045;4801.975990120097;4805.471398146201;4805.711657300573;5501.064818980783;5508.614396992172;5509.614326997152;5511.22842802008;5512.39363670004;6486.35136486357;6621.503387245976;6626.072349871022;6631.303713110054;6634.900476492857;1654.3465331194352;1670.0898010584017;1673.8075121361198;1675.8240384759424;1679.1016806008727;1063.542676649033;1088.950997205112;1114.9052330551995;1117.9944100279447;1128.3511980611017;6339.778107766206;6510.934890651033;6533.18335208099;6537.673116344164;6550.868982620321;6935.791926242221;6977.581345119309;6978.406835419046;6981;6982.860342793116;6492.870142597121;6494.6103233806125;6505.284418713938;6510.414062734377;6526.053722210253;3671.1372827385544;3705.203381273039;3710;3714.2200137971327;3715.9442608360896;6985.091938048021;7168.713251469882;7178.856422871513;7188.460865435113;7191.244919283505;6985.5808651481075;6997.370236678723;7004.15950085993;7008.369246767714;7030.050943122613;7157.069580954442;7167.283271672895;7170.282971702893;7174.748883789042;7181.461390395742;6849.794506164823;6874.175098988154;6883.208431030295;6885.380315771405;6890.621015844176;6624.6025238485845;6786.660666966731;6787.21946976104;6801.727930882709;6803.93196068033;7133.750318738819;7151.892721609284;7156.928430715626;7169.462290328351;7179.1026121734785;4818.927716084331;4820.927686084781;4827.396575428072;4829.710217386968;4832.613390928647;6879.346462086094;6881.311868813079;6882.931170688229;6889.896651550131;6892.379685828299;6566.507511936719;6676.49926255523;6685.264620891795;6701.564398314094;6702.798916032527;6637.734490620321;6666.566673166229;6672.6997285121315;6673.499487538357;6680.331966803476;6548.508861835477;6551.344865513411;6558.311377305315;6565.719684661445;6568.47452203813;6698.9665051676375;6715.05989161508;6729.495287853332;6736.191657001191;6737.528373013842;6289.9056514153235;6378.6810659467765;6408.967955160194;6530.183727034121;6544.934550654623 14:59:11 INFO - PROCESS | 31301 | |5;yui.html;871.9476831390117;904.8868891388577;923.7228831350593;928.1368327455464;952.49041762657;14982.175980321092;15136;15162.924185379057;15257.771133432994;15274.770878436831;14522.273886305695;15623.453179138703;15970.84029159708;16132;16183.271752771125;742.940564754821;895.3956079646246;911.1799380557485;911.2345629671108;932.93935894167;923.0815338737965;923.8198551282503;931.6413180925358;932.9626814927394;933.2207606648423;941.3128416256103;951.1297163095759;951.3863558005082;951.4006176109076;952.2286947572454;790.4782843323408;930.2139691960283;937.5687183895416;948.9240860731124;951.8619800129012;692.2834865913755;696.4915611603507;697.3967518096861;697.4420463629127;700.7757517594372;14777.187254700988;14789.630259243497;14831.629209269746;14852.70294594102;14947.327370268364;13645.38595763193;13881.861181388158;14125.78811317831;14236.572902812932;14464.927675361556;12192.817107743302;12232;12325.260484370876;12369.443375048144;12382.442790074469;3916.373380259145;3976.363781794928;4031.2743706132883;4061.817218225187;4093.6111069448357;59040.70479647617;59049;59424.405755942316;59425.702871485795;59528.70235648837;11215.1027917768;11552.595659152057;11568.595099171489;11892.227005244631;12055.87944120565;21953.67069493959;22467.775322246896;22509.099636014376;22541.43646408853;22562.210322638628;8552.871706924401;8612.354073444516;9204.493752843659;9235.538223088819;9336.95331523338;4762.738049407316;4842.854714358575;4944.505549445027;4968.627352948543;5074.4671809460215;3747.6814470769746;3769.7361184716806;3797.981010094987;3799.297130030953;3807.3908174691915;635.4249404289126;636.2015670333701;642.1331202876173;656.6158797103652;657.9867004812535;727.5755082620449;791.4894892794116;822.6051495282178;833.2750507058897;843.7426584891667;9923.751906202402;10212.387256764468;10214;10279.94860025695;10293.691189264184;575.683374144219;623.8783437229697;635.3582881289931;649.3733547127046;651.837040739815;4564.520725323793;4830.058138662927;4844.176489996709;4854.490278520704;4884.072026314989;59782.70108649516;61482.385176148564;61810.69094654498;61900;67478.32521674818;56715.43284567101;57337.42662573404;58331;58566.41433585695;58998.70500647555;51594.93620255223;52206.21690674567;52451.21323180155;52667;53636.46363536393;10186.541605627914;10230.590776368861;10283.84574231402;10286.537105830404;10313.845292320771;38181;39225.21549568936;39922.600773991886;40697.79651101844;41750;47949.520504794506;48045;48412.273815893495;48539;48552.271715924995;12421.31682757457;12750;12914.09601327898;12992.259168606879;13093.476260949456;13666.863331366956;13838.169709817443;14040.438382464996;14338.068025578305;14667.48663796762;13005.47978080904;13461.259630720013;13582.796258056334;13869.306534673427;14011.08927919682;13137.408816603085;13492.797608035691;13513.662158445724;14217.431302747775;14247.145171289756;13260.204387736381;13376.665583360495;13753.38109785042;13757.31213439304;13805.861941380457;10763.515641796295;11205.159613029218;11887.465064071965;11939.522419103487;11965.282083075042;11432;11592.88407115918;11652.708682283012;11661.6501504955;11846.348450835287 14:59:11 INFO - PROCESS | 31301 | __end_tp_report 14:59:11 INFO - PROCESS | 31301 | __start_cc_report 14:59:11 INFO - PROCESS | 31301 | _x_x_mozilla_cycle_collect,801 14:59:11 INFO - PROCESS | 31301 | __end_cc_report 14:59:11 INFO - PROCESS | 31301 | __startTimestamp1464645551127__endTimestamp 14:59:11 INFO - PROCESS | 31301 | 14:59:11 INFO - PROCESS | 31301 | ------- Summary: start ------- 14:59:11 INFO - PROCESS | 31301 | Number of tests: 6 14:59:11 INFO - PROCESS | 31301 | 14:59:11 INFO - PROCESS | 31301 | [#0] dojo.html Cycles:165 Average:5568.97 Median:5799.79 stddev:626.69 (10.8%) stddev-sans-first:604.22 14:59:11 INFO - PROCESS | 31301 | Values: 3361.7 3395.0 3411.8 3420.4 3436.4 5610.9 5619.0 5623.3 5624.4 5626.1 5536.3 5599.4 5608.0 5617.8 5619.2 4886.5 5076.8 5128.2 5185.5 5214.2 4995.9 5022.5 5031.6 5033.6 5034.9 4896.1 5008.4 5072.7 5108.8 5121.1 5105.4 5106.9 5121.9 5123.3 5154.6 4912.5 4979.1 5023.3 5044.7 5046.9 5441.9 5463.6 5492.9 5512.5 5513.4 5973.9 5985.8 5986.6 5988.5 6016.1 6024.8 6046.4 6053.0 6068.0 6090.8 5590.4 5670.4 5674.2 5678.9 5680.5 5993.3 6184.4 6184.9 6187.6 6192.0 5895.9 5950.9 5955.4 5964.2 5977.2 5987.1 5997.0 5999.9 6000.1 6001.0 5834.8 5948.8 5954.0 5957.1 5958.7 5966.0 5969.4 5972.8 5976.5 6006.7 4543.0 4551.0 4552.9 4553.0 4582.0 3946.5 4031.3 4072.8 4096.2 4110.8 5760.3 5780.1 5780.6 5781.1 5782.4 6001.9 6046.4 6052.7 6054.1 6059.1 5536.5 5728.9 5759.4 5807.0 5808.5 5142.2 5145.9 5147.2 5148.6 5160.7 6196.3 6245.0 6258.4 6264.8 6267.7 5871.2 5915.0 6002.6 6003.8 6015.8 6158.3 6158.7 6160.6 6161.4 6214.5 5918.4 5922.0 5926.5 5931.8 5964.1 5768.3 5971.0 6012.4 6044.0 6046.7 5823.6 5853.9 5877.6 5881.0 5891.0 5659.0 5799.8 5840.4 5860.6 5864.6 5712.3 5738.1 5745.7 5764.3 5780.9 5890.0 5928.9 5931.3 5948.3 5967.5 5565.2 5691.8 5807.2 5809.6 5812.3 14:59:11 INFO - PROCESS | 31301 | 14:59:11 INFO - PROCESS | 31301 | [#1] ext.html Cycles:180 Average:53481.83 Median:20442.21 stddev:98465.97 (481.7%) stddev-sans-first:98662.39 14:59:11 INFO - PROCESS | 31301 | Values: 681.1 690.9 691.3 736.8 751.7 32124.7 39588.8 40609.4 40633.4 40661.2 43512.6 43947.6 44017.6 44116.0 44259.8 7889.7 8831.9 9010.0 9011.9 10452.2 10482.0 10625.6 10627.2 10632.4 10635.0 10660.9 10731.4 10736.5 10738.5 10740.0 8159.2 10406.9 10606.7 10610.8 10640.8 10538.7 10653.4 10659.4 10668.1 10669.6 41105.0 41649.2 41663.4 41672.8 41785.6 3776.2 3832.8 3859.9 4088.3 4250.7 34792.5 35197.3 35503.0 35602.0 37395.0 4690.8 4730.0 4793.2 4823.3 4830.3 312157.0 316296.0 316561.0 316842.0 317112.0 40900.0 41822.8 68824.0 69554.7 69942.0 39030.0 39110.2 39135.2 39272.2 39369.8 16748.9 16935.9 16938.2 16938.2 16945.7 12366.0 12463.6 12580.6 12866.7 13165.4 9388.9 9415.3 9422.3 9473.1 9475.7 3566.6 3682.4 3686.9 3699.6 3758.6 1163.8 1164.7 1179.8 1188.1 1204.6 33713.8 34072.1 34091.0 34167.0 35006.5 1217.1 1294.5 1300.8 1301.5 1304.2 17917.5 18109.0 18180.5 18267.5 18323.9 479147.0 481613.0 485686.0 487254.0 492352.0 64464.0 65907.7 65930.0 65993.0 66026.7 1507.4 1526.8 1539.8 1558.3 1651.4 32660.7 33976.0 34032.2 34385.5 34732.3 45197.8 45234.3 45300.8 45304.8 45445.3 284611.0 285745.0 286991.0 287061.0 287080.0 28398.0 32687.0 33066.7 33067.3 33355.5 49755.8 50571.0 50871.7 51086.5 51347.7 40948.0 41107.2 41144.6 42027.0 42991.8 39486.8 41368.4 41974.0 42122.8 42641.1 43302.4 43408.3 44317.0 44500.8 44600.8 36316.8 36943.3 37184.8 37376.4 38252.0 28460.9 28868.9 29000.6 29070.1 29095.7 14:59:11 INFO - PROCESS | 31301 | 14:59:11 INFO - PROCESS | 31301 | [#2] jquery.html Cycles:180 Average:31007.40 Median:22864.54 stddev:90405.68 (395.4%) stddev-sans-first:90630.13 14:59:11 INFO - PROCESS | 31301 | Values: 429.1 437.5 447.0 448.4 460.1 19109.3 19505.7 19509.1 19523.6 19869.0 18878.4 18974.1 20562.6 20674.6 20705.7 5687.0 5880.4 5973.9 5987.6 6042.9 4330.6 5872.1 5987.7 6274.3 6555.8 6487.5 6548.6 6563.4 6568.0 6569.1 6345.0 6460.7 6538.3 6558.4 6576.4 3925.3 4139.4 5618.9 5853.9 5895.9 22864.5 22864.5 23084.0 24153.6 24528.6 2498.6 2503.5 2513.3 2558.2 2830.3 14992.7 15088.1 15148.7 15265.2 15577.5 1967.6 2022.5 2040.0 2059.0 2211.2 80579.0 81032.0 81776.0 83351.0 84094.6 10686.9 10917.7 11222.9 11462.5 12240.8 16052.4 16093.8 16239.7 16241.2 16256.3 8954.6 9091.2 9098.5 9100.0 9155.4 8998.3 9032.7 9062.8 9113.6 9171.3 7028.0 7146.5 7200.8 7205.7 7215.6 1840.6 1956.2 2035.4 2071.2 2164.8 1032.8 1099.3 1099.4 1103.1 1163.0 18394.2 18523.7 18860.8 19642.5 20311.3 1133.4 1134.2 1196.2 1206.1 1206.2 11417.4 11625.2 11684.2 11781.2 11845.5 538082.0 542472.0 543828.0 564336.0 568835.0 81157.2 85374.0 86002.6 87048.0 87098.0 1140.0 1154.5 1155.3 1157.6 1160.9 17591.3 17592.7 18133.4 18153.5 18377.9 39839.2 40224.4 40521.2 41213.8 41292.8 54582.5 55163.0 55262.2 55293.4 55306.7 9073.8 9097.1 9104.9 9146.6 9225.4 11762.5 13740.4 14146.6 14280.1 14373.2 12135.7 12290.9 12441.5 12628.4 12664.9 12226.6 12331.4 12440.1 12700.7 12794.0 12631.4 12651.9 12886.5 12978.2 12986.5 8655.6 9027.2 9129.9 9319.3 9585.8 11336.1 11567.1 11640.7 11889.9 11994.5 14:59:11 INFO - PROCESS | 31301 | 14:59:11 INFO - PROCESS | 31301 | [#3] mootools.html Cycles:180 Average:5856.53 Median:4860.47 stddev:3226.39 (66.4%) stddev-sans-first:3217.52 14:59:11 INFO - PROCESS | 31301 | Values: 1332.9 1585.5 1609.1 1808.3 1931.5 8413.8 8536.2 8550.3 8557.1 8572.5 8199.9 8352.7 8365.2 8367.6 8369.1 2112.5 2403.0 2423.5 2452.6 2460.4 2424.8 2435.6 2449.5 2449.6 2453.2 2311.9 2387.5 2388.4 2389.0 2389.4 2099.9 2388.1 2458.8 2461.1 2466.1 2362.5 2405.7 2417.3 2418.0 2427.8 8014.6 8067.0 8071.4 8081.6 8082.7 5284.6 5340.7 5374.8 5380.9 5426.7 3496.4 3572.1 3572.7 3573.8 3664.6 1103.5 1106.1 1115.3 1185.5 1212.0 12570.9 12610.6 12616.0 12627.4 12651.9 4860.4 4881.4 4882.6 4887.2 5009.7 10607.5 10609.9 10629.3 10645.3 10650.5 4860.5 5529.3 5546.5 5564.2 5568.9 5026.1 5055.7 5083.5 5115.8 5145.6 4208.4 4229.8 4242.6 4289.1 4358.8 1349.6 1392.7 1406.0 1424.5 1436.8 970.4 1096.6 1100.0 1107.8 1123.7 6080.1 6190.8 6251.1 6252.7 6299.6 995.4 1002.3 1051.8 1067.6 1091.6 4273.6 4367.0 4368.7 4412.0 4413.8 10245.3 10701.9 10704.8 10899.4 11036.2 10803.7 10880.3 10927.1 10931.5 10967.3 8334.5 8461.3 8505.1 8520.6 8563.9 6065.5 6090.4 6145.8 6161.3 6256.7 9727.1 9864.5 10013.8 10025.2 10038.1 9905.8 10096.4 10164.1 10356.3 10361.1 6373.7 6540.9 7122.1 7527.7 7681.2 8387.8 8408.0 8451.9 8453.0 8470.0 7495.8 7742.5 7763.0 7830.7 7852.8 7387.8 7403.4 7404.0 7510.1 7512.1 7140.3 7203.8 7301.6 7324.6 7346.7 5376.1 5419.7 5499.1 5575.4 5585.2 5238.8 5334.7 5413.1 5545.3 5590.2 14:59:11 INFO - PROCESS | 31301 | 14:59:11 INFO - PROCESS | 31301 | [#4] prototype.html Cycles:180 Average:5576.25 Median:6347.96 stddev:1686.02 (26.6%) stddev-sans-first:1644.52 14:59:11 INFO - PROCESS | 31301 | Values: 352.3 354.3 360.3 363.4 364.1 6282.0 6286.0 6321.1 6323.6 6356.1 6266.7 6270.6 6280.7 6288.7 6301.1 4559.0 4679.1 4780.1 4819.2 4825.1 4787.5 4795.3 4815.7 4821.2 4824.6 4596.1 4776.2 4778.0 4780.1 4783.8 4622.0 4706.0 4706.5 4726.2 4760.7 4195.2 4210.8 4211.9 4219.1 4224.9 6012.7 6022.2 6029.4 6034.7 6039.3 5546.6 5550.1 5558.6 5562.6 5566.3 6425.4 6563.2 6571.7 6572.9 6578.5 4611.5 4624.3 4626.4 4646.4 4662.4 6857.7 6878.1 6882.2 6887.6 6893.2 4717.0 4719.4 4720.2 4720.5 4727.4 4796.1 4799.1 4802.0 4805.5 4805.7 5501.1 5508.6 5509.6 5511.2 5512.4 6486.4 6621.5 6626.1 6631.3 6634.9 1654.3 1670.1 1673.8 1675.8 1679.1 1063.5 1089.0 1114.9 1118.0 1128.4 6339.8 6510.9 6533.2 6537.7 6550.9 6935.8 6977.6 6978.4 6981.0 6982.9 6492.9 6494.6 6505.3 6510.4 6526.1 3671.1 3705.2 3710.0 3714.2 3715.9 6985.1 7168.7 7178.9 7188.5 7191.2 6985.6 6997.4 7004.2 7008.4 7030.1 7157.1 7167.3 7170.3 7174.7 7181.5 6849.8 6874.2 6883.2 6885.4 6890.6 6624.6 6786.7 6787.2 6801.7 6803.9 7133.8 7151.9 7156.9 7169.5 7179.1 4818.9 4820.9 4827.4 4829.7 4832.6 6879.3 6881.3 6882.9 6889.9 6892.4 6566.5 6676.5 6685.3 6701.6 6702.8 6637.7 6666.6 6672.7 6673.5 6680.3 6548.5 6551.3 6558.3 6565.7 6568.5 6699.0 6715.1 6729.5 6736.2 6737.5 6289.9 6378.7 6409.0 6530.2 6544.9 14:59:11 INFO - PROCESS | 31301 | 14:59:11 INFO - PROCESS | 31301 | [#5] yui.html Cycles:180 Average:15888.97 Median:22379.81 stddev:18031.82 (80.6%) stddev-sans-first:18047.14 14:59:11 INFO - PROCESS | 31301 | Values: 871.9 904.9 923.7 928.1 952.5 14982.2 15136.0 15162.9 15257.8 15274.8 14522.3 15623.5 15970.8 16132.0 16183.3 742.9 895.4 911.2 911.2 932.9 923.1 923.8 931.6 933.0 933.2 941.3 951.1 951.4 951.4 952.2 790.5 930.2 937.6 948.9 951.9 692.3 696.5 697.4 697.4 700.8 14777.2 14789.6 14831.6 14852.7 14947.3 13645.4 13881.9 14125.8 14236.6 14464.9 12192.8 12232.0 12325.3 12369.4 12382.4 3916.4 3976.4 4031.3 4061.8 4093.6 59040.7 59049.0 59424.4 59425.7 59528.7 11215.1 11552.6 11568.6 11892.2 12055.9 21953.7 22467.8 22509.1 22541.4 22562.2 8552.9 8612.4 9204.5 9235.5 9337.0 4762.7 4842.9 4944.5 4968.6 5074.5 3747.7 3769.7 3798.0 3799.3 3807.4 635.4 636.2 642.1 656.6 658.0 727.6 791.5 822.6 833.3 843.7 9923.8 10212.4 10214.0 10279.9 10293.7 575.7 623.9 635.4 649.4 651.8 4564.5 4830.1 4844.2 4854.5 4884.1 59782.7 61482.4 61810.7 61900.0 67478.3 56715.4 57337.4 58331.0 58566.4 58998.7 51594.9 52206.2 52451.2 52667.0 53636.5 10186.5 10230.6 10283.8 10286.5 10313.8 38181.0 39225.2 39922.6 40697.8 41750.0 47949.5 48045.0 48412.3 48539.0 48552.3 12421.3 12750.0 12914.1 12992.3 13093.5 13666.9 13838.2 14040.4 14338.1 14667.5 13005.5 13461.3 13582.8 13869.3 14011.1 13137.4 13492.8 13513.7 14217.4 14247.1 13260.2 13376.7 13753.4 13757.3 13805.9 10763.5 11205.2 11887.5 11939.5 11965.3 11432.0 11592.9 11652.7 11661.7 11846.3 14:59:11 INFO - PROCESS | 31301 | -------- Summary: end -------- 14:59:11 INFO - PROCESS | 31301 | 14:59:11 INFO - TEST-INFO | 31301: exit 0 14:59:11 INFO - TEST-OK | dromaeo_css | took 1116744ms 14:59:11 INFO - TEST-START | kraken 14:59:11 INFO - operating with platform_type : linux_ 14:59:11 INFO - Initialising browser for kraken test... 14:59:11 INFO - TEST-INFO | started process 31492 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIUDWWQ/profile http://localhost:39145/getInfo.html) 14:59:17 INFO - PROCESS | 31492 | __metrics Screen width/height:1600/1200 14:59:17 INFO - PROCESS | 31492 | colorDepth:24 14:59:17 INFO - PROCESS | 31492 | Browser inner width/height: 1024/697 14:59:17 INFO - PROCESS | 31492 | __metrics 14:59:19 ERROR - PROCESS | 31492 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:59:20 INFO - TEST-INFO | 31492: exit 0 14:59:20 INFO - Browser initialized. 14:59:20 INFO - Running cycle 1/1 for kraken test... 14:59:20 INFO - TEST-INFO | started process 31581 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIUDWWQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:59:32 INFO - PROCESS | 31581 | RSS: Main: 142503936 14:59:32 INFO - PROCESS | 31581 | 14:59:34 INFO - PROCESS | 31581 | Cycle 1(1): loaded http://localhost:39145/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39145/tests/kraken/driver.html?testName=audio-beat-detection) 14:59:35 INFO - PROCESS | 31581 | RSS: Main: 196911104 14:59:35 INFO - PROCESS | 31581 | 14:59:38 INFO - PROCESS | 31581 | Cycle 1(1): loaded http://localhost:39145/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39145/tests/kraken/driver.html?testName=audio-dft) 14:59:38 INFO - PROCESS | 31581 | RSS: Main: 181964800 14:59:38 INFO - PROCESS | 31581 | 14:59:41 INFO - PROCESS | 31581 | Cycle 1(1): loaded http://localhost:39145/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39145/tests/kraken/driver.html?testName=audio-fft) 14:59:42 INFO - PROCESS | 31581 | RSS: Main: 271892480 14:59:42 INFO - PROCESS | 31581 | 14:59:44 INFO - PROCESS | 31581 | Cycle 1(1): loaded http://localhost:39145/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39145/tests/kraken/driver.html?testName=audio-oscillator) 14:59:44 INFO - PROCESS | 31581 | RSS: Main: 178860032 14:59:44 INFO - PROCESS | 31581 | 14:59:47 INFO - PROCESS | 31581 | Cycle 1(1): loaded http://localhost:39145/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39145/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:59:47 INFO - PROCESS | 31581 | RSS: Main: 176410624 14:59:47 INFO - PROCESS | 31581 | 14:59:50 INFO - PROCESS | 31581 | Cycle 1(1): loaded http://localhost:39145/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39145/tests/kraken/driver.html?testName=imaging-darkroom) 14:59:51 INFO - PROCESS | 31581 | RSS: Main: 211992576 14:59:51 INFO - PROCESS | 31581 | 14:59:54 INFO - PROCESS | 31581 | Cycle 1(1): loaded http://localhost:39145/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39145/tests/kraken/driver.html?testName=imaging-desaturate) 14:59:55 INFO - PROCESS | 31581 | RSS: Main: 211980288 14:59:55 INFO - PROCESS | 31581 | 14:59:58 INFO - PROCESS | 31581 | Cycle 1(1): loaded http://localhost:39145/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39145/tests/kraken/driver.html?testName=json-parse-financial) 14:59:58 INFO - PROCESS | 31581 | RSS: Main: 211767296 14:59:58 INFO - PROCESS | 31581 | 15:00:00 INFO - PROCESS | 31581 | Cycle 1(1): loaded http://localhost:39145/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39145/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:00:00 INFO - PROCESS | 31581 | RSS: Main: 192053248 15:00:00 INFO - PROCESS | 31581 | 15:00:02 INFO - PROCESS | 31581 | Cycle 1(1): loaded http://localhost:39145/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39145/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:00:03 INFO - PROCESS | 31581 | RSS: Main: 192339968 15:00:03 INFO - PROCESS | 31581 | 15:00:04 INFO - PROCESS | 31581 | Cycle 1(1): loaded http://localhost:39145/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39145/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:00:05 INFO - PROCESS | 31581 | RSS: Main: 209215488 15:00:05 INFO - PROCESS | 31581 | 15:00:08 INFO - PROCESS | 31581 | Cycle 1(1): loaded http://localhost:39145/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39145/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:00:08 INFO - PROCESS | 31581 | RSS: Main: 213499904 15:00:08 INFO - PROCESS | 31581 | 15:00:11 INFO - PROCESS | 31581 | Cycle 1(1): loaded http://localhost:39145/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39145/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:00:12 INFO - PROCESS | 31581 | RSS: Main: 208691200 15:00:12 INFO - PROCESS | 31581 | 15:00:13 INFO - PROCESS | 31581 | Cycle 1(1): loaded http://localhost:39145/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39145/tests/kraken/driver.html?testName=ai-astar) 15:00:13 INFO - PROCESS | 31581 | RSS: Main: 272629760 15:00:13 INFO - PROCESS | 31581 | 15:00:13 INFO - PROCESS | 31581 | __start_tp_report 15:00:13 INFO - PROCESS | 31581 | _x_x_mozilla_page_load 15:00:13 INFO - PROCESS | 31581 | _x_x_mozilla_page_load_details 15:00:13 INFO - PROCESS | 31581 | |i|pagename|runs| 15:00:13 INFO - PROCESS | 31581 | |0;ai-astar;110;110;109;111;112;111;106;109;110;109 15:00:13 INFO - PROCESS | 31581 | |1;audio-beat-detection;151;125;154;174;133;156;153;128;183;136 15:00:13 INFO - PROCESS | 31581 | |2;audio-dft;161;160;160;160;160;161;161;161;160;160 15:00:13 INFO - PROCESS | 31581 | |3;audio-fft;73;77;73;170;77;74;78;74;152;74 15:00:13 INFO - PROCESS | 31581 | |4;audio-oscillator;93;93;144;92;92;93;151;92;91;139 15:00:13 INFO - PROCESS | 31581 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 15:00:13 INFO - PROCESS | 31581 | |6;imaging-darkroom;145;146;146;146;146;146;147;145;146;146 15:00:13 INFO - PROCESS | 31581 | |7;imaging-desaturate;94;96;94;94;95;94;95;94;95;94 15:00:13 INFO - PROCESS | 31581 | |8;json-parse-financial;55;53;55;53;53;54;54;85;52;52 15:00:13 INFO - PROCESS | 31581 | |9;json-stringify-tinderbox;57;58;59;57;58;58;57;58;57;58 15:00:13 INFO - PROCESS | 31581 | |10;stanford-crypto-aes;73;74;73;83;74;74;74;75;74;74 15:00:13 INFO - PROCESS | 31581 | |11;stanford-crypto-ccm;115;116;125;112;113;110;121;113;138;123 15:00:13 INFO - PROCESS | 31581 | |12;stanford-crypto-pbkdf2;164;163;155;156;156;163;156;156;155;157 15:00:13 INFO - PROCESS | 31581 | |13;stanford-crypto-sha256-iterative;73;66;67;65;66;65;65;66;64;64 15:00:13 INFO - PROCESS | 31581 | __end_tp_report 15:00:13 INFO - PROCESS | 31581 | __start_cc_report 15:00:13 INFO - PROCESS | 31581 | _x_x_mozilla_cycle_collect,1613 15:00:13 INFO - PROCESS | 31581 | __end_cc_report 15:00:13 INFO - PROCESS | 31581 | __startTimestamp1464645613952__endTimestamp 15:00:13 INFO - PROCESS | 31581 | 15:00:13 INFO - PROCESS | 31581 | ------- Summary: start ------- 15:00:13 INFO - PROCESS | 31581 | Number of tests: 14 15:00:13 INFO - PROCESS | 31581 | 15:00:13 INFO - PROCESS | 31581 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.00 stddev:1.64 (1.5%) stddev-sans-first:1.73 15:00:13 INFO - PROCESS | 31581 | Values: 110.0 110.0 109.0 111.0 112.0 111.0 106.0 109.0 110.0 109.0 15:00:13 INFO - PROCESS | 31581 | 15:00:13 INFO - PROCESS | 31581 | [#1] audio-beat-detection Cycles:10 Average:149.30 Median:153.50 stddev:19.20 (12.5%) stddev-sans-first:20.35 15:00:13 INFO - PROCESS | 31581 | Values: 151.0 125.0 154.0 174.0 133.0 156.0 153.0 128.0 183.0 136.0 15:00:13 INFO - PROCESS | 31581 | 15:00:13 INFO - PROCESS | 31581 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.50 stddev:0.52 (0.3%) stddev-sans-first:0.50 15:00:13 INFO - PROCESS | 31581 | Values: 161.0 160.0 160.0 160.0 160.0 161.0 161.0 161.0 160.0 160.0 15:00:13 INFO - PROCESS | 31581 | 15:00:13 INFO - PROCESS | 31581 | [#3] audio-fft Cycles:10 Average:92.20 Median:74.00 stddev:36.55 (49.4%) stddev-sans-first:38.10 15:00:13 INFO - PROCESS | 31581 | Values: 73.0 77.0 73.0 170.0 77.0 74.0 78.0 74.0 152.0 74.0 15:00:13 INFO - PROCESS | 31581 | 15:00:13 INFO - PROCESS | 31581 | [#4] audio-oscillator Cycles:10 Average:108.00 Median:92.00 stddev:25.47 (27.7%) stddev-sans-first:26.43 15:00:13 INFO - PROCESS | 31581 | Values: 93.0 93.0 144.0 92.0 92.0 93.0 151.0 92.0 91.0 139.0 15:00:13 INFO - PROCESS | 31581 | 15:00:13 INFO - PROCESS | 31581 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 15:00:13 INFO - PROCESS | 31581 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 15:00:13 INFO - PROCESS | 31581 | 15:00:13 INFO - PROCESS | 31581 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 15:00:13 INFO - PROCESS | 31581 | Values: 145.0 146.0 146.0 146.0 146.0 146.0 147.0 145.0 146.0 146.0 15:00:13 INFO - PROCESS | 31581 | 15:00:13 INFO - PROCESS | 31581 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 15:00:13 INFO - PROCESS | 31581 | Values: 94.0 96.0 94.0 94.0 95.0 94.0 95.0 94.0 95.0 94.0 15:00:13 INFO - PROCESS | 31581 | 15:00:13 INFO - PROCESS | 31581 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:54.00 stddev:10.04 (18.6%) stddev-sans-first:10.63 15:00:13 INFO - PROCESS | 31581 | Values: 55.0 53.0 55.0 53.0 53.0 54.0 54.0 85.0 52.0 52.0 15:00:13 INFO - PROCESS | 31581 | 15:00:13 INFO - PROCESS | 31581 | [#9] json-stringify-tinderbox Cycles:10 Average:57.70 Median:58.00 stddev:0.67 (1.2%) stddev-sans-first:0.67 15:00:13 INFO - PROCESS | 31581 | Values: 57.0 58.0 59.0 57.0 58.0 58.0 57.0 58.0 57.0 58.0 15:00:13 INFO - PROCESS | 31581 | 15:00:13 INFO - PROCESS | 31581 | [#10] stanford-crypto-aes Cycles:10 Average:74.80 Median:74.00 stddev:2.94 (4.0%) stddev-sans-first:3.04 15:00:13 INFO - PROCESS | 31581 | Values: 73.0 74.0 73.0 83.0 74.0 74.0 74.0 75.0 74.0 74.0 15:00:13 INFO - PROCESS | 31581 | 15:00:13 INFO - PROCESS | 31581 | [#11] stanford-crypto-ccm Cycles:10 Average:118.60 Median:118.50 stddev:8.45 (7.1%) stddev-sans-first:8.86 15:00:13 INFO - PROCESS | 31581 | Values: 115.0 116.0 125.0 112.0 113.0 110.0 121.0 113.0 138.0 123.0 15:00:13 INFO - PROCESS | 31581 | 15:00:13 INFO - PROCESS | 31581 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.10 Median:156.50 stddev:3.67 (2.3%) stddev-sans-first:3.21 15:00:13 INFO - PROCESS | 31581 | Values: 164.0 163.0 155.0 156.0 156.0 163.0 156.0 156.0 155.0 157.0 15:00:13 INFO - PROCESS | 31581 | 15:00:13 INFO - PROCESS | 31581 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:2.60 (3.9%) stddev-sans-first:1.00 15:00:13 INFO - PROCESS | 31581 | Values: 73.0 66.0 67.0 65.0 66.0 65.0 65.0 66.0 64.0 64.0 15:00:13 INFO - PROCESS | 31581 | -------- Summary: end -------- 15:00:13 INFO - PROCESS | 31581 | 15:00:14 INFO - TEST-INFO | 31581: exit 0 15:00:14 INFO - TEST-OK | kraken | took 63068ms 15:00:14 INFO - SUITE-END | took 1179s 15:00:15 INFO - Completed test suite (00:19:39) 15:00:15 INFO - javascript benchmark 15:00:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3361.7478689098316, 3395.0324157615087, 3411.76117671763, 3420.3843308204546, 3436.3642726095673, 5610.943890561093, 5619.0, 5623.268975033245, 5624.3813180550105, 5626.099824028156, 5536.307961504812, 5599.356074051485, 5608.046632072547, 5617.831465056055, 5619.185218143367, 4886.535779100997, 5076.822311219108, 5128.230765385185, 5185.481451854822, 5214.243934629477, 4995.850124496271, 5022.472640372763, 5031.622628302874, 5033.6224783141415, 5034.924476132861, 4896.094222568819, 5008.39899212095, 5072.670276432039, 5108.795648174068, 5121.078205922932, 5105.387353517564, 5106.948930510703, 5121.923171152435, 5123.333966584358, 5154.587632989371, 4912.533309335643, 4979.0788704089855, 5023.296738456619, 5044.697318160922, 5046.899062018776, 5441.945580544183, 5463.617546771728, 5492.945070549284, 5512.476314750093, 5513.42109078549, 5973.850653733648, 5985.820425387245, 5986.610870293417, 5988.490978266809, 6016.067509535985, 6024.789132380346, 6046.395360463963, 6052.983490507438, 6067.9696252956555, 6090.756369745205, 5590.357108932484, 5670.376258611549, 5674.205611214434, 5678.886422271614, 5680.460356266148, 5993.310769261503, 6184.381561843869, 6184.8763024739255, 6187.566870319124, 6191.9690401547705, 5895.852603684856, 5950.851228719317, 5955.37468565803, 5964.194833697396, 5977.193078934288, 5987.101934709828, 5996.970015149896, 5999.850003749942, 6000.0699891516015, 6000.969995149996, 5834.766609335579, 5948.821535353946, 5954.047352423591, 5957.106434034843, 5958.6722730249385, 5966.0454327307425, 5969.373215812364, 5972.820815375546, 5976.462118409364, 6006.699665016732, 4543.045960348364, 4550.954490455119, 4552.931706024412, 4552.954470455253, 4582.014866803654, 3946.4672269243283, 4031.294523458383, 4072.75563466193, 4096.180763847243, 4110.835566577363, 5760.308762948389, 5780.075187969905, 5780.595358324961, 5781.132830075522, 5782.392848750905, 6001.879962400728, 6046.425589569072, 6052.727627256784, 6054.091886217015, 6059.0608455689435, 5536.474034966672, 5728.885422291531, 5759.424057594207, 5806.970965145148, 5808.535317174616, 5142.202958541432, 5145.871353216199, 5147.2279158126585, 5148.613853960968, 5160.7419629018395, 6196.287426945869, 6245.0, 6258.43674069336, 6264.812055638338, 6267.6866156691985, 5871.236739224044, 5914.970425147847, 6002.609830361012, 6003.7898673546215, 6015.819525414157, 6158.291796443466, 6158.661273629814, 6160.630362178284, 6161.4146656067605, 6214.475179992559, 5918.408159184047, 5922.0, 5926.496247818984, 5931.792387266425, 5964.105384192232, 5768.307803063659, 5971.044632858721, 6012.398760123952, 6044.032954727222, 6046.7278972445465, 5823.563232757645, 5853.882922341444, 5877.588568800143, 5881.0, 5891.0, 5659.0, 5799.791552930599, 5840.415958404125, 5860.560457965585, 5864.618799778001, 5712.285964254468, 5738.139279108167, 5745.741441635053, 5764.279465066867, 5780.94219057804, 5889.970550147222, 5928.9407105928385, 5931.3178984417345, 5948.256467941507, 5967.4629283362965, 5565.220869078251, 5691.800786972602, 5807.157962095557, 5809.622374545641, 5812.33158186797], "value": 5527.985935818461, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [681.1315572644877, 690.88945768677, 691.2672567078894, 736.8010637127973, 751.684292597109, 32124.67875321249, 39588.80205598975, 40609.390859137064, 40633.39049914254, 40661.186776264454, 43512.56487435125, 43947.56052439474, 44017.559824401746, 44116.0, 44259.77870110653, 7889.684412623488, 8831.911680883173, 9009.95495022524, 9011.909880901172, 10452.216083793708, 10482.0, 10625.574977000912, 10627.202959778047, 10632.415217163052, 10635.042846143846, 10660.893391066107, 10731.356118632868, 10736.463176841165, 10738.516766745515, 10740.03339699427, 8159.184081591793, 10406.9479652602, 10606.681799545988, 10610.840837387444, 10640.840387394195, 10538.683839484751, 10653.414062226575, 10659.360438373646, 10668.14654827612, 10669.626563070255, 41105.0, 41649.1670166595, 41663.375049374285, 41672.79163604163, 41785.58214417847, 3776.1692427666144, 3832.827522761482, 3859.9228015439535, 4088.2641124597562, 4250.702450828443, 34792.47811282833, 35197.296054078775, 35503.0, 35602.0, 37395.0, 4690.788914498856, 4729.952700472985, 4793.18515852306, 4823.252395878644, 4830.299606557065, 312157.0, 316296.0, 316561.0, 316841.9999999977, 317112.0, 40900.0, 41822.790886045375, 68824.0, 69554.65222673854, 69942.0, 39030.0, 39110.21779564393, 39135.21729565393, 39272.21455570873, 39369.80315098406, 16748.916255418644, 16935.91532042332, 16938.153092345332, 16938.23777929996, 16945.661086778196, 12366.0, 12463.626091217096, 12580.559680411325, 12866.67833304175, 13165.354330708662, 9388.8591671125, 9415.340926135104, 9422.340436169403, 9473.05269473061, 9475.715728528156, 3566.625504322009, 3682.355587772129, 3686.9262614747554, 3699.611540788232, 3758.624137586274, 1163.831244469547, 1164.6897240604321, 1179.8112302031805, 1188.085174415695, 1204.6085022367765, 33713.83143084318, 34072.14819629529, 34091.0, 34167.0, 35006.47490287648, 1217.1193514008712, 1294.4822071171418, 1300.8048792680984, 1301.531448678475, 1304.1718508747015, 17917.491551182844, 18109.0, 18180.45458636243, 18267.451976440727, 18323.90838045828, 479147.0, 481613.0, 485686.0, 487254.0, 492352.0, 64464.0, 65907.67046164739, 65930.0, 65993.0, 66026.66986665037, 1507.4196434372845, 1526.7633516804913, 1539.7921280626972, 1558.2676142213368, 1651.4385109062976, 32660.673393266712, 33976.0, 34032.229943460414, 34385.48421773625, 34732.30535389329, 45197.77401112973, 45234.32148517709, 45300.77349613231, 45304.77347613241, 45445.318320224564, 284611.0, 285745.0, 286991.0, 287061.0, 287080.0, 28398.0, 32687.0, 33066.66933330636, 33067.338653227285, 33355.49966750549, 49755.75122124366, 50571.0, 50871.74564127304, 51086.48913510966, 51347.74326128345, 40948.0, 41107.177856443304, 41144.588554114074, 42027.0, 42991.785041074596, 39486.80256598699, 41368.37947430851, 41974.0, 42122.78938605287, 42641.14717705567, 43302.35046474243, 43408.34887476754, 44317.0, 44500.777496112314, 44600.776996114815, 36316.81841590775, 36943.26113477769, 37184.81407592945, 37376.439353410264, 38252.0, 28460.857695711387, 28868.855655721585, 29000.564991524723, 29070.12789616315, 29095.709042910148], "value": 19878.681610325857, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.1481409402336, 437.50343360286087, 447.0, 448.41034040237105, 460.1418354768358, 19109.331173408933, 19505.707414388795, 19509.12208950597, 19523.609527809454, 19869.0, 18878.433646990612, 18974.146163422643, 20562.588748225025, 20674.586508269826, 20705.68941465879, 5687.0, 5880.382559831199, 5973.940260597382, 5987.580869339148, 6042.909356359658, 4330.5669433056755, 5872.148538461921, 5987.730552125143, 6274.309825919146, 6555.77054803082, 6487.540303431737, 6548.607083575001, 6563.442107420851, 6567.967160164192, 6569.080328753978, 6344.968275158641, 6460.709268082924, 6538.280789113193, 6558.409743123142, 6576.375244351779, 3925.3326934421216, 4139.379093136024, 5618.859528511779, 5853.941460585383, 5895.852603684899, 22864.542709145724, 22864.54270914589, 23084.0, 24153.637695434583, 24528.632070518957, 2498.612715029173, 2503.5493611149986, 2513.2711513661015, 2558.1941688368292, 2830.2924268932766, 14992.70014599702, 15088.094714317176, 15148.697026059528, 15265.23673816316, 15577.454789082327, 1967.5572996075769, 2022.5247066939257, 2040.0207900207836, 2058.95882082359, 2211.1818627107914, 80579.0, 81032.0, 81776.0, 83351.0, 84094.57952710197, 10686.893131068746, 10917.672469825919, 11222.887771122185, 11462.48418821155, 12240.81638775419, 16052.357905683875, 16093.839061609235, 16239.675206495804, 16241.187940602922, 16256.268467918972, 8954.597043133075, 9091.181793638605, 9098.545072746469, 9099.954500227457, 9155.359124861196, 8998.325125615605, 9032.729018129467, 9062.773430664287, 9113.589888455035, 9171.266298696222, 7028.0, 7146.5354751941995, 7200.783976480714, 7205.675744591506, 7215.60314182725, 1840.570447009934, 1956.2370675436591, 2035.3792093411355, 2071.2232912657755, 2164.815990640813, 1032.7727899862018, 1099.279971618575, 1099.4228030284005, 1103.0734183285917, 1162.9825552616717, 18394.17226224823, 18523.72214416785, 18860.811391886178, 19642.50893727668, 20311.28910488126, 1133.4219548030565, 1134.2173900008968, 1196.1507329795768, 1206.0652993929775, 1206.240068756695, 11417.42912854354, 11625.18623696333, 11684.18210725241, 11781.234219775688, 11845.526178952745, 538082.0, 542472.0, 543828.0, 564336.0, 568835.0, 81157.18842811615, 85374.0, 86002.56998715091, 87048.0, 87098.0, 1139.9715007124723, 1154.509333533245, 1155.318362166309, 1157.6353448663644, 1160.9013233875214, 17591.29634814593, 17592.73610895863, 18133.36533221331, 18153.45539633813, 18377.90811045936, 39839.20321593494, 40224.396634051096, 40521.1895762089, 41213.79393103015, 41292.79353603333, 54582.45417545774, 55163.0, 55262.17106743482, 55293.44706552883, 55306.72346638402, 9073.77315567116, 9097.090290971115, 9104.90895091067, 9146.588403521724, 9225.354225204172, 11762.529498819951, 13740.381682824096, 14146.646333841736, 14280.071795333686, 14373.209473479059, 12135.696607584881, 12290.938545307574, 12441.502339906303, 12628.43172057278, 12664.936675316932, 12226.633201003984, 12331.445084971378, 12440.129190956908, 12700.745985080432, 12794.0, 12631.431585578488, 12651.873481265438, 12886.48454061827, 12978.221306721627, 12986.545470908473, 8655.56722163902, 9027.187553119988, 9129.908700912905, 9319.301052421231, 9585.808283834423, 11336.14978876604, 11567.132465064986, 11640.650780476599, 11889.881101188877, 11994.520219191134], "value": 9914.50575079962, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1332.9333533323331, 1585.5481187861462, 1609.0989046134162, 1808.3218792952644, 1931.4591914264001, 8413.831723365529, 8536.231739143475, 8550.315974722023, 8557.058723540405, 8572.528510931896, 8199.91800081999, 8352.665893364257, 8365.247127758501, 8367.623456944437, 8369.079401265872, 2112.514121751998, 2403.038784486202, 2423.527412154635, 2452.5708001099824, 2460.360306320352, 2424.806015518754, 2435.5981263091567, 2449.461118553915, 2449.595816690253, 2453.1659235859806, 2311.919082832101, 2387.5344307859973, 2388.4387169015267, 2389.032441861049, 2389.426537630965, 2099.9160033598714, 2388.10446082719, 2458.8155888308447, 2461.0770960889668, 2466.05057053035, 2362.4920642061866, 2405.7353691093967, 2417.2627348658652, 2417.9758202417925, 2427.781499665021, 8014.599270036475, 8067.031956165298, 8071.354291656653, 8081.595920204025, 8082.7171049013, 5284.603654725873, 5340.679559226459, 5374.7850085996515, 5380.892382152335, 5426.67439953604, 3496.4405695088662, 3572.07126147201, 3572.6605972432576, 3573.803440810754, 3664.59689434162, 1103.5309993252836, 1106.0985296982933, 1115.263925808962, 1185.5376403202758, 1211.9818202726967, 12570.937145314307, 12610.558630447891, 12616.0, 12627.43176557057, 12651.873481265253, 4860.441049279378, 4881.438634557071, 4882.5605695487575, 4887.242477416006, 5009.674371165863, 10607.469626518643, 10609.9469502652, 10629.25595208328, 10645.254832161829, 10650.520726567323, 4860.489648586848, 5529.336479622471, 5546.528545073633, 5564.248826408383, 5568.916466253009, 5026.095302845523, 5055.7219352935945, 5083.517065878736, 5115.846524604268, 5145.588352931756, 4208.431861698693, 4229.767362795014, 4242.578736123433, 4289.120730250291, 4358.847440339573, 1349.6086135020735, 1392.6657602175608, 1406.045596620698, 1424.5370254667275, 1436.8203974503188, 970.3789574672215, 1096.5887199549395, 1099.9560017599206, 1107.839363292318, 1123.730304726876, 6080.0879868019265, 6190.783322583688, 6251.093591429218, 6252.718627661766, 6299.559030867887, 995.3977843404781, 1002.3033991375924, 1051.8211903976342, 1067.631667074858, 1091.5961094394966, 4273.572642735701, 4367.0, 4368.6723495737315, 4411.955880441219, 4413.8234470621455, 10245.282830201815, 10701.892981070245, 10704.839427408595, 10899.400532970763, 11036.227464077438, 10803.675889723321, 10880.347179169275, 10927.071198948019, 10931.508082136323, 10967.341959482457, 8334.458260213067, 8461.280791132822, 8505.10696376884, 8520.57397130141, 8563.871541926876, 6065.484433823174, 6090.390960904051, 6145.754169833157, 6161.291451483136, 6256.655883926428, 9727.124558789743, 9864.457454840052, 10013.849792253268, 10025.248106391904, 10038.096571308617, 9905.752356191153, 10096.394216346749, 10164.136048435967, 10356.275060745675, 10361.067503924683, 6373.74505019794, 6540.901886471612, 7122.074130363019, 7527.661255243418, 7681.1934746850775, 8387.83224335522, 8407.95796021016, 8451.915480845359, 8452.95773521153, 8470.0, 7495.812604684927, 7742.496737712031, 7762.961185194038, 7830.725924592612, 7852.842943140991, 7387.7783666490095, 7403.444741644506, 7403.962980185064, 7510.061242344707, 7512.13610434807, 7140.250273721393, 7203.783886483414, 7301.63491825396, 7324.5971471567445, 7346.742863999734, 5376.112941364788, 5419.701916394636, 5499.092649712753, 5575.386707462095, 5585.245991791056, 5238.842834714965, 5334.653247538898, 5413.10683737179, 5545.334559852843, 5590.2453168821685], "value": 4759.306616051505, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.2831038835969, 354.33562071116665, 360.30461209864967, 363.358671944019, 364.14062811764234, 6282.0, 6286.0, 6321.083442900783, 6323.5889667171605, 6356.141920840685, 6266.686665666722, 6270.623762574237, 6280.717367718452, 6288.654124023177, 6301.117843501914, 4559.0, 4679.064187162564, 4780.067886762083, 4819.156647586676, 4825.107355139293, 4787.521247875219, 4795.304680821278, 4815.651617547092, 4821.228603423453, 4824.614030877521, 4596.149712303235, 4776.235802271637, 4778.044391121773, 4780.067886762083, 4783.808647654089, 4621.976890115561, 4705.988212534305, 4706.5293470653005, 4726.2201736713405, 4760.738159401231, 4195.202911446815, 4210.789460526961, 4211.91576168478, 4219.050713589449, 4224.852130175429, 6012.669303188323, 6022.187004754346, 6029.366916473795, 6034.6982650867285, 6039.275286965549, 5546.639468434539, 5550.084236101038, 5558.610897237195, 5562.638428502134, 5566.332040155166, 6425.389587989133, 6563.212414510242, 6571.67141642916, 6572.868542629169, 6578.473722102221, 4611.492735799093, 4624.28323609841, 4626.398568186148, 4646.4424269087585, 4662.3705799716945, 6857.691403886787, 6878.105846240007, 6882.174139103289, 6887.586744795329, 6893.20728116268, 4716.976415117902, 4719.4100737407825, 4720.173969555382, 4720.527947205252, 4727.3854398927915, 4796.06476737033, 4799.136155492045, 4801.975990120097, 4805.471398146201, 4805.711657300573, 5501.064818980783, 5508.614396992172, 5509.614326997152, 5511.22842802008, 5512.39363670004, 6486.35136486357, 6621.503387245976, 6626.072349871022, 6631.303713110054, 6634.900476492857, 1654.3465331194352, 1670.0898010584017, 1673.8075121361198, 1675.8240384759424, 1679.1016806008727, 1063.542676649033, 1088.950997205112, 1114.9052330551995, 1117.9944100279447, 1128.3511980611017, 6339.778107766206, 6510.934890651033, 6533.18335208099, 6537.673116344164, 6550.868982620321, 6935.791926242221, 6977.581345119309, 6978.406835419046, 6981.0, 6982.860342793116, 6492.870142597121, 6494.6103233806125, 6505.284418713938, 6510.414062734377, 6526.053722210253, 3671.1372827385544, 3705.203381273039, 3710.0, 3714.2200137971327, 3715.9442608360896, 6985.091938048021, 7168.713251469882, 7178.856422871513, 7188.460865435113, 7191.244919283505, 6985.5808651481075, 6997.370236678723, 7004.15950085993, 7008.369246767714, 7030.050943122613, 7157.069580954442, 7167.283271672895, 7170.282971702893, 7174.748883789042, 7181.461390395742, 6849.794506164823, 6874.175098988154, 6883.208431030295, 6885.380315771405, 6890.621015844176, 6624.6025238485845, 6786.660666966731, 6787.21946976104, 6801.727930882709, 6803.93196068033, 7133.750318738819, 7151.892721609284, 7156.928430715626, 7169.462290328351, 7179.1026121734785, 4818.927716084331, 4820.927686084781, 4827.396575428072, 4829.710217386968, 4832.613390928647, 6879.346462086094, 6881.311868813079, 6882.931170688229, 6889.896651550131, 6892.379685828299, 6566.507511936719, 6676.49926255523, 6685.264620891795, 6701.564398314094, 6702.798916032527, 6637.734490620321, 6666.566673166229, 6672.6997285121315, 6673.499487538357, 6680.331966803476, 6548.508861835477, 6551.344865513411, 6558.311377305315, 6565.719684661445, 6568.47452203813, 6698.9665051676375, 6715.05989161508, 6729.495287853332, 6736.191657001191, 6737.528373013842, 6289.9056514153235, 6378.6810659467765, 6408.967955160194, 6530.183727034121, 6544.934550654623], "value": 5026.952248797229, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [871.9476831390117, 904.8868891388577, 923.7228831350593, 928.1368327455464, 952.49041762657, 14982.175980321092, 15136.0, 15162.924185379057, 15257.771133432994, 15274.770878436831, 14522.273886305695, 15623.453179138703, 15970.84029159708, 16132.0, 16183.271752771125, 742.940564754821, 895.3956079646246, 911.1799380557485, 911.2345629671108, 932.93935894167, 923.0815338737965, 923.8198551282503, 931.6413180925358, 932.9626814927394, 933.2207606648423, 941.3128416256103, 951.1297163095759, 951.3863558005082, 951.4006176109076, 952.2286947572454, 790.4782843323408, 930.2139691960283, 937.5687183895416, 948.9240860731124, 951.8619800129012, 692.2834865913755, 696.4915611603507, 697.3967518096861, 697.4420463629127, 700.7757517594372, 14777.187254700988, 14789.630259243497, 14831.629209269746, 14852.70294594102, 14947.327370268364, 13645.38595763193, 13881.861181388158, 14125.78811317831, 14236.572902812932, 14464.927675361556, 12192.817107743302, 12232.0, 12325.260484370876, 12369.443375048144, 12382.442790074469, 3916.373380259145, 3976.363781794928, 4031.2743706132883, 4061.817218225187, 4093.6111069448357, 59040.70479647617, 59049.0, 59424.405755942316, 59425.702871485795, 59528.70235648837, 11215.1027917768, 11552.595659152057, 11568.595099171489, 11892.227005244631, 12055.87944120565, 21953.67069493959, 22467.775322246896, 22509.099636014376, 22541.43646408853, 22562.210322638628, 8552.871706924401, 8612.354073444516, 9204.493752843659, 9235.538223088819, 9336.95331523338, 4762.738049407316, 4842.854714358575, 4944.505549445027, 4968.627352948543, 5074.4671809460215, 3747.6814470769746, 3769.7361184716806, 3797.981010094987, 3799.297130030953, 3807.3908174691915, 635.4249404289126, 636.2015670333701, 642.1331202876173, 656.6158797103652, 657.9867004812535, 727.5755082620449, 791.4894892794116, 822.6051495282178, 833.2750507058897, 843.7426584891667, 9923.751906202402, 10212.387256764468, 10214.0, 10279.94860025695, 10293.691189264184, 575.683374144219, 623.8783437229697, 635.3582881289931, 649.3733547127046, 651.837040739815, 4564.520725323793, 4830.058138662927, 4844.176489996709, 4854.490278520704, 4884.072026314989, 59782.70108649516, 61482.385176148564, 61810.69094654498, 61900.0, 67478.32521674818, 56715.43284567101, 57337.42662573404, 58331.0, 58566.41433585695, 58998.70500647555, 51594.93620255223, 52206.21690674567, 52451.21323180155, 52667.0, 53636.46363536393, 10186.541605627914, 10230.590776368861, 10283.84574231402, 10286.537105830404, 10313.845292320771, 38181.0, 39225.21549568936, 39922.600773991886, 40697.79651101844, 41750.0, 47949.520504794506, 48045.0, 48412.273815893495, 48539.0, 48552.271715924995, 12421.31682757457, 12750.0, 12914.09601327898, 12992.259168606879, 13093.476260949456, 13666.863331366956, 13838.169709817443, 14040.438382464996, 14338.068025578305, 14667.48663796762, 13005.47978080904, 13461.259630720013, 13582.796258056334, 13869.306534673427, 14011.08927919682, 13137.408816603085, 13492.797608035691, 13513.662158445724, 14217.431302747775, 14247.145171289756, 13260.204387736381, 13376.665583360495, 13753.38109785042, 13757.31213439304, 13805.861941380457, 10763.515641796295, 11205.159613029218, 11887.465064071965, 11939.522419103487, 11965.282083075042, 11432.0, 11592.88407115918, 11652.708682283012, 11661.6501504955, 11846.348450835287], "value": 7276.407585855515, "unit": "score"}], "name": "dromaeo_css", "value": 7580.039483113791, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 109.0, 111.0, 112.0, 111.0, 106.0, 109.0, 110.0, 109.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 125.0, 154.0, 174.0, 133.0, 156.0, 153.0, 128.0, 183.0, 136.0], "value": 149.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 160.0, 160.0, 161.0, 161.0, 161.0, 160.0, 160.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 77.0, 73.0, 170.0, 77.0, 74.0, 78.0, 74.0, 152.0, 74.0], "value": 92.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 144.0, 92.0, 92.0, 93.0, 151.0, 92.0, 91.0, 139.0], "value": 108.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 145.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 94.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 55.0, 53.0, 53.0, 54.0, 54.0, 85.0, 52.0, 52.0], "value": 56.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 59.0, 57.0, 58.0, 58.0, 57.0, 58.0, 57.0, 58.0], "value": 57.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 73.0, 83.0, 74.0, 74.0, 74.0, 75.0, 74.0, 74.0], "value": 74.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 125.0, 112.0, 113.0, 110.0, 121.0, 113.0, 138.0, 123.0], "value": 118.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 155.0, 156.0, 156.0, 163.0, 156.0, 156.0, 155.0, 157.0], "value": 158.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 66.0, 67.0, 65.0, 66.0, 65.0, 65.0, 66.0, 64.0, 64.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1508.8999999999996, "alertThreshold": 2.0}]} 15:00:15 INFO - Return code: 0 15:00:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:00:15 ERROR - # TBPL SUCCESS # 15:00:15 INFO - Running post-action listener: _resource_record_post_action 15:00:15 INFO - Running post-run listener: _resource_record_post_run 15:00:16 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 0; Write bytes: 493572096; Read time: 0; Write time: 3470204 15:00:16 INFO - install - Wall time: 17s; CPU: 26.0%; Read bytes: 0; Write bytes: 150650880; Read time: 0; Write time: 1141144 15:00:16 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 330694656; Read time: 0; Write time: 2124148 15:00:16 INFO - Running post-run listener: _upload_blobber_files 15:00:16 INFO - Blob upload gear active. 15:00:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:00:16 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 15:00:16 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'] 15:00:16 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 15:00:16 INFO - (blobuploader) - INFO - Open directory for files ... 15:00:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:00:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:00:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:00:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:00:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:00:17 INFO - (blobuploader) - INFO - Done attempting. 15:00:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:00:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:00:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:00:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:00:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:00:18 INFO - (blobuploader) - INFO - Done attempting. 15:00:18 INFO - (blobuploader) - INFO - Iteration through files over. 15:00:18 INFO - Return code: 0 15:00:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:00:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:00:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6b0bb6891d6695ff967abad344dccd4fab6bebeb3f8126b29324252f4e0a4d31cbe1a3c118f9fce1cbd85b35a088bac660381c4732ea0fde51b1c9de1836727c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e11a4d0755f23b232d58c092645c92b008c042225d1441c577f65dc7b4a9ecba9de94f11a870b7e09433bab822d478444165bdbd8585b5b459bf3a1d9986ca97"} 15:00:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:00:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:00:18 INFO - Contents: 15:00:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6b0bb6891d6695ff967abad344dccd4fab6bebeb3f8126b29324252f4e0a4d31cbe1a3c118f9fce1cbd85b35a088bac660381c4732ea0fde51b1c9de1836727c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e11a4d0755f23b232d58c092645c92b008c042225d1441c577f65dc7b4a9ecba9de94f11a870b7e09433bab822d478444165bdbd8585b5b459bf3a1d9986ca97"} 15:00:18 INFO - Running post-run listener: copy_logs_to_upload_dir 15:00:18 INFO - Copying logs to upload dir... 15:00:18 INFO - mkdir: /builds/slave/test/build/upload/logs 15:00:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.492288 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-05-30 15:00:18.184976) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 15:00:18.188975) ========= 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=33d5923976266a1c518c4bf7000001ab-1464643868.857785-1470080577 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/6b0bb6891d6695ff967abad344dccd4fab6bebeb3f8126b29324252f4e0a4d31cbe1a3c118f9fce1cbd85b35a088bac660381c4732ea0fde51b1c9de1836727c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e11a4d0755f23b232d58c092645c92b008c042225d1441c577f65dc7b4a9ecba9de94f11a870b7e09433bab822d478444165bdbd8585b5b459bf3a1d9986ca97"} build_url:https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011378 build_url: 'https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/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/6b0bb6891d6695ff967abad344dccd4fab6bebeb3f8126b29324252f4e0a4d31cbe1a3c118f9fce1cbd85b35a088bac660381c4732ea0fde51b1c9de1836727c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e11a4d0755f23b232d58c092645c92b008c042225d1441c577f65dc7b4a9ecba9de94f11a870b7e09433bab822d478444165bdbd8585b5b459bf3a1d9986ca97"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 15:00:18.215386) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 15:00:18.216000) ========= 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=33d5923976266a1c518c4bf7000001ab-1464643868.857785-1470080577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004589 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 15:00:18.265752) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 15:00:18.266090) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 15:00:18.266391) ========= ========= Total master_lag: 0.13 =========