builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-033 starttime: 1461478772.71 results: success (0) buildid: 20160423223116 builduid: f400093251484822be4c83a31736fd3d revision: 8afadb96e97704a98492c2286fb92479deb3365f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-23 23:19:32.708154) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-23 23:19:32.708537) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 23:19:32.708795) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 23:19:32.779175) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 23:19:32.779878) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1461478677.437013-192345811 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-23 23:19:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 40.3M=0s 2016-04-23 23:19:33 (40.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.170187 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 23:19:33.011051) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 23:19:33.011316) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1461478677.437013-192345811 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.049296 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 23:19:33.070270) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-23 23:19:33.070561) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8afadb96e97704a98492c2286fb92479deb3365f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 8afadb96e97704a98492c2286fb92479deb3365f --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=edae0fb5fee9fb758e8af6d3000002a4-1461478677.437013-192345811 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-23 23:19:33,342 truncating revision to first 12 chars 2016-04-23 23:19:33,342 Setting DEBUG logging. 2016-04-23 23:19:33,342 attempt 1/10 2016-04-23 23:19:33,342 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8afadb96e977?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-23 23:19:34,220 unpacking tar archive at: fx-team-8afadb96e977/testing/mozharness/ program finished with exit code 0 elapsedTime=1.162730 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-23 23:19:34.245566) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 23:19:34.245857) ========= script_repo_revision: 8afadb96e97704a98492c2286fb92479deb3365f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 23:19:34.246254) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-23 23:19:34.246513) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-23 23:19:34.255255) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-04-23 23:19:34.255511) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=edae0fb5fee9fb758e8af6d3000002a4-1461478677.437013-192345811 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:19:34 INFO - MultiFileLogger online at 20160423 23:19:34 in /builds/slave/test 23:19:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 23:19:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:19:34 INFO - {'append_to_log': False, 23:19:34 INFO - 'base_work_dir': '/builds/slave/test', 23:19:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 23:19:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:19:34 INFO - 'branch': 'Fx-Team-Non-PGO', 23:19:34 INFO - 'buildbot_json_path': 'buildprops.json', 23:19:34 INFO - 'config_files': ('talos/linux_config.py',), 23:19:34 INFO - 'default_actions': ('clobber', 23:19:34 INFO - 'read-buildbot-config', 23:19:34 INFO - 'download-and-extract', 23:19:34 INFO - 'populate-webroot', 23:19:34 INFO - 'create-virtualenv', 23:19:34 INFO - 'install', 23:19:34 INFO - 'run-tests'), 23:19:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:19:34 INFO - 'download_minidump_stackwalk': True, 23:19:34 INFO - 'download_symbols': 'ondemand', 23:19:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:19:34 INFO - 'tooltool.py': '/tools/tooltool.py', 23:19:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:19:34 INFO - '/tools/misc-python/virtualenv.py')}, 23:19:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:19:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:19:34 INFO - 'installer_path': 'installer.exe', 23:19:34 INFO - 'log_level': 'info', 23:19:34 INFO - 'log_name': 'talos', 23:19:34 INFO - 'log_to_console': True, 23:19:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:19:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:19:34 INFO - 'opt_config_files': (), 23:19:34 INFO - 'pip_index': False, 23:19:34 INFO - 'sps_profile': False, 23:19:34 INFO - 'sps_profile_interval': 0, 23:19:34 INFO - 'suite': 'dromaeojs', 23:19:34 INFO - 'system_bits': '32', 23:19:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:19:34 INFO - 'title': 'talos-linux64-ix-033', 23:19:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:19:34 INFO - 'use_talos_json': True, 23:19:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:19:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:19:34 INFO - 'work_dir': 'build'} 23:19:34 INFO - ##### 23:19:34 INFO - ##### Running clobber step. 23:19:34 INFO - ##### 23:19:34 INFO - Running pre-action listener: _resource_record_pre_action 23:19:34 INFO - Running main action method: clobber 23:19:34 INFO - rmtree: /builds/slave/test/build 23:19:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:19:36 INFO - Running post-action listener: _resource_record_post_action 23:19:36 INFO - ##### 23:19:36 INFO - ##### Running read-buildbot-config step. 23:19:36 INFO - ##### 23:19:36 INFO - Running pre-action listener: _resource_record_pre_action 23:19:36 INFO - Running main action method: read_buildbot_config 23:19:36 INFO - Using buildbot properties: 23:19:36 INFO - { 23:19:36 INFO - "project": "", 23:19:36 INFO - "product": "firefox", 23:19:36 INFO - "script_repo_revision": "production", 23:19:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 23:19:36 INFO - "repository": "", 23:19:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 23:19:36 INFO - "buildid": "20160423223116", 23:19:36 INFO - "pgo_build": "False", 23:19:36 INFO - "basedir": "/builds/slave/test", 23:19:36 INFO - "buildnumber": 1594, 23:19:36 INFO - "slavename": "talos-linux64-ix-033", 23:19:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:19:36 INFO - "platform": "ubuntu64_hw", 23:19:36 INFO - "scheduler": "tests-fx-team-linux64-talos", 23:19:36 INFO - "branch": "fx-team", 23:19:36 INFO - "repo_path": "integration/fx-team", 23:19:36 INFO - "revision": "8afadb96e97704a98492c2286fb92479deb3365f", 23:19:36 INFO - "stage_platform": "linux64", 23:19:36 INFO - "builduid": "f400093251484822be4c83a31736fd3d", 23:19:36 INFO - "slavebuilddir": "test" 23:19:36 INFO - } 23:19:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/IccouWiyTmKnZ6lP-hr2jw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 23:19:36 INFO - Running post-action listener: _resource_record_post_action 23:19:36 INFO - ##### 23:19:36 INFO - ##### Running download-and-extract step. 23:19:36 INFO - ##### 23:19:36 INFO - Running pre-action listener: _resource_record_pre_action 23:19:36 INFO - Running main action method: download_and_extract 23:19:36 INFO - mkdir: /builds/slave/test/build/tests 23:19:36 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')]} 23:19:36 INFO - https://queue.taskcluster.net/v1/task/IccouWiyTmKnZ6lP-hr2jw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:19:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IccouWiyTmKnZ6lP-hr2jw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 23:19:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IccouWiyTmKnZ6lP-hr2jw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 23:19:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IccouWiyTmKnZ6lP-hr2jw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 23:19:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IccouWiyTmKnZ6lP-hr2jw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:19:40 INFO - Downloaded 1361 bytes. 23:19:40 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 23:19:40 INFO - Using the following test package requirements: 23:19:40 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 23:19:40 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:19:40 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:19:40 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:19:40 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:19:40 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:19:40 INFO - u'jsshell-linux-x86_64.zip'], 23:19:40 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:19:40 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:19:40 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 23:19:40 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:19:40 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:19:40 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:19:40 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:19:40 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:19:40 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:19:40 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:19:40 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:19:40 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:19:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:19:40 INFO - https://queue.taskcluster.net/v1/task/IccouWiyTmKnZ6lP-hr2jw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:19:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IccouWiyTmKnZ6lP-hr2jw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 23:19:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IccouWiyTmKnZ6lP-hr2jw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 23:19:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IccouWiyTmKnZ6lP-hr2jw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 23:19:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IccouWiyTmKnZ6lP-hr2jw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:19:42 INFO - Downloaded 22285608 bytes. 23:19:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:19:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:19:43 INFO - Return code: 0 23:19:43 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:19:43 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')]} 23:19:43 INFO - https://queue.taskcluster.net/v1/task/IccouWiyTmKnZ6lP-hr2jw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:19:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IccouWiyTmKnZ6lP-hr2jw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 23:19:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IccouWiyTmKnZ6lP-hr2jw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 23:19:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IccouWiyTmKnZ6lP-hr2jw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 23:19:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IccouWiyTmKnZ6lP-hr2jw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:19:57 INFO - Downloaded 22285608 bytes. 23:19:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:19:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:19:58 INFO - Return code: 0 23:19:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:19:58 INFO - https://queue.taskcluster.net/v1/task/IccouWiyTmKnZ6lP-hr2jw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:19:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IccouWiyTmKnZ6lP-hr2jw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 23:19:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IccouWiyTmKnZ6lP-hr2jw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 23:19:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IccouWiyTmKnZ6lP-hr2jw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 23:19:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IccouWiyTmKnZ6lP-hr2jw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:19:59 INFO - Downloaded 10840145 bytes. 23:19:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:19:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 23:19:59 INFO - Return code: 0 23:19: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')]} 23:19:59 INFO - https://queue.taskcluster.net/v1/task/IccouWiyTmKnZ6lP-hr2jw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:19:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IccouWiyTmKnZ6lP-hr2jw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 23:19:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IccouWiyTmKnZ6lP-hr2jw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 23:19:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IccouWiyTmKnZ6lP-hr2jw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 23:19:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IccouWiyTmKnZ6lP-hr2jw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:20:01 INFO - Downloaded 54745786 bytes. 23:20:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IccouWiyTmKnZ6lP-hr2jw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 23:20:01 INFO - mkdir: /builds/slave/test/properties 23:20:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:20:01 INFO - Writing to file /builds/slave/test/properties/build_url 23:20:01 INFO - Contents: 23:20:01 INFO - build_url:https://queue.taskcluster.net/v1/task/IccouWiyTmKnZ6lP-hr2jw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 23:20:01 INFO - Running post-action listener: _resource_record_post_action 23:20:01 INFO - Running post-action listener: set_extra_try_arguments 23:20:01 INFO - ##### 23:20:01 INFO - ##### Running populate-webroot step. 23:20:01 INFO - ##### 23:20:01 INFO - Running pre-action listener: _resource_record_pre_action 23:20:01 INFO - Running main action method: populate_webroot 23:20:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:20:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:20:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:20:01 INFO - '--tppagecycles', 23:20:01 INFO - '7'], 23:20:01 INFO - 'tests': ['tsvgm']}}, 23:20:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:20:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:20:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:20:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:20:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:20:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:20:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:20:01 INFO - 'talos_options': ['--disable-e10s'], 23:20:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:20:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:20:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:20:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:20:01 INFO - 'talos_options': ['--disable-e10s'], 23:20:01 INFO - 'tests': ['damp', 'tps']}, 23:20:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:20:01 INFO - 'tests': ['damp', 'tps']}, 23:20:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:20:01 INFO - 'tests': ['dromaeo_dom']}, 23:20:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:20:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:20:01 INFO - 'tests': ['a11yr', 23:20:01 INFO - 'ts_paint', 23:20:01 INFO - 'tpaint', 23:20:01 INFO - 'sessionrestore', 23:20:01 INFO - 'sessionrestore_no_auto_restore', 23:20:01 INFO - 'tabpaint']}, 23:20:01 INFO - 'other-e10s': {'tests': ['a11yr', 23:20:01 INFO - 'ts_paint', 23:20:01 INFO - 'tpaint', 23:20:01 INFO - 'sessionrestore', 23:20:01 INFO - 'sessionrestore_no_auto_restore', 23:20:01 INFO - 'tabpaint']}, 23:20:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:20:01 INFO - 'ts_paint', 23:20:01 INFO - 'tpaint', 23:20:01 INFO - 'sessionrestore', 23:20:01 INFO - 'sessionrestore_no_auto_restore', 23:20:01 INFO - 'tabpaint']}, 23:20:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:20:01 INFO - 'ts_paint', 23:20:01 INFO - 'tpaint', 23:20:01 INFO - 'sessionrestore', 23:20:01 INFO - 'sessionrestore_no_auto_restore', 23:20:01 INFO - 'tabpaint']}, 23:20:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:20:01 INFO - 'tests': ['a11yr', 23:20:01 INFO - 'ts_paint', 23:20:01 INFO - 'tpaint', 23:20:01 INFO - 'sessionrestore', 23:20:01 INFO - 'sessionrestore_no_auto_restore', 23:20:01 INFO - 'tabpaint']}, 23:20:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:20:01 INFO - 'tests': ['a11yr', 23:20:01 INFO - 'ts_paint', 23:20:01 INFO - 'tpaint', 23:20:01 INFO - 'sessionrestore', 23:20:01 INFO - 'sessionrestore_no_auto_restore', 23:20:01 INFO - 'tabpaint']}, 23:20:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:20:01 INFO - 'tests': ['tsvgx', 23:20:01 INFO - 'tsvgr_opacity', 23:20:01 INFO - 'tart', 23:20:01 INFO - 'tscrollx', 23:20:01 INFO - 'cart']}, 23:20:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:20:01 INFO - 'tsvgr_opacity', 23:20:01 INFO - 'tart', 23:20:01 INFO - 'tscrollx', 23:20:01 INFO - 'cart']}, 23:20:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:20:01 INFO - 'talos_options': ['--disable-e10s'], 23:20:01 INFO - 'tests': ['tp5o']}, 23:20:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:20:01 INFO - 'tests': ['tp5o']}, 23:20:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:20:01 INFO - 'talos_options': ['--disable-e10s', 23:20:01 INFO - '--xperf_path', 23:20:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:20:01 INFO - 'tests': ['tp5n']}, 23:20:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:20:01 INFO - 'talos_options': ['--xperf_path', 23:20:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:20:01 INFO - 'tests': ['tp5n']}}, 23:20:01 INFO - 'talos.zip': {'path': '', 23:20:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:20:01 INFO - Running post-action listener: _resource_record_post_action 23:20:01 INFO - ##### 23:20:01 INFO - ##### Running create-virtualenv step. 23:20:01 INFO - ##### 23:20:01 INFO - Running pre-action listener: _resource_record_pre_action 23:20:01 INFO - Running main action method: create_virtualenv 23:20:01 INFO - Creating virtualenv /builds/slave/test/build/venv 23:20:01 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 23:20:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:20:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:20:02 INFO - Using real prefix '/usr' 23:20:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:20:02 INFO - Installing distribute.............................................................................................................................................................................................done. 23:20:04 INFO - Installing pip.................done. 23:20:04 INFO - Return code: 0 23:20:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:20: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')]} 23:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:20:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:20: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')]} 23:20:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:20:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:20: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9731a9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x120e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1368410>, '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 0x1369310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13697a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1461478677.437013-192345811', '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 23:20: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', 'pip>=1.5'] in /builds/slave/test/build 23:20: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 pip>=1.5 23:20:04 INFO - Using env: {'DISPLAY': ':0', 23:20:04 INFO - 'HOME': '/home/cltbld', 23:20:04 INFO - 'LANG': 'en_US.UTF-8', 23:20:04 INFO - 'LANGUAGE': 'en_US:en', 23:20:04 INFO - 'LOGNAME': 'cltbld', 23:20:04 INFO - 'MAIL': '/var/mail/cltbld', 23:20:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:20:04 INFO - 'MOZ_NO_REMOTE': '1', 23:20:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:20:04 INFO - 'NO_EM_RESTART': '1', 23:20:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:20:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:20:04 INFO - 'PWD': '/builds/slave/test', 23:20:04 INFO - 'SHELL': '/bin/bash', 23:20:04 INFO - 'SHLVL': '1', 23:20:04 INFO - 'TERM': 'linux', 23:20:04 INFO - 'TMOUT': '86400', 23:20:04 INFO - 'USER': 'cltbld', 23:20:04 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1461478677.437013-192345811', 23:20:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:20:04 INFO - '_': '/tools/buildbot/bin/python'} 23:20:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:20:05 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 23:20:05 INFO - Cleaning up... 23:20:05 INFO - Return code: 0 23:20:05 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 23:20:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:20:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:20:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:20:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:20:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:20:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9731a9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x120e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1368410>, '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 0x1369310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13697a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1461478677.437013-192345811', '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 23:20:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 23:20:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 23:20:05 INFO - Using env: {'DISPLAY': ':0', 23:20:05 INFO - 'HOME': '/home/cltbld', 23:20:05 INFO - 'LANG': 'en_US.UTF-8', 23:20:05 INFO - 'LANGUAGE': 'en_US:en', 23:20:05 INFO - 'LOGNAME': 'cltbld', 23:20:05 INFO - 'MAIL': '/var/mail/cltbld', 23:20:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:20:05 INFO - 'MOZ_NO_REMOTE': '1', 23:20:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:20:05 INFO - 'NO_EM_RESTART': '1', 23:20:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:20:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:20:05 INFO - 'PWD': '/builds/slave/test', 23:20:05 INFO - 'SHELL': '/bin/bash', 23:20:05 INFO - 'SHLVL': '1', 23:20:05 INFO - 'TERM': 'linux', 23:20:05 INFO - 'TMOUT': '86400', 23:20:05 INFO - 'USER': 'cltbld', 23:20:05 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1461478677.437013-192345811', 23:20:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:20:05 INFO - '_': '/tools/buildbot/bin/python'} 23:20:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:20:05 INFO - Downloading/unpacking psutil>=0.7.1 23:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:20:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:20:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:20:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:20:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:20:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:20:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:20:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:20:07 INFO - Installing collected packages: psutil 23:20:07 INFO - Running setup.py install for psutil 23:20:07 INFO - building 'psutil._psutil_linux' extension 23:20:07 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 23:20:08 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 23:20:08 INFO - building 'psutil._psutil_posix' extension 23:20:08 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 23:20:08 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 23:20:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:20:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:20:09 INFO - Successfully installed psutil 23:20:09 INFO - Cleaning up... 23:20:09 INFO - Return code: 0 23:20:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 23:20:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:20:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:20:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:20:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:20:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:20:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:20:09 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 0x7f9731a9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x120e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1368410>, '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 0x1369310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13697a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1461478677.437013-192345811', '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 23:20:09 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 23:20:09 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 23:20:09 INFO - Using env: {'DISPLAY': ':0', 23:20:09 INFO - 'HOME': '/home/cltbld', 23:20:09 INFO - 'LANG': 'en_US.UTF-8', 23:20:09 INFO - 'LANGUAGE': 'en_US:en', 23:20:09 INFO - 'LOGNAME': 'cltbld', 23:20:09 INFO - 'MAIL': '/var/mail/cltbld', 23:20:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:20:09 INFO - 'MOZ_NO_REMOTE': '1', 23:20:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:20:09 INFO - 'NO_EM_RESTART': '1', 23:20:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:20:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:20:09 INFO - 'PWD': '/builds/slave/test', 23:20:09 INFO - 'SHELL': '/bin/bash', 23:20:09 INFO - 'SHLVL': '1', 23:20:09 INFO - 'TERM': 'linux', 23:20:09 INFO - 'TMOUT': '86400', 23:20:09 INFO - 'USER': 'cltbld', 23:20:09 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1461478677.437013-192345811', 23:20:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:20:09 INFO - '_': '/tools/buildbot/bin/python'} 23:20:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:20:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:20: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 23:20: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 23:20: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 23:20: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 23:20: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 23:20: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 23:20:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:20:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:20:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:20:11 INFO - Installing collected packages: mozsystemmonitor 23:20:11 INFO - Running setup.py install for mozsystemmonitor 23:20:11 INFO - Successfully installed mozsystemmonitor 23:20:11 INFO - Cleaning up... 23:20:11 INFO - Return code: 0 23:20:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:20:11 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')]} 23:20:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:20:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:20:11 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')]} 23:20:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:20:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:20:11 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 0x7f9731a9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x120e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1368410>, '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 0x1369310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13697a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1461478677.437013-192345811', '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 23:20:11 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 23:20:11 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 23:20:11 INFO - Using env: {'DISPLAY': ':0', 23:20:11 INFO - 'HOME': '/home/cltbld', 23:20:11 INFO - 'LANG': 'en_US.UTF-8', 23:20:11 INFO - 'LANGUAGE': 'en_US:en', 23:20:11 INFO - 'LOGNAME': 'cltbld', 23:20:11 INFO - 'MAIL': '/var/mail/cltbld', 23:20:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:20:11 INFO - 'MOZ_NO_REMOTE': '1', 23:20:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:20:11 INFO - 'NO_EM_RESTART': '1', 23:20:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:20:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:20:11 INFO - 'PWD': '/builds/slave/test', 23:20:11 INFO - 'SHELL': '/bin/bash', 23:20:11 INFO - 'SHLVL': '1', 23:20:11 INFO - 'TERM': 'linux', 23:20:11 INFO - 'TMOUT': '86400', 23:20:11 INFO - 'USER': 'cltbld', 23:20:11 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1461478677.437013-192345811', 23:20:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:20:11 INFO - '_': '/tools/buildbot/bin/python'} 23:20:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:20:11 INFO - Downloading/unpacking blobuploader==1.2.4 23:20:11 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 23:20:11 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 23:20:11 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 23:20:11 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 23:20:11 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 23:20:11 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 23:20:13 INFO - Downloading blobuploader-1.2.4.tar.gz 23:20:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:20:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:20:13 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 23:20:13 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 23:20:13 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 23:20:13 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 23:20:13 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 23:20:13 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 23:20:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:20:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:20:13 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 23:20:13 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 23:20:13 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 23:20:13 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 23:20:13 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 23:20:13 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 23:20:14 INFO - Downloading docopt-0.6.1.tar.gz 23:20:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:20:14 INFO - Installing collected packages: blobuploader, requests, docopt 23:20:14 INFO - Running setup.py install for blobuploader 23:20:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:20:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:20:14 INFO - Running setup.py install for requests 23:20:14 INFO - Running setup.py install for docopt 23:20:14 INFO - Successfully installed blobuploader requests docopt 23:20:14 INFO - Cleaning up... 23:20:14 INFO - Return code: 0 23:20:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:20:14 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')]} 23:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:20:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:20:14 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')]} 23:20:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:20:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:20:14 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 0x7f9731a9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x120e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1368410>, '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 0x1369310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13697a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1461478677.437013-192345811', '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 23:20:14 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 23:20:14 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 23:20:14 INFO - Using env: {'DISPLAY': ':0', 23:20:14 INFO - 'HOME': '/home/cltbld', 23:20:14 INFO - 'LANG': 'en_US.UTF-8', 23:20:14 INFO - 'LANGUAGE': 'en_US:en', 23:20:14 INFO - 'LOGNAME': 'cltbld', 23:20:14 INFO - 'MAIL': '/var/mail/cltbld', 23:20:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:20:14 INFO - 'MOZ_NO_REMOTE': '1', 23:20:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:20:14 INFO - 'NO_EM_RESTART': '1', 23:20:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:20:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:20:14 INFO - 'PWD': '/builds/slave/test', 23:20:14 INFO - 'SHELL': '/bin/bash', 23:20:14 INFO - 'SHLVL': '1', 23:20:14 INFO - 'TERM': 'linux', 23:20:14 INFO - 'TMOUT': '86400', 23:20:14 INFO - 'USER': 'cltbld', 23:20:14 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1461478677.437013-192345811', 23:20:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:20:14 INFO - '_': '/tools/buildbot/bin/python'} 23:20:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:20:15 INFO - Running setup.py (path:/tmp/pip-wrRKpi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:20:15 INFO - Running setup.py (path:/tmp/pip-OWIAI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:20:15 INFO - Running setup.py (path:/tmp/pip-gAwYdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:20:15 INFO - Running setup.py (path:/tmp/pip-kEP_Wb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:20:15 INFO - Running setup.py (path:/tmp/pip-b4HcNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:20:15 INFO - Running setup.py (path:/tmp/pip-fMRk6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:20:15 INFO - Running setup.py (path:/tmp/pip-BKnZJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:20:15 INFO - Running setup.py (path:/tmp/pip-o1z7Ia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:20:15 INFO - Running setup.py (path:/tmp/pip-NOc_St-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:20:15 INFO - Running setup.py (path:/tmp/pip-Vp9n6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:20:15 INFO - Running setup.py (path:/tmp/pip-vPU2D7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:20:15 INFO - Running setup.py (path:/tmp/pip-WFW0ai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:20:15 INFO - Running setup.py (path:/tmp/pip-N_P5C_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:20:16 INFO - Running setup.py (path:/tmp/pip-giGhNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:20:16 INFO - Running setup.py (path:/tmp/pip-0asLp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:20:16 INFO - Running setup.py (path:/tmp/pip-6eu9dp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:20:16 INFO - Running setup.py (path:/tmp/pip-HVYbeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:20:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:20:16 INFO - Running setup.py install for manifestparser 23:20:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:20:16 INFO - Running setup.py install for mozcrash 23:20:16 INFO - Running setup.py install for mozdebug 23:20:16 INFO - Running setup.py install for mozdevice 23:20:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:20:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:20:16 INFO - Running setup.py install for mozfile 23:20:16 INFO - Running setup.py install for mozhttpd 23:20:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:20:16 INFO - Running setup.py install for mozinfo 23:20:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:20:17 INFO - Running setup.py install for mozInstall 23:20:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:20:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:20:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:20:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:20:17 INFO - Running setup.py install for mozleak 23:20:17 INFO - Running setup.py install for mozlog 23:20:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:20:17 INFO - Running setup.py install for moznetwork 23:20:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:20:17 INFO - Running setup.py install for mozprocess 23:20:17 INFO - Running setup.py install for mozprofile 23:20:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:20:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:20:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:20:17 INFO - Running setup.py install for mozrunner 23:20:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:20:17 INFO - Running setup.py install for mozscreenshot 23:20:17 INFO - Running setup.py install for moztest 23:20:17 INFO - Running setup.py install for mozversion 23:20:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:20:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:20:18 INFO - Cleaning up... 23:20:18 INFO - Return code: 0 23:20:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:20:18 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')]} 23:20:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:20:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:20:18 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')]} 23:20:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:20:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:20:18 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 0x7f9731a9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x120e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1368410>, '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 0x1369310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13697a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1461478677.437013-192345811', '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 23:20:18 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 23:20:18 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 23:20:18 INFO - Using env: {'DISPLAY': ':0', 23:20:18 INFO - 'HOME': '/home/cltbld', 23:20:18 INFO - 'LANG': 'en_US.UTF-8', 23:20:18 INFO - 'LANGUAGE': 'en_US:en', 23:20:18 INFO - 'LOGNAME': 'cltbld', 23:20:18 INFO - 'MAIL': '/var/mail/cltbld', 23:20:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:20:18 INFO - 'MOZ_NO_REMOTE': '1', 23:20:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:20:18 INFO - 'NO_EM_RESTART': '1', 23:20:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:20:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:20:18 INFO - 'PWD': '/builds/slave/test', 23:20:18 INFO - 'SHELL': '/bin/bash', 23:20:18 INFO - 'SHLVL': '1', 23:20:18 INFO - 'TERM': 'linux', 23:20:18 INFO - 'TMOUT': '86400', 23:20:18 INFO - 'USER': 'cltbld', 23:20:18 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1461478677.437013-192345811', 23:20:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:20:18 INFO - '_': '/tools/buildbot/bin/python'} 23:20:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:20:18 INFO - Running setup.py (path:/tmp/pip-C42ZZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:20:18 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)) 23:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:20:18 INFO - Running setup.py (path:/tmp/pip-wxZbl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:20:18 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)) 23:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:20:18 INFO - Running setup.py (path:/tmp/pip-o73Ovh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:20:18 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)) 23:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:20:18 INFO - Running setup.py (path:/tmp/pip-fKJp1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:20:18 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)) 23:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:20:18 INFO - Running setup.py (path:/tmp/pip-UYJAGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:20:18 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)) 23:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:20:18 INFO - Running setup.py (path:/tmp/pip-Y3SH2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:20:18 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)) 23:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:20:18 INFO - Running setup.py (path:/tmp/pip-Ylm5Gx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:20:18 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)) 23:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:20:18 INFO - Running setup.py (path:/tmp/pip-pZoYFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:20:18 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)) 23:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:20:18 INFO - Running setup.py (path:/tmp/pip-rOBYSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:20:18 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)) 23:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:20:18 INFO - Running setup.py (path:/tmp/pip-BLNE1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:20:19 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)) 23:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:20:19 INFO - Running setup.py (path:/tmp/pip-gT6bCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:20:19 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)) 23:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:20:19 INFO - Running setup.py (path:/tmp/pip-oqFFU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:20:19 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)) 23:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:20:19 INFO - Running setup.py (path:/tmp/pip-ra2hPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:20:19 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)) 23:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:20:19 INFO - Running setup.py (path:/tmp/pip-5GI9mo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:20:19 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)) 23:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:20:19 INFO - Running setup.py (path:/tmp/pip-PM6xvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:20:19 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)) 23:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:20:19 INFO - Running setup.py (path:/tmp/pip-p_00If-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:20:19 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)) 23:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:20:19 INFO - Running setup.py (path:/tmp/pip-2mmxF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:20:19 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)) 23:20:19 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)) 23:20:19 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)) 23:20:19 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)) 23:20:19 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)) 23:20:19 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)) 23:20:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:20:19 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 23:20:19 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 23:20:19 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 23:20:19 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 23:20:19 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 23:20:19 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 23:20:21 INFO - Downloading blessings-1.6.tar.gz 23:20:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:20:21 INFO - Installing collected packages: blessings 23:20:21 INFO - Running setup.py install for blessings 23:20:21 INFO - Successfully installed blessings 23:20:21 INFO - Cleaning up... 23:20:21 INFO - Return code: 0 23:20:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:20:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:20:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:20:21 INFO - Reading from file tmpfile_stdout 23:20:21 INFO - Current package versions: 23:20:21 INFO - argparse == 1.2.1 23:20:21 INFO - blessings == 1.6 23:20:21 INFO - blobuploader == 1.2.4 23:20:21 INFO - docopt == 0.6.1 23:20:21 INFO - manifestparser == 1.1 23:20:21 INFO - mozInstall == 1.12 23:20:21 INFO - mozcrash == 0.17 23:20:21 INFO - mozdebug == 0.1 23:20:21 INFO - mozdevice == 0.48 23:20:21 INFO - mozfile == 1.2 23:20:21 INFO - mozhttpd == 0.7 23:20:21 INFO - mozinfo == 0.9 23:20:21 INFO - mozleak == 0.1 23:20:21 INFO - mozlog == 3.1 23:20:21 INFO - moznetwork == 0.27 23:20:21 INFO - mozprocess == 0.22 23:20:21 INFO - mozprofile == 0.28 23:20:21 INFO - mozrunner == 6.11 23:20:21 INFO - mozscreenshot == 0.1 23:20:21 INFO - mozsystemmonitor == 0.0 23:20:21 INFO - moztest == 0.7 23:20:21 INFO - mozversion == 1.4 23:20:21 INFO - psutil == 3.1.1 23:20:21 INFO - requests == 1.2.3 23:20:21 INFO - wsgiref == 0.1.2 23:20:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:20:21 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')]} 23:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:20:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:20:21 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')]} 23:20:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:20:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:20:21 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 0x7f9731a9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x120e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1368410>, '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 0x1369310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13697a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1461478677.437013-192345811', '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 23:20:21 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 23:20:21 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 23:20:21 INFO - Using env: {'DISPLAY': ':0', 23:20:21 INFO - 'HOME': '/home/cltbld', 23:20:21 INFO - 'LANG': 'en_US.UTF-8', 23:20:21 INFO - 'LANGUAGE': 'en_US:en', 23:20:21 INFO - 'LOGNAME': 'cltbld', 23:20:21 INFO - 'MAIL': '/var/mail/cltbld', 23:20:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:20:21 INFO - 'MOZ_NO_REMOTE': '1', 23:20:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:20:21 INFO - 'NO_EM_RESTART': '1', 23:20:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:20:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:20:21 INFO - 'PWD': '/builds/slave/test', 23:20:21 INFO - 'SHELL': '/bin/bash', 23:20:21 INFO - 'SHLVL': '1', 23:20:21 INFO - 'TERM': 'linux', 23:20:21 INFO - 'TMOUT': '86400', 23:20:21 INFO - 'USER': 'cltbld', 23:20:21 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1461478677.437013-192345811', 23:20:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:20:21 INFO - '_': '/tools/buildbot/bin/python'} 23:20:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:20:22 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)) 23:20:22 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)) 23:20:22 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)) 23:20:22 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)) 23:20:22 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)) 23:20:22 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)) 23:20:22 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)) 23:20:22 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)) 23:20:22 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)) 23:20:22 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)) 23:20:22 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)) 23:20:22 INFO - Cleaning up... 23:20:22 INFO - Return code: 0 23:20:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:20:22 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')]} 23:20:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:20:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:20:22 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')]} 23:20:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:20:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:20:22 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 0x7f9731a9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x120e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1368410>, '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 0x1369310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13697a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1461478677.437013-192345811', '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 23:20:22 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 23:20:22 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 23:20:22 INFO - Using env: {'DISPLAY': ':0', 23:20:22 INFO - 'HOME': '/home/cltbld', 23:20:22 INFO - 'LANG': 'en_US.UTF-8', 23:20:22 INFO - 'LANGUAGE': 'en_US:en', 23:20:22 INFO - 'LOGNAME': 'cltbld', 23:20:22 INFO - 'MAIL': '/var/mail/cltbld', 23:20:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:20:22 INFO - 'MOZ_NO_REMOTE': '1', 23:20:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:20:22 INFO - 'NO_EM_RESTART': '1', 23:20:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:20:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:20:22 INFO - 'PWD': '/builds/slave/test', 23:20:22 INFO - 'SHELL': '/bin/bash', 23:20:22 INFO - 'SHLVL': '1', 23:20:22 INFO - 'TERM': 'linux', 23:20:22 INFO - 'TMOUT': '86400', 23:20:22 INFO - 'USER': 'cltbld', 23:20:22 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1461478677.437013-192345811', 23:20:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:20:22 INFO - '_': '/tools/buildbot/bin/python'} 23:20:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:20:22 INFO - Downloading/unpacking jsonschema 23:20:22 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 23:20:22 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 23:20:22 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 23:20:22 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 23:20:22 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 23:20:22 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 23:20:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:20:24 INFO - Downloading/unpacking functools32 (from jsonschema) 23:20:24 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 23:20:24 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 23:20:24 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 23:20:24 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 23:20:24 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 23:20:24 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 23:20:24 INFO - Downloading functools32-3.2.3-2.tar.gz 23:20:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:20:24 INFO - warning: no files found matching '*.txt' 23:20:24 INFO - no previously-included directories found matching 'build' 23:20:24 INFO - no previously-included directories found matching 'dist' 23:20:24 INFO - no previously-included directories found matching '.git*' 23:20:24 INFO - Installing collected packages: jsonschema, functools32 23:20:24 INFO - Running setup.py install for functools32 23:20:24 INFO - warning: no files found matching '*.txt' 23:20:24 INFO - no previously-included directories found matching 'build' 23:20:24 INFO - no previously-included directories found matching 'dist' 23:20:24 INFO - no previously-included directories found matching '.git*' 23:20:24 INFO - Successfully installed jsonschema functools32 23:20:24 INFO - Cleaning up... 23:20:24 INFO - Return code: 0 23:20:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:20:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:20:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:20:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:20:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:20:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:20:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:20:24 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 0x7f9731a9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x120e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1368410>, '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 0x1369310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13697a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1461478677.437013-192345811', '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 23:20:24 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 23:20:24 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 23:20:24 INFO - Using env: {'DISPLAY': ':0', 23:20:24 INFO - 'HOME': '/home/cltbld', 23:20:24 INFO - 'LANG': 'en_US.UTF-8', 23:20:24 INFO - 'LANGUAGE': 'en_US:en', 23:20:24 INFO - 'LOGNAME': 'cltbld', 23:20:24 INFO - 'MAIL': '/var/mail/cltbld', 23:20:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:20:24 INFO - 'MOZ_NO_REMOTE': '1', 23:20:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:20:24 INFO - 'NO_EM_RESTART': '1', 23:20:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:20:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:20:24 INFO - 'PWD': '/builds/slave/test', 23:20:24 INFO - 'SHELL': '/bin/bash', 23:20:24 INFO - 'SHLVL': '1', 23:20:24 INFO - 'TERM': 'linux', 23:20:24 INFO - 'TMOUT': '86400', 23:20:24 INFO - 'USER': 'cltbld', 23:20:24 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1461478677.437013-192345811', 23:20:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:20:24 INFO - '_': '/tools/buildbot/bin/python'} 23:20:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:20:24 INFO - Downloading/unpacking flake8 23:20:24 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 23:20:24 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 23:20:24 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 23:20:24 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 23:20:24 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 23:20:24 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 23:20:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:20:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:20:26 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 23:20:26 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 23:20:26 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 23:20:26 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 23:20:26 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 23:20:26 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 23:20:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:20:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:20:27 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 23:20:27 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 23:20:27 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 23:20:27 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 23:20:27 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 23:20:27 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 23:20:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:20:27 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 23:20:27 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 23:20:27 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 23:20:27 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 23:20:27 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 23:20:27 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 23:20:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:20:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:20:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:20:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:20:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:20:27 INFO - no previously-included directories found matching 'docs/_build' 23:20:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:20:27 INFO - Running setup.py install for pep8 23:20:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:20:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:20:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:20:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:20:27 INFO - no previously-included directories found matching 'docs/_build' 23:20:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:20:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:20:27 INFO - Cleaning up... 23:20:27 INFO - Return code: 0 23:20:27 INFO - Running post-action listener: _resource_record_post_action 23:20:27 INFO - Running post-action listener: _start_resource_monitoring 23:20:27 INFO - Starting resource monitoring. 23:20:27 INFO - ##### 23:20:27 INFO - ##### Running install step. 23:20:27 INFO - ##### 23:20:27 INFO - Running pre-action listener: _resource_record_pre_action 23:20:27 INFO - Running main action method: install 23:20:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:20:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:20:28 INFO - Reading from file tmpfile_stdout 23:20:28 INFO - Detecting whether we're running mozinstall >=1.0... 23:20:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:20:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:20:28 INFO - Reading from file tmpfile_stdout 23:20:28 INFO - Output received: 23:20:28 INFO - Usage: mozinstall [options] installer 23:20:28 INFO - Options: 23:20:28 INFO - -h, --help show this help message and exit 23:20:28 INFO - -d DEST, --destination=DEST 23:20:28 INFO - Directory to install application into. [default: 23:20:28 INFO - "/builds/slave/test"] 23:20:28 INFO - --app=APP Application being installed. [default: firefox] 23:20:28 INFO - mkdir: /builds/slave/test/build/application 23:20:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:20:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:20:44 INFO - Reading from file tmpfile_stdout 23:20:44 INFO - Output received: 23:20:44 INFO - /builds/slave/test/build/application/firefox/firefox 23:20:44 INFO - Running post-action listener: _resource_record_post_action 23:20:44 INFO - ##### 23:20:44 INFO - ##### Running run-tests step. 23:20:44 INFO - ##### 23:20:44 INFO - Running pre-action listener: _resource_record_pre_action 23:20:44 INFO - Running main action method: run_tests 23:20:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:20:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:20:44 INFO - Python 2.7.3 23:20:44 INFO - Return code: 0 23:20:44 INFO - grabbing minidump binary from tooltool 23:20:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:20:44 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 0x1368410>, '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 0x1369310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13697a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:20:44 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 23:20:44 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 23:20:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:20:44 INFO - Return code: 0 23:20:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:20:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:20:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:20:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:20:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:20:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:20:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:20:45 INFO - Return code: 0 23:20:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IccouWiyTmKnZ6lP-hr2jw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 23:20:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IccouWiyTmKnZ6lP-hr2jw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --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 23:20:45 INFO - Using env: {'DISPLAY': ':0', 23:20:45 INFO - 'HOME': '/home/cltbld', 23:20:45 INFO - 'LANG': 'en_US.UTF-8', 23:20:45 INFO - 'LANGUAGE': 'en_US:en', 23:20:45 INFO - 'LOGNAME': 'cltbld', 23:20:45 INFO - 'MAIL': '/var/mail/cltbld', 23:20:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:20:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:20:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:20:45 INFO - 'MOZ_NO_REMOTE': '1', 23:20:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:20:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:20:45 INFO - 'NO_EM_RESTART': '1', 23:20:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:20:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:20:45 INFO - 'PWD': '/builds/slave/test', 23:20:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:20:45 INFO - 'SHELL': '/bin/bash', 23:20:45 INFO - 'SHLVL': '1', 23:20:45 INFO - 'TERM': 'linux', 23:20:45 INFO - 'TMOUT': '86400', 23:20:45 INFO - 'USER': 'cltbld', 23:20:45 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1461478677.437013-192345811', 23:20:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:20:45 INFO - '_': '/tools/buildbot/bin/python'} 23:20:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IccouWiyTmKnZ6lP-hr2jw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 23:20:45 INFO - mozversion application_buildid: 20160423223116 23:20:45 INFO - mozversion application_changeset: 8afadb96e97704a98492c2286fb92479deb3365f 23:20:45 INFO - mozversion application_display_name: Nightly 23:20:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:20:45 INFO - mozversion application_name: Firefox 23:20:45 INFO - mozversion application_remotingname: firefox 23:20:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:20:45 INFO - mozversion application_vendor: Mozilla 23:20:45 INFO - mozversion application_version: 48.0a1 23:20:45 INFO - mozversion platform_buildid: 20160423223116 23:20:45 INFO - mozversion platform_changeset: 8afadb96e97704a98492c2286fb92479deb3365f 23:20:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:20:45 INFO - mozversion platform_version: 48.0a1 23:20:45 INFO - using testdate: 1461478845 23:20:45 INFO - actual date: 1461478845 23:20:45 INFO - starting webserver on 'localhost:57126' 23:20:45 INFO - SUITE-START | Running 2 tests 23:20:45 INFO - TEST-START | dromaeo_css 23:20:45 INFO - operating with platform_type : linux_ 23:20:45 INFO - Initialising browser for dromaeo_css test... 23:20:45 INFO - TEST-INFO | started process 3294 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt7qJOq/profile http://localhost:57126/getInfo.html) 23:20:53 INFO - PROCESS | 3294 | __metrics Screen width/height:1600/1200 23:20:53 INFO - PROCESS | 3294 | colorDepth:24 23:20:53 INFO - PROCESS | 3294 | Browser inner width/height: 1024/697 23:20:53 INFO - PROCESS | 3294 | __metrics 23:20:55 ERROR - PROCESS | 3294 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:20:56 INFO - TEST-INFO | 3294: exit 0 23:20:56 INFO - Browser initialized. 23:20:56 INFO - Running cycle 1/1 for dromaeo_css test... 23:20:56 INFO - TEST-INFO | started process 3378 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt7qJOq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:21:08 INFO - PROCESS | 3378 | RSS: Main: 156008448 23:21:08 INFO - PROCESS | 3378 | 23:21:59 INFO - PROCESS | 3378 | 1461478919439 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] 23:24:11 INFO - PROCESS | 3378 | Cycle 1(1): loaded http://localhost:57126/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57126/tests/dromaeo/cssquery-ext.html) 23:24:12 INFO - PROCESS | 3378 | RSS: Main: 264130560 23:24:12 INFO - PROCESS | 3378 | 23:27:15 INFO - PROCESS | 3378 | Cycle 1(1): loaded http://localhost:57126/tests/dromaeo/cssquery-ext.html (next: http://localhost:57126/tests/dromaeo/cssquery-jquery.html) 23:27:15 INFO - PROCESS | 3378 | RSS: Main: 235245568 23:27:15 INFO - PROCESS | 3378 | 23:30:17 INFO - PROCESS | 3378 | Cycle 1(1): loaded http://localhost:57126/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57126/tests/dromaeo/cssquery-mootools.html) 23:30:18 INFO - PROCESS | 3378 | RSS: Main: 235155456 23:30:18 INFO - PROCESS | 3378 | 23:33:20 INFO - PROCESS | 3378 | Cycle 1(1): loaded http://localhost:57126/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57126/tests/dromaeo/cssquery-prototype.html) 23:33:21 INFO - PROCESS | 3378 | RSS: Main: 234643456 23:33:21 INFO - PROCESS | 3378 | 23:36:24 INFO - PROCESS | 3378 | Cycle 1(1): loaded http://localhost:57126/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57126/tests/dromaeo/cssquery-yui.html) 23:36:24 INFO - PROCESS | 3378 | RSS: Main: 216215552 23:36:24 INFO - PROCESS | 3378 | 23:39:27 INFO - PROCESS | 3378 | Cycle 1(1): loaded http://localhost:57126/tests/dromaeo/cssquery-yui.html (next: http://localhost:57126/tests/dromaeo/cssquery-dojo.html) 23:39:27 INFO - PROCESS | 3378 | RSS: Main: 271036416 23:39:27 INFO - PROCESS | 3378 | 23:39:27 INFO - PROCESS | 3378 | __start_tp_report 23:39:27 INFO - PROCESS | 3378 | _x_x_mozilla_page_load 23:39:27 INFO - PROCESS | 3378 | _x_x_mozilla_page_load_details 23:39:27 INFO - PROCESS | 3378 | |i|pagename|runs| 23:39:27 INFO - PROCESS | 3378 | |0;dojo.html;2608.334874606975;2688.892444302228;2692.7576518113365;2716.2666080158356;2717.9728202717965;4589.495155532897;4635.652326075541;4665.463471700756;4720.811167553298;4724.196886529289;4654.860354189372;4703.835365762199;4772.260299653559;4791.185498465261;4798.040391921612;4236.9364459533135;4252.851150209735;4274.209271284807;4314.180305741915;4350.956490435103;4354.629856462205;4375.4311939447825;4376.496702879178;4383.3863259143745;4407.140607581523;4261.275583150872;4312.05134870328;4330.5669433056755;4377.037051848588;4392.670549708769;4268.573142685737;4301.118270754488;4333.328334108218;4339.1972485090355;4376.737395756265;4309.375140604595;4334.176506463793;4347.586979236968;4387.824487020547;4389.846355377578;4633.490316065264;4643.605293550052;4654.208784506608;4674.579287864109;4704.059188162381;4936.80252789888;4940.308356830046;4985.651004429691;5050.520200580939;5050.9494905051215;5029.84910452687;5055.797768089272;5068.493150684939;5087.87280317995;5088.847334579968;4596.701214421052;4731;4736.123817093849;4739.691920025188;4772.498887616785;5063.1645778446145;5087.949120508822;5108.361454818148;5128.410232823273;5158.690478571298;4967.3294105296045;5012.473690262543;5012.749362531858;5018.473060328686;5061.670991385548;4972.67677600962;5017.272495488134;5061.34202553673;5093.032323858455;5099.133147364957;5021.84934451967;5039.546440820343;5043.672161309503;5056.039352523009;5081.822136225288;5018.5232402921665;5030.3963524377305;5037.118504261813;5053.36832895888;5079.034983353151;4201.7268877522865;4260.744355338689;4291.785410729451;4355.1942890564715;4402.691811573223;3752.2683076799763;3774.8490060397826;3794.6395092466173;3810.333191691443;3834.654881060718;4328.978355108267;4334.544872788375;4335.566443355702;4340.001799586113;4382.7370357778;4960.8759781005765;5034.370703662043;5078.263651770547;5118.61610379223;5127.025865085622;4301.526832048472;4320.611144996966;4323.610875021201;4349.956500434955;4367.781610919441;4553.749543775058;4560.6807523473035;4560.794764235618;4567.10941366437;4615.723056616546;4643.349931009594;4730.787114579921;4762.285657151524;4822.7829747662145;4834.8791280216865;5048.217526283432;5060.974695126501;5066.721330326867;5067.695938243717;5119.0529751996;4719.10337035962;4751.311059896227;4767.4517430495935;4768.4754676986195;4771.5228477152;4840.540148685869;4865.7323847188745;4891.046245981999;4902.63230257725;4904.5340692634145;4998.4251811042195;5004.5746111579465;5018.42288136869;5023.2214006829;5062.341895553554;4706.835260765857;4850.733209673502;4885.95114048855;4889.462159162418;4932.21084626458;4855.854324370274;4909.312696222603;4921.237208232729;4943.901121977468;4945.579625731853;4756.215224487921;4762.547557981986;4765.785539650793;4771.284307353924;4800.831970881142;4803.1114243864995;4863.392075990501;4867.415910090812;4884.389451318585;4899.289603007615;4862.343583616166;4869.853904382874;4884.682495637772;4901.730404827626;4916.3362946001835 23:39:27 INFO - PROCESS | 3378 | |1;ext.html;566.6515093217672;596.6599038548023;605.8969975104231;615.012904288617;623.5759683415278;27161.04936327229;34834;36245.63754362452;36381.81809090951;36494.8175259124;37791.622083779155;38481;38506.4224036639;38511.22977540454;38556;7635.236476352362;7823.295903368696;7825.686972521121;7832.804179895491;7853.450258481908;7723.266289702469;7841.451098423113;7846.097698764629;7850.685972561119;7851.6652169131385;7818.218178182165;8016.278534931855;8016.639251233709;8017.158198389173;8017.799555011113;7882.921170788305;7933.167017463199;7933.484323518953;7936.761897143095;7950.960245198795;7709.190534993801;7822.374210063182;7826.217378262185;7826.882596761053;7833;37587.812060939796;37789.811050944845;37838.43242351367;38076.619233807585;38326.42510362347;3199.8641331495032;3254.1539199807985;3305.140663427502;3358.4122778513906;3783.7540559863796;28447.857760711064;28469;28823.71176288231;29870.954516591813;30564;3419.5383623211046;3449.275652113059;3474.930501389958;3482.2165012872156;3496.3881320768764;231467;232416;232754;233344;233526;32512.349753004808;33613.83193084019;52419;52969.735151324;53152;31486.527702084488;31622.525662115087;31654.841725791222;31671.36657266842;31773;12355.444005019795;12497.687557811127;12499.875001250053;12510.74978500425;12527.749445011048;10423.374597524173;10430.426326552113;10470.685879423629;10502.369857808557;10537.473126343652;8178.427510074357;8241.299489543457;8270.793230169294;8333.958330208432;8365.372597055124;3224.8229396270194;3248.6101667800017;3278.3607196596436;3295.802251864896;3297.472404415282;913.5888850017519;930.1675000874179;952.6760901293455;985.1872205430549;1005.8943810899897;27482.862585686944;28557.714422855504;28590.428191436054;28598.428031439256;28950.42099158005;993.9701808945744;994.835852084398;1014.437369411039;1015.8069966706303;1058.0319008107494;15066.171360575274;15186.392544298104;15289.15909624959;15496.225188740744;15542.9222853885;368866;374547;375297;375825;375842;48210.758946205046;49067.50932490629;49126.754366228655;49452.50547494551;49576.752116239186;1125.358545629;1142.7485953090306;1169.2808922512593;1173.2549830857467;1269.4541347220784;25523.74476255288;26118.34704132412;27962.161135165978;28954;29003.41993160167;39474.210515788945;39806.402903957045;39993.40009899912;40025.79987100046;40059.799701001306;239395;240585;240853;241023;241818;24708.876455618327;25920.092796752022;25927.870360648078;25942.351441213366;25964.610530841674;43365.66343365638;43716.56283437252;43736.781316094486;44541.777291113336;44973.77513112414;35024.824875875456;36183.63816361803;36603.81698091599;36618.63381366152;37002.44496332611;35691;36603.816980914926;36685.44971825478;36746.63253367539;36802;29430.142402312642;30451;36444.45333319949;37311.253774924895;37376.43935340918;27321.590176146976;29341.706582933897;29412.705872941;29517.262068447602;29625.07559967435;24120.276391708278;24457;24602.753972460046;24723.87638061798;25018 23:39:27 INFO - PROCESS | 3378 | |2;jquery.html;379.6014185105637;386.3451449792601;391.62334191730264;394.4083874188717;401.1355528835359;15003.774943375844;15631;15670.451534196305;15676.216189190553;16305.51083467495;16071.839281607181;16092.436764713237;16760.748588771177;16865.241064152113;17947.461576152702;5034.723090230045;5189.351331083614;5203.921941170866;5226.843194704146;5235.2147177923425;5115.9488405116035;5126.871828204287;5127.435982041972;5142.537171654551;5142.562882155022;4987.700737955716;5095.5923526118;5106.4382917879;5107.310513080743;5116.079105760961;5081.161608334621;5092.872678183056;5098.668586541863;5399.163129714901;5405.621606487547;5232.607554433433;5235.73821308933;5239.607029472767;5250.947490525123;5264.842054738326;12034.33811140387;12266;12560.057995650272;12564.434600443003;12573.057020723483;1770.2564922732354;2013.3154727392757;2164.545445456456;2169.1865550418593;2241.5628952354296;9021.774455638595;9156.679516216967;9418.434893906388;9910.355826871302;13487.055906086578;1719.733441316598;1756.9648607027916;1757.9384721534814;1775.485109318296;1857.3220774417375;65973.67013164904;66366.66816665886;67047.66476167589;67332.75109170354;67605.3239467604;9931.65239216624;10276.332038417479;10359.482025898675;10405.9479702601;10498.527566259536;14191.503297384543;14332.57002289933;14334.426622935174;14385.78421323681;14401.495947641783;6901.896471552931;6991.545549539263;7007.4394048476;7134.357907788324;7138.857222855514;6551.344865513506;6594.5342778292115;6641.767538136142;6650;6923.896141557881;4331.285337919208;4396.406485124531;4419.270820314612;4428.557144285545;4512.548745125527;1792.4264235444532;1868.7664041994751;1877.1552801239225;1883.2561138350275;1887.8584106191815;810.5703976892256;832.3133414932705;927.0729270729271;935.457434687893;968.5302628225305;16047.197640117947;16434.096124713255;16527.91736041312;16538.25577849;16893.915530422513;866.9046404895456;879.1647934462159;894.458852394305;916.4272329793879;966.3139171188394;9073.727788166365;9422.90577094234;9423.528823558932;9424.908973016138;9567.856482152773;398382;406950;411808;413716;414726;74165.6291718538;74759.62620186864;75156.62421687966;77508.61245693848;77603;936.138752347828;941.2328951904176;952.0717300631828;954.665866946577;967.4485543240426;14751.778723318945;14897.329620166902;15056.569625885524;15113.149237364083;15143.772843407138;22770.886145569166;23393.883030584737;28313.575296370982;33182.5022624656;33361.83319083389;43739.56260437355;44332.77833610812;46125.07749845051;46874.76562617165;47878.28182577195;7823.921760782319;8097.068837083811;8111.959440202997;8152.062512811102;8156.551389673387;8836.91163088361;10684.732881678021;10741.462926853783;10810.51352689115;11527.596534121265;10493.640742812957;10623.203259755395;10767.97704218098;10812.35125892449;10954.452277386259;10447.283706236281;10447.84328235062;10792.460376980962;10937.343759374464;11033.172512061466;9776.85334719994;10630.669266405253;10648.467576621293;10656.89343106559;10949.397783122005;7622.2758837910305;7886.72396466121;7901.130875603564;7903.130655627761;8022.478538894953;6825.1127353443735;8050.235227653364;9580.856287155837;10647.254692171784;10655.147588193082 23:39:27 INFO - PROCESS | 3378 | |3;mootools.html;1217.6042786094522;1324.8807607315346;1329.195836518906;1402.5091218073671;1443.3865607116975;6768.289329620393;7642.541447513153;7833.255840695139;7835;7864.685412583504;7530.096388433396;7661.655225514851;7664.425168112386;7668.846623067535;7681.423893208018;2102.3692892132335;2128.021110289269;2131.1049359269145;2131.7335333083365;2133.391983284764;2152.2251989283845;2172.4460262633006;2186.7157269554937;2189.1681161158735;2206.7793220677886;2160.6326924422888;2171.89140542973;2181.770914054025;2185.0495034659893;2190.791874771894;2133.1254185783832;2140.9250676226256;2141.582391433671;2144.04589957469;2144.6246906791407;2116.6295898217904;2159.762426133124;2162.643163877974;2162.816160626349;2168.349495151448;7483.513571617827;7796.103448103484;7802.258785415376;7837.529748215068;7863;4625.722456652578;4794.568488836021;4797.784099715521;4809.158397280462;4820.228763397875;3076.7230949214454;3077.938441231185;3141.6230052393857;3142.0887942496647;3166.667499912499;978.4031740638205;1007.5566750629699;1011.4790882695418;1028.7993841200969;1038.5689938675441;10684.145268378512;10758.838617420744;10769.030787229187;10771.084457821094;10806.675799726021;4092.3452247640234;4159.085001299709;4315.762633055212;4359.367891655756;4376.190404775127;8197.672093116209;8298.419110662197;8313.709020184264;8313.875291870627;8364.958175209085;4533.5013148553635;4536.092781443725;4558.384618076583;4561.7262964222255;4562.657800664963;3626.9274614507563;3766.886993390203;4139.730917490354;4223.260929337415;4234.745915245096;3497.9300413992087;3609.1338078860886;3609.8375573099274;3619.335105851338;3648.5074514940675;1076.1122074288587;1094.7427354571669;1099.2030777686114;1103.1175059952006;1105.9557617695364;810.3274282345639;848.4654667559398;857.5197889182078;898.734873212404;929.3169520402499;5284.207368894619;5431.131019037014;5525.060739674265;5560.277163968658;5763;874.7594411536751;890.1543533643065;898.2006014646969;920.4201353147474;939.572494514994;3636.818159092035;3666.1018050577777;3681.392570225936;3696.4085746280466;3748.887533374003;9332.860007099898;9560.617575297048;9653;9782.41305521671;9796.314258002014;9553.426794392359;9558.90441095594;9585.329026968046;9592.520373981273;9599.32804703678;6930.688119034757;7028.894566581505;7197.604131772698;7199.1001124859395;7201.0638616980505;5444.428335024923;5516.420775818642;5517.310336207974;5562.860928476821;5637.915431268452;8838.734837954871;8845.336599755174;8858.557072146496;8904.688335908211;8999.32505062136;8425.62084706202;8844.336674749291;8860.867086993829;8890.511021893857;9081.909180908106;6242.094896240111;6730.226024007106;6886.793396198122;6925.342092501204;6930.930690693231;7388.889166662612;7427.554346739213;7452.21751716062;7460.664270107966;7510.924890751023;6736.225334086446;6813.250542440229;6875.106236189464;6984.755533556301;6998.545094568837;6711.496637752286;6735.595864248161;6784.491163162684;6834.760783372558;6858.965705171642;6320.841978950563;6383.36166383358;6485.383888530582;6507.023946408077;6507.154069971063;4665.2535594304745;4716;4783.186858234039;4786.617070634411;4872.43966943806;4664.836730714409;4694.483606803317;4725.810967561259;4769.070031343855;4809.519048095162 23:39:27 INFO - PROCESS | 3378 | |4;prototype.html;320.09253765574596;321.0849080121652;325.5198582091415;328.9555909952156;329.8400275866203;5093.3124028256225;5116.846494605168;5118.385793704751;5136.871578210546;5156.974215128924;5010.624203184758;5062.316587260719;5068.923966140511;5077.238414237866;5095.261187127864;3792.1088544192094;3849.3840985442334;3933.15437181006;4009.338459154251;4023.4769479967563;3997.8200980955926;3999.4200840878057;4003.499562554681;4014.3978403239457;4019.0957034667113;3803.5055442792536;3988.1455123367627;3998.820053097618;4003.9399409008743;4008.13825027619;3877.243937432202;3985.163115745697;3994.980025099856;4008.518977722692;4025.939610905839;3558.1460449491938;3562.412201986669;3564.928701425957;3566.5898421681577;3571.8035508047046;4805.663603547753;4855.465898751135;4860.513948605147;4876.585490233334;4902.877428064291;4306.569343065699;4551.681382303207;4574.222382195035;4584.106099310636;4644.326572646981;5318.813841515528;5330.866728331784;5350.715828201203;5354.625176237665;5363.597730170253;3819.8281077351307;3825.885223443301;3828.119532507511;3835.4438606402196;3838.2707285615643;5495.258140151109;5574.219609254707;5589.099706099945;5595.552355811566;5605.299337582843;3893.7858417787293;3902.6097390260747;3902.746321489094;3924.4309575111447;3934.075492259317;3971.1660551283976;3971.523417189898;3971.92056158881;3972.8410863565714;3979.184267225212;4428.756418397019;4526.185286648369;4528.796204170821;4546.454425468899;4552.180607490617;5359.758810853521;5368.785248590013;5373.113436283048;5382.273393091882;5386.946130538645;1363.9318034098255;1369.7876829091506;1373.4231622718482;1377.4008306386754;1381.7996390523317;880.6218268409918;906.7869050773063;926.7636752628172;936.6159874451442;951.5147274889717;4603.516630753789;4627.097715945359;4634.791434385461;4636.5131661175765;4648.302754586839;5448.073827449343;5452.127659574449;5462.535684466865;5471.343438787291;5477.315335583052;4496.7077139985795;4632.698874573142;4639.489656137822;4641.95358046422;4738.763061846894;2947.896823611163;2964.0585416552194;2964.273752930546;2966.7923245372617;2968.6586042604945;5237.292965449692;5248.816291429782;5267.183586544015;5267.288915996368;5268.341457317835;5525.11598144295;5644.915326270109;5708.80019199326;5719.571032172604;5742.196092547047;5237.292965449616;5251.711155886386;5263.105272103751;5271.947280527299;5277.656952298088;5394.568434525307;5548.611597188158;5561.916571251515;5578.30271216098;5590.720463976866;5435.206381893887;5469.206964989975;5475.972620137033;5486.887548293856;5497.642653227527;5181.3005244293045;5195.5843532518065;5219.608529360389;5220.7650655721345;5260.210968354778;3782.527184101987;3814.065553939303;3885.9417108743955;3887.475190849199;3890.494235749448;5544.7782088716;5570.5543556516195;5573.832785016456;5575.470330318613;5577.274954256083;5382.677039377493;5386.5152136307925;5388.137897936468;5391.433899440659;5398.379186393615;5041.319421878146;5378.811741589026;5386.892262154814;5402.162664786964;5412.729363531729;5062.164742817541;5291.153415453509;5317.574594032545;5318.0959236930585;5328.973355133199;5176.559992400537;5306.628536002443;5314.441983591667;5317.229001794795;5317.468253174651;5271.1039123348355;5290.1800220965815;5293.697241699873;5296.496832800878;5315.335583052119 23:39:27 INFO - PROCESS | 3378 | |5;yui.html;711.5055036749458;738.2101151767611;744.1665334824995;777.2460713108285;786.5202226641744;12151.817722734155;14093.788593171097;14593.708125837476;14618.634534136652;14640.633984150401;13793.172409655428;13837.446502139928;13901.374438150282;13905;13907.860921390784;646.0438550944605;824.1922915542772;830.7756905635475;830.8296799156159;831.3640065350012;796.1242633103598;826.4297634632085;827.1893544326564;827.8799574061758;828.1263267253046;851.7657644147847;852.9914700853005;856.1267507142711;857.0358346859783;857.2541888556964;668.1714673804447;828.3166387730147;851.0340763233743;851.6550796927223;852.9914700853005;621.3227581935712;621.8103478439074;625.6371304643296;625.9687015649245;626.0171530696808;13316.467341306336;13377;13383.732325353438;13453.932730336286;13523;11965.820512692317;12531.498740050387;12563.246205227624;12727.87272127276;12819.935900320439;10206.926769034662;10285.845712314322;10392.324498907623;10558.630447934362;10647.787044259148;3312.287858110518;3313.718333941618;3370.140614143402;3370.9494357584654;3381.628020917697;47842.52157478416;48015.519844801805;48211.75894120542;48658;48739;9940.453275069796;10034.44810535413;10071.899281007243;10121.240906931862;10170.186385089175;16604.335826566803;17217.91391043062;17316.480505584852;17539.473815785546;17736.29054837792;6855.760048398282;7112.35988761014;7210.60341681202;7218.711251549879;7362.226966168582;3864.381698928158;3886.145048089416;3921.137349783043;3984.8406063757125;4019.718619696652;2896.0877323642985;2957.7190166934106;2958.8224706517676;2961.7926745127634;2966.2139533023765;524.4702850121405;532.339898525833;539.0781763184998;540.3057071662973;549.3161014536927;402.75029481720935;637.7640273098983;659.3670076726396;666.2870728320747;672.9158855143107;7541.7360392386;7693.4614576979075;7948.562829044343;8163.95918020418;8213.876791848126;581.4882903045377;584.6579750845718;593.8693487432757;595.4968051996057;602.2983224543358;3758.229562939591;3773.3773927302236;3807.1053302473897;3884.7280690351968;3957.881263562098;48135.75932120317;48381.5161848377;51421.48578514242;52777;52949.470505294456;44589;45171;45718.542814571425;45768.54231457709;45959.54040459619;39474.60525394709;40005.79997099996;40625.39061914015;40986.38520422196;41575.58424415778;8238.546879921661;8295.834083318421;8344;8479.15208479147;8569.314454843472;27643.861780691772;28075.578866316613;28093;29152.56271155892;29159.708402915698;35295;35800.28399432049;39381.2123757529;39525.40711889382;40466.59533404746;10897.509612067317;10913.454327283764;10926.50830712604;11100.888991110309;11250.60622878228;11511.942440287745;11567.421628918688;11744.58893938708;11838.467268972745;12061.276323420623;11236.157288203254;11410.94294528522;11417.31496110236;11585.246958947642;11716.589919352782;11411.201215914807;11428.25716328436;11650.76698466043;12119.515219391478;12135.635930922086;10493.580256789643;10598.099161571045;10695;10981.121510279318;10998.230123891572;9588.856167157637;9648.614055437985;9760.412606075133;9801.509924503604;10217.897821021694;8761.299096072426;9560.569774360032;9803.803923921625;9806.705798826046;9834.950825245827 23:39:27 INFO - PROCESS | 3378 | __end_tp_report 23:39:27 INFO - PROCESS | 3378 | __start_cc_report 23:39:27 INFO - PROCESS | 3378 | _x_x_mozilla_cycle_collect,1074 23:39:27 INFO - PROCESS | 3378 | __end_cc_report 23:39:27 INFO - PROCESS | 3378 | __startTimestamp1461479967550__endTimestamp 23:39:27 INFO - PROCESS | 3378 | 23:39:27 INFO - PROCESS | 3378 | ------- Summary: start ------- 23:39:27 INFO - PROCESS | 3378 | Number of tests: 6 23:39:27 INFO - PROCESS | 3378 | 23:39:27 INFO - PROCESS | 3378 | [#0] dojo.html Cycles:165 Average:4656.43 Median:4771.28 stddev:474.36 (9.9%) stddev-sans-first:447.78 23:39:27 INFO - PROCESS | 3378 | Values: 2608.3 2688.9 2692.8 2716.3 2718.0 4589.5 4635.7 4665.5 4720.8 4724.2 4654.9 4703.8 4772.3 4791.2 4798.0 4236.9 4252.9 4274.2 4314.2 4351.0 4354.6 4375.4 4376.5 4383.4 4407.1 4261.3 4312.1 4330.6 4377.0 4392.7 4268.6 4301.1 4333.3 4339.2 4376.7 4309.4 4334.2 4347.6 4387.8 4389.8 4633.5 4643.6 4654.2 4674.6 4704.1 4936.8 4940.3 4985.7 5050.5 5050.9 5029.8 5055.8 5068.5 5087.9 5088.8 4596.7 4731.0 4736.1 4739.7 4772.5 5063.2 5087.9 5108.4 5128.4 5158.7 4967.3 5012.5 5012.7 5018.5 5061.7 4972.7 5017.3 5061.3 5093.0 5099.1 5021.8 5039.5 5043.7 5056.0 5081.8 5018.5 5030.4 5037.1 5053.4 5079.0 4201.7 4260.7 4291.8 4355.2 4402.7 3752.3 3774.8 3794.6 3810.3 3834.7 4329.0 4334.5 4335.6 4340.0 4382.7 4960.9 5034.4 5078.3 5118.6 5127.0 4301.5 4320.6 4323.6 4350.0 4367.8 4553.7 4560.7 4560.8 4567.1 4615.7 4643.3 4730.8 4762.3 4822.8 4834.9 5048.2 5061.0 5066.7 5067.7 5119.1 4719.1 4751.3 4767.5 4768.5 4771.5 4840.5 4865.7 4891.0 4902.6 4904.5 4998.4 5004.6 5018.4 5023.2 5062.3 4706.8 4850.7 4886.0 4889.5 4932.2 4855.9 4909.3 4921.2 4943.9 4945.6 4756.2 4762.5 4765.8 4771.3 4800.8 4803.1 4863.4 4867.4 4884.4 4899.3 4862.3 4869.9 4884.7 4901.7 4916.3 23:39:27 INFO - PROCESS | 3378 | 23:39:27 INFO - PROCESS | 3378 | [#1] ext.html Cycles:180 Average:42746.19 Median:35937.32 stddev:76350.84 (212.5%) stddev-sans-first:76499.34 23:39:27 INFO - PROCESS | 3378 | Values: 566.7 596.7 605.9 615.0 623.6 27161.0 34834.0 36245.6 36381.8 36494.8 37791.6 38481.0 38506.4 38511.2 38556.0 7635.2 7823.3 7825.7 7832.8 7853.5 7723.3 7841.5 7846.1 7850.7 7851.7 7818.2 8016.3 8016.6 8017.2 8017.8 7882.9 7933.2 7933.5 7936.8 7951.0 7709.2 7822.4 7826.2 7826.9 7833.0 37587.8 37789.8 37838.4 38076.6 38326.4 3199.9 3254.2 3305.1 3358.4 3783.8 28447.9 28469.0 28823.7 29871.0 30564.0 3419.5 3449.3 3474.9 3482.2 3496.4 231467.0 232416.0 232754.0 233344.0 233526.0 32512.3 33613.8 52419.0 52969.7 53152.0 31486.5 31622.5 31654.8 31671.4 31773.0 12355.4 12497.7 12499.9 12510.7 12527.7 10423.4 10430.4 10470.7 10502.4 10537.5 8178.4 8241.3 8270.8 8334.0 8365.4 3224.8 3248.6 3278.4 3295.8 3297.5 913.6 930.2 952.7 985.2 1005.9 27482.9 28557.7 28590.4 28598.4 28950.4 994.0 994.8 1014.4 1015.8 1058.0 15066.2 15186.4 15289.2 15496.2 15542.9 368866.0 374547.0 375297.0 375825.0 375842.0 48210.8 49067.5 49126.8 49452.5 49576.8 1125.4 1142.7 1169.3 1173.3 1269.5 25523.7 26118.3 27962.2 28954.0 29003.4 39474.2 39806.4 39993.4 40025.8 40059.8 239395.0 240585.0 240853.0 241023.0 241818.0 24708.9 25920.1 25927.9 25942.4 25964.6 43365.7 43716.6 43736.8 44541.8 44973.8 35024.8 36183.6 36603.8 36618.6 37002.4 35691.0 36603.8 36685.4 36746.6 36802.0 29430.1 30451.0 36444.5 37311.3 37376.4 27321.6 29341.7 29412.7 29517.3 29625.1 24120.3 24457.0 24602.8 24723.9 25018.0 23:39:27 INFO - PROCESS | 3378 | 23:39:27 INFO - PROCESS | 3378 | [#2] jquery.html Cycles:180 Average:24075.87 Median:24422.66 stddev:67330.40 (275.7%) stddev-sans-first:67495.77 23:39:27 INFO - PROCESS | 3378 | Values: 379.6 386.3 391.6 394.4 401.1 15003.8 15631.0 15670.5 15676.2 16305.5 16071.8 16092.4 16760.7 16865.2 17947.5 5034.7 5189.4 5203.9 5226.8 5235.2 5115.9 5126.9 5127.4 5142.5 5142.6 4987.7 5095.6 5106.4 5107.3 5116.1 5081.2 5092.9 5098.7 5399.2 5405.6 5232.6 5235.7 5239.6 5250.9 5264.8 12034.3 12266.0 12560.1 12564.4 12573.1 1770.3 2013.3 2164.5 2169.2 2241.6 9021.8 9156.7 9418.4 9910.4 13487.1 1719.7 1757.0 1757.9 1775.5 1857.3 65973.7 66366.7 67047.7 67332.8 67605.3 9931.7 10276.3 10359.5 10405.9 10498.5 14191.5 14332.6 14334.4 14385.8 14401.5 6901.9 6991.5 7007.4 7134.4 7138.9 6551.3 6594.5 6641.8 6650.0 6923.9 4331.3 4396.4 4419.3 4428.6 4512.5 1792.4 1868.8 1877.2 1883.3 1887.9 810.6 832.3 927.1 935.5 968.5 16047.2 16434.1 16527.9 16538.3 16893.9 866.9 879.2 894.5 916.4 966.3 9073.7 9422.9 9423.5 9424.9 9567.9 398382.0 406950.0 411808.0 413716.0 414726.0 74165.6 74759.6 75156.6 77508.6 77603.0 936.1 941.2 952.1 954.7 967.4 14751.8 14897.3 15056.6 15113.1 15143.8 22770.9 23393.9 28313.6 33182.5 33361.8 43739.6 44332.8 46125.1 46874.8 47878.3 7823.9 8097.1 8112.0 8152.1 8156.6 8836.9 10684.7 10741.5 10810.5 11527.6 10493.6 10623.2 10768.0 10812.4 10954.5 10447.3 10447.8 10792.5 10937.3 11033.2 9776.9 10630.7 10648.5 10656.9 10949.4 7622.3 7886.7 7901.1 7903.1 8022.5 6825.1 8050.2 9580.9 10647.3 10655.1 23:39:27 INFO - PROCESS | 3378 | 23:39:27 INFO - PROCESS | 3378 | [#3] mootools.html Cycles:180 Average:5136.09 Median:5437.78 stddev:2836.41 (52.2%) stddev-sans-first:2829.08 23:39:27 INFO - PROCESS | 3378 | Values: 1217.6 1324.9 1329.2 1402.5 1443.4 6768.3 7642.5 7833.3 7835.0 7864.7 7530.1 7661.7 7664.4 7668.8 7681.4 2102.4 2128.0 2131.1 2131.7 2133.4 2152.2 2172.4 2186.7 2189.2 2206.8 2160.6 2171.9 2181.8 2185.0 2190.8 2133.1 2140.9 2141.6 2144.0 2144.6 2116.6 2159.8 2162.6 2162.8 2168.3 7483.5 7796.1 7802.3 7837.5 7863.0 4625.7 4794.6 4797.8 4809.2 4820.2 3076.7 3077.9 3141.6 3142.1 3166.7 978.4 1007.6 1011.5 1028.8 1038.6 10684.1 10758.8 10769.0 10771.1 10806.7 4092.3 4159.1 4315.8 4359.4 4376.2 8197.7 8298.4 8313.7 8313.9 8365.0 4533.5 4536.1 4558.4 4561.7 4562.7 3626.9 3766.9 4139.7 4223.3 4234.7 3497.9 3609.1 3609.8 3619.3 3648.5 1076.1 1094.7 1099.2 1103.1 1106.0 810.3 848.5 857.5 898.7 929.3 5284.2 5431.1 5525.1 5560.3 5763.0 874.8 890.2 898.2 920.4 939.6 3636.8 3666.1 3681.4 3696.4 3748.9 9332.9 9560.6 9653.0 9782.4 9796.3 9553.4 9558.9 9585.3 9592.5 9599.3 6930.7 7028.9 7197.6 7199.1 7201.1 5444.4 5516.4 5517.3 5562.9 5637.9 8838.7 8845.3 8858.6 8904.7 8999.3 8425.6 8844.3 8860.9 8890.5 9081.9 6242.1 6730.2 6886.8 6925.3 6930.9 7388.9 7427.6 7452.2 7460.7 7510.9 6736.2 6813.3 6875.1 6984.8 6998.5 6711.5 6735.6 6784.5 6834.8 6859.0 6320.8 6383.4 6485.4 6507.0 6507.2 4665.3 4716.0 4783.2 4786.6 4872.4 4664.8 4694.5 4725.8 4769.1 4809.5 23:39:27 INFO - PROCESS | 3378 | 23:39:27 INFO - PROCESS | 3378 | [#4] prototype.html Cycles:180 Average:4450.64 Median:5085.28 stddev:1292.54 (25.4%) stddev-sans-first:1258.44 23:39:27 INFO - PROCESS | 3378 | Values: 320.1 321.1 325.5 329.0 329.8 5093.3 5116.8 5118.4 5136.9 5157.0 5010.6 5062.3 5068.9 5077.2 5095.3 3792.1 3849.4 3933.2 4009.3 4023.5 3997.8 3999.4 4003.5 4014.4 4019.1 3803.5 3988.1 3998.8 4003.9 4008.1 3877.2 3985.2 3995.0 4008.5 4025.9 3558.1 3562.4 3564.9 3566.6 3571.8 4805.7 4855.5 4860.5 4876.6 4902.9 4306.6 4551.7 4574.2 4584.1 4644.3 5318.8 5330.9 5350.7 5354.6 5363.6 3819.8 3825.9 3828.1 3835.4 3838.3 5495.3 5574.2 5589.1 5595.6 5605.3 3893.8 3902.6 3902.7 3924.4 3934.1 3971.2 3971.5 3971.9 3972.8 3979.2 4428.8 4526.2 4528.8 4546.5 4552.2 5359.8 5368.8 5373.1 5382.3 5386.9 1363.9 1369.8 1373.4 1377.4 1381.8 880.6 906.8 926.8 936.6 951.5 4603.5 4627.1 4634.8 4636.5 4648.3 5448.1 5452.1 5462.5 5471.3 5477.3 4496.7 4632.7 4639.5 4642.0 4738.8 2947.9 2964.1 2964.3 2966.8 2968.7 5237.3 5248.8 5267.2 5267.3 5268.3 5525.1 5644.9 5708.8 5719.6 5742.2 5237.3 5251.7 5263.1 5271.9 5277.7 5394.6 5548.6 5561.9 5578.3 5590.7 5435.2 5469.2 5476.0 5486.9 5497.6 5181.3 5195.6 5219.6 5220.8 5260.2 3782.5 3814.1 3885.9 3887.5 3890.5 5544.8 5570.6 5573.8 5575.5 5577.3 5382.7 5386.5 5388.1 5391.4 5398.4 5041.3 5378.8 5386.9 5402.2 5412.7 5062.2 5291.2 5317.6 5318.1 5329.0 5176.6 5306.6 5314.4 5317.2 5317.5 5271.1 5290.2 5293.7 5296.5 5315.3 23:39:27 INFO - PROCESS | 3378 | 23:39:27 INFO - PROCESS | 3378 | [#5] yui.html Cycles:180 Average:12864.32 Median:2211.23 stddev:14213.40 (642.8%) stddev-sans-first:14223.97 23:39:27 INFO - PROCESS | 3378 | Values: 711.5 738.2 744.2 777.2 786.5 12151.8 14093.8 14593.7 14618.6 14640.6 13793.2 13837.4 13901.4 13905.0 13907.9 646.0 824.2 830.8 830.8 831.4 796.1 826.4 827.2 827.9 828.1 851.8 853.0 856.1 857.0 857.3 668.2 828.3 851.0 851.7 853.0 621.3 621.8 625.6 626.0 626.0 13316.5 13377.0 13383.7 13453.9 13523.0 11965.8 12531.5 12563.2 12727.9 12819.9 10206.9 10285.8 10392.3 10558.6 10647.8 3312.3 3313.7 3370.1 3370.9 3381.6 47842.5 48015.5 48211.8 48658.0 48739.0 9940.5 10034.4 10071.9 10121.2 10170.2 16604.3 17217.9 17316.5 17539.5 17736.3 6855.8 7112.4 7210.6 7218.7 7362.2 3864.4 3886.1 3921.1 3984.8 4019.7 2896.1 2957.7 2958.8 2961.8 2966.2 524.5 532.3 539.1 540.3 549.3 402.8 637.8 659.4 666.3 672.9 7541.7 7693.5 7948.6 8164.0 8213.9 581.5 584.7 593.9 595.5 602.3 3758.2 3773.4 3807.1 3884.7 3957.9 48135.8 48381.5 51421.5 52777.0 52949.5 44589.0 45171.0 45718.5 45768.5 45959.5 39474.6 40005.8 40625.4 40986.4 41575.6 8238.5 8295.8 8344.0 8479.2 8569.3 27643.9 28075.6 28093.0 29152.6 29159.7 35295.0 35800.3 39381.2 39525.4 40466.6 10897.5 10913.5 10926.5 11100.9 11250.6 11511.9 11567.4 11744.6 11838.5 12061.3 11236.2 11410.9 11417.3 11585.2 11716.6 11411.2 11428.3 11650.8 12119.5 12135.6 10493.6 10598.1 10695.0 10981.1 10998.2 9588.9 9648.6 9760.4 9801.5 10217.9 8761.3 9560.6 9803.8 9806.7 9835.0 23:39:27 INFO - PROCESS | 3378 | -------- Summary: end -------- 23:39:27 INFO - PROCESS | 3378 | 23:39:28 INFO - TEST-INFO | 3378: exit 0 23:39:28 INFO - TEST-OK | dromaeo_css | took 1122948ms 23:39:28 INFO - TEST-START | kraken 23:39:28 INFO - operating with platform_type : linux_ 23:39:28 INFO - Initialising browser for kraken test... 23:39:28 INFO - TEST-INFO | started process 3560 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQc1pay/profile http://localhost:57126/getInfo.html) 23:39:33 INFO - PROCESS | 3560 | __metrics Screen width/height:1600/1200 23:39:33 INFO - PROCESS | 3560 | colorDepth:24 23:39:33 INFO - PROCESS | 3560 | Browser inner width/height: 1024/697 23:39:33 INFO - PROCESS | 3560 | __metrics 23:39:34 ERROR - PROCESS | 3560 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:39:35 INFO - TEST-INFO | 3560: exit 0 23:39:35 INFO - Browser initialized. 23:39:35 INFO - Running cycle 1/1 for kraken test... 23:39:35 INFO - TEST-INFO | started process 3640 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQc1pay/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:39:47 INFO - PROCESS | 3640 | RSS: Main: 155082752 23:39:47 INFO - PROCESS | 3640 | 23:39:49 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:57126/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57126/tests/kraken/driver.html?testName=audio-beat-detection) 23:39:50 INFO - PROCESS | 3640 | RSS: Main: 210259968 23:39:50 INFO - PROCESS | 3640 | 23:39:53 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:57126/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57126/tests/kraken/driver.html?testName=audio-dft) 23:39:54 INFO - PROCESS | 3640 | RSS: Main: 195899392 23:39:54 INFO - PROCESS | 3640 | 23:39:57 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:57126/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57126/tests/kraken/driver.html?testName=audio-fft) 23:39:58 INFO - PROCESS | 3640 | RSS: Main: 267423744 23:39:58 INFO - PROCESS | 3640 | 23:40:00 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:57126/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57126/tests/kraken/driver.html?testName=audio-oscillator) 23:40:00 INFO - PROCESS | 3640 | RSS: Main: 175259648 23:40:00 INFO - PROCESS | 3640 | 23:40:03 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:57126/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57126/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:40:03 INFO - PROCESS | 3640 | RSS: Main: 179126272 23:40:03 INFO - PROCESS | 3640 | 23:40:07 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:57126/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57126/tests/kraken/driver.html?testName=imaging-darkroom) 23:40:07 INFO - PROCESS | 3640 | RSS: Main: 214790144 23:40:07 INFO - PROCESS | 3640 | 23:40:11 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:57126/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57126/tests/kraken/driver.html?testName=imaging-desaturate) 23:40:11 INFO - PROCESS | 3640 | RSS: Main: 213434368 23:40:11 INFO - PROCESS | 3640 | 23:40:14 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:57126/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57126/tests/kraken/driver.html?testName=json-parse-financial) 23:40:15 INFO - PROCESS | 3640 | RSS: Main: 214958080 23:40:15 INFO - PROCESS | 3640 | 23:40:16 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:57126/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57126/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:40:17 INFO - PROCESS | 3640 | RSS: Main: 201789440 23:40:17 INFO - PROCESS | 3640 | 23:40:19 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:57126/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57126/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:40:20 INFO - PROCESS | 3640 | RSS: Main: 203792384 23:40:20 INFO - PROCESS | 3640 | 23:40:22 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:57126/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57126/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:40:22 INFO - PROCESS | 3640 | RSS: Main: 214659072 23:40:22 INFO - PROCESS | 3640 | 23:40:25 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:57126/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57126/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:40:26 INFO - PROCESS | 3640 | RSS: Main: 225103872 23:40:26 INFO - PROCESS | 3640 | 23:40:29 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:57126/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57126/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:40:29 INFO - PROCESS | 3640 | RSS: Main: 221843456 23:40:29 INFO - PROCESS | 3640 | 23:40:31 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:57126/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57126/tests/kraken/driver.html?testName=ai-astar) 23:40:31 INFO - PROCESS | 3640 | RSS: Main: 284512256 23:40:31 INFO - PROCESS | 3640 | 23:40:31 INFO - PROCESS | 3640 | __start_tp_report 23:40:31 INFO - PROCESS | 3640 | _x_x_mozilla_page_load 23:40:31 INFO - PROCESS | 3640 | _x_x_mozilla_page_load_details 23:40:31 INFO - PROCESS | 3640 | |i|pagename|runs| 23:40:31 INFO - PROCESS | 3640 | |0;ai-astar;113;116;109;113;115;113;104;115;114;114 23:40:31 INFO - PROCESS | 3640 | |1;audio-beat-detection;167;138;162;193;138;156;157;139;198;140 23:40:31 INFO - PROCESS | 3640 | |2;audio-dft;174;160;160;161;162;162;164;163;163;159 23:40:31 INFO - PROCESS | 3640 | |3;audio-fft;76;73;108;116;75;74;74;117;113;73 23:40:31 INFO - PROCESS | 3640 | |4;audio-oscillator;95;93;144;95;96;93;158;94;95;140 23:40:31 INFO - PROCESS | 3640 | |5;imaging-gaussian-blur;117;117;117;116;117;116;117;116;117;117 23:40:31 INFO - PROCESS | 3640 | |6;imaging-darkroom;146;146;146;146;145;145;146;146;145;145 23:40:31 INFO - PROCESS | 3640 | |7;imaging-desaturate;95;95;95;96;95;96;96;95;95;95 23:40:31 INFO - PROCESS | 3640 | |8;json-parse-financial;66;67;68;68;67;69;67;79;64;64 23:40:31 INFO - PROCESS | 3640 | |9;json-stringify-tinderbox;64;64;65;64;68;64;67;64;65;64 23:40:31 INFO - PROCESS | 3640 | |10;stanford-crypto-aes;78;78;79;79;81;80;78;79;80;78 23:40:31 INFO - PROCESS | 3640 | |11;stanford-crypto-ccm;134;145;131;131;142;135;139;139;179;132 23:40:31 INFO - PROCESS | 3640 | |12;stanford-crypto-pbkdf2;170;174;170;169;177;169;171;171;174;169 23:40:31 INFO - PROCESS | 3640 | |13;stanford-crypto-sha256-iterative;73;73;73;74;73;71;73;70;71;70 23:40:31 INFO - PROCESS | 3640 | __end_tp_report 23:40:31 INFO - PROCESS | 3640 | __start_cc_report 23:40:31 INFO - PROCESS | 3640 | _x_x_mozilla_cycle_collect,1911 23:40:31 INFO - PROCESS | 3640 | __end_cc_report 23:40:31 INFO - PROCESS | 3640 | __startTimestamp1461480031821__endTimestamp 23:40:31 INFO - PROCESS | 3640 | 23:40:31 INFO - PROCESS | 3640 | ------- Summary: start ------- 23:40:31 INFO - PROCESS | 3640 | Number of tests: 14 23:40:31 INFO - PROCESS | 3640 | 23:40:31 INFO - PROCESS | 3640 | [#0] ai-astar Cycles:10 Average:112.60 Median:114.00 stddev:3.57 (3.1%) stddev-sans-first:3.78 23:40:31 INFO - PROCESS | 3640 | Values: 113.0 116.0 109.0 113.0 115.0 113.0 104.0 115.0 114.0 114.0 23:40:31 INFO - PROCESS | 3640 | 23:40:31 INFO - PROCESS | 3640 | [#1] audio-beat-detection Cycles:10 Average:158.80 Median:159.50 stddev:22.12 (13.9%) stddev-sans-first:23.27 23:40:31 INFO - PROCESS | 3640 | Values: 167.0 138.0 162.0 193.0 138.0 156.0 157.0 139.0 198.0 140.0 23:40:31 INFO - PROCESS | 3640 | 23:40:31 INFO - PROCESS | 3640 | [#2] audio-dft Cycles:10 Average:162.80 Median:162.50 stddev:4.24 (2.6%) stddev-sans-first:1.67 23:40:31 INFO - PROCESS | 3640 | Values: 174.0 160.0 160.0 161.0 162.0 162.0 164.0 163.0 163.0 159.0 23:40:31 INFO - PROCESS | 3640 | 23:40:31 INFO - PROCESS | 3640 | [#3] audio-fft Cycles:10 Average:89.90 Median:73.50 stddev:20.46 (27.8%) stddev-sans-first:21.08 23:40:31 INFO - PROCESS | 3640 | Values: 76.0 73.0 108.0 116.0 75.0 74.0 74.0 117.0 113.0 73.0 23:40:31 INFO - PROCESS | 3640 | 23:40:31 INFO - PROCESS | 3640 | [#4] audio-oscillator Cycles:10 Average:110.30 Median:94.50 stddev:25.96 (27.5%) stddev-sans-first:26.94 23:40:31 INFO - PROCESS | 3640 | Values: 95.0 93.0 144.0 95.0 96.0 93.0 158.0 94.0 95.0 140.0 23:40:31 INFO - PROCESS | 3640 | 23:40:31 INFO - PROCESS | 3640 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 23:40:31 INFO - PROCESS | 3640 | Values: 117.0 117.0 117.0 116.0 117.0 116.0 117.0 116.0 117.0 117.0 23:40:31 INFO - PROCESS | 3640 | 23:40:31 INFO - PROCESS | 3640 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 23:40:31 INFO - PROCESS | 3640 | Values: 146.0 146.0 146.0 146.0 145.0 145.0 146.0 146.0 145.0 145.0 23:40:31 INFO - PROCESS | 3640 | 23:40:31 INFO - PROCESS | 3640 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 23:40:31 INFO - PROCESS | 3640 | Values: 95.0 95.0 95.0 96.0 95.0 96.0 96.0 95.0 95.0 95.0 23:40:31 INFO - PROCESS | 3640 | 23:40:31 INFO - PROCESS | 3640 | [#8] json-parse-financial Cycles:10 Average:67.90 Median:67.50 stddev:4.23 (6.3%) stddev-sans-first:4.43 23:40:31 INFO - PROCESS | 3640 | Values: 66.0 67.0 68.0 68.0 67.0 69.0 67.0 79.0 64.0 64.0 23:40:31 INFO - PROCESS | 3640 | 23:40:31 INFO - PROCESS | 3640 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:64.50 stddev:1.45 (2.2%) stddev-sans-first:1.50 23:40:31 INFO - PROCESS | 3640 | Values: 64.0 64.0 65.0 64.0 68.0 64.0 67.0 64.0 65.0 64.0 23:40:31 INFO - PROCESS | 3640 | 23:40:31 INFO - PROCESS | 3640 | [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:79.00 stddev:1.05 (1.3%) stddev-sans-first:1.05 23:40:31 INFO - PROCESS | 3640 | Values: 78.0 78.0 79.0 79.0 81.0 80.0 78.0 79.0 80.0 78.0 23:40:31 INFO - PROCESS | 3640 | 23:40:31 INFO - PROCESS | 3640 | [#11] stanford-crypto-ccm Cycles:10 Average:140.70 Median:139.00 stddev:14.28 (10.3%) stddev-sans-first:14.93 23:40:31 INFO - PROCESS | 3640 | Values: 134.0 145.0 131.0 131.0 142.0 135.0 139.0 139.0 179.0 132.0 23:40:31 INFO - PROCESS | 3640 | 23:40:31 INFO - PROCESS | 3640 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.40 Median:171.00 stddev:2.72 (1.6%) stddev-sans-first:2.83 23:40:31 INFO - PROCESS | 3640 | Values: 170.0 174.0 170.0 169.0 177.0 169.0 171.0 171.0 174.0 169.0 23:40:31 INFO - PROCESS | 3640 | 23:40:31 INFO - PROCESS | 3640 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.10 Median:73.00 stddev:1.45 (2.0%) stddev-sans-first:1.50 23:40:31 INFO - PROCESS | 3640 | Values: 73.0 73.0 73.0 74.0 73.0 71.0 73.0 70.0 71.0 70.0 23:40:31 INFO - PROCESS | 3640 | -------- Summary: end -------- 23:40:31 INFO - PROCESS | 3640 | 23:40:32 INFO - TEST-INFO | 3640: exit 0 23:40:32 INFO - TEST-OK | kraken | took 64477ms 23:40:32 INFO - SUITE-END | took 1187s 23:40:32 INFO - Completed test suite (00:19:47) 23:40:32 INFO - javascript benchmark 23:40:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2608.334874606975, 2688.892444302228, 2692.7576518113365, 2716.2666080158356, 2717.9728202717965, 4589.495155532897, 4635.652326075541, 4665.463471700756, 4720.811167553298, 4724.196886529289, 4654.860354189372, 4703.835365762199, 4772.260299653559, 4791.185498465261, 4798.040391921612, 4236.9364459533135, 4252.851150209735, 4274.209271284807, 4314.180305741915, 4350.956490435103, 4354.629856462205, 4375.4311939447825, 4376.496702879178, 4383.3863259143745, 4407.140607581523, 4261.275583150872, 4312.05134870328, 4330.5669433056755, 4377.037051848588, 4392.670549708769, 4268.573142685737, 4301.118270754488, 4333.328334108218, 4339.1972485090355, 4376.737395756265, 4309.375140604595, 4334.176506463793, 4347.586979236968, 4387.824487020547, 4389.846355377578, 4633.490316065264, 4643.605293550052, 4654.208784506608, 4674.579287864109, 4704.059188162381, 4936.80252789888, 4940.308356830046, 4985.651004429691, 5050.520200580939, 5050.9494905051215, 5029.84910452687, 5055.797768089272, 5068.493150684939, 5087.87280317995, 5088.847334579968, 4596.701214421052, 4731.0, 4736.123817093849, 4739.691920025188, 4772.498887616785, 5063.1645778446145, 5087.949120508822, 5108.361454818148, 5128.410232823273, 5158.690478571298, 4967.3294105296045, 5012.473690262543, 5012.749362531858, 5018.473060328686, 5061.670991385548, 4972.67677600962, 5017.272495488134, 5061.34202553673, 5093.032323858455, 5099.133147364957, 5021.84934451967, 5039.546440820343, 5043.672161309503, 5056.039352523009, 5081.822136225288, 5018.5232402921665, 5030.3963524377305, 5037.118504261813, 5053.36832895888, 5079.034983353151, 4201.7268877522865, 4260.744355338689, 4291.785410729451, 4355.1942890564715, 4402.691811573223, 3752.2683076799763, 3774.8490060397826, 3794.6395092466173, 3810.333191691443, 3834.654881060718, 4328.978355108267, 4334.544872788375, 4335.566443355702, 4340.001799586113, 4382.7370357778, 4960.8759781005765, 5034.370703662043, 5078.263651770547, 5118.61610379223, 5127.025865085622, 4301.526832048472, 4320.611144996966, 4323.610875021201, 4349.956500434955, 4367.781610919441, 4553.749543775058, 4560.6807523473035, 4560.794764235618, 4567.10941366437, 4615.723056616546, 4643.349931009594, 4730.787114579921, 4762.285657151524, 4822.7829747662145, 4834.8791280216865, 5048.217526283432, 5060.974695126501, 5066.721330326867, 5067.695938243717, 5119.0529751996, 4719.10337035962, 4751.311059896227, 4767.4517430495935, 4768.4754676986195, 4771.5228477152, 4840.540148685869, 4865.7323847188745, 4891.046245981999, 4902.63230257725, 4904.5340692634145, 4998.4251811042195, 5004.5746111579465, 5018.42288136869, 5023.2214006829, 5062.341895553554, 4706.835260765857, 4850.733209673502, 4885.95114048855, 4889.462159162418, 4932.21084626458, 4855.854324370274, 4909.312696222603, 4921.237208232729, 4943.901121977468, 4945.579625731853, 4756.215224487921, 4762.547557981986, 4765.785539650793, 4771.284307353924, 4800.831970881142, 4803.1114243864995, 4863.392075990501, 4867.415910090812, 4884.389451318585, 4899.289603007615, 4862.343583616166, 4869.853904382874, 4884.682495637772, 4901.730404827626, 4916.3362946001835], "value": 4627.192006669745, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.6515093217672, 596.6599038548023, 605.8969975104231, 615.012904288617, 623.5759683415278, 27161.04936327229, 34834.0, 36245.63754362452, 36381.81809090951, 36494.8175259124, 37791.622083779155, 38481.0, 38506.4224036639, 38511.22977540454, 38556.0, 7635.236476352362, 7823.295903368696, 7825.686972521121, 7832.804179895491, 7853.450258481908, 7723.266289702469, 7841.451098423113, 7846.097698764629, 7850.685972561119, 7851.6652169131385, 7818.218178182165, 8016.278534931855, 8016.639251233709, 8017.158198389173, 8017.799555011113, 7882.921170788305, 7933.167017463199, 7933.484323518953, 7936.761897143095, 7950.960245198795, 7709.190534993801, 7822.374210063182, 7826.217378262185, 7826.882596761053, 7833.0, 37587.812060939796, 37789.811050944845, 37838.43242351367, 38076.619233807585, 38326.42510362347, 3199.8641331495032, 3254.1539199807985, 3305.140663427502, 3358.4122778513906, 3783.7540559863796, 28447.857760711064, 28469.0, 28823.71176288231, 29870.954516591813, 30564.0, 3419.5383623211046, 3449.275652113059, 3474.930501389958, 3482.2165012872156, 3496.3881320768764, 231467.0, 232416.0, 232754.0, 233344.0, 233526.0, 32512.349753004808, 33613.83193084019, 52419.0, 52969.735151324, 53152.0, 31486.527702084488, 31622.525662115087, 31654.841725791222, 31671.36657266842, 31773.0, 12355.444005019795, 12497.687557811127, 12499.875001250053, 12510.74978500425, 12527.749445011048, 10423.374597524173, 10430.426326552113, 10470.685879423629, 10502.369857808557, 10537.473126343652, 8178.427510074357, 8241.299489543457, 8270.793230169294, 8333.958330208432, 8365.372597055124, 3224.8229396270194, 3248.6101667800017, 3278.3607196596436, 3295.802251864896, 3297.472404415282, 913.5888850017519, 930.1675000874179, 952.6760901293455, 985.1872205430549, 1005.8943810899897, 27482.862585686944, 28557.714422855504, 28590.428191436054, 28598.428031439256, 28950.42099158005, 993.9701808945744, 994.835852084398, 1014.437369411039, 1015.8069966706303, 1058.0319008107494, 15066.171360575274, 15186.392544298104, 15289.15909624959, 15496.225188740744, 15542.9222853885, 368866.0, 374547.0, 375297.0, 375825.0, 375842.0, 48210.758946205046, 49067.50932490629, 49126.754366228655, 49452.50547494551, 49576.752116239186, 1125.358545629, 1142.7485953090306, 1169.2808922512593, 1173.2549830857467, 1269.4541347220784, 25523.74476255288, 26118.34704132412, 27962.161135165978, 28954.0, 29003.41993160167, 39474.210515788945, 39806.402903957045, 39993.40009899912, 40025.79987100046, 40059.799701001306, 239395.0, 240585.0, 240853.0, 241023.0, 241818.0, 24708.876455618327, 25920.092796752022, 25927.870360648078, 25942.351441213366, 25964.610530841674, 43365.66343365638, 43716.56283437252, 43736.781316094486, 44541.777291113336, 44973.77513112414, 35024.824875875456, 36183.63816361803, 36603.81698091599, 36618.63381366152, 37002.44496332611, 35691.0, 36603.816980914926, 36685.44971825478, 36746.63253367539, 36802.0, 29430.142402312642, 30451.0, 36444.45333319949, 37311.253774924895, 37376.43935340918, 27321.590176146976, 29341.706582933897, 29412.705872941, 29517.262068447602, 29625.07559967435, 24120.276391708278, 24457.0, 24602.753972460046, 24723.87638061798, 25018.0], "value": 16162.493705315228, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.6014185105637, 386.3451449792601, 391.62334191730264, 394.4083874188717, 401.1355528835359, 15003.774943375844, 15631.0, 15670.451534196305, 15676.216189190553, 16305.51083467495, 16071.839281607181, 16092.436764713237, 16760.748588771177, 16865.241064152113, 17947.461576152702, 5034.723090230045, 5189.351331083614, 5203.921941170866, 5226.843194704146, 5235.2147177923425, 5115.9488405116035, 5126.871828204287, 5127.435982041972, 5142.537171654551, 5142.562882155022, 4987.700737955716, 5095.5923526118, 5106.4382917879, 5107.310513080743, 5116.079105760961, 5081.161608334621, 5092.872678183056, 5098.668586541863, 5399.163129714901, 5405.621606487547, 5232.607554433433, 5235.73821308933, 5239.607029472767, 5250.947490525123, 5264.842054738326, 12034.33811140387, 12266.0, 12560.057995650272, 12564.434600443003, 12573.057020723483, 1770.2564922732354, 2013.3154727392757, 2164.545445456456, 2169.1865550418593, 2241.5628952354296, 9021.774455638595, 9156.679516216967, 9418.434893906388, 9910.355826871302, 13487.055906086578, 1719.733441316598, 1756.9648607027916, 1757.9384721534814, 1775.485109318296, 1857.3220774417375, 65973.67013164904, 66366.66816665886, 67047.66476167589, 67332.75109170354, 67605.3239467604, 9931.65239216624, 10276.332038417479, 10359.482025898675, 10405.9479702601, 10498.527566259536, 14191.503297384543, 14332.57002289933, 14334.426622935174, 14385.78421323681, 14401.495947641783, 6901.896471552931, 6991.545549539263, 7007.4394048476, 7134.357907788324, 7138.857222855514, 6551.344865513506, 6594.5342778292115, 6641.767538136142, 6650.0, 6923.896141557881, 4331.285337919208, 4396.406485124531, 4419.270820314612, 4428.557144285545, 4512.548745125527, 1792.4264235444532, 1868.7664041994751, 1877.1552801239225, 1883.2561138350275, 1887.8584106191815, 810.5703976892256, 832.3133414932705, 927.0729270729271, 935.457434687893, 968.5302628225305, 16047.197640117947, 16434.096124713255, 16527.91736041312, 16538.25577849, 16893.915530422513, 866.9046404895456, 879.1647934462159, 894.458852394305, 916.4272329793879, 966.3139171188394, 9073.727788166365, 9422.90577094234, 9423.528823558932, 9424.908973016138, 9567.856482152773, 398382.0, 406950.0, 411808.0, 413716.0, 414726.0, 74165.6291718538, 74759.62620186864, 75156.62421687966, 77508.61245693848, 77603.0, 936.138752347828, 941.2328951904176, 952.0717300631828, 954.665866946577, 967.4485543240426, 14751.778723318945, 14897.329620166902, 15056.569625885524, 15113.149237364083, 15143.772843407138, 22770.886145569166, 23393.883030584737, 28313.575296370982, 33182.5022624656, 33361.83319083389, 43739.56260437355, 44332.77833610812, 46125.07749845051, 46874.76562617165, 47878.28182577195, 7823.921760782319, 8097.068837083811, 8111.959440202997, 8152.062512811102, 8156.551389673387, 8836.91163088361, 10684.732881678021, 10741.462926853783, 10810.51352689115, 11527.596534121265, 10493.640742812957, 10623.203259755395, 10767.97704218098, 10812.35125892449, 10954.452277386259, 10447.283706236281, 10447.84328235062, 10792.460376980962, 10937.343759374464, 11033.172512061466, 9776.85334719994, 10630.669266405253, 10648.467576621293, 10656.89343106559, 10949.397783122005, 7622.2758837910305, 7886.72396466121, 7901.130875603564, 7903.130655627761, 8022.478538894953, 6825.1127353443735, 8050.235227653364, 9580.856287155837, 10647.254692171784, 10655.147588193082], "value": 8021.147904014862, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1217.6042786094522, 1324.8807607315346, 1329.195836518906, 1402.5091218073671, 1443.3865607116975, 6768.289329620393, 7642.541447513153, 7833.255840695139, 7835.0, 7864.685412583504, 7530.096388433396, 7661.655225514851, 7664.425168112386, 7668.846623067535, 7681.423893208018, 2102.3692892132335, 2128.021110289269, 2131.1049359269145, 2131.7335333083365, 2133.391983284764, 2152.2251989283845, 2172.4460262633006, 2186.7157269554937, 2189.1681161158735, 2206.7793220677886, 2160.6326924422888, 2171.89140542973, 2181.770914054025, 2185.0495034659893, 2190.791874771894, 2133.1254185783832, 2140.9250676226256, 2141.582391433671, 2144.04589957469, 2144.6246906791407, 2116.6295898217904, 2159.762426133124, 2162.643163877974, 2162.816160626349, 2168.349495151448, 7483.513571617827, 7796.103448103484, 7802.258785415376, 7837.529748215068, 7863.0, 4625.722456652578, 4794.568488836021, 4797.784099715521, 4809.158397280462, 4820.228763397875, 3076.7230949214454, 3077.938441231185, 3141.6230052393857, 3142.0887942496647, 3166.667499912499, 978.4031740638205, 1007.5566750629699, 1011.4790882695418, 1028.7993841200969, 1038.5689938675441, 10684.145268378512, 10758.838617420744, 10769.030787229187, 10771.084457821094, 10806.675799726021, 4092.3452247640234, 4159.085001299709, 4315.762633055212, 4359.367891655756, 4376.190404775127, 8197.672093116209, 8298.419110662197, 8313.709020184264, 8313.875291870627, 8364.958175209085, 4533.5013148553635, 4536.092781443725, 4558.384618076583, 4561.7262964222255, 4562.657800664963, 3626.9274614507563, 3766.886993390203, 4139.730917490354, 4223.260929337415, 4234.745915245096, 3497.9300413992087, 3609.1338078860886, 3609.8375573099274, 3619.335105851338, 3648.5074514940675, 1076.1122074288587, 1094.7427354571669, 1099.2030777686114, 1103.1175059952006, 1105.9557617695364, 810.3274282345639, 848.4654667559398, 857.5197889182078, 898.734873212404, 929.3169520402499, 5284.207368894619, 5431.131019037014, 5525.060739674265, 5560.277163968658, 5763.0, 874.7594411536751, 890.1543533643065, 898.2006014646969, 920.4201353147474, 939.572494514994, 3636.818159092035, 3666.1018050577777, 3681.392570225936, 3696.4085746280466, 3748.887533374003, 9332.860007099898, 9560.617575297048, 9653.0, 9782.41305521671, 9796.314258002014, 9553.426794392359, 9558.90441095594, 9585.329026968046, 9592.520373981273, 9599.32804703678, 6930.688119034757, 7028.894566581505, 7197.604131772698, 7199.1001124859395, 7201.0638616980505, 5444.428335024923, 5516.420775818642, 5517.310336207974, 5562.860928476821, 5637.915431268452, 8838.734837954871, 8845.336599755174, 8858.557072146496, 8904.688335908211, 8999.32505062136, 8425.62084706202, 8844.336674749291, 8860.867086993829, 8890.511021893857, 9081.909180908106, 6242.094896240111, 6730.226024007106, 6886.793396198122, 6925.342092501204, 6930.930690693231, 7388.889166662612, 7427.554346739213, 7452.21751716062, 7460.664270107966, 7510.924890751023, 6736.225334086446, 6813.250542440229, 6875.106236189464, 6984.755533556301, 6998.545094568837, 6711.496637752286, 6735.595864248161, 6784.491163162684, 6834.760783372558, 6858.965705171642, 6320.841978950563, 6383.36166383358, 6485.383888530582, 6507.023946408077, 6507.154069971063, 4665.2535594304745, 4716.0, 4783.186858234039, 4786.617070634411, 4872.43966943806, 4664.836730714409, 4694.483606803317, 4725.810967561259, 4769.070031343855, 4809.519048095162], "value": 4151.267378751093, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.09253765574596, 321.0849080121652, 325.5198582091415, 328.9555909952156, 329.8400275866203, 5093.3124028256225, 5116.846494605168, 5118.385793704751, 5136.871578210546, 5156.974215128924, 5010.624203184758, 5062.316587260719, 5068.923966140511, 5077.238414237866, 5095.261187127864, 3792.1088544192094, 3849.3840985442334, 3933.15437181006, 4009.338459154251, 4023.4769479967563, 3997.8200980955926, 3999.4200840878057, 4003.499562554681, 4014.3978403239457, 4019.0957034667113, 3803.5055442792536, 3988.1455123367627, 3998.820053097618, 4003.9399409008743, 4008.13825027619, 3877.243937432202, 3985.163115745697, 3994.980025099856, 4008.518977722692, 4025.939610905839, 3558.1460449491938, 3562.412201986669, 3564.928701425957, 3566.5898421681577, 3571.8035508047046, 4805.663603547753, 4855.465898751135, 4860.513948605147, 4876.585490233334, 4902.877428064291, 4306.569343065699, 4551.681382303207, 4574.222382195035, 4584.106099310636, 4644.326572646981, 5318.813841515528, 5330.866728331784, 5350.715828201203, 5354.625176237665, 5363.597730170253, 3819.8281077351307, 3825.885223443301, 3828.119532507511, 3835.4438606402196, 3838.2707285615643, 5495.258140151109, 5574.219609254707, 5589.099706099945, 5595.552355811566, 5605.299337582843, 3893.7858417787293, 3902.6097390260747, 3902.746321489094, 3924.4309575111447, 3934.075492259317, 3971.1660551283976, 3971.523417189898, 3971.92056158881, 3972.8410863565714, 3979.184267225212, 4428.756418397019, 4526.185286648369, 4528.796204170821, 4546.454425468899, 4552.180607490617, 5359.758810853521, 5368.785248590013, 5373.113436283048, 5382.273393091882, 5386.946130538645, 1363.9318034098255, 1369.7876829091506, 1373.4231622718482, 1377.4008306386754, 1381.7996390523317, 880.6218268409918, 906.7869050773063, 926.7636752628172, 936.6159874451442, 951.5147274889717, 4603.516630753789, 4627.097715945359, 4634.791434385461, 4636.5131661175765, 4648.302754586839, 5448.073827449343, 5452.127659574449, 5462.535684466865, 5471.343438787291, 5477.315335583052, 4496.7077139985795, 4632.698874573142, 4639.489656137822, 4641.95358046422, 4738.763061846894, 2947.896823611163, 2964.0585416552194, 2964.273752930546, 2966.7923245372617, 2968.6586042604945, 5237.292965449692, 5248.816291429782, 5267.183586544015, 5267.288915996368, 5268.341457317835, 5525.11598144295, 5644.915326270109, 5708.80019199326, 5719.571032172604, 5742.196092547047, 5237.292965449616, 5251.711155886386, 5263.105272103751, 5271.947280527299, 5277.656952298088, 5394.568434525307, 5548.611597188158, 5561.916571251515, 5578.30271216098, 5590.720463976866, 5435.206381893887, 5469.206964989975, 5475.972620137033, 5486.887548293856, 5497.642653227527, 5181.3005244293045, 5195.5843532518065, 5219.608529360389, 5220.7650655721345, 5260.210968354778, 3782.527184101987, 3814.065553939303, 3885.9417108743955, 3887.475190849199, 3890.494235749448, 5544.7782088716, 5570.5543556516195, 5573.832785016456, 5575.470330318613, 5577.274954256083, 5382.677039377493, 5386.5152136307925, 5388.137897936468, 5391.433899440659, 5398.379186393615, 5041.319421878146, 5378.811741589026, 5386.892262154814, 5402.162664786964, 5412.729363531729, 5062.164742817541, 5291.153415453509, 5317.574594032545, 5318.0959236930585, 5328.973355133199, 5176.559992400537, 5306.628536002443, 5314.441983591667, 5317.229001794795, 5317.468253174651, 5271.1039123348355, 5290.1800220965815, 5293.697241699873, 5296.496832800878, 5315.335583052119], "value": 4043.4127961195613, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.5055036749458, 738.2101151767611, 744.1665334824995, 777.2460713108285, 786.5202226641744, 12151.817722734155, 14093.788593171097, 14593.708125837476, 14618.634534136652, 14640.633984150401, 13793.172409655428, 13837.446502139928, 13901.374438150282, 13905.0, 13907.860921390784, 646.0438550944605, 824.1922915542772, 830.7756905635475, 830.8296799156159, 831.3640065350012, 796.1242633103598, 826.4297634632085, 827.1893544326564, 827.8799574061758, 828.1263267253046, 851.7657644147847, 852.9914700853005, 856.1267507142711, 857.0358346859783, 857.2541888556964, 668.1714673804447, 828.3166387730147, 851.0340763233743, 851.6550796927223, 852.9914700853005, 621.3227581935712, 621.8103478439074, 625.6371304643296, 625.9687015649245, 626.0171530696808, 13316.467341306336, 13377.0, 13383.732325353438, 13453.932730336286, 13523.0, 11965.820512692317, 12531.498740050387, 12563.246205227624, 12727.87272127276, 12819.935900320439, 10206.926769034662, 10285.845712314322, 10392.324498907623, 10558.630447934362, 10647.787044259148, 3312.287858110518, 3313.718333941618, 3370.140614143402, 3370.9494357584654, 3381.628020917697, 47842.52157478416, 48015.519844801805, 48211.75894120542, 48658.0, 48739.0, 9940.453275069796, 10034.44810535413, 10071.899281007243, 10121.240906931862, 10170.186385089175, 16604.335826566803, 17217.91391043062, 17316.480505584852, 17539.473815785546, 17736.29054837792, 6855.760048398282, 7112.35988761014, 7210.60341681202, 7218.711251549879, 7362.226966168582, 3864.381698928158, 3886.145048089416, 3921.137349783043, 3984.8406063757125, 4019.718619696652, 2896.0877323642985, 2957.7190166934106, 2958.8224706517676, 2961.7926745127634, 2966.2139533023765, 524.4702850121405, 532.339898525833, 539.0781763184998, 540.3057071662973, 549.3161014536927, 402.75029481720935, 637.7640273098983, 659.3670076726396, 666.2870728320747, 672.9158855143107, 7541.7360392386, 7693.4614576979075, 7948.562829044343, 8163.95918020418, 8213.876791848126, 581.4882903045377, 584.6579750845718, 593.8693487432757, 595.4968051996057, 602.2983224543358, 3758.229562939591, 3773.3773927302236, 3807.1053302473897, 3884.7280690351968, 3957.881263562098, 48135.75932120317, 48381.5161848377, 51421.48578514242, 52777.0, 52949.470505294456, 44589.0, 45171.0, 45718.542814571425, 45768.54231457709, 45959.54040459619, 39474.60525394709, 40005.79997099996, 40625.39061914015, 40986.38520422196, 41575.58424415778, 8238.546879921661, 8295.834083318421, 8344.0, 8479.15208479147, 8569.314454843472, 27643.861780691772, 28075.578866316613, 28093.0, 29152.56271155892, 29159.708402915698, 35295.0, 35800.28399432049, 39381.2123757529, 39525.40711889382, 40466.59533404746, 10897.509612067317, 10913.454327283764, 10926.50830712604, 11100.888991110309, 11250.60622878228, 11511.942440287745, 11567.421628918688, 11744.58893938708, 11838.467268972745, 12061.276323420623, 11236.157288203254, 11410.94294528522, 11417.31496110236, 11585.246958947642, 11716.589919352782, 11411.201215914807, 11428.25716328436, 11650.76698466043, 12119.515219391478, 12135.635930922086, 10493.580256789643, 10598.099161571045, 10695.0, 10981.121510279318, 10998.230123891572, 9588.856167157637, 9648.614055437985, 9760.412606075133, 9801.509924503604, 10217.897821021694, 8761.299096072426, 9560.569774360032, 9803.803923921625, 9806.705798826046, 9834.950825245827], "value": 6060.855278927696, "unit": "score"}], "name": "dromaeo_css", "value": 6274.725467096828, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 116.0, 109.0, 113.0, 115.0, 113.0, 104.0, 115.0, 114.0, 114.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 138.0, 162.0, 193.0, 138.0, 156.0, 157.0, 139.0, 198.0, 140.0], "value": 158.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 160.0, 160.0, 161.0, 162.0, 162.0, 164.0, 163.0, 163.0, 159.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 108.0, 116.0, 75.0, 74.0, 74.0, 117.0, 113.0, 73.0], "value": 89.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 93.0, 144.0, 95.0, 96.0, 93.0, 158.0, 94.0, 95.0, 140.0], "value": 110.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 68.0, 68.0, 67.0, 69.0, 67.0, 79.0, 64.0, 64.0], "value": 67.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 64.0, 68.0, 64.0, 67.0, 64.0, 65.0, 64.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 79.0, 79.0, 81.0, 80.0, 78.0, 79.0, 80.0, 78.0], "value": 79.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 145.0, 131.0, 131.0, 142.0, 135.0, 139.0, 139.0, 179.0, 132.0], "value": 140.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 174.0, 170.0, 169.0, 177.0, 169.0, 171.0, 171.0, 174.0, 169.0], "value": 171.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 74.0, 73.0, 71.0, 73.0, 70.0, 71.0, 70.0], "value": 72.1, "unit": "score"}], "name": "kraken", "value": 1588.0000000000002, "alertThreshold": 2.0}]} 23:40:33 INFO - Return code: 0 23:40:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:40:33 ERROR - # TBPL SUCCESS # 23:40:33 INFO - Running post-action listener: _resource_record_post_action 23:40:33 INFO - Running post-run listener: _resource_record_post_run 23:40:34 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 7913472; Write bytes: 367726592; Read time: 2432; Write time: 476216 23:40:34 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 80023552; Read time: 0; Write time: 103968 23:40:34 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 6152192; Write bytes: 287703040; Read time: 2360; Write time: 372248 23:40:34 INFO - Running post-run listener: _upload_blobber_files 23:40:34 INFO - Blob upload gear active. 23:40:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:40:34 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 23:40:34 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:40:34 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:40:34 INFO - (blobuploader) - INFO - Open directory for files ... 23:40:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:40:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:40:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:40:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:40:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:40:35 INFO - (blobuploader) - INFO - Done attempting. 23:40:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:40:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:40:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:40:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:40:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:40:36 INFO - (blobuploader) - INFO - Done attempting. 23:40:36 INFO - (blobuploader) - INFO - Iteration through files over. 23:40:36 INFO - Return code: 0 23:40:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:40:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:40:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8802a3d5a3c92d96742bc5f570b70d32658234e3003d6ebabdfa08df28a974342e5eaba141cdc8b454ca4b2012f92bc065c68beabc02b925d10f40c8b3b81955", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3efd57911a5fc240ae1cb0c03a65533438df65abdbe87605ae3aa09c846bc72df6a4710d165784224bdab30948bac988766f480ca3c1cfc3fe0074d0eee6ac4c"} 23:40:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:40:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:40:36 INFO - Contents: 23:40:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8802a3d5a3c92d96742bc5f570b70d32658234e3003d6ebabdfa08df28a974342e5eaba141cdc8b454ca4b2012f92bc065c68beabc02b925d10f40c8b3b81955", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3efd57911a5fc240ae1cb0c03a65533438df65abdbe87605ae3aa09c846bc72df6a4710d165784224bdab30948bac988766f480ca3c1cfc3fe0074d0eee6ac4c"} 23:40:36 INFO - Running post-run listener: copy_logs_to_upload_dir 23:40:36 INFO - Copying logs to upload dir... 23:40:36 INFO - mkdir: /builds/slave/test/build/upload/logs 23:40:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.802648 ========= master_lag: 0.30 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-04-23 23:40:36.359065) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-23 23:40:36.362451) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1461478677.437013-192345811 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8802a3d5a3c92d96742bc5f570b70d32658234e3003d6ebabdfa08df28a974342e5eaba141cdc8b454ca4b2012f92bc065c68beabc02b925d10f40c8b3b81955", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3efd57911a5fc240ae1cb0c03a65533438df65abdbe87605ae3aa09c846bc72df6a4710d165784224bdab30948bac988766f480ca3c1cfc3fe0074d0eee6ac4c"} build_url:https://queue.taskcluster.net/v1/task/IccouWiyTmKnZ6lP-hr2jw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011208 build_url: 'https://queue.taskcluster.net/v1/task/IccouWiyTmKnZ6lP-hr2jw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8802a3d5a3c92d96742bc5f570b70d32658234e3003d6ebabdfa08df28a974342e5eaba141cdc8b454ca4b2012f92bc065c68beabc02b925d10f40c8b3b81955", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3efd57911a5fc240ae1cb0c03a65533438df65abdbe87605ae3aa09c846bc72df6a4710d165784224bdab30948bac988766f480ca3c1cfc3fe0074d0eee6ac4c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-23 23:40:36.387117) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 23:40:36.387438) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1461478677.437013-192345811 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004341 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 23:40:36.470601) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-23 23:40:36.470904) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-23 23:40:36.471197) ========= ========= Total master_lag: 0.48 =========