builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-031 starttime: 1461716560.77 results: success (0) buildid: 20160426143018 builduid: 96ad2f1af0e3460682eb5c206f8975d8 revision: 937d57e8b4f0fa5f16231563ab0425eee9d40c82 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 17:22:40.774055) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 17:22:40.774706) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 17:22:40.775037) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 17:22:40.796094) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 17:22:40.796493) ========= 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=db0483c52d987ecb441a263b000001ad-1461712452.501083-1436965338 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-26 17:22:40-- 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% 67.1M=0s 2016-04-26 17:22:40 (67.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.077772 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 17:22:40.894026) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 17:22:40.894344) ========= 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=db0483c52d987ecb441a263b000001ad-1461712452.501083-1436965338 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022288 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 17:22:40.944503) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 17:22:40.944907) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 937d57e8b4f0fa5f16231563ab0425eee9d40c82 --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 937d57e8b4f0fa5f16231563ab0425eee9d40c82 --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=db0483c52d987ecb441a263b000001ad-1461712452.501083-1436965338 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-26 17:22:41,123 truncating revision to first 12 chars 2016-04-26 17:22:41,123 Setting DEBUG logging. 2016-04-26 17:22:41,123 attempt 1/10 2016-04-26 17:22:41,123 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/937d57e8b4f0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-26 17:22:41,388 unpacking tar archive at: fx-team-937d57e8b4f0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.540988 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 17:22:41.498833) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 17:22:41.499140) ========= script_repo_revision: 937d57e8b4f0fa5f16231563ab0425eee9d40c82 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 17:22:41.499545) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 17:22:41.499845) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 17:22:41.509010) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-04-26 17:22:41.509389) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=db0483c52d987ecb441a263b000001ad-1461712452.501083-1436965338 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:22:41 INFO - MultiFileLogger online at 20160426 17:22:41 in /builds/slave/test 17:22:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:22:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:22:41 INFO - {'append_to_log': False, 17:22:41 INFO - 'base_work_dir': '/builds/slave/test', 17:22:41 INFO - 'blob_upload_branch': 'Fx-Team', 17:22:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:22:41 INFO - 'branch': 'Fx-Team', 17:22:41 INFO - 'buildbot_json_path': 'buildprops.json', 17:22:41 INFO - 'config_files': ('talos/linux_config.py',), 17:22:41 INFO - 'default_actions': ('clobber', 17:22:41 INFO - 'read-buildbot-config', 17:22:41 INFO - 'download-and-extract', 17:22:41 INFO - 'populate-webroot', 17:22:41 INFO - 'create-virtualenv', 17:22:41 INFO - 'install', 17:22:41 INFO - 'run-tests'), 17:22:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:22:41 INFO - 'download_minidump_stackwalk': True, 17:22:41 INFO - 'download_symbols': 'ondemand', 17:22:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:22:41 INFO - 'tooltool.py': '/tools/tooltool.py', 17:22:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:22:41 INFO - '/tools/misc-python/virtualenv.py')}, 17:22:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:22:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:22:41 INFO - 'installer_path': 'installer.exe', 17:22:41 INFO - 'log_level': 'info', 17:22:41 INFO - 'log_name': 'talos', 17:22:41 INFO - 'log_to_console': True, 17:22:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:22:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:22:41 INFO - 'opt_config_files': (), 17:22:41 INFO - 'pip_index': False, 17:22:41 INFO - 'sps_profile': False, 17:22:41 INFO - 'sps_profile_interval': 0, 17:22:41 INFO - 'suite': 'dromaeojs-e10s', 17:22:41 INFO - 'system_bits': '32', 17:22:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:22:41 INFO - 'title': 'talos-linux64-ix-031', 17:22:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:22:41 INFO - 'use_talos_json': True, 17:22:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:22:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:22:41 INFO - 'work_dir': 'build'} 17:22:41 INFO - ##### 17:22:41 INFO - ##### Running clobber step. 17:22:41 INFO - ##### 17:22:41 INFO - Running pre-action listener: _resource_record_pre_action 17:22:41 INFO - Running main action method: clobber 17:22:41 INFO - rmtree: /builds/slave/test/build 17:22:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:22:42 INFO - Running post-action listener: _resource_record_post_action 17:22:42 INFO - ##### 17:22:42 INFO - ##### Running read-buildbot-config step. 17:22:42 INFO - ##### 17:22:42 INFO - Running pre-action listener: _resource_record_pre_action 17:22:42 INFO - Running main action method: read_buildbot_config 17:22:42 INFO - Using buildbot properties: 17:22:42 INFO - { 17:22:42 INFO - "project": "", 17:22:42 INFO - "product": "firefox", 17:22:42 INFO - "script_repo_revision": "production", 17:22:42 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:22:42 INFO - "repository": "", 17:22:42 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 17:22:42 INFO - "buildid": "20160426143018", 17:22:42 INFO - "pgo_build": "True", 17:22:42 INFO - "basedir": "/builds/slave/test", 17:22:42 INFO - "buildnumber": 695, 17:22:42 INFO - "slavename": "talos-linux64-ix-031", 17:22:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:22:42 INFO - "platform": "ubuntu64_hw", 17:22:42 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:22:42 INFO - "branch": "fx-team", 17:22:42 INFO - "repo_path": "integration/fx-team", 17:22:42 INFO - "revision": "937d57e8b4f0fa5f16231563ab0425eee9d40c82", 17:22:42 INFO - "stage_platform": "linux64-pgo", 17:22:42 INFO - "builduid": "96ad2f1af0e3460682eb5c206f8975d8", 17:22:42 INFO - "slavebuilddir": "test" 17:22:42 INFO - } 17:22:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 17:22:42 INFO - Running post-action listener: _resource_record_post_action 17:22:42 INFO - ##### 17:22:42 INFO - ##### Running download-and-extract step. 17:22:42 INFO - ##### 17:22:42 INFO - Running pre-action listener: _resource_record_pre_action 17:22:42 INFO - Running main action method: download_and_extract 17:22:42 INFO - mkdir: /builds/slave/test/build/tests 17:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:22:42 INFO - https://queue.taskcluster.net/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:22:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:22:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:22:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:22:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:22:42 INFO - Downloaded 1361 bytes. 17:22:42 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:22:42 INFO - Using the following test package requirements: 17:22:42 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:22:42 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:22:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:22:42 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:22:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:22:42 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:22:42 INFO - u'jsshell-linux-x86_64.zip'], 17:22:42 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:22:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:22:42 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:22:42 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:22:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:22:42 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:22:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:22:42 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:22:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:22:42 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:22:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:22:42 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:22:42 INFO - https://queue.taskcluster.net/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:22:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:22:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:22:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:22:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:22:45 INFO - Downloaded 23863733 bytes. 17:22:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:22:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:22:46 INFO - Return code: 0 17:22:46 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:22:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:22:46 INFO - https://queue.taskcluster.net/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:22:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:22:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:22:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:22:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:22:49 INFO - Downloaded 23863733 bytes. 17:22:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:22:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:22:51 INFO - Return code: 0 17:22:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:22:51 INFO - https://queue.taskcluster.net/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:22:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:22:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:22:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:22:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:22:52 INFO - Downloaded 10840145 bytes. 17:22:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:22:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:22:52 INFO - Return code: 0 17:22:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:22:52 INFO - https://queue.taskcluster.net/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:22:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:22:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:22:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:22:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:22:54 INFO - Downloaded 58368294 bytes. 17:22:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:22:54 INFO - mkdir: /builds/slave/test/properties 17:22:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:22:54 INFO - Writing to file /builds/slave/test/properties/build_url 17:22:54 INFO - Contents: 17:22:54 INFO - build_url:https://queue.taskcluster.net/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:22:54 INFO - Running post-action listener: _resource_record_post_action 17:22:54 INFO - Running post-action listener: set_extra_try_arguments 17:22:54 INFO - ##### 17:22:54 INFO - ##### Running populate-webroot step. 17:22:54 INFO - ##### 17:22:54 INFO - Running pre-action listener: _resource_record_pre_action 17:22:54 INFO - Running main action method: populate_webroot 17:22:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:22:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:22:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:22:54 INFO - '--tppagecycles', 17:22:54 INFO - '7'], 17:22:54 INFO - 'tests': ['tsvgm']}}, 17:22:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:22:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:22:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:22:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:22:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:22:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:22:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:22:54 INFO - 'talos_options': ['--disable-e10s'], 17:22:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:22:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:22:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:22:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:22:54 INFO - 'talos_options': ['--disable-e10s'], 17:22:54 INFO - 'tests': ['damp', 'tps']}, 17:22:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:22:54 INFO - 'tests': ['damp', 'tps']}, 17:22:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:22:54 INFO - 'tests': ['dromaeo_dom']}, 17:22:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:22:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:22:54 INFO - 'tests': ['a11yr', 17:22:54 INFO - 'ts_paint', 17:22:54 INFO - 'tpaint', 17:22:54 INFO - 'sessionrestore', 17:22:54 INFO - 'sessionrestore_no_auto_restore', 17:22:54 INFO - 'tabpaint']}, 17:22:54 INFO - 'other-e10s': {'tests': ['a11yr', 17:22:54 INFO - 'ts_paint', 17:22:54 INFO - 'tpaint', 17:22:54 INFO - 'sessionrestore', 17:22:54 INFO - 'sessionrestore_no_auto_restore', 17:22:54 INFO - 'tabpaint']}, 17:22:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:22:54 INFO - 'ts_paint', 17:22:54 INFO - 'tpaint', 17:22:54 INFO - 'sessionrestore', 17:22:54 INFO - 'sessionrestore_no_auto_restore', 17:22:54 INFO - 'tabpaint']}, 17:22:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:22:54 INFO - 'ts_paint', 17:22:54 INFO - 'tpaint', 17:22:54 INFO - 'sessionrestore', 17:22:54 INFO - 'sessionrestore_no_auto_restore', 17:22:54 INFO - 'tabpaint']}, 17:22:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:22:54 INFO - 'tests': ['a11yr', 17:22:54 INFO - 'ts_paint', 17:22:54 INFO - 'tpaint', 17:22:54 INFO - 'sessionrestore', 17:22:54 INFO - 'sessionrestore_no_auto_restore', 17:22:54 INFO - 'tabpaint']}, 17:22:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:22:54 INFO - 'tests': ['a11yr', 17:22:54 INFO - 'ts_paint', 17:22:54 INFO - 'tpaint', 17:22:54 INFO - 'sessionrestore', 17:22:54 INFO - 'sessionrestore_no_auto_restore', 17:22:54 INFO - 'tabpaint']}, 17:22:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:22:54 INFO - 'tests': ['tsvgx', 17:22:54 INFO - 'tsvgr_opacity', 17:22:54 INFO - 'tart', 17:22:54 INFO - 'tscrollx', 17:22:54 INFO - 'cart']}, 17:22:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:22:54 INFO - 'tsvgr_opacity', 17:22:54 INFO - 'tart', 17:22:54 INFO - 'tscrollx', 17:22:54 INFO - 'cart']}, 17:22:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:22:54 INFO - 'talos_options': ['--disable-e10s'], 17:22:54 INFO - 'tests': ['tp5o']}, 17:22:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:22:54 INFO - 'tests': ['tp5o']}, 17:22:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:22:54 INFO - 'talos_options': ['--disable-e10s', 17:22:54 INFO - '--xperf_path', 17:22:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:22:54 INFO - 'tests': ['tp5n']}, 17:22:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:22:54 INFO - 'talos_options': ['--xperf_path', 17:22:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:22:54 INFO - 'tests': ['tp5n']}}, 17:22:54 INFO - 'talos.zip': {'path': '', 17:22:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:22:54 INFO - Running post-action listener: _resource_record_post_action 17:22:54 INFO - ##### 17:22:54 INFO - ##### Running create-virtualenv step. 17:22:54 INFO - ##### 17:22:54 INFO - Running pre-action listener: _resource_record_pre_action 17:22:54 INFO - Running main action method: create_virtualenv 17:22:54 INFO - Creating virtualenv /builds/slave/test/build/venv 17:22:54 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 17:22:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:22:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:22:55 INFO - Using real prefix '/usr' 17:22:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:22:55 INFO - Installing distribute.............................................................................................................................................................................................done. 17:22:57 INFO - Installing pip.................done. 17:22:57 INFO - Return code: 0 17:22:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:22:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:22:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:57 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 0x7f51c7270f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2832410>, '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 0x2833310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28337a0>, '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': 'db0483c52d987ecb441a263b000001ad-1461712452.501083-1436965338', '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 17:22:57 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 17:22:57 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 17:22:57 INFO - Using env: {'DISPLAY': ':0', 17:22:57 INFO - 'HOME': '/home/cltbld', 17:22:57 INFO - 'LANG': 'en_US.UTF-8', 17:22:57 INFO - 'LANGUAGE': 'en_US:en', 17:22:57 INFO - 'LOGNAME': 'cltbld', 17:22:57 INFO - 'MAIL': '/var/mail/cltbld', 17:22:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:57 INFO - 'MOZ_NO_REMOTE': '1', 17:22:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:57 INFO - 'NO_EM_RESTART': '1', 17:22:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:57 INFO - 'PWD': '/builds/slave/test', 17:22:57 INFO - 'SHELL': '/bin/bash', 17:22:57 INFO - 'SHLVL': '1', 17:22:57 INFO - 'TERM': 'linux', 17:22:57 INFO - 'TMOUT': '86400', 17:22:57 INFO - 'USER': 'cltbld', 17:22:57 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1461712452.501083-1436965338', 17:22:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:57 INFO - '_': '/tools/buildbot/bin/python'} 17:22:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:57 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 17:22:57 INFO - Cleaning up... 17:22:57 INFO - Return code: 0 17:22:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:22:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:22:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:57 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 0x7f51c7270f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2832410>, '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 0x2833310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28337a0>, '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': 'db0483c52d987ecb441a263b000001ad-1461712452.501083-1436965338', '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 17:22:57 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 17:22:57 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 17:22:57 INFO - Using env: {'DISPLAY': ':0', 17:22:57 INFO - 'HOME': '/home/cltbld', 17:22:57 INFO - 'LANG': 'en_US.UTF-8', 17:22:57 INFO - 'LANGUAGE': 'en_US:en', 17:22:57 INFO - 'LOGNAME': 'cltbld', 17:22:57 INFO - 'MAIL': '/var/mail/cltbld', 17:22:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:57 INFO - 'MOZ_NO_REMOTE': '1', 17:22:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:57 INFO - 'NO_EM_RESTART': '1', 17:22:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:57 INFO - 'PWD': '/builds/slave/test', 17:22:57 INFO - 'SHELL': '/bin/bash', 17:22:57 INFO - 'SHLVL': '1', 17:22:57 INFO - 'TERM': 'linux', 17:22:57 INFO - 'TMOUT': '86400', 17:22:57 INFO - 'USER': 'cltbld', 17:22:57 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1461712452.501083-1436965338', 17:22:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:57 INFO - '_': '/tools/buildbot/bin/python'} 17:22:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:57 INFO - Downloading/unpacking psutil>=0.7.1 17:22:57 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 17:22:57 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 17:22:57 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 17:22:57 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 17:22:57 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 17:22:57 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 17:22:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:22:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:22:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:22:59 INFO - Installing collected packages: psutil 17:22:59 INFO - Running setup.py install for psutil 17:23:00 INFO - building 'psutil._psutil_linux' extension 17:23:00 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 17:23:00 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 17:23:00 INFO - building 'psutil._psutil_posix' extension 17:23:00 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 17:23:00 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 17:23:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:23:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:23:00 INFO - Successfully installed psutil 17:23:00 INFO - Cleaning up... 17:23:00 INFO - Return code: 0 17:23:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:23:00 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')]} 17:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:23:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23:00 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')]} 17:23:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:23:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23:00 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 0x7f51c7270f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2832410>, '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 0x2833310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28337a0>, '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': 'db0483c52d987ecb441a263b000001ad-1461712452.501083-1436965338', '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 17:23:00 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 17:23:00 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 17:23:00 INFO - Using env: {'DISPLAY': ':0', 17:23:00 INFO - 'HOME': '/home/cltbld', 17:23:00 INFO - 'LANG': 'en_US.UTF-8', 17:23:00 INFO - 'LANGUAGE': 'en_US:en', 17:23:00 INFO - 'LOGNAME': 'cltbld', 17:23:00 INFO - 'MAIL': '/var/mail/cltbld', 17:23:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:00 INFO - 'MOZ_NO_REMOTE': '1', 17:23:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:00 INFO - 'NO_EM_RESTART': '1', 17:23:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:00 INFO - 'PWD': '/builds/slave/test', 17:23:00 INFO - 'SHELL': '/bin/bash', 17:23:00 INFO - 'SHLVL': '1', 17:23:00 INFO - 'TERM': 'linux', 17:23:00 INFO - 'TMOUT': '86400', 17:23:00 INFO - 'USER': 'cltbld', 17:23:00 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1461712452.501083-1436965338', 17:23:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:00 INFO - '_': '/tools/buildbot/bin/python'} 17:23:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:23:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:23:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:23:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:23:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:23:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:23:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:23:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:23:02 INFO - Installing collected packages: mozsystemmonitor 17:23:02 INFO - Running setup.py install for mozsystemmonitor 17:23:02 INFO - Successfully installed mozsystemmonitor 17:23:02 INFO - Cleaning up... 17:23:02 INFO - Return code: 0 17:23:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:23:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:23:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:23:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f51c7270f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2832410>, '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 0x2833310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28337a0>, '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': 'db0483c52d987ecb441a263b000001ad-1461712452.501083-1436965338', '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 17:23:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:23:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:23:02 INFO - Using env: {'DISPLAY': ':0', 17:23:02 INFO - 'HOME': '/home/cltbld', 17:23:02 INFO - 'LANG': 'en_US.UTF-8', 17:23:02 INFO - 'LANGUAGE': 'en_US:en', 17:23:02 INFO - 'LOGNAME': 'cltbld', 17:23:02 INFO - 'MAIL': '/var/mail/cltbld', 17:23:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:02 INFO - 'MOZ_NO_REMOTE': '1', 17:23:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:02 INFO - 'NO_EM_RESTART': '1', 17:23:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:02 INFO - 'PWD': '/builds/slave/test', 17:23:02 INFO - 'SHELL': '/bin/bash', 17:23:02 INFO - 'SHLVL': '1', 17:23:02 INFO - 'TERM': 'linux', 17:23:02 INFO - 'TMOUT': '86400', 17:23:02 INFO - 'USER': 'cltbld', 17:23:02 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1461712452.501083-1436965338', 17:23:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:02 INFO - '_': '/tools/buildbot/bin/python'} 17:23:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:23:02 INFO - Downloading/unpacking blobuploader==1.2.4 17:23:02 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 17:23:02 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 17:23:02 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 17:23:02 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 17:23:02 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 17:23:02 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 17:23:04 INFO - Downloading blobuploader-1.2.4.tar.gz 17:23:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:23:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:23:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:23:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:23:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:23:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:23:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:23:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:23: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 17:23: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 17:23: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 17:23: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 17:23: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 17:23: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 17:23:05 INFO - Downloading docopt-0.6.1.tar.gz 17:23:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:23:05 INFO - Installing collected packages: blobuploader, requests, docopt 17:23:05 INFO - Running setup.py install for blobuploader 17:23:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:23:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:23:05 INFO - Running setup.py install for requests 17:23:06 INFO - Running setup.py install for docopt 17:23:06 INFO - Successfully installed blobuploader requests docopt 17:23:06 INFO - Cleaning up... 17:23:06 INFO - Return code: 0 17:23:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:23:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:23:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:23:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23:06 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 0x7f51c7270f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2832410>, '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 0x2833310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28337a0>, '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': 'db0483c52d987ecb441a263b000001ad-1461712452.501083-1436965338', '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 17:23:06 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 17:23:06 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 17:23:06 INFO - Using env: {'DISPLAY': ':0', 17:23:06 INFO - 'HOME': '/home/cltbld', 17:23:06 INFO - 'LANG': 'en_US.UTF-8', 17:23:06 INFO - 'LANGUAGE': 'en_US:en', 17:23:06 INFO - 'LOGNAME': 'cltbld', 17:23:06 INFO - 'MAIL': '/var/mail/cltbld', 17:23:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:06 INFO - 'MOZ_NO_REMOTE': '1', 17:23:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:06 INFO - 'NO_EM_RESTART': '1', 17:23:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:06 INFO - 'PWD': '/builds/slave/test', 17:23:06 INFO - 'SHELL': '/bin/bash', 17:23:06 INFO - 'SHLVL': '1', 17:23:06 INFO - 'TERM': 'linux', 17:23:06 INFO - 'TMOUT': '86400', 17:23:06 INFO - 'USER': 'cltbld', 17:23:06 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1461712452.501083-1436965338', 17:23:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:06 INFO - '_': '/tools/buildbot/bin/python'} 17:23:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:23:06 INFO - Running setup.py (path:/tmp/pip-qOar3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:23:06 INFO - Running setup.py (path:/tmp/pip-hVVedN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:23:06 INFO - Running setup.py (path:/tmp/pip-2GJaw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:23:06 INFO - Running setup.py (path:/tmp/pip-FALkGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:23:06 INFO - Running setup.py (path:/tmp/pip-wia7IB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:23:06 INFO - Running setup.py (path:/tmp/pip-VSoL9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:23:06 INFO - Running setup.py (path:/tmp/pip-5zeKUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:23:06 INFO - Running setup.py (path:/tmp/pip-IR46kM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:23:07 INFO - Running setup.py (path:/tmp/pip-RNYye4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:23:07 INFO - Running setup.py (path:/tmp/pip-NSIlOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:23:07 INFO - Running setup.py (path:/tmp/pip-OaBJyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:23:07 INFO - Running setup.py (path:/tmp/pip-WmcVPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:23:07 INFO - Running setup.py (path:/tmp/pip-KxO8IA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:23:07 INFO - Running setup.py (path:/tmp/pip-KXEvel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:23:07 INFO - Running setup.py (path:/tmp/pip-GWQas8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:23:07 INFO - Running setup.py (path:/tmp/pip-uAfA6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:23:07 INFO - Running setup.py (path:/tmp/pip-lrKft3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:23:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:23:07 INFO - Running setup.py install for manifestparser 17:23:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:23:07 INFO - Running setup.py install for mozcrash 17:23:07 INFO - Running setup.py install for mozdebug 17:23:07 INFO - Running setup.py install for mozdevice 17:23:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:23:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:23:08 INFO - Running setup.py install for mozfile 17:23:08 INFO - Running setup.py install for mozhttpd 17:23:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:23:08 INFO - Running setup.py install for mozinfo 17:23:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:23:08 INFO - Running setup.py install for mozInstall 17:23:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:23:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:23:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:23:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:23:08 INFO - Running setup.py install for mozleak 17:23:08 INFO - Running setup.py install for mozlog 17:23:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:23:08 INFO - Running setup.py install for moznetwork 17:23:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:23:08 INFO - Running setup.py install for mozprocess 17:23:08 INFO - Running setup.py install for mozprofile 17:23:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:23:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:23:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:23:09 INFO - Running setup.py install for mozrunner 17:23:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:23:09 INFO - Running setup.py install for mozscreenshot 17:23:09 INFO - Running setup.py install for moztest 17:23:09 INFO - Running setup.py install for mozversion 17:23:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:23:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:23:09 INFO - Cleaning up... 17:23:09 INFO - Return code: 0 17:23:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:23: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')]} 17:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:23:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23: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')]} 17:23:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:23:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23:09 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 0x7f51c7270f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2832410>, '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 0x2833310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28337a0>, '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': 'db0483c52d987ecb441a263b000001ad-1461712452.501083-1436965338', '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 17:23:09 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 17:23:09 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 17:23:09 INFO - Using env: {'DISPLAY': ':0', 17:23:09 INFO - 'HOME': '/home/cltbld', 17:23:09 INFO - 'LANG': 'en_US.UTF-8', 17:23:09 INFO - 'LANGUAGE': 'en_US:en', 17:23:09 INFO - 'LOGNAME': 'cltbld', 17:23:09 INFO - 'MAIL': '/var/mail/cltbld', 17:23:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:09 INFO - 'MOZ_NO_REMOTE': '1', 17:23:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:09 INFO - 'NO_EM_RESTART': '1', 17:23:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:09 INFO - 'PWD': '/builds/slave/test', 17:23:09 INFO - 'SHELL': '/bin/bash', 17:23:09 INFO - 'SHLVL': '1', 17:23:09 INFO - 'TERM': 'linux', 17:23:09 INFO - 'TMOUT': '86400', 17:23:09 INFO - 'USER': 'cltbld', 17:23:09 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1461712452.501083-1436965338', 17:23:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:09 INFO - '_': '/tools/buildbot/bin/python'} 17:23:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:23:09 INFO - Running setup.py (path:/tmp/pip-Jx9gHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:23:09 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)) 17:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:23:09 INFO - Running setup.py (path:/tmp/pip-8XLw8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:23:09 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)) 17:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:23:09 INFO - Running setup.py (path:/tmp/pip-5dEKwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:23:09 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)) 17:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:23:09 INFO - Running setup.py (path:/tmp/pip-FMU73Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:23:09 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)) 17:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:23:09 INFO - Running setup.py (path:/tmp/pip-dnOiVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:23:10 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)) 17:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:23:10 INFO - Running setup.py (path:/tmp/pip-cvB6Lp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:23:10 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)) 17:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:23:10 INFO - Running setup.py (path:/tmp/pip-E89RgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:23:10 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)) 17:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:23:10 INFO - Running setup.py (path:/tmp/pip-0m_gLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:23:10 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)) 17:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:23:10 INFO - Running setup.py (path:/tmp/pip-SryIO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:23:10 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)) 17:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:23:10 INFO - Running setup.py (path:/tmp/pip-ozosn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:23:10 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)) 17:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:23:10 INFO - Running setup.py (path:/tmp/pip-hXX7Uc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:23:10 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)) 17:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:23:10 INFO - Running setup.py (path:/tmp/pip-PFr7Yi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:23:10 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)) 17:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:23:10 INFO - Running setup.py (path:/tmp/pip-E8DEXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:23:10 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)) 17:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:23:10 INFO - Running setup.py (path:/tmp/pip-uTXpt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:23:10 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)) 17:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:23:10 INFO - Running setup.py (path:/tmp/pip-bzElOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:23:10 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)) 17:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:23:10 INFO - Running setup.py (path:/tmp/pip-AFtKax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:23:10 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)) 17:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:23:10 INFO - Running setup.py (path:/tmp/pip-KRp_7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:23:10 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)) 17:23:10 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)) 17:23:10 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)) 17:23:10 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)) 17:23:10 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)) 17:23:10 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)) 17:23:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:23:10 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 17:23:10 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 17:23:10 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 17:23:10 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 17:23:10 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 17:23:10 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 17:23:12 INFO - Downloading blessings-1.6.tar.gz 17:23:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:23:12 INFO - Installing collected packages: blessings 17:23:12 INFO - Running setup.py install for blessings 17:23:12 INFO - Successfully installed blessings 17:23:12 INFO - Cleaning up... 17:23:13 INFO - Return code: 0 17:23:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:23:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:23:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:23:13 INFO - Reading from file tmpfile_stdout 17:23:13 INFO - Current package versions: 17:23:13 INFO - argparse == 1.2.1 17:23:13 INFO - blessings == 1.6 17:23:13 INFO - blobuploader == 1.2.4 17:23:13 INFO - docopt == 0.6.1 17:23:13 INFO - manifestparser == 1.1 17:23:13 INFO - mozInstall == 1.12 17:23:13 INFO - mozcrash == 0.17 17:23:13 INFO - mozdebug == 0.1 17:23:13 INFO - mozdevice == 0.48 17:23:13 INFO - mozfile == 1.2 17:23:13 INFO - mozhttpd == 0.7 17:23:13 INFO - mozinfo == 0.9 17:23:13 INFO - mozleak == 0.1 17:23:13 INFO - mozlog == 3.1 17:23:13 INFO - moznetwork == 0.27 17:23:13 INFO - mozprocess == 0.22 17:23:13 INFO - mozprofile == 0.28 17:23:13 INFO - mozrunner == 6.11 17:23:13 INFO - mozscreenshot == 0.1 17:23:13 INFO - mozsystemmonitor == 0.0 17:23:13 INFO - moztest == 0.7 17:23:13 INFO - mozversion == 1.4 17:23:13 INFO - psutil == 3.1.1 17:23:13 INFO - requests == 1.2.3 17:23:13 INFO - wsgiref == 0.1.2 17:23:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:23:13 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')]} 17:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23:13 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')]} 17:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23:13 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 0x7f51c7270f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2832410>, '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 0x2833310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28337a0>, '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': 'db0483c52d987ecb441a263b000001ad-1461712452.501083-1436965338', '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 17:23:13 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 17:23:13 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 17:23:13 INFO - Using env: {'DISPLAY': ':0', 17:23:13 INFO - 'HOME': '/home/cltbld', 17:23:13 INFO - 'LANG': 'en_US.UTF-8', 17:23:13 INFO - 'LANGUAGE': 'en_US:en', 17:23:13 INFO - 'LOGNAME': 'cltbld', 17:23:13 INFO - 'MAIL': '/var/mail/cltbld', 17:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:13 INFO - 'MOZ_NO_REMOTE': '1', 17:23:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:13 INFO - 'NO_EM_RESTART': '1', 17:23:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:13 INFO - 'PWD': '/builds/slave/test', 17:23:13 INFO - 'SHELL': '/bin/bash', 17:23:13 INFO - 'SHLVL': '1', 17:23:13 INFO - 'TERM': 'linux', 17:23:13 INFO - 'TMOUT': '86400', 17:23:13 INFO - 'USER': 'cltbld', 17:23:13 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1461712452.501083-1436965338', 17:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:13 INFO - '_': '/tools/buildbot/bin/python'} 17:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:23:13 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)) 17:23:13 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)) 17:23:13 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)) 17:23:13 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)) 17:23:13 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)) 17:23:13 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)) 17:23:13 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)) 17:23:13 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)) 17:23:13 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)) 17:23:13 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)) 17:23:13 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)) 17:23:13 INFO - Cleaning up... 17:23:13 INFO - Return code: 0 17:23:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:23:13 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')]} 17:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23:13 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')]} 17:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23:13 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 0x7f51c7270f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2832410>, '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 0x2833310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28337a0>, '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': 'db0483c52d987ecb441a263b000001ad-1461712452.501083-1436965338', '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 17:23:13 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 17:23:13 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 17:23:13 INFO - Using env: {'DISPLAY': ':0', 17:23:13 INFO - 'HOME': '/home/cltbld', 17:23:13 INFO - 'LANG': 'en_US.UTF-8', 17:23:13 INFO - 'LANGUAGE': 'en_US:en', 17:23:13 INFO - 'LOGNAME': 'cltbld', 17:23:13 INFO - 'MAIL': '/var/mail/cltbld', 17:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:13 INFO - 'MOZ_NO_REMOTE': '1', 17:23:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:13 INFO - 'NO_EM_RESTART': '1', 17:23:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:13 INFO - 'PWD': '/builds/slave/test', 17:23:13 INFO - 'SHELL': '/bin/bash', 17:23:13 INFO - 'SHLVL': '1', 17:23:13 INFO - 'TERM': 'linux', 17:23:13 INFO - 'TMOUT': '86400', 17:23:13 INFO - 'USER': 'cltbld', 17:23:13 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1461712452.501083-1436965338', 17:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:13 INFO - '_': '/tools/buildbot/bin/python'} 17:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:23:13 INFO - Downloading/unpacking jsonschema 17:23: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 17:23: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 17:23: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 17:23: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 17:23: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 17:23: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 17:23:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:23:15 INFO - Downloading/unpacking functools32 (from jsonschema) 17:23:15 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 17:23:15 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 17:23:15 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 17:23:15 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 17:23:15 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 17:23:15 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 17:23:15 INFO - Downloading functools32-3.2.3-2.tar.gz 17:23:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:23:15 INFO - warning: no files found matching '*.txt' 17:23:15 INFO - no previously-included directories found matching 'build' 17:23:15 INFO - no previously-included directories found matching 'dist' 17:23:15 INFO - no previously-included directories found matching '.git*' 17:23:15 INFO - Installing collected packages: jsonschema, functools32 17:23:15 INFO - Running setup.py install for functools32 17:23:15 INFO - warning: no files found matching '*.txt' 17:23:15 INFO - no previously-included directories found matching 'build' 17:23:15 INFO - no previously-included directories found matching 'dist' 17:23:15 INFO - no previously-included directories found matching '.git*' 17:23:16 INFO - Successfully installed jsonschema functools32 17:23:16 INFO - Cleaning up... 17:23:16 INFO - Return code: 0 17:23:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:23:16 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')]} 17:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:23:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23:16 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')]} 17:23:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:23:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:23:16 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 0x7f51c7270f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2832410>, '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 0x2833310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28337a0>, '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': 'db0483c52d987ecb441a263b000001ad-1461712452.501083-1436965338', '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 17:23:16 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 17:23:16 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 17:23:16 INFO - Using env: {'DISPLAY': ':0', 17:23:16 INFO - 'HOME': '/home/cltbld', 17:23:16 INFO - 'LANG': 'en_US.UTF-8', 17:23:16 INFO - 'LANGUAGE': 'en_US:en', 17:23:16 INFO - 'LOGNAME': 'cltbld', 17:23:16 INFO - 'MAIL': '/var/mail/cltbld', 17:23:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:16 INFO - 'MOZ_NO_REMOTE': '1', 17:23:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:16 INFO - 'NO_EM_RESTART': '1', 17:23:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:16 INFO - 'PWD': '/builds/slave/test', 17:23:16 INFO - 'SHELL': '/bin/bash', 17:23:16 INFO - 'SHLVL': '1', 17:23:16 INFO - 'TERM': 'linux', 17:23:16 INFO - 'TMOUT': '86400', 17:23:16 INFO - 'USER': 'cltbld', 17:23:16 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1461712452.501083-1436965338', 17:23:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:16 INFO - '_': '/tools/buildbot/bin/python'} 17:23:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:23:16 INFO - Downloading/unpacking flake8 17:23:16 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 17:23:16 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 17:23:16 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 17:23:16 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 17:23:16 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 17:23:16 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 17:23:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:23:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:23:18 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 17:23:18 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 17:23:18 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 17:23:18 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 17:23:18 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 17:23:18 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 17:23:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:23:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:23:18 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 17:23:18 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 17:23:18 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 17:23:18 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 17:23:18 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 17:23:18 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 17:23:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:23:18 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 17:23:18 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 17:23:18 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 17:23:18 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 17:23:18 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 17:23:18 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 17:23:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:23:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:23:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:23:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:23:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:23:18 INFO - no previously-included directories found matching 'docs/_build' 17:23:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:23:18 INFO - Running setup.py install for pep8 17:23:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:23:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:23:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:23:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:23:18 INFO - no previously-included directories found matching 'docs/_build' 17:23:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:23:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:23:19 INFO - Cleaning up... 17:23:19 INFO - Return code: 0 17:23:19 INFO - Running post-action listener: _resource_record_post_action 17:23:19 INFO - Running post-action listener: _start_resource_monitoring 17:23:19 INFO - Starting resource monitoring. 17:23:19 INFO - ##### 17:23:19 INFO - ##### Running install step. 17:23:19 INFO - ##### 17:23:19 INFO - Running pre-action listener: _resource_record_pre_action 17:23:19 INFO - Running main action method: install 17:23:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:23:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:23:19 INFO - Reading from file tmpfile_stdout 17:23:19 INFO - Detecting whether we're running mozinstall >=1.0... 17:23:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:23:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:23:19 INFO - Reading from file tmpfile_stdout 17:23:19 INFO - Output received: 17:23:19 INFO - Usage: mozinstall [options] installer 17:23:19 INFO - Options: 17:23:19 INFO - -h, --help show this help message and exit 17:23:19 INFO - -d DEST, --destination=DEST 17:23:19 INFO - Directory to install application into. [default: 17:23:19 INFO - "/builds/slave/test"] 17:23:19 INFO - --app=APP Application being installed. [default: firefox] 17:23:19 INFO - mkdir: /builds/slave/test/build/application 17:23:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:23:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:23:35 INFO - Reading from file tmpfile_stdout 17:23:35 INFO - Output received: 17:23:35 INFO - /builds/slave/test/build/application/firefox/firefox 17:23:35 INFO - Running post-action listener: _resource_record_post_action 17:23:35 INFO - ##### 17:23:35 INFO - ##### Running run-tests step. 17:23:35 INFO - ##### 17:23:35 INFO - Running pre-action listener: _resource_record_pre_action 17:23:35 INFO - Running main action method: run_tests 17:23:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:23:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:23:35 INFO - Python 2.7.3 17:23:35 INFO - Return code: 0 17:23:35 INFO - grabbing minidump binary from tooltool 17:23:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:23:35 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 0x2832410>, '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 0x2833310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28337a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:23:35 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 17:23:35 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 17:23:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:23:36 INFO - Return code: 0 17:23:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:23:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:23:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:23:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:23:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:23:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:23:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:23:36 INFO - Return code: 0 17:23:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:23:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:23:36 INFO - Using env: {'DISPLAY': ':0', 17:23:36 INFO - 'HOME': '/home/cltbld', 17:23:36 INFO - 'LANG': 'en_US.UTF-8', 17:23:36 INFO - 'LANGUAGE': 'en_US:en', 17:23:36 INFO - 'LOGNAME': 'cltbld', 17:23:36 INFO - 'MAIL': '/var/mail/cltbld', 17:23:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:23:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:23:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:36 INFO - 'MOZ_NO_REMOTE': '1', 17:23:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:23:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:36 INFO - 'NO_EM_RESTART': '1', 17:23:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:36 INFO - 'PWD': '/builds/slave/test', 17:23:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:23:36 INFO - 'SHELL': '/bin/bash', 17:23:36 INFO - 'SHLVL': '1', 17:23:36 INFO - 'TERM': 'linux', 17:23:36 INFO - 'TMOUT': '86400', 17:23:36 INFO - 'USER': 'cltbld', 17:23:36 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1461712452.501083-1436965338', 17:23:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:36 INFO - '_': '/tools/buildbot/bin/python'} 17:23:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:23:37 INFO - mozversion application_buildid: 20160426143018 17:23:37 INFO - mozversion application_changeset: 937d57e8b4f0fa5f16231563ab0425eee9d40c82 17:23:37 INFO - mozversion application_display_name: Nightly 17:23:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:23:37 INFO - mozversion application_name: Firefox 17:23:37 INFO - mozversion application_remotingname: firefox 17:23:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:23:37 INFO - mozversion application_vendor: Mozilla 17:23:37 INFO - mozversion application_version: 49.0a1 17:23:37 INFO - mozversion platform_buildid: 20160426143018 17:23:37 INFO - mozversion platform_changeset: 937d57e8b4f0fa5f16231563ab0425eee9d40c82 17:23:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:23:37 INFO - mozversion platform_version: 49.0a1 17:23:37 INFO - using testdate: 1461716617 17:23:37 INFO - actual date: 1461716617 17:23:37 INFO - starting webserver on 'localhost:37705' 17:23:37 INFO - SUITE-START | Running 2 tests 17:23:37 INFO - TEST-START | dromaeo_css 17:23:37 INFO - operating with platform_type : linux_ 17:23:37 INFO - Initialising browser for dromaeo_css test... 17:23:37 INFO - TEST-INFO | started process 21415 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphVyhge/profile http://localhost:37705/getInfo.html) 17:23:40 INFO - PROCESS | 21415 | 17:23:40 INFO - PROCESS | 21415 | (process:21484): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:23:41 INFO - PROCESS | 21415 | __metrics Screen width/height:1600/1200 17:23:41 INFO - PROCESS | 21415 | colorDepth:24 17:23:41 INFO - PROCESS | 21415 | Browser inner width/height: 1024/697 17:23:41 INFO - PROCESS | 21415 | __metrics 17:23:42 ERROR - PROCESS | 21415 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 17:23:42 INFO - TEST-INFO | 21415: exit 0 17:23:42 INFO - Browser initialized. 17:23:42 INFO - Running cycle 1/1 for dromaeo_css test... 17:23:42 INFO - TEST-INFO | started process 21535 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphVyhge/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:23:44 INFO - PROCESS | 21535 | 17:23:44 INFO - PROCESS | 21535 | (process:21597): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:23:54 INFO - PROCESS | 21535 | RSS: Main: 164261888 17:23:54 INFO - PROCESS | 21535 | 17:24:44 INFO - PROCESS | 21535 | 1461716684421 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] 17:26:50 INFO - PROCESS | 21535 | Cycle 1(1): loaded http://localhost:37705/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37705/tests/dromaeo/cssquery-ext.html) 17:26:51 INFO - PROCESS | 21535 | RSS: Main: 169844736 17:26:51 INFO - PROCESS | 21535 | 17:29:53 INFO - PROCESS | 21535 | Cycle 1(1): loaded http://localhost:37705/tests/dromaeo/cssquery-ext.html (next: http://localhost:37705/tests/dromaeo/cssquery-jquery.html) 17:29:54 INFO - PROCESS | 21535 | RSS: Main: 169238528 17:29:54 INFO - PROCESS | 21535 | 17:32:56 INFO - PROCESS | 21535 | Cycle 1(1): loaded http://localhost:37705/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37705/tests/dromaeo/cssquery-mootools.html) 17:32:56 INFO - PROCESS | 21535 | RSS: Main: 167428096 17:32:56 INFO - PROCESS | 21535 | 17:35:58 INFO - PROCESS | 21535 | Cycle 1(1): loaded http://localhost:37705/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37705/tests/dromaeo/cssquery-prototype.html) 17:35:59 INFO - PROCESS | 21535 | RSS: Main: 165937152 17:35:59 INFO - PROCESS | 21535 | 17:39:01 INFO - PROCESS | 21535 | Cycle 1(1): loaded http://localhost:37705/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37705/tests/dromaeo/cssquery-yui.html) 17:39:02 INFO - PROCESS | 21535 | RSS: Main: 166481920 17:39:02 INFO - PROCESS | 21535 | 17:42:04 INFO - PROCESS | 21535 | Cycle 1(1): loaded http://localhost:37705/tests/dromaeo/cssquery-yui.html (next: http://localhost:37705/tests/dromaeo/cssquery-dojo.html) 17:42:04 INFO - PROCESS | 21535 | RSS: Main: 168525824 17:42:04 INFO - PROCESS | 21535 | 17:42:04 INFO - PROCESS | 21535 | __start_tp_report 17:42:04 INFO - PROCESS | 21535 | _x_x_mozilla_page_load 17:42:04 INFO - PROCESS | 21535 | _x_x_mozilla_page_load_details 17:42:04 INFO - PROCESS | 21535 | |i|pagename|runs| 17:42:04 INFO - PROCESS | 21535 | |0;dojo.html;3086.3055812442194;3147.5121356189784;3160.5417214503896;3181.045686294113;3181.3478236961423;5115.8209462668765;5162.122439185338;5178.741062946851;5188.662736922098;5232.764525596348;5139.768710408031;5222.9477705222935;5277.340332458442;5293.841184764463;5315;4724.842413608662;4745.240761478164;4825.589824864891;4854.805807767685;4907.631927605426;240.1672694394213;4718.858434246961;4758.928616070744;4815.398075240595;4824.87937801556;4716.245400735883;4716.976415117937;4738.19450693383;4764.857054288377;4773.164696178173;4717.198076327033;4720.150372932871;4746.216874215785;4807.11068452334;4835.105505481497;4672.789724462374;4709.9764501177615;4737.692050016738;4772.73749943753;4787.6648634595595;5167.870803229912;5201.7027371101085;5208.479152084799;5219.895602087975;5220.843374698765;5626.493615574618;5627.80302689408;5633.464820842054;5650.604457687963;5655.8586035349035;5622.915656265119;5664.320281566197;5682.573806964494;5717.285339332583;5718.685472299022;5202.3497062867145;5210.400803907562;5224.764885580158;5226.92159617606;5226.92159617606;5582.7766889324785;5690.317161940594;5715.457031581993;5719.113537401709;5772.538196944234;5578.553715702734;5585.273914391103;5591.7483713233005;5594.636348637407;5652.576056795757;5649.887002259932;5683.26117604717;5684.602077854511;5690.715464226855;5691.943080569225;5405.108157154104;5509.807156749494;5517.44825517445;5638.718064096779;5665.49010589049;5471.863203419866;5491.28613280271;5508.338999320027;5529.806456774074;5572;4147.834086636501;4196.139791342828;4211.0946146578635;4239;4249.511306199826;3759.6804271637216;3769.6984241260634;3773.7735735855936;3806.980965095212;3811.5235595550557;5343;5376.301080859464;5389.380221274525;5389.487998640123;5402.162664786964;5578.776848926079;5587.05020146576;5636.577256705764;5648.4633959773755;5692.772289108472;5264.105102132647;5352.464753524617;5374.704391258519;5465.699386533779;5467.890642187134;4779.95220047802;4788.066327066189;4816.133096042676;4828.806847726122;4870.488598697157;5740.13897915316;5747.281589801275;5756.827295181151;5765.1640512125505;5767.134929760486;5579.9163012554845;5693.914591281134;5714.314282286152;5737.426257374396;5791.884162316815;5823.912641310299;5824.883502329845;5826.184334193301;5840.649561026352;5843.29880414353;5455.536279416136;5547.61166718342;5552.861178470571;5557.36090349615;5575.749091290821;5620.1288800236025;5658;5668.2064510967675;5692.345380281155;5713.514351280188;5451.48210919962;5458.536024437967;5471.671699697871;5477.808276710296;5483.588730845282;5402.729863506887;5460.3993560707495;5464.672119672673;5496.285482887199;5537.141743029837;5203.453637368022;5318.8936221276135;5360.839174824761;5395.163749618815;5426.213199086189;5363.302770639792;5380.865478363072;5414.404415514212;5424.593155513273;5493.890122197614;5297.920531191958;5337.332833395825;5350.063738845609;5356.544693701079;5377.8117765878005 17:42:04 INFO - PROCESS | 21535 | |1;ext.html;616.5653214483789;631.1794666932987;642.9742810287587;646.221303329488;658.8221180281321;34550.654493455055;35899.82050089746;35998.820005899935;36109.819450902774;36121.277574448526;37517.06207344818;37960.43059354105;38277.61722382775;38282.425763613566;38305;8320;8460.238578527931;8530.573471326408;8535.189157030072;8543.188397102296;8453.154684531559;8469.280111190556;8513.53175575343;8546.230839224469;8738.169873861973;8764.517951512664;8864.335174861879;8873.645054197825;8881.333899957497;8908.777280567972;8694.608742606566;8734.912650873473;8737.213650771397;8771.07903670115;8778.385513014124;8557.614907329185;8628.568571571397;8654.177853103945;8654.610542525601;8688.826223475495;37015.25969480595;37635.81182094072;37711.868643940725;37735.811320943496;37815.62184378148;3606.531150950386;3628.183658676803;3675.1730860556427;3807.9238415231816;4253.617174454283;27626.585601215997;29498.592557963657;29601;30101.69898301011;30364.089077327495;4144.564820693844;4199.706020578561;4199.895002624929;4253.787310634456;4302.591253830881;227800;227908;228720;228944;230036;54157;54313.01278429724;54558.181627275626;54601;54787;52297;53581.46418535765;53640.73179634077;53694.46305536973;57897;15051.924740376448;15076.170810605303;15187.772183417257;15270.236488175547;15278.923605381902;11165.888341116484;11246.775064498665;11294.887051129548;11314.886851131549;11323.263987840764;17471.30114795394;17492.300307987538;17528.737068943978;17595.64808703819;17630.735538966925;6686.465082793365;6931.6880740366805;7182.778927582219;7221.747238846615;7254.600996945219;1044.835470722742;1118.5302173087323;1126.5947202722248;1150.5685367987005;1166.049669519339;29529.26176845553;29805.552916706267;29850;29878.25304367408;30006.849965750032;1098.9120870330355;1124.0389467005755;1152.567787079845;1260.8550016748009;1272.961811145667;15998.440054598033;16011.199440027953;16160;16257.674846503003;16323.10222937726;322641;325827;326120;327317;328415;52550.47449525532;53046;53242.73378633082;53590.7320463403;53605.463945360825;1389.4650559534653;1394.6861956059806;1405.9226742529054;1423.7721964485634;1432.3411230833933;28832;28968.420631587673;29052.27369315784;29173.124806255848;29684.554731679473;46844;47358.05283894234;47379.763101184275;47419.525804742894;47616.28575571439;281999;288336;289394;289773;290112;26375.4724905497;26413;26423.867880660473;26538.336541585842;26741.06406275771;43393.56606433895;44043.11913761643;44631.55368446274;44756;45163;37096.443553347264;37173.442398363506;37923.43114853224;37981.620183798914;38185.42721859119;36762.63237367592;37280.44079338758;38075.23849523049;38241.80879095587;38693;37576.81211594034;38789;38833;38944.80527597344;39149;32835;34278.6719724416;34463.72594603508;34694.82652586822;34777.30445391129;25847.92573745206;26061.218163455127;26191.345216369744;26207.344816379744;26207.868960655076 17:42:04 INFO - PROCESS | 21535 | |2;jquery.html;391.6083916083916;394.56597742483257;395.34767633404886;397.3820708797822;404.7591682948645;16620;16864.072476013815;17565.47303580893;17588.472345829614;17667.64664706705;17599.472015839547;17717.46847594574;17990.5502362441;18084.547886302847;18530.53673658159;5450.29146210992;5491.945080549183;5696.458836410535;5713.742881570319;5727.513161381287;5679.687617181054;5683.062294721366;5686.31764188298;5695.060315048012;5716.485516303532;5520.503154716075;6263.561550691454;6322.114903913456;6362.968185159068;6415.518836087289;6144.354842741493;6319.3680631936895;6345.587536810116;6352.301246862865;6357.713902874359;5614.747336369833;5626.634268772516;5697.6296540724725;5711.942880571182;5724.141378793172;20652.690209646866;22684.886575567183;22782.54434911309;23839;23950.28149155528;2646.4839356325524;2686.7716244119274;2700.7704345130687;2922.240217543454;2961.644602647696;14112.153270803785;14597;14889.181095039768;15306.851986100975;15460.922695386564;2021.5451523407262;2113;2135.540858715368;2192.1669765489173;2233.4416395901026;79710.6014469924;80262;80855;81029.59485202596;82330.17669823286;16606.667866642598;16768.077755723552;16848.831511684726;17364;17421.47735567935;29974.400511990076;30147.547786783216;30232.395352093274;30320.54519182214;30481.847590761903;9388.342816002814;9757.316987810786;9825;9825.9017409825;10008.249381296431;8108.9594552026865;8254.628541715638;8369.707060252862;8379.58102094905;8387.538685372363;8369.196319233126;8725.520096394632;8771.429857059271;8852.645894164161;8938;3459.8789042383396;3478.9652103479148;3498.352804731133;3671.3391589514144;3733.141377483194;983.9212862970945;1034.9896501034893;1041.4792603698152;1099.5491848342142;1104.8508451358964;16315.91842040806;17671;17980.2807887683;18005.19948005189;18142.818571814376;1008.7831116310028;1020.2450186861669;1065.7388939709665;1074.2963358999712;1117.2067831839486;9920.950395247977;10438.269321147447;10444.373337599616;10535.789284214272;10571.5242814072;495645;496081;500744;500920;514250;75900.62049689826;77740;78921.21078789138;79210;79454.60272698716;1056.186736213127;1069.983950240747;1073.806714791345;1087.8966498182817;1090.7491277006334;16092.11493367876;16104.27530761142;16141.75787363214;16155.67688646244;16382.918085409498;35451.46822797608;35557.28885422225;36327.45508817317;36675.44986825146;37306;47805.76097119492;48524.2721359187;48541.75729121332;48981.75509122432;49240.75379623079;7492.2133176017915;8359.122292159236;8447.95776021116;8681.782955426164;8867.068957759342;10793.62222322215;11184.664460066211;12702.30137342455;13156.539521116714;13194.142380745221;11353.489092991;11387.43062846871;11473;11503;11788.23376480526;11139.9339241178;11171.329720216812;11400.258983166068;11627;11694.766104678029;10010.898801131723;10347.534360953625;11547.249428787101;11609.30344179352;11652.41737913084;8567.443116197428;8686.305095592212;8736.25741811953;8818.426802257833;8884.244839188483;11188.944055279671;11220.943895280472;11393.544258229578;11427.257228280136;11471.082313415074 17:42:04 INFO - PROCESS | 21535 | |3;mootools.html;1480.39303885407;1523.794287771151;1626.8454496822799;1765.2409463930505;1786.651602937427;7448.441366897484;7638.809029774258;7708.113566939804;7760.3791696664275;7770.572618505987;7274.345308922196;7676.501027433213;7709.344705700022;7980.760577182679;8003.319717823977;2275.7610450902625;2298.1496846166942;2306.884655767213;2306.942326441844;2307.826912981525;2271.3299576624936;2283.931482055533;2313.5835549601065;2319.9420014499606;2321.93034208974;2215.5125872308067;2240.3279016295046;2249.865008099511;2255.424866659008;2256.9774302257015;2206.216793038472;2211.248175620297;2214.3910424633195;2221.566794475078;2231.6987206727044;2202.6806113113507;2210.027587861336;2210.347947355534;2224.0992398078806;2228.420610641229;8046.718364857261;8060.5566693831815;8129.187081291882;8135.064467586244;8154.184581541857;4767.070421267854;4927.876803079916;4934.679245849008;4951.43058548268;4957.107720610289;3117.6726443723537;3213.469777486712;3335.799852008863;3339.6493368196234;3363.781354211993;1063.3141623652778;1064.2231171244957;1074.9462526873624;1119.5186069989902;1121.2039451989097;10654;10771.83842242367;10805.891941080567;10838.674839754742;10890.891091089066;4178.958210417857;4300.526942036374;4357.324614684729;4369.235383807821;4409.581089796464;9122.36143469964;9143.268538516902;9158.129977652112;9203.447793132433;9206.493642849708;5020.523050310215;5077.39071311445;5077.898442031139;5116.411612664517;5142.640015198975;4161.2509748245;4491.865244042684;4701;4729.148753224453;4742.620590352763;3720.9441858372147;3724.3110024645525;3830.2339532093692;3843.269778742086;3850.6534411903062;1219.201423067892;1243.8445194350707;1246.731952630189;1247.781638213309;1263.3998850546102;1010.1312870930993;1012.5291739341242;1014.4876837197169;1027.445179603021;1032.6540608895955;5551.646179874505;5574.1917421973585;5641.323041234996;5643.774249030075;5683.54531637468;441.4944888103104;443.3792690233634;444.604302171068;449.56841432224775;458.933454649074;3809.504764380613;3902;3922.0391004204153;3930.862419815293;3964.0684439156776;9554.235661147091;9786.853197202048;9789.510524473748;9858.80282394348;9901.801963960681;9657.130858222794;9727.173190278905;9786.217102631772;9789.657361992297;9896;7352.669129889167;7645.885311720217;7654.578998155043;7659.731909383145;7702.576358300235;5382.407935127211;5601.24383208278;5673.517750991047;5724.084146536534;5794.739236734273;9009.189172974464;9106.180443760093;9185.770355740893;9198.67804626835;9305.069493050642;9034.954825225832;9216.723498295061;9327;9512.429254244767;9515.762105947406;6567.179102612174;6986.126734158231;7157.677904494206;7307.159676637042;7384.630768461448;7570.507916985378;7626.199249078989;7648;7685.615719213905;7719.498232614862;6862.759803406857;6992;7028.4728645352825;7057.188423331178;7140.464465165237;6959.304069593;6981.162260528769;7053.894191587233;7055.329743674342;7171.964140179474;6556.737730490918;6619.404253617197;6735.225449073419;6743.15710536183;6777.390034896883;5089.160288552347;5097.184450488053;5110.259012443249;5181.5077567631015;5261.394939581997;4979.203327467588;4990.4261009982865;5018.4730603286125;5059.038782631288;5075.796968121382 17:42:04 INFO - PROCESS | 21535 | |4;prototype.html;330.05263001397526;342.40934388180386;347.5533938888529;348.778525636221;350.89823951054194;5405.324334458192;5526.447355264481;5586.581006424519;5601.60788744788;5613.708846965195;5512.669239845612;5530.668159910409;5547.33431988162;5574.386817450078;5575.470330318613;4312.008238105238;4324.891877703051;4335.458067741532;4339.479262488506;4372.825086996516;4072.8799580115556;4278.957210427902;4294.892627684301;4340.110277393127;4401.845935392262;4213.1363070570615;4234.978825105885;4242.427272318244;4244.405783190356;4247.660187185018;4248.617624413802;4258.659307255412;4267.4025636410925;4272.530021697611;4301.827926882921;3583.7312201584723;3738.775673459601;3754.2679177560385;3763.717721170896;3766.566844812854;5356.812511562116;5399.460053994609;5400.189971504266;5408.648437851566;5434.945650543523;4910.950890491085;4917.8278760243575;4949.430815456232;4954.281629163787;4954.7274899880495;5612.719364031782;5765.942340576583;5771.307443106854;5790.783935373576;5811.738471768781;4097.201045796071;4117.623548690075;4118.464599602063;4128.772917489537;4150.294449943517;5852.619579727261;5976.193213916153;6080.817575472699;6119.66341851198;6131.570790044699;4176.979115104405;4202.978985105116;4203.726757760735;4233.724807887477;4242.490901091889;4190.434291370687;4218.282891908383;4233.1322078973735;4273.166732487197;4276.273033584298;4883.34074899891;4885.706857588556;4901.5588597026435;4905.405743133496;4912.582430493377;5688.63023903445;5762.654240745569;5860.853478663067;5875.9118613220835;5906;1571.230097252338;1585.841415858428;1589.928453219608;1591.7373633350599;1595.8563729264422;1065.6003998500562;1088.7387027113436;1092.4428541443922;1099.3294090604725;1117.2626066795876;5873.236479257669;5919.704014799243;5930.911036334458;5938.376470470625;5959.493443057302;6389.8722025560155;6404.135441715309;6426.646534440651;6435.4529864962005;6448.967755161194;5769.596128271065;5881.235439392852;5885.588008839341;5928.644281343133;5943.3462319144855;3407;3407.1771602192707;3419.6238413774463;3448.4310088835564;3466.5493485847182;5914.467697907209;6239.594426362272;6246.937530624727;6504.21134188102;6512.218533775977;6159;6181.783637572664;6192.783252586138;6202.945499265135;6219.129321894939;6074.271087469532;6153.7230824613;6198.163247961467;6271.122042913905;6274.9686251569365;5979.671118088547;5992.161097446274;5999.760009599567;6057.242844644419;6060.878782424415;5977.701114944322;5996.340402555628;6000.369961154016;6005.219321488178;6011.549133815069;5928.703564821655;6175.660338681416;6202.627842329474;6213.96893015532;6222.751089956351;4177.770222637784;4187.853425130106;4219.789010549522;4236.4069030336395;4240.957590424056;5724.883647688661;5855.648661080349;6023.427774361428;6057;6061;5876.559258055578;5885.323187833283;5891.587588868738;5892.292924849045;5896.410358964069;5855.590108692521;5858.648481091148;5877.647341159544;5899.557533184942;5905.379935106924;5480;5696.8006119785605;5728.914066288926;5731.455511726379;5743.195952566728;5873.916193998185;5927.2590926134235;5928.67392293428;5931.584789064724;5938.168656388196;5448.45515448452;5729.71351432435;5754.7122643866805;5766.3080430346945;5799.159121927381 17:42:04 INFO - PROCESS | 21535 | |5;yui.html;797.4298376660694;823.9011318641764;834.145001373592;847.8346722389134;874.5408660453265;14333.283335833206;14873.553793386202;15212.467563635248;15232.999999999985;15252.923735381335;13911.443542258297;13917.23455209963;13941.930290348559;14039.5086171984;14051.859481405208;672.2336536348554;810.1574362662824;830.3772170871846;836.753157818442;838.6477679374677;827.1397746343795;828.5608627427443;830.6718846055804;832.937529685273;833.170994860112;869.3306154261215;871.5206636350014;872.7730789994583;874.2743522875998;878.0210065776677;867.2324992381724;874.3879284500874;875.1073904617318;876.3558784293539;882.4220135811054;639.859230969186;639.8656282180748;641.9486441084701;644.4586547300244;644.9677516124221;13921.651958701012;13959.092658977235;13962;14013.929930350385;14014.22921739304;14012.509562165274;14074.296285185803;14142.575722728334;14237.64405889861;14300.284985750775;11368.829467557993;11512.136589755803;11557.826632600518;11615.535378584846;11701.824472632918;3871.8644847430487;3891.241207964448;4002.679785617144;4064.654504367132;4079.1841631673487;52344.73827630876;52459.73770131163;52474;52795;53030.73484632552;11161.665150045512;11333.546658133748;11339.14956378275;11393.886061139448;11538.13463990204;20110.497237568885;20144.19423223084;20154.596908061758;20187.697184542245;20250.65864132431;8194.262516373556;8250.958745206355;8418.200270974248;8432.747017589481;8504.489730616182;4332.111917057059;4413.22768515515;4463.709858859163;4522.072975040109;4640.23436133041;3314.6022477302877;3390.559227300435;3392.6776956189124;3394.2362968332422;3421.025007872794;618.3847072163227;620.7206756959296;625.3215261441296;625.4527288622455;635.9586626869238;637.3117033603697;673.2863165045068;689.2797027106685;696.8536607312521;744.3784439992559;9523.19052880513;9889.851652225223;9988.350757200904;10024.097831195082;10030.699079027641;713.3508507258474;724.8586525627452;765.383865987874;767.731294047079;800.7397595781395;4498.955010449854;4571.885702857455;4706.764661766898;4722.480527142012;4726;61600.69199653973;61848.381516184265;61979;62109.37890621126;62786;53734.745809316024;54615.45384546183;55231.72384138054;55358;56541.43458565362;50056.749716251914;50762.23856642153;51118.74440627773;51284.23073653898;51514.22728659073;8685.435446696198;8834.823303534022;8895.110488951053;8901.643934242558;8907.554622268732;32629;33226;33366.666333336354;33407.49888751719;33685.83157084199;44645.77677111594;45207.7739611313;45403.09193816039;45661.54338456573;45736.08527829358;12476.688082798002;12593.93703031479;12666.683332916382;12742.42659080325;12805.167664101804;13553.390097445836;13682.794758078438;13960.930195348958;14055;14067.437302508195;13329.266890320738;13458.93270533641;13593.93203034018;13609.387577558835;14128.929355353157;13293.534726284533;13446.731065378834;13621.863781362059;13628.250446225553;13673.726525469236;13276.53532126371;13382.330883455983;13403.597892063253;13609;13855.237961912191;10996.505157268102;11115.666530004113;11161.944190278997;11344.262622929484;11682.357470338873;11109.555617775199;11371;11502.42487875586;11514.88485115138;11614.76770464569 17:42:04 INFO - PROCESS | 21535 | __end_tp_report 17:42:04 INFO - PROCESS | 21535 | __start_cc_report 17:42:04 INFO - PROCESS | 21535 | _x_x_mozilla_cycle_collect,337 17:42:04 INFO - PROCESS | 21535 | __end_cc_report 17:42:04 INFO - PROCESS | 21535 | __startTimestamp1461717724590__endTimestamp 17:42:04 INFO - PROCESS | 21535 | 17:42:04 INFO - PROCESS | 21535 | ------- Summary: start ------- 17:42:04 INFO - PROCESS | 21535 | Number of tests: 6 17:42:04 INFO - PROCESS | 21535 | 17:42:04 INFO - PROCESS | 21535 | [#0] dojo.html Cycles:165 Average:5182.65 Median:5395.16 stddev:704.41 (13.1%) stddev-sans-first:687.10 17:42:04 INFO - PROCESS | 21535 | Values: 3086.3 3147.5 3160.5 3181.0 3181.3 5115.8 5162.1 5178.7 5188.7 5232.8 5139.8 5222.9 5277.3 5293.8 5315.0 4724.8 4745.2 4825.6 4854.8 4907.6 240.2 4718.9 4758.9 4815.4 4824.9 4716.2 4717.0 4738.2 4764.9 4773.2 4717.2 4720.2 4746.2 4807.1 4835.1 4672.8 4710.0 4737.7 4772.7 4787.7 5167.9 5201.7 5208.5 5219.9 5220.8 5626.5 5627.8 5633.5 5650.6 5655.9 5622.9 5664.3 5682.6 5717.3 5718.7 5202.3 5210.4 5224.8 5226.9 5226.9 5582.8 5690.3 5715.5 5719.1 5772.5 5578.6 5585.3 5591.7 5594.6 5652.6 5649.9 5683.3 5684.6 5690.7 5691.9 5405.1 5509.8 5517.4 5638.7 5665.5 5471.9 5491.3 5508.3 5529.8 5572.0 4147.8 4196.1 4211.1 4239.0 4249.5 3759.7 3769.7 3773.8 3807.0 3811.5 5343.0 5376.3 5389.4 5389.5 5402.2 5578.8 5587.1 5636.6 5648.5 5692.8 5264.1 5352.5 5374.7 5465.7 5467.9 4780.0 4788.1 4816.1 4828.8 4870.5 5740.1 5747.3 5756.8 5765.2 5767.1 5579.9 5693.9 5714.3 5737.4 5791.9 5823.9 5824.9 5826.2 5840.6 5843.3 5455.5 5547.6 5552.9 5557.4 5575.7 5620.1 5658.0 5668.2 5692.3 5713.5 5451.5 5458.5 5471.7 5477.8 5483.6 5402.7 5460.4 5464.7 5496.3 5537.1 5203.5 5318.9 5360.8 5395.2 5426.2 5363.3 5380.9 5414.4 5424.6 5493.9 5297.9 5337.3 5350.1 5356.5 5377.8 17:42:04 INFO - PROCESS | 21535 | 17:42:04 INFO - PROCESS | 21535 | [#1] ext.html Cycles:180 Average:44995.95 Median:37134.94 stddev:74110.14 (199.6%) stddev-sans-first:74243.13 17:42:04 INFO - PROCESS | 21535 | Values: 616.6 631.2 643.0 646.2 658.8 34550.7 35899.8 35998.8 36109.8 36121.3 37517.1 37960.4 38277.6 38282.4 38305.0 8320.0 8460.2 8530.6 8535.2 8543.2 8453.2 8469.3 8513.5 8546.2 8738.2 8764.5 8864.3 8873.6 8881.3 8908.8 8694.6 8734.9 8737.2 8771.1 8778.4 8557.6 8628.6 8654.2 8654.6 8688.8 37015.3 37635.8 37711.9 37735.8 37815.6 3606.5 3628.2 3675.2 3807.9 4253.6 27626.6 29498.6 29601.0 30101.7 30364.1 4144.6 4199.7 4199.9 4253.8 4302.6 227800.0 227908.0 228720.0 228944.0 230036.0 54157.0 54313.0 54558.2 54601.0 54787.0 52297.0 53581.5 53640.7 53694.5 57897.0 15051.9 15076.2 15187.8 15270.2 15278.9 11165.9 11246.8 11294.9 11314.9 11323.3 17471.3 17492.3 17528.7 17595.6 17630.7 6686.5 6931.7 7182.8 7221.7 7254.6 1044.8 1118.5 1126.6 1150.6 1166.0 29529.3 29805.6 29850.0 29878.3 30006.8 1098.9 1124.0 1152.6 1260.9 1273.0 15998.4 16011.2 16160.0 16257.7 16323.1 322641.0 325827.0 326120.0 327317.0 328415.0 52550.5 53046.0 53242.7 53590.7 53605.5 1389.5 1394.7 1405.9 1423.8 1432.3 28832.0 28968.4 29052.3 29173.1 29684.6 46844.0 47358.1 47379.8 47419.5 47616.3 281999.0 288336.0 289394.0 289773.0 290112.0 26375.5 26413.0 26423.9 26538.3 26741.1 43393.6 44043.1 44631.6 44756.0 45163.0 37096.4 37173.4 37923.4 37981.6 38185.4 36762.6 37280.4 38075.2 38241.8 38693.0 37576.8 38789.0 38833.0 38944.8 39149.0 32835.0 34278.7 34463.7 34694.8 34777.3 25847.9 26061.2 26191.3 26207.3 26207.9 17:42:04 INFO - PROCESS | 21535 | 17:42:04 INFO - PROCESS | 21535 | [#2] jquery.html Cycles:180 Average:29242.60 Median:30189.97 stddev:82155.10 (272.1%) stddev-sans-first:82357.00 17:42:04 INFO - PROCESS | 21535 | Values: 391.6 394.6 395.3 397.4 404.8 16620.0 16864.1 17565.5 17588.5 17667.6 17599.5 17717.5 17990.6 18084.5 18530.5 5450.3 5491.9 5696.5 5713.7 5727.5 5679.7 5683.1 5686.3 5695.1 5716.5 5520.5 6263.6 6322.1 6363.0 6415.5 6144.4 6319.4 6345.6 6352.3 6357.7 5614.7 5626.6 5697.6 5711.9 5724.1 20652.7 22684.9 22782.5 23839.0 23950.3 2646.5 2686.8 2700.8 2922.2 2961.6 14112.2 14597.0 14889.2 15306.9 15460.9 2021.5 2113.0 2135.5 2192.2 2233.4 79710.6 80262.0 80855.0 81029.6 82330.2 16606.7 16768.1 16848.8 17364.0 17421.5 29974.4 30147.5 30232.4 30320.5 30481.8 9388.3 9757.3 9825.0 9825.9 10008.2 8109.0 8254.6 8369.7 8379.6 8387.5 8369.2 8725.5 8771.4 8852.6 8938.0 3459.9 3479.0 3498.4 3671.3 3733.1 983.9 1035.0 1041.5 1099.5 1104.9 16315.9 17671.0 17980.3 18005.2 18142.8 1008.8 1020.2 1065.7 1074.3 1117.2 9921.0 10438.3 10444.4 10535.8 10571.5 495645.0 496081.0 500744.0 500920.0 514250.0 75900.6 77740.0 78921.2 79210.0 79454.6 1056.2 1070.0 1073.8 1087.9 1090.7 16092.1 16104.3 16141.8 16155.7 16382.9 35451.5 35557.3 36327.5 36675.4 37306.0 47805.8 48524.3 48541.8 48981.8 49240.8 7492.2 8359.1 8448.0 8681.8 8867.1 10793.6 11184.7 12702.3 13156.5 13194.1 11353.5 11387.4 11473.0 11503.0 11788.2 11139.9 11171.3 11400.3 11627.0 11694.8 10010.9 10347.5 11547.2 11609.3 11652.4 8567.4 8686.3 8736.3 8818.4 8884.2 11188.9 11220.9 11393.5 11427.3 11471.1 17:42:04 INFO - PROCESS | 21535 | 17:42:04 INFO - PROCESS | 21535 | [#3] mootools.html Cycles:180 Average:5349.09 Median:5076.59 stddev:2913.95 (57.4%) stddev-sans-first:2907.62 17:42:04 INFO - PROCESS | 21535 | Values: 1480.4 1523.8 1626.8 1765.2 1786.7 7448.4 7638.8 7708.1 7760.4 7770.6 7274.3 7676.5 7709.3 7980.8 8003.3 2275.8 2298.1 2306.9 2306.9 2307.8 2271.3 2283.9 2313.6 2319.9 2321.9 2215.5 2240.3 2249.9 2255.4 2257.0 2206.2 2211.2 2214.4 2221.6 2231.7 2202.7 2210.0 2210.3 2224.1 2228.4 8046.7 8060.6 8129.2 8135.1 8154.2 4767.1 4927.9 4934.7 4951.4 4957.1 3117.7 3213.5 3335.8 3339.6 3363.8 1063.3 1064.2 1074.9 1119.5 1121.2 10654.0 10771.8 10805.9 10838.7 10890.9 4179.0 4300.5 4357.3 4369.2 4409.6 9122.4 9143.3 9158.1 9203.4 9206.5 5020.5 5077.4 5077.9 5116.4 5142.6 4161.3 4491.9 4701.0 4729.1 4742.6 3720.9 3724.3 3830.2 3843.3 3850.7 1219.2 1243.8 1246.7 1247.8 1263.4 1010.1 1012.5 1014.5 1027.4 1032.7 5551.6 5574.2 5641.3 5643.8 5683.5 441.5 443.4 444.6 449.6 458.9 3809.5 3902.0 3922.0 3930.9 3964.1 9554.2 9786.9 9789.5 9858.8 9901.8 9657.1 9727.2 9786.2 9789.7 9896.0 7352.7 7645.9 7654.6 7659.7 7702.6 5382.4 5601.2 5673.5 5724.1 5794.7 9009.2 9106.2 9185.8 9198.7 9305.1 9035.0 9216.7 9327.0 9512.4 9515.8 6567.2 6986.1 7157.7 7307.2 7384.6 7570.5 7626.2 7648.0 7685.6 7719.5 6862.8 6992.0 7028.5 7057.2 7140.5 6959.3 6981.2 7053.9 7055.3 7172.0 6556.7 6619.4 6735.2 6743.2 6777.4 5089.2 5097.2 5110.3 5181.5 5261.4 4979.2 4990.4 5018.5 5059.0 5075.8 17:42:04 INFO - PROCESS | 21535 | 17:42:04 INFO - PROCESS | 21535 | [#4] prototype.html Cycles:180 Average:4946.70 Median:5607.16 stddev:1459.39 (26.0%) stddev-sans-first:1421.76 17:42:04 INFO - PROCESS | 21535 | Values: 330.1 342.4 347.6 348.8 350.9 5405.3 5526.4 5586.6 5601.6 5613.7 5512.7 5530.7 5547.3 5574.4 5575.5 4312.0 4324.9 4335.5 4339.5 4372.8 4072.9 4279.0 4294.9 4340.1 4401.8 4213.1 4235.0 4242.4 4244.4 4247.7 4248.6 4258.7 4267.4 4272.5 4301.8 3583.7 3738.8 3754.3 3763.7 3766.6 5356.8 5399.5 5400.2 5408.6 5434.9 4911.0 4917.8 4949.4 4954.3 4954.7 5612.7 5765.9 5771.3 5790.8 5811.7 4097.2 4117.6 4118.5 4128.8 4150.3 5852.6 5976.2 6080.8 6119.7 6131.6 4177.0 4203.0 4203.7 4233.7 4242.5 4190.4 4218.3 4233.1 4273.2 4276.3 4883.3 4885.7 4901.6 4905.4 4912.6 5688.6 5762.7 5860.9 5875.9 5906.0 1571.2 1585.8 1589.9 1591.7 1595.9 1065.6 1088.7 1092.4 1099.3 1117.3 5873.2 5919.7 5930.9 5938.4 5959.5 6389.9 6404.1 6426.6 6435.5 6449.0 5769.6 5881.2 5885.6 5928.6 5943.3 3407.0 3407.2 3419.6 3448.4 3466.5 5914.5 6239.6 6246.9 6504.2 6512.2 6159.0 6181.8 6192.8 6202.9 6219.1 6074.3 6153.7 6198.2 6271.1 6275.0 5979.7 5992.2 5999.8 6057.2 6060.9 5977.7 5996.3 6000.4 6005.2 6011.5 5928.7 6175.7 6202.6 6214.0 6222.8 4177.8 4187.9 4219.8 4236.4 4241.0 5724.9 5855.6 6023.4 6057.0 6061.0 5876.6 5885.3 5891.6 5892.3 5896.4 5855.6 5858.6 5877.6 5899.6 5905.4 5480.0 5696.8 5728.9 5731.5 5743.2 5873.9 5927.3 5928.7 5931.6 5938.2 5448.5 5729.7 5754.7 5766.3 5799.2 17:42:04 INFO - PROCESS | 21535 | 17:42:04 INFO - PROCESS | 21535 | [#5] yui.html Cycles:180 Average:14995.73 Median:24572.37 stddev:16950.26 (69.0%) stddev-sans-first:16964.28 17:42:04 INFO - PROCESS | 21535 | Values: 797.4 823.9 834.1 847.8 874.5 14333.3 14873.6 15212.5 15233.0 15252.9 13911.4 13917.2 13941.9 14039.5 14051.9 672.2 810.2 830.4 836.8 838.6 827.1 828.6 830.7 832.9 833.2 869.3 871.5 872.8 874.3 878.0 867.2 874.4 875.1 876.4 882.4 639.9 639.9 641.9 644.5 645.0 13921.7 13959.1 13962.0 14013.9 14014.2 14012.5 14074.3 14142.6 14237.6 14300.3 11368.8 11512.1 11557.8 11615.5 11701.8 3871.9 3891.2 4002.7 4064.7 4079.2 52344.7 52459.7 52474.0 52795.0 53030.7 11161.7 11333.5 11339.1 11393.9 11538.1 20110.5 20144.2 20154.6 20187.7 20250.7 8194.3 8251.0 8418.2 8432.7 8504.5 4332.1 4413.2 4463.7 4522.1 4640.2 3314.6 3390.6 3392.7 3394.2 3421.0 618.4 620.7 625.3 625.5 636.0 637.3 673.3 689.3 696.9 744.4 9523.2 9889.9 9988.4 10024.1 10030.7 713.4 724.9 765.4 767.7 800.7 4499.0 4571.9 4706.8 4722.5 4726.0 61600.7 61848.4 61979.0 62109.4 62786.0 53734.7 54615.5 55231.7 55358.0 56541.4 50056.7 50762.2 51118.7 51284.2 51514.2 8685.4 8834.8 8895.1 8901.6 8907.6 32629.0 33226.0 33366.7 33407.5 33685.8 44645.8 45207.8 45403.1 45661.5 45736.1 12476.7 12593.9 12666.7 12742.4 12805.2 13553.4 13682.8 13960.9 14055.0 14067.4 13329.3 13458.9 13593.9 13609.4 14128.9 13293.5 13446.7 13621.9 13628.3 13673.7 13276.5 13382.3 13403.6 13609.0 13855.2 10996.5 11115.7 11161.9 11344.3 11682.4 11109.6 11371.0 11502.4 11514.9 11614.8 17:42:04 INFO - PROCESS | 21535 | -------- Summary: end -------- 17:42:04 INFO - PROCESS | 21535 | 17:42:05 INFO - TEST-INFO | 21535: exit 0 17:42:05 INFO - TEST-OK | dromaeo_css | took 1108126ms 17:42:05 INFO - TEST-START | kraken 17:42:05 INFO - operating with platform_type : linux_ 17:42:05 INFO - Initialising browser for kraken test... 17:42:05 INFO - TEST-INFO | started process 21767 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX3E6TX/profile http://localhost:37705/getInfo.html) 17:42:08 INFO - PROCESS | 21767 | 17:42:08 INFO - PROCESS | 21767 | (process:21837): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:42:09 INFO - PROCESS | 21767 | __metrics Screen width/height:1600/1200 17:42:09 INFO - PROCESS | 21767 | colorDepth:24 17:42:09 INFO - PROCESS | 21767 | Browser inner width/height: 1024/697 17:42:09 INFO - PROCESS | 21767 | __metrics 17:42:10 ERROR - PROCESS | 21767 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 17:42:11 INFO - TEST-INFO | 21767: exit 0 17:42:11 INFO - Browser initialized. 17:42:11 INFO - Running cycle 1/1 for kraken test... 17:42:11 INFO - TEST-INFO | started process 21888 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX3E6TX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:42:13 INFO - PROCESS | 21888 | 17:42:13 INFO - PROCESS | 21888 | (process:21948): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:42:23 INFO - PROCESS | 21888 | RSS: Main: 165064704 17:42:23 INFO - PROCESS | 21888 | 17:42:25 INFO - PROCESS | 21888 | Cycle 1(1): loaded http://localhost:37705/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37705/tests/kraken/driver.html?testName=audio-beat-detection) 17:42:26 INFO - PROCESS | 21888 | RSS: Main: 169676800 17:42:26 INFO - PROCESS | 21888 | 17:42:29 INFO - PROCESS | 21888 | Cycle 1(1): loaded http://localhost:37705/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37705/tests/kraken/driver.html?testName=audio-dft) 17:42:29 INFO - PROCESS | 21888 | RSS: Main: 173531136 17:42:29 INFO - PROCESS | 21888 | 17:42:32 INFO - PROCESS | 21888 | Cycle 1(1): loaded http://localhost:37705/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37705/tests/kraken/driver.html?testName=audio-fft) 17:42:33 INFO - PROCESS | 21888 | RSS: Main: 165666816 17:42:33 INFO - PROCESS | 21888 | 17:42:35 INFO - PROCESS | 21888 | Cycle 1(1): loaded http://localhost:37705/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37705/tests/kraken/driver.html?testName=audio-oscillator) 17:42:36 INFO - PROCESS | 21888 | RSS: Main: 165449728 17:42:36 INFO - PROCESS | 21888 | 17:42:38 INFO - PROCESS | 21888 | Cycle 1(1): loaded http://localhost:37705/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37705/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:42:39 INFO - PROCESS | 21888 | RSS: Main: 165974016 17:42:39 INFO - PROCESS | 21888 | 17:42:42 INFO - PROCESS | 21888 | Cycle 1(1): loaded http://localhost:37705/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37705/tests/kraken/driver.html?testName=imaging-darkroom) 17:42:42 INFO - PROCESS | 21888 | RSS: Main: 166293504 17:42:42 INFO - PROCESS | 21888 | 17:42:46 INFO - PROCESS | 21888 | Cycle 1(1): loaded http://localhost:37705/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37705/tests/kraken/driver.html?testName=imaging-desaturate) 17:42:46 INFO - PROCESS | 21888 | RSS: Main: 166547456 17:42:46 INFO - PROCESS | 21888 | 17:42:49 INFO - PROCESS | 21888 | Cycle 1(1): loaded http://localhost:37705/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37705/tests/kraken/driver.html?testName=json-parse-financial) 17:42:50 INFO - PROCESS | 21888 | RSS: Main: 167075840 17:42:50 INFO - PROCESS | 21888 | 17:42:51 INFO - PROCESS | 21888 | Cycle 1(1): loaded http://localhost:37705/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37705/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:42:52 INFO - PROCESS | 21888 | RSS: Main: 166760448 17:42:52 INFO - PROCESS | 21888 | 17:42:54 INFO - PROCESS | 21888 | Cycle 1(1): loaded http://localhost:37705/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37705/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:42:54 INFO - PROCESS | 21888 | RSS: Main: 167051264 17:42:54 INFO - PROCESS | 21888 | 17:42:56 INFO - PROCESS | 21888 | Cycle 1(1): loaded http://localhost:37705/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37705/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:42:57 INFO - PROCESS | 21888 | RSS: Main: 167297024 17:42:57 INFO - PROCESS | 21888 | 17:43:00 INFO - PROCESS | 21888 | Cycle 1(1): loaded http://localhost:37705/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37705/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:43:00 INFO - PROCESS | 21888 | RSS: Main: 167542784 17:43:00 INFO - PROCESS | 21888 | 17:43:04 INFO - PROCESS | 21888 | Cycle 1(1): loaded http://localhost:37705/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37705/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:43:04 INFO - PROCESS | 21888 | RSS: Main: 167374848 17:43:04 INFO - PROCESS | 21888 | 17:43:06 INFO - PROCESS | 21888 | Cycle 1(1): loaded http://localhost:37705/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37705/tests/kraken/driver.html?testName=ai-astar) 17:43:06 INFO - PROCESS | 21888 | RSS: Main: 168767488 17:43:06 INFO - PROCESS | 21888 | 17:43:06 INFO - PROCESS | 21888 | __start_tp_report 17:43:06 INFO - PROCESS | 21888 | _x_x_mozilla_page_load 17:43:06 INFO - PROCESS | 21888 | _x_x_mozilla_page_load_details 17:43:06 INFO - PROCESS | 21888 | |i|pagename|runs| 17:43:06 INFO - PROCESS | 21888 | |0;ai-astar;113;108;111;113;109;124;110;111;111;110 17:43:06 INFO - PROCESS | 21888 | |1;audio-beat-detection;156;128;155;174;129;165;157;129;192;127 17:43:06 INFO - PROCESS | 21888 | |2;audio-dft;164;161;162;165;160;162;172;162;166;162 17:43:06 INFO - PROCESS | 21888 | |3;audio-fft;76;77;74;157;75;77;72;77;180;76 17:43:06 INFO - PROCESS | 21888 | |4;audio-oscillator;92;92;148;92;93;93;157;93;93;146 17:43:06 INFO - PROCESS | 21888 | |5;imaging-gaussian-blur;118;117;117;117;118;117;119;118;118;117 17:43:06 INFO - PROCESS | 21888 | |6;imaging-darkroom;146;147;146;147;146;148;145;146;147;148 17:43:06 INFO - PROCESS | 21888 | |7;imaging-desaturate;96;95;96;95;95;95;100;95;96;95 17:43:06 INFO - PROCESS | 21888 | |8;json-parse-financial;58;59;58;57;59;59;59;80;56;56 17:43:06 INFO - PROCESS | 21888 | |9;json-stringify-tinderbox;61;61;60;60;60;60;59;61;64;62 17:43:06 INFO - PROCESS | 21888 | |10;stanford-crypto-aes;76;84;77;78;79;85;79;79;78;78 17:43:06 INFO - PROCESS | 21888 | |11;stanford-crypto-ccm;132;125;128;128;134;140;138;131;217;130 17:43:06 INFO - PROCESS | 21888 | |12;stanford-crypto-pbkdf2;199;209;199;208;205;207;203;197;218;198 17:43:06 INFO - PROCESS | 21888 | |13;stanford-crypto-sha256-iterative;70;70;71;68;70;70;75;69;69;69 17:43:06 INFO - PROCESS | 21888 | __end_tp_report 17:43:06 INFO - PROCESS | 21888 | __start_cc_report 17:43:06 INFO - PROCESS | 21888 | _x_x_mozilla_cycle_collect,835 17:43:06 INFO - PROCESS | 21888 | __end_cc_report 17:43:06 INFO - PROCESS | 21888 | __startTimestamp1461717786645__endTimestamp 17:43:06 INFO - PROCESS | 21888 | 17:43:06 INFO - PROCESS | 21888 | ------- Summary: start ------- 17:43:06 INFO - PROCESS | 21888 | Number of tests: 14 17:43:06 INFO - PROCESS | 21888 | 17:43:06 INFO - PROCESS | 21888 | [#0] ai-astar Cycles:10 Average:112.00 Median:111.00 stddev:4.50 (4.1%) stddev-sans-first:4.76 17:43:06 INFO - PROCESS | 21888 | Values: 113.0 108.0 111.0 113.0 109.0 124.0 110.0 111.0 111.0 110.0 17:43:06 INFO - PROCESS | 21888 | 17:43:06 INFO - PROCESS | 21888 | [#1] audio-beat-detection Cycles:10 Average:151.20 Median:156.50 stddev:22.50 (14.4%) stddev-sans-first:23.80 17:43:06 INFO - PROCESS | 21888 | Values: 156.0 128.0 155.0 174.0 129.0 165.0 157.0 129.0 192.0 127.0 17:43:06 INFO - PROCESS | 21888 | 17:43:06 INFO - PROCESS | 21888 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.00 stddev:3.47 (2.1%) stddev-sans-first:3.68 17:43:06 INFO - PROCESS | 21888 | Values: 164.0 161.0 162.0 165.0 160.0 162.0 172.0 162.0 166.0 162.0 17:43:06 INFO - PROCESS | 21888 | 17:43:06 INFO - PROCESS | 21888 | [#3] audio-fft Cycles:10 Average:94.10 Median:76.00 stddev:39.62 (52.1%) stddev-sans-first:41.47 17:43:06 INFO - PROCESS | 21888 | Values: 76.0 77.0 74.0 157.0 75.0 77.0 72.0 77.0 180.0 76.0 17:43:06 INFO - PROCESS | 21888 | 17:43:06 INFO - PROCESS | 21888 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:92.50 stddev:28.04 (30.3%) stddev-sans-first:28.98 17:43:06 INFO - PROCESS | 21888 | Values: 92.0 92.0 148.0 92.0 93.0 93.0 157.0 93.0 93.0 146.0 17:43:06 INFO - PROCESS | 21888 | 17:43:06 INFO - PROCESS | 21888 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 17:43:06 INFO - PROCESS | 21888 | Values: 118.0 117.0 117.0 117.0 118.0 117.0 119.0 118.0 118.0 117.0 17:43:06 INFO - PROCESS | 21888 | 17:43:06 INFO - PROCESS | 21888 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.97 (0.7%) stddev-sans-first:1.00 17:43:06 INFO - PROCESS | 21888 | Values: 146.0 147.0 146.0 147.0 146.0 148.0 145.0 146.0 147.0 148.0 17:43:06 INFO - PROCESS | 21888 | 17:43:06 INFO - PROCESS | 21888 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:95.00 stddev:1.55 (1.6%) stddev-sans-first:1.64 17:43:06 INFO - PROCESS | 21888 | Values: 96.0 95.0 96.0 95.0 95.0 95.0 100.0 95.0 96.0 95.0 17:43:06 INFO - PROCESS | 21888 | 17:43:06 INFO - PROCESS | 21888 | [#8] json-parse-financial Cycles:10 Average:60.10 Median:59.00 stddev:7.09 (12.0%) stddev-sans-first:7.48 17:43:06 INFO - PROCESS | 21888 | Values: 58.0 59.0 58.0 57.0 59.0 59.0 59.0 80.0 56.0 56.0 17:43:06 INFO - PROCESS | 21888 | 17:43:06 INFO - PROCESS | 21888 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:1.40 (2.3%) stddev-sans-first:1.48 17:43:06 INFO - PROCESS | 21888 | Values: 61.0 61.0 60.0 60.0 60.0 60.0 59.0 61.0 64.0 62.0 17:43:06 INFO - PROCESS | 21888 | 17:43:06 INFO - PROCESS | 21888 | [#10] stanford-crypto-aes Cycles:10 Average:79.30 Median:79.00 stddev:2.91 (3.7%) stddev-sans-first:2.83 17:43:06 INFO - PROCESS | 21888 | Values: 76.0 84.0 77.0 78.0 79.0 85.0 79.0 79.0 78.0 78.0 17:43:06 INFO - PROCESS | 21888 | 17:43:06 INFO - PROCESS | 21888 | [#11] stanford-crypto-ccm Cycles:10 Average:140.30 Median:133.00 stddev:27.34 (20.6%) stddev-sans-first:28.83 17:43:06 INFO - PROCESS | 21888 | Values: 132.0 125.0 128.0 128.0 134.0 140.0 138.0 131.0 217.0 130.0 17:43:06 INFO - PROCESS | 21888 | 17:43:06 INFO - PROCESS | 21888 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:204.30 Median:206.00 stddev:6.52 (3.2%) stddev-sans-first:6.62 17:43:06 INFO - PROCESS | 21888 | Values: 199.0 209.0 199.0 208.0 205.0 207.0 203.0 197.0 218.0 198.0 17:43:06 INFO - PROCESS | 21888 | 17:43:06 INFO - PROCESS | 21888 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.00 stddev:1.91 (2.7%) stddev-sans-first:2.03 17:43:06 INFO - PROCESS | 21888 | Values: 70.0 70.0 71.0 68.0 70.0 70.0 75.0 69.0 69.0 69.0 17:43:06 INFO - PROCESS | 21888 | -------- Summary: end -------- 17:43:06 INFO - PROCESS | 21888 | 17:43:07 INFO - TEST-INFO | 21888: exit 0 17:43:07 INFO - TEST-OK | kraken | took 62314ms 17:43:07 INFO - SUITE-END | took 1170s 17:43:07 INFO - Completed test suite (00:19:30) 17:43:07 INFO - javascript benchmark 17:43:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3086.3055812442194, 3147.5121356189784, 3160.5417214503896, 3181.045686294113, 3181.3478236961423, 5115.8209462668765, 5162.122439185338, 5178.741062946851, 5188.662736922098, 5232.764525596348, 5139.768710408031, 5222.9477705222935, 5277.340332458442, 5293.841184764463, 5315.0, 4724.842413608662, 4745.240761478164, 4825.589824864891, 4854.805807767685, 4907.631927605426, 240.1672694394213, 4718.858434246961, 4758.928616070744, 4815.398075240595, 4824.87937801556, 4716.245400735883, 4716.976415117937, 4738.19450693383, 4764.857054288377, 4773.164696178173, 4717.198076327033, 4720.150372932871, 4746.216874215785, 4807.11068452334, 4835.105505481497, 4672.789724462374, 4709.9764501177615, 4737.692050016738, 4772.73749943753, 4787.6648634595595, 5167.870803229912, 5201.7027371101085, 5208.479152084799, 5219.895602087975, 5220.843374698765, 5626.493615574618, 5627.80302689408, 5633.464820842054, 5650.604457687963, 5655.8586035349035, 5622.915656265119, 5664.320281566197, 5682.573806964494, 5717.285339332583, 5718.685472299022, 5202.3497062867145, 5210.400803907562, 5224.764885580158, 5226.92159617606, 5226.92159617606, 5582.7766889324785, 5690.317161940594, 5715.457031581993, 5719.113537401709, 5772.538196944234, 5578.553715702734, 5585.273914391103, 5591.7483713233005, 5594.636348637407, 5652.576056795757, 5649.887002259932, 5683.26117604717, 5684.602077854511, 5690.715464226855, 5691.943080569225, 5405.108157154104, 5509.807156749494, 5517.44825517445, 5638.718064096779, 5665.49010589049, 5471.863203419866, 5491.28613280271, 5508.338999320027, 5529.806456774074, 5572.0, 4147.834086636501, 4196.139791342828, 4211.0946146578635, 4239.0, 4249.511306199826, 3759.6804271637216, 3769.6984241260634, 3773.7735735855936, 3806.980965095212, 3811.5235595550557, 5343.0, 5376.301080859464, 5389.380221274525, 5389.487998640123, 5402.162664786964, 5578.776848926079, 5587.05020146576, 5636.577256705764, 5648.4633959773755, 5692.772289108472, 5264.105102132647, 5352.464753524617, 5374.704391258519, 5465.699386533779, 5467.890642187134, 4779.95220047802, 4788.066327066189, 4816.133096042676, 4828.806847726122, 4870.488598697157, 5740.13897915316, 5747.281589801275, 5756.827295181151, 5765.1640512125505, 5767.134929760486, 5579.9163012554845, 5693.914591281134, 5714.314282286152, 5737.426257374396, 5791.884162316815, 5823.912641310299, 5824.883502329845, 5826.184334193301, 5840.649561026352, 5843.29880414353, 5455.536279416136, 5547.61166718342, 5552.861178470571, 5557.36090349615, 5575.749091290821, 5620.1288800236025, 5658.0, 5668.2064510967675, 5692.345380281155, 5713.514351280188, 5451.48210919962, 5458.536024437967, 5471.671699697871, 5477.808276710296, 5483.588730845282, 5402.729863506887, 5460.3993560707495, 5464.672119672673, 5496.285482887199, 5537.141743029837, 5203.453637368022, 5318.8936221276135, 5360.839174824761, 5395.163749618815, 5426.213199086189, 5363.302770639792, 5380.865478363072, 5414.404415514212, 5424.593155513273, 5493.890122197614, 5297.920531191958, 5337.332833395825, 5350.063738845609, 5356.544693701079, 5377.8117765878005], "value": 5138.245527517592, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [616.5653214483789, 631.1794666932987, 642.9742810287587, 646.221303329488, 658.8221180281321, 34550.654493455055, 35899.82050089746, 35998.820005899935, 36109.819450902774, 36121.277574448526, 37517.06207344818, 37960.43059354105, 38277.61722382775, 38282.425763613566, 38305.0, 8320.0, 8460.238578527931, 8530.573471326408, 8535.189157030072, 8543.188397102296, 8453.154684531559, 8469.280111190556, 8513.53175575343, 8546.230839224469, 8738.169873861973, 8764.517951512664, 8864.335174861879, 8873.645054197825, 8881.333899957497, 8908.777280567972, 8694.608742606566, 8734.912650873473, 8737.213650771397, 8771.07903670115, 8778.385513014124, 8557.614907329185, 8628.568571571397, 8654.177853103945, 8654.610542525601, 8688.826223475495, 37015.25969480595, 37635.81182094072, 37711.868643940725, 37735.811320943496, 37815.62184378148, 3606.531150950386, 3628.183658676803, 3675.1730860556427, 3807.9238415231816, 4253.617174454283, 27626.585601215997, 29498.592557963657, 29601.0, 30101.69898301011, 30364.089077327495, 4144.564820693844, 4199.706020578561, 4199.895002624929, 4253.787310634456, 4302.591253830881, 227800.0, 227908.0, 228720.0, 228944.0, 230036.0, 54157.0, 54313.01278429724, 54558.181627275626, 54601.0, 54787.0, 52297.0, 53581.46418535765, 53640.73179634077, 53694.46305536973, 57897.0, 15051.924740376448, 15076.170810605303, 15187.772183417257, 15270.236488175547, 15278.923605381902, 11165.888341116484, 11246.775064498665, 11294.887051129548, 11314.886851131549, 11323.263987840764, 17471.30114795394, 17492.300307987538, 17528.737068943978, 17595.64808703819, 17630.735538966925, 6686.465082793365, 6931.6880740366805, 7182.778927582219, 7221.747238846615, 7254.600996945219, 1044.835470722742, 1118.5302173087323, 1126.5947202722248, 1150.5685367987005, 1166.049669519339, 29529.26176845553, 29805.552916706267, 29850.0, 29878.25304367408, 30006.849965750032, 1098.9120870330355, 1124.0389467005755, 1152.567787079845, 1260.8550016748009, 1272.961811145667, 15998.440054598033, 16011.199440027953, 16160.0, 16257.674846503003, 16323.10222937726, 322641.0, 325827.0, 326120.0, 327317.0, 328415.0, 52550.47449525532, 53046.0, 53242.73378633082, 53590.7320463403, 53605.463945360825, 1389.4650559534653, 1394.6861956059806, 1405.9226742529054, 1423.7721964485634, 1432.3411230833933, 28832.0, 28968.420631587673, 29052.27369315784, 29173.124806255848, 29684.554731679473, 46844.0, 47358.05283894234, 47379.763101184275, 47419.525804742894, 47616.28575571439, 281999.0, 288336.0, 289394.0, 289773.0, 290112.0, 26375.4724905497, 26413.0, 26423.867880660473, 26538.336541585842, 26741.06406275771, 43393.56606433895, 44043.11913761643, 44631.55368446274, 44756.0, 45163.0, 37096.443553347264, 37173.442398363506, 37923.43114853224, 37981.620183798914, 38185.42721859119, 36762.63237367592, 37280.44079338758, 38075.23849523049, 38241.80879095587, 38693.0, 37576.81211594034, 38789.0, 38833.0, 38944.80527597344, 39149.0, 32835.0, 34278.6719724416, 34463.72594603508, 34694.82652586822, 34777.30445391129, 25847.92573745206, 26061.218163455127, 26191.345216369744, 26207.344816379744, 26207.868960655076], "value": 18459.97748323369, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.6083916083916, 394.56597742483257, 395.34767633404886, 397.3820708797822, 404.7591682948645, 16620.0, 16864.072476013815, 17565.47303580893, 17588.472345829614, 17667.64664706705, 17599.472015839547, 17717.46847594574, 17990.5502362441, 18084.547886302847, 18530.53673658159, 5450.29146210992, 5491.945080549183, 5696.458836410535, 5713.742881570319, 5727.513161381287, 5679.687617181054, 5683.062294721366, 5686.31764188298, 5695.060315048012, 5716.485516303532, 5520.503154716075, 6263.561550691454, 6322.114903913456, 6362.968185159068, 6415.518836087289, 6144.354842741493, 6319.3680631936895, 6345.587536810116, 6352.301246862865, 6357.713902874359, 5614.747336369833, 5626.634268772516, 5697.6296540724725, 5711.942880571182, 5724.141378793172, 20652.690209646866, 22684.886575567183, 22782.54434911309, 23839.0, 23950.28149155528, 2646.4839356325524, 2686.7716244119274, 2700.7704345130687, 2922.240217543454, 2961.644602647696, 14112.153270803785, 14597.0, 14889.181095039768, 15306.851986100975, 15460.922695386564, 2021.5451523407262, 2113.0, 2135.540858715368, 2192.1669765489173, 2233.4416395901026, 79710.6014469924, 80262.0, 80855.0, 81029.59485202596, 82330.17669823286, 16606.667866642598, 16768.077755723552, 16848.831511684726, 17364.0, 17421.47735567935, 29974.400511990076, 30147.547786783216, 30232.395352093274, 30320.54519182214, 30481.847590761903, 9388.342816002814, 9757.316987810786, 9825.0, 9825.9017409825, 10008.249381296431, 8108.9594552026865, 8254.628541715638, 8369.707060252862, 8379.58102094905, 8387.538685372363, 8369.196319233126, 8725.520096394632, 8771.429857059271, 8852.645894164161, 8938.0, 3459.8789042383396, 3478.9652103479148, 3498.352804731133, 3671.3391589514144, 3733.141377483194, 983.9212862970945, 1034.9896501034893, 1041.4792603698152, 1099.5491848342142, 1104.8508451358964, 16315.91842040806, 17671.0, 17980.2807887683, 18005.19948005189, 18142.818571814376, 1008.7831116310028, 1020.2450186861669, 1065.7388939709665, 1074.2963358999712, 1117.2067831839486, 9920.950395247977, 10438.269321147447, 10444.373337599616, 10535.789284214272, 10571.5242814072, 495645.0, 496081.0, 500744.0, 500920.0, 514250.0, 75900.62049689826, 77740.0, 78921.21078789138, 79210.0, 79454.60272698716, 1056.186736213127, 1069.983950240747, 1073.806714791345, 1087.8966498182817, 1090.7491277006334, 16092.11493367876, 16104.27530761142, 16141.75787363214, 16155.67688646244, 16382.918085409498, 35451.46822797608, 35557.28885422225, 36327.45508817317, 36675.44986825146, 37306.0, 47805.76097119492, 48524.2721359187, 48541.75729121332, 48981.75509122432, 49240.75379623079, 7492.2133176017915, 8359.122292159236, 8447.95776021116, 8681.782955426164, 8867.068957759342, 10793.62222322215, 11184.664460066211, 12702.30137342455, 13156.539521116714, 13194.142380745221, 11353.489092991, 11387.43062846871, 11473.0, 11503.0, 11788.23376480526, 11139.9339241178, 11171.329720216812, 11400.258983166068, 11627.0, 11694.766104678029, 10010.898801131723, 10347.534360953625, 11547.249428787101, 11609.30344179352, 11652.41737913084, 8567.443116197428, 8686.305095592212, 8736.25741811953, 8818.426802257833, 8884.244839188483, 11188.944055279671, 11220.943895280472, 11393.544258229578, 11427.257228280136, 11471.082313415074], "value": 9887.322422332874, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1480.39303885407, 1523.794287771151, 1626.8454496822799, 1765.2409463930505, 1786.651602937427, 7448.441366897484, 7638.809029774258, 7708.113566939804, 7760.3791696664275, 7770.572618505987, 7274.345308922196, 7676.501027433213, 7709.344705700022, 7980.760577182679, 8003.319717823977, 2275.7610450902625, 2298.1496846166942, 2306.884655767213, 2306.942326441844, 2307.826912981525, 2271.3299576624936, 2283.931482055533, 2313.5835549601065, 2319.9420014499606, 2321.93034208974, 2215.5125872308067, 2240.3279016295046, 2249.865008099511, 2255.424866659008, 2256.9774302257015, 2206.216793038472, 2211.248175620297, 2214.3910424633195, 2221.566794475078, 2231.6987206727044, 2202.6806113113507, 2210.027587861336, 2210.347947355534, 2224.0992398078806, 2228.420610641229, 8046.718364857261, 8060.5566693831815, 8129.187081291882, 8135.064467586244, 8154.184581541857, 4767.070421267854, 4927.876803079916, 4934.679245849008, 4951.43058548268, 4957.107720610289, 3117.6726443723537, 3213.469777486712, 3335.799852008863, 3339.6493368196234, 3363.781354211993, 1063.3141623652778, 1064.2231171244957, 1074.9462526873624, 1119.5186069989902, 1121.2039451989097, 10654.0, 10771.83842242367, 10805.891941080567, 10838.674839754742, 10890.891091089066, 4178.958210417857, 4300.526942036374, 4357.324614684729, 4369.235383807821, 4409.581089796464, 9122.36143469964, 9143.268538516902, 9158.129977652112, 9203.447793132433, 9206.493642849708, 5020.523050310215, 5077.39071311445, 5077.898442031139, 5116.411612664517, 5142.640015198975, 4161.2509748245, 4491.865244042684, 4701.0, 4729.148753224453, 4742.620590352763, 3720.9441858372147, 3724.3110024645525, 3830.2339532093692, 3843.269778742086, 3850.6534411903062, 1219.201423067892, 1243.8445194350707, 1246.731952630189, 1247.781638213309, 1263.3998850546102, 1010.1312870930993, 1012.5291739341242, 1014.4876837197169, 1027.445179603021, 1032.6540608895955, 5551.646179874505, 5574.1917421973585, 5641.323041234996, 5643.774249030075, 5683.54531637468, 441.4944888103104, 443.3792690233634, 444.604302171068, 449.56841432224775, 458.933454649074, 3809.504764380613, 3902.0, 3922.0391004204153, 3930.862419815293, 3964.0684439156776, 9554.235661147091, 9786.853197202048, 9789.510524473748, 9858.80282394348, 9901.801963960681, 9657.130858222794, 9727.173190278905, 9786.217102631772, 9789.657361992297, 9896.0, 7352.669129889167, 7645.885311720217, 7654.578998155043, 7659.731909383145, 7702.576358300235, 5382.407935127211, 5601.24383208278, 5673.517750991047, 5724.084146536534, 5794.739236734273, 9009.189172974464, 9106.180443760093, 9185.770355740893, 9198.67804626835, 9305.069493050642, 9034.954825225832, 9216.723498295061, 9327.0, 9512.429254244767, 9515.762105947406, 6567.179102612174, 6986.126734158231, 7157.677904494206, 7307.159676637042, 7384.630768461448, 7570.507916985378, 7626.199249078989, 7648.0, 7685.615719213905, 7719.498232614862, 6862.759803406857, 6992.0, 7028.4728645352825, 7057.188423331178, 7140.464465165237, 6959.304069593, 6981.162260528769, 7053.894191587233, 7055.329743674342, 7171.964140179474, 6556.737730490918, 6619.404253617197, 6735.225449073419, 6743.15710536183, 6777.390034896883, 5089.160288552347, 5097.184450488053, 5110.259012443249, 5181.5077567631015, 5261.394939581997, 4979.203327467588, 4990.4261009982865, 5018.4730603286125, 5059.038782631288, 5075.796968121382], "value": 4294.9013506192105, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.05263001397526, 342.40934388180386, 347.5533938888529, 348.778525636221, 350.89823951054194, 5405.324334458192, 5526.447355264481, 5586.581006424519, 5601.60788744788, 5613.708846965195, 5512.669239845612, 5530.668159910409, 5547.33431988162, 5574.386817450078, 5575.470330318613, 4312.008238105238, 4324.891877703051, 4335.458067741532, 4339.479262488506, 4372.825086996516, 4072.8799580115556, 4278.957210427902, 4294.892627684301, 4340.110277393127, 4401.845935392262, 4213.1363070570615, 4234.978825105885, 4242.427272318244, 4244.405783190356, 4247.660187185018, 4248.617624413802, 4258.659307255412, 4267.4025636410925, 4272.530021697611, 4301.827926882921, 3583.7312201584723, 3738.775673459601, 3754.2679177560385, 3763.717721170896, 3766.566844812854, 5356.812511562116, 5399.460053994609, 5400.189971504266, 5408.648437851566, 5434.945650543523, 4910.950890491085, 4917.8278760243575, 4949.430815456232, 4954.281629163787, 4954.7274899880495, 5612.719364031782, 5765.942340576583, 5771.307443106854, 5790.783935373576, 5811.738471768781, 4097.201045796071, 4117.623548690075, 4118.464599602063, 4128.772917489537, 4150.294449943517, 5852.619579727261, 5976.193213916153, 6080.817575472699, 6119.66341851198, 6131.570790044699, 4176.979115104405, 4202.978985105116, 4203.726757760735, 4233.724807887477, 4242.490901091889, 4190.434291370687, 4218.282891908383, 4233.1322078973735, 4273.166732487197, 4276.273033584298, 4883.34074899891, 4885.706857588556, 4901.5588597026435, 4905.405743133496, 4912.582430493377, 5688.63023903445, 5762.654240745569, 5860.853478663067, 5875.9118613220835, 5906.0, 1571.230097252338, 1585.841415858428, 1589.928453219608, 1591.7373633350599, 1595.8563729264422, 1065.6003998500562, 1088.7387027113436, 1092.4428541443922, 1099.3294090604725, 1117.2626066795876, 5873.236479257669, 5919.704014799243, 5930.911036334458, 5938.376470470625, 5959.493443057302, 6389.8722025560155, 6404.135441715309, 6426.646534440651, 6435.4529864962005, 6448.967755161194, 5769.596128271065, 5881.235439392852, 5885.588008839341, 5928.644281343133, 5943.3462319144855, 3407.0, 3407.1771602192707, 3419.6238413774463, 3448.4310088835564, 3466.5493485847182, 5914.467697907209, 6239.594426362272, 6246.937530624727, 6504.21134188102, 6512.218533775977, 6159.0, 6181.783637572664, 6192.783252586138, 6202.945499265135, 6219.129321894939, 6074.271087469532, 6153.7230824613, 6198.163247961467, 6271.122042913905, 6274.9686251569365, 5979.671118088547, 5992.161097446274, 5999.760009599567, 6057.242844644419, 6060.878782424415, 5977.701114944322, 5996.340402555628, 6000.369961154016, 6005.219321488178, 6011.549133815069, 5928.703564821655, 6175.660338681416, 6202.627842329474, 6213.96893015532, 6222.751089956351, 4177.770222637784, 4187.853425130106, 4219.789010549522, 4236.4069030336395, 4240.957590424056, 5724.883647688661, 5855.648661080349, 6023.427774361428, 6057.0, 6061.0, 5876.559258055578, 5885.323187833283, 5891.587588868738, 5892.292924849045, 5896.410358964069, 5855.590108692521, 5858.648481091148, 5877.647341159544, 5899.557533184942, 5905.379935106924, 5480.0, 5696.8006119785605, 5728.914066288926, 5731.455511726379, 5743.195952566728, 5873.916193998185, 5927.2590926134235, 5928.67392293428, 5931.584789064724, 5938.168656388196, 5448.45515448452, 5729.71351432435, 5754.7122643866805, 5766.3080430346945, 5799.159121927381], "value": 4490.508284974062, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [797.4298376660694, 823.9011318641764, 834.145001373592, 847.8346722389134, 874.5408660453265, 14333.283335833206, 14873.553793386202, 15212.467563635248, 15232.999999999985, 15252.923735381335, 13911.443542258297, 13917.23455209963, 13941.930290348559, 14039.5086171984, 14051.859481405208, 672.2336536348554, 810.1574362662824, 830.3772170871846, 836.753157818442, 838.6477679374677, 827.1397746343795, 828.5608627427443, 830.6718846055804, 832.937529685273, 833.170994860112, 869.3306154261215, 871.5206636350014, 872.7730789994583, 874.2743522875998, 878.0210065776677, 867.2324992381724, 874.3879284500874, 875.1073904617318, 876.3558784293539, 882.4220135811054, 639.859230969186, 639.8656282180748, 641.9486441084701, 644.4586547300244, 644.9677516124221, 13921.651958701012, 13959.092658977235, 13962.0, 14013.929930350385, 14014.22921739304, 14012.509562165274, 14074.296285185803, 14142.575722728334, 14237.64405889861, 14300.284985750775, 11368.829467557993, 11512.136589755803, 11557.826632600518, 11615.535378584846, 11701.824472632918, 3871.8644847430487, 3891.241207964448, 4002.679785617144, 4064.654504367132, 4079.1841631673487, 52344.73827630876, 52459.73770131163, 52474.0, 52795.0, 53030.73484632552, 11161.665150045512, 11333.546658133748, 11339.14956378275, 11393.886061139448, 11538.13463990204, 20110.497237568885, 20144.19423223084, 20154.596908061758, 20187.697184542245, 20250.65864132431, 8194.262516373556, 8250.958745206355, 8418.200270974248, 8432.747017589481, 8504.489730616182, 4332.111917057059, 4413.22768515515, 4463.709858859163, 4522.072975040109, 4640.23436133041, 3314.6022477302877, 3390.559227300435, 3392.6776956189124, 3394.2362968332422, 3421.025007872794, 618.3847072163227, 620.7206756959296, 625.3215261441296, 625.4527288622455, 635.9586626869238, 637.3117033603697, 673.2863165045068, 689.2797027106685, 696.8536607312521, 744.3784439992559, 9523.19052880513, 9889.851652225223, 9988.350757200904, 10024.097831195082, 10030.699079027641, 713.3508507258474, 724.8586525627452, 765.383865987874, 767.731294047079, 800.7397595781395, 4498.955010449854, 4571.885702857455, 4706.764661766898, 4722.480527142012, 4726.0, 61600.69199653973, 61848.381516184265, 61979.0, 62109.37890621126, 62786.0, 53734.745809316024, 54615.45384546183, 55231.72384138054, 55358.0, 56541.43458565362, 50056.749716251914, 50762.23856642153, 51118.74440627773, 51284.23073653898, 51514.22728659073, 8685.435446696198, 8834.823303534022, 8895.110488951053, 8901.643934242558, 8907.554622268732, 32629.0, 33226.0, 33366.666333336354, 33407.49888751719, 33685.83157084199, 44645.77677111594, 45207.7739611313, 45403.09193816039, 45661.54338456573, 45736.08527829358, 12476.688082798002, 12593.93703031479, 12666.683332916382, 12742.42659080325, 12805.167664101804, 13553.390097445836, 13682.794758078438, 13960.930195348958, 14055.0, 14067.437302508195, 13329.266890320738, 13458.93270533641, 13593.93203034018, 13609.387577558835, 14128.929355353157, 13293.534726284533, 13446.731065378834, 13621.863781362059, 13628.250446225553, 13673.726525469236, 13276.53532126371, 13382.330883455983, 13403.597892063253, 13609.0, 13855.237961912191, 10996.505157268102, 11115.666530004113, 11161.944190278997, 11344.262622929484, 11682.357470338873, 11109.555617775199, 11371.0, 11502.42487875586, 11514.88485115138, 11614.76770464569], "value": 6896.344560583993, "unit": "score"}], "name": "dromaeo_css", "value": 7068.697814397928, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 108.0, 111.0, 113.0, 109.0, 124.0, 110.0, 111.0, 111.0, 110.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 128.0, 155.0, 174.0, 129.0, 165.0, 157.0, 129.0, 192.0, 127.0], "value": 151.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 161.0, 162.0, 165.0, 160.0, 162.0, 172.0, 162.0, 166.0, 162.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 74.0, 157.0, 75.0, 77.0, 72.0, 77.0, 180.0, 76.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 148.0, 92.0, 93.0, 93.0, 157.0, 93.0, 93.0, 146.0], "value": 109.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 119.0, 118.0, 118.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 147.0, 146.0, 148.0, 145.0, 146.0, 147.0, 148.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 100.0, 95.0, 96.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 57.0, 59.0, 59.0, 59.0, 80.0, 56.0, 56.0], "value": 60.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 60.0, 60.0, 60.0, 59.0, 61.0, 64.0, 62.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 84.0, 77.0, 78.0, 79.0, 85.0, 79.0, 79.0, 78.0, 78.0], "value": 79.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 125.0, 128.0, 128.0, 134.0, 140.0, 138.0, 131.0, 217.0, 130.0], "value": 140.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 209.0, 199.0, 208.0, 205.0, 207.0, 203.0, 197.0, 218.0, 198.0], "value": 204.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 71.0, 68.0, 70.0, 70.0, 75.0, 69.0, 69.0, 69.0], "value": 70.1, "unit": "score"}], "name": "kraken", "value": 1605.6999999999996, "alertThreshold": 2.0}]} 17:43:07 INFO - Return code: 0 17:43:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:43:07 ERROR - # TBPL SUCCESS # 17:43:07 INFO - Running post-action listener: _resource_record_post_action 17:43:07 INFO - Running post-run listener: _resource_record_post_run 17:43:09 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 542199808; Read time: 8; Write time: 527136 17:43:09 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 251789312; Read time: 0; Write time: 304272 17:43:09 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290410496; Read time: 8; Write time: 222864 17:43:09 INFO - Running post-run listener: _upload_blobber_files 17:43:09 INFO - Blob upload gear active. 17:43:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:43:09 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 17:43:09 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:43:09 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:43:09 INFO - (blobuploader) - INFO - Open directory for files ... 17:43:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:43:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:43:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:43:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:43:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:43:10 INFO - (blobuploader) - INFO - Done attempting. 17:43:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:43:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:43:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:43:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:43:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:43:11 INFO - (blobuploader) - INFO - Done attempting. 17:43:11 INFO - (blobuploader) - INFO - Iteration through files over. 17:43:11 INFO - Return code: 0 17:43:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:43:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:43:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cf5b5117b458d76a9d3f929b312c13394b588426254874c736596a9b5d11f133dfa24eb50c6e2921d713f44643b11bab242b6022e7c4fd148fe4073a7eec8fae", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1da00511d45723708b0b3dde25e227436528e68494cd6c6596d2963d2672810f850eaecff9b3214dc6b7d87e80e5b3f98f5f32dc0c8a9afb40fe5aafa56769f0"} 17:43:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:43:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:43:11 INFO - Contents: 17:43:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cf5b5117b458d76a9d3f929b312c13394b588426254874c736596a9b5d11f133dfa24eb50c6e2921d713f44643b11bab242b6022e7c4fd148fe4073a7eec8fae", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1da00511d45723708b0b3dde25e227436528e68494cd6c6596d2963d2672810f850eaecff9b3214dc6b7d87e80e5b3f98f5f32dc0c8a9afb40fe5aafa56769f0"} 17:43:11 INFO - Running post-run listener: copy_logs_to_upload_dir 17:43:11 INFO - Copying logs to upload dir... 17:43:11 INFO - mkdir: /builds/slave/test/build/upload/logs 17:43:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.589487 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-04-26 17:43:11.121383) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 17:43:11.125245) ========= 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=db0483c52d987ecb441a263b000001ad-1461712452.501083-1436965338 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cf5b5117b458d76a9d3f929b312c13394b588426254874c736596a9b5d11f133dfa24eb50c6e2921d713f44643b11bab242b6022e7c4fd148fe4073a7eec8fae", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1da00511d45723708b0b3dde25e227436528e68494cd6c6596d2963d2672810f850eaecff9b3214dc6b7d87e80e5b3f98f5f32dc0c8a9afb40fe5aafa56769f0"} build_url:https://queue.taskcluster.net/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011175 build_url: 'https://queue.taskcluster.net/v1/task/ThO0LW7EQhaBt9KJxkoHeA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cf5b5117b458d76a9d3f929b312c13394b588426254874c736596a9b5d11f133dfa24eb50c6e2921d713f44643b11bab242b6022e7c4fd148fe4073a7eec8fae", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1da00511d45723708b0b3dde25e227436528e68494cd6c6596d2963d2672810f850eaecff9b3214dc6b7d87e80e5b3f98f5f32dc0c8a9afb40fe5aafa56769f0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 17:43:11.150347) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 17:43:11.150705) ========= 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=db0483c52d987ecb441a263b000001ad-1461712452.501083-1436965338 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004434 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 17:43:11.234029) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 17:43:11.234339) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 17:43:11.234658) ========= ========= Total master_lag: 0.18 =========