builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-034 starttime: 1464390800.25 results: success (0) buildid: 20160527133028 builduid: f169197b6939482d9dc2435f05961ef6 revision: a41a34f7d93659363d352eaad705d4da6d8f465c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 16:13:20.246856) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 16:13:20.247335) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 16:13:20.247661) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 16:13:20.264422) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 16:13:20.264735) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1464390792.608015-1730503185 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-27 16:13:20-- 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% 46.6M=0s 2016-05-27 16:13:20 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.069946 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 16:13:20.352073) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 16:13:20.352759) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1464390792.608015-1730503185 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019596 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 16:13:20.406794) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 16:13:20.407732) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a41a34f7d93659363d352eaad705d4da6d8f465c --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 a41a34f7d93659363d352eaad705d4da6d8f465c --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=d6bbd613908ccac0c6c9cb47000001f7-1464390792.608015-1730503185 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-27 16:13:20,520 truncating revision to first 12 chars 2016-05-27 16:13:20,520 Setting DEBUG logging. 2016-05-27 16:13:20,520 attempt 1/10 2016-05-27 16:13:20,520 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a41a34f7d936?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-27 16:13:20,848 unpacking tar archive at: mozilla-central-a41a34f7d936/testing/mozharness/ program finished with exit code 0 elapsedTime=0.630827 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 16:13:21.053739) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 16:13:21.054073) ========= script_repo_revision: a41a34f7d93659363d352eaad705d4da6d8f465c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 16:13:21.054517) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 16:13:21.054824) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 16:13:21.065904) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-05-27 16:13:21.066221) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=d6bbd613908ccac0c6c9cb47000001f7-1464390792.608015-1730503185 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:13:21 INFO - MultiFileLogger online at 20160527 16:13:21 in /builds/slave/test 16:13:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:13:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:13:21 INFO - {'append_to_log': False, 16:13:21 INFO - 'base_work_dir': '/builds/slave/test', 16:13:21 INFO - 'blob_upload_branch': 'Firefox', 16:13:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:13:21 INFO - 'branch': 'Firefox', 16:13:21 INFO - 'buildbot_json_path': 'buildprops.json', 16:13:21 INFO - 'config_files': ('talos/linux_config.py',), 16:13:21 INFO - 'default_actions': ('clobber', 16:13:21 INFO - 'read-buildbot-config', 16:13:21 INFO - 'download-and-extract', 16:13:21 INFO - 'populate-webroot', 16:13:21 INFO - 'create-virtualenv', 16:13:21 INFO - 'install', 16:13:21 INFO - 'run-tests'), 16:13:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:13:21 INFO - 'download_minidump_stackwalk': True, 16:13:21 INFO - 'download_symbols': 'ondemand', 16:13:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:13:21 INFO - 'tooltool.py': '/tools/tooltool.py', 16:13:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:13:21 INFO - '/tools/misc-python/virtualenv.py')}, 16:13:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:13:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:13:21 INFO - 'installer_path': 'installer.exe', 16:13:21 INFO - 'log_level': 'info', 16:13:21 INFO - 'log_name': 'talos', 16:13:21 INFO - 'log_to_console': True, 16:13:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:13:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:13:21 INFO - 'opt_config_files': (), 16:13:21 INFO - 'pip_index': False, 16:13:21 INFO - 'sps_profile': False, 16:13:21 INFO - 'sps_profile_interval': 0, 16:13:21 INFO - 'suite': 'dromaeojs', 16:13:21 INFO - 'system_bits': '32', 16:13:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:13:21 INFO - 'title': 'talos-linux64-ix-034', 16:13:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:13:21 INFO - 'use_talos_json': True, 16:13:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:13:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:13:21 INFO - 'work_dir': 'build'} 16:13:21 INFO - ##### 16:13:21 INFO - ##### Running clobber step. 16:13:21 INFO - ##### 16:13:21 INFO - Running pre-action listener: _resource_record_pre_action 16:13:21 INFO - Running main action method: clobber 16:13:21 INFO - rmtree: /builds/slave/test/build 16:13:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:13:21 INFO - Running post-action listener: _resource_record_post_action 16:13:21 INFO - ##### 16:13:21 INFO - ##### Finished clobber step (success) 16:13:21 INFO - ##### 16:13:21 INFO - ##### 16:13:21 INFO - ##### Running read-buildbot-config step. 16:13:21 INFO - ##### 16:13:21 INFO - Running pre-action listener: _resource_record_pre_action 16:13:21 INFO - Running main action method: read_buildbot_config 16:13:21 INFO - Using buildbot properties: 16:13:21 INFO - { 16:13:21 INFO - "project": "", 16:13:21 INFO - "product": "firefox", 16:13:21 INFO - "script_repo_revision": "production", 16:13:21 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 16:13:21 INFO - "repository": "", 16:13:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 16:13:21 INFO - "buildid": "20160527133028", 16:13:21 INFO - "pgo_build": "True", 16:13:21 INFO - "basedir": "/builds/slave/test", 16:13:21 INFO - "buildnumber": 458, 16:13:21 INFO - "slavename": "talos-linux64-ix-034", 16:13:21 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:13:21 INFO - "platform": "ubuntu64_hw", 16:13:21 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 16:13:21 INFO - "branch": "mozilla-central", 16:13:21 INFO - "repo_path": "mozilla-central", 16:13:21 INFO - "revision": "a41a34f7d93659363d352eaad705d4da6d8f465c", 16:13:21 INFO - "stage_platform": "linux64-pgo", 16:13:21 INFO - "builduid": "f169197b6939482d9dc2435f05961ef6", 16:13:21 INFO - "slavebuilddir": "test" 16:13:21 INFO - } 16:13:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/dokNQB2XT82AEM0wdpCLcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 16:13:21 INFO - Running post-action listener: _resource_record_post_action 16:13:21 INFO - ##### 16:13:21 INFO - ##### Finished read-buildbot-config step (success) 16:13:21 INFO - ##### 16:13:21 INFO - ##### 16:13:21 INFO - ##### Running download-and-extract step. 16:13:21 INFO - ##### 16:13:21 INFO - Running pre-action listener: _resource_record_pre_action 16:13:21 INFO - Running main action method: download_and_extract 16:13:21 INFO - mkdir: /builds/slave/test/build/tests 16:13:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:21 INFO - https://queue.taskcluster.net/v1/task/dokNQB2XT82AEM0wdpCLcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:13:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dokNQB2XT82AEM0wdpCLcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:13:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dokNQB2XT82AEM0wdpCLcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:13:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dokNQB2XT82AEM0wdpCLcg/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 16:13:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dokNQB2XT82AEM0wdpCLcg/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 16:13:22 INFO - Downloaded 1361 bytes. 16:13:22 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:13:22 INFO - Using the following test package requirements: 16:13:22 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 16:13:22 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:13:22 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:13:22 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:22 INFO - u'jsshell-linux-x86_64.zip'], 16:13:22 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:13:22 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 16:13:22 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:13:22 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:13:22 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:13:22 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:13:22 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:13:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:22 INFO - https://queue.taskcluster.net/v1/task/dokNQB2XT82AEM0wdpCLcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:13:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dokNQB2XT82AEM0wdpCLcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:13:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dokNQB2XT82AEM0wdpCLcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:13:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dokNQB2XT82AEM0wdpCLcg/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 16:13:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dokNQB2XT82AEM0wdpCLcg/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 16:13:24 INFO - Downloaded 24411241 bytes. 16:13:24 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'] 16:13:24 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 16:13:25 INFO - Return code: 0 16:13:25 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 16:13: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')]} 16:13:25 INFO - https://queue.taskcluster.net/v1/task/dokNQB2XT82AEM0wdpCLcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:13:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dokNQB2XT82AEM0wdpCLcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:13:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dokNQB2XT82AEM0wdpCLcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:13:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dokNQB2XT82AEM0wdpCLcg/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 16:13:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dokNQB2XT82AEM0wdpCLcg/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 16:13:39 INFO - Downloaded 24411241 bytes. 16:13:39 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'] 16:13:39 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 16:13:40 INFO - Return code: 0 16:13:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:40 INFO - https://queue.taskcluster.net/v1/task/dokNQB2XT82AEM0wdpCLcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:13:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dokNQB2XT82AEM0wdpCLcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 16:13:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dokNQB2XT82AEM0wdpCLcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 16:13:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dokNQB2XT82AEM0wdpCLcg/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 16:13:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dokNQB2XT82AEM0wdpCLcg/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 16:13:41 INFO - Downloaded 10834034 bytes. 16:13:41 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'] 16:13:41 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 16:13:41 INFO - Return code: 0 16:13: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')]} 16:13:41 INFO - https://queue.taskcluster.net/v1/task/dokNQB2XT82AEM0wdpCLcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:13:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dokNQB2XT82AEM0wdpCLcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:13:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dokNQB2XT82AEM0wdpCLcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:13:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dokNQB2XT82AEM0wdpCLcg/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 16:13:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dokNQB2XT82AEM0wdpCLcg/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 16:13:43 INFO - Downloaded 58663135 bytes. 16:13:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dokNQB2XT82AEM0wdpCLcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:13:43 INFO - mkdir: /builds/slave/test/properties 16:13:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:13:43 INFO - Writing to file /builds/slave/test/properties/build_url 16:13:43 INFO - Contents: 16:13:43 INFO - build_url:https://queue.taskcluster.net/v1/task/dokNQB2XT82AEM0wdpCLcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:13:44 INFO - Running post-action listener: _resource_record_post_action 16:13:44 INFO - Running post-action listener: set_extra_try_arguments 16:13:44 INFO - ##### 16:13:44 INFO - ##### Finished download-and-extract step (success) 16:13:44 INFO - ##### 16:13:44 INFO - ##### 16:13:44 INFO - ##### Running populate-webroot step. 16:13:44 INFO - ##### 16:13:44 INFO - Running pre-action listener: _resource_record_pre_action 16:13:44 INFO - Running main action method: populate_webroot 16:13:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:13:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:13:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:13:44 INFO - '--tppagecycles', 16:13:44 INFO - '7'], 16:13:44 INFO - 'tests': ['tsvgm']}}, 16:13:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:13:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:13:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:13:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:13:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:13:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:13:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:44 INFO - 'talos_options': ['--disable-e10s'], 16:13:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:13:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:13:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:44 INFO - 'talos_options': ['--disable-e10s'], 16:13:44 INFO - 'tests': ['damp', 'tps']}, 16:13:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:44 INFO - 'tests': ['damp', 'tps']}, 16:13:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:13:44 INFO - 'tests': ['dromaeo_dom']}, 16:13:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:13:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:13:44 INFO - 'tests': ['a11yr', 16:13:44 INFO - 'ts_paint', 16:13:44 INFO - 'tpaint', 16:13:44 INFO - 'sessionrestore', 16:13:44 INFO - 'sessionrestore_no_auto_restore', 16:13:44 INFO - 'tabpaint']}, 16:13:44 INFO - 'other-e10s': {'tests': ['a11yr', 16:13:44 INFO - 'ts_paint', 16:13:44 INFO - 'tpaint', 16:13:44 INFO - 'sessionrestore', 16:13:44 INFO - 'sessionrestore_no_auto_restore', 16:13:44 INFO - 'tabpaint']}, 16:13:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:13:44 INFO - 'ts_paint', 16:13:44 INFO - 'tpaint', 16:13:44 INFO - 'sessionrestore', 16:13:44 INFO - 'sessionrestore_no_auto_restore', 16:13:44 INFO - 'tabpaint']}, 16:13:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:13:44 INFO - 'ts_paint', 16:13:44 INFO - 'tpaint', 16:13:44 INFO - 'sessionrestore', 16:13:44 INFO - 'sessionrestore_no_auto_restore', 16:13:44 INFO - 'tabpaint']}, 16:13:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:13:44 INFO - 'tests': ['a11yr', 16:13:44 INFO - 'ts_paint', 16:13:44 INFO - 'tpaint', 16:13:44 INFO - 'sessionrestore', 16:13:44 INFO - 'sessionrestore_no_auto_restore', 16:13:44 INFO - 'tabpaint']}, 16:13:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:13:44 INFO - 'tests': ['a11yr', 16:13:44 INFO - 'ts_paint', 16:13:44 INFO - 'tpaint', 16:13:44 INFO - 'sessionrestore', 16:13:44 INFO - 'sessionrestore_no_auto_restore', 16:13:44 INFO - 'tabpaint']}, 16:13:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:13:44 INFO - 'tests': ['tsvgx', 16:13:44 INFO - 'tsvgr_opacity', 16:13:44 INFO - 'tart', 16:13:44 INFO - 'tscrollx', 16:13:44 INFO - 'cart']}, 16:13:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:13:44 INFO - 'tsvgr_opacity', 16:13:44 INFO - 'tart', 16:13:44 INFO - 'tscrollx', 16:13:44 INFO - 'cart']}, 16:13:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:44 INFO - 'talos_options': ['--disable-e10s'], 16:13:44 INFO - 'tests': ['tp5o']}, 16:13:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:44 INFO - 'tests': ['tp5o']}, 16:13:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:44 INFO - 'talos_options': ['--disable-e10s', 16:13:44 INFO - '--xperf_path', 16:13:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:13:44 INFO - 'tests': ['tp5n']}, 16:13:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:44 INFO - 'talos_options': ['--xperf_path', 16:13:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:13:44 INFO - 'tests': ['tp5n']}}, 16:13:44 INFO - 'talos.zip': {'path': '', 16:13:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:13:44 INFO - Running post-action listener: _resource_record_post_action 16:13:44 INFO - ##### 16:13:44 INFO - ##### Finished populate-webroot step (success) 16:13:44 INFO - ##### 16:13:44 INFO - ##### 16:13:44 INFO - ##### Running create-virtualenv step. 16:13:44 INFO - ##### 16:13:44 INFO - Running pre-action listener: _resource_record_pre_action 16:13:44 INFO - Running main action method: create_virtualenv 16:13:44 INFO - Creating virtualenv /builds/slave/test/build/venv 16:13:44 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 16:13:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:13:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:13:44 INFO - Using real prefix '/usr' 16:13:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:13:45 INFO - Installing distribute.............................................................................................................................................................................................done. 16:13:47 INFO - Installing pip.................done. 16:13:47 INFO - Return code: 0 16:13:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:13: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')]} 16:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13: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')]} 16:13:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb071af4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25809c0>, '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 0x25818c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2581d50>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1464390792.608015-1730503185', '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 16:13:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:13:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:13:47 INFO - Using env: {'DISPLAY': ':0', 16:13:47 INFO - 'HOME': '/home/cltbld', 16:13:47 INFO - 'LANG': 'en_US.UTF-8', 16:13:47 INFO - 'LANGUAGE': 'en_US:en', 16:13:47 INFO - 'LOGNAME': 'cltbld', 16:13:47 INFO - 'MAIL': '/var/mail/cltbld', 16:13:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:47 INFO - 'MOZ_NO_REMOTE': '1', 16:13:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:47 INFO - 'NO_EM_RESTART': '1', 16:13:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:47 INFO - 'PWD': '/builds/slave/test', 16:13:47 INFO - 'SHELL': '/bin/bash', 16:13:47 INFO - 'SHLVL': '1', 16:13:47 INFO - 'TERM': 'linux', 16:13:47 INFO - 'TMOUT': '86400', 16:13:47 INFO - 'USER': 'cltbld', 16:13:47 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464390792.608015-1730503185', 16:13:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:47 INFO - '_': '/tools/buildbot/bin/python'} 16:13:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:47 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 16:13:47 INFO - Cleaning up... 16:13:47 INFO - Return code: 0 16:13:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:13: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')]} 16:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13: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')]} 16:13:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb071af4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25809c0>, '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 0x25818c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2581d50>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1464390792.608015-1730503185', '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 16:13:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:13:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:13:47 INFO - Using env: {'DISPLAY': ':0', 16:13:47 INFO - 'HOME': '/home/cltbld', 16:13:47 INFO - 'LANG': 'en_US.UTF-8', 16:13:47 INFO - 'LANGUAGE': 'en_US:en', 16:13:47 INFO - 'LOGNAME': 'cltbld', 16:13:47 INFO - 'MAIL': '/var/mail/cltbld', 16:13:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:47 INFO - 'MOZ_NO_REMOTE': '1', 16:13:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:47 INFO - 'NO_EM_RESTART': '1', 16:13:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:47 INFO - 'PWD': '/builds/slave/test', 16:13:47 INFO - 'SHELL': '/bin/bash', 16:13:47 INFO - 'SHLVL': '1', 16:13:47 INFO - 'TERM': 'linux', 16:13:47 INFO - 'TMOUT': '86400', 16:13:47 INFO - 'USER': 'cltbld', 16:13:47 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464390792.608015-1730503185', 16:13:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:47 INFO - '_': '/tools/buildbot/bin/python'} 16:13:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:47 INFO - Downloading/unpacking psutil>=3.1.1 16:13:47 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 16:13:47 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 16:13:47 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 16:13:47 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 16:13:47 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 16:13:47 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 16:13:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:13:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:13:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:13:49 INFO - Installing collected packages: psutil 16:13:49 INFO - Running setup.py install for psutil 16:13:49 INFO - building 'psutil._psutil_linux' extension 16:13:49 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 16:13:49 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 16:13:49 INFO - building 'psutil._psutil_posix' extension 16:13:49 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 16:13:49 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 16:13:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:13:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:13:50 INFO - Successfully installed psutil 16:13:50 INFO - Cleaning up... 16:13:50 INFO - Return code: 0 16:13:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:13: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')]} 16:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13: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')]} 16:13:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb071af4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25809c0>, '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 0x25818c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2581d50>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1464390792.608015-1730503185', '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 16:13:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:13:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:13:50 INFO - Using env: {'DISPLAY': ':0', 16:13:50 INFO - 'HOME': '/home/cltbld', 16:13:50 INFO - 'LANG': 'en_US.UTF-8', 16:13:50 INFO - 'LANGUAGE': 'en_US:en', 16:13:50 INFO - 'LOGNAME': 'cltbld', 16:13:50 INFO - 'MAIL': '/var/mail/cltbld', 16:13:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:50 INFO - 'MOZ_NO_REMOTE': '1', 16:13:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:50 INFO - 'NO_EM_RESTART': '1', 16:13:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:50 INFO - 'PWD': '/builds/slave/test', 16:13:50 INFO - 'SHELL': '/bin/bash', 16:13:50 INFO - 'SHLVL': '1', 16:13:50 INFO - 'TERM': 'linux', 16:13:50 INFO - 'TMOUT': '86400', 16:13:50 INFO - 'USER': 'cltbld', 16:13:50 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464390792.608015-1730503185', 16:13:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:50 INFO - '_': '/tools/buildbot/bin/python'} 16:13:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:13:50 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 16:13:50 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 16:13:50 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 16:13:50 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 16:13:50 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 16:13:50 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 16:13:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:13:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:13:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:13:52 INFO - Installing collected packages: mozsystemmonitor 16:13:52 INFO - Running setup.py install for mozsystemmonitor 16:13:52 INFO - Successfully installed mozsystemmonitor 16:13:52 INFO - Cleaning up... 16:13:52 INFO - Return code: 0 16:13:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:13:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:52 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 0x7fb071af4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25809c0>, '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 0x25818c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2581d50>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1464390792.608015-1730503185', '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 16:13:52 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 16:13:52 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 16:13:52 INFO - Using env: {'DISPLAY': ':0', 16:13:52 INFO - 'HOME': '/home/cltbld', 16:13:52 INFO - 'LANG': 'en_US.UTF-8', 16:13:52 INFO - 'LANGUAGE': 'en_US:en', 16:13:52 INFO - 'LOGNAME': 'cltbld', 16:13:52 INFO - 'MAIL': '/var/mail/cltbld', 16:13:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:52 INFO - 'MOZ_NO_REMOTE': '1', 16:13:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:52 INFO - 'NO_EM_RESTART': '1', 16:13:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:52 INFO - 'PWD': '/builds/slave/test', 16:13:52 INFO - 'SHELL': '/bin/bash', 16:13:52 INFO - 'SHLVL': '1', 16:13:52 INFO - 'TERM': 'linux', 16:13:52 INFO - 'TMOUT': '86400', 16:13:52 INFO - 'USER': 'cltbld', 16:13:52 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464390792.608015-1730503185', 16:13:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:52 INFO - '_': '/tools/buildbot/bin/python'} 16:13:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:52 INFO - Downloading/unpacking blobuploader==1.2.4 16:13: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 16:13: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 16:13: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 16:13: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 16:13: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 16:13: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 16:13:54 INFO - Downloading blobuploader-1.2.4.tar.gz 16:13:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:13:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:13: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 16:13: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 16:13: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 16:13: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 16:13: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 16:13: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 16:13:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:13:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:55 INFO - Downloading docopt-0.6.1.tar.gz 16:13:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:13:55 INFO - Installing collected packages: blobuploader, requests, docopt 16:13:55 INFO - Running setup.py install for blobuploader 16:13:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:13:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:13:55 INFO - Running setup.py install for requests 16:13:55 INFO - Running setup.py install for docopt 16:13:55 INFO - Successfully installed blobuploader requests docopt 16:13:55 INFO - Cleaning up... 16:13:55 INFO - Return code: 0 16:13:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:13:55 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')]} 16:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:55 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')]} 16:13:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:55 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 0x7fb071af4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25809c0>, '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 0x25818c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2581d50>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1464390792.608015-1730503185', '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 16:13:55 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 16:13:55 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 16:13:55 INFO - Using env: {'DISPLAY': ':0', 16:13:55 INFO - 'HOME': '/home/cltbld', 16:13:55 INFO - 'LANG': 'en_US.UTF-8', 16:13:55 INFO - 'LANGUAGE': 'en_US:en', 16:13:55 INFO - 'LOGNAME': 'cltbld', 16:13:55 INFO - 'MAIL': '/var/mail/cltbld', 16:13:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:55 INFO - 'MOZ_NO_REMOTE': '1', 16:13:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:55 INFO - 'NO_EM_RESTART': '1', 16:13:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:55 INFO - 'PWD': '/builds/slave/test', 16:13:55 INFO - 'SHELL': '/bin/bash', 16:13:55 INFO - 'SHLVL': '1', 16:13:55 INFO - 'TERM': 'linux', 16:13:55 INFO - 'TMOUT': '86400', 16:13:55 INFO - 'USER': 'cltbld', 16:13:55 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464390792.608015-1730503185', 16:13:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:55 INFO - '_': '/tools/buildbot/bin/python'} 16:13:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:13:56 INFO - Running setup.py (path:/tmp/pip-yiMP8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:13:56 INFO - Running setup.py (path:/tmp/pip-IGh9ob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:13:56 INFO - Running setup.py (path:/tmp/pip-eoXXC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:13:56 INFO - Running setup.py (path:/tmp/pip-s5db9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:13:56 INFO - Running setup.py (path:/tmp/pip-DCI1Wp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:13:56 INFO - Running setup.py (path:/tmp/pip-Sh2L4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:13:56 INFO - Running setup.py (path:/tmp/pip-GRXu4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:13:56 INFO - Running setup.py (path:/tmp/pip-vRMKDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:13:56 INFO - Running setup.py (path:/tmp/pip-DkdAw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:13:56 INFO - Running setup.py (path:/tmp/pip-d1FGzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:13:56 INFO - Running setup.py (path:/tmp/pip-2q93ND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:13:56 INFO - Running setup.py (path:/tmp/pip-wV2ac2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:13:56 INFO - Running setup.py (path:/tmp/pip-Hq3dAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:13:57 INFO - Running setup.py (path:/tmp/pip-Ywphub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:13:57 INFO - Running setup.py (path:/tmp/pip-_cWXxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:13:57 INFO - Running setup.py (path:/tmp/pip-0C9aIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:13:57 INFO - Running setup.py (path:/tmp/pip-2oGICQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:13:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:13:57 INFO - Running setup.py install for manifestparser 16:13:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:13:57 INFO - Running setup.py install for mozcrash 16:13:57 INFO - Running setup.py install for mozdebug 16:13:57 INFO - Running setup.py install for mozdevice 16:13:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:13:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:13:57 INFO - Running setup.py install for mozfile 16:13:57 INFO - Running setup.py install for mozhttpd 16:13:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:13:57 INFO - Running setup.py install for mozinfo 16:13:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:13:58 INFO - Running setup.py install for mozInstall 16:13:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:13:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:13:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:13:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:13:58 INFO - Running setup.py install for mozleak 16:13:58 INFO - Running setup.py install for mozlog 16:13:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:13:58 INFO - Running setup.py install for moznetwork 16:13:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:13:58 INFO - Running setup.py install for mozprocess 16:13:58 INFO - Running setup.py install for mozprofile 16:13:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:13:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:13:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:13:58 INFO - Running setup.py install for mozrunner 16:13:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:13:58 INFO - Running setup.py install for mozscreenshot 16:13:58 INFO - Running setup.py install for moztest 16:13:58 INFO - Running setup.py install for mozversion 16:13:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:13:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:13:59 INFO - Cleaning up... 16:13:59 INFO - Return code: 0 16:13:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:13:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb071af4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25809c0>, '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 0x25818c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2581d50>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1464390792.608015-1730503185', '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 16:13:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:13:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:13:59 INFO - Using env: {'DISPLAY': ':0', 16:13:59 INFO - 'HOME': '/home/cltbld', 16:13:59 INFO - 'LANG': 'en_US.UTF-8', 16:13:59 INFO - 'LANGUAGE': 'en_US:en', 16:13:59 INFO - 'LOGNAME': 'cltbld', 16:13:59 INFO - 'MAIL': '/var/mail/cltbld', 16:13:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:59 INFO - 'MOZ_NO_REMOTE': '1', 16:13:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:59 INFO - 'NO_EM_RESTART': '1', 16:13:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:59 INFO - 'PWD': '/builds/slave/test', 16:13:59 INFO - 'SHELL': '/bin/bash', 16:13:59 INFO - 'SHLVL': '1', 16:13:59 INFO - 'TERM': 'linux', 16:13:59 INFO - 'TMOUT': '86400', 16:13:59 INFO - 'USER': 'cltbld', 16:13:59 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464390792.608015-1730503185', 16:13:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:59 INFO - '_': '/tools/buildbot/bin/python'} 16:13:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:13:59 INFO - Running setup.py (path:/tmp/pip-3YUy1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:13:59 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)) 16:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:13:59 INFO - Running setup.py (path:/tmp/pip-Gp_dCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:13:59 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)) 16:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:13:59 INFO - Running setup.py (path:/tmp/pip-h3sDOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:13:59 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)) 16:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:13:59 INFO - Running setup.py (path:/tmp/pip-yKyGC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:13:59 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)) 16:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:13:59 INFO - Running setup.py (path:/tmp/pip-1acwvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:13:59 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)) 16:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:13:59 INFO - Running setup.py (path:/tmp/pip-TfQ5zG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:13:59 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)) 16:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:13:59 INFO - Running setup.py (path:/tmp/pip-ZWVIgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:13:59 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)) 16:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:13:59 INFO - Running setup.py (path:/tmp/pip-OTY6Oz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:13:59 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)) 16:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:13:59 INFO - Running setup.py (path:/tmp/pip-tq7qhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:13:59 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)) 16:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:13:59 INFO - Running setup.py (path:/tmp/pip-HwMoHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:14:00 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)) 16:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:14:00 INFO - Running setup.py (path:/tmp/pip-cHp_nA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:14:00 INFO - Running setup.py (path:/tmp/pip-RYRetL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:14:00 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)) 16:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:14:00 INFO - Running setup.py (path:/tmp/pip-GO77bt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:14:00 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)) 16:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:14:00 INFO - Running setup.py (path:/tmp/pip-0qcYA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:14:00 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)) 16:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:14:00 INFO - Running setup.py (path:/tmp/pip-91ejFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:14:00 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)) 16:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:14:00 INFO - Running setup.py (path:/tmp/pip-DDkdTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:14:00 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)) 16:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:14:00 INFO - Running setup.py (path:/tmp/pip-7E0uCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:14:00 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)) 16:14:00 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)) 16:14:00 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)) 16:14:00 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)) 16:14:00 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)) 16:14:00 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)) 16:14:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:02 INFO - Downloading blessings-1.6.tar.gz 16:14:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:14:02 INFO - Installing collected packages: blessings 16:14:02 INFO - Running setup.py install for blessings 16:14:02 INFO - Successfully installed blessings 16:14:02 INFO - Cleaning up... 16:14:02 INFO - Return code: 0 16:14:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:14:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:14:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:14:02 INFO - Reading from file tmpfile_stdout 16:14:02 INFO - Current package versions: 16:14:02 INFO - argparse == 1.2.1 16:14:02 INFO - blessings == 1.6 16:14:02 INFO - blobuploader == 1.2.4 16:14:02 INFO - docopt == 0.6.1 16:14:02 INFO - manifestparser == 1.1 16:14:02 INFO - mozInstall == 1.12 16:14:02 INFO - mozcrash == 0.17 16:14:02 INFO - mozdebug == 0.1 16:14:02 INFO - mozdevice == 0.48 16:14:02 INFO - mozfile == 1.2 16:14:02 INFO - mozhttpd == 0.7 16:14:02 INFO - mozinfo == 0.9 16:14:02 INFO - mozleak == 0.1 16:14:02 INFO - mozlog == 3.2 16:14:02 INFO - moznetwork == 0.27 16:14:02 INFO - mozprocess == 0.22 16:14:02 INFO - mozprofile == 0.28 16:14:02 INFO - mozrunner == 6.11 16:14:02 INFO - mozscreenshot == 0.1 16:14:02 INFO - mozsystemmonitor == 0.3 16:14:02 INFO - moztest == 0.7 16:14:02 INFO - mozversion == 1.4 16:14:02 INFO - psutil == 3.1.1 16:14:02 INFO - requests == 1.2.3 16:14:02 INFO - wsgiref == 0.1.2 16:14:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:14:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:14:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:02 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 0x7fb071af4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25809c0>, '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 0x25818c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2581d50>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1464390792.608015-1730503185', '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 16:14:02 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 16:14:02 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 16:14:02 INFO - Using env: {'DISPLAY': ':0', 16:14:02 INFO - 'HOME': '/home/cltbld', 16:14:02 INFO - 'LANG': 'en_US.UTF-8', 16:14:02 INFO - 'LANGUAGE': 'en_US:en', 16:14:02 INFO - 'LOGNAME': 'cltbld', 16:14:02 INFO - 'MAIL': '/var/mail/cltbld', 16:14:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:02 INFO - 'MOZ_NO_REMOTE': '1', 16:14:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:02 INFO - 'NO_EM_RESTART': '1', 16:14:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:02 INFO - 'PWD': '/builds/slave/test', 16:14:02 INFO - 'SHELL': '/bin/bash', 16:14:02 INFO - 'SHLVL': '1', 16:14:02 INFO - 'TERM': 'linux', 16:14:02 INFO - 'TMOUT': '86400', 16:14:02 INFO - 'USER': 'cltbld', 16:14:02 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464390792.608015-1730503185', 16:14:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:02 INFO - '_': '/tools/buildbot/bin/python'} 16:14:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:03 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)) 16:14:03 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)) 16:14:03 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)) 16:14:03 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)) 16:14:03 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)) 16:14:03 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)) 16:14:03 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)) 16:14:03 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)) 16:14:03 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)) 16:14:03 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)) 16:14:03 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)) 16:14:03 INFO - Cleaning up... 16:14:03 INFO - Return code: 0 16:14:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:14:03 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')]} 16:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:03 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')]} 16:14:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:03 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 0x7fb071af4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25809c0>, '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 0x25818c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2581d50>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1464390792.608015-1730503185', '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 16:14:03 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 16:14:03 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 16:14:03 INFO - Using env: {'DISPLAY': ':0', 16:14:03 INFO - 'HOME': '/home/cltbld', 16:14:03 INFO - 'LANG': 'en_US.UTF-8', 16:14:03 INFO - 'LANGUAGE': 'en_US:en', 16:14:03 INFO - 'LOGNAME': 'cltbld', 16:14:03 INFO - 'MAIL': '/var/mail/cltbld', 16:14:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:03 INFO - 'MOZ_NO_REMOTE': '1', 16:14:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:03 INFO - 'NO_EM_RESTART': '1', 16:14:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:03 INFO - 'PWD': '/builds/slave/test', 16:14:03 INFO - 'SHELL': '/bin/bash', 16:14:03 INFO - 'SHLVL': '1', 16:14:03 INFO - 'TERM': 'linux', 16:14:03 INFO - 'TMOUT': '86400', 16:14:03 INFO - 'USER': 'cltbld', 16:14:03 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464390792.608015-1730503185', 16:14:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:03 INFO - '_': '/tools/buildbot/bin/python'} 16:14:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:03 INFO - Downloading/unpacking jsonschema 16:14:03 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 16:14:03 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 16:14:03 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 16:14:03 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 16:14:03 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 16:14:03 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 16:14:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:14:05 INFO - Downloading/unpacking functools32 (from jsonschema) 16:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:05 INFO - Downloading functools32-3.2.3-2.tar.gz 16:14:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:14:05 INFO - warning: no files found matching '*.txt' 16:14:05 INFO - no previously-included directories found matching 'build' 16:14:05 INFO - no previously-included directories found matching 'dist' 16:14:05 INFO - no previously-included directories found matching '.git*' 16:14:05 INFO - Installing collected packages: jsonschema, functools32 16:14:05 INFO - Running setup.py install for functools32 16:14:05 INFO - warning: no files found matching '*.txt' 16:14:05 INFO - no previously-included directories found matching 'build' 16:14:05 INFO - no previously-included directories found matching 'dist' 16:14:05 INFO - no previously-included directories found matching '.git*' 16:14:05 INFO - Successfully installed jsonschema functools32 16:14:05 INFO - Cleaning up... 16:14:05 INFO - Return code: 0 16:14:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:14:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:14:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb071af4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25809c0>, '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 0x25818c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2581d50>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1464390792.608015-1730503185', '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 16:14:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 16:14:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:14:05 INFO - Using env: {'DISPLAY': ':0', 16:14:05 INFO - 'HOME': '/home/cltbld', 16:14:05 INFO - 'LANG': 'en_US.UTF-8', 16:14:05 INFO - 'LANGUAGE': 'en_US:en', 16:14:05 INFO - 'LOGNAME': 'cltbld', 16:14:05 INFO - 'MAIL': '/var/mail/cltbld', 16:14:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:05 INFO - 'MOZ_NO_REMOTE': '1', 16:14:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:05 INFO - 'NO_EM_RESTART': '1', 16:14:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:05 INFO - 'PWD': '/builds/slave/test', 16:14:05 INFO - 'SHELL': '/bin/bash', 16:14:05 INFO - 'SHLVL': '1', 16:14:05 INFO - 'TERM': 'linux', 16:14:05 INFO - 'TMOUT': '86400', 16:14:05 INFO - 'USER': 'cltbld', 16:14:05 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464390792.608015-1730503185', 16:14:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:05 INFO - '_': '/tools/buildbot/bin/python'} 16:14:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:05 INFO - Downloading/unpacking flake8 16:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:14:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:14:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:14:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:14:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:14:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:14:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:14:08 INFO - no previously-included directories found matching 'docs/_build' 16:14:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:14:08 INFO - Running setup.py install for pep8 16:14:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:14:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:14:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:14:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:14:08 INFO - no previously-included directories found matching 'docs/_build' 16:14:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:14:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:14:08 INFO - Cleaning up... 16:14:08 INFO - Return code: 0 16:14:08 INFO - Running post-action listener: _resource_record_post_action 16:14:08 INFO - Running post-action listener: _start_resource_monitoring 16:14:08 INFO - Starting resource monitoring. 16:14:08 INFO - ##### 16:14:08 INFO - ##### Finished create-virtualenv step (success) 16:14:08 INFO - ##### 16:14:08 INFO - ##### 16:14:08 INFO - ##### Running install step. 16:14:08 INFO - ##### 16:14:08 INFO - Running pre-action listener: _resource_record_pre_action 16:14:08 INFO - Running main action method: install 16:14:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:14:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:14:09 INFO - Reading from file tmpfile_stdout 16:14:09 INFO - Detecting whether we're running mozinstall >=1.0... 16:14:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:14:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:14:09 INFO - Reading from file tmpfile_stdout 16:14:09 INFO - Output received: 16:14:09 INFO - Usage: mozinstall [options] installer 16:14:09 INFO - Options: 16:14:09 INFO - -h, --help show this help message and exit 16:14:09 INFO - -d DEST, --destination=DEST 16:14:09 INFO - Directory to install application into. [default: 16:14:09 INFO - "/builds/slave/test"] 16:14:09 INFO - --app=APP Application being installed. [default: firefox] 16:14:09 INFO - mkdir: /builds/slave/test/build/application 16:14:09 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'] 16:14:09 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 16:14:25 INFO - Reading from file tmpfile_stdout 16:14:25 INFO - Output received: 16:14:25 INFO - /builds/slave/test/build/application/firefox/firefox 16:14:25 INFO - Running post-action listener: _resource_record_post_action 16:14:25 INFO - ##### 16:14:25 INFO - ##### Finished install step (success) 16:14:25 INFO - ##### 16:14:25 INFO - ##### 16:14:25 INFO - ##### Running run-tests step. 16:14:25 INFO - ##### 16:14:25 INFO - Running pre-action listener: _resource_record_pre_action 16:14:25 INFO - Running main action method: run_tests 16:14:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:14:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:14:25 INFO - Python 2.7.3 16:14:25 INFO - Return code: 0 16:14:25 INFO - grabbing minidump binary from tooltool 16:14: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')]} 16:14:25 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 0x25809c0>, '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 0x25818c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2581d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:14:25 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 16:14:25 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 16:14:25 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 16:14:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:14:25 INFO - Return code: 0 16:14:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:14:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:14:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:14:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:14:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:14:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:14:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:14:26 INFO - Return code: 0 16:14:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dokNQB2XT82AEM0wdpCLcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:14:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dokNQB2XT82AEM0wdpCLcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:14:26 INFO - Using env: {'DISPLAY': ':0', 16:14:26 INFO - 'HOME': '/home/cltbld', 16:14:26 INFO - 'LANG': 'en_US.UTF-8', 16:14:26 INFO - 'LANGUAGE': 'en_US:en', 16:14:26 INFO - 'LOGNAME': 'cltbld', 16:14:26 INFO - 'MAIL': '/var/mail/cltbld', 16:14:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:14:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:14:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:26 INFO - 'MOZ_NO_REMOTE': '1', 16:14:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:14:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:26 INFO - 'NO_EM_RESTART': '1', 16:14:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:26 INFO - 'PWD': '/builds/slave/test', 16:14:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:14:26 INFO - 'SHELL': '/bin/bash', 16:14:26 INFO - 'SHLVL': '1', 16:14:26 INFO - 'TERM': 'linux', 16:14:26 INFO - 'TMOUT': '86400', 16:14:26 INFO - 'USER': 'cltbld', 16:14:26 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464390792.608015-1730503185', 16:14:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:26 INFO - '_': '/tools/buildbot/bin/python'} 16:14:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dokNQB2XT82AEM0wdpCLcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:14:26 INFO - mozversion application_buildid: 20160527133028 16:14:26 INFO - mozversion application_changeset: a41a34f7d93659363d352eaad705d4da6d8f465c 16:14:26 INFO - mozversion application_display_name: Nightly 16:14:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:14:26 INFO - mozversion application_name: Firefox 16:14:26 INFO - mozversion application_remotingname: firefox 16:14:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:14:26 INFO - mozversion application_vendor: Mozilla 16:14:26 INFO - mozversion application_version: 49.0a1 16:14:26 INFO - mozversion platform_buildid: 20160527133028 16:14:26 INFO - mozversion platform_changeset: a41a34f7d93659363d352eaad705d4da6d8f465c 16:14:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:14:26 INFO - mozversion platform_version: 49.0a1 16:14:26 INFO - using testdate: 1464390866 16:14:26 INFO - actual date: 1464390866 16:14:26 INFO - starting webserver on 'localhost:37411' 16:14:26 INFO - SUITE-START | Running 2 tests 16:14:26 INFO - TEST-START | dromaeo_css 16:14:26 INFO - operating with platform_type : linux_ 16:14:26 INFO - Initialising browser for dromaeo_css test... 16:14:26 INFO - TEST-INFO | started process 8526 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgb6HCt/profile http://localhost:37411/getInfo.html) 16:14:31 INFO - PROCESS | 8526 | __metrics Screen width/height:1600/1200 16:14:31 INFO - PROCESS | 8526 | colorDepth:24 16:14:31 INFO - PROCESS | 8526 | Browser inner width/height: 1024/697 16:14:31 INFO - PROCESS | 8526 | __metrics 16:14:32 ERROR - PROCESS | 8526 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:14:32 INFO - TEST-INFO | 8526: exit 0 16:14:32 INFO - Browser initialized. 16:14:32 INFO - Running cycle 1/1 for dromaeo_css test... 16:14:32 INFO - TEST-INFO | started process 8609 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgb6HCt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:14:44 INFO - PROCESS | 8609 | RSS: Main: 155631616 16:14:44 INFO - PROCESS | 8609 | 16:15:36 INFO - PROCESS | 8609 | 1464390936165 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] 16:17:43 INFO - PROCESS | 8609 | Cycle 1(1): loaded http://localhost:37411/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37411/tests/dromaeo/cssquery-ext.html) 16:17:44 INFO - PROCESS | 8609 | RSS: Main: 247857152 16:17:44 INFO - PROCESS | 8609 | 16:20:47 INFO - PROCESS | 8609 | Cycle 1(1): loaded http://localhost:37411/tests/dromaeo/cssquery-ext.html (next: http://localhost:37411/tests/dromaeo/cssquery-jquery.html) 16:20:47 INFO - PROCESS | 8609 | RSS: Main: 254214144 16:20:47 INFO - PROCESS | 8609 | 16:23:50 INFO - PROCESS | 8609 | Cycle 1(1): loaded http://localhost:37411/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37411/tests/dromaeo/cssquery-mootools.html) 16:23:50 INFO - PROCESS | 8609 | RSS: Main: 250691584 16:23:50 INFO - PROCESS | 8609 | 16:26:52 INFO - PROCESS | 8609 | Cycle 1(1): loaded http://localhost:37411/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37411/tests/dromaeo/cssquery-prototype.html) 16:26:53 INFO - PROCESS | 8609 | RSS: Main: 242999296 16:26:53 INFO - PROCESS | 8609 | 16:29:55 INFO - PROCESS | 8609 | Cycle 1(1): loaded http://localhost:37411/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37411/tests/dromaeo/cssquery-yui.html) 16:29:56 INFO - PROCESS | 8609 | RSS: Main: 230334464 16:29:56 INFO - PROCESS | 8609 | 16:32:58 INFO - PROCESS | 8609 | Cycle 1(1): loaded http://localhost:37411/tests/dromaeo/cssquery-yui.html (next: http://localhost:37411/tests/dromaeo/cssquery-dojo.html) 16:32:59 INFO - PROCESS | 8609 | RSS: Main: 347217920 16:32:59 INFO - PROCESS | 8609 | 16:32:59 INFO - PROCESS | 8609 | __start_tp_report 16:32:59 INFO - PROCESS | 8609 | _x_x_mozilla_page_load 16:32:59 INFO - PROCESS | 8609 | _x_x_mozilla_page_load_details 16:32:59 INFO - PROCESS | 8609 | |i|pagename|runs| 16:32:59 INFO - PROCESS | 8609 | |0;dojo.html;3159.6840315968407;3176.364727054588;3195.4567723487003;3212.405704944584;3242.5136229565564;5321.414644389124;5396.055690254209;5466.344038715355;5511.255980442639;5527.115661494162;5426.158945363465;5474.39781624021;5475.206095116206;5486.286782718251;5519.199716041182;4910.165271903785;4990.65065445419;5006.349174607296;5039.84880453587;5214.400343960437;5103.23451482277;5107.591392688594;5120.820771273006;5161.896762064775;5167.870803229912;4814.422269327668;4865.3675022247235;4869.683470574401;4927.802887884481;4945.629077819142;4847.806087756486;4854.611631069506;4861.489543597942;4868.756562171912;4955.950440495585;4861.829835955725;4898.191798353268;4908.509149085098;4910.484399138075;4930.087933732271;5197.506236907488;5235.712035838027;5238.1618940969265;5279.102552566073;5413.702246376448;5639.605227634067;5699.430056994309;5705.343885453184;5722.570807189478;5731.541476681856;5693.4875861172695;5759.625624334405;5766.452187042224;5768.048272035109;5777.768889244425;5317.441668624816;5435;5456.890862182774;5495.725213739337;5577.2191893135;6054.09278165868;6064.145763134906;6064.587407993564;6103.992841181155;6115.602485838406;5520.91718624221;5818.330891947396;5823.650580965155;5871.794487192928;5873.794417195378;5691.231683722727;5714.7999820006935;5731.455511726379;5776.5089967352405;5783.8554036149435;5717.485426311652;5732.197492351074;5738.368779434259;5739.62692424991;5757.769689212385;5616.747246373923;5724.656520608693;5774.538036957033;5776.971115144482;5781.82654520365;4411.889702757392;4453.643708503312;4459.620932220732;4493.460784705856;4503.189425903369;3957.980210098931;3971.384435412516;3974.026363540951;3981.462502562175;4014.7791871447353;5296.417394086648;5390.811321603725;5493.752781124859;5558.861028474321;5632.098864181711;5907.23205983228;5916.704164791743;5946.970265148647;5973.253343332083;6009.609375390585;5603.831885043455;5613.971930140405;5619.690916999604;5621.297337832771;5622.57830662702;4990.3762029746285;5023.899522009539;5082.974585127125;5112.054269960069;5122.538971492583;6142.13045781164;6145.692715364214;6149;6151.046587778901;6157.507399408037;5928.733207005781;5930.614510056833;5931.6441013539325;5943.64338139713;5965.791197308074;5884.7940322088525;6028.849278768066;6082.695865206811;6108.694565271808;6121.173641558333;5804.622699524517;5845.503132233808;5845.824625261249;5849.181114644039;5852.882942341214;5938.2280303560265;5939.346671866005;5939.792107276225;5947.791827286024;5957.046872500379;5600.943990560042;5602.355729091207;5637.126245431965;5679.74441150141;5723.370429252862;5665.971670141623;5667.40492248308;5668.858278542904;5669.489745922887;5680.375158732619;5421.295231619864;5576.693281869536;5585.301837270341;5588.497035266845;5592.161175823659;5719.941810764855;5765.509931655856;5783.277090363705;5867.266591676041;5884.08796636522;5666.206731057738;5702.486776190163;5704.714764261687;5707.0583353747825;5751.252337196138 16:32:59 INFO - PROCESS | 8609 | |1;ext.html;621.1490258346065;622.2968046107898;634.5399585300656;646.1825790375174;648.4293821437135;31706.524402133957;42618.78690606546;44742.552574474284;44837.327440088426;47959.28061079087;46413.535864641344;46569.767151164284;46607.76696116514;46622.60132196039;46656.533434665726;8667.696630617915;8878.28973682104;8886.155815197546;8886.600102995348;8892.8666070009;8688.131186881325;8807.471551706885;8825.426347287406;8832.470051796881;8832.558372081403;8879.51162686052;8932.55337233139;8941.955290223572;8949.865752013726;8953.194212520872;8874;8931.598078086437;8931.776705582348;8940.910590894073;8942.821143577092;8765.693200737944;8881.156290152425;8884.689035883714;8888.288936885034;8890.110988901122;43026.35460468096;43425.565744342784;43450.782746086385;43474.56525434768;43479.78260108711;3262.6574209708115;3527.6825085742407;3546.308469848381;3719.107414220595;4029.435878976946;32293.838530807196;32705.345893082005;33615;33641.6635833641;33645.831770841236;4321.783910804447;4355.1725172217175;4381.4961279452955;4438.889027774299;4481.282994720862;323887;325656;325878;326353;328053.3597332022;52361.47638523566;58670;59292.11061834076;59354.70322648445;59384.812303753686;62070.68964655148;63445.682771585845;63659.36340636627;68730;68741.3125868745;16754.4135955241;16819.66360672804;16914.238859251363;16930.830691692925;16942.66114677724;11444.599439019761;12070.155089143676;12701.618951431472;12786.168899021533;12797.488100476063;17327.873688210228;17825.554361140817;17923.910380448015;18034.729479057823;18052.91682499054;6048.153258543807;6215;6243.687815609293;6304.18045654062;6413.29453760086;963.677168148678;1024.994875025635;1047.8375851742992;1093.4642025407493;1151.8445009923553;32893.50659740106;32970;33397.83301083479;33434;33568.3286334272;1083.707399002265;1120.4789772755707;1127.960521381764;1167.177140116216;1199.2564609941717;17262.913685431744;18195.363162289257;18266;18559.35042273541;18896.905515472336;468558;474467;476989;477737;492147;58234.92355535157;59299.407005930254;59384.703076484344;59410.10884836731;59455.10817337743;1278.8721127887136;1386.83357997041;1387.070662656023;1416.206924122474;1431.2628996066826;32036.35927281395;33968.490472642436;33989.83005084959;34342;34434.655653443144;49992.50007499878;50296;50563;50571.2414313793;50697.239541407645;372334;372865;373540;374338;374919;24453.87773061123;45180;45471.31793023041;46793.29810052784;46906.76546617245;48065.5193448075;48273;48865.75567122284;51373;51880.22179667383;42833.357499636906;42966.78516607397;43832.56167438285;44367;44703.32945005762;42510.362344565474;42961;43424.34863477114;43443.782781085894;43846.561534385524;41639.37540936828;42511.57488425076;43607.12785744331;43626;43631.56368436275;38060.619393805704;38237.11731888287;38784.66659679733;38907.22185556329;39157;28920.469205882837;28942.855285723435;28972.420551588428;29001.56497652579;29427 16:32:59 INFO - PROCESS | 8609 | |2;jquery.html;379.92591444668284;385.9286032084064;393.3607887183327;404.6722155054404;410.71455338539727;17668.91165544172;18586.81413185868;20277.493062673442;20297.898510507428;20313.695294570574;11363.14776391772;11550.595729149481;11561;11602.419879006036;15485.845141548609;4827.5172482751705;4956.7025978441225;5037.042961837257;5056.797728090872;5074.4925507449325;3874.418837174418;5337.946620533784;5609.242752228438;5619.269494965649;5703.600747947646;5640.294963129609;5655;5665.12190610456;5700.059490184115;5874.5594080443925;6109.602875813102;6266.185395898504;6467.353264673518;6472.967635161817;6479.449246814026;3758.1168425420005;5239.973800131013;5528.917066244009;5566.304211973504;5593.440655934414;12926.224426534438;13081.21512709231;13127.474901003949;13283.800742988862;13357.866421335857;2095.8428117891067;2116.7459904811367;2215.8670479771267;2278.9972412138604;2848.572714092882;9251;9732.805343893082;9864.30949833512;12517.937410312981;14204.164875483664;1827.2599597163037;1861.2741030997922;1906.1803424527448;1926.0273561851175;1981.9405417837343;75690.62154689246;80459;80920;81944.59027704883;82111.58944205301;10150;10546.156307495536;11126.833097503544;11133.443327833576;11298.830517542243;15367.15480648575;15425.84574154244;15526.689466210613;15544.76682849758;15548.689026219412;7949.6025198739835;8088.797780055545;8121.79695507617;8251.546164960864;8323.750287491264;7557.886631700529;7646.273604007611;7664.693412263447;7725.961370193113;7769.72805951789;4112.979435102865;4261.190373829025;4777.928331075037;4802.831900883452;4843.346148270009;1767.6258509279637;1853.9073046347628;1976.9308074217333;1990.7710613279369;2022.7572691276846;410.2246753635631;879.872418499314;937.095702646949;1000.3647683720744;1005.9889810740159;10717.83923241152;11217.60738374153;11334.263272887401;11382.772344553228;11510.712232194262;420.72442550129716;421.97679127648274;432.1055415290319;441.0891509033835;441.3512137158372;5963.642181469126;6157.415045570664;6163.9383606164265;6197.907031394533;6319.873602528016;439436;444770;476076;481431;500031;61351;68694;87273.12726872777;90631;92974;428.03478156756313;430.896584819641;432.1529801588921;434.08408258574383;435.6427729261975;10173.33873298263;10269.537870795682;10541.262111652417;10557.788844223227;10580.36517808934;39120.413193802684;39703.40444893387;40127;41490.170196596504;41777;56237.718811405684;57228.42771572231;57896.421035789106;58332.125018123916;58337;8263.504189748634;8394.412391132562;8438.198371154731;8714.477131372138;8728.738137855875;8845.557722113997;10859.859714729839;11566.30602163873;12769.553065642658;13584.049116561746;11332.660020199408;11508.94245528767;11534.942325288655;11655.358955257543;11969.581064662694;5782.017057100387;10120.949395252977;10940.781184376427;11568.537258509901;11781.108051789799;11809.23239989398;11912.463939122586;12153.756924861631;12200.328981906081;12213.633590992284;8141.185881411811;8301.916980830114;8367.456115352483;8388.412811103164;8520.957395213232;8860.803791488066;11736.354500502553;12019.519219231133;12148.817767733668;12205.389730513616 16:32:59 INFO - PROCESS | 8609 | |3;mootools.html;1319.379891451019;1521.855423734745;1541.6685412636284;1728.69747794136;1867.9533011674714;8659.826803463928;9041.186293233608;9048.547572621368;9248;9253.95373023134;9047.41191822531;9238.953805230982;9250.02874698157;9267.258619310456;9268.165865072142;2087.488565301503;2271.1483193802324;2338.1348900906687;2378.774016468437;2408.1932552594903;2391.4021494626345;2396.8801559921935;2402.327348342467;2403.591389463795;2411.8191135664806;2316.559853627814;2368.5736567417857;2368.6683864259016;2370.7036620422446;2371.8695471749134;1910.7707075151002;2307.457747429361;2378.5361854438393;2382.4401265702545;2397.736249012607;2268.274152271274;2278.612635851909;2279.031411650042;2291.919782807594;2347.8826058696995;9128;9128.634854605807;9141.680041198593;9160.587773550205;9203.26373890094;5555.583331250132;5701.315842098975;5709.115087161496;5717.142428635696;5718.71406429681;3223.693749093832;3306.933861322784;3336.616289126733;3350.782199157047;3357.1103657530775;1045.628801775374;1047.1727335405021;1050.070687441612;1069.5454431866426;1070.8875568065318;13114.540991065362;13153.473861045546;13172;13185.142965707199;13202.867971320356;4887.780049897763;4948.158813001798;5001.4998500149695;5014.022265658162;5036.690460480301;10941.671749847517;11016.283941543774;11020.944895275632;11033;11055;5008.4240312364545;5545.944540554624;5548.55611551075;5555.361133469622;5561.6663000220115;4975.303457515951;5145.819896303611;5149.819756308511;5201.063808514504;5202.687838729688;4120.381942708557;4124.52567954683;4220.07158425146;4241.533431322552;4289.6139347458875;1281.858995510493;1340.1490053815896;1340.3097404836517;1345.604823414324;1351.9256440895845;968.704545113747;993.9811693014718;997.3018886779283;998.121652945418;1011.7571782772081;6081.665508396992;6083.422074902877;6295.338989406138;6321.747130114744;6414.422701956753;953.3803028031834;1045.4668119259081;1068.7435015596202;1069.4118234970736;1076.7469644633504;3923.7645741255615;3939.3893946438347;3949.111449923744;3957.52509698838;4141.627253547195;11452.94273528627;11845.170838041427;11858.644240672793;11865.466054027589;11902.047836173086;11572.710682233012;11747.47136378865;11753.4710938008;11756.294622322688;11768.058555315554;8573.27127194183;8631.6978905738;8700.477971321741;8774.341924355698;8787.472751634794;5827.213326201078;5908.468237858613;5918.704064796829;5951.55363347742;6094.634321940698;10573.2598718089;10783.352998820095;10866.728331791768;10907.672769816918;10920.126389888632;10881.891181088087;10918.399488028235;10931.453427328443;11145.554177832795;11241.325520468798;6930.410915072275;7705.42209334291;7824.4131690124605;8457.57712114404;8748.65005399777;8792.824143516966;8932.910670893209;8991.955040224757;9092.499912504876;9112.134347237003;7828.256315650005;8024.0772311184965;8081.070676872235;8134.06458257308;8203.30271926869;7809.92190078092;7853.175416581405;7919.445638805229;7929.762107136795;8113.878291825746;6701;6735.797926062226;6818.8636227276165;6837.487188460786;7246.239144889922;4992.80028798844;5022.447530771539;5024.84925452237;5055.747212639427;5107.565856902205;5225.529702326809;5245.449227831023;5281.498257665516;5385.6230063895155;5450.727463626882 16:32:59 INFO - PROCESS | 8609 | |4;prototype.html;291.4171656686627;292.4866858663047;298.1844654868933;300.8616036623153;301.2709243630415;5296.814611488594;5317.627766056377;5334.5732341412695;5349.465053494649;5383.973080134594;5248.737563121847;5280.815171468999;5285.339332583427;5312.123499622558;5312.362516498016;4081.1225586498895;4086.1419101988467;4094.3858421236755;4129.112240868213;4136.751794892301;3905.2775236581183;4094.61101195386;4098.672106231509;4129.215449064668;4131.173765246947;3929.862454814082;4018.919621607566;4021.396790481422;4046.8785936421955;4068.0473372781084;3964.8017599120217;3978.3833505806647;4029.0934539728473;4031.254217969685;4047.9392809107885;3308.17295676081;3443.6212016678396;3523.436250199956;3541.1501239702543;3554.306910152521;5000.1499445205145;5052.494750524955;5056.772445239936;5057.645964782467;5075.695458272478;4342.761148136851;4524.841630542948;4574.771261436948;4600.654950878664;4635.6523260755575;5290.1800220965815;5442.312883006281;5465.699386533739;5477.1510415885605;5490.835274941758;3794.2221844521805;3798.810059497042;3816.8282427290837;3822.73240873139;3831.2720583089404;5533.280673512458;5680.971595142039;5721.370649228582;5734;5777.075667893159;3921.490206273223;3926.450296958428;3932.803359831997;3945.151792364655;3962.0887195945093;4002;4010.8796736097966;4028.436018957348;4036.899077523027;4037.6769858411258;4597.540245975442;4597.793099310539;4639.930401043987;4641.582257596832;4663.207254766698;5308.628396012319;5488.4785945335925;5494.340679118532;5527.170924361378;5562.082256427644;1356.3150608942617;1359.7960305954186;1367.5213675213795;1374.4949280537794;1386.8682475164844;848.3001523742937;885.623609965762;889;896.677400833765;901.6799036342135;4690.601298889633;4694.882627934329;4749.2876068589985;4781.450133234723;4839.346688197048;5014.323066386064;5021.447640759514;5022.59819214462;5023.748812559431;5026.572741317029;4794;4799.568038876518;4803.447603525639;4826.903461930741;5001.874953126128;2876.424715056997;2923.4299311634027;3015.522394026911;3015.7135072168107;3046.390721855638;5873.236479257669;5893;5906.940930590725;5912.260967379078;5925.200097986803;5534.418886016991;5723.971380143073;5760.74076666551;5793.131030345482;5819.272590926134;5807.751333463326;5807.912881306784;5842.211301474246;5859.589828711949;5879.323877754027;5639.4642508963225;5646.491815736604;5670.432956704297;5710.37185909558;5721.799737009184;5403.972980135231;5603.075492543685;5609.691466969192;5627.859303517281;5645.68948707825;5810.477057064884;5822.388649191774;5864.709763851945;5888.646681199141;5891.23413956183;3814.1608846053823;3816.160444702161;3821.159344944108;3847.48059012041;3851.942220866745;5496.477834605706;5551.528844856197;5579.74891129892;5654.491095801398;5669.3480249770155;5430.647007944471;5434.614173385761;5443.782248710166;5493.862653433536;5505.889882202254;5326.97336513315;5407.458494507575;5450.945490545044;5456.508914197741;5462.808801691922;5293.947060529499;5319.787208511616;5375.521731523862;5389.892202156013;5406;5444.373897001896;5464.235007099089;5487.259220005249;5489.890202195854;5505.394406615349;5213.608979326642;5375.220593014069;5395.24466574672;5434.510894019557;5527.723613819213 16:32:59 INFO - PROCESS | 8609 | |5;yui.html;723.7792473295643;748.0835975929484;804.9517028978262;829.7469271872078;851.2508992086963;13026.934865325671;13469.191848489074;13608.659783505418;13625.523106691267;13658.317084145803;12398.752024959495;12423.503059877617;12425.254484730922;12455;12469.68825779356;663.9170103737033;781.7185813107277;798.377265732728;803.3693550562809;804.9597520123999;783.1229023493695;789.1358961936699;791.078393671375;792.0693185507006;792.8057625881667;853.6798700487317;858.4119877883638;860.5482121886029;860.7288704058233;860.918212769789;700.7967689370103;839.6347588798861;849.757819021582;854.0050840770494;866.1944391715701;612.3845535237058;613.3866133866134;614.4316507230793;616.516034912596;616.7563812294119;14147.717045659132;14232.932530060183;14238.644033899132;14258.64353391163;14261;14520.491782787552;14701.338439770236;14823.925880370529;14903.403863845433;15001.699966000619;11800.291982481078;11972.161948663597;12045.578404755792;12112.939435302767;12158.5136594537;3751.81240937952;3770.698344132463;3807.3527500325013;3821.5414150301863;3857.0935830079907;54935;59264;59410;59428.70285648587;59622;11331.716707082389;11636.709082272842;11826.231294965799;11849;12144.878551214375;20800.89599552023;21056.473588160417;21068.683969740465;21076.578468430547;21674.891625542088;8592.226699597066;8605.354598405145;8670.089640587648;8710.825783484295;8791.560421978875;4831.4202295724735;4872.293517439952;4943.456219815817;4960.305557221992;5131.307273518102;3640.927181456409;3656.542932133483;3774.1319496515407;3776.15036616759;3783.05423644089;683.6752542542353;694.2952902803659;704.264044073944;707.0631413377296;708.1714394158846;666.2970566052763;692.5256199503256;693.2789898505598;698.1308271202386;711.6441779110445;9075.773105672411;9115.680951166678;9720.31957762964;9833.950830245803;9839.754006149904;739.0946091038543;749.2956620776453;760.5358638012799;768.2240936654019;770.2143813310392;4467.173572889026;4515.187266292099;4632.559906808848;4776.617870570346;5336.866578335573;74391.25608743844;74874.25125748673;76306;78519.21480785233;78906;64921;66544;66549.33450665431;66832.66583667051;68040;59174.70412647909;59919.400805992256;60051.69974150101;60786.696066519384;60998.695006524686;9991.700248992542;10255.179585633281;10379.221558383;10426.374417534973;10457.895421045692;38667.80666096652;38876.6112338873;39256.60743392644;39345.60654393534;40071;51973;53177;53356.466435336704;54830;55122;12278.881312382717;12380.133390662568;12534.87465125337;13233.536826211037;13697.246651433868;14099.365528551034;14567.271636418349;14621.342039608457;14736.926315368355;15456.381744730084;13912.234827084607;14115.788263175855;14138.50515231962;14293.499727509487;14398.928005359907;13077.934610326887;13527.256000920044;13676.452941882213;13754.174749515061;14036.929815350857;13010.674733131369;13551.119177253448;13594;13620.455181792617;13706.794398083837;10393.220508461744;10568.471576421302;10691.839622405514;11008.834867476835;11087.722806929569;10809.037031144197;11722.179447438597;11781.410929453321;11864.822027669765;12047.216930899463 16:32:59 INFO - PROCESS | 8609 | __end_tp_report 16:32:59 INFO - PROCESS | 8609 | __start_cc_report 16:32:59 INFO - PROCESS | 8609 | _x_x_mozilla_cycle_collect,754 16:32:59 INFO - PROCESS | 8609 | __end_cc_report 16:32:59 INFO - PROCESS | 8609 | __startTimestamp1464391979111__endTimestamp 16:32:59 INFO - PROCESS | 8609 | 16:32:59 INFO - PROCESS | 8609 | ------- Summary: start ------- 16:32:59 INFO - PROCESS | 8609 | Number of tests: 6 16:32:59 INFO - PROCESS | 8609 | 16:32:59 INFO - PROCESS | 8609 | [#0] dojo.html Cycles:165 Average:5425.92 Median:5622.58 stddev:620.97 (11.0%) stddev-sans-first:596.89 16:32:59 INFO - PROCESS | 8609 | Values: 3159.7 3176.4 3195.5 3212.4 3242.5 5321.4 5396.1 5466.3 5511.3 5527.1 5426.2 5474.4 5475.2 5486.3 5519.2 4910.2 4990.7 5006.3 5039.8 5214.4 5103.2 5107.6 5120.8 5161.9 5167.9 4814.4 4865.4 4869.7 4927.8 4945.6 4847.8 4854.6 4861.5 4868.8 4956.0 4861.8 4898.2 4908.5 4910.5 4930.1 5197.5 5235.7 5238.2 5279.1 5413.7 5639.6 5699.4 5705.3 5722.6 5731.5 5693.5 5759.6 5766.5 5768.0 5777.8 5317.4 5435.0 5456.9 5495.7 5577.2 6054.1 6064.1 6064.6 6104.0 6115.6 5520.9 5818.3 5823.7 5871.8 5873.8 5691.2 5714.8 5731.5 5776.5 5783.9 5717.5 5732.2 5738.4 5739.6 5757.8 5616.7 5724.7 5774.5 5777.0 5781.8 4411.9 4453.6 4459.6 4493.5 4503.2 3958.0 3971.4 3974.0 3981.5 4014.8 5296.4 5390.8 5493.8 5558.9 5632.1 5907.2 5916.7 5947.0 5973.3 6009.6 5603.8 5614.0 5619.7 5621.3 5622.6 4990.4 5023.9 5083.0 5112.1 5122.5 6142.1 6145.7 6149.0 6151.0 6157.5 5928.7 5930.6 5931.6 5943.6 5965.8 5884.8 6028.8 6082.7 6108.7 6121.2 5804.6 5845.5 5845.8 5849.2 5852.9 5938.2 5939.3 5939.8 5947.8 5957.0 5600.9 5602.4 5637.1 5679.7 5723.4 5666.0 5667.4 5668.9 5669.5 5680.4 5421.3 5576.7 5585.3 5588.5 5592.2 5719.9 5765.5 5783.3 5867.3 5884.1 5666.2 5702.5 5704.7 5707.1 5751.3 16:32:59 INFO - PROCESS | 8609 | 16:32:59 INFO - PROCESS | 8609 | [#1] ext.html Cycles:180 Average:57222.65 Median:23917.48 stddev:104799.62 (438.2%) stddev-sans-first:105007.44 16:32:59 INFO - PROCESS | 8609 | Values: 621.1 622.3 634.5 646.2 648.4 31706.5 42618.8 44742.6 44837.3 47959.3 46413.5 46569.8 46607.8 46622.6 46656.5 8667.7 8878.3 8886.2 8886.6 8892.9 8688.1 8807.5 8825.4 8832.5 8832.6 8879.5 8932.6 8942.0 8949.9 8953.2 8874.0 8931.6 8931.8 8940.9 8942.8 8765.7 8881.2 8884.7 8888.3 8890.1 43026.4 43425.6 43450.8 43474.6 43479.8 3262.7 3527.7 3546.3 3719.1 4029.4 32293.8 32705.3 33615.0 33641.7 33645.8 4321.8 4355.2 4381.5 4438.9 4481.3 323887.0 325656.0 325878.0 326353.0 328053.4 52361.5 58670.0 59292.1 59354.7 59384.8 62070.7 63445.7 63659.4 68730.0 68741.3 16754.4 16819.7 16914.2 16930.8 16942.7 11444.6 12070.2 12701.6 12786.2 12797.5 17327.9 17825.6 17923.9 18034.7 18052.9 6048.2 6215.0 6243.7 6304.2 6413.3 963.7 1025.0 1047.8 1093.5 1151.8 32893.5 32970.0 33397.8 33434.0 33568.3 1083.7 1120.5 1128.0 1167.2 1199.3 17262.9 18195.4 18266.0 18559.4 18896.9 468558.0 474467.0 476989.0 477737.0 492147.0 58234.9 59299.4 59384.7 59410.1 59455.1 1278.9 1386.8 1387.1 1416.2 1431.3 32036.4 33968.5 33989.8 34342.0 34434.7 49992.5 50296.0 50563.0 50571.2 50697.2 372334.0 372865.0 373540.0 374338.0 374919.0 24453.9 45180.0 45471.3 46793.3 46906.8 48065.5 48273.0 48865.8 51373.0 51880.2 42833.4 42966.8 43832.6 44367.0 44703.3 42510.4 42961.0 43424.3 43443.8 43846.6 41639.4 42511.6 43607.1 43626.0 43631.6 38060.6 38237.1 38784.7 38907.2 39157.0 28920.5 28942.9 28972.4 29001.6 29427.0 16:32:59 INFO - PROCESS | 8609 | 16:32:59 INFO - PROCESS | 8609 | [#2] jquery.html Cycles:180 Average:26846.68 Median:421.35 stddev:77403.62 (18370.4%) stddev-sans-first:77595.25 16:32:59 INFO - PROCESS | 8609 | Values: 379.9 385.9 393.4 404.7 410.7 17668.9 18586.8 20277.5 20297.9 20313.7 11363.1 11550.6 11561.0 11602.4 15485.8 4827.5 4956.7 5037.0 5056.8 5074.5 3874.4 5337.9 5609.2 5619.3 5703.6 5640.3 5655.0 5665.1 5700.1 5874.6 6109.6 6266.2 6467.4 6473.0 6479.4 3758.1 5240.0 5528.9 5566.3 5593.4 12926.2 13081.2 13127.5 13283.8 13357.9 2095.8 2116.7 2215.9 2279.0 2848.6 9251.0 9732.8 9864.3 12517.9 14204.2 1827.3 1861.3 1906.2 1926.0 1981.9 75690.6 80459.0 80920.0 81944.6 82111.6 10150.0 10546.2 11126.8 11133.4 11298.8 15367.2 15425.8 15526.7 15544.8 15548.7 7949.6 8088.8 8121.8 8251.5 8323.8 7557.9 7646.3 7664.7 7726.0 7769.7 4113.0 4261.2 4777.9 4802.8 4843.3 1767.6 1853.9 1976.9 1990.8 2022.8 410.2 879.9 937.1 1000.4 1006.0 10717.8 11217.6 11334.3 11382.8 11510.7 420.7 422.0 432.1 441.1 441.4 5963.6 6157.4 6163.9 6197.9 6319.9 439436.0 444770.0 476076.0 481431.0 500031.0 61351.0 68694.0 87273.1 90631.0 92974.0 428.0 430.9 432.2 434.1 435.6 10173.3 10269.5 10541.3 10557.8 10580.4 39120.4 39703.4 40127.0 41490.2 41777.0 56237.7 57228.4 57896.4 58332.1 58337.0 8263.5 8394.4 8438.2 8714.5 8728.7 8845.6 10859.9 11566.3 12769.6 13584.0 11332.7 11508.9 11534.9 11655.4 11969.6 5782.0 10120.9 10940.8 11568.5 11781.1 11809.2 11912.5 12153.8 12200.3 12213.6 8141.2 8301.9 8367.5 8388.4 8521.0 8860.8 11736.4 12019.5 12148.8 12205.4 16:32:59 INFO - PROCESS | 8609 | 16:32:59 INFO - PROCESS | 8609 | [#3] mootools.html Cycles:180 Average:6064.20 Median:4917.97 stddev:3548.61 (72.2%) stddev-sans-first:3540.65 16:32:59 INFO - PROCESS | 8609 | Values: 1319.4 1521.9 1541.7 1728.7 1868.0 8659.8 9041.2 9048.5 9248.0 9254.0 9047.4 9239.0 9250.0 9267.3 9268.2 2087.5 2271.1 2338.1 2378.8 2408.2 2391.4 2396.9 2402.3 2403.6 2411.8 2316.6 2368.6 2368.7 2370.7 2371.9 1910.8 2307.5 2378.5 2382.4 2397.7 2268.3 2278.6 2279.0 2291.9 2347.9 9128.0 9128.6 9141.7 9160.6 9203.3 5555.6 5701.3 5709.1 5717.1 5718.7 3223.7 3306.9 3336.6 3350.8 3357.1 1045.6 1047.2 1050.1 1069.5 1070.9 13114.5 13153.5 13172.0 13185.1 13202.9 4887.8 4948.2 5001.5 5014.0 5036.7 10941.7 11016.3 11020.9 11033.0 11055.0 5008.4 5545.9 5548.6 5555.4 5561.7 4975.3 5145.8 5149.8 5201.1 5202.7 4120.4 4124.5 4220.1 4241.5 4289.6 1281.9 1340.1 1340.3 1345.6 1351.9 968.7 994.0 997.3 998.1 1011.8 6081.7 6083.4 6295.3 6321.7 6414.4 953.4 1045.5 1068.7 1069.4 1076.7 3923.8 3939.4 3949.1 3957.5 4141.6 11452.9 11845.2 11858.6 11865.5 11902.0 11572.7 11747.5 11753.5 11756.3 11768.1 8573.3 8631.7 8700.5 8774.3 8787.5 5827.2 5908.5 5918.7 5951.6 6094.6 10573.3 10783.4 10866.7 10907.7 10920.1 10881.9 10918.4 10931.5 11145.6 11241.3 6930.4 7705.4 7824.4 8457.6 8748.7 8792.8 8932.9 8992.0 9092.5 9112.1 7828.3 8024.1 8081.1 8134.1 8203.3 7809.9 7853.2 7919.4 7929.8 8113.9 6701.0 6735.8 6818.9 6837.5 7246.2 4992.8 5022.4 5024.8 5055.7 5107.6 5225.5 5245.4 5281.5 5385.6 5450.7 16:32:59 INFO - PROCESS | 8609 | 16:32:59 INFO - PROCESS | 8609 | [#4] prototype.html Cycles:180 Average:4559.39 Median:5231.17 stddev:1363.99 (26.1%) stddev-sans-first:1329.67 16:32:59 INFO - PROCESS | 8609 | Values: 291.4 292.5 298.2 300.9 301.3 5296.8 5317.6 5334.6 5349.5 5384.0 5248.7 5280.8 5285.3 5312.1 5312.4 4081.1 4086.1 4094.4 4129.1 4136.8 3905.3 4094.6 4098.7 4129.2 4131.2 3929.9 4018.9 4021.4 4046.9 4068.0 3964.8 3978.4 4029.1 4031.3 4047.9 3308.2 3443.6 3523.4 3541.2 3554.3 5000.1 5052.5 5056.8 5057.6 5075.7 4342.8 4524.8 4574.8 4600.7 4635.7 5290.2 5442.3 5465.7 5477.2 5490.8 3794.2 3798.8 3816.8 3822.7 3831.3 5533.3 5681.0 5721.4 5734.0 5777.1 3921.5 3926.5 3932.8 3945.2 3962.1 4002.0 4010.9 4028.4 4036.9 4037.7 4597.5 4597.8 4639.9 4641.6 4663.2 5308.6 5488.5 5494.3 5527.2 5562.1 1356.3 1359.8 1367.5 1374.5 1386.9 848.3 885.6 889.0 896.7 901.7 4690.6 4694.9 4749.3 4781.5 4839.3 5014.3 5021.4 5022.6 5023.7 5026.6 4794.0 4799.6 4803.4 4826.9 5001.9 2876.4 2923.4 3015.5 3015.7 3046.4 5873.2 5893.0 5906.9 5912.3 5925.2 5534.4 5724.0 5760.7 5793.1 5819.3 5807.8 5807.9 5842.2 5859.6 5879.3 5639.5 5646.5 5670.4 5710.4 5721.8 5404.0 5603.1 5609.7 5627.9 5645.7 5810.5 5822.4 5864.7 5888.6 5891.2 3814.2 3816.2 3821.2 3847.5 3851.9 5496.5 5551.5 5579.7 5654.5 5669.3 5430.6 5434.6 5443.8 5493.9 5505.9 5327.0 5407.5 5450.9 5456.5 5462.8 5293.9 5319.8 5375.5 5389.9 5406.0 5444.4 5464.2 5487.3 5489.9 5505.4 5213.6 5375.2 5395.2 5434.5 5527.7 16:32:59 INFO - PROCESS | 8609 | 16:32:59 INFO - PROCESS | 8609 | [#5] yui.html Cycles:180 Average:16621.71 Median:4573.87 stddev:20384.21 (445.7%) stddev-sans-first:20406.43 16:32:59 INFO - PROCESS | 8609 | Values: 723.8 748.1 805.0 829.7 851.3 13026.9 13469.2 13608.7 13625.5 13658.3 12398.8 12423.5 12425.3 12455.0 12469.7 663.9 781.7 798.4 803.4 805.0 783.1 789.1 791.1 792.1 792.8 853.7 858.4 860.5 860.7 860.9 700.8 839.6 849.8 854.0 866.2 612.4 613.4 614.4 616.5 616.8 14147.7 14232.9 14238.6 14258.6 14261.0 14520.5 14701.3 14823.9 14903.4 15001.7 11800.3 11972.2 12045.6 12112.9 12158.5 3751.8 3770.7 3807.4 3821.5 3857.1 54935.0 59264.0 59410.0 59428.7 59622.0 11331.7 11636.7 11826.2 11849.0 12144.9 20800.9 21056.5 21068.7 21076.6 21674.9 8592.2 8605.4 8670.1 8710.8 8791.6 4831.4 4872.3 4943.5 4960.3 5131.3 3640.9 3656.5 3774.1 3776.2 3783.1 683.7 694.3 704.3 707.1 708.2 666.3 692.5 693.3 698.1 711.6 9075.8 9115.7 9720.3 9834.0 9839.8 739.1 749.3 760.5 768.2 770.2 4467.2 4515.2 4632.6 4776.6 5336.9 74391.3 74874.3 76306.0 78519.2 78906.0 64921.0 66544.0 66549.3 66832.7 68040.0 59174.7 59919.4 60051.7 60786.7 60998.7 9991.7 10255.2 10379.2 10426.4 10457.9 38667.8 38876.6 39256.6 39345.6 40071.0 51973.0 53177.0 53356.5 54830.0 55122.0 12278.9 12380.1 12534.9 13233.5 13697.2 14099.4 14567.3 14621.3 14736.9 15456.4 13912.2 14115.8 14138.5 14293.5 14398.9 13077.9 13527.3 13676.5 13754.2 14036.9 13010.7 13551.1 13594.0 13620.5 13706.8 10393.2 10568.5 10691.8 11008.8 11087.7 10809.0 11722.2 11781.4 11864.8 12047.2 16:32:59 INFO - PROCESS | 8609 | -------- Summary: end -------- 16:32:59 INFO - PROCESS | 8609 | 16:32:59 INFO - TEST-INFO | 8609: exit 0 16:32:59 INFO - TEST-OK | dromaeo_css | took 1112876ms 16:32:59 INFO - TEST-START | kraken 16:32:59 INFO - operating with platform_type : linux_ 16:32:59 INFO - Initialising browser for kraken test... 16:32:59 INFO - TEST-INFO | started process 8792 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAi1aPN/profile http://localhost:37411/getInfo.html) 16:33:03 INFO - PROCESS | 8792 | __metrics Screen width/height:1600/1200 16:33:03 INFO - PROCESS | 8792 | colorDepth:24 16:33:03 INFO - PROCESS | 8792 | Browser inner width/height: 1024/697 16:33:03 INFO - PROCESS | 8792 | __metrics 16:33:05 ERROR - PROCESS | 8792 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:33:05 INFO - TEST-INFO | 8792: exit 0 16:33:05 INFO - Browser initialized. 16:33:05 INFO - Running cycle 1/1 for kraken test... 16:33:05 INFO - TEST-INFO | started process 8875 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAi1aPN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:33:17 INFO - PROCESS | 8875 | RSS: Main: 155312128 16:33:17 INFO - PROCESS | 8875 | 16:33:20 INFO - PROCESS | 8875 | Cycle 1(1): loaded http://localhost:37411/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37411/tests/kraken/driver.html?testName=audio-beat-detection) 16:33:21 INFO - PROCESS | 8875 | RSS: Main: 213446656 16:33:21 INFO - PROCESS | 8875 | 16:33:23 INFO - PROCESS | 8875 | Cycle 1(1): loaded http://localhost:37411/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37411/tests/kraken/driver.html?testName=audio-dft) 16:33:24 INFO - PROCESS | 8875 | RSS: Main: 200355840 16:33:24 INFO - PROCESS | 8875 | 16:33:27 INFO - PROCESS | 8875 | Cycle 1(1): loaded http://localhost:37411/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37411/tests/kraken/driver.html?testName=audio-fft) 16:33:28 INFO - PROCESS | 8875 | RSS: Main: 268541952 16:33:28 INFO - PROCESS | 8875 | 16:33:30 INFO - PROCESS | 8875 | Cycle 1(1): loaded http://localhost:37411/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37411/tests/kraken/driver.html?testName=audio-oscillator) 16:33:30 INFO - PROCESS | 8875 | RSS: Main: 179408896 16:33:30 INFO - PROCESS | 8875 | 16:33:32 INFO - PROCESS | 8875 | Cycle 1(1): loaded http://localhost:37411/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37411/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:33:33 INFO - PROCESS | 8875 | RSS: Main: 182923264 16:33:33 INFO - PROCESS | 8875 | 16:33:36 INFO - PROCESS | 8875 | Cycle 1(1): loaded http://localhost:37411/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37411/tests/kraken/driver.html?testName=imaging-darkroom) 16:33:37 INFO - PROCESS | 8875 | RSS: Main: 217505792 16:33:37 INFO - PROCESS | 8875 | 16:33:40 INFO - PROCESS | 8875 | Cycle 1(1): loaded http://localhost:37411/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37411/tests/kraken/driver.html?testName=imaging-desaturate) 16:33:41 INFO - PROCESS | 8875 | RSS: Main: 220065792 16:33:41 INFO - PROCESS | 8875 | 16:33:43 INFO - PROCESS | 8875 | Cycle 1(1): loaded http://localhost:37411/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37411/tests/kraken/driver.html?testName=json-parse-financial) 16:33:44 INFO - PROCESS | 8875 | RSS: Main: 219852800 16:33:44 INFO - PROCESS | 8875 | 16:33:45 INFO - PROCESS | 8875 | Cycle 1(1): loaded http://localhost:37411/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37411/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:33:46 INFO - PROCESS | 8875 | RSS: Main: 207953920 16:33:46 INFO - PROCESS | 8875 | 16:33:48 INFO - PROCESS | 8875 | Cycle 1(1): loaded http://localhost:37411/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37411/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:33:48 INFO - PROCESS | 8875 | RSS: Main: 210235392 16:33:48 INFO - PROCESS | 8875 | 16:33:51 INFO - PROCESS | 8875 | Cycle 1(1): loaded http://localhost:37411/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37411/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:33:51 INFO - PROCESS | 8875 | RSS: Main: 216604672 16:33:51 INFO - PROCESS | 8875 | 16:33:54 INFO - PROCESS | 8875 | Cycle 1(1): loaded http://localhost:37411/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37411/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:33:54 INFO - PROCESS | 8875 | RSS: Main: 221528064 16:33:54 INFO - PROCESS | 8875 | 16:33:57 INFO - PROCESS | 8875 | Cycle 1(1): loaded http://localhost:37411/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37411/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:33:58 INFO - PROCESS | 8875 | RSS: Main: 221876224 16:33:58 INFO - PROCESS | 8875 | 16:33:59 INFO - PROCESS | 8875 | Cycle 1(1): loaded http://localhost:37411/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37411/tests/kraken/driver.html?testName=ai-astar) 16:34:00 INFO - PROCESS | 8875 | RSS: Main: 263725056 16:34:00 INFO - PROCESS | 8875 | 16:34:00 INFO - PROCESS | 8875 | __start_tp_report 16:34:00 INFO - PROCESS | 8875 | _x_x_mozilla_page_load 16:34:00 INFO - PROCESS | 8875 | _x_x_mozilla_page_load_details 16:34:00 INFO - PROCESS | 8875 | |i|pagename|runs| 16:34:00 INFO - PROCESS | 8875 | |0;ai-astar;110;106;111;112;111;110;112;110;110;110 16:34:00 INFO - PROCESS | 8875 | |1;audio-beat-detection;148;132;127;185;125;131;146;124;170;124 16:34:00 INFO - PROCESS | 8875 | |2;audio-dft;160;163;161;161;159;161;160;159;161;160 16:34:00 INFO - PROCESS | 8875 | |3;audio-fft;75;77;73;117;75;76;77;75;101;75 16:34:00 INFO - PROCESS | 8875 | |4;audio-oscillator;83;84;122;83;84;82;123;83;83;119 16:34:00 INFO - PROCESS | 8875 | |5;imaging-gaussian-blur;117;117;117;117;117;118;118;117;117;117 16:34:00 INFO - PROCESS | 8875 | |6;imaging-darkroom;145;145;145;146;145;146;146;146;146;146 16:34:00 INFO - PROCESS | 8875 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 16:34:00 INFO - PROCESS | 8875 | |8;json-parse-financial;54;52;51;53;52;59;52;52;53;52 16:34:00 INFO - PROCESS | 8875 | |9;json-stringify-tinderbox;61;60;61;61;61;61;60;61;61;61 16:34:00 INFO - PROCESS | 8875 | |10;stanford-crypto-aes;79;79;78;84;79;81;80;81;108;83 16:34:00 INFO - PROCESS | 8875 | |11;stanford-crypto-ccm;136;123;124;126;119;120;139;131;131;123 16:34:00 INFO - PROCESS | 8875 | |12;stanford-crypto-pbkdf2;158;165;160;158;161;158;161;159;159;156 16:34:00 INFO - PROCESS | 8875 | |13;stanford-crypto-sha256-iterative;62;66;65;67;63;66;63;66;64;62 16:34:00 INFO - PROCESS | 8875 | __end_tp_report 16:34:00 INFO - PROCESS | 8875 | __start_cc_report 16:34:00 INFO - PROCESS | 8875 | _x_x_mozilla_cycle_collect,1611 16:34:00 INFO - PROCESS | 8875 | __end_cc_report 16:34:00 INFO - PROCESS | 8875 | __startTimestamp1464392040071__endTimestamp 16:34:00 INFO - PROCESS | 8875 | 16:34:00 INFO - PROCESS | 8875 | ------- Summary: start ------- 16:34:00 INFO - PROCESS | 8875 | Number of tests: 14 16:34:00 INFO - PROCESS | 8875 | 16:34:00 INFO - PROCESS | 8875 | [#0] ai-astar Cycles:10 Average:110.20 Median:110.50 stddev:1.69 (1.5%) stddev-sans-first:1.79 16:34:00 INFO - PROCESS | 8875 | Values: 110.0 106.0 111.0 112.0 111.0 110.0 112.0 110.0 110.0 110.0 16:34:00 INFO - PROCESS | 8875 | 16:34:00 INFO - PROCESS | 8875 | [#1] audio-beat-detection Cycles:10 Average:141.20 Median:139.00 stddev:21.24 (15.3%) stddev-sans-first:22.39 16:34:00 INFO - PROCESS | 8875 | Values: 148.0 132.0 127.0 185.0 125.0 131.0 146.0 124.0 170.0 124.0 16:34:00 INFO - PROCESS | 8875 | 16:34:00 INFO - PROCESS | 8875 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:1.18 (0.7%) stddev-sans-first:1.24 16:34:00 INFO - PROCESS | 8875 | Values: 160.0 163.0 161.0 161.0 159.0 161.0 160.0 159.0 161.0 160.0 16:34:00 INFO - PROCESS | 8875 | 16:34:00 INFO - PROCESS | 8875 | [#3] audio-fft Cycles:10 Average:82.10 Median:75.00 stddev:14.72 (19.6%) stddev-sans-first:15.38 16:34:00 INFO - PROCESS | 8875 | Values: 75.0 77.0 73.0 117.0 75.0 76.0 77.0 75.0 101.0 75.0 16:34:00 INFO - PROCESS | 8875 | 16:34:00 INFO - PROCESS | 8875 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:83.00 stddev:18.48 (22.3%) stddev-sans-first:19.12 16:34:00 INFO - PROCESS | 8875 | Values: 83.0 84.0 122.0 83.0 84.0 82.0 123.0 83.0 83.0 119.0 16:34:00 INFO - PROCESS | 8875 | 16:34:00 INFO - PROCESS | 8875 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 16:34:00 INFO - PROCESS | 8875 | Values: 117.0 117.0 117.0 117.0 117.0 118.0 118.0 117.0 117.0 117.0 16:34:00 INFO - PROCESS | 8875 | 16:34:00 INFO - PROCESS | 8875 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 16:34:00 INFO - PROCESS | 8875 | Values: 145.0 145.0 145.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 16:34:00 INFO - PROCESS | 8875 | 16:34:00 INFO - PROCESS | 8875 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 16:34:00 INFO - PROCESS | 8875 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 16:34:00 INFO - PROCESS | 8875 | 16:34:00 INFO - PROCESS | 8875 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:52.50 stddev:2.26 (4.3%) stddev-sans-first:2.37 16:34:00 INFO - PROCESS | 8875 | Values: 54.0 52.0 51.0 53.0 52.0 59.0 52.0 52.0 53.0 52.0 16:34:00 INFO - PROCESS | 8875 | 16:34:00 INFO - PROCESS | 8875 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 16:34:00 INFO - PROCESS | 8875 | Values: 61.0 60.0 61.0 61.0 61.0 61.0 60.0 61.0 61.0 61.0 16:34:00 INFO - PROCESS | 8875 | 16:34:00 INFO - PROCESS | 8875 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:80.50 stddev:8.92 (11.1%) stddev-sans-first:9.33 16:34:00 INFO - PROCESS | 8875 | Values: 79.0 79.0 78.0 84.0 79.0 81.0 80.0 81.0 108.0 83.0 16:34:00 INFO - PROCESS | 8875 | 16:34:00 INFO - PROCESS | 8875 | [#11] stanford-crypto-ccm Cycles:10 Average:127.20 Median:128.50 stddev:6.76 (5.3%) stddev-sans-first:6.38 16:34:00 INFO - PROCESS | 8875 | Values: 136.0 123.0 124.0 126.0 119.0 120.0 139.0 131.0 131.0 123.0 16:34:00 INFO - PROCESS | 8875 | 16:34:00 INFO - PROCESS | 8875 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.50 Median:159.50 stddev:2.46 (1.5%) stddev-sans-first:2.55 16:34:00 INFO - PROCESS | 8875 | Values: 158.0 165.0 160.0 158.0 161.0 158.0 161.0 159.0 159.0 156.0 16:34:00 INFO - PROCESS | 8875 | 16:34:00 INFO - PROCESS | 8875 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:65.50 stddev:1.84 (2.8%) stddev-sans-first:1.73 16:34:00 INFO - PROCESS | 8875 | Values: 62.0 66.0 65.0 67.0 63.0 66.0 63.0 66.0 64.0 62.0 16:34:00 INFO - PROCESS | 8875 | -------- Summary: end -------- 16:34:00 INFO - PROCESS | 8875 | 16:34:00 INFO - TEST-INFO | 8875: exit 0 16:34:01 INFO - TEST-OK | kraken | took 61196ms 16:34:01 INFO - SUITE-END | took 1174s 16:34:01 INFO - Completed test suite (00:19:34) 16:34:01 INFO - javascript benchmark 16:34:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3159.6840315968407, 3176.364727054588, 3195.4567723487003, 3212.405704944584, 3242.5136229565564, 5321.414644389124, 5396.055690254209, 5466.344038715355, 5511.255980442639, 5527.115661494162, 5426.158945363465, 5474.39781624021, 5475.206095116206, 5486.286782718251, 5519.199716041182, 4910.165271903785, 4990.65065445419, 5006.349174607296, 5039.84880453587, 5214.400343960437, 5103.23451482277, 5107.591392688594, 5120.820771273006, 5161.896762064775, 5167.870803229912, 4814.422269327668, 4865.3675022247235, 4869.683470574401, 4927.802887884481, 4945.629077819142, 4847.806087756486, 4854.611631069506, 4861.489543597942, 4868.756562171912, 4955.950440495585, 4861.829835955725, 4898.191798353268, 4908.509149085098, 4910.484399138075, 4930.087933732271, 5197.506236907488, 5235.712035838027, 5238.1618940969265, 5279.102552566073, 5413.702246376448, 5639.605227634067, 5699.430056994309, 5705.343885453184, 5722.570807189478, 5731.541476681856, 5693.4875861172695, 5759.625624334405, 5766.452187042224, 5768.048272035109, 5777.768889244425, 5317.441668624816, 5435.0, 5456.890862182774, 5495.725213739337, 5577.2191893135, 6054.09278165868, 6064.145763134906, 6064.587407993564, 6103.992841181155, 6115.602485838406, 5520.91718624221, 5818.330891947396, 5823.650580965155, 5871.794487192928, 5873.794417195378, 5691.231683722727, 5714.7999820006935, 5731.455511726379, 5776.5089967352405, 5783.8554036149435, 5717.485426311652, 5732.197492351074, 5738.368779434259, 5739.62692424991, 5757.769689212385, 5616.747246373923, 5724.656520608693, 5774.538036957033, 5776.971115144482, 5781.82654520365, 4411.889702757392, 4453.643708503312, 4459.620932220732, 4493.460784705856, 4503.189425903369, 3957.980210098931, 3971.384435412516, 3974.026363540951, 3981.462502562175, 4014.7791871447353, 5296.417394086648, 5390.811321603725, 5493.752781124859, 5558.861028474321, 5632.098864181711, 5907.23205983228, 5916.704164791743, 5946.970265148647, 5973.253343332083, 6009.609375390585, 5603.831885043455, 5613.971930140405, 5619.690916999604, 5621.297337832771, 5622.57830662702, 4990.3762029746285, 5023.899522009539, 5082.974585127125, 5112.054269960069, 5122.538971492583, 6142.13045781164, 6145.692715364214, 6149.0, 6151.046587778901, 6157.507399408037, 5928.733207005781, 5930.614510056833, 5931.6441013539325, 5943.64338139713, 5965.791197308074, 5884.7940322088525, 6028.849278768066, 6082.695865206811, 6108.694565271808, 6121.173641558333, 5804.622699524517, 5845.503132233808, 5845.824625261249, 5849.181114644039, 5852.882942341214, 5938.2280303560265, 5939.346671866005, 5939.792107276225, 5947.791827286024, 5957.046872500379, 5600.943990560042, 5602.355729091207, 5637.126245431965, 5679.74441150141, 5723.370429252862, 5665.971670141623, 5667.40492248308, 5668.858278542904, 5669.489745922887, 5680.375158732619, 5421.295231619864, 5576.693281869536, 5585.301837270341, 5588.497035266845, 5592.161175823659, 5719.941810764855, 5765.509931655856, 5783.277090363705, 5867.266591676041, 5884.08796636522, 5666.206731057738, 5702.486776190163, 5704.714764261687, 5707.0583353747825, 5751.252337196138], "value": 5384.1556352970165, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [621.1490258346065, 622.2968046107898, 634.5399585300656, 646.1825790375174, 648.4293821437135, 31706.524402133957, 42618.78690606546, 44742.552574474284, 44837.327440088426, 47959.28061079087, 46413.535864641344, 46569.767151164284, 46607.76696116514, 46622.60132196039, 46656.533434665726, 8667.696630617915, 8878.28973682104, 8886.155815197546, 8886.600102995348, 8892.8666070009, 8688.131186881325, 8807.471551706885, 8825.426347287406, 8832.470051796881, 8832.558372081403, 8879.51162686052, 8932.55337233139, 8941.955290223572, 8949.865752013726, 8953.194212520872, 8874.0, 8931.598078086437, 8931.776705582348, 8940.910590894073, 8942.821143577092, 8765.693200737944, 8881.156290152425, 8884.689035883714, 8888.288936885034, 8890.110988901122, 43026.35460468096, 43425.565744342784, 43450.782746086385, 43474.56525434768, 43479.78260108711, 3262.6574209708115, 3527.6825085742407, 3546.308469848381, 3719.107414220595, 4029.435878976946, 32293.838530807196, 32705.345893082005, 33615.0, 33641.6635833641, 33645.831770841236, 4321.783910804447, 4355.1725172217175, 4381.4961279452955, 4438.889027774299, 4481.282994720862, 323887.0, 325656.0, 325878.0, 326353.0, 328053.3597332022, 52361.47638523566, 58670.0, 59292.11061834076, 59354.70322648445, 59384.812303753686, 62070.68964655148, 63445.682771585845, 63659.36340636627, 68730.0, 68741.3125868745, 16754.4135955241, 16819.66360672804, 16914.238859251363, 16930.830691692925, 16942.66114677724, 11444.599439019761, 12070.155089143676, 12701.618951431472, 12786.168899021533, 12797.488100476063, 17327.873688210228, 17825.554361140817, 17923.910380448015, 18034.729479057823, 18052.91682499054, 6048.153258543807, 6215.0, 6243.687815609293, 6304.18045654062, 6413.29453760086, 963.677168148678, 1024.994875025635, 1047.8375851742992, 1093.4642025407493, 1151.8445009923553, 32893.50659740106, 32970.0, 33397.83301083479, 33434.0, 33568.3286334272, 1083.707399002265, 1120.4789772755707, 1127.960521381764, 1167.177140116216, 1199.2564609941717, 17262.913685431744, 18195.363162289257, 18266.0, 18559.35042273541, 18896.905515472336, 468558.0, 474467.0, 476989.0, 477737.0, 492147.0, 58234.92355535157, 59299.407005930254, 59384.703076484344, 59410.10884836731, 59455.10817337743, 1278.8721127887136, 1386.83357997041, 1387.070662656023, 1416.206924122474, 1431.2628996066826, 32036.35927281395, 33968.490472642436, 33989.83005084959, 34342.0, 34434.655653443144, 49992.50007499878, 50296.0, 50563.0, 50571.2414313793, 50697.239541407645, 372334.0, 372865.0, 373540.0, 374338.0, 374919.0, 24453.87773061123, 45180.0, 45471.31793023041, 46793.29810052784, 46906.76546617245, 48065.5193448075, 48273.0, 48865.75567122284, 51373.0, 51880.22179667383, 42833.357499636906, 42966.78516607397, 43832.56167438285, 44367.0, 44703.32945005762, 42510.362344565474, 42961.0, 43424.34863477114, 43443.782781085894, 43846.561534385524, 41639.37540936828, 42511.57488425076, 43607.12785744331, 43626.0, 43631.56368436275, 38060.619393805704, 38237.11731888287, 38784.66659679733, 38907.22185556329, 39157.0, 28920.469205882837, 28942.855285723435, 28972.420551588428, 29001.56497652579, 29427.0], "value": 20457.40730356385, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.92591444668284, 385.9286032084064, 393.3607887183327, 404.6722155054404, 410.71455338539727, 17668.91165544172, 18586.81413185868, 20277.493062673442, 20297.898510507428, 20313.695294570574, 11363.14776391772, 11550.595729149481, 11561.0, 11602.419879006036, 15485.845141548609, 4827.5172482751705, 4956.7025978441225, 5037.042961837257, 5056.797728090872, 5074.4925507449325, 3874.418837174418, 5337.946620533784, 5609.242752228438, 5619.269494965649, 5703.600747947646, 5640.294963129609, 5655.0, 5665.12190610456, 5700.059490184115, 5874.5594080443925, 6109.602875813102, 6266.185395898504, 6467.353264673518, 6472.967635161817, 6479.449246814026, 3758.1168425420005, 5239.973800131013, 5528.917066244009, 5566.304211973504, 5593.440655934414, 12926.224426534438, 13081.21512709231, 13127.474901003949, 13283.800742988862, 13357.866421335857, 2095.8428117891067, 2116.7459904811367, 2215.8670479771267, 2278.9972412138604, 2848.572714092882, 9251.0, 9732.805343893082, 9864.30949833512, 12517.937410312981, 14204.164875483664, 1827.2599597163037, 1861.2741030997922, 1906.1803424527448, 1926.0273561851175, 1981.9405417837343, 75690.62154689246, 80459.0, 80920.0, 81944.59027704883, 82111.58944205301, 10150.0, 10546.156307495536, 11126.833097503544, 11133.443327833576, 11298.830517542243, 15367.15480648575, 15425.84574154244, 15526.689466210613, 15544.76682849758, 15548.689026219412, 7949.6025198739835, 8088.797780055545, 8121.79695507617, 8251.546164960864, 8323.750287491264, 7557.886631700529, 7646.273604007611, 7664.693412263447, 7725.961370193113, 7769.72805951789, 4112.979435102865, 4261.190373829025, 4777.928331075037, 4802.831900883452, 4843.346148270009, 1767.6258509279637, 1853.9073046347628, 1976.9308074217333, 1990.7710613279369, 2022.7572691276846, 410.2246753635631, 879.872418499314, 937.095702646949, 1000.3647683720744, 1005.9889810740159, 10717.83923241152, 11217.60738374153, 11334.263272887401, 11382.772344553228, 11510.712232194262, 420.72442550129716, 421.97679127648274, 432.1055415290319, 441.0891509033835, 441.3512137158372, 5963.642181469126, 6157.415045570664, 6163.9383606164265, 6197.907031394533, 6319.873602528016, 439436.0, 444770.0, 476076.0, 481431.0, 500031.0, 61351.0, 68694.0, 87273.12726872777, 90631.0, 92974.0, 428.03478156756313, 430.896584819641, 432.1529801588921, 434.08408258574383, 435.6427729261975, 10173.33873298263, 10269.537870795682, 10541.262111652417, 10557.788844223227, 10580.36517808934, 39120.413193802684, 39703.40444893387, 40127.0, 41490.170196596504, 41777.0, 56237.718811405684, 57228.42771572231, 57896.421035789106, 58332.125018123916, 58337.0, 8263.504189748634, 8394.412391132562, 8438.198371154731, 8714.477131372138, 8728.738137855875, 8845.557722113997, 10859.859714729839, 11566.30602163873, 12769.553065642658, 13584.049116561746, 11332.660020199408, 11508.94245528767, 11534.942325288655, 11655.358955257543, 11969.581064662694, 5782.017057100387, 10120.949395252977, 10940.781184376427, 11568.537258509901, 11781.108051789799, 11809.23239989398, 11912.463939122586, 12153.756924861631, 12200.328981906081, 12213.633590992284, 8141.185881411811, 8301.916980830114, 8367.456115352483, 8388.412811103164, 8520.957395213232, 8860.803791488066, 11736.354500502553, 12019.519219231133, 12148.817767733668, 12205.389730513616], "value": 7972.511469026132, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1319.379891451019, 1521.855423734745, 1541.6685412636284, 1728.69747794136, 1867.9533011674714, 8659.826803463928, 9041.186293233608, 9048.547572621368, 9248.0, 9253.95373023134, 9047.41191822531, 9238.953805230982, 9250.02874698157, 9267.258619310456, 9268.165865072142, 2087.488565301503, 2271.1483193802324, 2338.1348900906687, 2378.774016468437, 2408.1932552594903, 2391.4021494626345, 2396.8801559921935, 2402.327348342467, 2403.591389463795, 2411.8191135664806, 2316.559853627814, 2368.5736567417857, 2368.6683864259016, 2370.7036620422446, 2371.8695471749134, 1910.7707075151002, 2307.457747429361, 2378.5361854438393, 2382.4401265702545, 2397.736249012607, 2268.274152271274, 2278.612635851909, 2279.031411650042, 2291.919782807594, 2347.8826058696995, 9128.0, 9128.634854605807, 9141.680041198593, 9160.587773550205, 9203.26373890094, 5555.583331250132, 5701.315842098975, 5709.115087161496, 5717.142428635696, 5718.71406429681, 3223.693749093832, 3306.933861322784, 3336.616289126733, 3350.782199157047, 3357.1103657530775, 1045.628801775374, 1047.1727335405021, 1050.070687441612, 1069.5454431866426, 1070.8875568065318, 13114.540991065362, 13153.473861045546, 13172.0, 13185.142965707199, 13202.867971320356, 4887.780049897763, 4948.158813001798, 5001.4998500149695, 5014.022265658162, 5036.690460480301, 10941.671749847517, 11016.283941543774, 11020.944895275632, 11033.0, 11055.0, 5008.4240312364545, 5545.944540554624, 5548.55611551075, 5555.361133469622, 5561.6663000220115, 4975.303457515951, 5145.819896303611, 5149.819756308511, 5201.063808514504, 5202.687838729688, 4120.381942708557, 4124.52567954683, 4220.07158425146, 4241.533431322552, 4289.6139347458875, 1281.858995510493, 1340.1490053815896, 1340.3097404836517, 1345.604823414324, 1351.9256440895845, 968.704545113747, 993.9811693014718, 997.3018886779283, 998.121652945418, 1011.7571782772081, 6081.665508396992, 6083.422074902877, 6295.338989406138, 6321.747130114744, 6414.422701956753, 953.3803028031834, 1045.4668119259081, 1068.7435015596202, 1069.4118234970736, 1076.7469644633504, 3923.7645741255615, 3939.3893946438347, 3949.111449923744, 3957.52509698838, 4141.627253547195, 11452.94273528627, 11845.170838041427, 11858.644240672793, 11865.466054027589, 11902.047836173086, 11572.710682233012, 11747.47136378865, 11753.4710938008, 11756.294622322688, 11768.058555315554, 8573.27127194183, 8631.6978905738, 8700.477971321741, 8774.341924355698, 8787.472751634794, 5827.213326201078, 5908.468237858613, 5918.704064796829, 5951.55363347742, 6094.634321940698, 10573.2598718089, 10783.352998820095, 10866.728331791768, 10907.672769816918, 10920.126389888632, 10881.891181088087, 10918.399488028235, 10931.453427328443, 11145.554177832795, 11241.325520468798, 6930.410915072275, 7705.42209334291, 7824.4131690124605, 8457.57712114404, 8748.65005399777, 8792.824143516966, 8932.910670893209, 8991.955040224757, 9092.499912504876, 9112.134347237003, 7828.256315650005, 8024.0772311184965, 8081.070676872235, 8134.06458257308, 8203.30271926869, 7809.92190078092, 7853.175416581405, 7919.445638805229, 7929.762107136795, 8113.878291825746, 6701.0, 6735.797926062226, 6818.8636227276165, 6837.487188460786, 7246.239144889922, 4992.80028798844, 5022.447530771539, 5024.84925452237, 5055.747212639427, 5107.565856902205, 5225.529702326809, 5245.449227831023, 5281.498257665516, 5385.6230063895155, 5450.727463626882], "value": 4802.6237504191495, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.4171656686627, 292.4866858663047, 298.1844654868933, 300.8616036623153, 301.2709243630415, 5296.814611488594, 5317.627766056377, 5334.5732341412695, 5349.465053494649, 5383.973080134594, 5248.737563121847, 5280.815171468999, 5285.339332583427, 5312.123499622558, 5312.362516498016, 4081.1225586498895, 4086.1419101988467, 4094.3858421236755, 4129.112240868213, 4136.751794892301, 3905.2775236581183, 4094.61101195386, 4098.672106231509, 4129.215449064668, 4131.173765246947, 3929.862454814082, 4018.919621607566, 4021.396790481422, 4046.8785936421955, 4068.0473372781084, 3964.8017599120217, 3978.3833505806647, 4029.0934539728473, 4031.254217969685, 4047.9392809107885, 3308.17295676081, 3443.6212016678396, 3523.436250199956, 3541.1501239702543, 3554.306910152521, 5000.1499445205145, 5052.494750524955, 5056.772445239936, 5057.645964782467, 5075.695458272478, 4342.761148136851, 4524.841630542948, 4574.771261436948, 4600.654950878664, 4635.6523260755575, 5290.1800220965815, 5442.312883006281, 5465.699386533739, 5477.1510415885605, 5490.835274941758, 3794.2221844521805, 3798.810059497042, 3816.8282427290837, 3822.73240873139, 3831.2720583089404, 5533.280673512458, 5680.971595142039, 5721.370649228582, 5734.0, 5777.075667893159, 3921.490206273223, 3926.450296958428, 3932.803359831997, 3945.151792364655, 3962.0887195945093, 4002.0, 4010.8796736097966, 4028.436018957348, 4036.899077523027, 4037.6769858411258, 4597.540245975442, 4597.793099310539, 4639.930401043987, 4641.582257596832, 4663.207254766698, 5308.628396012319, 5488.4785945335925, 5494.340679118532, 5527.170924361378, 5562.082256427644, 1356.3150608942617, 1359.7960305954186, 1367.5213675213795, 1374.4949280537794, 1386.8682475164844, 848.3001523742937, 885.623609965762, 889.0, 896.677400833765, 901.6799036342135, 4690.601298889633, 4694.882627934329, 4749.2876068589985, 4781.450133234723, 4839.346688197048, 5014.323066386064, 5021.447640759514, 5022.59819214462, 5023.748812559431, 5026.572741317029, 4794.0, 4799.568038876518, 4803.447603525639, 4826.903461930741, 5001.874953126128, 2876.424715056997, 2923.4299311634027, 3015.522394026911, 3015.7135072168107, 3046.390721855638, 5873.236479257669, 5893.0, 5906.940930590725, 5912.260967379078, 5925.200097986803, 5534.418886016991, 5723.971380143073, 5760.74076666551, 5793.131030345482, 5819.272590926134, 5807.751333463326, 5807.912881306784, 5842.211301474246, 5859.589828711949, 5879.323877754027, 5639.4642508963225, 5646.491815736604, 5670.432956704297, 5710.37185909558, 5721.799737009184, 5403.972980135231, 5603.075492543685, 5609.691466969192, 5627.859303517281, 5645.68948707825, 5810.477057064884, 5822.388649191774, 5864.709763851945, 5888.646681199141, 5891.23413956183, 3814.1608846053823, 3816.160444702161, 3821.159344944108, 3847.48059012041, 3851.942220866745, 5496.477834605706, 5551.528844856197, 5579.74891129892, 5654.491095801398, 5669.3480249770155, 5430.647007944471, 5434.614173385761, 5443.782248710166, 5493.862653433536, 5505.889882202254, 5326.97336513315, 5407.458494507575, 5450.945490545044, 5456.508914197741, 5462.808801691922, 5293.947060529499, 5319.787208511616, 5375.521731523862, 5389.892202156013, 5406.0, 5444.373897001896, 5464.235007099089, 5487.259220005249, 5489.890202195854, 5505.394406615349, 5213.608979326642, 5375.220593014069, 5395.24466574672, 5434.510894019557, 5527.723613819213], "value": 4114.285562105404, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [723.7792473295643, 748.0835975929484, 804.9517028978262, 829.7469271872078, 851.2508992086963, 13026.934865325671, 13469.191848489074, 13608.659783505418, 13625.523106691267, 13658.317084145803, 12398.752024959495, 12423.503059877617, 12425.254484730922, 12455.0, 12469.68825779356, 663.9170103737033, 781.7185813107277, 798.377265732728, 803.3693550562809, 804.9597520123999, 783.1229023493695, 789.1358961936699, 791.078393671375, 792.0693185507006, 792.8057625881667, 853.6798700487317, 858.4119877883638, 860.5482121886029, 860.7288704058233, 860.918212769789, 700.7967689370103, 839.6347588798861, 849.757819021582, 854.0050840770494, 866.1944391715701, 612.3845535237058, 613.3866133866134, 614.4316507230793, 616.516034912596, 616.7563812294119, 14147.717045659132, 14232.932530060183, 14238.644033899132, 14258.64353391163, 14261.0, 14520.491782787552, 14701.338439770236, 14823.925880370529, 14903.403863845433, 15001.699966000619, 11800.291982481078, 11972.161948663597, 12045.578404755792, 12112.939435302767, 12158.5136594537, 3751.81240937952, 3770.698344132463, 3807.3527500325013, 3821.5414150301863, 3857.0935830079907, 54935.0, 59264.0, 59410.0, 59428.70285648587, 59622.0, 11331.716707082389, 11636.709082272842, 11826.231294965799, 11849.0, 12144.878551214375, 20800.89599552023, 21056.473588160417, 21068.683969740465, 21076.578468430547, 21674.891625542088, 8592.226699597066, 8605.354598405145, 8670.089640587648, 8710.825783484295, 8791.560421978875, 4831.4202295724735, 4872.293517439952, 4943.456219815817, 4960.305557221992, 5131.307273518102, 3640.927181456409, 3656.542932133483, 3774.1319496515407, 3776.15036616759, 3783.05423644089, 683.6752542542353, 694.2952902803659, 704.264044073944, 707.0631413377296, 708.1714394158846, 666.2970566052763, 692.5256199503256, 693.2789898505598, 698.1308271202386, 711.6441779110445, 9075.773105672411, 9115.680951166678, 9720.31957762964, 9833.950830245803, 9839.754006149904, 739.0946091038543, 749.2956620776453, 760.5358638012799, 768.2240936654019, 770.2143813310392, 4467.173572889026, 4515.187266292099, 4632.559906808848, 4776.617870570346, 5336.866578335573, 74391.25608743844, 74874.25125748673, 76306.0, 78519.21480785233, 78906.0, 64921.0, 66544.0, 66549.33450665431, 66832.66583667051, 68040.0, 59174.70412647909, 59919.400805992256, 60051.69974150101, 60786.696066519384, 60998.695006524686, 9991.700248992542, 10255.179585633281, 10379.221558383, 10426.374417534973, 10457.895421045692, 38667.80666096652, 38876.6112338873, 39256.60743392644, 39345.60654393534, 40071.0, 51973.0, 53177.0, 53356.466435336704, 54830.0, 55122.0, 12278.881312382717, 12380.133390662568, 12534.87465125337, 13233.536826211037, 13697.246651433868, 14099.365528551034, 14567.271636418349, 14621.342039608457, 14736.926315368355, 15456.381744730084, 13912.234827084607, 14115.788263175855, 14138.50515231962, 14293.499727509487, 14398.928005359907, 13077.934610326887, 13527.256000920044, 13676.452941882213, 13754.174749515061, 14036.929815350857, 13010.674733131369, 13551.119177253448, 13594.0, 13620.455181792617, 13706.794398083837, 10393.220508461744, 10568.471576421302, 10691.839622405514, 11008.834867476835, 11087.722806929569, 10809.037031144197, 11722.179447438597, 11781.410929453321, 11864.822027669765, 12047.216930899463], "value": 7138.307143131632, "unit": "score"}], "name": "dromaeo_css", "value": 7060.399593759076, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 106.0, 111.0, 112.0, 111.0, 110.0, 112.0, 110.0, 110.0, 110.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 132.0, 127.0, 185.0, 125.0, 131.0, 146.0, 124.0, 170.0, 124.0], "value": 141.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 161.0, 161.0, 159.0, 161.0, 160.0, 159.0, 161.0, 160.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 73.0, 117.0, 75.0, 76.0, 77.0, 75.0, 101.0, 75.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 122.0, 83.0, 84.0, 82.0, 123.0, 83.0, 83.0, 119.0], "value": 94.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 51.0, 53.0, 52.0, 59.0, 52.0, 52.0, 53.0, 52.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 61.0, 61.0, 61.0, 61.0, 60.0, 61.0, 61.0, 61.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 84.0, 79.0, 81.0, 80.0, 81.0, 108.0, 83.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 123.0, 124.0, 126.0, 119.0, 120.0, 139.0, 131.0, 131.0, 123.0], "value": 127.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 165.0, 160.0, 158.0, 161.0, 158.0, 161.0, 159.0, 159.0, 156.0], "value": 159.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 66.0, 65.0, 67.0, 63.0, 66.0, 63.0, 66.0, 64.0, 62.0], "value": 64.4, "unit": "score"}], "name": "kraken", "value": 1494.5000000000002, "alertThreshold": 2.0}]} 16:34:01 INFO - Return code: 0 16:34:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:34:01 ERROR - # TBPL SUCCESS # 16:34:01 INFO - Running post-action listener: _resource_record_post_action 16:34:01 INFO - ##### 16:34:01 INFO - ##### Finished run-tests step (success) 16:34:01 INFO - ##### 16:34:01 INFO - Running post-run listener: _resource_record_post_run 16:34:01 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 143360; Write bytes: 538910720; Read time: 76; Write time: 578416 16:34:01 INFO - TinderboxPrint: CPU usage
13.1% 16:34:01 INFO - TinderboxPrint: I/O read bytes / time
143,360 / 76 16:34:01 INFO - TinderboxPrint: I/O write bytes / time
538,910,720 / 578,416 16:34:01 INFO - TinderboxPrint: CPU idle
8,263.2 (86.9%) 16:34:01 INFO - TinderboxPrint: CPU user
1,203.7 (12.7%) 16:34:01 INFO - TinderboxPrint: Swap in / out
0 / 0 16:34:01 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 253661184; Read time: 0; Write time: 327856 16:34:01 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 143360; Write bytes: 285249536; Read time: 76; Write time: 250560 16:34:02 INFO - Running post-run listener: _upload_blobber_files 16:34:02 INFO - Blob upload gear active. 16:34:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:34:02 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 16:34:02 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:34:02 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:34:02 INFO - (blobuploader) - INFO - Open directory for files ... 16:34:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:34:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:34:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:34:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:34:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:34:03 INFO - (blobuploader) - INFO - Done attempting. 16:34:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:34:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:34:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:34:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:34:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:34:03 INFO - (blobuploader) - INFO - Done attempting. 16:34:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:34:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:34:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:34:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:34:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:34:08 INFO - (blobuploader) - INFO - Done attempting. 16:34:08 INFO - (blobuploader) - INFO - Iteration through files over. 16:34:08 INFO - Return code: 0 16:34:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:34:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:34:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd193ac3d44b6058c11a383952c2d460ee7a9385b28c7403a93b4912ad9dc029b2f369fa2083ba7055fd149c700a11ec8f55699c23f95a5e1ca6d04aade5b85c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/28ffb079fba05578dd10595518f685511e75aa240d2c72ddd659b0db10e50603e5ed932fb929bacfb4c6120330588bfe50eb3ef1448b4477a536594d5005ef3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/257977ab0d4d967ec8235c1803b2c3a84528c485176104b87bcf78887f84ca93aa765fabf7befedfdf2eaf772525eb8bafa3936537962f5ead300d8dd6463859"} 16:34:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:34:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:34:08 INFO - Contents: 16:34:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd193ac3d44b6058c11a383952c2d460ee7a9385b28c7403a93b4912ad9dc029b2f369fa2083ba7055fd149c700a11ec8f55699c23f95a5e1ca6d04aade5b85c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/28ffb079fba05578dd10595518f685511e75aa240d2c72ddd659b0db10e50603e5ed932fb929bacfb4c6120330588bfe50eb3ef1448b4477a536594d5005ef3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/257977ab0d4d967ec8235c1803b2c3a84528c485176104b87bcf78887f84ca93aa765fabf7befedfdf2eaf772525eb8bafa3936537962f5ead300d8dd6463859"} 16:34:08 INFO - Running post-run listener: copy_logs_to_upload_dir 16:34:08 INFO - Copying logs to upload dir... 16:34:08 INFO - mkdir: /builds/slave/test/build/upload/logs 16:34:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.923685 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-05-27 16:34:08.005384) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 16:34:08.008928) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1464390792.608015-1730503185 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd193ac3d44b6058c11a383952c2d460ee7a9385b28c7403a93b4912ad9dc029b2f369fa2083ba7055fd149c700a11ec8f55699c23f95a5e1ca6d04aade5b85c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/28ffb079fba05578dd10595518f685511e75aa240d2c72ddd659b0db10e50603e5ed932fb929bacfb4c6120330588bfe50eb3ef1448b4477a536594d5005ef3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/257977ab0d4d967ec8235c1803b2c3a84528c485176104b87bcf78887f84ca93aa765fabf7befedfdf2eaf772525eb8bafa3936537962f5ead300d8dd6463859"} build_url:https://queue.taskcluster.net/v1/task/dokNQB2XT82AEM0wdpCLcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011376 build_url: 'https://queue.taskcluster.net/v1/task/dokNQB2XT82AEM0wdpCLcg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd193ac3d44b6058c11a383952c2d460ee7a9385b28c7403a93b4912ad9dc029b2f369fa2083ba7055fd149c700a11ec8f55699c23f95a5e1ca6d04aade5b85c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/28ffb079fba05578dd10595518f685511e75aa240d2c72ddd659b0db10e50603e5ed932fb929bacfb4c6120330588bfe50eb3ef1448b4477a536594d5005ef3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/257977ab0d4d967ec8235c1803b2c3a84528c485176104b87bcf78887f84ca93aa765fabf7befedfdf2eaf772525eb8bafa3936537962f5ead300d8dd6463859"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 16:34:08.038538) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 16:34:08.038878) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1464390792.608015-1730503185 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004484 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 16:34:08.123160) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 16:34:08.123861) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 16:34:08.124503) ========= ========= Total master_lag: 0.18 =========