builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-017 starttime: 1463808797.76 results: success (0) buildid: 20160520212034 builduid: 37f845c2f7054708a3bac5462d464393 revision: f1f2644d34440fe38c098e323bf570e09197e51a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-20 22:33:17.759323) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-20 22:33:17.760034) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-20 22:33:17.760334) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-20 22:33:17.800844) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 22:33:17.801224) ========= 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=0333a256a5e4f052382dd180000001b1-1463808614.610631-1167946975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-20 22:33:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 213M=0s 2016-05-20 22:33:17 (213 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120396 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 22:33:17.934827) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 22:33:17.935151) ========= 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=0333a256a5e4f052382dd180000001b1-1463808614.610631-1167946975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017349 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 22:33:17.986771) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-20 22:33:17.987176) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f1f2644d34440fe38c098e323bf570e09197e51a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev f1f2644d34440fe38c098e323bf570e09197e51a --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=0333a256a5e4f052382dd180000001b1-1463808614.610631-1167946975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-20 22:33:18,062 truncating revision to first 12 chars 2016-05-20 22:33:18,062 Setting DEBUG logging. 2016-05-20 22:33:18,062 attempt 1/10 2016-05-20 22:33:18,062 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f1f2644d3444?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-20 22:33:19,383 unpacking tar archive at: mozilla-central-f1f2644d3444/testing/mozharness/ program finished with exit code 0 elapsedTime=1.613638 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-20 22:33:19.615048) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-20 22:33:19.615370) ========= script_repo_revision: f1f2644d34440fe38c098e323bf570e09197e51a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-20 22:33:19.615771) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-20 22:33:19.616038) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-20 22:33:19.624898) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-05-20 22:33:19.625196) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1463808614.610631-1167946975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:33:19 INFO - MultiFileLogger online at 20160520 22:33:19 in /builds/slave/test 22:33:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 22:33:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:33:19 INFO - {'append_to_log': False, 22:33:19 INFO - 'base_work_dir': '/builds/slave/test', 22:33:19 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 22:33:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:33:19 INFO - 'branch': 'Firefox-Non-PGO', 22:33:19 INFO - 'buildbot_json_path': 'buildprops.json', 22:33:19 INFO - 'config_files': ('talos/linux_config.py',), 22:33:19 INFO - 'default_actions': ('clobber', 22:33:19 INFO - 'read-buildbot-config', 22:33:19 INFO - 'download-and-extract', 22:33:19 INFO - 'populate-webroot', 22:33:19 INFO - 'create-virtualenv', 22:33:19 INFO - 'install', 22:33:19 INFO - 'run-tests'), 22:33:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:33:19 INFO - 'download_minidump_stackwalk': True, 22:33:19 INFO - 'download_symbols': 'ondemand', 22:33:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:33:19 INFO - 'tooltool.py': '/tools/tooltool.py', 22:33:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:33:19 INFO - '/tools/misc-python/virtualenv.py')}, 22:33:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:33:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:33:19 INFO - 'installer_path': 'installer.exe', 22:33:19 INFO - 'log_level': 'info', 22:33:19 INFO - 'log_name': 'talos', 22:33:19 INFO - 'log_to_console': True, 22:33:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:33:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:33:19 INFO - 'opt_config_files': (), 22:33:19 INFO - 'pip_index': False, 22:33:19 INFO - 'sps_profile': False, 22:33:19 INFO - 'sps_profile_interval': 0, 22:33:19 INFO - 'suite': 'dromaeojs-e10s', 22:33:19 INFO - 'system_bits': '32', 22:33:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:33:19 INFO - 'title': 'talos-linux64-ix-017', 22:33:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:33:19 INFO - 'use_talos_json': True, 22:33:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:33:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:33:19 INFO - 'work_dir': 'build'} 22:33:19 INFO - ##### 22:33:19 INFO - ##### Running clobber step. 22:33:19 INFO - ##### 22:33:19 INFO - Running pre-action listener: _resource_record_pre_action 22:33:19 INFO - Running main action method: clobber 22:33:19 INFO - rmtree: /builds/slave/test/build 22:33:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:33:20 INFO - Running post-action listener: _resource_record_post_action 22:33:20 INFO - ##### 22:33:20 INFO - ##### Finished clobber step (success) 22:33:20 INFO - ##### 22:33:20 INFO - ##### 22:33:20 INFO - ##### Running read-buildbot-config step. 22:33:20 INFO - ##### 22:33:20 INFO - Running pre-action listener: _resource_record_pre_action 22:33:20 INFO - Running main action method: read_buildbot_config 22:33:20 INFO - Using buildbot properties: 22:33:20 INFO - { 22:33:20 INFO - "project": "", 22:33:20 INFO - "product": "firefox", 22:33:20 INFO - "script_repo_revision": "production", 22:33:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 22:33:20 INFO - "repository": "", 22:33:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 22:33:20 INFO - "buildid": "20160520212034", 22:33:20 INFO - "pgo_build": "False", 22:33:20 INFO - "basedir": "/builds/slave/test", 22:33:20 INFO - "buildnumber": 327, 22:33:20 INFO - "slavename": "talos-linux64-ix-017", 22:33:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:33:20 INFO - "platform": "ubuntu64_hw", 22:33:20 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 22:33:20 INFO - "branch": "mozilla-central", 22:33:20 INFO - "repo_path": "mozilla-central", 22:33:20 INFO - "revision": "f1f2644d34440fe38c098e323bf570e09197e51a", 22:33:20 INFO - "stage_platform": "linux64", 22:33:20 INFO - "builduid": "37f845c2f7054708a3bac5462d464393", 22:33:20 INFO - "slavebuilddir": "test" 22:33:20 INFO - } 22:33:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/Sy-kGYeJQniD5T4K3vdyaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 22:33:20 INFO - Running post-action listener: _resource_record_post_action 22:33:20 INFO - ##### 22:33:20 INFO - ##### Finished read-buildbot-config step (success) 22:33:20 INFO - ##### 22:33:20 INFO - ##### 22:33:20 INFO - ##### Running download-and-extract step. 22:33:20 INFO - ##### 22:33:20 INFO - Running pre-action listener: _resource_record_pre_action 22:33:20 INFO - Running main action method: download_and_extract 22:33:20 INFO - mkdir: /builds/slave/test/build/tests 22:33:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:20 INFO - https://queue.taskcluster.net/v1/task/Sy-kGYeJQniD5T4K3vdyaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:33:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sy-kGYeJQniD5T4K3vdyaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:33:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sy-kGYeJQniD5T4K3vdyaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:33:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sy-kGYeJQniD5T4K3vdyaw/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 22:33:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sy-kGYeJQniD5T4K3vdyaw/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 22:33:25 INFO - Downloaded 1361 bytes. 22:33:25 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:33:25 INFO - Using the following test package requirements: 22:33:25 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 22:33:25 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:33:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:33:25 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:33:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:33:25 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:33:25 INFO - u'jsshell-linux-x86_64.zip'], 22:33:25 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:33:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:33:25 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 22:33:25 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:33:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:33:25 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:33:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:33:25 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:33:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:33:25 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:33:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:33:25 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:33:25 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')]} 22:33:25 INFO - https://queue.taskcluster.net/v1/task/Sy-kGYeJQniD5T4K3vdyaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:33:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sy-kGYeJQniD5T4K3vdyaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:33:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sy-kGYeJQniD5T4K3vdyaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:33:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sy-kGYeJQniD5T4K3vdyaw/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 22:33:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sy-kGYeJQniD5T4K3vdyaw/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 22:33:27 INFO - Downloaded 22814329 bytes. 22:33:27 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'] 22:33:27 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 22:33:28 INFO - Return code: 0 22:33:28 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 22:33:28 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')]} 22:33:28 INFO - https://queue.taskcluster.net/v1/task/Sy-kGYeJQniD5T4K3vdyaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:33:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sy-kGYeJQniD5T4K3vdyaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:33:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sy-kGYeJQniD5T4K3vdyaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:33:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sy-kGYeJQniD5T4K3vdyaw/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 22:33:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sy-kGYeJQniD5T4K3vdyaw/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 22:33:30 INFO - Downloaded 22814329 bytes. 22:33:30 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'] 22:33:30 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 22:33:32 INFO - Return code: 0 22:33:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:32 INFO - https://queue.taskcluster.net/v1/task/Sy-kGYeJQniD5T4K3vdyaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:33:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sy-kGYeJQniD5T4K3vdyaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 22:33:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sy-kGYeJQniD5T4K3vdyaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 22:33:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sy-kGYeJQniD5T4K3vdyaw/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 22:33:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sy-kGYeJQniD5T4K3vdyaw/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 22:33:33 INFO - Downloaded 10840359 bytes. 22:33:33 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'] 22:33:33 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 22:33:33 INFO - Return code: 0 22:33: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')]} 22:33:33 INFO - https://queue.taskcluster.net/v1/task/Sy-kGYeJQniD5T4K3vdyaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:33:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sy-kGYeJQniD5T4K3vdyaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:33:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sy-kGYeJQniD5T4K3vdyaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:33:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sy-kGYeJQniD5T4K3vdyaw/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 22:33:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sy-kGYeJQniD5T4K3vdyaw/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 22:33:34 INFO - Downloaded 54818616 bytes. 22:33:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Sy-kGYeJQniD5T4K3vdyaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:33:34 INFO - mkdir: /builds/slave/test/properties 22:33:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:33:34 INFO - Writing to file /builds/slave/test/properties/build_url 22:33:34 INFO - Contents: 22:33:34 INFO - build_url:https://queue.taskcluster.net/v1/task/Sy-kGYeJQniD5T4K3vdyaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:33:35 INFO - Running post-action listener: _resource_record_post_action 22:33:35 INFO - Running post-action listener: set_extra_try_arguments 22:33:35 INFO - ##### 22:33:35 INFO - ##### Finished download-and-extract step (success) 22:33:35 INFO - ##### 22:33:35 INFO - ##### 22:33:35 INFO - ##### Running populate-webroot step. 22:33:35 INFO - ##### 22:33:35 INFO - Running pre-action listener: _resource_record_pre_action 22:33:35 INFO - Running main action method: populate_webroot 22:33:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:33:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:33:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:33:35 INFO - '--tppagecycles', 22:33:35 INFO - '7'], 22:33:35 INFO - 'tests': ['tsvgm']}}, 22:33:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:33:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:33:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:33:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:33:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:33:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:33:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:33:35 INFO - 'talos_options': ['--disable-e10s'], 22:33:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:33:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:33:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:33:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:33:35 INFO - 'talos_options': ['--disable-e10s'], 22:33:35 INFO - 'tests': ['damp', 'tps']}, 22:33:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:33:35 INFO - 'tests': ['damp', 'tps']}, 22:33:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:33:35 INFO - 'tests': ['dromaeo_dom']}, 22:33:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:33:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:33:35 INFO - 'tests': ['a11yr', 22:33:35 INFO - 'ts_paint', 22:33:35 INFO - 'tpaint', 22:33:35 INFO - 'sessionrestore', 22:33:35 INFO - 'sessionrestore_no_auto_restore', 22:33:35 INFO - 'tabpaint']}, 22:33:35 INFO - 'other-e10s': {'tests': ['a11yr', 22:33:35 INFO - 'ts_paint', 22:33:35 INFO - 'tpaint', 22:33:35 INFO - 'sessionrestore', 22:33:35 INFO - 'sessionrestore_no_auto_restore', 22:33:35 INFO - 'tabpaint']}, 22:33:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:33:35 INFO - 'ts_paint', 22:33:35 INFO - 'tpaint', 22:33:35 INFO - 'sessionrestore', 22:33:35 INFO - 'sessionrestore_no_auto_restore', 22:33:35 INFO - 'tabpaint']}, 22:33:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:33:35 INFO - 'ts_paint', 22:33:35 INFO - 'tpaint', 22:33:35 INFO - 'sessionrestore', 22:33:35 INFO - 'sessionrestore_no_auto_restore', 22:33:35 INFO - 'tabpaint']}, 22:33:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:33:35 INFO - 'tests': ['a11yr', 22:33:35 INFO - 'ts_paint', 22:33:35 INFO - 'tpaint', 22:33:35 INFO - 'sessionrestore', 22:33:35 INFO - 'sessionrestore_no_auto_restore', 22:33:35 INFO - 'tabpaint']}, 22:33:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:33:35 INFO - 'tests': ['a11yr', 22:33:35 INFO - 'ts_paint', 22:33:35 INFO - 'tpaint', 22:33:35 INFO - 'sessionrestore', 22:33:35 INFO - 'sessionrestore_no_auto_restore', 22:33:35 INFO - 'tabpaint']}, 22:33:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:33:35 INFO - 'tests': ['tsvgx', 22:33:35 INFO - 'tsvgr_opacity', 22:33:35 INFO - 'tart', 22:33:35 INFO - 'tscrollx', 22:33:35 INFO - 'cart']}, 22:33:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:33:35 INFO - 'tsvgr_opacity', 22:33:35 INFO - 'tart', 22:33:35 INFO - 'tscrollx', 22:33:35 INFO - 'cart']}, 22:33:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:33:35 INFO - 'talos_options': ['--disable-e10s'], 22:33:35 INFO - 'tests': ['tp5o']}, 22:33:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:33:35 INFO - 'tests': ['tp5o']}, 22:33:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:33:35 INFO - 'talos_options': ['--disable-e10s', 22:33:35 INFO - '--xperf_path', 22:33:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:33:35 INFO - 'tests': ['tp5n']}, 22:33:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:33:35 INFO - 'talos_options': ['--xperf_path', 22:33:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:33:35 INFO - 'tests': ['tp5n']}}, 22:33:35 INFO - 'talos.zip': {'path': '', 22:33:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:33:35 INFO - Running post-action listener: _resource_record_post_action 22:33:35 INFO - ##### 22:33:35 INFO - ##### Finished populate-webroot step (success) 22:33:35 INFO - ##### 22:33:35 INFO - ##### 22:33:35 INFO - ##### Running create-virtualenv step. 22:33:35 INFO - ##### 22:33:35 INFO - Running pre-action listener: _resource_record_pre_action 22:33:35 INFO - Running main action method: create_virtualenv 22:33:35 INFO - Creating virtualenv /builds/slave/test/build/venv 22:33:35 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 22:33:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:33:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:33:35 INFO - Using real prefix '/usr' 22:33:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:33:36 INFO - Installing distribute.............................................................................................................................................................................................done. 22:33:38 INFO - Installing pip.................done. 22:33:38 INFO - Return code: 0 22:33:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:38 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 0x7f1e9355af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1daa770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e399c0>, '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 0x1e3a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e3ad50>, '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': '0333a256a5e4f052382dd180000001b1-1463808614.610631-1167946975', '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 22:33:38 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 22:33:38 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 22:33:38 INFO - Using env: {'DISPLAY': ':0', 22:33:38 INFO - 'HOME': '/home/cltbld', 22:33:38 INFO - 'LANG': 'en_US.UTF-8', 22:33:38 INFO - 'LANGUAGE': 'en_US:en', 22:33:38 INFO - 'LOGNAME': 'cltbld', 22:33:38 INFO - 'MAIL': '/var/mail/cltbld', 22:33:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:38 INFO - 'MOZ_NO_REMOTE': '1', 22:33:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:33:38 INFO - 'NO_EM_RESTART': '1', 22:33:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:33:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:38 INFO - 'PWD': '/builds/slave/test', 22:33:38 INFO - 'SHELL': '/bin/bash', 22:33:38 INFO - 'SHLVL': '1', 22:33:38 INFO - 'TERM': 'linux', 22:33:38 INFO - 'TMOUT': '86400', 22:33:38 INFO - 'USER': 'cltbld', 22:33:38 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463808614.610631-1167946975', 22:33:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:38 INFO - '_': '/tools/buildbot/bin/python'} 22:33:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:38 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 22:33:38 INFO - Cleaning up... 22:33:38 INFO - Return code: 0 22:33:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:38 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 0x7f1e9355af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1daa770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e399c0>, '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 0x1e3a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e3ad50>, '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': '0333a256a5e4f052382dd180000001b1-1463808614.610631-1167946975', '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 22:33:38 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 22:33:38 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 22:33:38 INFO - Using env: {'DISPLAY': ':0', 22:33:38 INFO - 'HOME': '/home/cltbld', 22:33:38 INFO - 'LANG': 'en_US.UTF-8', 22:33:38 INFO - 'LANGUAGE': 'en_US:en', 22:33:38 INFO - 'LOGNAME': 'cltbld', 22:33:38 INFO - 'MAIL': '/var/mail/cltbld', 22:33:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:38 INFO - 'MOZ_NO_REMOTE': '1', 22:33:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:33:38 INFO - 'NO_EM_RESTART': '1', 22:33:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:33:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:38 INFO - 'PWD': '/builds/slave/test', 22:33:38 INFO - 'SHELL': '/bin/bash', 22:33:38 INFO - 'SHLVL': '1', 22:33:38 INFO - 'TERM': 'linux', 22:33:38 INFO - 'TMOUT': '86400', 22:33:38 INFO - 'USER': 'cltbld', 22:33:38 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463808614.610631-1167946975', 22:33:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:38 INFO - '_': '/tools/buildbot/bin/python'} 22:33:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:38 INFO - Downloading/unpacking psutil>=3.1.1 22:33:38 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 22:33:38 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 22:33:38 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 22:33:38 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 22:33:38 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 22:33:38 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 22:33:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:33:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:33:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:33:40 INFO - Installing collected packages: psutil 22:33:40 INFO - Running setup.py install for psutil 22:33:40 INFO - building 'psutil._psutil_linux' extension 22:33:40 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 22:33:41 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 22:33:41 INFO - building 'psutil._psutil_posix' extension 22:33:41 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 22:33:41 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 22:33:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:33:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:33:41 INFO - Successfully installed psutil 22:33:41 INFO - Cleaning up... 22:33:41 INFO - Return code: 0 22:33:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:33:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:41 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 0x7f1e9355af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1daa770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e399c0>, '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 0x1e3a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e3ad50>, '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': '0333a256a5e4f052382dd180000001b1-1463808614.610631-1167946975', '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 22:33:41 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 22:33:41 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 22:33:41 INFO - Using env: {'DISPLAY': ':0', 22:33:41 INFO - 'HOME': '/home/cltbld', 22:33:41 INFO - 'LANG': 'en_US.UTF-8', 22:33:41 INFO - 'LANGUAGE': 'en_US:en', 22:33:41 INFO - 'LOGNAME': 'cltbld', 22:33:41 INFO - 'MAIL': '/var/mail/cltbld', 22:33:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:41 INFO - 'MOZ_NO_REMOTE': '1', 22:33:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:33:41 INFO - 'NO_EM_RESTART': '1', 22:33:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:33:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:41 INFO - 'PWD': '/builds/slave/test', 22:33:41 INFO - 'SHELL': '/bin/bash', 22:33:41 INFO - 'SHLVL': '1', 22:33:41 INFO - 'TERM': 'linux', 22:33:41 INFO - 'TMOUT': '86400', 22:33:41 INFO - 'USER': 'cltbld', 22:33:41 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463808614.610631-1167946975', 22:33:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:41 INFO - '_': '/tools/buildbot/bin/python'} 22:33:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:33:41 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 22:33:41 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 22:33:41 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 22:33:41 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 22:33:41 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 22:33:41 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 22:33:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:33:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:33:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:33:43 INFO - Installing collected packages: mozsystemmonitor 22:33:43 INFO - Running setup.py install for mozsystemmonitor 22:33:43 INFO - Successfully installed mozsystemmonitor 22:33:43 INFO - Cleaning up... 22:33:43 INFO - Return code: 0 22:33:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:33: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')]} 22:33:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33: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')]} 22:33:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:43 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 0x7f1e9355af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1daa770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e399c0>, '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 0x1e3a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e3ad50>, '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': '0333a256a5e4f052382dd180000001b1-1463808614.610631-1167946975', '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 22:33:43 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 22:33:43 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 22:33:43 INFO - Using env: {'DISPLAY': ':0', 22:33:43 INFO - 'HOME': '/home/cltbld', 22:33:43 INFO - 'LANG': 'en_US.UTF-8', 22:33:43 INFO - 'LANGUAGE': 'en_US:en', 22:33:43 INFO - 'LOGNAME': 'cltbld', 22:33:43 INFO - 'MAIL': '/var/mail/cltbld', 22:33:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:43 INFO - 'MOZ_NO_REMOTE': '1', 22:33:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:33:43 INFO - 'NO_EM_RESTART': '1', 22:33:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:33:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:43 INFO - 'PWD': '/builds/slave/test', 22:33:43 INFO - 'SHELL': '/bin/bash', 22:33:43 INFO - 'SHLVL': '1', 22:33:43 INFO - 'TERM': 'linux', 22:33:43 INFO - 'TMOUT': '86400', 22:33:43 INFO - 'USER': 'cltbld', 22:33:43 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463808614.610631-1167946975', 22:33:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:43 INFO - '_': '/tools/buildbot/bin/python'} 22:33:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:44 INFO - Downloading/unpacking blobuploader==1.2.4 22:33:44 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 22:33:44 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 22:33:44 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 22:33:44 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 22:33:44 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 22:33:44 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 22:33:46 INFO - Downloading blobuploader-1.2.4.tar.gz 22:33:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:33:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:33:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:33:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:33:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:33:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:33:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:33:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:33:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:33:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:33:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:33:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:33:46 INFO - Downloading docopt-0.6.1.tar.gz 22:33:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:33:46 INFO - Installing collected packages: blobuploader, requests, docopt 22:33:46 INFO - Running setup.py install for blobuploader 22:33:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:33:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:33:47 INFO - Running setup.py install for requests 22:33:47 INFO - Running setup.py install for docopt 22:33:47 INFO - Successfully installed blobuploader requests docopt 22:33:47 INFO - Cleaning up... 22:33:47 INFO - Return code: 0 22:33:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:33:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:47 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 0x7f1e9355af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1daa770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e399c0>, '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 0x1e3a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e3ad50>, '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': '0333a256a5e4f052382dd180000001b1-1463808614.610631-1167946975', '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 22:33:47 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 22:33:47 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 22:33:47 INFO - Using env: {'DISPLAY': ':0', 22:33:47 INFO - 'HOME': '/home/cltbld', 22:33:47 INFO - 'LANG': 'en_US.UTF-8', 22:33:47 INFO - 'LANGUAGE': 'en_US:en', 22:33:47 INFO - 'LOGNAME': 'cltbld', 22:33:47 INFO - 'MAIL': '/var/mail/cltbld', 22:33:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:47 INFO - 'MOZ_NO_REMOTE': '1', 22:33:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:33:47 INFO - 'NO_EM_RESTART': '1', 22:33:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:33:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:47 INFO - 'PWD': '/builds/slave/test', 22:33:47 INFO - 'SHELL': '/bin/bash', 22:33:47 INFO - 'SHLVL': '1', 22:33:47 INFO - 'TERM': 'linux', 22:33:47 INFO - 'TMOUT': '86400', 22:33:47 INFO - 'USER': 'cltbld', 22:33:47 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463808614.610631-1167946975', 22:33:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:47 INFO - '_': '/tools/buildbot/bin/python'} 22:33:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:33:47 INFO - Running setup.py (path:/tmp/pip-q6IcjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:33:47 INFO - Running setup.py (path:/tmp/pip-mj_ZK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:33:47 INFO - Running setup.py (path:/tmp/pip-t9SVuB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:33:47 INFO - Running setup.py (path:/tmp/pip-cosIE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:33:48 INFO - Running setup.py (path:/tmp/pip-1DiJ_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:33:48 INFO - Running setup.py (path:/tmp/pip-lP7w2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:33:48 INFO - Running setup.py (path:/tmp/pip-fwnm2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:33:48 INFO - Running setup.py (path:/tmp/pip-LkpwWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:33:48 INFO - Running setup.py (path:/tmp/pip-nGCxMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:33:48 INFO - Running setup.py (path:/tmp/pip-m83KCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:33:48 INFO - Running setup.py (path:/tmp/pip-YyTQV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:33:48 INFO - Running setup.py (path:/tmp/pip-Si1fv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:33:48 INFO - Running setup.py (path:/tmp/pip-o73AdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:33:48 INFO - Running setup.py (path:/tmp/pip-dov3SJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:33:48 INFO - Running setup.py (path:/tmp/pip-7GpPHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:33:48 INFO - Running setup.py (path:/tmp/pip-0BPnrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:33:48 INFO - Running setup.py (path:/tmp/pip-VU_o56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:33:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:33:48 INFO - Running setup.py install for manifestparser 22:33:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:33:49 INFO - Running setup.py install for mozcrash 22:33:49 INFO - Running setup.py install for mozdebug 22:33:49 INFO - Running setup.py install for mozdevice 22:33:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:33:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:33:49 INFO - Running setup.py install for mozfile 22:33:49 INFO - Running setup.py install for mozhttpd 22:33:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:33:49 INFO - Running setup.py install for mozinfo 22:33:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:33:49 INFO - Running setup.py install for mozInstall 22:33:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:33:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:33:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:33:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:33:49 INFO - Running setup.py install for mozleak 22:33:49 INFO - Running setup.py install for mozlog 22:33:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:33:49 INFO - Running setup.py install for moznetwork 22:33:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:33:50 INFO - Running setup.py install for mozprocess 22:33:50 INFO - Running setup.py install for mozprofile 22:33:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:33:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:33:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:33:50 INFO - Running setup.py install for mozrunner 22:33:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:33:50 INFO - Running setup.py install for mozscreenshot 22:33:50 INFO - Running setup.py install for moztest 22:33:50 INFO - Running setup.py install for mozversion 22:33:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:33:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:33:50 INFO - Cleaning up... 22:33:50 INFO - Return code: 0 22:33:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:33:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:50 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 0x7f1e9355af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1daa770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e399c0>, '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 0x1e3a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e3ad50>, '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': '0333a256a5e4f052382dd180000001b1-1463808614.610631-1167946975', '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 22:33:50 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 22:33:50 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 22:33:50 INFO - Using env: {'DISPLAY': ':0', 22:33:50 INFO - 'HOME': '/home/cltbld', 22:33:50 INFO - 'LANG': 'en_US.UTF-8', 22:33:50 INFO - 'LANGUAGE': 'en_US:en', 22:33:50 INFO - 'LOGNAME': 'cltbld', 22:33:50 INFO - 'MAIL': '/var/mail/cltbld', 22:33:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:50 INFO - 'MOZ_NO_REMOTE': '1', 22:33:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:33:50 INFO - 'NO_EM_RESTART': '1', 22:33:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:33:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:50 INFO - 'PWD': '/builds/slave/test', 22:33:50 INFO - 'SHELL': '/bin/bash', 22:33:50 INFO - 'SHLVL': '1', 22:33:50 INFO - 'TERM': 'linux', 22:33:50 INFO - 'TMOUT': '86400', 22:33:50 INFO - 'USER': 'cltbld', 22:33:50 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463808614.610631-1167946975', 22:33:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:50 INFO - '_': '/tools/buildbot/bin/python'} 22:33:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:33:50 INFO - Running setup.py (path:/tmp/pip-GzblJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:33:51 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)) 22:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:33:51 INFO - Running setup.py (path:/tmp/pip-yBBTPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:33:51 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)) 22:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:33:51 INFO - Running setup.py (path:/tmp/pip-103FFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:33:51 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)) 22:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:33:51 INFO - Running setup.py (path:/tmp/pip-nEmS64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:33:51 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)) 22:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:33:51 INFO - Running setup.py (path:/tmp/pip-oLHUag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:33:51 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)) 22:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:33:51 INFO - Running setup.py (path:/tmp/pip-b0mZAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:33:51 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)) 22:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:33:51 INFO - Running setup.py (path:/tmp/pip-A5EZFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:33:51 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)) 22:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:33:51 INFO - Running setup.py (path:/tmp/pip-RZDyaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:33:51 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)) 22:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:33:51 INFO - Running setup.py (path:/tmp/pip-Uv0JHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:33:51 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)) 22:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:33:51 INFO - Running setup.py (path:/tmp/pip-P7nO5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:33:51 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)) 22:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:33:51 INFO - Running setup.py (path:/tmp/pip-5gFkJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:33:51 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)) 22:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:33:51 INFO - Running setup.py (path:/tmp/pip-X11GRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:33:51 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)) 22:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:33:51 INFO - Running setup.py (path:/tmp/pip-rDEUaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:33:51 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)) 22:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:33:51 INFO - Running setup.py (path:/tmp/pip-o918hQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:33:51 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)) 22:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:33:51 INFO - Running setup.py (path:/tmp/pip-aA_u2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:33:52 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)) 22:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:33:52 INFO - Running setup.py (path:/tmp/pip-kVLdtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:33:52 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)) 22:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:33:52 INFO - Running setup.py (path:/tmp/pip-LcSY5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:33:52 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)) 22:33:52 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)) 22:33:52 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)) 22:33:52 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)) 22:33:52 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)) 22:33:52 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)) 22:33:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:33:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:33:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:33:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:33:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:33:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:33:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:33:54 INFO - Downloading blessings-1.6.tar.gz 22:33:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:33:54 INFO - Installing collected packages: blessings 22:33:54 INFO - Running setup.py install for blessings 22:33:54 INFO - Successfully installed blessings 22:33:54 INFO - Cleaning up... 22:33:54 INFO - Return code: 0 22:33:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:33:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:33:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:33:54 INFO - Reading from file tmpfile_stdout 22:33:54 INFO - Current package versions: 22:33:54 INFO - argparse == 1.2.1 22:33:54 INFO - blessings == 1.6 22:33:54 INFO - blobuploader == 1.2.4 22:33:54 INFO - docopt == 0.6.1 22:33:54 INFO - manifestparser == 1.1 22:33:54 INFO - mozInstall == 1.12 22:33:54 INFO - mozcrash == 0.17 22:33:54 INFO - mozdebug == 0.1 22:33:54 INFO - mozdevice == 0.48 22:33:54 INFO - mozfile == 1.2 22:33:54 INFO - mozhttpd == 0.7 22:33:54 INFO - mozinfo == 0.9 22:33:54 INFO - mozleak == 0.1 22:33:54 INFO - mozlog == 3.2 22:33:54 INFO - moznetwork == 0.27 22:33:54 INFO - mozprocess == 0.22 22:33:54 INFO - mozprofile == 0.28 22:33:54 INFO - mozrunner == 6.11 22:33:54 INFO - mozscreenshot == 0.1 22:33:54 INFO - mozsystemmonitor == 0.3 22:33:54 INFO - moztest == 0.7 22:33:54 INFO - mozversion == 1.4 22:33:54 INFO - psutil == 3.1.1 22:33:54 INFO - requests == 1.2.3 22:33:54 INFO - wsgiref == 0.1.2 22:33:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:33: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')]} 22:33:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33: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')]} 22:33:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:54 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 0x7f1e9355af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1daa770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e399c0>, '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 0x1e3a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e3ad50>, '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': '0333a256a5e4f052382dd180000001b1-1463808614.610631-1167946975', '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 22:33:54 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 22:33:54 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 22:33:54 INFO - Using env: {'DISPLAY': ':0', 22:33:54 INFO - 'HOME': '/home/cltbld', 22:33:54 INFO - 'LANG': 'en_US.UTF-8', 22:33:54 INFO - 'LANGUAGE': 'en_US:en', 22:33:54 INFO - 'LOGNAME': 'cltbld', 22:33:54 INFO - 'MAIL': '/var/mail/cltbld', 22:33:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:54 INFO - 'MOZ_NO_REMOTE': '1', 22:33:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:33:54 INFO - 'NO_EM_RESTART': '1', 22:33:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:33:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:54 INFO - 'PWD': '/builds/slave/test', 22:33:54 INFO - 'SHELL': '/bin/bash', 22:33:54 INFO - 'SHLVL': '1', 22:33:54 INFO - 'TERM': 'linux', 22:33:54 INFO - 'TMOUT': '86400', 22:33:54 INFO - 'USER': 'cltbld', 22:33:54 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463808614.610631-1167946975', 22:33:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:54 INFO - '_': '/tools/buildbot/bin/python'} 22:33:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:54 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)) 22:33:54 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)) 22:33:54 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)) 22:33:54 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)) 22:33:54 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)) 22:33:54 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)) 22:33:54 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)) 22:33:54 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)) 22:33:54 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)) 22:33:54 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)) 22:33:54 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)) 22:33:54 INFO - Cleaning up... 22:33:54 INFO - Return code: 0 22:33:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:33: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')]} 22:33:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33: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')]} 22:33:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1e9355af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1daa770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e399c0>, '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 0x1e3a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e3ad50>, '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': '0333a256a5e4f052382dd180000001b1-1463808614.610631-1167946975', '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 22:33: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', 'jsonschema'] in /builds/slave/test/build 22:33: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 jsonschema 22:33:54 INFO - Using env: {'DISPLAY': ':0', 22:33:54 INFO - 'HOME': '/home/cltbld', 22:33:54 INFO - 'LANG': 'en_US.UTF-8', 22:33:54 INFO - 'LANGUAGE': 'en_US:en', 22:33:54 INFO - 'LOGNAME': 'cltbld', 22:33:54 INFO - 'MAIL': '/var/mail/cltbld', 22:33:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:54 INFO - 'MOZ_NO_REMOTE': '1', 22:33:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:33:54 INFO - 'NO_EM_RESTART': '1', 22:33:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:33:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:54 INFO - 'PWD': '/builds/slave/test', 22:33:54 INFO - 'SHELL': '/bin/bash', 22:33:54 INFO - 'SHLVL': '1', 22:33:54 INFO - 'TERM': 'linux', 22:33:54 INFO - 'TMOUT': '86400', 22:33:54 INFO - 'USER': 'cltbld', 22:33:54 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463808614.610631-1167946975', 22:33:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:54 INFO - '_': '/tools/buildbot/bin/python'} 22:33:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:54 INFO - Downloading/unpacking jsonschema 22:33: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 22:33: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 22:33: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 22:33: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 22:33: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 22:33: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 22:33:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:33:56 INFO - Downloading/unpacking functools32 (from jsonschema) 22:33: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 22:33: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 22:33: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 22:33: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 22:33: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 22:33: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 22:33:57 INFO - Downloading functools32-3.2.3-2.tar.gz 22:33:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:33:57 INFO - warning: no files found matching '*.txt' 22:33:57 INFO - no previously-included directories found matching 'build' 22:33:57 INFO - no previously-included directories found matching 'dist' 22:33:57 INFO - no previously-included directories found matching '.git*' 22:33:57 INFO - Installing collected packages: jsonschema, functools32 22:33:57 INFO - Running setup.py install for functools32 22:33:57 INFO - warning: no files found matching '*.txt' 22:33:57 INFO - no previously-included directories found matching 'build' 22:33:57 INFO - no previously-included directories found matching 'dist' 22:33:57 INFO - no previously-included directories found matching '.git*' 22:33:57 INFO - Successfully installed jsonschema functools32 22:33:57 INFO - Cleaning up... 22:33:57 INFO - Return code: 0 22:33:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:33: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')]} 22:33:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33: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')]} 22:33:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1e9355af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1daa770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e399c0>, '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 0x1e3a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e3ad50>, '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': '0333a256a5e4f052382dd180000001b1-1463808614.610631-1167946975', '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 22:33:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 22:33:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:33:57 INFO - Using env: {'DISPLAY': ':0', 22:33:57 INFO - 'HOME': '/home/cltbld', 22:33:57 INFO - 'LANG': 'en_US.UTF-8', 22:33:57 INFO - 'LANGUAGE': 'en_US:en', 22:33:57 INFO - 'LOGNAME': 'cltbld', 22:33:57 INFO - 'MAIL': '/var/mail/cltbld', 22:33:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:57 INFO - 'MOZ_NO_REMOTE': '1', 22:33:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:33:57 INFO - 'NO_EM_RESTART': '1', 22:33:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:33:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:57 INFO - 'PWD': '/builds/slave/test', 22:33:57 INFO - 'SHELL': '/bin/bash', 22:33:57 INFO - 'SHLVL': '1', 22:33:57 INFO - 'TERM': 'linux', 22:33:57 INFO - 'TMOUT': '86400', 22:33:57 INFO - 'USER': 'cltbld', 22:33:57 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463808614.610631-1167946975', 22:33:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:57 INFO - '_': '/tools/buildbot/bin/python'} 22:33:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:57 INFO - Downloading/unpacking flake8 22:33:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:33:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:33:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:33:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:33:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:33:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:33:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:33:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:33:59 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 22:33:59 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 22:33:59 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 22:33:59 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 22:33:59 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 22:33:59 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 22:33:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:33:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:33:59 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 22:33:59 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 22:33:59 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 22:33:59 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 22:33:59 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 22:33:59 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 22:33:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:33:59 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 22:33:59 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 22:33:59 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 22:33:59 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 22:33:59 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 22:33:59 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 22:34:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:34:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:34:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:34:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:34:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:34:00 INFO - no previously-included directories found matching 'docs/_build' 22:34:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:34:00 INFO - Running setup.py install for pep8 22:34:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:34:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:34:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:34:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:34:00 INFO - no previously-included directories found matching 'docs/_build' 22:34:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:34:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:34:00 INFO - Cleaning up... 22:34:00 INFO - Return code: 0 22:34:00 INFO - Running post-action listener: _resource_record_post_action 22:34:00 INFO - Running post-action listener: _start_resource_monitoring 22:34:00 INFO - Starting resource monitoring. 22:34:00 INFO - ##### 22:34:00 INFO - ##### Finished create-virtualenv step (success) 22:34:00 INFO - ##### 22:34:00 INFO - ##### 22:34:00 INFO - ##### Running install step. 22:34:00 INFO - ##### 22:34:00 INFO - Running pre-action listener: _resource_record_pre_action 22:34:00 INFO - Running main action method: install 22:34:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:34:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:34:00 INFO - Reading from file tmpfile_stdout 22:34:00 INFO - Detecting whether we're running mozinstall >=1.0... 22:34:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:34:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:34:00 INFO - Reading from file tmpfile_stdout 22:34:00 INFO - Output received: 22:34:00 INFO - Usage: mozinstall [options] installer 22:34:00 INFO - Options: 22:34:00 INFO - -h, --help show this help message and exit 22:34:00 INFO - -d DEST, --destination=DEST 22:34:00 INFO - Directory to install application into. [default: 22:34:00 INFO - "/builds/slave/test"] 22:34:00 INFO - --app=APP Application being installed. [default: firefox] 22:34:00 INFO - mkdir: /builds/slave/test/build/application 22:34:00 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'] 22:34:00 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 22:34:16 INFO - Reading from file tmpfile_stdout 22:34:16 INFO - Output received: 22:34:16 INFO - /builds/slave/test/build/application/firefox/firefox 22:34:16 INFO - Running post-action listener: _resource_record_post_action 22:34:16 INFO - ##### 22:34:16 INFO - ##### Finished install step (success) 22:34:16 INFO - ##### 22:34:16 INFO - ##### 22:34:16 INFO - ##### Running run-tests step. 22:34:16 INFO - ##### 22:34:16 INFO - Running pre-action listener: _resource_record_pre_action 22:34:16 INFO - Running main action method: run_tests 22:34:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:34:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:34:16 INFO - Python 2.7.3 22:34:16 INFO - Return code: 0 22:34:16 INFO - grabbing minidump binary from tooltool 22:34:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:34:16 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 0x1e399c0>, '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 0x1e3a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e3ad50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:34:16 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 22:34:16 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 22:34:16 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 22:34:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:34:16 INFO - Return code: 0 22:34:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:34:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:34:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:34:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:34:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:34:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:34:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:34:17 INFO - Return code: 0 22:34:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Sy-kGYeJQniD5T4K3vdyaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 22:34:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Sy-kGYeJQniD5T4K3vdyaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 22:34:17 INFO - Using env: {'DISPLAY': ':0', 22:34:17 INFO - 'HOME': '/home/cltbld', 22:34:17 INFO - 'LANG': 'en_US.UTF-8', 22:34:17 INFO - 'LANGUAGE': 'en_US:en', 22:34:17 INFO - 'LOGNAME': 'cltbld', 22:34:17 INFO - 'MAIL': '/var/mail/cltbld', 22:34:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:34:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:34:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:34:17 INFO - 'MOZ_NO_REMOTE': '1', 22:34:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:34:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:34:17 INFO - 'NO_EM_RESTART': '1', 22:34:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:34:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:34:17 INFO - 'PWD': '/builds/slave/test', 22:34:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:34:17 INFO - 'SHELL': '/bin/bash', 22:34:17 INFO - 'SHLVL': '1', 22:34:17 INFO - 'TERM': 'linux', 22:34:17 INFO - 'TMOUT': '86400', 22:34:17 INFO - 'USER': 'cltbld', 22:34:17 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463808614.610631-1167946975', 22:34:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:34:17 INFO - '_': '/tools/buildbot/bin/python'} 22:34:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Sy-kGYeJQniD5T4K3vdyaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 22:34:17 INFO - mozversion application_buildid: 20160520212034 22:34:17 INFO - mozversion application_changeset: f1f2644d34440fe38c098e323bf570e09197e51a 22:34:17 INFO - mozversion application_display_name: Nightly 22:34:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:34:17 INFO - mozversion application_name: Firefox 22:34:17 INFO - mozversion application_remotingname: firefox 22:34:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:34:17 INFO - mozversion application_vendor: Mozilla 22:34:17 INFO - mozversion application_version: 49.0a1 22:34:17 INFO - mozversion platform_buildid: 20160520212034 22:34:17 INFO - mozversion platform_changeset: f1f2644d34440fe38c098e323bf570e09197e51a 22:34:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:34:17 INFO - mozversion platform_version: 49.0a1 22:34:17 INFO - using testdate: 1463808857 22:34:17 INFO - actual date: 1463808857 22:34:17 INFO - starting webserver on 'localhost:45747' 22:34:17 INFO - SUITE-START | Running 2 tests 22:34:17 INFO - TEST-START | dromaeo_css 22:34:17 INFO - operating with platform_type : linux_ 22:34:17 INFO - Initialising browser for dromaeo_css test... 22:34:17 INFO - TEST-INFO | started process 3956 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2n1OYX/profile http://localhost:45747/getInfo.html) 22:34:21 INFO - PROCESS | 3956 | 22:34:21 INFO - PROCESS | 3956 | (process:4025): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:34:22 INFO - PROCESS | 3956 | __metrics Screen width/height:1600/1200 22:34:22 INFO - PROCESS | 3956 | colorDepth:24 22:34:22 INFO - PROCESS | 3956 | Browser inner width/height: 1024/697 22:34:22 INFO - PROCESS | 3956 | __metrics 22:34:23 ERROR - PROCESS | 3956 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 22:34:24 INFO - TEST-INFO | 3956: exit 0 22:34:24 INFO - Browser initialized. 22:34:24 INFO - Running cycle 1/1 for dromaeo_css test... 22:34:24 INFO - TEST-INFO | started process 4076 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2n1OYX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:34:26 INFO - PROCESS | 4076 | 22:34:26 INFO - PROCESS | 4076 | (process:4135): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:34:36 INFO - PROCESS | 4076 | RSS: Main: 165851136 22:34:36 INFO - PROCESS | 4076 | 22:35:25 INFO - PROCESS | 4076 | 1463808925884 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] 22:37:36 INFO - PROCESS | 4076 | Cycle 1(1): loaded http://localhost:45747/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45747/tests/dromaeo/cssquery-ext.html) 22:37:37 INFO - PROCESS | 4076 | RSS: Main: 168185856 22:37:37 INFO - PROCESS | 4076 | 22:40:39 INFO - PROCESS | 4076 | Cycle 1(1): loaded http://localhost:45747/tests/dromaeo/cssquery-ext.html (next: http://localhost:45747/tests/dromaeo/cssquery-jquery.html) 22:40:40 INFO - PROCESS | 4076 | RSS: Main: 167407616 22:40:40 INFO - PROCESS | 4076 | 22:43:42 INFO - PROCESS | 4076 | Cycle 1(1): loaded http://localhost:45747/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45747/tests/dromaeo/cssquery-mootools.html) 22:43:42 INFO - PROCESS | 4076 | RSS: Main: 168984576 22:43:42 INFO - PROCESS | 4076 | 22:46:44 INFO - PROCESS | 4076 | Cycle 1(1): loaded http://localhost:45747/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45747/tests/dromaeo/cssquery-prototype.html) 22:46:45 INFO - PROCESS | 4076 | RSS: Main: 166477824 22:46:45 INFO - PROCESS | 4076 | 22:49:48 INFO - PROCESS | 4076 | Cycle 1(1): loaded http://localhost:45747/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45747/tests/dromaeo/cssquery-yui.html) 22:49:48 INFO - PROCESS | 4076 | RSS: Main: 167727104 22:49:48 INFO - PROCESS | 4076 | 22:52:51 INFO - PROCESS | 4076 | Cycle 1(1): loaded http://localhost:45747/tests/dromaeo/cssquery-yui.html (next: http://localhost:45747/tests/dromaeo/cssquery-dojo.html) 22:52:51 INFO - PROCESS | 4076 | RSS: Main: 170188800 22:52:51 INFO - PROCESS | 4076 | 22:52:51 INFO - PROCESS | 4076 | __start_tp_report 22:52:51 INFO - PROCESS | 4076 | _x_x_mozilla_page_load 22:52:51 INFO - PROCESS | 4076 | _x_x_mozilla_page_load_details 22:52:51 INFO - PROCESS | 4076 | |i|pagename|runs| 22:52:51 INFO - PROCESS | 4076 | |0;dojo.html;2662.640543526624;2713.1996061161954;2717.510848047353;2719.6736391632994;2730.713275106114;4736.384270044894;4757.096151731169;4775.450823155338;4843.790497836795;4901.509849015097;4697.953020469794;4717.834875779348;4756.833510827122;4764.78558464869;4766.5471780180915;4346.587074227943;4421.6683748718815;4490.87728067983;4494.1910456117885;4495.3931219285305;16.764153865777434;4306.784660766964;4360.040791025969;4403.229434848905;4511.661625378109;4329.480462344523;4351.673624478145;4393.36296237047;4393.472783265996;4394.472663280395;4348.021695118573;4415.381846541487;4431;4431.711938723973;4458.9554104459185;4374.978125109354;4408.603225709701;4416.050549131952;4422.204003279408;4447.488538818045;4388.5830846069575;4572.199865023607;4607.424071991001;4661.930071048937;4663.626909847204;5074.112030394703;5097.7196254206;5107.4892510749;5120.052790233819;5169.327987361657;5016.247562865563;5139.280500729901;5142.820001299937;5146.794128234867;5166.302549155854;4742.146413645542;4793.832215872462;4802.727277271526;4803.855884323476;4825.734584597881;5265.578753699695;5276.997370499593;5276.997370499593;5291.867703307448;5331.360236771535;4927.5811556017425;4990.30135780991;5033.748312584356;5060.696358218519;5068.239764035424;5137.691738495702;5160.432352441228;5178.352705911761;5181.844544663666;5227.085260079547;5083.364579427572;5134.178531435027;5134.845954621367;5138.3577052868395;5174.560162386239;4949.579285760678;5056.721880296545;5096.847094587169;5113.8721531962;5119.3088932994315;4379.890502737393;4399.582039706287;4403.4495688039;4411.889702757392;4454.7549884756;3788.052986753312;3806.9619303807162;3836.290286297044;3838.3091043612417;3852.4028775539837;4268.317069268902;4308.224519586442;4344.218040752632;4379.146066516999;4399;5086.109930762102;5101.489851014869;5112.207607820719;5127.154019586801;5153.072446959508;4414.249577571821;4429.867103986886;4437.889052773707;4470.597646211857;4470.8435204767675;4421.53573874745;4453.576910193527;4466.196084704784;4509.977450112729;4639.327297541838;4717.080169366941;4759.50025247344;4766.999999999931;4822.107910036514;4851.417829860439;5146.948530514647;5149.176131818891;5151.175811870083;5161.148410512224;5209.739513024258;4790.640701947298;4806.086843499724;4809.831655892027;4825.155597770447;4876.171050921423;4902.994886048423;4957.603391728725;4974.502549745142;5019.0463811875625;5026.899462010666;5027.773750181177;5074.2642316864585;5080.593552515716;5107.668001579886;5116.641835071509;5014.5737612303365;5030.572401345927;5067.695938243717;5113.130767769562;5121.129408000724;5035.723035233097;5049.873753156054;5062;5063.1645778446145;5065.13892638245;4757.881052973703;4817.108834865561;4973.502649735142;4986.80052797884;4988.625853060962;4926.950730492793;5032.62255330859;5034.572061374678;5035.496450354935;5066.214736715815;4886.218205087312;4904.460509343898;4921.557059864629;4946.431160416454;4954.108260512998 22:52:51 INFO - PROCESS | 4076 | |1;ext.html;557.6849080269648;596.0998891673571;607.4047433515155;610.3652201710222;612.1796792298319;28249.43501129976;40434.59565404345;41233.58766412335;41344.99999999996;41421.37867931984;41261.79369103158;41692.166156676845;41798.79100604493;41850;41912.16175676492;7609.086909570846;7682.193369696185;7767.922320776805;7776;7778.6888524458955;7630.656620452093;7719.614019299041;7756.495827771205;7768.922310776877;7780.610969451504;7731.961340193319;7751.844963100734;7798.142204357516;7805.765827025199;7811.492253003565;7694.269044440797;7746.728864489744;7747.690092396298;7768.533887966683;7781.26078022587;7628.466007379486;7648.847023059563;7701.614919254015;7713.807154821118;7738.845223095506;38857.22285554301;39353.21293574141;39365.212695745926;39428.81713548598;39585.604143958764;3132.483140281851;3273.1326198557404;3467.4105402081454;3530.8587656493964;3817.2938006468617;29198.416031679248;29214.561781573295;29494.557581636294;29648.110556683117;29928.251793705113;3560.287942411502;3619.402798538238;3632.981835090834;3669.3028324618235;3771.3400154973046;254486;254962;255620;255648;255848.99999999814;31531.527027094613;32380.514292285163;32380.514292285636;34200.65799341975;51998.74000630048;33892.32215355679;34113.31773364569;34162.14594635104;34269.915707586435;34334.14164645904;10702.518386672618;10741.892581074246;10748.731281718019;10765.192610554239;10812.35125892449;9351.859722104175;9352.766180845534;9423.057694230522;9441.24470042395;9460.57427415768;7886.3296619786815;7919.841603167904;7941.36469082472;7978.122406535276;7982.600869956479;3148.134263077626;3157.857896394622;3170.397624451347;3209.4543927532377;3210.7110360067704;898.595631965618;924.6624981881699;944.2870632672289;950.6862735297335;981.2297346582898;27720.445591088064;28372.85813570919;28591.714082859322;29061.564076538867;29183.270418239714;969.781799095212;979.1872745621117;990.7225976726528;1012.427978192319;1128.1313388690662;14938.253087345589;15258.160801156044;15267.389304427921;15312.770308445382;15602;379555;380703;380946;382408;384104;48643.75678121587;48821.75589122032;48914.26628600574;49040;49183.26225106626;1196.4376742930808;1207.5954555223923;1214;1222.419350808359;1235.197121870809;26512.867435662698;27845;28137.859310703316;28523.144305670863;28578.57132142978;42568.787156065264;42619.14761704687;42864.57135428606;42883.7855810719;43005.139897201254;330204;330693;330793;331882;332447;23268.65097023512;25070.74929250684;25337.746622534276;25489.617655734808;25878;42686.146277074906;42726;43204.78397608118;43326.78336608297;43569;36382.636173637926;36880.81559592185;36957.63042369542;37299.81350093232;37363;35604.82197588996;35651.64348356483;35980.10049748777;36360;36386.63613363833;34861.12847178739;35741.46387804133;36232;36480.270394591425;36697.26605467929;31898;32639.11064984873;32920.506192406654;33210.66789332076;33359.33281334311;25502.362440939123;25781.226563203134;26219.820108095562;26284.342891427867;27838.44323113567 22:52:51 INFO - PROCESS | 4076 | |2;jquery.html;354.56388641970375;360.513307035502;364.51701495518444;370.4831759695225;372.10323121277725;15574.766378504317;16287.1042092685;16945.576360590992;17073.7438938416;17134.143292835353;15481.612959676013;16052.83947160528;16796.244169012392;16824.915875420607;16825.41111061113;4992.475790042039;5184.377874655047;5194.71429071401;5195.350581177353;5244.449332820056;3641.6722494975447;5077.314562534048;5668.461496157858;6011.969940150293;6012.3687012863675;6025.548083893704;6035.849103772397;6076.301225359074;6081.726322315506;6085.056816193497;6279.215098112736;6664.666766661648;6689.598624082546;6703.095082163894;6703.8324041899095;6446.677666116722;6825.249222585511;6939.895901561481;6941.757038503628;6947.756828511028;16223.675526489522;20671.89664051685;21975.890120549295;22927.65608515857;23034.76965230343;1866.7199920011972;1978.2087165133917;1987.2746447546685;2069.1516478244;2112.6619740841547;13115.081944263906;13910.443582256697;13949.511767088103;14281.285935703278;15022.549323520203;1868.588910439701;1945.445548018822;1965.9705104423444;1984.28565716342;1993.5414854583382;81213.18786812115;81685;82179;82276;82438;15916.602084947968;16592.751108733377;16776.245068971926;16890.408835690938;17399.73900391495;29027.85486072556;29397;29595;29682.851585741933;29721.702782972327;7768.883466748003;8039.397045221632;8134.389920755849;8242.546659933641;8247.175282471704;6338.334474880071;6383.36166383358;6485.059666348353;6505.934940650533;6526;8277.420580559423;8337;8447.915520844714;8472.322214222848;8562.272206862486;1531.1655147944398;1620.5138458462413;1628.828972957846;1634.2237437217227;3191.8244496552447;364.1678764024192;364.33508846354977;368.3075817463206;829.8547754143001;891.4250308550949;9998.650047248311;10065.748356291006;10117.392956422638;10168.694939151837;10268.332558383681;388.7395445051822;399.656295585796;406.15317063922055;410.47049306395013;413.4542404026656;5418.647787893774;5422.15956526739;5501.312335958005;5528.226048353234;5701;403880;411870;415167;416428;417629;56294.71852640711;81676.18323816804;84631;84720.57639711886;85978;443.35270505062323;445.86178284731835;446.57129156009944;448.34765416319175;449.52350508460484;9793.069658382443;9875.259355548505;10091;10106;10136.138428233387;33981.15047123743;34365.484517731755;35793.284134316644;35822.87506419512;35887.82056089703;50139.49860501348;51813;52291.73854130857;52375;52805.7359713199;7191.3887319578425;7420.623616254699;7497.662605182671;7582.052243469567;7589.279018493235;8112.634931427981;8759.386842921189;9814.75463113428;10090.495475226357;10546.683599492027;9713.222942164752;9721.85417218728;9774.266929980422;9868.901310987085;10091.596336146766;9772.169365604002;10086.445245511568;10144.746381340525;10147.949260253652;10249.795004099728;9665.468399238109;9983.800323993335;10033.397996120257;10077.857241912077;10140.13808826258;7241.203467618452;7243.0946131733535;7324;7456.850862982601;7623.65693543803;9631.903680963382;9904.75238119024;9931.056549627774;10005.699829005142;10060.547275372479 22:52:51 INFO - PROCESS | 4076 | |3;mootools.html;1397.19661194813;1426.1656930695544;1513.3719506404843;1704.4630941253497;1734.6443978984303;6922.930770692292;7560.810979725503;7577.469577129603;8066.435349525528;8076.878846817288;7678.270564296383;7764.223577642233;7870.960645196766;7888.447808653396;7934.047914250298;2176.9564608707856;2210.171185805323;2218.1127548980376;2218.7448443429053;2219.9889000554977;2159.114762947192;2177.0421014753456;2177.412098733341;2196.901139448729;2198.4723666320047;2174.2607513445423;2176.1948079210715;2182.0289970962926;2192.166976548909;2207.2826331442266;2053.599548088131;2057.6913462980597;2061.051916118587;2068.906899189525;2069.286096296775;2099.128861522466;2136.5513242219154;2158.6977823104776;2162.4918144236094;2167.436466518701;7909.24862138096;7939.5633240171765;7945.920540794576;7958.602069896482;7971.48185367955;4391.077873646538;4455.554444555551;4485.573870482299;4511.368408422823;4560.863174104749;2844.1041072062235;2947.882084716609;2973.1675130963363;2976.55351697245;3001.7298443140003;887.3522328700085;897.6364572348209;902.2376092202079;904.4528060523354;918.8392031394479;10986.340819550853;10995.065419439357;11067.114630829596;11074.335539867634;11084.556617735201;4241.97879010603;4258.787060646955;4290.2921018031675;4291.485021797404;4306.80619372129;9315.39449935752;9386.577604007836;9404.811903761887;9461.148496635336;9481.383710058824;4408.118376324684;4443.422355093817;4478.6864919455975;4487.977560112178;4494.415725955605;3556.093196234995;3846.8461261549783;4002.4996875390575;4022.416749571296;4075.816588253536;3694.8891533254045;3710.350688629479;3715.479832823407;3758.680512156497;3845.384738441892;1155.4511606986614;1156.1444531046964;1170.9941450292865;1198.5565340823778;1224.5958833584896;811.3265989228926;825.1094457223346;825.5335735309651;833.6707000734797;840.6343240690319;5210.400803907523;5227.137522308776;5291.682499050069;5402.810901618424;5427.728613569306;883.5184824270659;896.9327300452492;897.2507955856802;901.4861528928448;920.9961142354865;3674.761140525857;3839.0978120141745;3855.6722678572073;3874.7287689862;3917.4123881418013;9020.278377729766;9061.637534498546;9274.258059355236;9277.536123193813;9285.767855803524;9105.726828195166;9119.635214591342;9123.863142052875;9136.862947055799;9156.404833685789;7152.570845749272;7412.221716719667;7425.554466732014;7654.770356889302;7709.691612335444;5538.750756215899;5609.691466969356;5710.172025056427;5736.196932429547;5758.1362795581;8658.78353041179;8924.910750892408;8989.056149104512;9171.495567743837;9250.444973301353;9089;9365.297602679962;9379.624815007322;9495.572699228413;9552;6291.433770960635;6523.934760652332;6663.866722665616;6702.966485167543;6815;7585.848283034419;7615.048118985127;7648;7654;7703.499272547267;6831.6242606657115;6865.965670171618;6952.130983627047;7010.369066784014;7168.426525877813;6995.825104372431;7043.436525078084;7050.5769653820935;7131.786046418616;7203.639818009184;6359.046143078575;6364.363563643598;6447.0329450582785;6457;6484.448821850196;4474.37358769766;4478.529754375743;4508.368828364098;4517.593416592523;4517.954820451753;4860.441049279378;4889.584385327287;4915.803367865388;4916.532929371704;4947.604191664586 22:52:51 INFO - PROCESS | 4076 | |4;prototype.html;294.390611434331;296.41753953481407;302.5265459555794;307.9445699774041;310.9751219902408;4856.223004319309;4989.800407983681;4994.2258949862735;5110.233464980251;5121.6696403136575;5003.024410240005;5013.598912087034;5017.172166592508;5019.573336266421;5032.295478632995;3920.137569734654;3932.4101384792366;3933.0167458135465;3937.9129061597255;3961.683065354779;3647.58052823926;3928.135810121783;3962.6037396260285;3965.6715000474874;3979.3633018716864;3839.78881161536;3854.7494412863075;3865.4781604483314;3881.359575670011;3884.6698030667426;3853.4412510186007;3872.3029854626157;3877.689784817222;3898.4152377143373;3909.1204478992286;3418.5214070030215;3421.538092357525;3440.587129544446;3441.2773317603333;3457.101153700056;4644.420896895072;4806.279058141306;4809.927851082237;4857.348501509504;4858.562729354375;4361.978190109061;4416.123147662262;4425.468943726742;4428.3800267962515;4439.178751930871;5204.76578553966;5216.843494695166;5235.869103272411;5247.921281180786;5251.842444726626;3611.2416392557593;3715.145516531186;3717.1450566369617;3733.2720119576693;3751.8311675974646;5477.329414528567;5500.22996780451;5510.972445137749;5539.667619942817;5551.666899985973;3816.5229346331707;3824.0631045394057;3824.8470061197795;3833.6549710526187;3850.3261929162286;3899.727019108635;3906.531216254011;3910.198409326081;3923.9797652609955;3927.5483319418063;4295.806688699016;4439.334099885043;4451.308502768992;4453.75504347264;4469.41897553316;5247.239150323182;5264.657797243243;5295.034780522919;5295.205719142083;5309.389420216725;1263.24836722152;1299.1685321394316;1329.5014369611395;1334.9265790381428;1342.744878473087;840.4831028917295;850.5917159763349;853.5732133933034;856.3106699107278;865.4201684871151;4114.156597897484;4119.496383819885;4136.9793151034055;4139.3583994480905;4157.958420415817;4837.806487740521;4841.467438581753;4848.903021939542;4856.571714142929;4887.486813884562;4088.468499095158;4098.262312783728;4124.886280704193;4133.8966525837095;4163.960308974466;2627.7124209137387;2677.942212825923;2889.1477014280836;2896.5075937090746;2912.88348466059;5151.381834179922;5169.870753231124;5182.378114626269;5184.585233181412;5193.480651934852;5430.13117901134;5505.752241149158;5609.607327487037;5664.555538337698;5684.772609095672;5140.123854793049;5156.587473002151;5166.638335316567;5168.870778230575;5200.115980283285;5483.314585676791;5496.120620700669;5519.641223320471;5534.944650553443;5564.860878477908;5051.823186188466;5345.305110335787;5373.596980226421;5389.946100539101;5422.430644782241;5062.848114556569;5111.616628752784;5153.304303918923;5193.532582067632;5238.633295669419;3970.900727481836;3995.5615978247224;4014.1570270243574;4014.538328092307;4022.537408198095;5391.353037635509;5396.865078373072;5453.400125986059;5521.309836270466;5548.611597188158;5298.682079075268;5298.894022119459;5319.25530425733;5320.813771517978;5321.3880403754065;5297.576193904401;5305.469453054664;5329.840104796862;5339.119045357628;5352.143657014859;5082.466341034138;5176.301199338041;5199.194124910645;5207.973960130175;5223.164293712987;5290.788368465218;5305.469453054664;5320.255164277081;5333.466653334635;5355.4376790436445;5199.324087868553;5204.765785539736;5219.530242278061;5244.344456942882;5248.134057880559 22:52:51 INFO - PROCESS | 4076 | |5;yui.html;700.3801635552537;735.5366119344812;736.1366714122018;747.5664114813409;777.5023984649822;11485.999999999989;12043;12058.09564282678;12151.331676757774;12162.20945638534;11986.940065299683;12014.519419223243;12471.625851224479;12528.561500347467;12539.059570532201;643.2891654721535;791.2601717394226;796.7251298302076;806.5322113174374;810.6109067647503;817.7955511122219;818.4311903227259;821.3511326052411;823.8599438095538;824.3981893217955;852.5183271451641;859.3683642522741;859.8022454835392;860.1183786618734;861.0313397427893;843.7510934274404;847.3814115695515;848.8090179709578;849.9107593702696;855.3755758296478;625.5464788028688;628.3057221769924;628.6322501336723;629.6757170057424;630.7256343490596;12000.87999120015;12077.577284795078;12120.212186207957;12132.332721700302;12155.088368372319;12924.547640832525;13246;13336.399862006234;13382;13590.59228223155;10464.63373781914;10487.161027117812;10562.894371056267;10588.894111058868;10610.46947652622;3354.9664503354898;3394;3440.4323286657673;3444.6727560881677;3445.173158441981;49924.75037624825;50642;50986.7450662748;51083.23375149376;52633.210501842885;10122.392656440637;10164.695059148238;10230.488475576192;10270.024347686958;10482.63310784119;17405.47783566495;17519.124043797758;17589.29642814299;17669.204885779913;17710.911445442947;6214.844628884314;6510.023496475566;6607.966960165265;6621.106150669598;6674.098996635489;3643.5081264029545;3693.686036686912;3753.3244016076824;3803.2963901678277;3827.349350610403;2727.7817774577984;2839.900603478868;2842.957355639667;2846.1319297614427;2846.4164846206477;505.9241113832881;528.6933578524447;529.8516415403693;542.8887078149049;580.9390014048548;504.3658546310003;533.0059439146042;612.9509639228941;623.3698877435473;629.3329071184559;8226.547539885363;8257;8384.245417912418;8490.363222758318;8741.51921644303;553.950144486998;600.9303439877026;625;642.9099926010363;650.4276236911487;3706.703463722896;3727.925441491155;3739.2334571412794;3883.6989608480912;4043.332850079704;57588.71205643945;58789.70605146947;59017.704911475164;59070.70464647649;59178.40821591815;53104.46895530995;53436.19845702317;53631.46368536264;53656;55182.44817551853;48770.268445973335;49532.25701614479;50057.49942500601;50556;50667;7447.5531468112085;7635.732749353746;7700.1144868338615;7713.652885620273;7876;31505.369892602477;32135.19662008375;32204.355912882078;32352;32465.675343246265;38624.42063368995;40821.59178408178;41678;42015;42042;10048;10446.582136714447;10615.416152111708;10616.203784716332;10726.570937162425;10732.409717465614;10877;10922.126229901747;11094.778104438028;11236.94381528087;9930.9572494887;10007.899921000697;10941.945290273497;11080.445977701243;11425.657230283105;11145.944270278596;11610.187286890174;12082.637520874388;12136.33250171249;12376.319302438453;11198.776024479628;11407.150751217234;11530.59642912494;11800;11950.581729639422;9306.534673266446;9530.857037144588;9573.2820038496;9648.565814538502;9674.17769489573;9960.900390995997;10010.799784004425;10017.69946901565;10090.899091008996;10118.392896426238 22:52:51 INFO - PROCESS | 4076 | __end_tp_report 22:52:51 INFO - PROCESS | 4076 | __start_cc_report 22:52:51 INFO - PROCESS | 4076 | _x_x_mozilla_cycle_collect,353 22:52:51 INFO - PROCESS | 4076 | __end_cc_report 22:52:51 INFO - PROCESS | 4076 | __startTimestamp1463809971482__endTimestamp 22:52:51 INFO - PROCESS | 4076 | 22:52:51 INFO - PROCESS | 4076 | ------- Summary: start ------- 22:52:51 INFO - PROCESS | 4076 | Number of tests: 6 22:52:51 INFO - PROCESS | 4076 | 22:52:51 INFO - PROCESS | 4076 | [#0] dojo.html Cycles:165 Average:4701.39 Median:4825.73 stddev:614.46 (12.7%) stddev-sans-first:595.17 22:52:51 INFO - PROCESS | 4076 | Values: 2662.6 2713.2 2717.5 2719.7 2730.7 4736.4 4757.1 4775.5 4843.8 4901.5 4698.0 4717.8 4756.8 4764.8 4766.5 4346.6 4421.7 4490.9 4494.2 4495.4 16.8 4306.8 4360.0 4403.2 4511.7 4329.5 4351.7 4393.4 4393.5 4394.5 4348.0 4415.4 4431.0 4431.7 4459.0 4375.0 4408.6 4416.1 4422.2 4447.5 4388.6 4572.2 4607.4 4661.9 4663.6 5074.1 5097.7 5107.5 5120.1 5169.3 5016.2 5139.3 5142.8 5146.8 5166.3 4742.1 4793.8 4802.7 4803.9 4825.7 5265.6 5277.0 5277.0 5291.9 5331.4 4927.6 4990.3 5033.7 5060.7 5068.2 5137.7 5160.4 5178.4 5181.8 5227.1 5083.4 5134.2 5134.8 5138.4 5174.6 4949.6 5056.7 5096.8 5113.9 5119.3 4379.9 4399.6 4403.4 4411.9 4454.8 3788.1 3807.0 3836.3 3838.3 3852.4 4268.3 4308.2 4344.2 4379.1 4399.0 5086.1 5101.5 5112.2 5127.2 5153.1 4414.2 4429.9 4437.9 4470.6 4470.8 4421.5 4453.6 4466.2 4510.0 4639.3 4717.1 4759.5 4767.0 4822.1 4851.4 5146.9 5149.2 5151.2 5161.1 5209.7 4790.6 4806.1 4809.8 4825.2 4876.2 4903.0 4957.6 4974.5 5019.0 5026.9 5027.8 5074.3 5080.6 5107.7 5116.6 5014.6 5030.6 5067.7 5113.1 5121.1 5035.7 5049.9 5062.0 5063.2 5065.1 4757.9 4817.1 4973.5 4986.8 4988.6 4927.0 5032.6 5034.6 5035.5 5066.2 4886.2 4904.5 4921.6 4946.4 4954.1 22:52:51 INFO - PROCESS | 4076 | 22:52:51 INFO - PROCESS | 4076 | [#1] ext.html Cycles:180 Average:46341.31 Median:36789.04 stddev:86238.88 (234.4%) stddev-sans-first:86412.29 22:52:51 INFO - PROCESS | 4076 | Values: 557.7 596.1 607.4 610.4 612.2 28249.4 40434.6 41233.6 41345.0 41421.4 41261.8 41692.2 41798.8 41850.0 41912.2 7609.1 7682.2 7767.9 7776.0 7778.7 7630.7 7719.6 7756.5 7768.9 7780.6 7732.0 7751.8 7798.1 7805.8 7811.5 7694.3 7746.7 7747.7 7768.5 7781.3 7628.5 7648.8 7701.6 7713.8 7738.8 38857.2 39353.2 39365.2 39428.8 39585.6 3132.5 3273.1 3467.4 3530.9 3817.3 29198.4 29214.6 29494.6 29648.1 29928.3 3560.3 3619.4 3633.0 3669.3 3771.3 254486.0 254962.0 255620.0 255648.0 255849.0 31531.5 32380.5 32380.5 34200.7 51998.7 33892.3 34113.3 34162.1 34269.9 34334.1 10702.5 10741.9 10748.7 10765.2 10812.4 9351.9 9352.8 9423.1 9441.2 9460.6 7886.3 7919.8 7941.4 7978.1 7982.6 3148.1 3157.9 3170.4 3209.5 3210.7 898.6 924.7 944.3 950.7 981.2 27720.4 28372.9 28591.7 29061.6 29183.3 969.8 979.2 990.7 1012.4 1128.1 14938.3 15258.2 15267.4 15312.8 15602.0 379555.0 380703.0 380946.0 382408.0 384104.0 48643.8 48821.8 48914.3 49040.0 49183.3 1196.4 1207.6 1214.0 1222.4 1235.2 26512.9 27845.0 28137.9 28523.1 28578.6 42568.8 42619.1 42864.6 42883.8 43005.1 330204.0 330693.0 330793.0 331882.0 332447.0 23268.7 25070.7 25337.7 25489.6 25878.0 42686.1 42726.0 43204.8 43326.8 43569.0 36382.6 36880.8 36957.6 37299.8 37363.0 35604.8 35651.6 35980.1 36360.0 36386.6 34861.1 35741.5 36232.0 36480.3 36697.3 31898.0 32639.1 32920.5 33210.7 33359.3 25502.4 25781.2 26219.8 26284.3 27838.4 22:52:51 INFO - PROCESS | 4076 | 22:52:51 INFO - PROCESS | 4076 | [#2] jquery.html Cycles:180 Average:25699.16 Median:447.46 stddev:68363.98 (15278.3%) stddev-sans-first:68529.27 22:52:51 INFO - PROCESS | 4076 | Values: 354.6 360.5 364.5 370.5 372.1 15574.8 16287.1 16945.6 17073.7 17134.1 15481.6 16052.8 16796.2 16824.9 16825.4 4992.5 5184.4 5194.7 5195.4 5244.4 3641.7 5077.3 5668.5 6012.0 6012.4 6025.5 6035.8 6076.3 6081.7 6085.1 6279.2 6664.7 6689.6 6703.1 6703.8 6446.7 6825.2 6939.9 6941.8 6947.8 16223.7 20671.9 21975.9 22927.7 23034.8 1866.7 1978.2 1987.3 2069.2 2112.7 13115.1 13910.4 13949.5 14281.3 15022.5 1868.6 1945.4 1966.0 1984.3 1993.5 81213.2 81685.0 82179.0 82276.0 82438.0 15916.6 16592.8 16776.2 16890.4 17399.7 29027.9 29397.0 29595.0 29682.9 29721.7 7768.9 8039.4 8134.4 8242.5 8247.2 6338.3 6383.4 6485.1 6505.9 6526.0 8277.4 8337.0 8447.9 8472.3 8562.3 1531.2 1620.5 1628.8 1634.2 3191.8 364.2 364.3 368.3 829.9 891.4 9998.7 10065.7 10117.4 10168.7 10268.3 388.7 399.7 406.2 410.5 413.5 5418.6 5422.2 5501.3 5528.2 5701.0 403880.0 411870.0 415167.0 416428.0 417629.0 56294.7 81676.2 84631.0 84720.6 85978.0 443.4 445.9 446.6 448.3 449.5 9793.1 9875.3 10091.0 10106.0 10136.1 33981.2 34365.5 35793.3 35822.9 35887.8 50139.5 51813.0 52291.7 52375.0 52805.7 7191.4 7420.6 7497.7 7582.1 7589.3 8112.6 8759.4 9814.8 10090.5 10546.7 9713.2 9721.9 9774.3 9868.9 10091.6 9772.2 10086.4 10144.7 10147.9 10249.8 9665.5 9983.8 10033.4 10077.9 10140.1 7241.2 7243.1 7324.0 7456.9 7623.7 9631.9 9904.8 9931.1 10005.7 10060.5 22:52:51 INFO - PROCESS | 4076 | 22:52:51 INFO - PROCESS | 4076 | [#3] mootools.html Cycles:180 Average:5192.29 Median:5574.22 stddev:2906.48 (52.1%) stddev-sans-first:2900.64 22:52:51 INFO - PROCESS | 4076 | Values: 1397.2 1426.2 1513.4 1704.5 1734.6 6922.9 7560.8 7577.5 8066.4 8076.9 7678.3 7764.2 7871.0 7888.4 7934.0 2177.0 2210.2 2218.1 2218.7 2220.0 2159.1 2177.0 2177.4 2196.9 2198.5 2174.3 2176.2 2182.0 2192.2 2207.3 2053.6 2057.7 2061.1 2068.9 2069.3 2099.1 2136.6 2158.7 2162.5 2167.4 7909.2 7939.6 7945.9 7958.6 7971.5 4391.1 4455.6 4485.6 4511.4 4560.9 2844.1 2947.9 2973.2 2976.6 3001.7 887.4 897.6 902.2 904.5 918.8 10986.3 10995.1 11067.1 11074.3 11084.6 4242.0 4258.8 4290.3 4291.5 4306.8 9315.4 9386.6 9404.8 9461.1 9481.4 4408.1 4443.4 4478.7 4488.0 4494.4 3556.1 3846.8 4002.5 4022.4 4075.8 3694.9 3710.4 3715.5 3758.7 3845.4 1155.5 1156.1 1171.0 1198.6 1224.6 811.3 825.1 825.5 833.7 840.6 5210.4 5227.1 5291.7 5402.8 5427.7 883.5 896.9 897.3 901.5 921.0 3674.8 3839.1 3855.7 3874.7 3917.4 9020.3 9061.6 9274.3 9277.5 9285.8 9105.7 9119.6 9123.9 9136.9 9156.4 7152.6 7412.2 7425.6 7654.8 7709.7 5538.8 5609.7 5710.2 5736.2 5758.1 8658.8 8924.9 8989.1 9171.5 9250.4 9089.0 9365.3 9379.6 9495.6 9552.0 6291.4 6523.9 6663.9 6703.0 6815.0 7585.8 7615.0 7648.0 7654.0 7703.5 6831.6 6866.0 6952.1 7010.4 7168.4 6995.8 7043.4 7050.6 7131.8 7203.6 6359.0 6364.4 6447.0 6457.0 6484.4 4474.4 4478.5 4508.4 4517.6 4518.0 4860.4 4889.6 4915.8 4916.5 4947.6 22:52:51 INFO - PROCESS | 4076 | 22:52:51 INFO - PROCESS | 4076 | [#4] prototype.html Cycles:180 Average:4340.95 Median:4938.64 stddev:1281.02 (25.9%) stddev-sans-first:1248.09 22:52:51 INFO - PROCESS | 4076 | Values: 294.4 296.4 302.5 307.9 311.0 4856.2 4989.8 4994.2 5110.2 5121.7 5003.0 5013.6 5017.2 5019.6 5032.3 3920.1 3932.4 3933.0 3937.9 3961.7 3647.6 3928.1 3962.6 3965.7 3979.4 3839.8 3854.7 3865.5 3881.4 3884.7 3853.4 3872.3 3877.7 3898.4 3909.1 3418.5 3421.5 3440.6 3441.3 3457.1 4644.4 4806.3 4809.9 4857.3 4858.6 4362.0 4416.1 4425.5 4428.4 4439.2 5204.8 5216.8 5235.9 5247.9 5251.8 3611.2 3715.1 3717.1 3733.3 3751.8 5477.3 5500.2 5511.0 5539.7 5551.7 3816.5 3824.1 3824.8 3833.7 3850.3 3899.7 3906.5 3910.2 3924.0 3927.5 4295.8 4439.3 4451.3 4453.8 4469.4 5247.2 5264.7 5295.0 5295.2 5309.4 1263.2 1299.2 1329.5 1334.9 1342.7 840.5 850.6 853.6 856.3 865.4 4114.2 4119.5 4137.0 4139.4 4158.0 4837.8 4841.5 4848.9 4856.6 4887.5 4088.5 4098.3 4124.9 4133.9 4164.0 2627.7 2677.9 2889.1 2896.5 2912.9 5151.4 5169.9 5182.4 5184.6 5193.5 5430.1 5505.8 5609.6 5664.6 5684.8 5140.1 5156.6 5166.6 5168.9 5200.1 5483.3 5496.1 5519.6 5534.9 5564.9 5051.8 5345.3 5373.6 5389.9 5422.4 5062.8 5111.6 5153.3 5193.5 5238.6 3970.9 3995.6 4014.2 4014.5 4022.5 5391.4 5396.9 5453.4 5521.3 5548.6 5298.7 5298.9 5319.3 5320.8 5321.4 5297.6 5305.5 5329.8 5339.1 5352.1 5082.5 5176.3 5199.2 5208.0 5223.2 5290.8 5305.5 5320.3 5333.5 5355.4 5199.3 5204.8 5219.5 5244.3 5248.1 22:52:51 INFO - PROCESS | 4076 | 22:52:51 INFO - PROCESS | 4076 | [#5] yui.html Cycles:180 Average:13686.74 Median:41846.50 stddev:16375.20 (39.1%) stddev-sans-first:16392.10 22:52:51 INFO - PROCESS | 4076 | Values: 700.4 735.5 736.1 747.6 777.5 11486.0 12043.0 12058.1 12151.3 12162.2 11986.9 12014.5 12471.6 12528.6 12539.1 643.3 791.3 796.7 806.5 810.6 817.8 818.4 821.4 823.9 824.4 852.5 859.4 859.8 860.1 861.0 843.8 847.4 848.8 849.9 855.4 625.5 628.3 628.6 629.7 630.7 12000.9 12077.6 12120.2 12132.3 12155.1 12924.5 13246.0 13336.4 13382.0 13590.6 10464.6 10487.2 10562.9 10588.9 10610.5 3355.0 3394.0 3440.4 3444.7 3445.2 49924.8 50642.0 50986.7 51083.2 52633.2 10122.4 10164.7 10230.5 10270.0 10482.6 17405.5 17519.1 17589.3 17669.2 17710.9 6214.8 6510.0 6608.0 6621.1 6674.1 3643.5 3693.7 3753.3 3803.3 3827.3 2727.8 2839.9 2843.0 2846.1 2846.4 505.9 528.7 529.9 542.9 580.9 504.4 533.0 613.0 623.4 629.3 8226.5 8257.0 8384.2 8490.4 8741.5 554.0 600.9 625.0 642.9 650.4 3706.7 3727.9 3739.2 3883.7 4043.3 57588.7 58789.7 59017.7 59070.7 59178.4 53104.5 53436.2 53631.5 53656.0 55182.4 48770.3 49532.3 50057.5 50556.0 50667.0 7447.6 7635.7 7700.1 7713.7 7876.0 31505.4 32135.2 32204.4 32352.0 32465.7 38624.4 40821.6 41678.0 42015.0 42042.0 10048.0 10446.6 10615.4 10616.2 10726.6 10732.4 10877.0 10922.1 11094.8 11236.9 9931.0 10007.9 10941.9 11080.4 11425.7 11145.9 11610.2 12082.6 12136.3 12376.3 11198.8 11407.2 11530.6 11800.0 11950.6 9306.5 9530.9 9573.3 9648.6 9674.2 9960.9 10010.8 10017.7 10090.9 10118.4 22:52:51 INFO - PROCESS | 4076 | -------- Summary: end -------- 22:52:51 INFO - PROCESS | 4076 | 22:52:51 INFO - PROCESS | 4076 | 22:52:51 INFO - PROCESS | 4076 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2C0042,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 22:52:51 INFO - PROCESS | 4076 | 22:52:51 INFO - PROCESS | 4076 | 22:52:51 INFO - PROCESS | 4076 | ###!!! [Child][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 22:52:51 INFO - PROCESS | 4076 | 22:52:52 INFO - TEST-INFO | 4076: exit 0 22:52:52 INFO - TEST-OK | dromaeo_css | took 1114649ms 22:52:52 INFO - TEST-START | kraken 22:52:52 INFO - operating with platform_type : linux_ 22:52:52 INFO - Initialising browser for kraken test... 22:52:52 INFO - TEST-INFO | started process 4311 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg98N7L/profile http://localhost:45747/getInfo.html) 22:52:56 INFO - PROCESS | 4311 | 22:52:56 INFO - PROCESS | 4311 | (process:4378): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:52:57 INFO - PROCESS | 4311 | __metrics Screen width/height:1600/1200 22:52:57 INFO - PROCESS | 4311 | colorDepth:24 22:52:57 INFO - PROCESS | 4311 | Browser inner width/height: 1024/697 22:52:57 INFO - PROCESS | 4311 | __metrics 22:52:57 ERROR - PROCESS | 4311 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 22:52:58 INFO - TEST-INFO | 4311: exit 0 22:52:58 INFO - Browser initialized. 22:52:58 INFO - Running cycle 1/1 for kraken test... 22:52:58 INFO - TEST-INFO | started process 4430 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg98N7L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:53:00 INFO - PROCESS | 4430 | 22:53:00 INFO - PROCESS | 4430 | (process:4490): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:53:10 INFO - PROCESS | 4430 | RSS: Main: 165605376 22:53:10 INFO - PROCESS | 4430 | 22:53:13 INFO - PROCESS | 4430 | Cycle 1(1): loaded http://localhost:45747/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45747/tests/kraken/driver.html?testName=audio-beat-detection) 22:53:14 INFO - PROCESS | 4430 | RSS: Main: 168808448 22:53:14 INFO - PROCESS | 4430 | 22:53:17 INFO - PROCESS | 4430 | Cycle 1(1): loaded http://localhost:45747/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45747/tests/kraken/driver.html?testName=audio-dft) 22:53:17 INFO - PROCESS | 4430 | RSS: Main: 168837120 22:53:17 INFO - PROCESS | 4430 | 22:53:20 INFO - PROCESS | 4430 | Cycle 1(1): loaded http://localhost:45747/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45747/tests/kraken/driver.html?testName=audio-fft) 22:53:21 INFO - PROCESS | 4430 | RSS: Main: 164438016 22:53:21 INFO - PROCESS | 4430 | 22:53:23 INFO - PROCESS | 4430 | Cycle 1(1): loaded http://localhost:45747/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45747/tests/kraken/driver.html?testName=audio-oscillator) 22:53:24 INFO - PROCESS | 4430 | RSS: Main: 164851712 22:53:24 INFO - PROCESS | 4430 | 22:53:26 INFO - PROCESS | 4430 | Cycle 1(1): loaded http://localhost:45747/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45747/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:53:27 INFO - PROCESS | 4430 | RSS: Main: 165396480 22:53:27 INFO - PROCESS | 4430 | 22:53:30 INFO - PROCESS | 4430 | Cycle 1(1): loaded http://localhost:45747/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45747/tests/kraken/driver.html?testName=imaging-darkroom) 22:53:31 INFO - PROCESS | 4430 | RSS: Main: 165134336 22:53:31 INFO - PROCESS | 4430 | 22:53:34 INFO - PROCESS | 4430 | Cycle 1(1): loaded http://localhost:45747/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45747/tests/kraken/driver.html?testName=imaging-desaturate) 22:53:35 INFO - PROCESS | 4430 | RSS: Main: 164937728 22:53:35 INFO - PROCESS | 4430 | 22:53:38 INFO - PROCESS | 4430 | Cycle 1(1): loaded http://localhost:45747/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45747/tests/kraken/driver.html?testName=json-parse-financial) 22:53:39 INFO - PROCESS | 4430 | RSS: Main: 164900864 22:53:39 INFO - PROCESS | 4430 | 22:53:40 INFO - PROCESS | 4430 | Cycle 1(1): loaded http://localhost:45747/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45747/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:53:41 INFO - PROCESS | 4430 | RSS: Main: 165158912 22:53:41 INFO - PROCESS | 4430 | 22:53:43 INFO - PROCESS | 4430 | Cycle 1(1): loaded http://localhost:45747/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45747/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:53:44 INFO - PROCESS | 4430 | RSS: Main: 166027264 22:53:44 INFO - PROCESS | 4430 | 22:53:46 INFO - PROCESS | 4430 | Cycle 1(1): loaded http://localhost:45747/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45747/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:53:47 INFO - PROCESS | 4430 | RSS: Main: 165732352 22:53:47 INFO - PROCESS | 4430 | 22:53:50 INFO - PROCESS | 4430 | Cycle 1(1): loaded http://localhost:45747/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45747/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:53:50 INFO - PROCESS | 4430 | RSS: Main: 165687296 22:53:50 INFO - PROCESS | 4430 | 22:53:53 INFO - PROCESS | 4430 | Cycle 1(1): loaded http://localhost:45747/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45747/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:53:54 INFO - PROCESS | 4430 | RSS: Main: 165658624 22:53:54 INFO - PROCESS | 4430 | 22:53:56 INFO - PROCESS | 4430 | Cycle 1(1): loaded http://localhost:45747/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45747/tests/kraken/driver.html?testName=ai-astar) 22:53:56 INFO - PROCESS | 4430 | RSS: Main: 168652800 22:53:56 INFO - PROCESS | 4430 | 22:53:56 INFO - PROCESS | 4430 | __start_tp_report 22:53:56 INFO - PROCESS | 4430 | _x_x_mozilla_page_load 22:53:56 INFO - PROCESS | 4430 | _x_x_mozilla_page_load_details 22:53:56 INFO - PROCESS | 4430 | |i|pagename|runs| 22:53:56 INFO - PROCESS | 4430 | |0;ai-astar;119;112;119;114;114;113;115;115;113;114 22:53:56 INFO - PROCESS | 4430 | |1;audio-beat-detection;161;129;162;219;141;155;152;130;189;131 22:53:56 INFO - PROCESS | 4430 | |2;audio-dft;163;168;181;166;162;162;161;162;162;162 22:53:56 INFO - PROCESS | 4430 | |3;audio-fft;75;76;76;166;80;77;77;75;151;76 22:53:56 INFO - PROCESS | 4430 | |4;audio-oscillator;94;95;180;94;93;94;149;95;94;163 22:53:56 INFO - PROCESS | 4430 | |5;imaging-gaussian-blur;118;117;117;118;118;117;118;120;118;118 22:53:56 INFO - PROCESS | 4430 | |6;imaging-darkroom;149;147;147;147;148;147;146;148;149;147 22:53:56 INFO - PROCESS | 4430 | |7;imaging-desaturate;96;95;95;95;96;94;95;95;95;95 22:53:56 INFO - PROCESS | 4430 | |8;json-parse-financial;67;65;66;63;64;65;67;65;65;64 22:53:56 INFO - PROCESS | 4430 | |9;json-stringify-tinderbox;65;65;66;65;65;65;65;65;66;66 22:53:56 INFO - PROCESS | 4430 | |10;stanford-crypto-aes;91;94;91;83;83;83;84;84;151;85 22:53:56 INFO - PROCESS | 4430 | |11;stanford-crypto-ccm;150;152;131;135;142;130;128;139;164;137 22:53:56 INFO - PROCESS | 4430 | |12;stanford-crypto-pbkdf2;173;173;175;174;176;173;175;175;173;174 22:53:56 INFO - PROCESS | 4430 | |13;stanford-crypto-sha256-iterative;67;69;67;66;66;67;66;66;67;70 22:53:56 INFO - PROCESS | 4430 | __end_tp_report 22:53:56 INFO - PROCESS | 4430 | __start_cc_report 22:53:56 INFO - PROCESS | 4430 | _x_x_mozilla_cycle_collect,943 22:53:56 INFO - PROCESS | 4430 | __end_cc_report 22:53:56 INFO - PROCESS | 4430 | __startTimestamp1463810036368__endTimestamp 22:53:56 INFO - PROCESS | 4430 | 22:53:56 INFO - PROCESS | 4430 | ------- Summary: start ------- 22:53:56 INFO - PROCESS | 4430 | Number of tests: 14 22:53:56 INFO - PROCESS | 4430 | 22:53:56 INFO - PROCESS | 4430 | [#0] ai-astar Cycles:10 Average:114.80 Median:114.50 stddev:2.39 (2.1%) stddev-sans-first:2.00 22:53:56 INFO - PROCESS | 4430 | Values: 119.0 112.0 119.0 114.0 114.0 113.0 115.0 115.0 113.0 114.0 22:53:56 INFO - PROCESS | 4430 | 22:53:56 INFO - PROCESS | 4430 | [#1] audio-beat-detection Cycles:10 Average:156.90 Median:158.00 stddev:28.64 (18.1%) stddev-sans-first:30.34 22:53:56 INFO - PROCESS | 4430 | Values: 161.0 129.0 162.0 219.0 141.0 155.0 152.0 130.0 189.0 131.0 22:53:56 INFO - PROCESS | 4430 | 22:53:56 INFO - PROCESS | 4430 | [#2] audio-dft Cycles:10 Average:164.90 Median:162.50 stddev:6.06 (3.7%) stddev-sans-first:6.39 22:53:56 INFO - PROCESS | 4430 | Values: 163.0 168.0 181.0 166.0 162.0 162.0 161.0 162.0 162.0 162.0 22:53:56 INFO - PROCESS | 4430 | 22:53:56 INFO - PROCESS | 4430 | [#3] audio-fft Cycles:10 Average:92.90 Median:76.00 stddev:34.78 (45.8%) stddev-sans-first:36.29 22:53:56 INFO - PROCESS | 4430 | Values: 75.0 76.0 76.0 166.0 80.0 77.0 77.0 75.0 151.0 76.0 22:53:56 INFO - PROCESS | 4430 | 22:53:56 INFO - PROCESS | 4430 | [#4] audio-oscillator Cycles:10 Average:115.10 Median:94.00 stddev:34.53 (36.7%) stddev-sans-first:35.77 22:53:56 INFO - PROCESS | 4430 | Values: 94.0 95.0 180.0 94.0 93.0 94.0 149.0 95.0 94.0 163.0 22:53:56 INFO - PROCESS | 4430 | 22:53:56 INFO - PROCESS | 4430 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.88 (0.7%) stddev-sans-first:0.93 22:53:56 INFO - PROCESS | 4430 | Values: 118.0 117.0 117.0 118.0 118.0 117.0 118.0 120.0 118.0 118.0 22:53:56 INFO - PROCESS | 4430 | 22:53:56 INFO - PROCESS | 4430 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:0.97 (0.7%) stddev-sans-first:0.87 22:53:56 INFO - PROCESS | 4430 | Values: 149.0 147.0 147.0 147.0 148.0 147.0 146.0 148.0 149.0 147.0 22:53:56 INFO - PROCESS | 4430 | 22:53:56 INFO - PROCESS | 4430 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 22:53:56 INFO - PROCESS | 4430 | Values: 96.0 95.0 95.0 95.0 96.0 94.0 95.0 95.0 95.0 95.0 22:53:56 INFO - PROCESS | 4430 | 22:53:56 INFO - PROCESS | 4430 | [#8] json-parse-financial Cycles:10 Average:65.10 Median:65.00 stddev:1.29 (2.0%) stddev-sans-first:1.17 22:53:56 INFO - PROCESS | 4430 | Values: 67.0 65.0 66.0 63.0 64.0 65.0 67.0 65.0 65.0 64.0 22:53:56 INFO - PROCESS | 4430 | 22:53:56 INFO - PROCESS | 4430 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 22:53:56 INFO - PROCESS | 4430 | Values: 65.0 65.0 66.0 65.0 65.0 65.0 65.0 65.0 66.0 66.0 22:53:56 INFO - PROCESS | 4430 | 22:53:56 INFO - PROCESS | 4430 | [#10] stanford-crypto-aes Cycles:10 Average:92.90 Median:84.50 stddev:20.81 (24.6%) stddev-sans-first:22.06 22:53:56 INFO - PROCESS | 4430 | Values: 91.0 94.0 91.0 83.0 83.0 83.0 84.0 84.0 151.0 85.0 22:53:56 INFO - PROCESS | 4430 | 22:53:56 INFO - PROCESS | 4430 | [#11] stanford-crypto-ccm Cycles:10 Average:140.80 Median:140.50 stddev:11.44 (8.1%) stddev-sans-first:11.64 22:53:56 INFO - PROCESS | 4430 | Values: 150.0 152.0 131.0 135.0 142.0 130.0 128.0 139.0 164.0 137.0 22:53:56 INFO - PROCESS | 4430 | 22:53:56 INFO - PROCESS | 4430 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.10 Median:174.50 stddev:1.10 (0.6%) stddev-sans-first:1.09 22:53:56 INFO - PROCESS | 4430 | Values: 173.0 173.0 175.0 174.0 176.0 173.0 175.0 175.0 173.0 174.0 22:53:56 INFO - PROCESS | 4430 | 22:53:56 INFO - PROCESS | 4430 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:1.37 (2.0%) stddev-sans-first:1.45 22:53:56 INFO - PROCESS | 4430 | Values: 67.0 69.0 67.0 66.0 66.0 67.0 66.0 66.0 67.0 70.0 22:53:56 INFO - PROCESS | 4430 | -------- Summary: end -------- 22:53:56 INFO - PROCESS | 4430 | 22:53:57 INFO - TEST-INFO | 4430: exit 0 22:53:57 INFO - TEST-OK | kraken | took 65158ms 22:53:57 INFO - SUITE-END | took 1179s 22:53:57 INFO - Completed test suite (00:19:39) 22:53:57 INFO - javascript benchmark 22:53:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6291.260808248201, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2662.640543526624, 2713.1996061161954, 2717.510848047353, 2719.6736391632994, 2730.713275106114, 4736.384270044894, 4757.096151731169, 4775.450823155338, 4843.790497836795, 4901.509849015097, 4697.953020469794, 4717.834875779348, 4756.833510827122, 4764.78558464869, 4766.5471780180915, 4346.587074227943, 4421.6683748718815, 4490.87728067983, 4494.1910456117885, 4495.3931219285305, 16.764153865777434, 4306.784660766964, 4360.040791025969, 4403.229434848905, 4511.661625378109, 4329.480462344523, 4351.673624478145, 4393.36296237047, 4393.472783265996, 4394.472663280395, 4348.021695118573, 4415.381846541487, 4431.0, 4431.711938723973, 4458.9554104459185, 4374.978125109354, 4408.603225709701, 4416.050549131952, 4422.204003279408, 4447.488538818045, 4388.5830846069575, 4572.199865023607, 4607.424071991001, 4661.930071048937, 4663.626909847204, 5074.112030394703, 5097.7196254206, 5107.4892510749, 5120.052790233819, 5169.327987361657, 5016.247562865563, 5139.280500729901, 5142.820001299937, 5146.794128234867, 5166.302549155854, 4742.146413645542, 4793.832215872462, 4802.727277271526, 4803.855884323476, 4825.734584597881, 5265.578753699695, 5276.997370499593, 5276.997370499593, 5291.867703307448, 5331.360236771535, 4927.5811556017425, 4990.30135780991, 5033.748312584356, 5060.696358218519, 5068.239764035424, 5137.691738495702, 5160.432352441228, 5178.352705911761, 5181.844544663666, 5227.085260079547, 5083.364579427572, 5134.178531435027, 5134.845954621367, 5138.3577052868395, 5174.560162386239, 4949.579285760678, 5056.721880296545, 5096.847094587169, 5113.8721531962, 5119.3088932994315, 4379.890502737393, 4399.582039706287, 4403.4495688039, 4411.889702757392, 4454.7549884756, 3788.052986753312, 3806.9619303807162, 3836.290286297044, 3838.3091043612417, 3852.4028775539837, 4268.317069268902, 4308.224519586442, 4344.218040752632, 4379.146066516999, 4399.0, 5086.109930762102, 5101.489851014869, 5112.207607820719, 5127.154019586801, 5153.072446959508, 4414.249577571821, 4429.867103986886, 4437.889052773707, 4470.597646211857, 4470.8435204767675, 4421.53573874745, 4453.576910193527, 4466.196084704784, 4509.977450112729, 4639.327297541838, 4717.080169366941, 4759.50025247344, 4766.999999999931, 4822.107910036514, 4851.417829860439, 5146.948530514647, 5149.176131818891, 5151.175811870083, 5161.148410512224, 5209.739513024258, 4790.640701947298, 4806.086843499724, 4809.831655892027, 4825.155597770447, 4876.171050921423, 4902.994886048423, 4957.603391728725, 4974.502549745142, 5019.0463811875625, 5026.899462010666, 5027.773750181177, 5074.2642316864585, 5080.593552515716, 5107.668001579886, 5116.641835071509, 5014.5737612303365, 5030.572401345927, 5067.695938243717, 5113.130767769562, 5121.129408000724, 5035.723035233097, 5049.873753156054, 5062.0, 5063.1645778446145, 5065.13892638245, 4757.881052973703, 4817.108834865561, 4973.502649735142, 4986.80052797884, 4988.625853060962, 4926.950730492793, 5032.62255330859, 5034.572061374678, 5035.496450354935, 5066.214736715815, 4886.218205087312, 4904.460509343898, 4921.557059864629, 4946.431160416454, 4954.108260512998], "value": 4665.418111643381, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.6849080269648, 596.0998891673571, 607.4047433515155, 610.3652201710222, 612.1796792298319, 28249.43501129976, 40434.59565404345, 41233.58766412335, 41344.99999999996, 41421.37867931984, 41261.79369103158, 41692.166156676845, 41798.79100604493, 41850.0, 41912.16175676492, 7609.086909570846, 7682.193369696185, 7767.922320776805, 7776.0, 7778.6888524458955, 7630.656620452093, 7719.614019299041, 7756.495827771205, 7768.922310776877, 7780.610969451504, 7731.961340193319, 7751.844963100734, 7798.142204357516, 7805.765827025199, 7811.492253003565, 7694.269044440797, 7746.728864489744, 7747.690092396298, 7768.533887966683, 7781.26078022587, 7628.466007379486, 7648.847023059563, 7701.614919254015, 7713.807154821118, 7738.845223095506, 38857.22285554301, 39353.21293574141, 39365.212695745926, 39428.81713548598, 39585.604143958764, 3132.483140281851, 3273.1326198557404, 3467.4105402081454, 3530.8587656493964, 3817.2938006468617, 29198.416031679248, 29214.561781573295, 29494.557581636294, 29648.110556683117, 29928.251793705113, 3560.287942411502, 3619.402798538238, 3632.981835090834, 3669.3028324618235, 3771.3400154973046, 254486.0, 254962.0, 255620.0, 255648.0, 255848.99999999814, 31531.527027094613, 32380.514292285163, 32380.514292285636, 34200.65799341975, 51998.74000630048, 33892.32215355679, 34113.31773364569, 34162.14594635104, 34269.915707586435, 34334.14164645904, 10702.518386672618, 10741.892581074246, 10748.731281718019, 10765.192610554239, 10812.35125892449, 9351.859722104175, 9352.766180845534, 9423.057694230522, 9441.24470042395, 9460.57427415768, 7886.3296619786815, 7919.841603167904, 7941.36469082472, 7978.122406535276, 7982.600869956479, 3148.134263077626, 3157.857896394622, 3170.397624451347, 3209.4543927532377, 3210.7110360067704, 898.595631965618, 924.6624981881699, 944.2870632672289, 950.6862735297335, 981.2297346582898, 27720.445591088064, 28372.85813570919, 28591.714082859322, 29061.564076538867, 29183.270418239714, 969.781799095212, 979.1872745621117, 990.7225976726528, 1012.427978192319, 1128.1313388690662, 14938.253087345589, 15258.160801156044, 15267.389304427921, 15312.770308445382, 15602.0, 379555.0, 380703.0, 380946.0, 382408.0, 384104.0, 48643.75678121587, 48821.75589122032, 48914.26628600574, 49040.0, 49183.26225106626, 1196.4376742930808, 1207.5954555223923, 1214.0, 1222.419350808359, 1235.197121870809, 26512.867435662698, 27845.0, 28137.859310703316, 28523.144305670863, 28578.57132142978, 42568.787156065264, 42619.14761704687, 42864.57135428606, 42883.7855810719, 43005.139897201254, 330204.0, 330693.0, 330793.0, 331882.0, 332447.0, 23268.65097023512, 25070.74929250684, 25337.746622534276, 25489.617655734808, 25878.0, 42686.146277074906, 42726.0, 43204.78397608118, 43326.78336608297, 43569.0, 36382.636173637926, 36880.81559592185, 36957.63042369542, 37299.81350093232, 37363.0, 35604.82197588996, 35651.64348356483, 35980.10049748777, 36360.0, 36386.63613363833, 34861.12847178739, 35741.46387804133, 36232.0, 36480.270394591425, 36697.26605467929, 31898.0, 32639.11064984873, 32920.506192406654, 33210.66789332076, 33359.33281334311, 25502.362440939123, 25781.226563203134, 26219.820108095562, 26284.342891427867, 27838.44323113567], "value": 16387.23708057579, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.56388641970375, 360.513307035502, 364.51701495518444, 370.4831759695225, 372.10323121277725, 15574.766378504317, 16287.1042092685, 16945.576360590992, 17073.7438938416, 17134.143292835353, 15481.612959676013, 16052.83947160528, 16796.244169012392, 16824.915875420607, 16825.41111061113, 4992.475790042039, 5184.377874655047, 5194.71429071401, 5195.350581177353, 5244.449332820056, 3641.6722494975447, 5077.314562534048, 5668.461496157858, 6011.969940150293, 6012.3687012863675, 6025.548083893704, 6035.849103772397, 6076.301225359074, 6081.726322315506, 6085.056816193497, 6279.215098112736, 6664.666766661648, 6689.598624082546, 6703.095082163894, 6703.8324041899095, 6446.677666116722, 6825.249222585511, 6939.895901561481, 6941.757038503628, 6947.756828511028, 16223.675526489522, 20671.89664051685, 21975.890120549295, 22927.65608515857, 23034.76965230343, 1866.7199920011972, 1978.2087165133917, 1987.2746447546685, 2069.1516478244, 2112.6619740841547, 13115.081944263906, 13910.443582256697, 13949.511767088103, 14281.285935703278, 15022.549323520203, 1868.588910439701, 1945.445548018822, 1965.9705104423444, 1984.28565716342, 1993.5414854583382, 81213.18786812115, 81685.0, 82179.0, 82276.0, 82438.0, 15916.602084947968, 16592.751108733377, 16776.245068971926, 16890.408835690938, 17399.73900391495, 29027.85486072556, 29397.0, 29595.0, 29682.851585741933, 29721.702782972327, 7768.883466748003, 8039.397045221632, 8134.389920755849, 8242.546659933641, 8247.175282471704, 6338.334474880071, 6383.36166383358, 6485.059666348353, 6505.934940650533, 6526.0, 8277.420580559423, 8337.0, 8447.915520844714, 8472.322214222848, 8562.272206862486, 1531.1655147944398, 1620.5138458462413, 1628.828972957846, 1634.2237437217227, 3191.8244496552447, 364.1678764024192, 364.33508846354977, 368.3075817463206, 829.8547754143001, 891.4250308550949, 9998.650047248311, 10065.748356291006, 10117.392956422638, 10168.694939151837, 10268.332558383681, 388.7395445051822, 399.656295585796, 406.15317063922055, 410.47049306395013, 413.4542404026656, 5418.647787893774, 5422.15956526739, 5501.312335958005, 5528.226048353234, 5701.0, 403880.0, 411870.0, 415167.0, 416428.0, 417629.0, 56294.71852640711, 81676.18323816804, 84631.0, 84720.57639711886, 85978.0, 443.35270505062323, 445.86178284731835, 446.57129156009944, 448.34765416319175, 449.52350508460484, 9793.069658382443, 9875.259355548505, 10091.0, 10106.0, 10136.138428233387, 33981.15047123743, 34365.484517731755, 35793.284134316644, 35822.87506419512, 35887.82056089703, 50139.49860501348, 51813.0, 52291.73854130857, 52375.0, 52805.7359713199, 7191.3887319578425, 7420.623616254699, 7497.662605182671, 7582.052243469567, 7589.279018493235, 8112.634931427981, 8759.386842921189, 9814.75463113428, 10090.495475226357, 10546.683599492027, 9713.222942164752, 9721.85417218728, 9774.266929980422, 9868.901310987085, 10091.596336146766, 9772.169365604002, 10086.445245511568, 10144.746381340525, 10147.949260253652, 10249.795004099728, 9665.468399238109, 9983.800323993335, 10033.397996120257, 10077.857241912077, 10140.13808826258, 7241.203467618452, 7243.0946131733535, 7324.0, 7456.850862982601, 7623.65693543803, 9631.903680963382, 9904.75238119024, 9931.056549627774, 10005.699829005142, 10060.547275372479], "value": 8097.69686330755, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1397.19661194813, 1426.1656930695544, 1513.3719506404843, 1704.4630941253497, 1734.6443978984303, 6922.930770692292, 7560.810979725503, 7577.469577129603, 8066.435349525528, 8076.878846817288, 7678.270564296383, 7764.223577642233, 7870.960645196766, 7888.447808653396, 7934.047914250298, 2176.9564608707856, 2210.171185805323, 2218.1127548980376, 2218.7448443429053, 2219.9889000554977, 2159.114762947192, 2177.0421014753456, 2177.412098733341, 2196.901139448729, 2198.4723666320047, 2174.2607513445423, 2176.1948079210715, 2182.0289970962926, 2192.166976548909, 2207.2826331442266, 2053.599548088131, 2057.6913462980597, 2061.051916118587, 2068.906899189525, 2069.286096296775, 2099.128861522466, 2136.5513242219154, 2158.6977823104776, 2162.4918144236094, 2167.436466518701, 7909.24862138096, 7939.5633240171765, 7945.920540794576, 7958.602069896482, 7971.48185367955, 4391.077873646538, 4455.554444555551, 4485.573870482299, 4511.368408422823, 4560.863174104749, 2844.1041072062235, 2947.882084716609, 2973.1675130963363, 2976.55351697245, 3001.7298443140003, 887.3522328700085, 897.6364572348209, 902.2376092202079, 904.4528060523354, 918.8392031394479, 10986.340819550853, 10995.065419439357, 11067.114630829596, 11074.335539867634, 11084.556617735201, 4241.97879010603, 4258.787060646955, 4290.2921018031675, 4291.485021797404, 4306.80619372129, 9315.39449935752, 9386.577604007836, 9404.811903761887, 9461.148496635336, 9481.383710058824, 4408.118376324684, 4443.422355093817, 4478.6864919455975, 4487.977560112178, 4494.415725955605, 3556.093196234995, 3846.8461261549783, 4002.4996875390575, 4022.416749571296, 4075.816588253536, 3694.8891533254045, 3710.350688629479, 3715.479832823407, 3758.680512156497, 3845.384738441892, 1155.4511606986614, 1156.1444531046964, 1170.9941450292865, 1198.5565340823778, 1224.5958833584896, 811.3265989228926, 825.1094457223346, 825.5335735309651, 833.6707000734797, 840.6343240690319, 5210.400803907523, 5227.137522308776, 5291.682499050069, 5402.810901618424, 5427.728613569306, 883.5184824270659, 896.9327300452492, 897.2507955856802, 901.4861528928448, 920.9961142354865, 3674.761140525857, 3839.0978120141745, 3855.6722678572073, 3874.7287689862, 3917.4123881418013, 9020.278377729766, 9061.637534498546, 9274.258059355236, 9277.536123193813, 9285.767855803524, 9105.726828195166, 9119.635214591342, 9123.863142052875, 9136.862947055799, 9156.404833685789, 7152.570845749272, 7412.221716719667, 7425.554466732014, 7654.770356889302, 7709.691612335444, 5538.750756215899, 5609.691466969356, 5710.172025056427, 5736.196932429547, 5758.1362795581, 8658.78353041179, 8924.910750892408, 8989.056149104512, 9171.495567743837, 9250.444973301353, 9089.0, 9365.297602679962, 9379.624815007322, 9495.572699228413, 9552.0, 6291.433770960635, 6523.934760652332, 6663.866722665616, 6702.966485167543, 6815.0, 7585.848283034419, 7615.048118985127, 7648.0, 7654.0, 7703.499272547267, 6831.6242606657115, 6865.965670171618, 6952.130983627047, 7010.369066784014, 7168.426525877813, 6995.825104372431, 7043.436525078084, 7050.5769653820935, 7131.786046418616, 7203.639818009184, 6359.046143078575, 6364.363563643598, 6447.0329450582785, 6457.0, 6484.448821850196, 4474.37358769766, 4478.529754375743, 4508.368828364098, 4517.593416592523, 4517.954820451753, 4860.441049279378, 4889.584385327287, 4915.803367865388, 4916.532929371704, 4947.604191664586], "value": 4177.704598568214, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.390611434331, 296.41753953481407, 302.5265459555794, 307.9445699774041, 310.9751219902408, 4856.223004319309, 4989.800407983681, 4994.2258949862735, 5110.233464980251, 5121.6696403136575, 5003.024410240005, 5013.598912087034, 5017.172166592508, 5019.573336266421, 5032.295478632995, 3920.137569734654, 3932.4101384792366, 3933.0167458135465, 3937.9129061597255, 3961.683065354779, 3647.58052823926, 3928.135810121783, 3962.6037396260285, 3965.6715000474874, 3979.3633018716864, 3839.78881161536, 3854.7494412863075, 3865.4781604483314, 3881.359575670011, 3884.6698030667426, 3853.4412510186007, 3872.3029854626157, 3877.689784817222, 3898.4152377143373, 3909.1204478992286, 3418.5214070030215, 3421.538092357525, 3440.587129544446, 3441.2773317603333, 3457.101153700056, 4644.420896895072, 4806.279058141306, 4809.927851082237, 4857.348501509504, 4858.562729354375, 4361.978190109061, 4416.123147662262, 4425.468943726742, 4428.3800267962515, 4439.178751930871, 5204.76578553966, 5216.843494695166, 5235.869103272411, 5247.921281180786, 5251.842444726626, 3611.2416392557593, 3715.145516531186, 3717.1450566369617, 3733.2720119576693, 3751.8311675974646, 5477.329414528567, 5500.22996780451, 5510.972445137749, 5539.667619942817, 5551.666899985973, 3816.5229346331707, 3824.0631045394057, 3824.8470061197795, 3833.6549710526187, 3850.3261929162286, 3899.727019108635, 3906.531216254011, 3910.198409326081, 3923.9797652609955, 3927.5483319418063, 4295.806688699016, 4439.334099885043, 4451.308502768992, 4453.75504347264, 4469.41897553316, 5247.239150323182, 5264.657797243243, 5295.034780522919, 5295.205719142083, 5309.389420216725, 1263.24836722152, 1299.1685321394316, 1329.5014369611395, 1334.9265790381428, 1342.744878473087, 840.4831028917295, 850.5917159763349, 853.5732133933034, 856.3106699107278, 865.4201684871151, 4114.156597897484, 4119.496383819885, 4136.9793151034055, 4139.3583994480905, 4157.958420415817, 4837.806487740521, 4841.467438581753, 4848.903021939542, 4856.571714142929, 4887.486813884562, 4088.468499095158, 4098.262312783728, 4124.886280704193, 4133.8966525837095, 4163.960308974466, 2627.7124209137387, 2677.942212825923, 2889.1477014280836, 2896.5075937090746, 2912.88348466059, 5151.381834179922, 5169.870753231124, 5182.378114626269, 5184.585233181412, 5193.480651934852, 5430.13117901134, 5505.752241149158, 5609.607327487037, 5664.555538337698, 5684.772609095672, 5140.123854793049, 5156.587473002151, 5166.638335316567, 5168.870778230575, 5200.115980283285, 5483.314585676791, 5496.120620700669, 5519.641223320471, 5534.944650553443, 5564.860878477908, 5051.823186188466, 5345.305110335787, 5373.596980226421, 5389.946100539101, 5422.430644782241, 5062.848114556569, 5111.616628752784, 5153.304303918923, 5193.532582067632, 5238.633295669419, 3970.900727481836, 3995.5615978247224, 4014.1570270243574, 4014.538328092307, 4022.537408198095, 5391.353037635509, 5396.865078373072, 5453.400125986059, 5521.309836270466, 5548.611597188158, 5298.682079075268, 5298.894022119459, 5319.25530425733, 5320.813771517978, 5321.3880403754065, 5297.576193904401, 5305.469453054664, 5329.840104796862, 5339.119045357628, 5352.143657014859, 5082.466341034138, 5176.301199338041, 5199.194124910645, 5207.973960130175, 5223.164293712987, 5290.788368465218, 5305.469453054664, 5320.255164277081, 5333.466653334635, 5355.4376790436445, 5199.324087868553, 5204.765785539736, 5219.530242278061, 5244.344456942882, 5248.134057880559], "value": 3929.7611546070334, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.3801635552537, 735.5366119344812, 736.1366714122018, 747.5664114813409, 777.5023984649822, 11485.999999999989, 12043.0, 12058.09564282678, 12151.331676757774, 12162.20945638534, 11986.940065299683, 12014.519419223243, 12471.625851224479, 12528.561500347467, 12539.059570532201, 643.2891654721535, 791.2601717394226, 796.7251298302076, 806.5322113174374, 810.6109067647503, 817.7955511122219, 818.4311903227259, 821.3511326052411, 823.8599438095538, 824.3981893217955, 852.5183271451641, 859.3683642522741, 859.8022454835392, 860.1183786618734, 861.0313397427893, 843.7510934274404, 847.3814115695515, 848.8090179709578, 849.9107593702696, 855.3755758296478, 625.5464788028688, 628.3057221769924, 628.6322501336723, 629.6757170057424, 630.7256343490596, 12000.87999120015, 12077.577284795078, 12120.212186207957, 12132.332721700302, 12155.088368372319, 12924.547640832525, 13246.0, 13336.399862006234, 13382.0, 13590.59228223155, 10464.63373781914, 10487.161027117812, 10562.894371056267, 10588.894111058868, 10610.46947652622, 3354.9664503354898, 3394.0, 3440.4323286657673, 3444.6727560881677, 3445.173158441981, 49924.75037624825, 50642.0, 50986.7450662748, 51083.23375149376, 52633.210501842885, 10122.392656440637, 10164.695059148238, 10230.488475576192, 10270.024347686958, 10482.63310784119, 17405.47783566495, 17519.124043797758, 17589.29642814299, 17669.204885779913, 17710.911445442947, 6214.844628884314, 6510.023496475566, 6607.966960165265, 6621.106150669598, 6674.098996635489, 3643.5081264029545, 3693.686036686912, 3753.3244016076824, 3803.2963901678277, 3827.349350610403, 2727.7817774577984, 2839.900603478868, 2842.957355639667, 2846.1319297614427, 2846.4164846206477, 505.9241113832881, 528.6933578524447, 529.8516415403693, 542.8887078149049, 580.9390014048548, 504.3658546310003, 533.0059439146042, 612.9509639228941, 623.3698877435473, 629.3329071184559, 8226.547539885363, 8257.0, 8384.245417912418, 8490.363222758318, 8741.51921644303, 553.950144486998, 600.9303439877026, 625.0, 642.9099926010363, 650.4276236911487, 3706.703463722896, 3727.925441491155, 3739.2334571412794, 3883.6989608480912, 4043.332850079704, 57588.71205643945, 58789.70605146947, 59017.704911475164, 59070.70464647649, 59178.40821591815, 53104.46895530995, 53436.19845702317, 53631.46368536264, 53656.0, 55182.44817551853, 48770.268445973335, 49532.25701614479, 50057.49942500601, 50556.0, 50667.0, 7447.5531468112085, 7635.732749353746, 7700.1144868338615, 7713.652885620273, 7876.0, 31505.369892602477, 32135.19662008375, 32204.355912882078, 32352.0, 32465.675343246265, 38624.42063368995, 40821.59178408178, 41678.0, 42015.0, 42042.0, 10048.0, 10446.582136714447, 10615.416152111708, 10616.203784716332, 10726.570937162425, 10732.409717465614, 10877.0, 10922.126229901747, 11094.778104438028, 11236.94381528087, 9930.9572494887, 10007.899921000697, 10941.945290273497, 11080.445977701243, 11425.657230283105, 11145.944270278596, 11610.187286890174, 12082.637520874388, 12136.33250171249, 12376.319302438453, 11198.776024479628, 11407.150751217234, 11530.59642912494, 11800.0, 11950.581729639422, 9306.534673266446, 9530.857037144588, 9573.2820038496, 9648.565814538502, 9674.17769489573, 9960.900390995997, 10010.799784004425, 10017.69946901565, 10090.899091008996, 10118.392896426238], "value": 6099.858261836687, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1610.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 112.0, 119.0, 114.0, 114.0, 113.0, 115.0, 115.0, 113.0, 114.0], "value": 114.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 129.0, 162.0, 219.0, 141.0, 155.0, 152.0, 130.0, 189.0, 131.0], "value": 156.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 168.0, 181.0, 166.0, 162.0, 162.0, 161.0, 162.0, 162.0, 162.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 166.0, 80.0, 77.0, 77.0, 75.0, 151.0, 76.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 180.0, 94.0, 93.0, 94.0, 149.0, 95.0, 94.0, 163.0], "value": 115.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 120.0, 118.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 147.0, 147.0, 148.0, 147.0, 146.0, 148.0, 149.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 66.0, 63.0, 64.0, 65.0, 67.0, 65.0, 65.0, 64.0], "value": 65.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 65.0, 65.0, 65.0, 65.0, 65.0, 66.0, 66.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 94.0, 91.0, 83.0, 83.0, 83.0, 84.0, 84.0, 151.0, 85.0], "value": 92.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 152.0, 131.0, 135.0, 142.0, 130.0, 128.0, 139.0, 164.0, 137.0], "value": 140.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 173.0, 175.0, 174.0, 176.0, 173.0, 175.0, 175.0, 173.0, 174.0], "value": 174.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 67.0, 66.0, 66.0, 67.0, 66.0, 66.0, 67.0, 70.0], "value": 67.1, "unit": "score"}]}]} 22:53:57 INFO - Return code: 0 22:53:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:53:57 ERROR - # TBPL SUCCESS # 22:53:57 INFO - Running post-action listener: _resource_record_post_action 22:53:57 INFO - ##### 22:53:57 INFO - ##### Finished run-tests step (success) 22:53:57 INFO - ##### 22:53:57 INFO - Running post-run listener: _resource_record_post_run 22:53:57 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 425984; Write bytes: 293474304; Read time: 48; Write time: 240528 22:53:57 INFO - TinderboxPrint: CPU usage
13.3% 22:53:57 INFO - TinderboxPrint: I/O read bytes / time
425,984 / 48 22:53:57 INFO - TinderboxPrint: I/O write bytes / time
293,474,304 / 240,528 22:53:57 INFO - TinderboxPrint: CPU idle
8,278.9 (86.7%) 22:53:57 INFO - TinderboxPrint: CPU user
1,225.0 (12.8%) 22:53:57 INFO - TinderboxPrint: Swap in / out
0 / 0 22:53:57 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 1298432; Read time: 0; Write time: 36 22:53:57 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 425984; Write bytes: 292175872; Read time: 48; Write time: 240492 22:53:58 INFO - Running post-run listener: _upload_blobber_files 22:53:58 INFO - Blob upload gear active. 22:53:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:53:58 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 22:53:58 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:53:58 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:53:58 INFO - (blobuploader) - INFO - Open directory for files ... 22:53:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:53:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:53:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:53:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:53:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:53:59 INFO - (blobuploader) - INFO - Done attempting. 22:53:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:53:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:53:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:54:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:54:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:54:00 INFO - (blobuploader) - INFO - Done attempting. 22:54:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:54:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:54:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:54:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:54:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:54:04 INFO - (blobuploader) - INFO - Done attempting. 22:54:04 INFO - (blobuploader) - INFO - Iteration through files over. 22:54:04 INFO - Return code: 0 22:54:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:54:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:54:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c0f98021d6cd28dc80c438bb29085ddd96105b397e5d8a741a9a83dda406e463ac93ef2c89014815bf792365894b7817b07ea2f5ede1a8675039d5adeb62edad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cfc06b49f078b9ed0b508ed6d02af89323ab1572d3205792213110bfefa8d69033400982800d3b106677dc8665d51c0d83e20f4ad32762cc0b49f249c2ce2c3c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad75b8bf55e0d6e2092efe659cc4d5197a7c8a96ef39f493f8120296303d50e300beb25c53833f274063937b96788749433c3fbc90de213f15aa64ac55f23592"} 22:54:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:54:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:54:04 INFO - Contents: 22:54:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c0f98021d6cd28dc80c438bb29085ddd96105b397e5d8a741a9a83dda406e463ac93ef2c89014815bf792365894b7817b07ea2f5ede1a8675039d5adeb62edad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cfc06b49f078b9ed0b508ed6d02af89323ab1572d3205792213110bfefa8d69033400982800d3b106677dc8665d51c0d83e20f4ad32762cc0b49f249c2ce2c3c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad75b8bf55e0d6e2092efe659cc4d5197a7c8a96ef39f493f8120296303d50e300beb25c53833f274063937b96788749433c3fbc90de213f15aa64ac55f23592"} 22:54:04 INFO - Running post-run listener: copy_logs_to_upload_dir 22:54:04 INFO - Copying logs to upload dir... 22:54:04 INFO - mkdir: /builds/slave/test/build/upload/logs 22:54:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.972390 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-05-20 22:54:04.611213) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-20 22:54:04.614996) ========= 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=0333a256a5e4f052382dd180000001b1-1463808614.610631-1167946975 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/Firefox-Non-PGO/sha512/c0f98021d6cd28dc80c438bb29085ddd96105b397e5d8a741a9a83dda406e463ac93ef2c89014815bf792365894b7817b07ea2f5ede1a8675039d5adeb62edad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cfc06b49f078b9ed0b508ed6d02af89323ab1572d3205792213110bfefa8d69033400982800d3b106677dc8665d51c0d83e20f4ad32762cc0b49f249c2ce2c3c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad75b8bf55e0d6e2092efe659cc4d5197a7c8a96ef39f493f8120296303d50e300beb25c53833f274063937b96788749433c3fbc90de213f15aa64ac55f23592"} build_url:https://queue.taskcluster.net/v1/task/Sy-kGYeJQniD5T4K3vdyaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011220 build_url: 'https://queue.taskcluster.net/v1/task/Sy-kGYeJQniD5T4K3vdyaw/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/Firefox-Non-PGO/sha512/c0f98021d6cd28dc80c438bb29085ddd96105b397e5d8a741a9a83dda406e463ac93ef2c89014815bf792365894b7817b07ea2f5ede1a8675039d5adeb62edad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cfc06b49f078b9ed0b508ed6d02af89323ab1572d3205792213110bfefa8d69033400982800d3b106677dc8665d51c0d83e20f4ad32762cc0b49f249c2ce2c3c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad75b8bf55e0d6e2092efe659cc4d5197a7c8a96ef39f493f8120296303d50e300beb25c53833f274063937b96788749433c3fbc90de213f15aa64ac55f23592"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-20 22:54:04.639996) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 22:54:04.640329) ========= 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=0333a256a5e4f052382dd180000001b1-1463808614.610631-1167946975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004376 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 22:54:04.724157) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-20 22:54:04.724561) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-20 22:54:04.724953) ========= ========= Total master_lag: 0.17 =========