builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-033 starttime: 1463724572.27 results: success (0) buildid: 20160519203032 builduid: fb0f5803510540ada2ec95aa72d5d836 revision: c62705a833ff9c985c71ddf4c07054de113525c3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 23:09:32.265402) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 23:09:32.265836) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 23:09:32.266113) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 23:09:32.373034) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 23:09:32.373300) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1463723795.853079-575851582 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-19 23:09:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.1M=0s 2016-05-19 23:09:32 (38.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085459 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 23:09:32.485403) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 23:09:32.485700) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1463723795.853079-575851582 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018185 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 23:09:32.547869) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 23:09:32.548212) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c62705a833ff9c985c71ddf4c07054de113525c3 --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 c62705a833ff9c985c71ddf4c07054de113525c3 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1463723795.853079-575851582 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-19 23:09:32,728 truncating revision to first 12 chars 2016-05-19 23:09:32,728 Setting DEBUG logging. 2016-05-19 23:09:32,728 attempt 1/10 2016-05-19 23:09:32,728 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c62705a833ff?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-19 23:09:32,999 unpacking tar archive at: fx-team-c62705a833ff/testing/mozharness/ program finished with exit code 0 elapsedTime=0.545241 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 23:09:33.117564) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 23:09:33.117848) ========= script_repo_revision: c62705a833ff9c985c71ddf4c07054de113525c3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 23:09:33.118237) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 23:09:33.121526) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 23:09:33.138497) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-05-19 23:09:33.138783) ========= /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=edae0fb5fee9fb758e8af6d3000002a4-1463723795.853079-575851582 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:09:33 INFO - MultiFileLogger online at 20160519 23:09:33 in /builds/slave/test 23:09:33 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 23:09:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:09:33 INFO - {'append_to_log': False, 23:09:33 INFO - 'base_work_dir': '/builds/slave/test', 23:09:33 INFO - 'blob_upload_branch': 'Fx-Team', 23:09:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:09:33 INFO - 'branch': 'Fx-Team', 23:09:33 INFO - 'buildbot_json_path': 'buildprops.json', 23:09:33 INFO - 'config_files': ('talos/linux_config.py',), 23:09:33 INFO - 'default_actions': ('clobber', 23:09:33 INFO - 'read-buildbot-config', 23:09:33 INFO - 'download-and-extract', 23:09:33 INFO - 'populate-webroot', 23:09:33 INFO - 'create-virtualenv', 23:09:33 INFO - 'install', 23:09:33 INFO - 'run-tests'), 23:09:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:09:33 INFO - 'download_minidump_stackwalk': True, 23:09:33 INFO - 'download_symbols': 'ondemand', 23:09:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:09:33 INFO - 'tooltool.py': '/tools/tooltool.py', 23:09:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:09:33 INFO - '/tools/misc-python/virtualenv.py')}, 23:09:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:09:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:09:33 INFO - 'installer_path': 'installer.exe', 23:09:33 INFO - 'log_level': 'info', 23:09:33 INFO - 'log_name': 'talos', 23:09:33 INFO - 'log_to_console': True, 23:09:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:09:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:09:33 INFO - 'opt_config_files': (), 23:09:33 INFO - 'pip_index': False, 23:09:33 INFO - 'sps_profile': False, 23:09:33 INFO - 'sps_profile_interval': 0, 23:09:33 INFO - 'suite': 'dromaeojs-e10s', 23:09:33 INFO - 'system_bits': '32', 23:09:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:09:33 INFO - 'title': 'talos-linux64-ix-033', 23:09:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:09:33 INFO - 'use_talos_json': True, 23:09:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:09:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:09:33 INFO - 'work_dir': 'build'} 23:09:33 INFO - ##### 23:09:33 INFO - ##### Running clobber step. 23:09:33 INFO - ##### 23:09:33 INFO - Running pre-action listener: _resource_record_pre_action 23:09:33 INFO - Running main action method: clobber 23:09:33 INFO - rmtree: /builds/slave/test/build 23:09:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:09:33 INFO - Running post-action listener: _resource_record_post_action 23:09:33 INFO - ##### 23:09:33 INFO - ##### Finished clobber step (success) 23:09:33 INFO - ##### 23:09:33 INFO - ##### 23:09:33 INFO - ##### Running read-buildbot-config step. 23:09:33 INFO - ##### 23:09:33 INFO - Running pre-action listener: _resource_record_pre_action 23:09:33 INFO - Running main action method: read_buildbot_config 23:09:33 INFO - Using buildbot properties: 23:09:33 INFO - { 23:09:33 INFO - "project": "", 23:09:33 INFO - "product": "firefox", 23:09:33 INFO - "script_repo_revision": "production", 23:09:33 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 23:09:33 INFO - "repository": "", 23:09:33 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 23:09:33 INFO - "buildid": "20160519203032", 23:09:33 INFO - "pgo_build": "True", 23:09:33 INFO - "basedir": "/builds/slave/test", 23:09:33 INFO - "buildnumber": 478, 23:09:33 INFO - "slavename": "talos-linux64-ix-033", 23:09:33 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:09:33 INFO - "platform": "ubuntu64_hw", 23:09:33 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:09:33 INFO - "branch": "fx-team", 23:09:33 INFO - "repo_path": "integration/fx-team", 23:09:33 INFO - "revision": "c62705a833ff9c985c71ddf4c07054de113525c3", 23:09:33 INFO - "stage_platform": "linux64-pgo", 23:09:33 INFO - "builduid": "fb0f5803510540ada2ec95aa72d5d836", 23:09:33 INFO - "slavebuilddir": "test" 23:09:33 INFO - } 23:09:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/XyxYN_omThyuEW0u-STcpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 23:09:33 INFO - Running post-action listener: _resource_record_post_action 23:09:33 INFO - ##### 23:09:33 INFO - ##### Finished read-buildbot-config step (success) 23:09:33 INFO - ##### 23:09:33 INFO - ##### 23:09:33 INFO - ##### Running download-and-extract step. 23:09:33 INFO - ##### 23:09:33 INFO - Running pre-action listener: _resource_record_pre_action 23:09:33 INFO - Running main action method: download_and_extract 23:09:33 INFO - mkdir: /builds/slave/test/build/tests 23:09:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:33 INFO - https://queue.taskcluster.net/v1/task/XyxYN_omThyuEW0u-STcpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:09:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyxYN_omThyuEW0u-STcpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:09:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyxYN_omThyuEW0u-STcpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:09:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyxYN_omThyuEW0u-STcpg/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 23:09:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyxYN_omThyuEW0u-STcpg/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 23:09:34 INFO - Downloaded 1361 bytes. 23:09:34 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:09:34 INFO - Using the following test package requirements: 23:09:34 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 23:09:34 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:34 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:09:34 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:34 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:09:34 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:34 INFO - u'jsshell-linux-x86_64.zip'], 23:09:34 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:34 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:09:34 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 23:09:34 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:34 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:09:34 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:34 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:09:34 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:34 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:09:34 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:34 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:09:34 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:09:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:34 INFO - https://queue.taskcluster.net/v1/task/XyxYN_omThyuEW0u-STcpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:09:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyxYN_omThyuEW0u-STcpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:09:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyxYN_omThyuEW0u-STcpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:09:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyxYN_omThyuEW0u-STcpg/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 23:09:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyxYN_omThyuEW0u-STcpg/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 23:09:35 INFO - Downloaded 24387668 bytes. 23:09:35 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'] 23:09:35 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 23:09:37 INFO - Return code: 0 23:09:37 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 23:09:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:37 INFO - https://queue.taskcluster.net/v1/task/XyxYN_omThyuEW0u-STcpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:09:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyxYN_omThyuEW0u-STcpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:09:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyxYN_omThyuEW0u-STcpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:09:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyxYN_omThyuEW0u-STcpg/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 23:09:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyxYN_omThyuEW0u-STcpg/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 23:09:41 INFO - Downloaded 24387668 bytes. 23:09:41 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'] 23:09:41 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 23:09:42 INFO - Return code: 0 23:09: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')]} 23:09:42 INFO - https://queue.taskcluster.net/v1/task/XyxYN_omThyuEW0u-STcpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:09:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyxYN_omThyuEW0u-STcpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:09:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyxYN_omThyuEW0u-STcpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:09:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyxYN_omThyuEW0u-STcpg/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 23:09:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyxYN_omThyuEW0u-STcpg/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 23:09:43 INFO - Downloaded 10840359 bytes. 23:09:43 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'] 23:09:43 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 23:09:43 INFO - Return code: 0 23:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:43 INFO - https://queue.taskcluster.net/v1/task/XyxYN_omThyuEW0u-STcpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:09:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyxYN_omThyuEW0u-STcpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:09:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyxYN_omThyuEW0u-STcpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:09:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyxYN_omThyuEW0u-STcpg/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 23:09:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyxYN_omThyuEW0u-STcpg/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 23:09:45 INFO - Downloaded 58565734 bytes. 23:09:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XyxYN_omThyuEW0u-STcpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:09:45 INFO - mkdir: /builds/slave/test/properties 23:09:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:09:45 INFO - Writing to file /builds/slave/test/properties/build_url 23:09:45 INFO - Contents: 23:09:45 INFO - build_url:https://queue.taskcluster.net/v1/task/XyxYN_omThyuEW0u-STcpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:09:46 INFO - Running post-action listener: _resource_record_post_action 23:09:46 INFO - Running post-action listener: set_extra_try_arguments 23:09:46 INFO - ##### 23:09:46 INFO - ##### Finished download-and-extract step (success) 23:09:46 INFO - ##### 23:09:46 INFO - ##### 23:09:46 INFO - ##### Running populate-webroot step. 23:09:46 INFO - ##### 23:09:46 INFO - Running pre-action listener: _resource_record_pre_action 23:09:46 INFO - Running main action method: populate_webroot 23:09:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:09:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:09:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:09:46 INFO - '--tppagecycles', 23:09:46 INFO - '7'], 23:09:46 INFO - 'tests': ['tsvgm']}}, 23:09:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:09:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:09:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:09:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:09:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:09:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:09:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:46 INFO - 'talos_options': ['--disable-e10s'], 23:09:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:09:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:09:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:46 INFO - 'talos_options': ['--disable-e10s'], 23:09:46 INFO - 'tests': ['damp', 'tps']}, 23:09:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:46 INFO - 'tests': ['damp', 'tps']}, 23:09:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:09:46 INFO - 'tests': ['dromaeo_dom']}, 23:09:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:09:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:09:46 INFO - 'tests': ['a11yr', 23:09:46 INFO - 'ts_paint', 23:09:46 INFO - 'tpaint', 23:09:46 INFO - 'sessionrestore', 23:09:46 INFO - 'sessionrestore_no_auto_restore', 23:09:46 INFO - 'tabpaint']}, 23:09:46 INFO - 'other-e10s': {'tests': ['a11yr', 23:09:46 INFO - 'ts_paint', 23:09:46 INFO - 'tpaint', 23:09:46 INFO - 'sessionrestore', 23:09:46 INFO - 'sessionrestore_no_auto_restore', 23:09:46 INFO - 'tabpaint']}, 23:09:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:09:46 INFO - 'ts_paint', 23:09:46 INFO - 'tpaint', 23:09:46 INFO - 'sessionrestore', 23:09:46 INFO - 'sessionrestore_no_auto_restore', 23:09:46 INFO - 'tabpaint']}, 23:09:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:09:46 INFO - 'ts_paint', 23:09:46 INFO - 'tpaint', 23:09:46 INFO - 'sessionrestore', 23:09:46 INFO - 'sessionrestore_no_auto_restore', 23:09:46 INFO - 'tabpaint']}, 23:09:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:09:46 INFO - 'tests': ['a11yr', 23:09:46 INFO - 'ts_paint', 23:09:46 INFO - 'tpaint', 23:09:46 INFO - 'sessionrestore', 23:09:46 INFO - 'sessionrestore_no_auto_restore', 23:09:46 INFO - 'tabpaint']}, 23:09:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:09:46 INFO - 'tests': ['a11yr', 23:09:46 INFO - 'ts_paint', 23:09:46 INFO - 'tpaint', 23:09:46 INFO - 'sessionrestore', 23:09:46 INFO - 'sessionrestore_no_auto_restore', 23:09:46 INFO - 'tabpaint']}, 23:09:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:09:46 INFO - 'tests': ['tsvgx', 23:09:46 INFO - 'tsvgr_opacity', 23:09:46 INFO - 'tart', 23:09:46 INFO - 'tscrollx', 23:09:46 INFO - 'cart']}, 23:09:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:09:46 INFO - 'tsvgr_opacity', 23:09:46 INFO - 'tart', 23:09:46 INFO - 'tscrollx', 23:09:46 INFO - 'cart']}, 23:09:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:46 INFO - 'talos_options': ['--disable-e10s'], 23:09:46 INFO - 'tests': ['tp5o']}, 23:09:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:46 INFO - 'tests': ['tp5o']}, 23:09:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:46 INFO - 'talos_options': ['--disable-e10s', 23:09:46 INFO - '--xperf_path', 23:09:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:09:46 INFO - 'tests': ['tp5n']}, 23:09:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:46 INFO - 'talos_options': ['--xperf_path', 23:09:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:09:46 INFO - 'tests': ['tp5n']}}, 23:09:46 INFO - 'talos.zip': {'path': '', 23:09:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:09:46 INFO - Running post-action listener: _resource_record_post_action 23:09:46 INFO - ##### 23:09:46 INFO - ##### Finished populate-webroot step (success) 23:09:46 INFO - ##### 23:09:46 INFO - ##### 23:09:46 INFO - ##### Running create-virtualenv step. 23:09:46 INFO - ##### 23:09:46 INFO - Running pre-action listener: _resource_record_pre_action 23:09:46 INFO - Running main action method: create_virtualenv 23:09:46 INFO - Creating virtualenv /builds/slave/test/build/venv 23:09:46 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 23:09:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:09:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:09:46 INFO - Using real prefix '/usr' 23:09:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:09:46 INFO - Installing distribute.............................................................................................................................................................................................done. 23:09:48 INFO - Installing pip.................done. 23:09:48 INFO - Return code: 0 23:09:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:09:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2527cb1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ad770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263c9c0>, '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 0x263d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263dd50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1463723795.853079-575851582', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:09:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:09:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:09:48 INFO - Using env: {'DISPLAY': ':0', 23:09:48 INFO - 'HOME': '/home/cltbld', 23:09:48 INFO - 'LANG': 'en_US.UTF-8', 23:09:48 INFO - 'LANGUAGE': 'en_US:en', 23:09:48 INFO - 'LOGNAME': 'cltbld', 23:09:48 INFO - 'MAIL': '/var/mail/cltbld', 23:09:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:48 INFO - 'MOZ_NO_REMOTE': '1', 23:09:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:48 INFO - 'NO_EM_RESTART': '1', 23:09:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:48 INFO - 'PWD': '/builds/slave/test', 23:09:48 INFO - 'SHELL': '/bin/bash', 23:09:48 INFO - 'SHLVL': '1', 23:09:48 INFO - 'TERM': 'linux', 23:09:48 INFO - 'TMOUT': '86400', 23:09:48 INFO - 'USER': 'cltbld', 23:09:48 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1463723795.853079-575851582', 23:09:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:48 INFO - '_': '/tools/buildbot/bin/python'} 23:09:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:48 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 23:09:48 INFO - Cleaning up... 23:09:48 INFO - Return code: 0 23:09:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:09:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2527cb1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ad770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263c9c0>, '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 0x263d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263dd50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1463723795.853079-575851582', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:09:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:09:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:09:48 INFO - Using env: {'DISPLAY': ':0', 23:09:48 INFO - 'HOME': '/home/cltbld', 23:09:48 INFO - 'LANG': 'en_US.UTF-8', 23:09:48 INFO - 'LANGUAGE': 'en_US:en', 23:09:48 INFO - 'LOGNAME': 'cltbld', 23:09:48 INFO - 'MAIL': '/var/mail/cltbld', 23:09:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:48 INFO - 'MOZ_NO_REMOTE': '1', 23:09:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:48 INFO - 'NO_EM_RESTART': '1', 23:09:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:48 INFO - 'PWD': '/builds/slave/test', 23:09:48 INFO - 'SHELL': '/bin/bash', 23:09:48 INFO - 'SHLVL': '1', 23:09:48 INFO - 'TERM': 'linux', 23:09:48 INFO - 'TMOUT': '86400', 23:09:48 INFO - 'USER': 'cltbld', 23:09:48 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1463723795.853079-575851582', 23:09:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:48 INFO - '_': '/tools/buildbot/bin/python'} 23:09:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:49 INFO - Downloading/unpacking psutil>=3.1.1 23:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:09:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:09:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:09:51 INFO - Installing collected packages: psutil 23:09:51 INFO - Running setup.py install for psutil 23:09:51 INFO - building 'psutil._psutil_linux' extension 23:09:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 23:09:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 23:09:51 INFO - building 'psutil._psutil_posix' extension 23:09:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 23:09:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 23:09:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:09:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:09:51 INFO - Successfully installed psutil 23:09:51 INFO - Cleaning up... 23:09:51 INFO - Return code: 0 23:09:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:09: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')]} 23:09:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09: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')]} 23:09:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:51 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2527cb1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ad770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263c9c0>, '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 0x263d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263dd50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1463723795.853079-575851582', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:09:51 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.3'] in /builds/slave/test/build 23:09:51 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.3 23:09:51 INFO - Using env: {'DISPLAY': ':0', 23:09:51 INFO - 'HOME': '/home/cltbld', 23:09:51 INFO - 'LANG': 'en_US.UTF-8', 23:09:51 INFO - 'LANGUAGE': 'en_US:en', 23:09:51 INFO - 'LOGNAME': 'cltbld', 23:09:51 INFO - 'MAIL': '/var/mail/cltbld', 23:09:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:51 INFO - 'MOZ_NO_REMOTE': '1', 23:09:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:51 INFO - 'NO_EM_RESTART': '1', 23:09:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:51 INFO - 'PWD': '/builds/slave/test', 23:09:51 INFO - 'SHELL': '/bin/bash', 23:09:51 INFO - 'SHLVL': '1', 23:09:51 INFO - 'TERM': 'linux', 23:09:51 INFO - 'TMOUT': '86400', 23:09:51 INFO - 'USER': 'cltbld', 23:09:51 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1463723795.853079-575851582', 23:09:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:51 INFO - '_': '/tools/buildbot/bin/python'} 23:09:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:09:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:09:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:09:53 INFO - Installing collected packages: mozsystemmonitor 23:09:53 INFO - Running setup.py install for mozsystemmonitor 23:09:53 INFO - Successfully installed mozsystemmonitor 23:09:53 INFO - Cleaning up... 23:09:54 INFO - Return code: 0 23:09:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:54 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 0x7f2527cb1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ad770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263c9c0>, '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 0x263d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263dd50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1463723795.853079-575851582', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:09:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:09:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:09:54 INFO - Using env: {'DISPLAY': ':0', 23:09:54 INFO - 'HOME': '/home/cltbld', 23:09:54 INFO - 'LANG': 'en_US.UTF-8', 23:09:54 INFO - 'LANGUAGE': 'en_US:en', 23:09:54 INFO - 'LOGNAME': 'cltbld', 23:09:54 INFO - 'MAIL': '/var/mail/cltbld', 23:09:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:54 INFO - 'MOZ_NO_REMOTE': '1', 23:09:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:54 INFO - 'NO_EM_RESTART': '1', 23:09:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:54 INFO - 'PWD': '/builds/slave/test', 23:09:54 INFO - 'SHELL': '/bin/bash', 23:09:54 INFO - 'SHLVL': '1', 23:09:54 INFO - 'TERM': 'linux', 23:09:54 INFO - 'TMOUT': '86400', 23:09:54 INFO - 'USER': 'cltbld', 23:09:54 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1463723795.853079-575851582', 23:09:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:54 INFO - '_': '/tools/buildbot/bin/python'} 23:09:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:54 INFO - Downloading/unpacking blobuploader==1.2.4 23:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:56 INFO - Downloading blobuploader-1.2.4.tar.gz 23:09:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:09:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:09:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:56 INFO - Downloading docopt-0.6.1.tar.gz 23:09:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:09:56 INFO - Installing collected packages: blobuploader, requests, docopt 23:09:56 INFO - Running setup.py install for blobuploader 23:09:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:09:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:09:56 INFO - Running setup.py install for requests 23:09:57 INFO - Running setup.py install for docopt 23:09:57 INFO - Successfully installed blobuploader requests docopt 23:09:57 INFO - Cleaning up... 23:09:57 INFO - Return code: 0 23:09:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:09: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')]} 23:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09: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')]} 23:09:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:57 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 0x7f2527cb1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ad770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263c9c0>, '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 0x263d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263dd50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1463723795.853079-575851582', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:09:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:09:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:09:57 INFO - Using env: {'DISPLAY': ':0', 23:09:57 INFO - 'HOME': '/home/cltbld', 23:09:57 INFO - 'LANG': 'en_US.UTF-8', 23:09:57 INFO - 'LANGUAGE': 'en_US:en', 23:09:57 INFO - 'LOGNAME': 'cltbld', 23:09:57 INFO - 'MAIL': '/var/mail/cltbld', 23:09:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:57 INFO - 'MOZ_NO_REMOTE': '1', 23:09:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:57 INFO - 'NO_EM_RESTART': '1', 23:09:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:57 INFO - 'PWD': '/builds/slave/test', 23:09:57 INFO - 'SHELL': '/bin/bash', 23:09:57 INFO - 'SHLVL': '1', 23:09:57 INFO - 'TERM': 'linux', 23:09:57 INFO - 'TMOUT': '86400', 23:09:57 INFO - 'USER': 'cltbld', 23:09:57 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1463723795.853079-575851582', 23:09:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:57 INFO - '_': '/tools/buildbot/bin/python'} 23:09:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:09:57 INFO - Running setup.py (path:/tmp/pip-ZMGr2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:09:57 INFO - Running setup.py (path:/tmp/pip-SUtCn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:09:57 INFO - Running setup.py (path:/tmp/pip-sy8SLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:09:57 INFO - Running setup.py (path:/tmp/pip-5b0CnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:09:57 INFO - Running setup.py (path:/tmp/pip-R3dGiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:09:58 INFO - Running setup.py (path:/tmp/pip-dgzOvu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:09:58 INFO - Running setup.py (path:/tmp/pip-I7E5MZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:09:58 INFO - Running setup.py (path:/tmp/pip-bHd8XL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:09:58 INFO - Running setup.py (path:/tmp/pip-TDixG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:09:58 INFO - Running setup.py (path:/tmp/pip-SYn00A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:09:58 INFO - Running setup.py (path:/tmp/pip-oFObQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:09:58 INFO - Running setup.py (path:/tmp/pip-nvP5ND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:09:58 INFO - Running setup.py (path:/tmp/pip-DIEUbf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:09:58 INFO - Running setup.py (path:/tmp/pip-3fumc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:09:58 INFO - Running setup.py (path:/tmp/pip-FO5A2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:09:58 INFO - Running setup.py (path:/tmp/pip-xIRYEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:09:58 INFO - Running setup.py (path:/tmp/pip-bxW6Jb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:09:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:09:58 INFO - Running setup.py install for manifestparser 23:09:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:09:59 INFO - Running setup.py install for mozcrash 23:09:59 INFO - Running setup.py install for mozdebug 23:09:59 INFO - Running setup.py install for mozdevice 23:09:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:09:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:09:59 INFO - Running setup.py install for mozfile 23:09:59 INFO - Running setup.py install for mozhttpd 23:09:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:09:59 INFO - Running setup.py install for mozinfo 23:09:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:09:59 INFO - Running setup.py install for mozInstall 23:09:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:09:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:09:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:09:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:09:59 INFO - Running setup.py install for mozleak 23:09:59 INFO - Running setup.py install for mozlog 23:09:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:09:59 INFO - Running setup.py install for moznetwork 23:10:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:10:00 INFO - Running setup.py install for mozprocess 23:10:00 INFO - Running setup.py install for mozprofile 23:10:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:10:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:10:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:10:00 INFO - Running setup.py install for mozrunner 23:10:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:10:00 INFO - Running setup.py install for mozscreenshot 23:10:00 INFO - Running setup.py install for moztest 23:10:00 INFO - Running setup.py install for mozversion 23:10:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:10:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:10:00 INFO - Cleaning up... 23:10:00 INFO - Return code: 0 23:10:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:10: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')]} 23:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10: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')]} 23:10:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:00 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 0x7f2527cb1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ad770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263c9c0>, '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 0x263d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263dd50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1463723795.853079-575851582', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:10:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:10:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:10:00 INFO - Using env: {'DISPLAY': ':0', 23:10:00 INFO - 'HOME': '/home/cltbld', 23:10:00 INFO - 'LANG': 'en_US.UTF-8', 23:10:00 INFO - 'LANGUAGE': 'en_US:en', 23:10:00 INFO - 'LOGNAME': 'cltbld', 23:10:00 INFO - 'MAIL': '/var/mail/cltbld', 23:10:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:00 INFO - 'MOZ_NO_REMOTE': '1', 23:10:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:00 INFO - 'NO_EM_RESTART': '1', 23:10:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:00 INFO - 'PWD': '/builds/slave/test', 23:10:00 INFO - 'SHELL': '/bin/bash', 23:10:00 INFO - 'SHLVL': '1', 23:10:00 INFO - 'TERM': 'linux', 23:10:00 INFO - 'TMOUT': '86400', 23:10:00 INFO - 'USER': 'cltbld', 23:10:00 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1463723795.853079-575851582', 23:10:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:00 INFO - '_': '/tools/buildbot/bin/python'} 23:10:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:10:00 INFO - Running setup.py (path:/tmp/pip-nhmupA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:10:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 23:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:10:00 INFO - Running setup.py (path:/tmp/pip-voKWjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:10:01 INFO - Running setup.py (path:/tmp/pip-UnOzxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:10:01 INFO - Running setup.py (path:/tmp/pip-C4TrOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:10:01 INFO - Running setup.py (path:/tmp/pip-IpGf7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 23:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:10:01 INFO - Running setup.py (path:/tmp/pip-J1Zsu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 23:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:10:01 INFO - Running setup.py (path:/tmp/pip-3ihPAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 23:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:10:01 INFO - Running setup.py (path:/tmp/pip-Z279vW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 23:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:10:01 INFO - Running setup.py (path:/tmp/pip-cwKmPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 23:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:10:01 INFO - Running setup.py (path:/tmp/pip-HmWdMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:10:01 INFO - Running setup.py (path:/tmp/pip-b3OL2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 23:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:10:01 INFO - Running setup.py (path:/tmp/pip-5iXsrl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:10:01 INFO - Running setup.py (path:/tmp/pip-P0tTch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 23:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:10:01 INFO - Running setup.py (path:/tmp/pip-53_b4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:10:01 INFO - Running setup.py (path:/tmp/pip-LoGHWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 23:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:10:02 INFO - Running setup.py (path:/tmp/pip-31wg0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 23:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:10:02 INFO - Running setup.py (path:/tmp/pip-RF7yoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 23:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:10:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:10: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 23:10: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 23:10: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 23:10: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 23:10: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 23:10: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 23:10:04 INFO - Downloading blessings-1.6.tar.gz 23:10:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:10:04 INFO - Installing collected packages: blessings 23:10:04 INFO - Running setup.py install for blessings 23:10:04 INFO - Successfully installed blessings 23:10:04 INFO - Cleaning up... 23:10:04 INFO - Return code: 0 23:10:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:10:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:10:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:10:04 INFO - Reading from file tmpfile_stdout 23:10:04 INFO - Current package versions: 23:10:04 INFO - argparse == 1.2.1 23:10:04 INFO - blessings == 1.6 23:10:04 INFO - blobuploader == 1.2.4 23:10:04 INFO - docopt == 0.6.1 23:10:04 INFO - manifestparser == 1.1 23:10:04 INFO - mozInstall == 1.12 23:10:04 INFO - mozcrash == 0.17 23:10:04 INFO - mozdebug == 0.1 23:10:04 INFO - mozdevice == 0.48 23:10:04 INFO - mozfile == 1.2 23:10:04 INFO - mozhttpd == 0.7 23:10:04 INFO - mozinfo == 0.9 23:10:04 INFO - mozleak == 0.1 23:10:04 INFO - mozlog == 3.2 23:10:04 INFO - moznetwork == 0.27 23:10:04 INFO - mozprocess == 0.22 23:10:04 INFO - mozprofile == 0.28 23:10:04 INFO - mozrunner == 6.11 23:10:04 INFO - mozscreenshot == 0.1 23:10:04 INFO - mozsystemmonitor == 0.3 23:10:04 INFO - moztest == 0.7 23:10:04 INFO - mozversion == 1.4 23:10:04 INFO - psutil == 3.1.1 23:10:04 INFO - requests == 1.2.3 23:10:04 INFO - wsgiref == 0.1.2 23:10:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:10:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2527cb1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ad770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263c9c0>, '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 0x263d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263dd50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1463723795.853079-575851582', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:10:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 23:10:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:10:04 INFO - Using env: {'DISPLAY': ':0', 23:10:04 INFO - 'HOME': '/home/cltbld', 23:10:04 INFO - 'LANG': 'en_US.UTF-8', 23:10:04 INFO - 'LANGUAGE': 'en_US:en', 23:10:04 INFO - 'LOGNAME': 'cltbld', 23:10:04 INFO - 'MAIL': '/var/mail/cltbld', 23:10:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:04 INFO - 'MOZ_NO_REMOTE': '1', 23:10:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:04 INFO - 'NO_EM_RESTART': '1', 23:10:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:04 INFO - 'PWD': '/builds/slave/test', 23:10:04 INFO - 'SHELL': '/bin/bash', 23:10:04 INFO - 'SHLVL': '1', 23:10:04 INFO - 'TERM': 'linux', 23:10:04 INFO - 'TMOUT': '86400', 23:10:04 INFO - 'USER': 'cltbld', 23:10:04 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1463723795.853079-575851582', 23:10:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:04 INFO - '_': '/tools/buildbot/bin/python'} 23:10:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:10:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 23:10:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 23:10:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:10:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 23:10:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 23:10:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 23:10:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 23:10:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 23:10:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:10:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:10:04 INFO - Cleaning up... 23:10:04 INFO - Return code: 0 23:10:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:10:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2527cb1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ad770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263c9c0>, '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 0x263d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263dd50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1463723795.853079-575851582', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:10:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:10:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:10:04 INFO - Using env: {'DISPLAY': ':0', 23:10:04 INFO - 'HOME': '/home/cltbld', 23:10:04 INFO - 'LANG': 'en_US.UTF-8', 23:10:04 INFO - 'LANGUAGE': 'en_US:en', 23:10:04 INFO - 'LOGNAME': 'cltbld', 23:10:04 INFO - 'MAIL': '/var/mail/cltbld', 23:10:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:04 INFO - 'MOZ_NO_REMOTE': '1', 23:10:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:04 INFO - 'NO_EM_RESTART': '1', 23:10:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:04 INFO - 'PWD': '/builds/slave/test', 23:10:04 INFO - 'SHELL': '/bin/bash', 23:10:04 INFO - 'SHLVL': '1', 23:10:04 INFO - 'TERM': 'linux', 23:10:04 INFO - 'TMOUT': '86400', 23:10:04 INFO - 'USER': 'cltbld', 23:10:04 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1463723795.853079-575851582', 23:10:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:04 INFO - '_': '/tools/buildbot/bin/python'} 23:10:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:04 INFO - Downloading/unpacking jsonschema 23:10: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 23:10: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 23:10: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 23:10: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 23:10: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 23:10: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 23:10:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:10:06 INFO - Downloading/unpacking functools32 (from jsonschema) 23:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:07 INFO - Downloading functools32-3.2.3-2.tar.gz 23:10:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:10:07 INFO - warning: no files found matching '*.txt' 23:10:07 INFO - no previously-included directories found matching 'build' 23:10:07 INFO - no previously-included directories found matching 'dist' 23:10:07 INFO - no previously-included directories found matching '.git*' 23:10:07 INFO - Installing collected packages: jsonschema, functools32 23:10:07 INFO - Running setup.py install for functools32 23:10:07 INFO - warning: no files found matching '*.txt' 23:10:07 INFO - no previously-included directories found matching 'build' 23:10:07 INFO - no previously-included directories found matching 'dist' 23:10:07 INFO - no previously-included directories found matching '.git*' 23:10:07 INFO - Successfully installed jsonschema functools32 23:10:07 INFO - Cleaning up... 23:10:07 INFO - Return code: 0 23:10:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:10:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:07 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 0x7f2527cb1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ad770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263c9c0>, '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 0x263d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263dd50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1463723795.853079-575851582', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:10:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 23:10:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 23:10:07 INFO - Using env: {'DISPLAY': ':0', 23:10:07 INFO - 'HOME': '/home/cltbld', 23:10:07 INFO - 'LANG': 'en_US.UTF-8', 23:10:07 INFO - 'LANGUAGE': 'en_US:en', 23:10:07 INFO - 'LOGNAME': 'cltbld', 23:10:07 INFO - 'MAIL': '/var/mail/cltbld', 23:10:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:07 INFO - 'MOZ_NO_REMOTE': '1', 23:10:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:07 INFO - 'NO_EM_RESTART': '1', 23:10:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:07 INFO - 'PWD': '/builds/slave/test', 23:10:07 INFO - 'SHELL': '/bin/bash', 23:10:07 INFO - 'SHLVL': '1', 23:10:07 INFO - 'TERM': 'linux', 23:10:07 INFO - 'TMOUT': '86400', 23:10:07 INFO - 'USER': 'cltbld', 23:10:07 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1463723795.853079-575851582', 23:10:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:07 INFO - '_': '/tools/buildbot/bin/python'} 23:10:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:07 INFO - Downloading/unpacking flake8 23:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:10:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:10:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:10:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:10:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:10:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:10:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:10:10 INFO - no previously-included directories found matching 'docs/_build' 23:10:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:10:10 INFO - Running setup.py install for pep8 23:10:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:10:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:10:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:10:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:10:10 INFO - no previously-included directories found matching 'docs/_build' 23:10:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:10:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:10:10 INFO - Cleaning up... 23:10:10 INFO - Return code: 0 23:10:10 INFO - Running post-action listener: _resource_record_post_action 23:10:10 INFO - Running post-action listener: _start_resource_monitoring 23:10:10 INFO - Starting resource monitoring. 23:10:10 INFO - ##### 23:10:10 INFO - ##### Finished create-virtualenv step (success) 23:10:10 INFO - ##### 23:10:10 INFO - ##### 23:10:10 INFO - ##### Running install step. 23:10:10 INFO - ##### 23:10:10 INFO - Running pre-action listener: _resource_record_pre_action 23:10:10 INFO - Running main action method: install 23:10:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:10:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:10:10 INFO - Reading from file tmpfile_stdout 23:10:10 INFO - Detecting whether we're running mozinstall >=1.0... 23:10:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:10:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:10:10 INFO - Reading from file tmpfile_stdout 23:10:10 INFO - Output received: 23:10:10 INFO - Usage: mozinstall [options] installer 23:10:10 INFO - Options: 23:10:10 INFO - -h, --help show this help message and exit 23:10:10 INFO - -d DEST, --destination=DEST 23:10:10 INFO - Directory to install application into. [default: 23:10:10 INFO - "/builds/slave/test"] 23:10:10 INFO - --app=APP Application being installed. [default: firefox] 23:10:10 INFO - mkdir: /builds/slave/test/build/application 23:10:10 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'] 23:10:10 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 23:10:27 INFO - Reading from file tmpfile_stdout 23:10:27 INFO - Output received: 23:10:27 INFO - /builds/slave/test/build/application/firefox/firefox 23:10:27 INFO - Running post-action listener: _resource_record_post_action 23:10:27 INFO - ##### 23:10:27 INFO - ##### Finished install step (success) 23:10:27 INFO - ##### 23:10:27 INFO - ##### 23:10:27 INFO - ##### Running run-tests step. 23:10:27 INFO - ##### 23:10:27 INFO - Running pre-action listener: _resource_record_pre_action 23:10:27 INFO - Running main action method: run_tests 23:10:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:10:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:10:27 INFO - Python 2.7.3 23:10:27 INFO - Return code: 0 23:10:27 INFO - grabbing minidump binary from tooltool 23:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:27 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263c9c0>, '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 0x263d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263dd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:10:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 23:10:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 23:10:27 INFO - Calling ['/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'] with output_timeout 600 23:10:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:10:27 INFO - Return code: 0 23:10:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:10:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:10:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:10:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:10:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:10:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:10:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:10:28 INFO - Return code: 0 23:10:28 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/XyxYN_omThyuEW0u-STcpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 23:10:28 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/XyxYN_omThyuEW0u-STcpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 23:10:28 INFO - Using env: {'DISPLAY': ':0', 23:10:28 INFO - 'HOME': '/home/cltbld', 23:10:28 INFO - 'LANG': 'en_US.UTF-8', 23:10:28 INFO - 'LANGUAGE': 'en_US:en', 23:10:28 INFO - 'LOGNAME': 'cltbld', 23:10:28 INFO - 'MAIL': '/var/mail/cltbld', 23:10:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:10:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:10:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:28 INFO - 'MOZ_NO_REMOTE': '1', 23:10:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:10:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:28 INFO - 'NO_EM_RESTART': '1', 23:10:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:28 INFO - 'PWD': '/builds/slave/test', 23:10:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:10:28 INFO - 'SHELL': '/bin/bash', 23:10:28 INFO - 'SHLVL': '1', 23:10:28 INFO - 'TERM': 'linux', 23:10:28 INFO - 'TMOUT': '86400', 23:10:28 INFO - 'USER': 'cltbld', 23:10:28 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1463723795.853079-575851582', 23:10:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:28 INFO - '_': '/tools/buildbot/bin/python'} 23:10:28 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/XyxYN_omThyuEW0u-STcpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 23:10:28 INFO - mozversion application_buildid: 20160519203032 23:10:28 INFO - mozversion application_changeset: c62705a833ff9c985c71ddf4c07054de113525c3 23:10:28 INFO - mozversion application_display_name: Nightly 23:10:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:10:28 INFO - mozversion application_name: Firefox 23:10:28 INFO - mozversion application_remotingname: firefox 23:10:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 23:10:28 INFO - mozversion application_vendor: Mozilla 23:10:28 INFO - mozversion application_version: 49.0a1 23:10:28 INFO - mozversion platform_buildid: 20160519203032 23:10:28 INFO - mozversion platform_changeset: c62705a833ff9c985c71ddf4c07054de113525c3 23:10:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 23:10:28 INFO - mozversion platform_version: 49.0a1 23:10:28 INFO - using testdate: 1463724628 23:10:28 INFO - actual date: 1463724628 23:10:28 INFO - starting webserver on 'localhost:46162' 23:10:28 INFO - SUITE-START | Running 2 tests 23:10:28 INFO - TEST-START | dromaeo_css 23:10:28 INFO - operating with platform_type : linux_ 23:10:28 INFO - Initialising browser for dromaeo_css test... 23:10:28 INFO - TEST-INFO | started process 19044 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphu6ILe/profile http://localhost:46162/getInfo.html) 23:10:33 INFO - PROCESS | 19044 | 23:10:33 INFO - PROCESS | 19044 | (process:19113): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:10:34 INFO - PROCESS | 19044 | __metrics Screen width/height:1600/1200 23:10:34 INFO - PROCESS | 19044 | colorDepth:24 23:10:34 INFO - PROCESS | 19044 | Browser inner width/height: 1024/697 23:10:34 INFO - PROCESS | 19044 | __metrics 23:10:35 ERROR - PROCESS | 19044 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 23:10:36 INFO - TEST-INFO | 19044: exit 0 23:10:36 INFO - Browser initialized. 23:10:36 INFO - Running cycle 1/1 for dromaeo_css test... 23:10:36 INFO - TEST-INFO | started process 19165 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphu6ILe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:10:38 INFO - PROCESS | 19165 | 23:10:38 INFO - PROCESS | 19165 | (process:19228): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:10:48 INFO - PROCESS | 19165 | RSS: Main: 163692544 23:10:48 INFO - PROCESS | 19165 | 23:11:37 INFO - PROCESS | 19165 | 1463724697661 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 23:13:45 INFO - PROCESS | 19165 | Cycle 1(1): loaded http://localhost:46162/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46162/tests/dromaeo/cssquery-ext.html) 23:13:46 INFO - PROCESS | 19165 | RSS: Main: 166686720 23:13:46 INFO - PROCESS | 19165 | 23:16:48 INFO - PROCESS | 19165 | Cycle 1(1): loaded http://localhost:46162/tests/dromaeo/cssquery-ext.html (next: http://localhost:46162/tests/dromaeo/cssquery-jquery.html) 23:16:49 INFO - PROCESS | 19165 | RSS: Main: 166760448 23:16:49 INFO - PROCESS | 19165 | 23:19:51 INFO - PROCESS | 19165 | Cycle 1(1): loaded http://localhost:46162/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46162/tests/dromaeo/cssquery-mootools.html) 23:19:51 INFO - PROCESS | 19165 | RSS: Main: 168566784 23:19:51 INFO - PROCESS | 19165 | 23:22:53 INFO - PROCESS | 19165 | Cycle 1(1): loaded http://localhost:46162/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46162/tests/dromaeo/cssquery-prototype.html) 23:22:53 INFO - PROCESS | 19165 | RSS: Main: 165199872 23:22:53 INFO - PROCESS | 19165 | 23:25:56 INFO - PROCESS | 19165 | Cycle 1(1): loaded http://localhost:46162/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46162/tests/dromaeo/cssquery-yui.html) 23:25:57 INFO - PROCESS | 19165 | RSS: Main: 166166528 23:25:57 INFO - PROCESS | 19165 | 23:28:59 INFO - PROCESS | 19165 | Cycle 1(1): loaded http://localhost:46162/tests/dromaeo/cssquery-yui.html (next: http://localhost:46162/tests/dromaeo/cssquery-dojo.html) 23:28:59 INFO - PROCESS | 19165 | RSS: Main: 168816640 23:28:59 INFO - PROCESS | 19165 | 23:28:59 INFO - PROCESS | 19165 | __start_tp_report 23:28:59 INFO - PROCESS | 19165 | _x_x_mozilla_page_load 23:28:59 INFO - PROCESS | 19165 | _x_x_mozilla_page_load_details 23:28:59 INFO - PROCESS | 19165 | |i|pagename|runs| 23:28:59 INFO - PROCESS | 19165 | |0;dojo.html;3162.6837316268375;3163.9242657496447;3188.56954311168;3195.440797860374;3209.486482162853;5292.814751483699;5312.150055991042;5322.893542129155;5352.384475785286;5413.323334583177;5206.036883176605;5294.285271488348;5311.362636483617;5335.893282134355;5368.62419630626;4837.564619184264;4859.975700121512;4908.803647854082;4993.325901003354;5051.166557518005;4908.877278068041;4920.237363208708;4956.950430495703;4997.525235102659;5039.44566097729;4995.200767877141;5003.899922001558;5006.949930500703;5007.624428167884;5051.621128415365;4868.561829435333;4917.7786999585105;4935.481774413671;4948.0846043481715;4956.727379994099;4886.987173406138;4889.071076495455;4900.215965445547;4903.485134060944;4928.778204980785;5132.666376685504;5232.084385232607;5240.659357141773;5253.0544501989625;5289.629725919187;5663.207150998822;5731.77072917087;5735.971320143414;5747.655140691572;5779;5803.332616749043;5880.176775251468;5882.088276317178;5882.735276912506;5894.17481552583;5453.890922181574;5470.972645136749;5473.8357849264585;5502.862428439281;5516.475934786189;5956.970215148896;5976.163337132805;5989.520838332923;5990.790322338785;6028.577999540078;5778.3354914184565;5800.796972105956;5804.129380592861;5807.941920580824;5809.128630705343;5683.857903552444;5718.428157184248;5732.914006289909;5747.770089196469;5893.057110862242;5781.508571771446;5784.739686714108;5787.421257874179;5793.797217097465;5813;5759.740811663485;5764.394738552392;5784.797532086357;5799.043157878987;5804.88390232193;4340.2187606230555;4379.430674012358;4393.0994146199955;4398.670099742532;4422.955770442319;3853.537575490903;3893.929169478416;3919.353306704362;3949.6445319921345;3978.920421591552;5574.526165275915;5582.525485333792;5585.1901474286005;5596.160575913564;5601.439856014366;5724.055530837449;5752.223449834302;5760.798372056958;5770.538356931435;5781.88436231273;5418.078926582491;5432.158015507603;5495.670259784346;5497.5601951843755;5555.527780138734;4970.65205435616;4978.90042199154;4986.0277245936695;4997.175466048134;5020.698758074527;5940;5942.078977758454;5947.048472244506;5975.701214939236;6014.849628759229;5848.064309710596;5849.239598852207;5850.707464626837;5862;5865.384134665798;6041;6043.123747056564;6045.667488288011;6047.818565443044;6049;5612.971935140462;5731.942680573307;5746.827595171984;5783.566232532661;5817.389174136655;5833.970830145822;5836.766529338779;5843.620164689281;5868.178455016387;5879.176915231957;5585.581081418829;5724.914126288026;5731.283589551306;5737.942620573741;5779.959607270732;5733.569982251432;5780.537556995514;5793.9420605795085;5803.013487707184;5831.475167234969;5663.631863928831;5666.46168613981;5671.064274394678;5672.404397538199;5694.629849059798;5620.690862002629;5691.459311365414;5803.216565763568;5824.912626310694;5853.707314634336;5547.278853748987;5601.691906945157;5616.550675945833;5649.971750141223;5696.0316746154085 23:28:59 INFO - PROCESS | 19165 | |1;ext.html;576.8875069361476;627.4478458956117;641.871625674865;656.8587753632969;668.3817468841321;39027;43299;43368.3494747579;43402.34896476555;43448.565514344846;43152.568474315245;43443.13113737723;43545.56454435454;43553.564464355346;43647.127057458914;8725.345599080063;8899.822003559924;8910.910890891073;8914.55427228636;8928;8745.4752714837;8869.290456763476;8869.68956086537;8871.733847984538;8878.156575125386;8857.070007649201;8926.107389261088;8935.463872167658;8939.64241430342;8943.731688049369;8860.379773415863;8874.600642971049;8901.866472002925;8907.599158037903;8920.152585504398;8816.779580510474;8887.466751994836;8922.330825188072;8923.643054277885;8954.059823718546;33121.668783312096;41383.793081034404;41673.583264167275;41742.79128604368;41828.58171418277;3247.9025629230923;3334.333133373335;3344.0469466202258;3732.346839303111;3938.5667576566557;31628;31694.366112677846;31821.681783182103;32058.839705801554;32183.6781632183;4034.8789536313666;4139.648129908961;4158.7296825706235;4162.042730172077;4167.937480937789;299656;299766;299771;299982;301061.9999999978;35081.82459087688;35167;35383;35386;35455;36430;36668.81665591655;36686.26627467489;37051.81474092612;37389.626103738614;16662.83337166613;16777.496675099523;16939.153042347833;16967.660646786993;16973.066481343398;12825.230486170673;12913.677158071123;12926.353682315847;12927.935360323138;12933.935330323477;20017.59964800696;20314.085866135763;20343.186272548934;20459.488512787;20492.69260961087;7352.96323518379;7357.484976051732;7445.85108297831;7476.401887848959;7487.1389790173735;906.6962567539948;998.9250806189565;1089.1613457637575;1097.3635291530893;1113.1373185781085;31310.37379252448;32914.17714557108;33543.83228083893;33551;33662.158446039044;1111.1610733895857;1118.6588090632436;1144.3820337018083;1190.14309697018;1213.1568559850818;17302.567435814206;17507.56231094233;17517.64964700724;17592.824071759376;17717.557061073578;606131;606505;609199;611420;612535;60553.69723151356;61713.38286617166;62033.37966620366;62223.6888815553;62262.37737622566;1362.9591112266648;1397.0849093843347;1420.0769499825196;1420.4318272691007;1423.9857601423853;30680.539791902695;32282.677173227967;32759.508607371386;32816.50775238326;33128.50307245441;52326.47673523216;52477;52712.73643631757;52742;52988;451092;451300;451538;451901;451950;28462.430751384443;28998.85500572568;29219.561706573993;29247.122586322443;29455.410891782474;48621.756891215315;49500.75249623729;49622.25566616576;49943.50056499388;50086.499135008184;41824;42043.57956420397;42139;42589;42959.78520107379;41984;42915.785421073946;43248;43304;43565.12869742524;41158.794206028775;41378.37932430956;41950.79024604857;42276.15447690967;42454.363184551636;36458.27083458369;37775.62224377721;37818.62181378151;37968;38852;28501.287467813472;28799.13602591842;29000.41999159963;29003.854980724962;29075.563866541597 23:28:59 INFO - PROCESS | 19165 | |2;jquery.html;377.70538979595926;380.9656089249131;384.0609709260857;401.7087611481674;407.2059484006187;17692.82307176928;19545.12046957887;19644.21423143076;19685.31101411449;19709.211631534738;18162.727559086623;18209;18252;18556.44330670079;18794.43616691498;5613.971930140344;5684.346300175471;5802.158686990384;5927.2294601701715;5933.317668468117;5693.202951586781;5712.457316554921;5736.3403208631125;5774.335951365605;5776.855578610526;5265.815696450625;5553.694546799924;5669.0646043402785;5702.344230413514;5706.429357064302;5490.752916118744;5557;5572.58205634577;5616.971915140439;5631.099024156136;5567.164925261202;5617.775288988436;5623.915641265385;5628.043232650419;5640.097584386478;12458.377081145996;12727.109102362838;12782.169159004636;13057.086003979724;13322.73354532904;2169.8372622053407;2191.9780802191935;2193.4954960359046;2243.1363924888874;2266.218154736613;9773.462459564722;9862.60549578016;9942.602295908155;10051.095401413835;10051.24615653829;1872.241742094454;1958.7551556055494;2006.6488364536149;2032.6239645665598;2049.5081180516568;79270.47987162347;79586.60206698987;79777.60111199407;82096;84463.5776821118;8897.688580899638;9354.877414710143;9489.478078705599;9914.305998580174;10556.671764576487;12541.122121451594;12614.432350544248;12623.179493332904;12673;12687.619371418872;7460.850782984418;7640.121386040565;7704.075510938723;7735.381169506426;7744.6514906829325;7669.923300767033;7727.150013498511;7802.492837965628;7893.960530197312;7929.1277959424415;3962.9603703963166;3986.4418981342637;4008.2985477541897;4051.331530297468;4052.8176232069627;1799.190364336054;1842.907854607291;1900.372876950603;1945.319138301583;1969.1040576537928;983.233078199006;1008.2035192198229;1022.6471867205802;1082.377632861108;1102.990763451449;19195;19775.18074675652;19942.90028549848;20036.098375573136;20042.498937526678;994.796066806303;996.4220751963844;1018.4754851251612;1029.583018877356;1030.2273295028729;10586.89413105859;10850.2667162883;11000.284981476178;11016.669499915015;11029.889701102886;482372;488943;489207;490558;505070;97147;97699.023009769;102056;102321.48839255756;106039;1044.749260177567;1048.2138396202847;1074.1245884604023;1082.118073769875;1099.2470157941675;17727;17736.2018709161;17983.460496185136;18131;18397;42484.65337625717;43521.78239108784;43660.56339436692;44389.55610443854;45056.324155138354;57186.42813571811;58736;59432;59759;60416;8273.379496537664;8443.408961372645;8523.701670441505;8620.827583448421;8769.649214031368;13054.738905222031;13531.864681353061;13548.390322435711;13653.453861845415;13763;10951.945240274066;11074.889251107386;11110;11261.436928153396;11549.595764148215;11648.592299269485;11784.528618855149;11899.881001189877;12229.87770122323;12245.448954797233;11452.271453164549;11565.537378504765;11809.82285265739;11953.701157471132;12146.696332591757;8474.872876906727;8543.188397102265;8551.486910785372;8823.558822059;9011.684591039544;8564.01513825918;11678.88321116778;11766.411679416165;11835.053195744493;11994.64016079519 23:28:59 INFO - PROCESS | 19165 | |3;mootools.html;1534.2098819108155;1563.2027665890396;1698.7706659600958;1759.6128851652632;1811.999999999999;7624.466287359887;8489.91510084899;8599.570021498923;9168.404053736502;9176.449413035223;8738.73783786486;8997.145271199242;9054.456732596049;9083.591238394272;9085.863712044325;2363.988180059106;2389.0563227525117;2394.7006624171977;2401.86789726565;2412.49337639096;2286.9085236590518;2313.0516488239823;2346.1788374069024;2347.507023525062;2349.7885190332954;2311.3759284993043;2314.4098254944965;2326.1742081561056;2340.695709557755;2356.9882150589224;2268.875211863347;2287.8741669208353;2301.9539609207804;2306.7116610423695;2318.374039009458;2281.3726225288015;2290;2300.1949317738827;2303.7120359955006;2308.5382923415386;8613.526256055915;8704.477731336077;8714.738557843275;8718.17177368149;8736.039035706131;5249.711265880375;5333.706646134461;5339.786408543654;5363.973180134113;5368.570514358842;3275.6888095630875;3307.914725314235;3439.570053743282;3453.2057626745736;3530.6116327203986;1031.6543957774154;1050.4117694091333;1058.4496062047692;1067.4502631144967;1073.5330131392868;12196.085293603015;12197.634070977885;12220.877791222063;12236.877631223751;12240.265584064984;4475.641948644101;4688.437387513521;4743;4795.95204047962;4820.8794780130775;10406.5837366506;10494.790104197873;10506.474676266156;10556.894431055745;10594.258401911793;5231.71225582589;5235.110031294689;5252.448492908266;5256;5257.526822585985;4267.957320426818;4817.229243321051;4849.806007759721;4933.58064564516;4987.276844857548;4127.422160897477;4128.772917489567;4198.979005105016;4221.915561688749;4224.640905523003;1258.811178323259;1270.8665590112905;1294.1264646363668;1311.3639884655934;1312.5078095714107;938.5260443476001;947.3747326764441;953.046953046953;959.8560215967522;973.0561355485167;5684.687342196219;5790.739416726257;5808.07070868659;5935.7625694972585;5973.581849270597;461.6122457136022;477.4461624515545;983.4885859353096;1065.898739619735;1071.6410002649045;3800.467934489174;3861.555921069113;3929.724919255682;3930.272899513599;3947.111899822517;10827.133829293638;11020.889791102147;11056.502457389437;11154.498047587878;11165.497552610152;11044.944775276072;11087.889121108847;11097.778044439066;11102.167337449724;11150.832737508943;8300.12848650883;8368.665253389918;8489.151084891584;8550.786230344167;8590.098039705867;5571.303587051619;5594.720263986866;5668.206451096932;5704.258446401941;5731.598788084794;10201.336913100624;10309.329893556895;10420.166386689198;10451.529681164518;10452.059314661718;10141.239407044648;10473.842892356468;10667.306625069346;10669.46652667379;10738.40938748345;6824.829379265359;7210.747623833141;7211.459140564374;7465.813354666177;7565.167831538636;8719.38964272495;8746.431481953907;8747.737567872973;8766.956165219133;8839.337049721426;7564.4704870658525;7724.884126737991;7837.725679601187;7981;8141.755747327589;7706.807329816799;7805.414593905366;7858.528488290721;7929.881051784112;7930.881036784568;7110.644467776487;7121.394681452135;7211.134663840373;7260.346568808833;7289.1981881994;4876.536729010738;4925.48282430354;5036.093503169464;5078.873028174326;5101.0308041472;4993.151164302005;5046.419661738947;5102.260172274925;5120;5130.948690513047 23:28:59 INFO - PROCESS | 19165 | |4;prototype.html;309.16987887522004;319.39315300928234;319.928016196356;321.6686812583039;326.186165517035;5434.592405569579;5600.5799565032585;5722.599418040739;5730.9713451432735;5751.56863235258;5505.03661859174;5526;5540.944590554093;5549.861253468665;5614.859628509289;4336.21948049351;4371.978140109295;4373.868783936471;4383.999999999984;4393.670474714393;4054.6553542948736;4270.893227669302;4271.893202669942;4314.1371725654835;4323.200207961521;4172.624463798257;4199.139176468817;4204.978975105136;4207.768572728499;4248.851290204843;4238.961454443681;4244.151169766059;4281.143771245747;4290.742555446652;4325.13497300538;3512.4731290306404;3727;3740.8590379934108;3744.6255374462608;3750.5686846012513;5410.594205434608;5478.315210598676;5483.725813709299;5507.504324610764;5515.7242137892945;4850.611951043908;4888.584470320027;4896.730679812609;4901;4907.607391408679;5503.9174412383845;5832.445917637818;5864.208331875185;5885.588008839383;5904.793332233394;4051.8176682049084;4126.401671757609;4143.70994030418;4152.484343214735;4152.8131234094535;6088.299845517734;6123.785667501616;6129.264488261392;6138.355472675349;6210.50315974721;4114.5679703630685;4213.599708027732;4238.703290769617;4241.575842415734;4248.532661407243;4270.50889147752;4286.335617979218;4287.721298115613;4294.656427485794;4299.527052024275;4891.26631005352;4930.556249937523;4981.750912454363;4987.62592805541;4993.50064993505;5879.941200588025;5987;5991.64050156992;6010.609310394811;6050.848728781815;1434.419060280588;1445.6964037552023;1456.1263242054895;1460.5618314505605;1462.151951867914;884.712468447757;916.7937214126769;920.4431319052011;928.758522784081;932.3054324528134;5012.774425150804;5061.519155680205;5099.674084737921;5122.538971492583;5137.073597400975;5334.5732341412595;5349.502139400974;5364.310242273671;5424.674519528841;5497.615166938356;4900.460949295574;4990.10178167926;5018.272350509155;5089.923651145235;5123.182249762615;2895.609092772491;2896.5799959005826;2940.8823647053878;2957.497225471675;2966.1991262359043;5438.91841622376;5516.889662206733;5525.834224973257;5561.277033985637;5578.191162281528;5250.842474725764;5419.891602167934;5457.908418316273;5568.415316391802;5580.637258578179;5541.27963364768;5575.247341608912;5619.353774316006;5638.04153293941;5677.318721753333;5381.865453363697;5444.346678398618;5460.781568737365;5480.835574932758;5805.680687562056;6061.212042434456;6072.574919755575;6097.146399504161;6111.449969502766;6112.144299797943;6042.6101996540165;6348.809535713936;6377.426031657174;6400;6422.293547709654;4073.3889916512762;4220.134872351099;4226.112516371596;4237.152569486177;4239.554846741048;6026.849328766816;6054.788082417094;6100.5292856393235;6148.538859585459;6190.721417536131;5792.913106303493;5856.862245280357;5884.705764711662;5918.230630018243;6020.367861374492;5854.882902341844;5860.446981549978;5941.514621344664;5944.881102377842;5947.137665038632;5761.5102716269585;5762.625429347079;5774.2782152230975;5793.246877905845;5873.355460471075;5782.739776710142;6078.635281883101;6116.2660480740815;6118.663473509;6146.200993870768;5878.559108066826;5919.556033297606;5926.851828704317;5935.465808077293;5973.820785376446 23:28:59 INFO - PROCESS | 19165 | |5;yui.html;822.8148666550026;850.8893843800313;853.6841368693584;857.8627419612861;883.9425437346572;14620.34208460619;14708.852911470882;14821.333040013198;14930.178840163786;14967.47613833516;14873.776893346581;15117.092974421543;15435.768463473029;15722;15785.05289682617;658.2758965138357;664.186371694675;684.1448189762797;689.0387908867127;690.7237105157927;657.4805903336382;781.847539729753;800.9919900800976;805.3677862877643;814.5153633588005;853.8206976534935;855.9743207703779;859.1194026123211;860.0754189246554;860.8063185783211;840.3319361107934;847.3433089355768;847.4745657692271;849.9617517211709;851.7615067781031;607.9513638908877;609.3206075226135;610.0391882784587;612.3417326374166;612.7518355066205;14768.335424905905;14771.261436928111;14789.11265324084;14815.111093334326;14878.181700006495;14156.85843141576;14264.215468149248;14286.785698214535;14376;14416.783748243784;11672.708182295426;11679;11729.882701172965;11768.588099416565;11843.644690659294;3744.700423966076;3766.152615661454;3812.7331086823933;3827.3302172120048;3916.5887581803786;61189.38810611926;61327;61474;61476.69261653663;62201.37798622001;10813.891861081289;11046.779064418828;11062.502187401426;11245.044171245372;11525.654230373102;19477.318293859647;19477.415677529698;19489.317873874345;19503.024848757505;19570.21719131219;7965.322947549524;8051.557164356017;8055.275025247639;8179.550124743197;8422.157784221528;4761.214399624093;4780.139574876486;4806.567408933212;4808.35087263222;4922.827701030518;3223.8065716057113;3332.683395077464;3340.1148695595684;3346.983265083708;3357.983210083934;605.6396444115744;610.2798697536861;613.7821073518836;625.0156004293257;636.1729751323354;679.9932000680029;746.895434639151;770.2066871122753;775.8138046868823;790.3282210121466;8853.335999799912;9099.727008189764;9206.401583897024;9337.112974267433;9390.201832844148;697.2609034423527;725.7060890339421;762.9084509858742;769.830637259802;769.8960640313486;4615.192341340252;4856.125897338513;4901.215805471107;4922.33548470959;4940.728259945738;77849;77867.61066194632;78341;79288;79898;67226.66386668035;68972;70003.64998174977;70084.64957675179;70216;61453.999999999105;61670.38329616647;61752;62593;63094;9128.087191280818;9385.953070234606;9605.663801766905;9632.229421646392;9722.854157187789;41152.1769564613;41439.37840932328;41842.397336293594;41859.372109417774;42798.78600606977;54792.17811732907;54935;55163.17255241094;55596;55721.44278557163;11607.883921160681;11883.702907427038;12575.245485270912;12709.36453177319;12761.747732893578;13375.866241337462;14044.087134336236;14230.644233894236;14746.262686865828;14965.625859353604;12194.146409751233;12891.613251602466;13282.269475178959;13284.136531125447;13367.732645347232;13447.394867231194;13449.193048417126;13525.2561109136;13577.190001943;13668.453261869414;13671.316434178052;13770;14018.649533761738;14023.50917717875;14076.155430674193;11025.173112016791;11274.605388811353;11415.200935934405;11632.76734465289;11857.466414011218;11280.32318060919;11758.176927615326;11868.287902725864;11901.28592284431;12073.879261207276 23:28:59 INFO - PROCESS | 19165 | __end_tp_report 23:28:59 INFO - PROCESS | 19165 | __start_cc_report 23:28:59 INFO - PROCESS | 19165 | _x_x_mozilla_cycle_collect,337 23:28:59 INFO - PROCESS | 19165 | __end_cc_report 23:28:59 INFO - PROCESS | 19165 | __startTimestamp1463725739752__endTimestamp 23:28:59 INFO - PROCESS | 19165 | 23:28:59 INFO - PROCESS | 19165 | ------- Summary: start ------- 23:28:59 INFO - PROCESS | 19165 | Number of tests: 6 23:28:59 INFO - PROCESS | 19165 | 23:28:59 INFO - PROCESS | 19165 | [#0] dojo.html Cycles:165 Average:5397.73 Median:5663.21 stddev:620.52 (11.0%) stddev-sans-first:597.14 23:28:59 INFO - PROCESS | 19165 | Values: 3162.7 3163.9 3188.6 3195.4 3209.5 5292.8 5312.2 5322.9 5352.4 5413.3 5206.0 5294.3 5311.4 5335.9 5368.6 4837.6 4860.0 4908.8 4993.3 5051.2 4908.9 4920.2 4957.0 4997.5 5039.4 4995.2 5003.9 5006.9 5007.6 5051.6 4868.6 4917.8 4935.5 4948.1 4956.7 4887.0 4889.1 4900.2 4903.5 4928.8 5132.7 5232.1 5240.7 5253.1 5289.6 5663.2 5731.8 5736.0 5747.7 5779.0 5803.3 5880.2 5882.1 5882.7 5894.2 5453.9 5471.0 5473.8 5502.9 5516.5 5957.0 5976.2 5989.5 5990.8 6028.6 5778.3 5800.8 5804.1 5807.9 5809.1 5683.9 5718.4 5732.9 5747.8 5893.1 5781.5 5784.7 5787.4 5793.8 5813.0 5759.7 5764.4 5784.8 5799.0 5804.9 4340.2 4379.4 4393.1 4398.7 4423.0 3853.5 3893.9 3919.4 3949.6 3978.9 5574.5 5582.5 5585.2 5596.2 5601.4 5724.1 5752.2 5760.8 5770.5 5781.9 5418.1 5432.2 5495.7 5497.6 5555.5 4970.7 4978.9 4986.0 4997.2 5020.7 5940.0 5942.1 5947.0 5975.7 6014.8 5848.1 5849.2 5850.7 5862.0 5865.4 6041.0 6043.1 6045.7 6047.8 6049.0 5613.0 5731.9 5746.8 5783.6 5817.4 5834.0 5836.8 5843.6 5868.2 5879.2 5585.6 5724.9 5731.3 5737.9 5780.0 5733.6 5780.5 5793.9 5803.0 5831.5 5663.6 5666.5 5671.1 5672.4 5694.6 5620.7 5691.5 5803.2 5824.9 5853.7 5547.3 5601.7 5616.6 5650.0 5696.0 23:28:59 INFO - PROCESS | 19165 | 23:28:59 INFO - PROCESS | 19165 | [#1] ext.html Cycles:180 Average:60395.95 Median:4160.39 stddev:125510.63 (3016.8%) stddev-sans-first:125782.36 23:28:59 INFO - PROCESS | 19165 | Values: 576.9 627.4 641.9 656.9 668.4 39027.0 43299.0 43368.3 43402.3 43448.6 43152.6 43443.1 43545.6 43553.6 43647.1 8725.3 8899.8 8910.9 8914.6 8928.0 8745.5 8869.3 8869.7 8871.7 8878.2 8857.1 8926.1 8935.5 8939.6 8943.7 8860.4 8874.6 8901.9 8907.6 8920.2 8816.8 8887.5 8922.3 8923.6 8954.1 33121.7 41383.8 41673.6 41742.8 41828.6 3247.9 3334.3 3344.0 3732.3 3938.6 31628.0 31694.4 31821.7 32058.8 32183.7 4034.9 4139.6 4158.7 4162.0 4167.9 299656.0 299766.0 299771.0 299982.0 301062.0 35081.8 35167.0 35383.0 35386.0 35455.0 36430.0 36668.8 36686.3 37051.8 37389.6 16662.8 16777.5 16939.2 16967.7 16973.1 12825.2 12913.7 12926.4 12927.9 12933.9 20017.6 20314.1 20343.2 20459.5 20492.7 7353.0 7357.5 7445.9 7476.4 7487.1 906.7 998.9 1089.2 1097.4 1113.1 31310.4 32914.2 33543.8 33551.0 33662.2 1111.2 1118.7 1144.4 1190.1 1213.2 17302.6 17507.6 17517.6 17592.8 17717.6 606131.0 606505.0 609199.0 611420.0 612535.0 60553.7 61713.4 62033.4 62223.7 62262.4 1363.0 1397.1 1420.1 1420.4 1424.0 30680.5 32282.7 32759.5 32816.5 33128.5 52326.5 52477.0 52712.7 52742.0 52988.0 451092.0 451300.0 451538.0 451901.0 451950.0 28462.4 28998.9 29219.6 29247.1 29455.4 48621.8 49500.8 49622.3 49943.5 50086.5 41824.0 42043.6 42139.0 42589.0 42959.8 41984.0 42915.8 43248.0 43304.0 43565.1 41158.8 41378.4 41950.8 42276.2 42454.4 36458.3 37775.6 37818.6 37968.0 38852.0 28501.3 28799.1 29000.4 29003.9 29075.6 23:28:59 INFO - PROCESS | 19165 | 23:28:59 INFO - PROCESS | 19165 | [#2] jquery.html Cycles:180 Average:28940.66 Median:2254.68 stddev:81305.37 (3606.1%) stddev-sans-first:81505.16 23:28:59 INFO - PROCESS | 19165 | Values: 377.7 381.0 384.1 401.7 407.2 17692.8 19545.1 19644.2 19685.3 19709.2 18162.7 18209.0 18252.0 18556.4 18794.4 5614.0 5684.3 5802.2 5927.2 5933.3 5693.2 5712.5 5736.3 5774.3 5776.9 5265.8 5553.7 5669.1 5702.3 5706.4 5490.8 5557.0 5572.6 5617.0 5631.1 5567.2 5617.8 5623.9 5628.0 5640.1 12458.4 12727.1 12782.2 13057.1 13322.7 2169.8 2192.0 2193.5 2243.1 2266.2 9773.5 9862.6 9942.6 10051.1 10051.2 1872.2 1958.8 2006.6 2032.6 2049.5 79270.5 79586.6 79777.6 82096.0 84463.6 8897.7 9354.9 9489.5 9914.3 10556.7 12541.1 12614.4 12623.2 12673.0 12687.6 7460.9 7640.1 7704.1 7735.4 7744.7 7669.9 7727.2 7802.5 7894.0 7929.1 3963.0 3986.4 4008.3 4051.3 4052.8 1799.2 1842.9 1900.4 1945.3 1969.1 983.2 1008.2 1022.6 1082.4 1103.0 19195.0 19775.2 19942.9 20036.1 20042.5 994.8 996.4 1018.5 1029.6 1030.2 10586.9 10850.3 11000.3 11016.7 11029.9 482372.0 488943.0 489207.0 490558.0 505070.0 97147.0 97699.0 102056.0 102321.5 106039.0 1044.7 1048.2 1074.1 1082.1 1099.2 17727.0 17736.2 17983.5 18131.0 18397.0 42484.7 43521.8 43660.6 44389.6 45056.3 57186.4 58736.0 59432.0 59759.0 60416.0 8273.4 8443.4 8523.7 8620.8 8769.6 13054.7 13531.9 13548.4 13653.5 13763.0 10951.9 11074.9 11110.0 11261.4 11549.6 11648.6 11784.5 11899.9 12229.9 12245.4 11452.3 11565.5 11809.8 11953.7 12146.7 8474.9 8543.2 8551.5 8823.6 9011.7 8564.0 11678.9 11766.4 11835.1 11994.6 23:28:59 INFO - PROCESS | 19165 | 23:28:59 INFO - PROCESS | 19165 | [#3] mootools.html Cycles:180 Average:5832.95 Median:4715.72 stddev:3352.07 (71.1%) stddev-sans-first:3345.91 23:28:59 INFO - PROCESS | 19165 | Values: 1534.2 1563.2 1698.8 1759.6 1812.0 7624.5 8489.9 8599.6 9168.4 9176.4 8738.7 8997.1 9054.5 9083.6 9085.9 2364.0 2389.1 2394.7 2401.9 2412.5 2286.9 2313.1 2346.2 2347.5 2349.8 2311.4 2314.4 2326.2 2340.7 2357.0 2268.9 2287.9 2302.0 2306.7 2318.4 2281.4 2290.0 2300.2 2303.7 2308.5 8613.5 8704.5 8714.7 8718.2 8736.0 5249.7 5333.7 5339.8 5364.0 5368.6 3275.7 3307.9 3439.6 3453.2 3530.6 1031.7 1050.4 1058.4 1067.5 1073.5 12196.1 12197.6 12220.9 12236.9 12240.3 4475.6 4688.4 4743.0 4796.0 4820.9 10406.6 10494.8 10506.5 10556.9 10594.3 5231.7 5235.1 5252.4 5256.0 5257.5 4268.0 4817.2 4849.8 4933.6 4987.3 4127.4 4128.8 4199.0 4221.9 4224.6 1258.8 1270.9 1294.1 1311.4 1312.5 938.5 947.4 953.0 959.9 973.1 5684.7 5790.7 5808.1 5935.8 5973.6 461.6 477.4 983.5 1065.9 1071.6 3800.5 3861.6 3929.7 3930.3 3947.1 10827.1 11020.9 11056.5 11154.5 11165.5 11044.9 11087.9 11097.8 11102.2 11150.8 8300.1 8368.7 8489.2 8550.8 8590.1 5571.3 5594.7 5668.2 5704.3 5731.6 10201.3 10309.3 10420.2 10451.5 10452.1 10141.2 10473.8 10667.3 10669.5 10738.4 6824.8 7210.7 7211.5 7465.8 7565.2 8719.4 8746.4 8747.7 8767.0 8839.3 7564.5 7724.9 7837.7 7981.0 8141.8 7706.8 7805.4 7858.5 7929.9 7930.9 7110.6 7121.4 7211.1 7260.3 7289.2 4876.5 4925.5 5036.1 5078.9 5101.0 4993.2 5046.4 5102.3 5120.0 5130.9 23:28:59 INFO - PROCESS | 19165 | 23:28:59 INFO - PROCESS | 19165 | [#4] prototype.html Cycles:180 Average:4816.01 Median:5451.13 stddev:1440.40 (26.4%) stddev-sans-first:1404.16 23:28:59 INFO - PROCESS | 19165 | Values: 309.2 319.4 319.9 321.7 326.2 5434.6 5600.6 5722.6 5731.0 5751.6 5505.0 5526.0 5540.9 5549.9 5614.9 4336.2 4372.0 4373.9 4384.0 4393.7 4054.7 4270.9 4271.9 4314.1 4323.2 4172.6 4199.1 4205.0 4207.8 4248.9 4239.0 4244.2 4281.1 4290.7 4325.1 3512.5 3727.0 3740.9 3744.6 3750.6 5410.6 5478.3 5483.7 5507.5 5515.7 4850.6 4888.6 4896.7 4901.0 4907.6 5503.9 5832.4 5864.2 5885.6 5904.8 4051.8 4126.4 4143.7 4152.5 4152.8 6088.3 6123.8 6129.3 6138.4 6210.5 4114.6 4213.6 4238.7 4241.6 4248.5 4270.5 4286.3 4287.7 4294.7 4299.5 4891.3 4930.6 4981.8 4987.6 4993.5 5879.9 5987.0 5991.6 6010.6 6050.8 1434.4 1445.7 1456.1 1460.6 1462.2 884.7 916.8 920.4 928.8 932.3 5012.8 5061.5 5099.7 5122.5 5137.1 5334.6 5349.5 5364.3 5424.7 5497.6 4900.5 4990.1 5018.3 5089.9 5123.2 2895.6 2896.6 2940.9 2957.5 2966.2 5438.9 5516.9 5525.8 5561.3 5578.2 5250.8 5419.9 5457.9 5568.4 5580.6 5541.3 5575.2 5619.4 5638.0 5677.3 5381.9 5444.3 5460.8 5480.8 5805.7 6061.2 6072.6 6097.1 6111.4 6112.1 6042.6 6348.8 6377.4 6400.0 6422.3 4073.4 4220.1 4226.1 4237.2 4239.6 6026.8 6054.8 6100.5 6148.5 6190.7 5792.9 5856.9 5884.7 5918.2 6020.4 5854.9 5860.4 5941.5 5944.9 5947.1 5761.5 5762.6 5774.3 5793.2 5873.4 5782.7 6078.6 6116.3 6118.7 6146.2 5878.6 5919.6 5926.9 5935.5 5973.8 23:28:59 INFO - PROCESS | 19165 | 23:28:59 INFO - PROCESS | 19165 | [#5] yui.html Cycles:180 Average:16970.09 Median:4878.67 stddev:21193.57 (434.4%) stddev-sans-first:21218.34 23:28:59 INFO - PROCESS | 19165 | Values: 822.8 850.9 853.7 857.9 883.9 14620.3 14708.9 14821.3 14930.2 14967.5 14873.8 15117.1 15435.8 15722.0 15785.1 658.3 664.2 684.1 689.0 690.7 657.5 781.8 801.0 805.4 814.5 853.8 856.0 859.1 860.1 860.8 840.3 847.3 847.5 850.0 851.8 608.0 609.3 610.0 612.3 612.8 14768.3 14771.3 14789.1 14815.1 14878.2 14156.9 14264.2 14286.8 14376.0 14416.8 11672.7 11679.0 11729.9 11768.6 11843.6 3744.7 3766.2 3812.7 3827.3 3916.6 61189.4 61327.0 61474.0 61476.7 62201.4 10813.9 11046.8 11062.5 11245.0 11525.7 19477.3 19477.4 19489.3 19503.0 19570.2 7965.3 8051.6 8055.3 8179.6 8422.2 4761.2 4780.1 4806.6 4808.4 4922.8 3223.8 3332.7 3340.1 3347.0 3358.0 605.6 610.3 613.8 625.0 636.2 680.0 746.9 770.2 775.8 790.3 8853.3 9099.7 9206.4 9337.1 9390.2 697.3 725.7 762.9 769.8 769.9 4615.2 4856.1 4901.2 4922.3 4940.7 77849.0 77867.6 78341.0 79288.0 79898.0 67226.7 68972.0 70003.6 70084.6 70216.0 61454.0 61670.4 61752.0 62593.0 63094.0 9128.1 9386.0 9605.7 9632.2 9722.9 41152.2 41439.4 41842.4 41859.4 42798.8 54792.2 54935.0 55163.2 55596.0 55721.4 11607.9 11883.7 12575.2 12709.4 12761.7 13375.9 14044.1 14230.6 14746.3 14965.6 12194.1 12891.6 13282.3 13284.1 13367.7 13447.4 13449.2 13525.3 13577.2 13668.5 13671.3 13770.0 14018.6 14023.5 14076.2 11025.2 11274.6 11415.2 11632.8 11857.5 11280.3 11758.2 11868.3 11901.3 12073.9 23:28:59 INFO - PROCESS | 19165 | -------- Summary: end -------- 23:28:59 INFO - PROCESS | 19165 | 23:28:59 INFO - PROCESS | 19165 | 23:28:59 INFO - PROCESS | 19165 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2C0042,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 23:28:59 INFO - PROCESS | 19165 | 23:28:59 INFO - PROCESS | 19165 | 23:28:59 INFO - PROCESS | 19165 | ###!!! [Child][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 23:28:59 INFO - PROCESS | 19165 | 23:29:00 INFO - TEST-INFO | 19165: exit 0 23:29:00 INFO - TEST-OK | dromaeo_css | took 1111838ms 23:29:00 INFO - TEST-START | kraken 23:29:00 INFO - operating with platform_type : linux_ 23:29:00 INFO - Initialising browser for kraken test... 23:29:00 INFO - TEST-INFO | started process 19404 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRZtvTe/profile http://localhost:46162/getInfo.html) 23:29:04 INFO - PROCESS | 19404 | 23:29:04 INFO - PROCESS | 19404 | (process:19472): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:29:05 INFO - PROCESS | 19404 | __metrics Screen width/height:1600/1200 23:29:05 INFO - PROCESS | 19404 | colorDepth:24 23:29:05 INFO - PROCESS | 19404 | Browser inner width/height: 1024/697 23:29:05 INFO - PROCESS | 19404 | __metrics 23:29:06 ERROR - PROCESS | 19404 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 23:29:07 INFO - TEST-INFO | 19404: exit 0 23:29:07 INFO - Browser initialized. 23:29:07 INFO - Running cycle 1/1 for kraken test... 23:29:07 INFO - TEST-INFO | started process 19523 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRZtvTe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:29:09 INFO - PROCESS | 19523 | 23:29:09 INFO - PROCESS | 19523 | (process:19585): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:29:19 INFO - PROCESS | 19523 | RSS: Main: 164237312 23:29:19 INFO - PROCESS | 19523 | 23:29:22 INFO - PROCESS | 19523 | Cycle 1(1): loaded http://localhost:46162/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46162/tests/kraken/driver.html?testName=audio-beat-detection) 23:29:22 INFO - PROCESS | 19523 | RSS: Main: 168828928 23:29:22 INFO - PROCESS | 19523 | 23:29:25 INFO - PROCESS | 19523 | Cycle 1(1): loaded http://localhost:46162/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46162/tests/kraken/driver.html?testName=audio-dft) 23:29:26 INFO - PROCESS | 19523 | RSS: Main: 169283584 23:29:26 INFO - PROCESS | 19523 | 23:29:29 INFO - PROCESS | 19523 | Cycle 1(1): loaded http://localhost:46162/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46162/tests/kraken/driver.html?testName=audio-fft) 23:29:29 INFO - PROCESS | 19523 | RSS: Main: 163917824 23:29:29 INFO - PROCESS | 19523 | 23:29:32 INFO - PROCESS | 19523 | Cycle 1(1): loaded http://localhost:46162/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46162/tests/kraken/driver.html?testName=audio-oscillator) 23:29:32 INFO - PROCESS | 19523 | RSS: Main: 163794944 23:29:32 INFO - PROCESS | 19523 | 23:29:34 INFO - PROCESS | 19523 | Cycle 1(1): loaded http://localhost:46162/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46162/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:29:35 INFO - PROCESS | 19523 | RSS: Main: 164261888 23:29:35 INFO - PROCESS | 19523 | 23:29:38 INFO - PROCESS | 19523 | Cycle 1(1): loaded http://localhost:46162/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46162/tests/kraken/driver.html?testName=imaging-darkroom) 23:29:39 INFO - PROCESS | 19523 | RSS: Main: 164622336 23:29:39 INFO - PROCESS | 19523 | 23:29:42 INFO - PROCESS | 19523 | Cycle 1(1): loaded http://localhost:46162/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46162/tests/kraken/driver.html?testName=imaging-desaturate) 23:29:43 INFO - PROCESS | 19523 | RSS: Main: 163319808 23:29:43 INFO - PROCESS | 19523 | 23:29:46 INFO - PROCESS | 19523 | Cycle 1(1): loaded http://localhost:46162/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46162/tests/kraken/driver.html?testName=json-parse-financial) 23:29:47 INFO - PROCESS | 19523 | RSS: Main: 164081664 23:29:47 INFO - PROCESS | 19523 | 23:29:48 INFO - PROCESS | 19523 | Cycle 1(1): loaded http://localhost:46162/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46162/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:29:49 INFO - PROCESS | 19523 | RSS: Main: 164151296 23:29:49 INFO - PROCESS | 19523 | 23:29:51 INFO - PROCESS | 19523 | Cycle 1(1): loaded http://localhost:46162/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46162/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:29:51 INFO - PROCESS | 19523 | RSS: Main: 164352000 23:29:51 INFO - PROCESS | 19523 | 23:29:54 INFO - PROCESS | 19523 | Cycle 1(1): loaded http://localhost:46162/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46162/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:29:54 INFO - PROCESS | 19523 | RSS: Main: 164614144 23:29:54 INFO - PROCESS | 19523 | 23:29:57 INFO - PROCESS | 19523 | Cycle 1(1): loaded http://localhost:46162/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46162/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:29:58 INFO - PROCESS | 19523 | RSS: Main: 164786176 23:29:58 INFO - PROCESS | 19523 | 23:30:00 INFO - PROCESS | 19523 | Cycle 1(1): loaded http://localhost:46162/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46162/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:30:01 INFO - PROCESS | 19523 | RSS: Main: 164958208 23:30:01 INFO - PROCESS | 19523 | 23:30:03 INFO - PROCESS | 19523 | Cycle 1(1): loaded http://localhost:46162/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46162/tests/kraken/driver.html?testName=ai-astar) 23:30:03 INFO - PROCESS | 19523 | RSS: Main: 166019072 23:30:03 INFO - PROCESS | 19523 | 23:30:03 INFO - PROCESS | 19523 | __start_tp_report 23:30:03 INFO - PROCESS | 19523 | _x_x_mozilla_page_load 23:30:03 INFO - PROCESS | 19523 | _x_x_mozilla_page_load_details 23:30:03 INFO - PROCESS | 19523 | |i|pagename|runs| 23:30:03 INFO - PROCESS | 19523 | |0;ai-astar;110;112;104;111;113;111;106;110;112;110 23:30:03 INFO - PROCESS | 19523 | |1;audio-beat-detection;157;129;154;209;127;156;164;130;178;131 23:30:03 INFO - PROCESS | 19523 | |2;audio-dft;162;162;162;162;161;176;164;166;163;164 23:30:03 INFO - PROCESS | 19523 | |3;audio-fft;74;74;74;157;78;76;76;74;170;76 23:30:03 INFO - PROCESS | 19523 | |4;audio-oscillator;92;93;185;92;93;101;152;92;93;154 23:30:03 INFO - PROCESS | 19523 | |5;imaging-gaussian-blur;117;117;117;118;119;118;117;118;118;119 23:30:03 INFO - PROCESS | 19523 | |6;imaging-darkroom;146;147;148;147;168;148;146;146;147;146 23:30:03 INFO - PROCESS | 19523 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 23:30:03 INFO - PROCESS | 19523 | |8;json-parse-financial;54;55;55;56;56;54;56;57;55;55 23:30:03 INFO - PROCESS | 19523 | |9;json-stringify-tinderbox;62;66;62;62;62;62;62;62;63;62 23:30:03 INFO - PROCESS | 19523 | |10;stanford-crypto-aes;79;81;78;79;84;85;80;79;142;80 23:30:03 INFO - PROCESS | 19523 | |11;stanford-crypto-ccm;128;121;122;128;125;119;129;131;146;120 23:30:03 INFO - PROCESS | 19523 | |12;stanford-crypto-pbkdf2;164;160;160;167;158;160;168;162;157;165 23:30:03 INFO - PROCESS | 19523 | |13;stanford-crypto-sha256-iterative;67;62;64;65;62;63;63;62;63;62 23:30:03 INFO - PROCESS | 19523 | __end_tp_report 23:30:03 INFO - PROCESS | 19523 | __start_cc_report 23:30:03 INFO - PROCESS | 19523 | _x_x_mozilla_cycle_collect,867 23:30:03 INFO - PROCESS | 19523 | __end_cc_report 23:30:03 INFO - PROCESS | 19523 | __startTimestamp1463725803384__endTimestamp 23:30:03 INFO - PROCESS | 19523 | 23:30:03 INFO - PROCESS | 19523 | ------- Summary: start ------- 23:30:03 INFO - PROCESS | 19523 | Number of tests: 14 23:30:03 INFO - PROCESS | 19523 | 23:30:03 INFO - PROCESS | 19523 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:2.81 (2.5%) stddev-sans-first:2.98 23:30:03 INFO - PROCESS | 19523 | Values: 110.0 112.0 104.0 111.0 113.0 111.0 106.0 110.0 112.0 110.0 23:30:03 INFO - PROCESS | 19523 | 23:30:03 INFO - PROCESS | 19523 | [#1] audio-beat-detection Cycles:10 Average:153.50 Median:156.50 stddev:26.18 (16.7%) stddev-sans-first:27.74 23:30:03 INFO - PROCESS | 19523 | Values: 157.0 129.0 154.0 209.0 127.0 156.0 164.0 130.0 178.0 131.0 23:30:03 INFO - PROCESS | 19523 | 23:30:03 INFO - PROCESS | 19523 | [#2] audio-dft Cycles:10 Average:164.20 Median:163.50 stddev:4.39 (2.7%) stddev-sans-first:4.59 23:30:03 INFO - PROCESS | 19523 | Values: 162.0 162.0 162.0 162.0 161.0 176.0 164.0 166.0 163.0 164.0 23:30:03 INFO - PROCESS | 19523 | 23:30:03 INFO - PROCESS | 19523 | [#3] audio-fft Cycles:10 Average:92.90 Median:75.00 stddev:37.36 (49.8%) stddev-sans-first:38.99 23:30:03 INFO - PROCESS | 19523 | Values: 74.0 74.0 74.0 157.0 78.0 76.0 76.0 74.0 170.0 76.0 23:30:03 INFO - PROCESS | 19523 | 23:30:03 INFO - PROCESS | 19523 | [#4] audio-oscillator Cycles:10 Average:114.70 Median:92.00 stddev:35.00 (38.0%) stddev-sans-first:36.14 23:30:03 INFO - PROCESS | 19523 | Values: 92.0 93.0 185.0 92.0 93.0 101.0 152.0 92.0 93.0 154.0 23:30:03 INFO - PROCESS | 19523 | 23:30:03 INFO - PROCESS | 19523 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.79 (0.7%) stddev-sans-first:0.78 23:30:03 INFO - PROCESS | 19523 | Values: 117.0 117.0 117.0 118.0 119.0 118.0 117.0 118.0 118.0 119.0 23:30:03 INFO - PROCESS | 19523 | 23:30:03 INFO - PROCESS | 19523 | [#6] imaging-darkroom Cycles:10 Average:148.90 Median:147.00 stddev:6.76 (4.6%) stddev-sans-first:7.08 23:30:03 INFO - PROCESS | 19523 | Values: 146.0 147.0 148.0 147.0 168.0 148.0 146.0 146.0 147.0 146.0 23:30:03 INFO - PROCESS | 19523 | 23:30:03 INFO - PROCESS | 19523 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 23:30:03 INFO - PROCESS | 19523 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 23:30:03 INFO - PROCESS | 19523 | 23:30:03 INFO - PROCESS | 19523 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.50 stddev:0.95 (1.7%) stddev-sans-first:0.88 23:30:03 INFO - PROCESS | 19523 | Values: 54.0 55.0 55.0 56.0 56.0 54.0 56.0 57.0 55.0 55.0 23:30:03 INFO - PROCESS | 19523 | 23:30:03 INFO - PROCESS | 19523 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:62.00 stddev:1.27 (2.0%) stddev-sans-first:1.33 23:30:03 INFO - PROCESS | 19523 | Values: 62.0 66.0 62.0 62.0 62.0 62.0 62.0 62.0 63.0 62.0 23:30:03 INFO - PROCESS | 19523 | 23:30:03 INFO - PROCESS | 19523 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:80.00 stddev:19.56 (24.5%) stddev-sans-first:20.55 23:30:03 INFO - PROCESS | 19523 | Values: 79.0 81.0 78.0 79.0 84.0 85.0 80.0 79.0 142.0 80.0 23:30:03 INFO - PROCESS | 19523 | 23:30:03 INFO - PROCESS | 19523 | [#11] stanford-crypto-ccm Cycles:10 Average:126.90 Median:128.00 stddev:7.89 (6.2%) stddev-sans-first:8.36 23:30:03 INFO - PROCESS | 19523 | Values: 128.0 121.0 122.0 128.0 125.0 119.0 129.0 131.0 146.0 120.0 23:30:03 INFO - PROCESS | 19523 | 23:30:03 INFO - PROCESS | 19523 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.10 Median:163.00 stddev:3.75 (2.3%) stddev-sans-first:3.92 23:30:03 INFO - PROCESS | 19523 | Values: 164.0 160.0 160.0 167.0 158.0 160.0 168.0 162.0 157.0 165.0 23:30:03 INFO - PROCESS | 19523 | 23:30:03 INFO - PROCESS | 19523 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:63.00 stddev:1.64 (2.6%) stddev-sans-first:1.05 23:30:03 INFO - PROCESS | 19523 | Values: 67.0 62.0 64.0 65.0 62.0 63.0 63.0 62.0 63.0 62.0 23:30:03 INFO - PROCESS | 19523 | -------- Summary: end -------- 23:30:03 INFO - PROCESS | 19523 | 23:30:04 INFO - TEST-INFO | 19523: exit 0 23:30:04 INFO - TEST-OK | kraken | took 64007ms 23:30:04 INFO - SUITE-END | took 1175s 23:30:04 INFO - Completed test suite (00:19:35) 23:30:04 INFO - javascript benchmark 23:30:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7179.707460096774, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3162.6837316268375, 3163.9242657496447, 3188.56954311168, 3195.440797860374, 3209.486482162853, 5292.814751483699, 5312.150055991042, 5322.893542129155, 5352.384475785286, 5413.323334583177, 5206.036883176605, 5294.285271488348, 5311.362636483617, 5335.893282134355, 5368.62419630626, 4837.564619184264, 4859.975700121512, 4908.803647854082, 4993.325901003354, 5051.166557518005, 4908.877278068041, 4920.237363208708, 4956.950430495703, 4997.525235102659, 5039.44566097729, 4995.200767877141, 5003.899922001558, 5006.949930500703, 5007.624428167884, 5051.621128415365, 4868.561829435333, 4917.7786999585105, 4935.481774413671, 4948.0846043481715, 4956.727379994099, 4886.987173406138, 4889.071076495455, 4900.215965445547, 4903.485134060944, 4928.778204980785, 5132.666376685504, 5232.084385232607, 5240.659357141773, 5253.0544501989625, 5289.629725919187, 5663.207150998822, 5731.77072917087, 5735.971320143414, 5747.655140691572, 5779.0, 5803.332616749043, 5880.176775251468, 5882.088276317178, 5882.735276912506, 5894.17481552583, 5453.890922181574, 5470.972645136749, 5473.8357849264585, 5502.862428439281, 5516.475934786189, 5956.970215148896, 5976.163337132805, 5989.520838332923, 5990.790322338785, 6028.577999540078, 5778.3354914184565, 5800.796972105956, 5804.129380592861, 5807.941920580824, 5809.128630705343, 5683.857903552444, 5718.428157184248, 5732.914006289909, 5747.770089196469, 5893.057110862242, 5781.508571771446, 5784.739686714108, 5787.421257874179, 5793.797217097465, 5813.0, 5759.740811663485, 5764.394738552392, 5784.797532086357, 5799.043157878987, 5804.88390232193, 4340.2187606230555, 4379.430674012358, 4393.0994146199955, 4398.670099742532, 4422.955770442319, 3853.537575490903, 3893.929169478416, 3919.353306704362, 3949.6445319921345, 3978.920421591552, 5574.526165275915, 5582.525485333792, 5585.1901474286005, 5596.160575913564, 5601.439856014366, 5724.055530837449, 5752.223449834302, 5760.798372056958, 5770.538356931435, 5781.88436231273, 5418.078926582491, 5432.158015507603, 5495.670259784346, 5497.5601951843755, 5555.527780138734, 4970.65205435616, 4978.90042199154, 4986.0277245936695, 4997.175466048134, 5020.698758074527, 5940.0, 5942.078977758454, 5947.048472244506, 5975.701214939236, 6014.849628759229, 5848.064309710596, 5849.239598852207, 5850.707464626837, 5862.0, 5865.384134665798, 6041.0, 6043.123747056564, 6045.667488288011, 6047.818565443044, 6049.0, 5612.971935140462, 5731.942680573307, 5746.827595171984, 5783.566232532661, 5817.389174136655, 5833.970830145822, 5836.766529338779, 5843.620164689281, 5868.178455016387, 5879.176915231957, 5585.581081418829, 5724.914126288026, 5731.283589551306, 5737.942620573741, 5779.959607270732, 5733.569982251432, 5780.537556995514, 5793.9420605795085, 5803.013487707184, 5831.475167234969, 5663.631863928831, 5666.46168613981, 5671.064274394678, 5672.404397538199, 5694.629849059798, 5620.690862002629, 5691.459311365414, 5803.216565763568, 5824.912626310694, 5853.707314634336, 5547.278853748987, 5601.691906945157, 5616.550675945833, 5649.971750141223, 5696.0316746154085], "value": 5355.560600904062, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.8875069361476, 627.4478458956117, 641.871625674865, 656.8587753632969, 668.3817468841321, 39027.0, 43299.0, 43368.3494747579, 43402.34896476555, 43448.565514344846, 43152.568474315245, 43443.13113737723, 43545.56454435454, 43553.564464355346, 43647.127057458914, 8725.345599080063, 8899.822003559924, 8910.910890891073, 8914.55427228636, 8928.0, 8745.4752714837, 8869.290456763476, 8869.68956086537, 8871.733847984538, 8878.156575125386, 8857.070007649201, 8926.107389261088, 8935.463872167658, 8939.64241430342, 8943.731688049369, 8860.379773415863, 8874.600642971049, 8901.866472002925, 8907.599158037903, 8920.152585504398, 8816.779580510474, 8887.466751994836, 8922.330825188072, 8923.643054277885, 8954.059823718546, 33121.668783312096, 41383.793081034404, 41673.583264167275, 41742.79128604368, 41828.58171418277, 3247.9025629230923, 3334.333133373335, 3344.0469466202258, 3732.346839303111, 3938.5667576566557, 31628.0, 31694.366112677846, 31821.681783182103, 32058.839705801554, 32183.6781632183, 4034.8789536313666, 4139.648129908961, 4158.7296825706235, 4162.042730172077, 4167.937480937789, 299656.0, 299766.0, 299771.0, 299982.0, 301061.9999999978, 35081.82459087688, 35167.0, 35383.0, 35386.0, 35455.0, 36430.0, 36668.81665591655, 36686.26627467489, 37051.81474092612, 37389.626103738614, 16662.83337166613, 16777.496675099523, 16939.153042347833, 16967.660646786993, 16973.066481343398, 12825.230486170673, 12913.677158071123, 12926.353682315847, 12927.935360323138, 12933.935330323477, 20017.59964800696, 20314.085866135763, 20343.186272548934, 20459.488512787, 20492.69260961087, 7352.96323518379, 7357.484976051732, 7445.85108297831, 7476.401887848959, 7487.1389790173735, 906.6962567539948, 998.9250806189565, 1089.1613457637575, 1097.3635291530893, 1113.1373185781085, 31310.37379252448, 32914.17714557108, 33543.83228083893, 33551.0, 33662.158446039044, 1111.1610733895857, 1118.6588090632436, 1144.3820337018083, 1190.14309697018, 1213.1568559850818, 17302.567435814206, 17507.56231094233, 17517.64964700724, 17592.824071759376, 17717.557061073578, 606131.0, 606505.0, 609199.0, 611420.0, 612535.0, 60553.69723151356, 61713.38286617166, 62033.37966620366, 62223.6888815553, 62262.37737622566, 1362.9591112266648, 1397.0849093843347, 1420.0769499825196, 1420.4318272691007, 1423.9857601423853, 30680.539791902695, 32282.677173227967, 32759.508607371386, 32816.50775238326, 33128.50307245441, 52326.47673523216, 52477.0, 52712.73643631757, 52742.0, 52988.0, 451092.0, 451300.0, 451538.0, 451901.0, 451950.0, 28462.430751384443, 28998.85500572568, 29219.561706573993, 29247.122586322443, 29455.410891782474, 48621.756891215315, 49500.75249623729, 49622.25566616576, 49943.50056499388, 50086.499135008184, 41824.0, 42043.57956420397, 42139.0, 42589.0, 42959.78520107379, 41984.0, 42915.785421073946, 43248.0, 43304.0, 43565.12869742524, 41158.794206028775, 41378.37932430956, 41950.79024604857, 42276.15447690967, 42454.363184551636, 36458.27083458369, 37775.62224377721, 37818.62181378151, 37968.0, 38852.0, 28501.287467813472, 28799.13602591842, 29000.41999159963, 29003.854980724962, 29075.563866541597], "value": 19849.809746451538, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.70538979595926, 380.9656089249131, 384.0609709260857, 401.7087611481674, 407.2059484006187, 17692.82307176928, 19545.12046957887, 19644.21423143076, 19685.31101411449, 19709.211631534738, 18162.727559086623, 18209.0, 18252.0, 18556.44330670079, 18794.43616691498, 5613.971930140344, 5684.346300175471, 5802.158686990384, 5927.2294601701715, 5933.317668468117, 5693.202951586781, 5712.457316554921, 5736.3403208631125, 5774.335951365605, 5776.855578610526, 5265.815696450625, 5553.694546799924, 5669.0646043402785, 5702.344230413514, 5706.429357064302, 5490.752916118744, 5557.0, 5572.58205634577, 5616.971915140439, 5631.099024156136, 5567.164925261202, 5617.775288988436, 5623.915641265385, 5628.043232650419, 5640.097584386478, 12458.377081145996, 12727.109102362838, 12782.169159004636, 13057.086003979724, 13322.73354532904, 2169.8372622053407, 2191.9780802191935, 2193.4954960359046, 2243.1363924888874, 2266.218154736613, 9773.462459564722, 9862.60549578016, 9942.602295908155, 10051.095401413835, 10051.24615653829, 1872.241742094454, 1958.7551556055494, 2006.6488364536149, 2032.6239645665598, 2049.5081180516568, 79270.47987162347, 79586.60206698987, 79777.60111199407, 82096.0, 84463.5776821118, 8897.688580899638, 9354.877414710143, 9489.478078705599, 9914.305998580174, 10556.671764576487, 12541.122121451594, 12614.432350544248, 12623.179493332904, 12673.0, 12687.619371418872, 7460.850782984418, 7640.121386040565, 7704.075510938723, 7735.381169506426, 7744.6514906829325, 7669.923300767033, 7727.150013498511, 7802.492837965628, 7893.960530197312, 7929.1277959424415, 3962.9603703963166, 3986.4418981342637, 4008.2985477541897, 4051.331530297468, 4052.8176232069627, 1799.190364336054, 1842.907854607291, 1900.372876950603, 1945.319138301583, 1969.1040576537928, 983.233078199006, 1008.2035192198229, 1022.6471867205802, 1082.377632861108, 1102.990763451449, 19195.0, 19775.18074675652, 19942.90028549848, 20036.098375573136, 20042.498937526678, 994.796066806303, 996.4220751963844, 1018.4754851251612, 1029.583018877356, 1030.2273295028729, 10586.89413105859, 10850.2667162883, 11000.284981476178, 11016.669499915015, 11029.889701102886, 482372.0, 488943.0, 489207.0, 490558.0, 505070.0, 97147.0, 97699.023009769, 102056.0, 102321.48839255756, 106039.0, 1044.749260177567, 1048.2138396202847, 1074.1245884604023, 1082.118073769875, 1099.2470157941675, 17727.0, 17736.2018709161, 17983.460496185136, 18131.0, 18397.0, 42484.65337625717, 43521.78239108784, 43660.56339436692, 44389.55610443854, 45056.324155138354, 57186.42813571811, 58736.0, 59432.0, 59759.0, 60416.0, 8273.379496537664, 8443.408961372645, 8523.701670441505, 8620.827583448421, 8769.649214031368, 13054.738905222031, 13531.864681353061, 13548.390322435711, 13653.453861845415, 13763.0, 10951.945240274066, 11074.889251107386, 11110.0, 11261.436928153396, 11549.595764148215, 11648.592299269485, 11784.528618855149, 11899.881001189877, 12229.87770122323, 12245.448954797233, 11452.271453164549, 11565.537378504765, 11809.82285265739, 11953.701157471132, 12146.696332591757, 8474.872876906727, 8543.188397102265, 8551.486910785372, 8823.558822059, 9011.684591039544, 8564.01513825918, 11678.88321116778, 11766.411679416165, 11835.053195744493, 11994.64016079519], "value": 8971.64568975331, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1534.2098819108155, 1563.2027665890396, 1698.7706659600958, 1759.6128851652632, 1811.999999999999, 7624.466287359887, 8489.91510084899, 8599.570021498923, 9168.404053736502, 9176.449413035223, 8738.73783786486, 8997.145271199242, 9054.456732596049, 9083.591238394272, 9085.863712044325, 2363.988180059106, 2389.0563227525117, 2394.7006624171977, 2401.86789726565, 2412.49337639096, 2286.9085236590518, 2313.0516488239823, 2346.1788374069024, 2347.507023525062, 2349.7885190332954, 2311.3759284993043, 2314.4098254944965, 2326.1742081561056, 2340.695709557755, 2356.9882150589224, 2268.875211863347, 2287.8741669208353, 2301.9539609207804, 2306.7116610423695, 2318.374039009458, 2281.3726225288015, 2290.0, 2300.1949317738827, 2303.7120359955006, 2308.5382923415386, 8613.526256055915, 8704.477731336077, 8714.738557843275, 8718.17177368149, 8736.039035706131, 5249.711265880375, 5333.706646134461, 5339.786408543654, 5363.973180134113, 5368.570514358842, 3275.6888095630875, 3307.914725314235, 3439.570053743282, 3453.2057626745736, 3530.6116327203986, 1031.6543957774154, 1050.4117694091333, 1058.4496062047692, 1067.4502631144967, 1073.5330131392868, 12196.085293603015, 12197.634070977885, 12220.877791222063, 12236.877631223751, 12240.265584064984, 4475.641948644101, 4688.437387513521, 4743.0, 4795.95204047962, 4820.8794780130775, 10406.5837366506, 10494.790104197873, 10506.474676266156, 10556.894431055745, 10594.258401911793, 5231.71225582589, 5235.110031294689, 5252.448492908266, 5256.0, 5257.526822585985, 4267.957320426818, 4817.229243321051, 4849.806007759721, 4933.58064564516, 4987.276844857548, 4127.422160897477, 4128.772917489567, 4198.979005105016, 4221.915561688749, 4224.640905523003, 1258.811178323259, 1270.8665590112905, 1294.1264646363668, 1311.3639884655934, 1312.5078095714107, 938.5260443476001, 947.3747326764441, 953.046953046953, 959.8560215967522, 973.0561355485167, 5684.687342196219, 5790.739416726257, 5808.07070868659, 5935.7625694972585, 5973.581849270597, 461.6122457136022, 477.4461624515545, 983.4885859353096, 1065.898739619735, 1071.6410002649045, 3800.467934489174, 3861.555921069113, 3929.724919255682, 3930.272899513599, 3947.111899822517, 10827.133829293638, 11020.889791102147, 11056.502457389437, 11154.498047587878, 11165.497552610152, 11044.944775276072, 11087.889121108847, 11097.778044439066, 11102.167337449724, 11150.832737508943, 8300.12848650883, 8368.665253389918, 8489.151084891584, 8550.786230344167, 8590.098039705867, 5571.303587051619, 5594.720263986866, 5668.206451096932, 5704.258446401941, 5731.598788084794, 10201.336913100624, 10309.329893556895, 10420.166386689198, 10451.529681164518, 10452.059314661718, 10141.239407044648, 10473.842892356468, 10667.306625069346, 10669.46652667379, 10738.40938748345, 6824.829379265359, 7210.747623833141, 7211.459140564374, 7465.813354666177, 7565.167831538636, 8719.38964272495, 8746.431481953907, 8747.737567872973, 8766.956165219133, 8839.337049721426, 7564.4704870658525, 7724.884126737991, 7837.725679601187, 7981.0, 8141.755747327589, 7706.807329816799, 7805.414593905366, 7858.528488290721, 7929.881051784112, 7930.881036784568, 7110.644467776487, 7121.394681452135, 7211.134663840373, 7260.346568808833, 7289.1981881994, 4876.536729010738, 4925.48282430354, 5036.093503169464, 5078.873028174326, 5101.0308041472, 4993.151164302005, 5046.419661738947, 5102.260172274925, 5120.0, 5130.948690513047], "value": 4638.636479936263, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.16987887522004, 319.39315300928234, 319.928016196356, 321.6686812583039, 326.186165517035, 5434.592405569579, 5600.5799565032585, 5722.599418040739, 5730.9713451432735, 5751.56863235258, 5505.03661859174, 5526.0, 5540.944590554093, 5549.861253468665, 5614.859628509289, 4336.21948049351, 4371.978140109295, 4373.868783936471, 4383.999999999984, 4393.670474714393, 4054.6553542948736, 4270.893227669302, 4271.893202669942, 4314.1371725654835, 4323.200207961521, 4172.624463798257, 4199.139176468817, 4204.978975105136, 4207.768572728499, 4248.851290204843, 4238.961454443681, 4244.151169766059, 4281.143771245747, 4290.742555446652, 4325.13497300538, 3512.4731290306404, 3727.0, 3740.8590379934108, 3744.6255374462608, 3750.5686846012513, 5410.594205434608, 5478.315210598676, 5483.725813709299, 5507.504324610764, 5515.7242137892945, 4850.611951043908, 4888.584470320027, 4896.730679812609, 4901.0, 4907.607391408679, 5503.9174412383845, 5832.445917637818, 5864.208331875185, 5885.588008839383, 5904.793332233394, 4051.8176682049084, 4126.401671757609, 4143.70994030418, 4152.484343214735, 4152.8131234094535, 6088.299845517734, 6123.785667501616, 6129.264488261392, 6138.355472675349, 6210.50315974721, 4114.5679703630685, 4213.599708027732, 4238.703290769617, 4241.575842415734, 4248.532661407243, 4270.50889147752, 4286.335617979218, 4287.721298115613, 4294.656427485794, 4299.527052024275, 4891.26631005352, 4930.556249937523, 4981.750912454363, 4987.62592805541, 4993.50064993505, 5879.941200588025, 5987.0, 5991.64050156992, 6010.609310394811, 6050.848728781815, 1434.419060280588, 1445.6964037552023, 1456.1263242054895, 1460.5618314505605, 1462.151951867914, 884.712468447757, 916.7937214126769, 920.4431319052011, 928.758522784081, 932.3054324528134, 5012.774425150804, 5061.519155680205, 5099.674084737921, 5122.538971492583, 5137.073597400975, 5334.5732341412595, 5349.502139400974, 5364.310242273671, 5424.674519528841, 5497.615166938356, 4900.460949295574, 4990.10178167926, 5018.272350509155, 5089.923651145235, 5123.182249762615, 2895.609092772491, 2896.5799959005826, 2940.8823647053878, 2957.497225471675, 2966.1991262359043, 5438.91841622376, 5516.889662206733, 5525.834224973257, 5561.277033985637, 5578.191162281528, 5250.842474725764, 5419.891602167934, 5457.908418316273, 5568.415316391802, 5580.637258578179, 5541.27963364768, 5575.247341608912, 5619.353774316006, 5638.04153293941, 5677.318721753333, 5381.865453363697, 5444.346678398618, 5460.781568737365, 5480.835574932758, 5805.680687562056, 6061.212042434456, 6072.574919755575, 6097.146399504161, 6111.449969502766, 6112.144299797943, 6042.6101996540165, 6348.809535713936, 6377.426031657174, 6400.0, 6422.293547709654, 4073.3889916512762, 4220.134872351099, 4226.112516371596, 4237.152569486177, 4239.554846741048, 6026.849328766816, 6054.788082417094, 6100.5292856393235, 6148.538859585459, 6190.721417536131, 5792.913106303493, 5856.862245280357, 5884.705764711662, 5918.230630018243, 6020.367861374492, 5854.882902341844, 5860.446981549978, 5941.514621344664, 5944.881102377842, 5947.137665038632, 5761.5102716269585, 5762.625429347079, 5774.2782152230975, 5793.246877905845, 5873.355460471075, 5782.739776710142, 6078.635281883101, 6116.2660480740815, 6118.663473509, 6146.200993870768, 5878.559108066826, 5919.556033297606, 5926.851828704317, 5935.465808077293, 5973.820785376446], "value": 4345.70537723824, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [822.8148666550026, 850.8893843800313, 853.6841368693584, 857.8627419612861, 883.9425437346572, 14620.34208460619, 14708.852911470882, 14821.333040013198, 14930.178840163786, 14967.47613833516, 14873.776893346581, 15117.092974421543, 15435.768463473029, 15722.0, 15785.05289682617, 658.2758965138357, 664.186371694675, 684.1448189762797, 689.0387908867127, 690.7237105157927, 657.4805903336382, 781.847539729753, 800.9919900800976, 805.3677862877643, 814.5153633588005, 853.8206976534935, 855.9743207703779, 859.1194026123211, 860.0754189246554, 860.8063185783211, 840.3319361107934, 847.3433089355768, 847.4745657692271, 849.9617517211709, 851.7615067781031, 607.9513638908877, 609.3206075226135, 610.0391882784587, 612.3417326374166, 612.7518355066205, 14768.335424905905, 14771.261436928111, 14789.11265324084, 14815.111093334326, 14878.181700006495, 14156.85843141576, 14264.215468149248, 14286.785698214535, 14376.0, 14416.783748243784, 11672.708182295426, 11679.0, 11729.882701172965, 11768.588099416565, 11843.644690659294, 3744.700423966076, 3766.152615661454, 3812.7331086823933, 3827.3302172120048, 3916.5887581803786, 61189.38810611926, 61327.0, 61474.0, 61476.69261653663, 62201.37798622001, 10813.891861081289, 11046.779064418828, 11062.502187401426, 11245.044171245372, 11525.654230373102, 19477.318293859647, 19477.415677529698, 19489.317873874345, 19503.024848757505, 19570.21719131219, 7965.322947549524, 8051.557164356017, 8055.275025247639, 8179.550124743197, 8422.157784221528, 4761.214399624093, 4780.139574876486, 4806.567408933212, 4808.35087263222, 4922.827701030518, 3223.8065716057113, 3332.683395077464, 3340.1148695595684, 3346.983265083708, 3357.983210083934, 605.6396444115744, 610.2798697536861, 613.7821073518836, 625.0156004293257, 636.1729751323354, 679.9932000680029, 746.895434639151, 770.2066871122753, 775.8138046868823, 790.3282210121466, 8853.335999799912, 9099.727008189764, 9206.401583897024, 9337.112974267433, 9390.201832844148, 697.2609034423527, 725.7060890339421, 762.9084509858742, 769.830637259802, 769.8960640313486, 4615.192341340252, 4856.125897338513, 4901.215805471107, 4922.33548470959, 4940.728259945738, 77849.0, 77867.61066194632, 78341.0, 79288.0, 79898.0, 67226.66386668035, 68972.0, 70003.64998174977, 70084.64957675179, 70216.0, 61453.999999999105, 61670.38329616647, 61752.0, 62593.0, 63094.0, 9128.087191280818, 9385.953070234606, 9605.663801766905, 9632.229421646392, 9722.854157187789, 41152.1769564613, 41439.37840932328, 41842.397336293594, 41859.372109417774, 42798.78600606977, 54792.17811732907, 54935.0, 55163.17255241094, 55596.0, 55721.44278557163, 11607.883921160681, 11883.702907427038, 12575.245485270912, 12709.36453177319, 12761.747732893578, 13375.866241337462, 14044.087134336236, 14230.644233894236, 14746.262686865828, 14965.625859353604, 12194.146409751233, 12891.613251602466, 13282.269475178959, 13284.136531125447, 13367.732645347232, 13447.394867231194, 13449.193048417126, 13525.2561109136, 13577.190001943, 13668.453261869414, 13671.316434178052, 13770.0, 14018.649533761738, 14023.50917717875, 14076.155430674193, 11025.173112016791, 11274.605388811353, 11415.200935934405, 11632.76734465289, 11857.466414011218, 11280.32318060919, 11758.176927615326, 11868.287902725864, 11901.28592284431, 12073.879261207276], "value": 7123.829517963899, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1553.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 104.0, 111.0, 113.0, 111.0, 106.0, 110.0, 112.0, 110.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 129.0, 154.0, 209.0, 127.0, 156.0, 164.0, 130.0, 178.0, 131.0], "value": 153.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 162.0, 161.0, 176.0, 164.0, 166.0, 163.0, 164.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 157.0, 78.0, 76.0, 76.0, 74.0, 170.0, 76.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 185.0, 92.0, 93.0, 101.0, 152.0, 92.0, 93.0, 154.0], "value": 114.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 119.0, 118.0, 117.0, 118.0, 118.0, 119.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 148.0, 147.0, 168.0, 148.0, 146.0, 146.0, 147.0, 146.0], "value": 148.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 55.0, 56.0, 56.0, 54.0, 56.0, 57.0, 55.0, 55.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 66.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 63.0, 62.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 78.0, 79.0, 84.0, 85.0, 80.0, 79.0, 142.0, 80.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 121.0, 122.0, 128.0, 125.0, 119.0, 129.0, 131.0, 146.0, 120.0], "value": 126.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 160.0, 160.0, 167.0, 158.0, 160.0, 168.0, 162.0, 157.0, 165.0], "value": 162.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 62.0, 64.0, 65.0, 62.0, 63.0, 63.0, 62.0, 63.0, 62.0], "value": 63.3, "unit": "score"}]}]} 23:30:04 INFO - Return code: 0 23:30:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:30:04 ERROR - # TBPL SUCCESS # 23:30:04 INFO - Running post-action listener: _resource_record_post_action 23:30:04 INFO - ##### 23:30:04 INFO - ##### Finished run-tests step (success) 23:30:04 INFO - ##### 23:30:04 INFO - Running post-run listener: _resource_record_post_run 23:30:04 INFO - Total resource usage - Wall time: 1194s; CPU: 14.0%; Read bytes: 12288; Write bytes: 547090432; Read time: 1196; Write time: 1451132 23:30:04 INFO - TinderboxPrint: CPU usage
13.6% 23:30:04 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 1,196 23:30:04 INFO - TinderboxPrint: I/O write bytes / time
547,090,432 / 1,451,132 23:30:04 INFO - TinderboxPrint: CPU idle
8,235.9 (86.4%) 23:30:04 INFO - TinderboxPrint: CPU user
1,226.0 (12.9%) 23:30:04 INFO - TinderboxPrint: Swap in / out
0 / 0 23:30:04 INFO - install - Wall time: 17s; CPU: 17.0%; Read bytes: 4096; Write bytes: 257150976; Read time: 460; Write time: 668948 23:30:04 INFO - run-tests - Wall time: 1177s; CPU: 14.0%; Read bytes: 8192; Write bytes: 289939456; Read time: 736; Write time: 782184 23:30:05 INFO - Running post-run listener: _upload_blobber_files 23:30:05 INFO - Blob upload gear active. 23:30:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:30:05 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:30:05 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'] 23:30:05 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 23:30:05 INFO - (blobuploader) - INFO - Open directory for files ... 23:30:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:30:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:30:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:30:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:30:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:30:06 INFO - (blobuploader) - INFO - Done attempting. 23:30:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:30:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:30:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:30:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:30:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:30:10 INFO - (blobuploader) - INFO - Done attempting. 23:30:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:30:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:30:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:30:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:30:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:30:11 INFO - (blobuploader) - INFO - Done attempting. 23:30:11 INFO - (blobuploader) - INFO - Iteration through files over. 23:30:11 INFO - Return code: 0 23:30:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:30:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:30:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8113fb965a5013037a0f2181ff54f171f5e70a51cb7427cf7985374fbfdc678767ae57e15f35a507102c5cea91fe9da3dad5a7b69bba8d57be54e6aad276075b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1bf66f6137443a4db86fa4d40f43fe66b64d2b857012b00093c77545a83b1662df3bd68c635c21bc3eacbf65dcd55911a058daeca4b7ee70e702bf0cd88aabc3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f4090ff98c10278f6058415f48158a31deeb6fe56e7f2ff895192fc09b6a4436c887760c388067c0c900fa1514b96546f478047d14915c5f607a9cbf4ccd2a4b"} 23:30:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:30:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:30:11 INFO - Contents: 23:30:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8113fb965a5013037a0f2181ff54f171f5e70a51cb7427cf7985374fbfdc678767ae57e15f35a507102c5cea91fe9da3dad5a7b69bba8d57be54e6aad276075b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1bf66f6137443a4db86fa4d40f43fe66b64d2b857012b00093c77545a83b1662df3bd68c635c21bc3eacbf65dcd55911a058daeca4b7ee70e702bf0cd88aabc3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f4090ff98c10278f6058415f48158a31deeb6fe56e7f2ff895192fc09b6a4436c887760c388067c0c900fa1514b96546f478047d14915c5f607a9cbf4ccd2a4b"} 23:30:11 INFO - Running post-run listener: copy_logs_to_upload_dir 23:30:11 INFO - Copying logs to upload dir... 23:30:11 INFO - mkdir: /builds/slave/test/build/upload/logs 23:30:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.318936 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-05-19 23:30:11.480308) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 23:30:11.483853) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1463723795.853079-575851582 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/8113fb965a5013037a0f2181ff54f171f5e70a51cb7427cf7985374fbfdc678767ae57e15f35a507102c5cea91fe9da3dad5a7b69bba8d57be54e6aad276075b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1bf66f6137443a4db86fa4d40f43fe66b64d2b857012b00093c77545a83b1662df3bd68c635c21bc3eacbf65dcd55911a058daeca4b7ee70e702bf0cd88aabc3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f4090ff98c10278f6058415f48158a31deeb6fe56e7f2ff895192fc09b6a4436c887760c388067c0c900fa1514b96546f478047d14915c5f607a9cbf4ccd2a4b"} build_url:https://queue.taskcluster.net/v1/task/XyxYN_omThyuEW0u-STcpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011238 build_url: 'https://queue.taskcluster.net/v1/task/XyxYN_omThyuEW0u-STcpg/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/8113fb965a5013037a0f2181ff54f171f5e70a51cb7427cf7985374fbfdc678767ae57e15f35a507102c5cea91fe9da3dad5a7b69bba8d57be54e6aad276075b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1bf66f6137443a4db86fa4d40f43fe66b64d2b857012b00093c77545a83b1662df3bd68c635c21bc3eacbf65dcd55911a058daeca4b7ee70e702bf0cd88aabc3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f4090ff98c10278f6058415f48158a31deeb6fe56e7f2ff895192fc09b6a4436c887760c388067c0c900fa1514b96546f478047d14915c5f607a9cbf4ccd2a4b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 23:30:11.508701) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 23:30:11.509043) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1463723795.853079-575851582 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004618 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 23:30:11.593555) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 23:30:11.593899) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 23:30:11.594199) ========= ========= Total master_lag: 0.21 =========