builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-058 starttime: 1463061965.44 results: success (0) buildid: 20160512043053 builduid: 46ef79d4eee54e17b5df5a611d0775f4 revision: c3f5e6079284a7b7053c41f05d0fe06ff031db03 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-12 07:06:05.443783) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-12 07:06:05.444255) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-12 07:06:05.444621) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-12 07:06:05.486083) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 07:06:05.486392) ========= 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=0e2a256762fed810e2f0f810000001b3-1463059451.618068-841884228 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-12 07:06:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 35.0M=0s 2016-05-12 07:06:05 (35.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127320 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 07:06:05.634154) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 07:06:05.634512) ========= 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=0e2a256762fed810e2f0f810000001b3-1463059451.618068-841884228 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018143 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 07:06:05.687042) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-12 07:06:05.687512) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c3f5e6079284a7b7053c41f05d0fe06ff031db03 --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 c3f5e6079284a7b7053c41f05d0fe06ff031db03 --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=0e2a256762fed810e2f0f810000001b3-1463059451.618068-841884228 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-12 07:06:05,971 truncating revision to first 12 chars 2016-05-12 07:06:05,971 Setting DEBUG logging. 2016-05-12 07:06:05,971 attempt 1/10 2016-05-12 07:06:05,971 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c3f5e6079284?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-12 07:06:07,169 unpacking tar archive at: mozilla-central-c3f5e6079284/testing/mozharness/ program finished with exit code 0 elapsedTime=1.468879 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-12 07:06:07.171146) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-12 07:06:07.171552) ========= script_repo_revision: c3f5e6079284a7b7053c41f05d0fe06ff031db03 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-12 07:06:07.172046) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-12 07:06:07.172423) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-12 07:06:07.183038) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 24 mins, 54 secs) (at 2016-05-12 07:06:07.183545) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=0e2a256762fed810e2f0f810000001b3-1463059451.618068-841884228 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:06:07 INFO - MultiFileLogger online at 20160512 07:06:07 in /builds/slave/test 07:06:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:06:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:06:07 INFO - {'append_to_log': False, 07:06:07 INFO - 'base_work_dir': '/builds/slave/test', 07:06:07 INFO - 'blob_upload_branch': 'Firefox', 07:06:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:06:07 INFO - 'branch': 'Firefox', 07:06:07 INFO - 'buildbot_json_path': 'buildprops.json', 07:06:07 INFO - 'config_files': ('talos/linux_config.py',), 07:06:07 INFO - 'default_actions': ('clobber', 07:06:07 INFO - 'read-buildbot-config', 07:06:07 INFO - 'download-and-extract', 07:06:07 INFO - 'populate-webroot', 07:06:07 INFO - 'create-virtualenv', 07:06:07 INFO - 'install', 07:06:07 INFO - 'run-tests'), 07:06:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:06:07 INFO - 'download_minidump_stackwalk': True, 07:06:07 INFO - 'download_symbols': 'ondemand', 07:06:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:06:07 INFO - 'tooltool.py': '/tools/tooltool.py', 07:06:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:06:07 INFO - '/tools/misc-python/virtualenv.py')}, 07:06:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:06:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:06:07 INFO - 'installer_path': 'installer.exe', 07:06:07 INFO - 'log_level': 'info', 07:06:07 INFO - 'log_name': 'talos', 07:06:07 INFO - 'log_to_console': True, 07:06:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:06:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:06:07 INFO - 'opt_config_files': (), 07:06:07 INFO - 'pip_index': False, 07:06:07 INFO - 'sps_profile': False, 07:06:07 INFO - 'sps_profile_interval': 0, 07:06:07 INFO - 'suite': 'dromaeojs-e10s', 07:06:07 INFO - 'system_bits': '32', 07:06:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:06:07 INFO - 'title': 'talos-linux64-ix-058', 07:06:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:06:07 INFO - 'use_talos_json': True, 07:06:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:06:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:06:07 INFO - 'work_dir': 'build'} 07:06:07 INFO - ##### 07:06:07 INFO - ##### Running clobber step. 07:06:07 INFO - ##### 07:06:07 INFO - Running pre-action listener: _resource_record_pre_action 07:06:07 INFO - Running main action method: clobber 07:06:07 INFO - rmtree: /builds/slave/test/build 07:06:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:06:08 INFO - Running post-action listener: _resource_record_post_action 07:06:08 INFO - ##### 07:06:08 INFO - ##### Finished clobber step (success) 07:06:08 INFO - ##### 07:06:08 INFO - ##### 07:06:08 INFO - ##### Running read-buildbot-config step. 07:06:08 INFO - ##### 07:06:08 INFO - Running pre-action listener: _resource_record_pre_action 07:06:08 INFO - Running main action method: read_buildbot_config 07:06:08 INFO - Using buildbot properties: 07:06:08 INFO - { 07:06:08 INFO - "project": "", 07:06:08 INFO - "product": "firefox", 07:06:08 INFO - "script_repo_revision": "production", 07:06:08 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:06:08 INFO - "repository": "", 07:06:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 07:06:08 INFO - "buildid": "20160512043053", 07:06:08 INFO - "pgo_build": "True", 07:06:08 INFO - "basedir": "/builds/slave/test", 07:06:08 INFO - "buildnumber": 196, 07:06:08 INFO - "slavename": "talos-linux64-ix-058", 07:06:08 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:06:08 INFO - "platform": "ubuntu64_hw", 07:06:08 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:06:08 INFO - "branch": "mozilla-central", 07:06:08 INFO - "repo_path": "mozilla-central", 07:06:08 INFO - "revision": "c3f5e6079284a7b7053c41f05d0fe06ff031db03", 07:06:08 INFO - "stage_platform": "linux64-pgo", 07:06:08 INFO - "builduid": "46ef79d4eee54e17b5df5a611d0775f4", 07:06:08 INFO - "slavebuilddir": "test" 07:06:08 INFO - } 07:06:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/EU5-rn-HS4C6aYdUbShcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 07:06:08 INFO - Running post-action listener: _resource_record_post_action 07:06:08 INFO - ##### 07:06:08 INFO - ##### Finished read-buildbot-config step (success) 07:06:08 INFO - ##### 07:06:08 INFO - ##### 07:06:08 INFO - ##### Running download-and-extract step. 07:06:08 INFO - ##### 07:06:08 INFO - Running pre-action listener: _resource_record_pre_action 07:06:08 INFO - Running main action method: download_and_extract 07:06:08 INFO - mkdir: /builds/slave/test/build/tests 07:06:08 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')]} 07:06:08 INFO - https://queue.taskcluster.net/v1/task/EU5-rn-HS4C6aYdUbShcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:06:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EU5-rn-HS4C6aYdUbShcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:06:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EU5-rn-HS4C6aYdUbShcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:06:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EU5-rn-HS4C6aYdUbShcEg/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 07:06:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EU5-rn-HS4C6aYdUbShcEg/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 07:06:17 INFO - Downloaded 1361 bytes. 07:06:17 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:06:17 INFO - Using the following test package requirements: 07:06:17 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:06:17 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:06:17 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:06:17 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:17 INFO - u'jsshell-linux-x86_64.zip'], 07:06:17 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:06:17 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:06:17 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:06:17 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:06:17 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:06:17 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:06:17 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:06:17 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')]} 07:06:17 INFO - https://queue.taskcluster.net/v1/task/EU5-rn-HS4C6aYdUbShcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:06:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EU5-rn-HS4C6aYdUbShcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:06:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EU5-rn-HS4C6aYdUbShcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:06:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EU5-rn-HS4C6aYdUbShcEg/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 07:06:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EU5-rn-HS4C6aYdUbShcEg/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 07:06:24 INFO - Downloaded 23904308 bytes. 07:06: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'] 07:06: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 07:06:25 INFO - Return code: 0 07:06: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 07:06: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')]} 07:06:25 INFO - https://queue.taskcluster.net/v1/task/EU5-rn-HS4C6aYdUbShcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:06:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EU5-rn-HS4C6aYdUbShcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:06:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EU5-rn-HS4C6aYdUbShcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:06:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EU5-rn-HS4C6aYdUbShcEg/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 07:06:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EU5-rn-HS4C6aYdUbShcEg/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 07:06:28 INFO - Downloaded 23904308 bytes. 07:06:28 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'] 07:06:28 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 07:06:29 INFO - Return code: 0 07:06:29 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')]} 07:06:29 INFO - https://queue.taskcluster.net/v1/task/EU5-rn-HS4C6aYdUbShcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:06:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EU5-rn-HS4C6aYdUbShcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:06:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EU5-rn-HS4C6aYdUbShcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:06:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EU5-rn-HS4C6aYdUbShcEg/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 07:06:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EU5-rn-HS4C6aYdUbShcEg/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 07:06:30 INFO - Downloaded 10840239 bytes. 07:06:30 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'] 07:06:30 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 07:06:30 INFO - Return code: 0 07:06:30 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')]} 07:06:30 INFO - https://queue.taskcluster.net/v1/task/EU5-rn-HS4C6aYdUbShcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:06:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EU5-rn-HS4C6aYdUbShcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:06:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EU5-rn-HS4C6aYdUbShcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:06:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EU5-rn-HS4C6aYdUbShcEg/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 07:06:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EU5-rn-HS4C6aYdUbShcEg/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 07:06:33 INFO - Downloaded 58362264 bytes. 07:06:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EU5-rn-HS4C6aYdUbShcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:06:33 INFO - mkdir: /builds/slave/test/properties 07:06:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:06:33 INFO - Writing to file /builds/slave/test/properties/build_url 07:06:33 INFO - Contents: 07:06:33 INFO - build_url:https://queue.taskcluster.net/v1/task/EU5-rn-HS4C6aYdUbShcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:06:34 INFO - Running post-action listener: _resource_record_post_action 07:06:34 INFO - Running post-action listener: set_extra_try_arguments 07:06:34 INFO - ##### 07:06:34 INFO - ##### Finished download-and-extract step (success) 07:06:34 INFO - ##### 07:06:34 INFO - ##### 07:06:34 INFO - ##### Running populate-webroot step. 07:06:34 INFO - ##### 07:06:34 INFO - Running pre-action listener: _resource_record_pre_action 07:06:34 INFO - Running main action method: populate_webroot 07:06:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:06:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:06:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:06:34 INFO - '--tppagecycles', 07:06:34 INFO - '7'], 07:06:34 INFO - 'tests': ['tsvgm']}}, 07:06:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:06:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:06:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:06:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:06:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:06:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:06:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:34 INFO - 'talos_options': ['--disable-e10s'], 07:06:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:06:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:06:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:34 INFO - 'talos_options': ['--disable-e10s'], 07:06:34 INFO - 'tests': ['damp', 'tps']}, 07:06:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:34 INFO - 'tests': ['damp', 'tps']}, 07:06:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:06:34 INFO - 'tests': ['dromaeo_dom']}, 07:06:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:06:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:06:34 INFO - 'tests': ['a11yr', 07:06:34 INFO - 'ts_paint', 07:06:34 INFO - 'tpaint', 07:06:34 INFO - 'sessionrestore', 07:06:34 INFO - 'sessionrestore_no_auto_restore', 07:06:34 INFO - 'tabpaint']}, 07:06:34 INFO - 'other-e10s': {'tests': ['a11yr', 07:06:34 INFO - 'ts_paint', 07:06:34 INFO - 'tpaint', 07:06:34 INFO - 'sessionrestore', 07:06:34 INFO - 'sessionrestore_no_auto_restore', 07:06:34 INFO - 'tabpaint']}, 07:06:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:06:34 INFO - 'ts_paint', 07:06:34 INFO - 'tpaint', 07:06:34 INFO - 'sessionrestore', 07:06:34 INFO - 'sessionrestore_no_auto_restore', 07:06:34 INFO - 'tabpaint']}, 07:06:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:06:34 INFO - 'ts_paint', 07:06:34 INFO - 'tpaint', 07:06:34 INFO - 'sessionrestore', 07:06:34 INFO - 'sessionrestore_no_auto_restore', 07:06:34 INFO - 'tabpaint']}, 07:06:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:06:34 INFO - 'tests': ['a11yr', 07:06:34 INFO - 'ts_paint', 07:06:34 INFO - 'tpaint', 07:06:34 INFO - 'sessionrestore', 07:06:34 INFO - 'sessionrestore_no_auto_restore', 07:06:34 INFO - 'tabpaint']}, 07:06:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:06:34 INFO - 'tests': ['a11yr', 07:06:34 INFO - 'ts_paint', 07:06:34 INFO - 'tpaint', 07:06:34 INFO - 'sessionrestore', 07:06:34 INFO - 'sessionrestore_no_auto_restore', 07:06:34 INFO - 'tabpaint']}, 07:06:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:06:34 INFO - 'tests': ['tsvgx', 07:06:34 INFO - 'tsvgr_opacity', 07:06:34 INFO - 'tart', 07:06:34 INFO - 'tscrollx', 07:06:34 INFO - 'cart']}, 07:06:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:06:34 INFO - 'tsvgr_opacity', 07:06:34 INFO - 'tart', 07:06:34 INFO - 'tscrollx', 07:06:34 INFO - 'cart']}, 07:06:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:34 INFO - 'talos_options': ['--disable-e10s'], 07:06:34 INFO - 'tests': ['tp5o']}, 07:06:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:34 INFO - 'tests': ['tp5o']}, 07:06:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:34 INFO - 'talos_options': ['--disable-e10s', 07:06:34 INFO - '--xperf_path', 07:06:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:06:34 INFO - 'tests': ['tp5n']}, 07:06:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:34 INFO - 'talos_options': ['--xperf_path', 07:06:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:06:34 INFO - 'tests': ['tp5n']}}, 07:06:34 INFO - 'talos.zip': {'path': '', 07:06:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:06:34 INFO - Running post-action listener: _resource_record_post_action 07:06:34 INFO - ##### 07:06:34 INFO - ##### Finished populate-webroot step (success) 07:06:34 INFO - ##### 07:06:34 INFO - ##### 07:06:34 INFO - ##### Running create-virtualenv step. 07:06:34 INFO - ##### 07:06:34 INFO - Running pre-action listener: _resource_record_pre_action 07:06:34 INFO - Running main action method: create_virtualenv 07:06:34 INFO - Creating virtualenv /builds/slave/test/build/venv 07:06:34 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 07:06:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:06:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:06:34 INFO - Using real prefix '/usr' 07:06:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:06:35 INFO - Installing distribute.............................................................................................................................................................................................done. 07:06:37 INFO - Installing pip.................done. 07:06:37 INFO - Return code: 0 07:06:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:37 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 0x7fd091bb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f369c0>, '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 0x1f378c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f37d50>, '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': '0e2a256762fed810e2f0f810000001b3-1463059451.618068-841884228', '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 07:06:37 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 07:06:37 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 07:06:37 INFO - Using env: {'DISPLAY': ':0', 07:06:37 INFO - 'HOME': '/home/cltbld', 07:06:37 INFO - 'LANG': 'en_US.UTF-8', 07:06:37 INFO - 'LANGUAGE': 'en_US:en', 07:06:37 INFO - 'LOGNAME': 'cltbld', 07:06:37 INFO - 'MAIL': '/var/mail/cltbld', 07:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:37 INFO - 'MOZ_NO_REMOTE': '1', 07:06:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:37 INFO - 'NO_EM_RESTART': '1', 07:06:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:37 INFO - 'PWD': '/builds/slave/test', 07:06:37 INFO - 'SHELL': '/bin/bash', 07:06:37 INFO - 'SHLVL': '1', 07:06:37 INFO - 'TERM': 'linux', 07:06:37 INFO - 'TMOUT': '86400', 07:06:37 INFO - 'USER': 'cltbld', 07:06:37 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1463059451.618068-841884228', 07:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:37 INFO - '_': '/tools/buildbot/bin/python'} 07:06:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:37 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 07:06:37 INFO - Cleaning up... 07:06:37 INFO - Return code: 0 07:06:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd091bb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f369c0>, '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 0x1f378c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f37d50>, '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': '0e2a256762fed810e2f0f810000001b3-1463059451.618068-841884228', '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 07:06:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 07:06:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:06:37 INFO - Using env: {'DISPLAY': ':0', 07:06:37 INFO - 'HOME': '/home/cltbld', 07:06:37 INFO - 'LANG': 'en_US.UTF-8', 07:06:37 INFO - 'LANGUAGE': 'en_US:en', 07:06:37 INFO - 'LOGNAME': 'cltbld', 07:06:37 INFO - 'MAIL': '/var/mail/cltbld', 07:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:37 INFO - 'MOZ_NO_REMOTE': '1', 07:06:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:37 INFO - 'NO_EM_RESTART': '1', 07:06:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:37 INFO - 'PWD': '/builds/slave/test', 07:06:37 INFO - 'SHELL': '/bin/bash', 07:06:37 INFO - 'SHLVL': '1', 07:06:37 INFO - 'TERM': 'linux', 07:06:37 INFO - 'TMOUT': '86400', 07:06:37 INFO - 'USER': 'cltbld', 07:06:37 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1463059451.618068-841884228', 07:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:37 INFO - '_': '/tools/buildbot/bin/python'} 07:06:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:37 INFO - Downloading/unpacking psutil>=0.7.1 07:06:37 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 07:06:37 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 07:06:37 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 07:06:37 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 07:06:37 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 07:06:37 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 07:06:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:06:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:06:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:06:39 INFO - Installing collected packages: psutil 07:06:39 INFO - Running setup.py install for psutil 07:06:39 INFO - building 'psutil._psutil_linux' extension 07:06:39 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 07:06:39 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 07:06:39 INFO - building 'psutil._psutil_posix' extension 07:06:39 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 07:06:40 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 07:06:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:06:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:06:40 INFO - Successfully installed psutil 07:06:40 INFO - Cleaning up... 07:06:40 INFO - Return code: 0 07:06:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:06: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')]} 07:06:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06: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')]} 07:06:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd091bb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f369c0>, '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 0x1f378c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f37d50>, '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': '0e2a256762fed810e2f0f810000001b3-1463059451.618068-841884228', '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 07:06:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:06:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:06:40 INFO - Using env: {'DISPLAY': ':0', 07:06:40 INFO - 'HOME': '/home/cltbld', 07:06:40 INFO - 'LANG': 'en_US.UTF-8', 07:06:40 INFO - 'LANGUAGE': 'en_US:en', 07:06:40 INFO - 'LOGNAME': 'cltbld', 07:06:40 INFO - 'MAIL': '/var/mail/cltbld', 07:06:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:40 INFO - 'MOZ_NO_REMOTE': '1', 07:06:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:40 INFO - 'NO_EM_RESTART': '1', 07:06:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:40 INFO - 'PWD': '/builds/slave/test', 07:06:40 INFO - 'SHELL': '/bin/bash', 07:06:40 INFO - 'SHLVL': '1', 07:06:40 INFO - 'TERM': 'linux', 07:06:40 INFO - 'TMOUT': '86400', 07:06:40 INFO - 'USER': 'cltbld', 07:06:40 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1463059451.618068-841884228', 07:06:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:40 INFO - '_': '/tools/buildbot/bin/python'} 07:06:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:06:40 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 07:06:40 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 07:06:40 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 07:06:40 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 07:06:40 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 07:06:40 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 07:06:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:06:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:06:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:06:42 INFO - Installing collected packages: mozsystemmonitor 07:06:42 INFO - Running setup.py install for mozsystemmonitor 07:06:42 INFO - Successfully installed mozsystemmonitor 07:06:42 INFO - Cleaning up... 07:06:42 INFO - Return code: 0 07:06:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:42 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 0x7fd091bb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f369c0>, '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 0x1f378c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f37d50>, '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': '0e2a256762fed810e2f0f810000001b3-1463059451.618068-841884228', '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 07:06:42 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 07:06:42 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 07:06:42 INFO - Using env: {'DISPLAY': ':0', 07:06:42 INFO - 'HOME': '/home/cltbld', 07:06:42 INFO - 'LANG': 'en_US.UTF-8', 07:06:42 INFO - 'LANGUAGE': 'en_US:en', 07:06:42 INFO - 'LOGNAME': 'cltbld', 07:06:42 INFO - 'MAIL': '/var/mail/cltbld', 07:06:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:42 INFO - 'MOZ_NO_REMOTE': '1', 07:06:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:42 INFO - 'NO_EM_RESTART': '1', 07:06:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:42 INFO - 'PWD': '/builds/slave/test', 07:06:42 INFO - 'SHELL': '/bin/bash', 07:06:42 INFO - 'SHLVL': '1', 07:06:42 INFO - 'TERM': 'linux', 07:06:42 INFO - 'TMOUT': '86400', 07:06:42 INFO - 'USER': 'cltbld', 07:06:42 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1463059451.618068-841884228', 07:06:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:42 INFO - '_': '/tools/buildbot/bin/python'} 07:06:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:42 INFO - Downloading/unpacking blobuploader==1.2.4 07:06:42 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 07:06:42 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 07:06:42 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 07:06:42 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 07:06:42 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 07:06:42 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 07:06:44 INFO - Downloading blobuploader-1.2.4.tar.gz 07:06:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:06:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:06:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:06:45 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 07:06:45 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 07:06:45 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 07:06:45 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 07:06:45 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 07:06:45 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 07:06:45 INFO - Downloading docopt-0.6.1.tar.gz 07:06:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:06:45 INFO - Installing collected packages: blobuploader, requests, docopt 07:06:45 INFO - Running setup.py install for blobuploader 07:06:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:06:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:06:45 INFO - Running setup.py install for requests 07:06:45 INFO - Running setup.py install for docopt 07:06:46 INFO - Successfully installed blobuploader requests docopt 07:06:46 INFO - Cleaning up... 07:06:46 INFO - Return code: 0 07:06:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:06:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:46 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 0x7fd091bb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f369c0>, '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 0x1f378c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f37d50>, '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': '0e2a256762fed810e2f0f810000001b3-1463059451.618068-841884228', '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 07:06:46 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 07:06:46 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 07:06:46 INFO - Using env: {'DISPLAY': ':0', 07:06:46 INFO - 'HOME': '/home/cltbld', 07:06:46 INFO - 'LANG': 'en_US.UTF-8', 07:06:46 INFO - 'LANGUAGE': 'en_US:en', 07:06:46 INFO - 'LOGNAME': 'cltbld', 07:06:46 INFO - 'MAIL': '/var/mail/cltbld', 07:06:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:46 INFO - 'MOZ_NO_REMOTE': '1', 07:06:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:46 INFO - 'NO_EM_RESTART': '1', 07:06:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:46 INFO - 'PWD': '/builds/slave/test', 07:06:46 INFO - 'SHELL': '/bin/bash', 07:06:46 INFO - 'SHLVL': '1', 07:06:46 INFO - 'TERM': 'linux', 07:06:46 INFO - 'TMOUT': '86400', 07:06:46 INFO - 'USER': 'cltbld', 07:06:46 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1463059451.618068-841884228', 07:06:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:46 INFO - '_': '/tools/buildbot/bin/python'} 07:06:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:06:46 INFO - Running setup.py (path:/tmp/pip-ZAzYRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:06:46 INFO - Running setup.py (path:/tmp/pip-UTTCcl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:06:46 INFO - Running setup.py (path:/tmp/pip-ELE9Sy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:06:46 INFO - Running setup.py (path:/tmp/pip-p0pNDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:06:46 INFO - Running setup.py (path:/tmp/pip-amdq1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:06:46 INFO - Running setup.py (path:/tmp/pip-IUuUqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:06:46 INFO - Running setup.py (path:/tmp/pip-KG5Eot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:06:46 INFO - Running setup.py (path:/tmp/pip-ns_d2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:06:46 INFO - Running setup.py (path:/tmp/pip-uR1JOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:06:47 INFO - Running setup.py (path:/tmp/pip-1LVSqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:06:47 INFO - Running setup.py (path:/tmp/pip-J5busr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:06:47 INFO - Running setup.py (path:/tmp/pip-hoxiez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:06:47 INFO - Running setup.py (path:/tmp/pip-NxJw84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:06:47 INFO - Running setup.py (path:/tmp/pip-ZHMQ9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:47 INFO - Running setup.py (path:/tmp/pip-fzn3fY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:06:47 INFO - Running setup.py (path:/tmp/pip-IPxAhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:06:47 INFO - Running setup.py (path:/tmp/pip-AYLi0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:06:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:06:47 INFO - Running setup.py install for manifestparser 07:06:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:06:47 INFO - Running setup.py install for mozcrash 07:06:47 INFO - Running setup.py install for mozdebug 07:06:47 INFO - Running setup.py install for mozdevice 07:06:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:06:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:06:48 INFO - Running setup.py install for mozfile 07:06:48 INFO - Running setup.py install for mozhttpd 07:06:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:06:48 INFO - Running setup.py install for mozinfo 07:06:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:06:48 INFO - Running setup.py install for mozInstall 07:06:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:06:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:06:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:06:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:06:48 INFO - Running setup.py install for mozleak 07:06:48 INFO - Running setup.py install for mozlog 07:06:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:06:48 INFO - Running setup.py install for moznetwork 07:06:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:06:48 INFO - Running setup.py install for mozprocess 07:06:48 INFO - Running setup.py install for mozprofile 07:06:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:06:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:06:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:06:48 INFO - Running setup.py install for mozrunner 07:06:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:06:49 INFO - Running setup.py install for mozscreenshot 07:06:49 INFO - Running setup.py install for moztest 07:06:49 INFO - Running setup.py install for mozversion 07:06:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:06:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:06:49 INFO - Cleaning up... 07:06:49 INFO - Return code: 0 07:06:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:06:49 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')]} 07:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:49 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')]} 07:06:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:49 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 0x7fd091bb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f369c0>, '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 0x1f378c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f37d50>, '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': '0e2a256762fed810e2f0f810000001b3-1463059451.618068-841884228', '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 07:06:49 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 07:06:49 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 07:06:49 INFO - Using env: {'DISPLAY': ':0', 07:06:49 INFO - 'HOME': '/home/cltbld', 07:06:49 INFO - 'LANG': 'en_US.UTF-8', 07:06:49 INFO - 'LANGUAGE': 'en_US:en', 07:06:49 INFO - 'LOGNAME': 'cltbld', 07:06:49 INFO - 'MAIL': '/var/mail/cltbld', 07:06:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:49 INFO - 'MOZ_NO_REMOTE': '1', 07:06:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:49 INFO - 'NO_EM_RESTART': '1', 07:06:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:49 INFO - 'PWD': '/builds/slave/test', 07:06:49 INFO - 'SHELL': '/bin/bash', 07:06:49 INFO - 'SHLVL': '1', 07:06:49 INFO - 'TERM': 'linux', 07:06:49 INFO - 'TMOUT': '86400', 07:06:49 INFO - 'USER': 'cltbld', 07:06:49 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1463059451.618068-841884228', 07:06:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:49 INFO - '_': '/tools/buildbot/bin/python'} 07:06:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:06:49 INFO - Running setup.py (path:/tmp/pip-vo0ZZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:06:49 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)) 07:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:06:49 INFO - Running setup.py (path:/tmp/pip-eiBpSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:06:49 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)) 07:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:06:49 INFO - Running setup.py (path:/tmp/pip-qPw5AO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:06:49 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)) 07:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:06:49 INFO - Running setup.py (path:/tmp/pip-J6HDg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:06:49 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)) 07:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:06:49 INFO - Running setup.py (path:/tmp/pip-YXfcuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:06:49 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)) 07:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:06:49 INFO - Running setup.py (path:/tmp/pip-YpsqWO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:06:50 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)) 07:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:06:50 INFO - Running setup.py (path:/tmp/pip-Tt5G1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:06:50 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)) 07:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:06:50 INFO - Running setup.py (path:/tmp/pip-wr_s81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:06:50 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)) 07:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:06:50 INFO - Running setup.py (path:/tmp/pip-cJ4EqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:06:50 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)) 07:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:06:50 INFO - Running setup.py (path:/tmp/pip-Uji4GT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:06:50 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)) 07:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:06:50 INFO - Running setup.py (path:/tmp/pip-Ynh5Hj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:06:50 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)) 07:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:06:50 INFO - Running setup.py (path:/tmp/pip-QMv3sa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:06:50 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)) 07:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:06:50 INFO - Running setup.py (path:/tmp/pip-2TgLAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:06:50 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)) 07:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:06:50 INFO - Running setup.py (path:/tmp/pip-DWGuoZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:06:50 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)) 07:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:50 INFO - Running setup.py (path:/tmp/pip-WLNSwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:50 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)) 07:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:06:50 INFO - Running setup.py (path:/tmp/pip-vXiT6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:06:50 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)) 07:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:06:50 INFO - Running setup.py (path:/tmp/pip-LGG0Yr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:06:50 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)) 07:06:50 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)) 07:06:50 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)) 07:06:50 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)) 07:06:50 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)) 07:06:50 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)) 07:06:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:06: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 07:06: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 07:06: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 07:06: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 07:06: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 07:06: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 07:06:52 INFO - Downloading blessings-1.6.tar.gz 07:06:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:06:52 INFO - Installing collected packages: blessings 07:06:52 INFO - Running setup.py install for blessings 07:06:52 INFO - Successfully installed blessings 07:06:52 INFO - Cleaning up... 07:06:52 INFO - Return code: 0 07:06:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:06:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:06:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:06:53 INFO - Reading from file tmpfile_stdout 07:06:53 INFO - Current package versions: 07:06:53 INFO - argparse == 1.2.1 07:06:53 INFO - blessings == 1.6 07:06:53 INFO - blobuploader == 1.2.4 07:06:53 INFO - docopt == 0.6.1 07:06:53 INFO - manifestparser == 1.1 07:06:53 INFO - mozInstall == 1.12 07:06:53 INFO - mozcrash == 0.17 07:06:53 INFO - mozdebug == 0.1 07:06:53 INFO - mozdevice == 0.48 07:06:53 INFO - mozfile == 1.2 07:06:53 INFO - mozhttpd == 0.7 07:06:53 INFO - mozinfo == 0.9 07:06:53 INFO - mozleak == 0.1 07:06:53 INFO - mozlog == 3.2 07:06:53 INFO - moznetwork == 0.27 07:06:53 INFO - mozprocess == 0.22 07:06:53 INFO - mozprofile == 0.28 07:06:53 INFO - mozrunner == 6.11 07:06:53 INFO - mozscreenshot == 0.1 07:06:53 INFO - mozsystemmonitor == 0.0 07:06:53 INFO - moztest == 0.7 07:06:53 INFO - mozversion == 1.4 07:06:53 INFO - psutil == 3.1.1 07:06:53 INFO - requests == 1.2.3 07:06:53 INFO - wsgiref == 0.1.2 07:06:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:06:53 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')]} 07:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:53 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')]} 07:06:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:53 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 0x7fd091bb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f369c0>, '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 0x1f378c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f37d50>, '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': '0e2a256762fed810e2f0f810000001b3-1463059451.618068-841884228', '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 07:06:53 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 07:06:53 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 07:06:53 INFO - Using env: {'DISPLAY': ':0', 07:06:53 INFO - 'HOME': '/home/cltbld', 07:06:53 INFO - 'LANG': 'en_US.UTF-8', 07:06:53 INFO - 'LANGUAGE': 'en_US:en', 07:06:53 INFO - 'LOGNAME': 'cltbld', 07:06:53 INFO - 'MAIL': '/var/mail/cltbld', 07:06:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:53 INFO - 'MOZ_NO_REMOTE': '1', 07:06:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:53 INFO - 'NO_EM_RESTART': '1', 07:06:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:53 INFO - 'PWD': '/builds/slave/test', 07:06:53 INFO - 'SHELL': '/bin/bash', 07:06:53 INFO - 'SHLVL': '1', 07:06:53 INFO - 'TERM': 'linux', 07:06:53 INFO - 'TMOUT': '86400', 07:06:53 INFO - 'USER': 'cltbld', 07:06:53 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1463059451.618068-841884228', 07:06:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:53 INFO - '_': '/tools/buildbot/bin/python'} 07:06:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:53 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)) 07:06:53 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)) 07:06:53 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)) 07:06:53 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)) 07:06:53 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)) 07:06:53 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)) 07:06:53 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)) 07:06:53 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)) 07:06:53 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)) 07:06:53 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)) 07:06:53 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)) 07:06:53 INFO - Cleaning up... 07:06:53 INFO - Return code: 0 07:06:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:06:53 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')]} 07:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:53 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')]} 07:06:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:53 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 0x7fd091bb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f369c0>, '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 0x1f378c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f37d50>, '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': '0e2a256762fed810e2f0f810000001b3-1463059451.618068-841884228', '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 07:06:53 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 07:06:53 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 07:06:53 INFO - Using env: {'DISPLAY': ':0', 07:06:53 INFO - 'HOME': '/home/cltbld', 07:06:53 INFO - 'LANG': 'en_US.UTF-8', 07:06:53 INFO - 'LANGUAGE': 'en_US:en', 07:06:53 INFO - 'LOGNAME': 'cltbld', 07:06:53 INFO - 'MAIL': '/var/mail/cltbld', 07:06:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:53 INFO - 'MOZ_NO_REMOTE': '1', 07:06:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:53 INFO - 'NO_EM_RESTART': '1', 07:06:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:53 INFO - 'PWD': '/builds/slave/test', 07:06:53 INFO - 'SHELL': '/bin/bash', 07:06:53 INFO - 'SHLVL': '1', 07:06:53 INFO - 'TERM': 'linux', 07:06:53 INFO - 'TMOUT': '86400', 07:06:53 INFO - 'USER': 'cltbld', 07:06:53 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1463059451.618068-841884228', 07:06:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:53 INFO - '_': '/tools/buildbot/bin/python'} 07:06:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:53 INFO - Downloading/unpacking jsonschema 07:06:53 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 07:06:53 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 07:06:53 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 07:06:53 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 07:06:53 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 07:06:53 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 07:06:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:06:55 INFO - Downloading/unpacking functools32 (from jsonschema) 07:06: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 07:06: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 07:06: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 07:06: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 07:06: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 07:06: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 07:06:55 INFO - Downloading functools32-3.2.3-2.tar.gz 07:06:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:06:55 INFO - warning: no files found matching '*.txt' 07:06:55 INFO - no previously-included directories found matching 'build' 07:06:55 INFO - no previously-included directories found matching 'dist' 07:06:55 INFO - no previously-included directories found matching '.git*' 07:06:55 INFO - Installing collected packages: jsonschema, functools32 07:06:55 INFO - Running setup.py install for functools32 07:06:55 INFO - warning: no files found matching '*.txt' 07:06:55 INFO - no previously-included directories found matching 'build' 07:06:55 INFO - no previously-included directories found matching 'dist' 07:06:55 INFO - no previously-included directories found matching '.git*' 07:06:55 INFO - Successfully installed jsonschema functools32 07:06:55 INFO - Cleaning up... 07:06:55 INFO - Return code: 0 07:06:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:06: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')]} 07:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06: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')]} 07:06:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:55 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 0x7fd091bb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f369c0>, '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 0x1f378c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f37d50>, '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': '0e2a256762fed810e2f0f810000001b3-1463059451.618068-841884228', '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 07:06:55 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 07:06:56 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 07:06:56 INFO - Using env: {'DISPLAY': ':0', 07:06:56 INFO - 'HOME': '/home/cltbld', 07:06:56 INFO - 'LANG': 'en_US.UTF-8', 07:06:56 INFO - 'LANGUAGE': 'en_US:en', 07:06:56 INFO - 'LOGNAME': 'cltbld', 07:06:56 INFO - 'MAIL': '/var/mail/cltbld', 07:06:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:56 INFO - 'MOZ_NO_REMOTE': '1', 07:06:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:56 INFO - 'NO_EM_RESTART': '1', 07:06:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:56 INFO - 'PWD': '/builds/slave/test', 07:06:56 INFO - 'SHELL': '/bin/bash', 07:06:56 INFO - 'SHLVL': '1', 07:06:56 INFO - 'TERM': 'linux', 07:06:56 INFO - 'TMOUT': '86400', 07:06:56 INFO - 'USER': 'cltbld', 07:06:56 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1463059451.618068-841884228', 07:06:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:56 INFO - '_': '/tools/buildbot/bin/python'} 07:06:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:56 INFO - Downloading/unpacking flake8 07:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:06:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:06:58 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 07:06:58 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 07:06:58 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 07:06:58 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 07:06:58 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 07:06:58 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 07:06:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:06:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:06:58 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 07:06:58 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 07:06:58 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 07:06:58 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 07:06:58 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 07:06:58 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 07:06:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:06:58 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 07:06:58 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 07:06:58 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 07:06:58 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 07:06:58 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 07:06:58 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 07:06:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:06:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:06:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:06:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:06:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:06:58 INFO - no previously-included directories found matching 'docs/_build' 07:06:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:06:58 INFO - Running setup.py install for pep8 07:06:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:06:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:06:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:06:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:06:58 INFO - no previously-included directories found matching 'docs/_build' 07:06:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:06:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:06:58 INFO - Cleaning up... 07:06:59 INFO - Return code: 0 07:06:59 INFO - Running post-action listener: _resource_record_post_action 07:06:59 INFO - Running post-action listener: _start_resource_monitoring 07:06:59 INFO - Starting resource monitoring. 07:06:59 INFO - ##### 07:06:59 INFO - ##### Finished create-virtualenv step (success) 07:06:59 INFO - ##### 07:06:59 INFO - ##### 07:06:59 INFO - ##### Running install step. 07:06:59 INFO - ##### 07:06:59 INFO - Running pre-action listener: _resource_record_pre_action 07:06:59 INFO - Running main action method: install 07:06:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:06:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:06:59 INFO - Reading from file tmpfile_stdout 07:06:59 INFO - Detecting whether we're running mozinstall >=1.0... 07:06:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:06:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:06:59 INFO - Reading from file tmpfile_stdout 07:06:59 INFO - Output received: 07:06:59 INFO - Usage: mozinstall [options] installer 07:06:59 INFO - Options: 07:06:59 INFO - -h, --help show this help message and exit 07:06:59 INFO - -d DEST, --destination=DEST 07:06:59 INFO - Directory to install application into. [default: 07:06:59 INFO - "/builds/slave/test"] 07:06:59 INFO - --app=APP Application being installed. [default: firefox] 07:06:59 INFO - mkdir: /builds/slave/test/build/application 07:06:59 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'] 07:06:59 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 07:07:15 INFO - Reading from file tmpfile_stdout 07:07:15 INFO - Output received: 07:07:15 INFO - /builds/slave/test/build/application/firefox/firefox 07:07:15 INFO - Running post-action listener: _resource_record_post_action 07:07:15 INFO - ##### 07:07:15 INFO - ##### Finished install step (success) 07:07:15 INFO - ##### 07:07:15 INFO - ##### 07:07:15 INFO - ##### Running run-tests step. 07:07:15 INFO - ##### 07:07:15 INFO - Running pre-action listener: _resource_record_pre_action 07:07:15 INFO - Running main action method: run_tests 07:07:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:07:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:07:15 INFO - Python 2.7.3 07:07:15 INFO - Return code: 0 07:07:15 INFO - grabbing minidump binary from tooltool 07:07:15 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')]} 07:07:15 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 0x1f369c0>, '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 0x1f378c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f37d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:07:15 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 07:07:15 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 07:07:15 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 07:07:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:07:16 INFO - Return code: 0 07:07:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:07:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:07:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:07:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:07:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:07:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:07:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:07:16 INFO - Return code: 0 07:07:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EU5-rn-HS4C6aYdUbShcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:07:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EU5-rn-HS4C6aYdUbShcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:07:16 INFO - Using env: {'DISPLAY': ':0', 07:07:16 INFO - 'HOME': '/home/cltbld', 07:07:16 INFO - 'LANG': 'en_US.UTF-8', 07:07:16 INFO - 'LANGUAGE': 'en_US:en', 07:07:16 INFO - 'LOGNAME': 'cltbld', 07:07:16 INFO - 'MAIL': '/var/mail/cltbld', 07:07:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:07:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:07:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:16 INFO - 'MOZ_NO_REMOTE': '1', 07:07:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:07:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:16 INFO - 'NO_EM_RESTART': '1', 07:07:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:16 INFO - 'PWD': '/builds/slave/test', 07:07:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:07:16 INFO - 'SHELL': '/bin/bash', 07:07:16 INFO - 'SHLVL': '1', 07:07:16 INFO - 'TERM': 'linux', 07:07:16 INFO - 'TMOUT': '86400', 07:07:16 INFO - 'USER': 'cltbld', 07:07:16 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1463059451.618068-841884228', 07:07:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:16 INFO - '_': '/tools/buildbot/bin/python'} 07:07:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EU5-rn-HS4C6aYdUbShcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:07:17 INFO - mozversion application_buildid: 20160512043053 07:07:17 INFO - mozversion application_changeset: c3f5e6079284a7b7053c41f05d0fe06ff031db03 07:07:17 INFO - mozversion application_display_name: Nightly 07:07:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:07:17 INFO - mozversion application_name: Firefox 07:07:17 INFO - mozversion application_remotingname: firefox 07:07:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:07:17 INFO - mozversion application_vendor: Mozilla 07:07:17 INFO - mozversion application_version: 49.0a1 07:07:17 INFO - mozversion platform_buildid: 20160512043053 07:07:17 INFO - mozversion platform_changeset: c3f5e6079284a7b7053c41f05d0fe06ff031db03 07:07:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:07:17 INFO - mozversion platform_version: 49.0a1 07:07:17 INFO - using testdate: 1463062037 07:07:17 INFO - actual date: 1463062037 07:07:17 INFO - starting webserver on 'localhost:53331' 07:07:17 INFO - SUITE-START | Running 2 tests 07:07:17 INFO - TEST-START | dromaeo_css 07:07:17 INFO - operating with platform_type : linux_ 07:07:17 INFO - Initialising browser for dromaeo_css test... 07:07:17 INFO - TEST-INFO | started process 5264 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8NUpYB/profile http://localhost:53331/getInfo.html) 07:07:20 INFO - PROCESS | 5264 | 07:07:20 INFO - PROCESS | 5264 | (process:5332): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:07:21 INFO - PROCESS | 5264 | __metrics Screen width/height:1600/1200 07:07:21 INFO - PROCESS | 5264 | colorDepth:24 07:07:21 INFO - PROCESS | 5264 | Browser inner width/height: 1024/697 07:07:21 INFO - PROCESS | 5264 | __metrics 07:07:22 ERROR - PROCESS | 5264 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 07:07:23 INFO - TEST-INFO | 5264: exit 0 07:07:23 INFO - Browser initialized. 07:07:23 INFO - Running cycle 1/1 for dromaeo_css test... 07:07:23 INFO - TEST-INFO | started process 5383 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8NUpYB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:07:25 INFO - PROCESS | 5383 | 07:07:25 INFO - PROCESS | 5383 | (process:5445): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:07:35 INFO - PROCESS | 5383 | RSS: Main: 163250176 07:07:35 INFO - PROCESS | 5383 | 07:08:24 INFO - PROCESS | 5383 | 1463062104914 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] 07:10:32 INFO - PROCESS | 5383 | Cycle 1(1): loaded http://localhost:53331/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53331/tests/dromaeo/cssquery-ext.html) 07:10:33 INFO - PROCESS | 5383 | RSS: Main: 165179392 07:10:33 INFO - PROCESS | 5383 | 07:13:35 INFO - PROCESS | 5383 | Cycle 1(1): loaded http://localhost:53331/tests/dromaeo/cssquery-ext.html (next: http://localhost:53331/tests/dromaeo/cssquery-jquery.html) 07:13:36 INFO - PROCESS | 5383 | RSS: Main: 166281216 07:13:36 INFO - PROCESS | 5383 | 07:16:38 INFO - PROCESS | 5383 | Cycle 1(1): loaded http://localhost:53331/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53331/tests/dromaeo/cssquery-mootools.html) 07:16:38 INFO - PROCESS | 5383 | RSS: Main: 167448576 07:16:38 INFO - PROCESS | 5383 | 07:19:40 INFO - PROCESS | 5383 | Cycle 1(1): loaded http://localhost:53331/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53331/tests/dromaeo/cssquery-prototype.html) 07:19:41 INFO - PROCESS | 5383 | RSS: Main: 165277696 07:19:41 INFO - PROCESS | 5383 | 07:22:43 INFO - PROCESS | 5383 | Cycle 1(1): loaded http://localhost:53331/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53331/tests/dromaeo/cssquery-yui.html) 07:22:44 INFO - PROCESS | 5383 | RSS: Main: 166694912 07:22:44 INFO - PROCESS | 5383 | 07:25:46 INFO - PROCESS | 5383 | Cycle 1(1): loaded http://localhost:53331/tests/dromaeo/cssquery-yui.html (next: http://localhost:53331/tests/dromaeo/cssquery-dojo.html) 07:25:46 INFO - PROCESS | 5383 | RSS: Main: 168542208 07:25:46 INFO - PROCESS | 5383 | 07:25:46 INFO - PROCESS | 5383 | __start_tp_report 07:25:46 INFO - PROCESS | 5383 | _x_x_mozilla_page_load 07:25:46 INFO - PROCESS | 5383 | _x_x_mozilla_page_load_details 07:25:46 INFO - PROCESS | 5383 | |i|pagename|runs| 07:25:46 INFO - PROCESS | 5383 | |0;dojo.html;3137.9686203137967;3205;3218.951715724263;3220.951685724713;3238.125706059364;5394.109971854644;5405.43242959489;5416.052190866598;5495.368032676243;5524.917126243099;5377.274068000819;5432.592555558329;5490.588205884555;5554.1391084381885;5562.666240025601;4953.306537084811;4960.826371077013;5077.898442031157;5101.846944591668;5156.381234251895;4928.679635823678;5164.147915593941;5176.55999240065;5196.168613021917;5198.116320225571;4954.7522623868845;4992.2511623256805;5012.498750124995;5061.417936937244;5091.541761241488;5042.672226305279;5047.217681259374;5055.014272216919;5062.038212739568;5106.8212612558755;5003.149464591028;5020.3724534433195;5035.068512325195;5035.798568057273;5052.8484145475695;5373.570114390878;5374.946250537484;5428.565714742851;5445.047116754592;5470.425605311425;5833.79581714638;5859.941400585983;5860.560457965669;5907.350191478934;5936.821895343103;5650.067738823089;5709.486146246816;5962.672053037081;5981.880362392728;6021.337652858182;5536.4186760389985;5553.888922221573;5555.2222688823595;5604.495595396434;5610.046292130389;6053.061775424816;6069.3627169147485;6096.177016102858;6108.938910610926;6131.417515336036;5551.472610102034;5752.108423194411;5841.707914604252;5852.063669812809;5864.765409383577;5870.119482077723;5964.075568286922;5965.3139888912465;5970.552208584287;6006.939930600725;5686.77252909879;5805.303363596396;5887.646741195542;5898.557608179403;5902.675352855548;5668.234788303526;5861.531077513874;5907.49786268172;5996.070609055603;5996.880062398727;4391.231534481453;4443.244648409778;4479.46246450428;4502.797374118172;4504.1216962692615;4001.799910004488;4005.1388951375593;4008.9799551002056;4037.8990525237105;4042.0703238255364;5439.619226654176;5498.752556134984;5687.544996400278;5689.317281926113;5695.373508914016;5894.204282421904;5943.55423343251;5963.105534169822;5973.522118230531;6017.729202185912;5629.887402251932;5637.295338082739;5651.039323315046;5654.1236108402445;5675.602707810496;4659.6505262105475;4873.293372461044;4887.413510378707;4898.804047838046;4906.975465122723;6126.387361263838;6130.489860652556;6145.508359331243;6150.876982460326;6155.907661385083;6004.669743164168;6009.128676341993;6009.789657361971;6034.637921724535;6049.969750151309;5795;6061.212042434456;6079.939200608114;6113.816585502442;6179.752809887734;5887.4406931341455;5889.322727886177;5893.292804863444;5896.439838215363;5901.911471327848;5948.4943779779205;5971.402859713994;5972.13404056418;5990.161377407079;5995.640261584319;5529.142982837667;5779.682117483579;5792.275965504312;5832.1543376209365;5863.970680146743;5575.498205161555;5665.830025099253;5681.4034526374135;5720.08478643415;5751;5640;5659.773609055592;5665.66006039639;5672.262605861211;5674.06377947634;5606.635568688022;5742.1673857289625;5802.4197580241635;5820.417958204146;5850.151727999331;5625.324961004706;5679.9148012779015;5681.630694004876;5756.568257380797;5780.450857168562 07:25:46 INFO - PROCESS | 5383 | |1;ext.html;597.8744463662631;635.1425575473112;636.891728406171;653.6862306093075;683.3678847066462;36791.632083679186;40578.188436231256;41307.17385652289;41447.37828932564;41512.377314340236;42736.35895461571;42993;43062.78468607661;43168.78415607925;43315.566844331544;8700.912990870089;8817.16236957488;8861.246794022483;8864.069272726367;8884.244839188677;8853.645854165825;8907.643694252221;8909.1536304051;8913.732588022338;8935.59789809457;8899.33255005874;8913.59888805002;8936.731898043068;8941.59762810675;8961.372703910729;8839.07189745074;8895.154960278764;8915.1976322131;8927.508987005713;8935.865962010575;8556.957215213884;8633.956830215871;8651.740447786577;8702.564871756387;8719.346049046348;40400.39399409011;40659.186816263806;40763.79618101891;40814.38778418326;41010.17979640391;3053;3269.1990462336644;3277.5411442398085;3355.027042157771;3992.680585553178;31793.52309715356;32267;32502;32545;33608.327833443196;4045.615666511677;4264.808083636244;4373.737575745466;4374.256376416017;4506.819727210907;319208;321563;323871;326127.9999999976;326707;33928.15179620529;59178.70410648005;60739.69630151821;60785.696071520244;60967.695161524796;35384.64615353814;35761.28477430437;35807.28385432329;35921.46117808235;36133.45799813005;16038.599035024217;16050.277737501841;16181.352745890268;16242.918785405996;16265.186740662919;13489.865101349058;13502.594922152155;13557.796633050511;13589.728205435837;13660.112092713942;8598.097199794056;8648.789169516273;8649.697260595849;8661.956690216508;8757.781055473537;3321.78408403453;3328.118048717092;3344.39800835847;3370.9325813483592;3434.5363375944426;1092.3773449133917;1110.5890820396344;1155.3241353807948;1159.9739354055769;1179.0803173524664;32138.071715697133;32219;32264.35471290608;32337.838310808766;32530.512042319384;1118.2004866520476;1131.9359801786295;1163.66253786401;1224.4184012593946;1240.5472002718943;16011.599710007344;16254;16374.263158157912;16431.26059327333;16450.424235151713;471555;472663.2733672619;472732;475563;477319;56384.43615563874;56431.71784141053;56531;56817.71591142101;56986.7150664244;1373.6703191234033;1374.4708287309459;1391.1861560986936;1454.3818876977243;1466.2668665667165;29912;30184.24539386445;30234.697653024068;30265.394692106474;30404.38916898544;47750.76124619355;48173;48263;48361.75819120882;48438;428995;431027;433193;437075;440362;27065;27270;27610.309742256606;28900.566491503065;29874.103776886728;47380.763096184295;47841.52158478371;48689;48722;49043.75478122729;41216.587834122474;41890.1621967565;41920.3711944315;42113.36829947492;42804.78597606992;41387.379189312785;41514.58485415107;41777.887829639716;42436.363454548824;42516.14967700567;36880.26239475249;41352.58647413487;41598.584014159474;41926.79036604797;42420.5757942429;35563.11092222715;36773;36921.81539092287;37346.813265933495;37467;28239.43521129607;28765;28859.278518037216;28986.27534311659;29100.7089929098 07:25:46 INFO - PROCESS | 5383 | |2;jquery.html;404.750123701138;406.24641290406294;412.5152945289285;412.9917401651969;425.5106627378514;16432.589185270343;17958.46124616262;18717.625647487042;19756.60486790265;19946.202151913923;15531.767023494656;15695.215239238021;17974.730379044326;19947.501312467197;20147.798522014775;5653.99999999999;5790.942090579104;5795.623284486495;5888.263967004124;5901.852453688649;5758.222639943596;5776;5790.305163380401;5791.913121303184;5818.359980402152;5544.364412498323;5653.830385088454;5736.397678243787;5771.2497375341145;5787.305523337205;5471.562275018029;5644.463775941279;5656.123300888369;5667.121596152603;5736.827895163131;5121.923171152435;5180.533751962342;5232.555232805216;5247.9737601311745;5260.210968354739;20948.895255523777;22585;22904.770952290597;23355.182568610016;23359;2132.2004248406847;2383.833131680783;2417.709874815016;2453.337598848319;2637.894484220629;9861.852072218922;9916.25628077897;10339.586416543405;10406.375617462976;10921.453927303683;1962.4505138561226;2028.4523178741656;2042.7855075217037;2046.1201683276186;2060.206820374152;83735;86687;89479.55260223722;90166;92125.07874921232;10598.152147828156;10774.838377424345;11256.161048318403;11296.6046188383;11305.26515776472;13816.792748108786;14652.413903443743;15928.681426371639;16014.19929003545;16056.839431605535;8115.229053239933;8366.163383661707;8516.233538981398;8632.78418039554;8732.301415886714;8292.502449853027;8347.29048030912;8366.07973122956;8461.957690211633;8504.532250726146;4688.976555117202;4820.373351464287;4834.661573689808;4866.975665121652;4900.215965445512;1948;1981.6333978214077;2031.0860112948938;2034.1558253325;2052.671572548385;972.7373609125497;1043.3583346242006;1046.9844251076443;1072.0191025211843;1083.025277250465;18082.186301616457;19020.90489547571;19037.14332855025;19649.31227407034;19679.704804427944;1005.9387346349525;1020.1736593359402;1049.2497864027105;1054.651964851597;1066.983995240072;10504.369737815756;10828.620998265023;10833.187510936712;10981.286216395909;11091.667249982513;374306;375609;378196;523823;525595;59767.701161494784;84866.57566712251;92537;99330.5033474828;99417.50291248497;1064.3667018124204;1077.4558847781977;1103.624767579027;1113.3041848844473;1117.413357987047;14898.627534311729;17365.305387784854;17498.73751893697;17572.648547029243;17614;36552.45171322486;37000.07499812526;38323;38393.42409863798;39403.60596393999;55083;56136.43863561312;57091.14363284637;57379;57666.71166644308;5294.179402192666;6212.502999759918;7519.060117485315;8937.06160853127;8968.641254349754;13196.538121165713;13515.391807368494;13744.312784360542;13970.930145349208;14185.432582696576;11394.829077563678;11425.143114266297;11699.23954942926;11715.648530544097;11764.529418823151;11754.578882160877;11766.88233117658;12090.153689241668;12106.697332566757;12286.262824230575;11823.76352472963;11871.584494542649;11915.76168476643;12317.137800353888;12429.129960903012;8910.975237847471;8927.419717718327;9057.456552606865;9124.361294709572;9169.457769081344;10361.84457233127;11818;12122.27266364021;12203.816942746043;12205.511779529075 07:25:46 INFO - PROCESS | 5383 | |3;mootools.html;1588.2297085913333;1599.3762432651267;1803.7204233343837;1865.766779152606;1901.2204995951663;7444.8138796529975;8321.375896807733;8613.483191008543;9278.4432934024;9287.071292870709;8346.332293416528;8712.912870871289;8755.299576033918;8840.336974726904;8856.734297971056;2364.527094581082;2380.5000949800565;2399.6880405547254;2402.939926501834;2407.687000689908;2348.7064116985375;2364.3852598324474;2386.5107652931106;2390.486045500217;2403.07481619576;2304.850184737995;2331.25399872041;2341.648752687102;2390.964135537968;2398.304491697406;2263.807576356012;2272.0230300970575;2272.125231785758;2273.454370950968;2281.281396360158;2291.644795056769;2295.4949911019717;2298.1152256381247;2301.079568172744;2317.7682231776857;8726.04013558508;8758.693445729368;8797.296216302744;8833.911660883374;8836.160564746338;5436.91844622331;5437.537809286216;5501.202325662756;5565.2486914266465;5577.525910297589;3381.3913495570787;3430.622631510532;3485.982570087159;3515.525404070469;3547.5565554305713;1197.7305106351089;1238.4488902438418;1251.9499220031187;1259.9181053231603;1275.4005617359826;12396.81404778929;12486.81269780954;12593.874061259361;12611.621651350475;12674.112812103156;4905.117078925757;4945.752712364368;4994.875128121754;5031.496850314939;5042.117629414838;10706.94646526778;10785.460726963778;10807.243492955575;10811.40537270442;10834.566617335377;5514.145307477347;5516.806911758069;5559.305086864142;5568.638038527482;5575.860603484864;4382.9342559861625;4860.538248866352;4981.053599816023;4986.476419975923;5040.294358789773;4198.6011328923705;4228.851990180329;4260.659147268211;4267.338562522814;4280.892977675583;1352.1008529328083;1374.7044385457175;1390.2978995607357;1392.2133994293192;1402.5371627362945;1045.5765415006933;1051.2851261142343;1054.4516851237313;1067.9305845120043;1071.539238127597;5996.700164991733;6104.847378815476;6129.938700612936;6153.169322141453;6199.287081985539;465.65774155995314;470.618798772995;471.86246304241837;472.0276230964225;478.2945155895027;4191.8532851350055;4325.870223893288;4342.739435633872;4393.912121757611;4402.3176407656865;10699.572017119384;11095.223334366518;11140.721481962853;11299.943500282447;11309.886901131047;10422.530986105643;10916.563337466412;10924.781504369868;11244.156688248415;11252.774944501065;8172.182781721899;8310.418270721113;8341.874871876928;8427.452215605967;8455.069942306342;6096.512279017757;6282.717277722422;6290.748370065329;6379.585326953733;6456.2575303838785;10001.449920254456;10149.137323327304;10190.031946965026;10199.490025498844;10267.691969240936;10239.48802559854;10356.792864142826;10386.272960892666;10387.844182337421;10482.790344193227;6999;7588.8482230356185;7847.764567062997;7884.2115788423;7918.2477664621765;8582.227599516074;8687.04442511336;8706.738797836075;8732.869006965027;8786.560671966248;7685.11621163551;7861.371090312876;7943.92056079455;7956.6419511120985;8044.235797599219;7513.173550909286;7616.961915190389;7623.618819059136;7692;7737.535747855147;6938.861222775416;6959.8608027838145;6992.720291188499;7022;7027.262137475492;4775.355327030807;4799.256115302133;4869.050535145612;4882.121218180761;4902.460729319843;5088.898222035465;5196.662216955886;5333.5199832015305;5344.4922732340365;5396.811111611232 07:25:46 INFO - PROCESS | 5383 | |4;prototype.html;342.7823332184063;347.7739469344925;349.3781069695941;351.853980598052;352.5874726569913;5650.26546548949;5661.480641114706;5664.376918538957;5671.291088613923;5679.290088738908;5515.951969125863;5553.111502159655;5560.888782224353;5567.916481252784;5589.7205139743055;4098.38524221367;4255.595718406762;4347.913041739163;4355.738655680653;4368.890777730567;4314.676399270052;4324.6972711910175;4328.653707703392;4335.349697545377;4354.455693038371;4309.245881970658;4319;4339.370791235269;4340.8697739067875;4341.522432532419;4252.766097864632;4281.72168809028;4291.077418355068;4302.322094383193;4314.848980285675;3816.446615240802;3832.0419895026243;3834.2523207974455;3847.2305538892056;3859.247446747885;5247.23915032322;5255.237990491396;5285.841424757225;5297;5323.680579165224;4810.742492893779;4819.180739274297;4963.528464795839;4985.426675932242;4985.429589679239;5716.685162412668;5730.914036289459;5748.655080695172;5768;5784.71076446176;4194.91610167798;4230.830766769325;4244;4253.80857861397;4263.786810659454;5852;6041.667708276043;6104.603200791934;6125.264968203799;6126.969365153191;4290.334998075304;4307.289297265916;4312.223799716018;4329.848455304049;4368.5194628590825;4351.303791393362;4370.431843860341;4375.868723938287;4415.271480205794;4427.490838553543;4851.660383773102;4878.390131256677;4928.827491037797;4991.775370108354;4998.5751211146735;5821.7380217890295;5862.472377486047;5867.853303667443;5889.558283128783;5890.558208134407;1496;1498.1572665621347;1504.5335945856818;1518.4381778741715;1519.4833756522614;979.8089372572423;979.9020097990144;998.1066945084109;1003.5283416794096;1010.1918465227789;4969.552740253394;5053.747312634354;5076.593872490192;5086.033653605803;5107.463716309734;5248.239005344204;5257.868553286198;5266.630016492593;5404.756785944642;5409.891802164014;4810.542998415145;5092.668976516515;5101.9744901276;5108.872278193001;5136.126858434075;2774.597683335905;2837.333226691726;2850.643669541307;2908.476474234658;2915.5626656001346;5354.277172581652;5450.182472629137;5453.64551304164;5483.533899618497;5501.367342755634;5123.3339665843205;5346.144616861284;5387.24578559002;5399.946000539944;5417.702026388586;5439.564834813205;5439.700816455053;5450.591205659592;5460.781568737365;5465.699386533779;4968.006398720198;5227.451117632594;5254.8192500113555;5262.842114736564;5276.419593844751;5186.599618103167;5272.44639312882;5275.630705850554;5286.3392075990505;5298.3906850712665;5404.83785486436;5406.810761623482;5440.483154100354;5481.479259470344;5529.778808847601;3812.6377994090517;3859.4403811446623;3971.285168669667;3979.940300895431;3992.0219546211365;5252.290940722954;5265.7367131642495;5282.97358513205;5773.942260577341;5912.142739302863;5844.386339434298;5874.412558744091;5898.675572843363;5909.645421274738;5919.970400148144;5795.188673585617;5826.679532625746;5827.79602713903;5844.824655260349;5866.2960444746905;5560.91658625129;5663.518600918968;5766.250387449605;5769.9711501442225;5783.826485205451;5851.180834683063;5885.529157667462;5947.553933454921;5959.582829201914;5993.831202915389;5705.429457054427;5798.797042103506;5829.562782791392;5843.678597676999;5847.532197424111 07:25:46 INFO - PROCESS | 5383 | |5;yui.html;838.1785849867134;844.1347618690837;844.9873251901223;866.2290561400351;874.6151693254967;14097.577072687824;15242.847571524282;15262.542123736277;15275;15303.846961530382;13675.179489230653;14227.644308892257;14253.572392828206;14289.142651440921;14297.142171469693;819.0458116294525;829.2122483640535;831.6798032757401;831.8876951611546;832.24681663095;818.1041759273616;853.036069241759;856.7601071699934;856.8543347630917;857.536930057768;888.9911100888972;900.0369604523163;900.7252787899688;900.8783814185067;904.2539904578716;894.5571941888774;897.2059727141461;898.4474548152839;899.7930475990559;900.5452246615483;645.8966565349568;653.7287025884252;654.7577396363329;655.2857385449835;655.5280198257248;14967.925160374129;14968.70062598742;14987.175705336202;14989.925050374679;15010.699786004328;13551.661208469768;13575.592732218049;13731.313434328244;14089.788653170212;14119.446860845299;11739.354335511543;11742.647720568397;11859.58491452795;11922.225055371373;12250.75498490034;3830.636089571486;3837.4052021936363;3891.182851601167;3947.032976920673;3966.4446977423186;56175.43824561743;57153.714231428996;57156.14265786017;57163.714181428826;57309.71345143248;10876.510557024953;11178.329300241849;11231.67126233123;11303.321800691985;11381.317120972768;18405.63188736218;18450.630987380177;18453;18453.261869525337;18532.444026679223;7898.091719452336;8021.879671804811;8155.266026057683;8189.590520474072;8266.272130197021;4810.326554282403;4817.9518204818205;4818.68678535894;4879.048585525788;4993.375828021497;3447.517347571342;3514.7715398499017;3535.876244331436;3563.572371315459;3573.0710015396185;645.6965226343705;660.9504287178481;685.6880119545594;726.6294189963157;726.6766289001343;655.5640499068162;700.4816435837444;734.295076726338;775.6393277126051;789.1950210784967;9359.766005849908;9550.713478595653;9633.614655413845;9671.90328096724;9679.70960871175;608.4493533352323;655.8130932684162;721.3760097515611;778.6496076765478;783.7021931666045;4611.216093264153;4675.392199014106;4715.905681886343;4719.38647975761;4740.715557066587;65205;66114.66942665256;66216.66891665511;69021.65489172522;70697.64651176712;60506.697466513266;61034.389656102874;62266.377336226964;62427;63259.367406326266;54123;54198.45801542013;55027;55684.16473752897;55766;8950.373473856767;8979.775505612412;9008.099190080939;9071.228945539702;9112.0887911211;35103;35938.820305898305;35975.10062248465;36041.63958360383;36244;44182;47014.76492617515;48551.51448485611;48946.510534894194;50360.99278014492;11451.312921224753;11556.59551915679;11629;11845.703857403289;12278.386080695751;13168.880645144887;13381.264030478416;13451.798223026859;13559.186448813103;13717.245551494763;11983.28100313984;12010.39948002579;12146;12231.327276999851;12320.137590368588;11559.653210403701;12354.567590134302;12388;12641.115121941375;12781.233126012468;9911.950440247752;11919.94040029829;12927.676808079874;12998.675033124247;13213;11331.886681133414;11507.252028618113;11599.478023488795;11642.15018839129;11654.94172529166;11010.449477525932;11038.226421086136;11051.613193538187;11437.714057148638;11795.410229488663 07:25:46 INFO - PROCESS | 5383 | __end_tp_report 07:25:46 INFO - PROCESS | 5383 | __start_cc_report 07:25:46 INFO - PROCESS | 5383 | _x_x_mozilla_cycle_collect,342 07:25:46 INFO - PROCESS | 5383 | __end_cc_report 07:25:46 INFO - PROCESS | 5383 | __startTimestamp1463063146804__endTimestamp 07:25:46 INFO - PROCESS | 5383 | 07:25:46 INFO - PROCESS | 5383 | ------- Summary: start ------- 07:25:46 INFO - PROCESS | 5383 | Number of tests: 6 07:25:46 INFO - PROCESS | 5383 | 07:25:46 INFO - PROCESS | 5383 | [#0] dojo.html Cycles:165 Average:5481.71 Median:5672.26 stddev:632.65 (11.2%) stddev-sans-first:607.29 07:25:46 INFO - PROCESS | 5383 | Values: 3138.0 3205.0 3219.0 3221.0 3238.1 5394.1 5405.4 5416.1 5495.4 5524.9 5377.3 5432.6 5490.6 5554.1 5562.7 4953.3 4960.8 5077.9 5101.8 5156.4 4928.7 5164.1 5176.6 5196.2 5198.1 4954.8 4992.3 5012.5 5061.4 5091.5 5042.7 5047.2 5055.0 5062.0 5106.8 5003.1 5020.4 5035.1 5035.8 5052.8 5373.6 5374.9 5428.6 5445.0 5470.4 5833.8 5859.9 5860.6 5907.4 5936.8 5650.1 5709.5 5962.7 5981.9 6021.3 5536.4 5553.9 5555.2 5604.5 5610.0 6053.1 6069.4 6096.2 6108.9 6131.4 5551.5 5752.1 5841.7 5852.1 5864.8 5870.1 5964.1 5965.3 5970.6 6006.9 5686.8 5805.3 5887.6 5898.6 5902.7 5668.2 5861.5 5907.5 5996.1 5996.9 4391.2 4443.2 4479.5 4502.8 4504.1 4001.8 4005.1 4009.0 4037.9 4042.1 5439.6 5498.8 5687.5 5689.3 5695.4 5894.2 5943.6 5963.1 5973.5 6017.7 5629.9 5637.3 5651.0 5654.1 5675.6 4659.7 4873.3 4887.4 4898.8 4907.0 6126.4 6130.5 6145.5 6150.9 6155.9 6004.7 6009.1 6009.8 6034.6 6050.0 5795.0 6061.2 6079.9 6113.8 6179.8 5887.4 5889.3 5893.3 5896.4 5901.9 5948.5 5971.4 5972.1 5990.2 5995.6 5529.1 5779.7 5792.3 5832.2 5864.0 5575.5 5665.8 5681.4 5720.1 5751.0 5640.0 5659.8 5665.7 5672.3 5674.1 5606.6 5742.2 5802.4 5820.4 5850.2 5625.3 5679.9 5681.6 5756.6 5780.5 07:25:46 INFO - PROCESS | 5383 | 07:25:46 INFO - PROCESS | 5383 | [#1] ext.html Cycles:180 Average:56323.89 Median:41261.88 stddev:110032.65 (266.7%) stddev-sans-first:110261.77 07:25:46 INFO - PROCESS | 5383 | Values: 597.9 635.1 636.9 653.7 683.4 36791.6 40578.2 41307.2 41447.4 41512.4 42736.4 42993.0 43062.8 43168.8 43315.6 8700.9 8817.2 8861.2 8864.1 8884.2 8853.6 8907.6 8909.2 8913.7 8935.6 8899.3 8913.6 8936.7 8941.6 8961.4 8839.1 8895.2 8915.2 8927.5 8935.9 8557.0 8634.0 8651.7 8702.6 8719.3 40400.4 40659.2 40763.8 40814.4 41010.2 3053.0 3269.2 3277.5 3355.0 3992.7 31793.5 32267.0 32502.0 32545.0 33608.3 4045.6 4264.8 4373.7 4374.3 4506.8 319208.0 321563.0 323871.0 326128.0 326707.0 33928.2 59178.7 60739.7 60785.7 60967.7 35384.6 35761.3 35807.3 35921.5 36133.5 16038.6 16050.3 16181.4 16242.9 16265.2 13489.9 13502.6 13557.8 13589.7 13660.1 8598.1 8648.8 8649.7 8662.0 8757.8 3321.8 3328.1 3344.4 3370.9 3434.5 1092.4 1110.6 1155.3 1160.0 1179.1 32138.1 32219.0 32264.4 32337.8 32530.5 1118.2 1131.9 1163.7 1224.4 1240.5 16011.6 16254.0 16374.3 16431.3 16450.4 471555.0 472663.3 472732.0 475563.0 477319.0 56384.4 56431.7 56531.0 56817.7 56986.7 1373.7 1374.5 1391.2 1454.4 1466.3 29912.0 30184.2 30234.7 30265.4 30404.4 47750.8 48173.0 48263.0 48361.8 48438.0 428995.0 431027.0 433193.0 437075.0 440362.0 27065.0 27270.0 27610.3 28900.6 29874.1 47380.8 47841.5 48689.0 48722.0 49043.8 41216.6 41890.2 41920.4 42113.4 42804.8 41387.4 41514.6 41777.9 42436.4 42516.1 36880.3 41352.6 41598.6 41926.8 42420.6 35563.1 36773.0 36921.8 37346.8 37467.0 28239.4 28765.0 28859.3 28986.3 29100.7 07:25:46 INFO - PROCESS | 5383 | 07:25:46 INFO - PROCESS | 5383 | [#2] jquery.html Cycles:180 Average:27382.39 Median:23129.98 stddev:73219.66 (316.6%) stddev-sans-first:73397.04 07:25:46 INFO - PROCESS | 5383 | Values: 404.8 406.2 412.5 413.0 425.5 16432.6 17958.5 18717.6 19756.6 19946.2 15531.8 15695.2 17974.7 19947.5 20147.8 5654.0 5790.9 5795.6 5888.3 5901.9 5758.2 5776.0 5790.3 5791.9 5818.4 5544.4 5653.8 5736.4 5771.2 5787.3 5471.6 5644.5 5656.1 5667.1 5736.8 5121.9 5180.5 5232.6 5248.0 5260.2 20948.9 22585.0 22904.8 23355.2 23359.0 2132.2 2383.8 2417.7 2453.3 2637.9 9861.9 9916.3 10339.6 10406.4 10921.5 1962.5 2028.5 2042.8 2046.1 2060.2 83735.0 86687.0 89479.6 90166.0 92125.1 10598.2 10774.8 11256.2 11296.6 11305.3 13816.8 14652.4 15928.7 16014.2 16056.8 8115.2 8366.2 8516.2 8632.8 8732.3 8292.5 8347.3 8366.1 8462.0 8504.5 4689.0 4820.4 4834.7 4867.0 4900.2 1948.0 1981.6 2031.1 2034.2 2052.7 972.7 1043.4 1047.0 1072.0 1083.0 18082.2 19020.9 19037.1 19649.3 19679.7 1005.9 1020.2 1049.2 1054.7 1067.0 10504.4 10828.6 10833.2 10981.3 11091.7 374306.0 375609.0 378196.0 523823.0 525595.0 59767.7 84866.6 92537.0 99330.5 99417.5 1064.4 1077.5 1103.6 1113.3 1117.4 14898.6 17365.3 17498.7 17572.6 17614.0 36552.5 37000.1 38323.0 38393.4 39403.6 55083.0 56136.4 57091.1 57379.0 57666.7 5294.2 6212.5 7519.1 8937.1 8968.6 13196.5 13515.4 13744.3 13970.9 14185.4 11394.8 11425.1 11699.2 11715.6 11764.5 11754.6 11766.9 12090.2 12106.7 12286.3 11823.8 11871.6 11915.8 12317.1 12429.1 8911.0 8927.4 9057.5 9124.4 9169.5 10361.8 11818.0 12122.3 12203.8 12205.5 07:25:46 INFO - PROCESS | 5383 | 07:25:46 INFO - PROCESS | 5383 | [#3] mootools.html Cycles:180 Average:5897.35 Median:2433.99 stddev:3338.58 (137.2%) stddev-sans-first:3332.24 07:25:46 INFO - PROCESS | 5383 | Values: 1588.2 1599.4 1803.7 1865.8 1901.2 7444.8 8321.4 8613.5 9278.4 9287.1 8346.3 8712.9 8755.3 8840.3 8856.7 2364.5 2380.5 2399.7 2402.9 2407.7 2348.7 2364.4 2386.5 2390.5 2403.1 2304.9 2331.3 2341.6 2391.0 2398.3 2263.8 2272.0 2272.1 2273.5 2281.3 2291.6 2295.5 2298.1 2301.1 2317.8 8726.0 8758.7 8797.3 8833.9 8836.2 5436.9 5437.5 5501.2 5565.2 5577.5 3381.4 3430.6 3486.0 3515.5 3547.6 1197.7 1238.4 1251.9 1259.9 1275.4 12396.8 12486.8 12593.9 12611.6 12674.1 4905.1 4945.8 4994.9 5031.5 5042.1 10706.9 10785.5 10807.2 10811.4 10834.6 5514.1 5516.8 5559.3 5568.6 5575.9 4382.9 4860.5 4981.1 4986.5 5040.3 4198.6 4228.9 4260.7 4267.3 4280.9 1352.1 1374.7 1390.3 1392.2 1402.5 1045.6 1051.3 1054.5 1067.9 1071.5 5996.7 6104.8 6129.9 6153.2 6199.3 465.7 470.6 471.9 472.0 478.3 4191.9 4325.9 4342.7 4393.9 4402.3 10699.6 11095.2 11140.7 11299.9 11309.9 10422.5 10916.6 10924.8 11244.2 11252.8 8172.2 8310.4 8341.9 8427.5 8455.1 6096.5 6282.7 6290.7 6379.6 6456.3 10001.4 10149.1 10190.0 10199.5 10267.7 10239.5 10356.8 10386.3 10387.8 10482.8 6999.0 7588.8 7847.8 7884.2 7918.2 8582.2 8687.0 8706.7 8732.9 8786.6 7685.1 7861.4 7943.9 7956.6 8044.2 7513.2 7617.0 7623.6 7692.0 7737.5 6938.9 6959.9 6992.7 7022.0 7027.3 4775.4 4799.3 4869.1 4882.1 4902.5 5088.9 5196.7 5333.5 5344.5 5396.8 07:25:46 INFO - PROCESS | 5383 | 07:25:46 INFO - PROCESS | 5383 | [#4] prototype.html Cycles:180 Average:4719.47 Median:5256.55 stddev:1353.76 (25.8%) stddev-sans-first:1317.10 07:25:46 INFO - PROCESS | 5383 | Values: 342.8 347.8 349.4 351.9 352.6 5650.3 5661.5 5664.4 5671.3 5679.3 5516.0 5553.1 5560.9 5567.9 5589.7 4098.4 4255.6 4347.9 4355.7 4368.9 4314.7 4324.7 4328.7 4335.3 4354.5 4309.2 4319.0 4339.4 4340.9 4341.5 4252.8 4281.7 4291.1 4302.3 4314.8 3816.4 3832.0 3834.3 3847.2 3859.2 5247.2 5255.2 5285.8 5297.0 5323.7 4810.7 4819.2 4963.5 4985.4 4985.4 5716.7 5730.9 5748.7 5768.0 5784.7 4194.9 4230.8 4244.0 4253.8 4263.8 5852.0 6041.7 6104.6 6125.3 6127.0 4290.3 4307.3 4312.2 4329.8 4368.5 4351.3 4370.4 4375.9 4415.3 4427.5 4851.7 4878.4 4928.8 4991.8 4998.6 5821.7 5862.5 5867.9 5889.6 5890.6 1496.0 1498.2 1504.5 1518.4 1519.5 979.8 979.9 998.1 1003.5 1010.2 4969.6 5053.7 5076.6 5086.0 5107.5 5248.2 5257.9 5266.6 5404.8 5409.9 4810.5 5092.7 5102.0 5108.9 5136.1 2774.6 2837.3 2850.6 2908.5 2915.6 5354.3 5450.2 5453.6 5483.5 5501.4 5123.3 5346.1 5387.2 5399.9 5417.7 5439.6 5439.7 5450.6 5460.8 5465.7 4968.0 5227.5 5254.8 5262.8 5276.4 5186.6 5272.4 5275.6 5286.3 5298.4 5404.8 5406.8 5440.5 5481.5 5529.8 3812.6 3859.4 3971.3 3979.9 3992.0 5252.3 5265.7 5283.0 5773.9 5912.1 5844.4 5874.4 5898.7 5909.6 5920.0 5795.2 5826.7 5827.8 5844.8 5866.3 5560.9 5663.5 5766.3 5770.0 5783.8 5851.2 5885.5 5947.6 5959.6 5993.8 5705.4 5798.8 5829.6 5843.7 5847.5 07:25:46 INFO - PROCESS | 5383 | 07:25:46 INFO - PROCESS | 5383 | [#5] yui.html Cycles:180 Average:15555.83 Median:4775.52 stddev:18549.51 (388.4%) stddev-sans-first:18568.62 07:25:46 INFO - PROCESS | 5383 | Values: 838.2 844.1 845.0 866.2 874.6 14097.6 15242.8 15262.5 15275.0 15303.8 13675.2 14227.6 14253.6 14289.1 14297.1 819.0 829.2 831.7 831.9 832.2 818.1 853.0 856.8 856.9 857.5 889.0 900.0 900.7 900.9 904.3 894.6 897.2 898.4 899.8 900.5 645.9 653.7 654.8 655.3 655.5 14967.9 14968.7 14987.2 14989.9 15010.7 13551.7 13575.6 13731.3 14089.8 14119.4 11739.4 11742.6 11859.6 11922.2 12250.8 3830.6 3837.4 3891.2 3947.0 3966.4 56175.4 57153.7 57156.1 57163.7 57309.7 10876.5 11178.3 11231.7 11303.3 11381.3 18405.6 18450.6 18453.0 18453.3 18532.4 7898.1 8021.9 8155.3 8189.6 8266.3 4810.3 4818.0 4818.7 4879.0 4993.4 3447.5 3514.8 3535.9 3563.6 3573.1 645.7 661.0 685.7 726.6 726.7 655.6 700.5 734.3 775.6 789.2 9359.8 9550.7 9633.6 9671.9 9679.7 608.4 655.8 721.4 778.6 783.7 4611.2 4675.4 4715.9 4719.4 4740.7 65205.0 66114.7 66216.7 69021.7 70697.6 60506.7 61034.4 62266.4 62427.0 63259.4 54123.0 54198.5 55027.0 55684.2 55766.0 8950.4 8979.8 9008.1 9071.2 9112.1 35103.0 35938.8 35975.1 36041.6 36244.0 44182.0 47014.8 48551.5 48946.5 50361.0 11451.3 11556.6 11629.0 11845.7 12278.4 13168.9 13381.3 13451.8 13559.2 13717.2 11983.3 12010.4 12146.0 12231.3 12320.1 11559.7 12354.6 12388.0 12641.1 12781.2 9912.0 11919.9 12927.7 12998.7 13213.0 11331.9 11507.3 11599.5 11642.2 11654.9 11010.4 11038.2 11051.6 11437.7 11795.4 07:25:46 INFO - PROCESS | 5383 | -------- Summary: end -------- 07:25:46 INFO - PROCESS | 5383 | 07:25:47 INFO - TEST-INFO | 5383: exit 0 07:25:47 INFO - TEST-OK | dromaeo_css | took 1110367ms 07:25:47 INFO - TEST-START | kraken 07:25:47 INFO - operating with platform_type : linux_ 07:25:47 INFO - Initialising browser for kraken test... 07:25:47 INFO - TEST-INFO | started process 5622 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqrz07p/profile http://localhost:53331/getInfo.html) 07:25:51 INFO - PROCESS | 5622 | 07:25:51 INFO - PROCESS | 5622 | (process:5693): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:25:51 INFO - PROCESS | 5622 | __metrics Screen width/height:1600/1200 07:25:51 INFO - PROCESS | 5622 | colorDepth:24 07:25:51 INFO - PROCESS | 5622 | Browser inner width/height: 1024/697 07:25:51 INFO - PROCESS | 5622 | __metrics 07:25:52 ERROR - PROCESS | 5622 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 07:25:53 INFO - TEST-INFO | 5622: exit 0 07:25:53 INFO - Browser initialized. 07:25:53 INFO - Running cycle 1/1 for kraken test... 07:25:53 INFO - TEST-INFO | started process 5744 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqrz07p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:25:55 INFO - PROCESS | 5744 | 07:25:55 INFO - PROCESS | 5744 | (process:5803): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:26:05 INFO - PROCESS | 5744 | RSS: Main: 162951168 07:26:05 INFO - PROCESS | 5744 | 07:26:07 INFO - PROCESS | 5744 | Cycle 1(1): loaded http://localhost:53331/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53331/tests/kraken/driver.html?testName=audio-beat-detection) 07:26:08 INFO - PROCESS | 5744 | RSS: Main: 167292928 07:26:08 INFO - PROCESS | 5744 | 07:26:11 INFO - PROCESS | 5744 | Cycle 1(1): loaded http://localhost:53331/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53331/tests/kraken/driver.html?testName=audio-dft) 07:26:11 INFO - PROCESS | 5744 | RSS: Main: 167710720 07:26:11 INFO - PROCESS | 5744 | 07:26:14 INFO - PROCESS | 5744 | Cycle 1(1): loaded http://localhost:53331/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53331/tests/kraken/driver.html?testName=audio-fft) 07:26:15 INFO - PROCESS | 5744 | RSS: Main: 162512896 07:26:15 INFO - PROCESS | 5744 | 07:26:17 INFO - PROCESS | 5744 | Cycle 1(1): loaded http://localhost:53331/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53331/tests/kraken/driver.html?testName=audio-oscillator) 07:26:18 INFO - PROCESS | 5744 | RSS: Main: 162807808 07:26:18 INFO - PROCESS | 5744 | 07:26:20 INFO - PROCESS | 5744 | Cycle 1(1): loaded http://localhost:53331/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53331/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:26:21 INFO - PROCESS | 5744 | RSS: Main: 162963456 07:26:21 INFO - PROCESS | 5744 | 07:26:24 INFO - PROCESS | 5744 | Cycle 1(1): loaded http://localhost:53331/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53331/tests/kraken/driver.html?testName=imaging-darkroom) 07:26:25 INFO - PROCESS | 5744 | RSS: Main: 162951168 07:26:25 INFO - PROCESS | 5744 | 07:26:28 INFO - PROCESS | 5744 | Cycle 1(1): loaded http://localhost:53331/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53331/tests/kraken/driver.html?testName=imaging-desaturate) 07:26:29 INFO - PROCESS | 5744 | RSS: Main: 161935360 07:26:29 INFO - PROCESS | 5744 | 07:26:32 INFO - PROCESS | 5744 | Cycle 1(1): loaded http://localhost:53331/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53331/tests/kraken/driver.html?testName=json-parse-financial) 07:26:32 INFO - PROCESS | 5744 | RSS: Main: 162787328 07:26:32 INFO - PROCESS | 5744 | 07:26:34 INFO - PROCESS | 5744 | Cycle 1(1): loaded http://localhost:53331/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53331/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:26:34 INFO - PROCESS | 5744 | RSS: Main: 163147776 07:26:34 INFO - PROCESS | 5744 | 07:26:36 INFO - PROCESS | 5744 | Cycle 1(1): loaded http://localhost:53331/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53331/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:26:37 INFO - PROCESS | 5744 | RSS: Main: 163639296 07:26:37 INFO - PROCESS | 5744 | 07:26:39 INFO - PROCESS | 5744 | Cycle 1(1): loaded http://localhost:53331/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53331/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:26:40 INFO - PROCESS | 5744 | RSS: Main: 163241984 07:26:40 INFO - PROCESS | 5744 | 07:26:42 INFO - PROCESS | 5744 | Cycle 1(1): loaded http://localhost:53331/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53331/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:26:43 INFO - PROCESS | 5744 | RSS: Main: 163475456 07:26:43 INFO - PROCESS | 5744 | 07:26:46 INFO - PROCESS | 5744 | Cycle 1(1): loaded http://localhost:53331/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53331/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:26:47 INFO - PROCESS | 5744 | RSS: Main: 163946496 07:26:47 INFO - PROCESS | 5744 | 07:26:48 INFO - PROCESS | 5744 | Cycle 1(1): loaded http://localhost:53331/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53331/tests/kraken/driver.html?testName=ai-astar) 07:26:48 INFO - PROCESS | 5744 | RSS: Main: 164876288 07:26:48 INFO - PROCESS | 5744 | 07:26:48 INFO - PROCESS | 5744 | __start_tp_report 07:26:48 INFO - PROCESS | 5744 | _x_x_mozilla_page_load 07:26:48 INFO - PROCESS | 5744 | _x_x_mozilla_page_load_details 07:26:48 INFO - PROCESS | 5744 | |i|pagename|runs| 07:26:48 INFO - PROCESS | 5744 | |0;ai-astar;107;112;104;109;110;113;104;110;110;111 07:26:48 INFO - PROCESS | 5744 | |1;audio-beat-detection;157;128;153;204;126;151;153;129;178;126 07:26:48 INFO - PROCESS | 5744 | |2;audio-dft;164;163;163;163;163;176;166;164;161;162 07:26:48 INFO - PROCESS | 5744 | |3;audio-fft;75;76;76;163;76;77;76;75;175;76 07:26:48 INFO - PROCESS | 5744 | |4;audio-oscillator;92;92;175;93;93;92;148;93;92;156 07:26:48 INFO - PROCESS | 5744 | |5;imaging-gaussian-blur;117;118;117;118;118;117;117;118;117;118 07:26:48 INFO - PROCESS | 5744 | |6;imaging-darkroom;146;146;146;146;146;146;146;147;146;146 07:26:48 INFO - PROCESS | 5744 | |7;imaging-desaturate;97;95;96;96;95;96;95;96;96;95 07:26:48 INFO - PROCESS | 5744 | |8;json-parse-financial;58;61;59;59;57;57;57;109;55;56 07:26:48 INFO - PROCESS | 5744 | |9;json-stringify-tinderbox;61;61;61;60;61;60;61;61;60;61 07:26:48 INFO - PROCESS | 5744 | |10;stanford-crypto-aes;86;80;80;82;80;80;80;80;79;80 07:26:48 INFO - PROCESS | 5744 | |11;stanford-crypto-ccm;140;137;132;126;125;130;137;129;191;122 07:26:48 INFO - PROCESS | 5744 | |12;stanford-crypto-pbkdf2;169;171;171;172;167;166;173;171;165;166 07:26:48 INFO - PROCESS | 5744 | |13;stanford-crypto-sha256-iterative;69;64;73;66;66;64;65;63;65;64 07:26:48 INFO - PROCESS | 5744 | __end_tp_report 07:26:48 INFO - PROCESS | 5744 | __start_cc_report 07:26:48 INFO - PROCESS | 5744 | _x_x_mozilla_cycle_collect,858 07:26:48 INFO - PROCESS | 5744 | __end_cc_report 07:26:48 INFO - PROCESS | 5744 | __startTimestamp1463063208990__endTimestamp 07:26:48 INFO - PROCESS | 5744 | 07:26:49 INFO - PROCESS | 5744 | ------- Summary: start ------- 07:26:49 INFO - PROCESS | 5744 | Number of tests: 14 07:26:49 INFO - PROCESS | 5744 | 07:26:49 INFO - PROCESS | 5744 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.00 stddev:3.09 (2.8%) stddev-sans-first:3.19 07:26:49 INFO - PROCESS | 5744 | Values: 107.0 112.0 104.0 109.0 110.0 113.0 104.0 110.0 110.0 111.0 07:26:49 INFO - PROCESS | 5744 | 07:26:49 INFO - PROCESS | 5744 | [#1] audio-beat-detection Cycles:10 Average:150.50 Median:153.00 stddev:25.48 (16.7%) stddev-sans-first:26.92 07:26:49 INFO - PROCESS | 5744 | Values: 157.0 128.0 153.0 204.0 126.0 151.0 153.0 129.0 178.0 126.0 07:26:49 INFO - PROCESS | 5744 | 07:26:49 INFO - PROCESS | 5744 | [#2] audio-dft Cycles:10 Average:164.50 Median:163.50 stddev:4.25 (2.6%) stddev-sans-first:4.50 07:26:49 INFO - PROCESS | 5744 | Values: 164.0 163.0 163.0 163.0 163.0 176.0 166.0 164.0 161.0 162.0 07:26:49 INFO - PROCESS | 5744 | 07:26:49 INFO - PROCESS | 5744 | [#3] audio-fft Cycles:10 Average:94.50 Median:76.00 stddev:39.37 (51.8%) stddev-sans-first:41.12 07:26:49 INFO - PROCESS | 5744 | Values: 75.0 76.0 76.0 163.0 76.0 77.0 76.0 75.0 175.0 76.0 07:26:49 INFO - PROCESS | 5744 | 07:26:49 INFO - PROCESS | 5744 | [#4] audio-oscillator Cycles:10 Average:112.60 Median:92.00 stddev:33.13 (36.0%) stddev-sans-first:34.29 07:26:49 INFO - PROCESS | 5744 | Values: 92.0 92.0 175.0 93.0 93.0 92.0 148.0 93.0 92.0 156.0 07:26:49 INFO - PROCESS | 5744 | 07:26:49 INFO - PROCESS | 5744 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 07:26:49 INFO - PROCESS | 5744 | Values: 117.0 118.0 117.0 118.0 118.0 117.0 117.0 118.0 117.0 118.0 07:26:49 INFO - PROCESS | 5744 | 07:26:49 INFO - PROCESS | 5744 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 07:26:49 INFO - PROCESS | 5744 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 07:26:49 INFO - PROCESS | 5744 | 07:26:49 INFO - PROCESS | 5744 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.53 07:26:49 INFO - PROCESS | 5744 | Values: 97.0 95.0 96.0 96.0 95.0 96.0 95.0 96.0 96.0 95.0 07:26:49 INFO - PROCESS | 5744 | 07:26:49 INFO - PROCESS | 5744 | [#8] json-parse-financial Cycles:10 Average:62.80 Median:57.50 stddev:16.32 (28.4%) stddev-sans-first:17.22 07:26:49 INFO - PROCESS | 5744 | Values: 58.0 61.0 59.0 59.0 57.0 57.0 57.0 109.0 55.0 56.0 07:26:49 INFO - PROCESS | 5744 | 07:26:49 INFO - PROCESS | 5744 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 07:26:49 INFO - PROCESS | 5744 | Values: 61.0 61.0 61.0 60.0 61.0 60.0 61.0 61.0 60.0 61.0 07:26:49 INFO - PROCESS | 5744 | 07:26:49 INFO - PROCESS | 5744 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:80.00 stddev:2.00 (2.5%) stddev-sans-first:0.78 07:26:49 INFO - PROCESS | 5744 | Values: 86.0 80.0 80.0 82.0 80.0 80.0 80.0 80.0 79.0 80.0 07:26:49 INFO - PROCESS | 5744 | 07:26:49 INFO - PROCESS | 5744 | [#11] stanford-crypto-ccm Cycles:10 Average:136.90 Median:134.50 stddev:19.87 (14.8%) stddev-sans-first:21.04 07:26:49 INFO - PROCESS | 5744 | Values: 140.0 137.0 132.0 126.0 125.0 130.0 137.0 129.0 191.0 122.0 07:26:49 INFO - PROCESS | 5744 | 07:26:49 INFO - PROCESS | 5744 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.10 Median:171.00 stddev:2.88 (1.7%) stddev-sans-first:3.06 07:26:49 INFO - PROCESS | 5744 | Values: 169.0 171.0 171.0 172.0 167.0 166.0 173.0 171.0 165.0 166.0 07:26:49 INFO - PROCESS | 5744 | 07:26:49 INFO - PROCESS | 5744 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:65.50 stddev:3.00 (4.6%) stddev-sans-first:2.96 07:26:49 INFO - PROCESS | 5744 | Values: 69.0 64.0 73.0 66.0 66.0 64.0 65.0 63.0 65.0 64.0 07:26:49 INFO - PROCESS | 5744 | -------- Summary: end -------- 07:26:49 INFO - PROCESS | 5744 | 07:26:49 INFO - TEST-INFO | 5744: exit 0 07:26:49 INFO - TEST-OK | kraken | took 62469ms 07:26:49 INFO - SUITE-END | took 1172s 07:26:50 INFO - Completed test suite (00:19:33) 07:26:50 INFO - javascript benchmark 07:26:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7140.887528249055, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3137.9686203137967, 3205.0, 3218.951715724263, 3220.951685724713, 3238.125706059364, 5394.109971854644, 5405.43242959489, 5416.052190866598, 5495.368032676243, 5524.917126243099, 5377.274068000819, 5432.592555558329, 5490.588205884555, 5554.1391084381885, 5562.666240025601, 4953.306537084811, 4960.826371077013, 5077.898442031157, 5101.846944591668, 5156.381234251895, 4928.679635823678, 5164.147915593941, 5176.55999240065, 5196.168613021917, 5198.116320225571, 4954.7522623868845, 4992.2511623256805, 5012.498750124995, 5061.417936937244, 5091.541761241488, 5042.672226305279, 5047.217681259374, 5055.014272216919, 5062.038212739568, 5106.8212612558755, 5003.149464591028, 5020.3724534433195, 5035.068512325195, 5035.798568057273, 5052.8484145475695, 5373.570114390878, 5374.946250537484, 5428.565714742851, 5445.047116754592, 5470.425605311425, 5833.79581714638, 5859.941400585983, 5860.560457965669, 5907.350191478934, 5936.821895343103, 5650.067738823089, 5709.486146246816, 5962.672053037081, 5981.880362392728, 6021.337652858182, 5536.4186760389985, 5553.888922221573, 5555.2222688823595, 5604.495595396434, 5610.046292130389, 6053.061775424816, 6069.3627169147485, 6096.177016102858, 6108.938910610926, 6131.417515336036, 5551.472610102034, 5752.108423194411, 5841.707914604252, 5852.063669812809, 5864.765409383577, 5870.119482077723, 5964.075568286922, 5965.3139888912465, 5970.552208584287, 6006.939930600725, 5686.77252909879, 5805.303363596396, 5887.646741195542, 5898.557608179403, 5902.675352855548, 5668.234788303526, 5861.531077513874, 5907.49786268172, 5996.070609055603, 5996.880062398727, 4391.231534481453, 4443.244648409778, 4479.46246450428, 4502.797374118172, 4504.1216962692615, 4001.799910004488, 4005.1388951375593, 4008.9799551002056, 4037.8990525237105, 4042.0703238255364, 5439.619226654176, 5498.752556134984, 5687.544996400278, 5689.317281926113, 5695.373508914016, 5894.204282421904, 5943.55423343251, 5963.105534169822, 5973.522118230531, 6017.729202185912, 5629.887402251932, 5637.295338082739, 5651.039323315046, 5654.1236108402445, 5675.602707810496, 4659.6505262105475, 4873.293372461044, 4887.413510378707, 4898.804047838046, 4906.975465122723, 6126.387361263838, 6130.489860652556, 6145.508359331243, 6150.876982460326, 6155.907661385083, 6004.669743164168, 6009.128676341993, 6009.789657361971, 6034.637921724535, 6049.969750151309, 5795.0, 6061.212042434456, 6079.939200608114, 6113.816585502442, 6179.752809887734, 5887.4406931341455, 5889.322727886177, 5893.292804863444, 5896.439838215363, 5901.911471327848, 5948.4943779779205, 5971.402859713994, 5972.13404056418, 5990.161377407079, 5995.640261584319, 5529.142982837667, 5779.682117483579, 5792.275965504312, 5832.1543376209365, 5863.970680146743, 5575.498205161555, 5665.830025099253, 5681.4034526374135, 5720.08478643415, 5751.0, 5640.0, 5659.773609055592, 5665.66006039639, 5672.262605861211, 5674.06377947634, 5606.635568688022, 5742.1673857289625, 5802.4197580241635, 5820.417958204146, 5850.151727999331, 5625.324961004706, 5679.9148012779015, 5681.630694004876, 5756.568257380797, 5780.450857168562], "value": 5438.756303321282, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.8744463662631, 635.1425575473112, 636.891728406171, 653.6862306093075, 683.3678847066462, 36791.632083679186, 40578.188436231256, 41307.17385652289, 41447.37828932564, 41512.377314340236, 42736.35895461571, 42993.0, 43062.78468607661, 43168.78415607925, 43315.566844331544, 8700.912990870089, 8817.16236957488, 8861.246794022483, 8864.069272726367, 8884.244839188677, 8853.645854165825, 8907.643694252221, 8909.1536304051, 8913.732588022338, 8935.59789809457, 8899.33255005874, 8913.59888805002, 8936.731898043068, 8941.59762810675, 8961.372703910729, 8839.07189745074, 8895.154960278764, 8915.1976322131, 8927.508987005713, 8935.865962010575, 8556.957215213884, 8633.956830215871, 8651.740447786577, 8702.564871756387, 8719.346049046348, 40400.39399409011, 40659.186816263806, 40763.79618101891, 40814.38778418326, 41010.17979640391, 3053.0, 3269.1990462336644, 3277.5411442398085, 3355.027042157771, 3992.680585553178, 31793.52309715356, 32267.0, 32502.0, 32545.0, 33608.327833443196, 4045.615666511677, 4264.808083636244, 4373.737575745466, 4374.256376416017, 4506.819727210907, 319208.0, 321563.0, 323871.0, 326127.9999999976, 326707.0, 33928.15179620529, 59178.70410648005, 60739.69630151821, 60785.696071520244, 60967.695161524796, 35384.64615353814, 35761.28477430437, 35807.28385432329, 35921.46117808235, 36133.45799813005, 16038.599035024217, 16050.277737501841, 16181.352745890268, 16242.918785405996, 16265.186740662919, 13489.865101349058, 13502.594922152155, 13557.796633050511, 13589.728205435837, 13660.112092713942, 8598.097199794056, 8648.789169516273, 8649.697260595849, 8661.956690216508, 8757.781055473537, 3321.78408403453, 3328.118048717092, 3344.39800835847, 3370.9325813483592, 3434.5363375944426, 1092.3773449133917, 1110.5890820396344, 1155.3241353807948, 1159.9739354055769, 1179.0803173524664, 32138.071715697133, 32219.0, 32264.35471290608, 32337.838310808766, 32530.512042319384, 1118.2004866520476, 1131.9359801786295, 1163.66253786401, 1224.4184012593946, 1240.5472002718943, 16011.599710007344, 16254.0, 16374.263158157912, 16431.26059327333, 16450.424235151713, 471555.0, 472663.2733672619, 472732.0, 475563.0, 477319.0, 56384.43615563874, 56431.71784141053, 56531.0, 56817.71591142101, 56986.7150664244, 1373.6703191234033, 1374.4708287309459, 1391.1861560986936, 1454.3818876977243, 1466.2668665667165, 29912.0, 30184.24539386445, 30234.697653024068, 30265.394692106474, 30404.38916898544, 47750.76124619355, 48173.0, 48263.0, 48361.75819120882, 48438.0, 428995.0, 431027.0, 433193.0, 437075.0, 440362.0, 27065.0, 27270.0, 27610.309742256606, 28900.566491503065, 29874.103776886728, 47380.763096184295, 47841.52158478371, 48689.0, 48722.0, 49043.75478122729, 41216.587834122474, 41890.1621967565, 41920.3711944315, 42113.36829947492, 42804.78597606992, 41387.379189312785, 41514.58485415107, 41777.887829639716, 42436.363454548824, 42516.14967700567, 36880.26239475249, 41352.58647413487, 41598.584014159474, 41926.79036604797, 42420.5757942429, 35563.11092222715, 36773.0, 36921.81539092287, 37346.813265933495, 37467.0, 28239.43521129607, 28765.0, 28859.278518037216, 28986.27534311659, 29100.7089929098], "value": 18862.763478868656, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.750123701138, 406.24641290406294, 412.5152945289285, 412.9917401651969, 425.5106627378514, 16432.589185270343, 17958.46124616262, 18717.625647487042, 19756.60486790265, 19946.202151913923, 15531.767023494656, 15695.215239238021, 17974.730379044326, 19947.501312467197, 20147.798522014775, 5653.99999999999, 5790.942090579104, 5795.623284486495, 5888.263967004124, 5901.852453688649, 5758.222639943596, 5776.0, 5790.305163380401, 5791.913121303184, 5818.359980402152, 5544.364412498323, 5653.830385088454, 5736.397678243787, 5771.2497375341145, 5787.305523337205, 5471.562275018029, 5644.463775941279, 5656.123300888369, 5667.121596152603, 5736.827895163131, 5121.923171152435, 5180.533751962342, 5232.555232805216, 5247.9737601311745, 5260.210968354739, 20948.895255523777, 22585.0, 22904.770952290597, 23355.182568610016, 23359.0, 2132.2004248406847, 2383.833131680783, 2417.709874815016, 2453.337598848319, 2637.894484220629, 9861.852072218922, 9916.25628077897, 10339.586416543405, 10406.375617462976, 10921.453927303683, 1962.4505138561226, 2028.4523178741656, 2042.7855075217037, 2046.1201683276186, 2060.206820374152, 83735.0, 86687.0, 89479.55260223722, 90166.0, 92125.07874921232, 10598.152147828156, 10774.838377424345, 11256.161048318403, 11296.6046188383, 11305.26515776472, 13816.792748108786, 14652.413903443743, 15928.681426371639, 16014.19929003545, 16056.839431605535, 8115.229053239933, 8366.163383661707, 8516.233538981398, 8632.78418039554, 8732.301415886714, 8292.502449853027, 8347.29048030912, 8366.07973122956, 8461.957690211633, 8504.532250726146, 4688.976555117202, 4820.373351464287, 4834.661573689808, 4866.975665121652, 4900.215965445512, 1948.0, 1981.6333978214077, 2031.0860112948938, 2034.1558253325, 2052.671572548385, 972.7373609125497, 1043.3583346242006, 1046.9844251076443, 1072.0191025211843, 1083.025277250465, 18082.186301616457, 19020.90489547571, 19037.14332855025, 19649.31227407034, 19679.704804427944, 1005.9387346349525, 1020.1736593359402, 1049.2497864027105, 1054.651964851597, 1066.983995240072, 10504.369737815756, 10828.620998265023, 10833.187510936712, 10981.286216395909, 11091.667249982513, 374306.0, 375609.0, 378196.0, 523823.0, 525595.0, 59767.701161494784, 84866.57566712251, 92537.0, 99330.5033474828, 99417.50291248497, 1064.3667018124204, 1077.4558847781977, 1103.624767579027, 1113.3041848844473, 1117.413357987047, 14898.627534311729, 17365.305387784854, 17498.73751893697, 17572.648547029243, 17614.0, 36552.45171322486, 37000.07499812526, 38323.0, 38393.42409863798, 39403.60596393999, 55083.0, 56136.43863561312, 57091.14363284637, 57379.0, 57666.71166644308, 5294.179402192666, 6212.502999759918, 7519.060117485315, 8937.06160853127, 8968.641254349754, 13196.538121165713, 13515.391807368494, 13744.312784360542, 13970.930145349208, 14185.432582696576, 11394.829077563678, 11425.143114266297, 11699.23954942926, 11715.648530544097, 11764.529418823151, 11754.578882160877, 11766.88233117658, 12090.153689241668, 12106.697332566757, 12286.262824230575, 11823.76352472963, 11871.584494542649, 11915.76168476643, 12317.137800353888, 12429.129960903012, 8910.975237847471, 8927.419717718327, 9057.456552606865, 9124.361294709572, 9169.457769081344, 10361.84457233127, 11818.0, 12122.27266364021, 12203.816942746043, 12205.511779529075], "value": 9229.308962649833, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1588.2297085913333, 1599.3762432651267, 1803.7204233343837, 1865.766779152606, 1901.2204995951663, 7444.8138796529975, 8321.375896807733, 8613.483191008543, 9278.4432934024, 9287.071292870709, 8346.332293416528, 8712.912870871289, 8755.299576033918, 8840.336974726904, 8856.734297971056, 2364.527094581082, 2380.5000949800565, 2399.6880405547254, 2402.939926501834, 2407.687000689908, 2348.7064116985375, 2364.3852598324474, 2386.5107652931106, 2390.486045500217, 2403.07481619576, 2304.850184737995, 2331.25399872041, 2341.648752687102, 2390.964135537968, 2398.304491697406, 2263.807576356012, 2272.0230300970575, 2272.125231785758, 2273.454370950968, 2281.281396360158, 2291.644795056769, 2295.4949911019717, 2298.1152256381247, 2301.079568172744, 2317.7682231776857, 8726.04013558508, 8758.693445729368, 8797.296216302744, 8833.911660883374, 8836.160564746338, 5436.91844622331, 5437.537809286216, 5501.202325662756, 5565.2486914266465, 5577.525910297589, 3381.3913495570787, 3430.622631510532, 3485.982570087159, 3515.525404070469, 3547.5565554305713, 1197.7305106351089, 1238.4488902438418, 1251.9499220031187, 1259.9181053231603, 1275.4005617359826, 12396.81404778929, 12486.81269780954, 12593.874061259361, 12611.621651350475, 12674.112812103156, 4905.117078925757, 4945.752712364368, 4994.875128121754, 5031.496850314939, 5042.117629414838, 10706.94646526778, 10785.460726963778, 10807.243492955575, 10811.40537270442, 10834.566617335377, 5514.145307477347, 5516.806911758069, 5559.305086864142, 5568.638038527482, 5575.860603484864, 4382.9342559861625, 4860.538248866352, 4981.053599816023, 4986.476419975923, 5040.294358789773, 4198.6011328923705, 4228.851990180329, 4260.659147268211, 4267.338562522814, 4280.892977675583, 1352.1008529328083, 1374.7044385457175, 1390.2978995607357, 1392.2133994293192, 1402.5371627362945, 1045.5765415006933, 1051.2851261142343, 1054.4516851237313, 1067.9305845120043, 1071.539238127597, 5996.700164991733, 6104.847378815476, 6129.938700612936, 6153.169322141453, 6199.287081985539, 465.65774155995314, 470.618798772995, 471.86246304241837, 472.0276230964225, 478.2945155895027, 4191.8532851350055, 4325.870223893288, 4342.739435633872, 4393.912121757611, 4402.3176407656865, 10699.572017119384, 11095.223334366518, 11140.721481962853, 11299.943500282447, 11309.886901131047, 10422.530986105643, 10916.563337466412, 10924.781504369868, 11244.156688248415, 11252.774944501065, 8172.182781721899, 8310.418270721113, 8341.874871876928, 8427.452215605967, 8455.069942306342, 6096.512279017757, 6282.717277722422, 6290.748370065329, 6379.585326953733, 6456.2575303838785, 10001.449920254456, 10149.137323327304, 10190.031946965026, 10199.490025498844, 10267.691969240936, 10239.48802559854, 10356.792864142826, 10386.272960892666, 10387.844182337421, 10482.790344193227, 6999.0, 7588.8482230356185, 7847.764567062997, 7884.2115788423, 7918.2477664621765, 8582.227599516074, 8687.04442511336, 8706.738797836075, 8732.869006965027, 8786.560671966248, 7685.11621163551, 7861.371090312876, 7943.92056079455, 7956.6419511120985, 8044.235797599219, 7513.173550909286, 7616.961915190389, 7623.618819059136, 7692.0, 7737.535747855147, 6938.861222775416, 6959.8608027838145, 6992.720291188499, 7022.0, 7027.262137475492, 4775.355327030807, 4799.256115302133, 4869.050535145612, 4882.121218180761, 4902.460729319843, 5088.898222035465, 5196.662216955886, 5333.5199832015305, 5344.4922732340365, 5396.811111611232], "value": 4676.4002964751735, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.7823332184063, 347.7739469344925, 349.3781069695941, 351.853980598052, 352.5874726569913, 5650.26546548949, 5661.480641114706, 5664.376918538957, 5671.291088613923, 5679.290088738908, 5515.951969125863, 5553.111502159655, 5560.888782224353, 5567.916481252784, 5589.7205139743055, 4098.38524221367, 4255.595718406762, 4347.913041739163, 4355.738655680653, 4368.890777730567, 4314.676399270052, 4324.6972711910175, 4328.653707703392, 4335.349697545377, 4354.455693038371, 4309.245881970658, 4319.0, 4339.370791235269, 4340.8697739067875, 4341.522432532419, 4252.766097864632, 4281.72168809028, 4291.077418355068, 4302.322094383193, 4314.848980285675, 3816.446615240802, 3832.0419895026243, 3834.2523207974455, 3847.2305538892056, 3859.247446747885, 5247.23915032322, 5255.237990491396, 5285.841424757225, 5297.0, 5323.680579165224, 4810.742492893779, 4819.180739274297, 4963.528464795839, 4985.426675932242, 4985.429589679239, 5716.685162412668, 5730.914036289459, 5748.655080695172, 5768.0, 5784.71076446176, 4194.91610167798, 4230.830766769325, 4244.0, 4253.80857861397, 4263.786810659454, 5852.0, 6041.667708276043, 6104.603200791934, 6125.264968203799, 6126.969365153191, 4290.334998075304, 4307.289297265916, 4312.223799716018, 4329.848455304049, 4368.5194628590825, 4351.303791393362, 4370.431843860341, 4375.868723938287, 4415.271480205794, 4427.490838553543, 4851.660383773102, 4878.390131256677, 4928.827491037797, 4991.775370108354, 4998.5751211146735, 5821.7380217890295, 5862.472377486047, 5867.853303667443, 5889.558283128783, 5890.558208134407, 1496.0, 1498.1572665621347, 1504.5335945856818, 1518.4381778741715, 1519.4833756522614, 979.8089372572423, 979.9020097990144, 998.1066945084109, 1003.5283416794096, 1010.1918465227789, 4969.552740253394, 5053.747312634354, 5076.593872490192, 5086.033653605803, 5107.463716309734, 5248.239005344204, 5257.868553286198, 5266.630016492593, 5404.756785944642, 5409.891802164014, 4810.542998415145, 5092.668976516515, 5101.9744901276, 5108.872278193001, 5136.126858434075, 2774.597683335905, 2837.333226691726, 2850.643669541307, 2908.476474234658, 2915.5626656001346, 5354.277172581652, 5450.182472629137, 5453.64551304164, 5483.533899618497, 5501.367342755634, 5123.3339665843205, 5346.144616861284, 5387.24578559002, 5399.946000539944, 5417.702026388586, 5439.564834813205, 5439.700816455053, 5450.591205659592, 5460.781568737365, 5465.699386533779, 4968.006398720198, 5227.451117632594, 5254.8192500113555, 5262.842114736564, 5276.419593844751, 5186.599618103167, 5272.44639312882, 5275.630705850554, 5286.3392075990505, 5298.3906850712665, 5404.83785486436, 5406.810761623482, 5440.483154100354, 5481.479259470344, 5529.778808847601, 3812.6377994090517, 3859.4403811446623, 3971.285168669667, 3979.940300895431, 3992.0219546211365, 5252.290940722954, 5265.7367131642495, 5282.97358513205, 5773.942260577341, 5912.142739302863, 5844.386339434298, 5874.412558744091, 5898.675572843363, 5909.645421274738, 5919.970400148144, 5795.188673585617, 5826.679532625746, 5827.79602713903, 5844.824655260349, 5866.2960444746905, 5560.91658625129, 5663.518600918968, 5766.250387449605, 5769.9711501442225, 5783.826485205451, 5851.180834683063, 5885.529157667462, 5947.553933454921, 5959.582829201914, 5993.831202915389, 5705.429457054427, 5798.797042103506, 5829.562782791392, 5843.678597676999, 5847.532197424111], "value": 4294.9745359859135, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [838.1785849867134, 844.1347618690837, 844.9873251901223, 866.2290561400351, 874.6151693254967, 14097.577072687824, 15242.847571524282, 15262.542123736277, 15275.0, 15303.846961530382, 13675.179489230653, 14227.644308892257, 14253.572392828206, 14289.142651440921, 14297.142171469693, 819.0458116294525, 829.2122483640535, 831.6798032757401, 831.8876951611546, 832.24681663095, 818.1041759273616, 853.036069241759, 856.7601071699934, 856.8543347630917, 857.536930057768, 888.9911100888972, 900.0369604523163, 900.7252787899688, 900.8783814185067, 904.2539904578716, 894.5571941888774, 897.2059727141461, 898.4474548152839, 899.7930475990559, 900.5452246615483, 645.8966565349568, 653.7287025884252, 654.7577396363329, 655.2857385449835, 655.5280198257248, 14967.925160374129, 14968.70062598742, 14987.175705336202, 14989.925050374679, 15010.699786004328, 13551.661208469768, 13575.592732218049, 13731.313434328244, 14089.788653170212, 14119.446860845299, 11739.354335511543, 11742.647720568397, 11859.58491452795, 11922.225055371373, 12250.75498490034, 3830.636089571486, 3837.4052021936363, 3891.182851601167, 3947.032976920673, 3966.4446977423186, 56175.43824561743, 57153.714231428996, 57156.14265786017, 57163.714181428826, 57309.71345143248, 10876.510557024953, 11178.329300241849, 11231.67126233123, 11303.321800691985, 11381.317120972768, 18405.63188736218, 18450.630987380177, 18453.0, 18453.261869525337, 18532.444026679223, 7898.091719452336, 8021.879671804811, 8155.266026057683, 8189.590520474072, 8266.272130197021, 4810.326554282403, 4817.9518204818205, 4818.68678535894, 4879.048585525788, 4993.375828021497, 3447.517347571342, 3514.7715398499017, 3535.876244331436, 3563.572371315459, 3573.0710015396185, 645.6965226343705, 660.9504287178481, 685.6880119545594, 726.6294189963157, 726.6766289001343, 655.5640499068162, 700.4816435837444, 734.295076726338, 775.6393277126051, 789.1950210784967, 9359.766005849908, 9550.713478595653, 9633.614655413845, 9671.90328096724, 9679.70960871175, 608.4493533352323, 655.8130932684162, 721.3760097515611, 778.6496076765478, 783.7021931666045, 4611.216093264153, 4675.392199014106, 4715.905681886343, 4719.38647975761, 4740.715557066587, 65205.0, 66114.66942665256, 66216.66891665511, 69021.65489172522, 70697.64651176712, 60506.697466513266, 61034.389656102874, 62266.377336226964, 62427.0, 63259.367406326266, 54123.0, 54198.45801542013, 55027.0, 55684.16473752897, 55766.0, 8950.373473856767, 8979.775505612412, 9008.099190080939, 9071.228945539702, 9112.0887911211, 35103.0, 35938.820305898305, 35975.10062248465, 36041.63958360383, 36244.0, 44182.0, 47014.76492617515, 48551.51448485611, 48946.510534894194, 50360.99278014492, 11451.312921224753, 11556.59551915679, 11629.0, 11845.703857403289, 12278.386080695751, 13168.880645144887, 13381.264030478416, 13451.798223026859, 13559.186448813103, 13717.245551494763, 11983.28100313984, 12010.39948002579, 12146.0, 12231.327276999851, 12320.137590368588, 11559.653210403701, 12354.567590134302, 12388.0, 12641.115121941375, 12781.233126012468, 9911.950440247752, 11919.94040029829, 12927.676808079874, 12998.675033124247, 13213.0, 11331.886681133414, 11507.252028618113, 11599.478023488795, 11642.15018839129, 11654.94172529166, 11010.449477525932, 11038.226421086136, 11051.613193538187, 11437.714057148638, 11795.410229488663], "value": 6971.4880289375, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1566.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 112.0, 104.0, 109.0, 110.0, 113.0, 104.0, 110.0, 110.0, 111.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 128.0, 153.0, 204.0, 126.0, 151.0, 153.0, 129.0, 178.0, 126.0], "value": 150.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 163.0, 163.0, 163.0, 176.0, 166.0, 164.0, 161.0, 162.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 163.0, 76.0, 77.0, 76.0, 75.0, 175.0, 76.0], "value": 94.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 175.0, 93.0, 93.0, 92.0, 148.0, 93.0, 92.0, 156.0], "value": 112.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 117.0, 118.0, 117.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 61.0, 59.0, 59.0, 57.0, 57.0, 57.0, 109.0, 55.0, 56.0], "value": 62.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 60.0, 61.0, 60.0, 61.0, 61.0, 60.0, 61.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 80.0, 80.0, 82.0, 80.0, 80.0, 80.0, 80.0, 79.0, 80.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 137.0, 132.0, 126.0, 125.0, 130.0, 137.0, 129.0, 191.0, 122.0], "value": 136.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 171.0, 171.0, 172.0, 167.0, 166.0, 173.0, 171.0, 165.0, 166.0], "value": 169.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 64.0, 73.0, 66.0, 66.0, 64.0, 65.0, 63.0, 65.0, 64.0], "value": 65.9, "unit": "score"}]}]} 07:26:50 INFO - Return code: 0 07:26:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:26:50 ERROR - # TBPL SUCCESS # 07:26:50 INFO - Running post-action listener: _resource_record_post_action 07:26:50 INFO - ##### 07:26:50 INFO - ##### Finished run-tests step (success) 07:26:50 INFO - ##### 07:26:50 INFO - Running post-run listener: _resource_record_post_run 07:26:51 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 536371200; Read time: 12; Write time: 457324 07:26:51 INFO - TinderboxPrint: CPU usage
13.5% 07:26:51 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 07:26:51 INFO - TinderboxPrint: I/O write bytes / time
536,371,200 / 457,324 07:26:51 INFO - TinderboxPrint: CPU idle
8,221.5 (86.5%) 07:26:51 INFO - TinderboxPrint: CPU user
1,222.8 (12.9%) 07:26:51 INFO - TinderboxPrint: Swap in / out
0 / 0 07:26:51 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244817920; Read time: 0; Write time: 233420 07:26:51 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291553280; Read time: 12; Write time: 223904 07:26:51 INFO - Running post-run listener: _upload_blobber_files 07:26:51 INFO - Blob upload gear active. 07:26:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:26:51 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 07:26:51 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'] 07:26:51 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 07:26:51 INFO - (blobuploader) - INFO - Open directory for files ... 07:26:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:26:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:26:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:26:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:26:52 INFO - (blobuploader) - INFO - Done attempting. 07:26:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:26:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:26:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:26:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:26:53 INFO - (blobuploader) - INFO - Done attempting. 07:26:53 INFO - (blobuploader) - INFO - Iteration through files over. 07:26:53 INFO - Return code: 0 07:26:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:26:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:26:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a6eea6fd5ae7d43cd04cc454bbabd6d3e8b99c9071c728395316362ebd61d6dcca0e788a308955b4372dba9dad3427c0c2672c96655c9b092eab1c59931a390", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5fc397c72a9a8fc0e035cb10400ca9ae08582df0e2c7c6fab537d6d2b3cf18c5fcd1853df56e31a78a1f25894ad89f62841a0fcbcbe7baab55016de0047b29af"} 07:26:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:26:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:26:53 INFO - Contents: 07:26:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a6eea6fd5ae7d43cd04cc454bbabd6d3e8b99c9071c728395316362ebd61d6dcca0e788a308955b4372dba9dad3427c0c2672c96655c9b092eab1c59931a390", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5fc397c72a9a8fc0e035cb10400ca9ae08582df0e2c7c6fab537d6d2b3cf18c5fcd1853df56e31a78a1f25894ad89f62841a0fcbcbe7baab55016de0047b29af"} 07:26:53 INFO - Running post-run listener: copy_logs_to_upload_dir 07:26:53 INFO - Copying logs to upload dir... 07:26:53 INFO - mkdir: /builds/slave/test/build/upload/logs 07:26:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.976747 ========= master_lag: 248.25 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 24 mins, 54 secs) (at 2016-05-12 07:31:01.408884) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 3 mins, 48 secs) (at 2016-05-12 07:31:01.417281) ========= 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=0e2a256762fed810e2f0f810000001b3-1463059451.618068-841884228 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a6eea6fd5ae7d43cd04cc454bbabd6d3e8b99c9071c728395316362ebd61d6dcca0e788a308955b4372dba9dad3427c0c2672c96655c9b092eab1c59931a390", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5fc397c72a9a8fc0e035cb10400ca9ae08582df0e2c7c6fab537d6d2b3cf18c5fcd1853df56e31a78a1f25894ad89f62841a0fcbcbe7baab55016de0047b29af"} build_url:https://queue.taskcluster.net/v1/task/EU5-rn-HS4C6aYdUbShcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011310 build_url: 'https://queue.taskcluster.net/v1/task/EU5-rn-HS4C6aYdUbShcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a6eea6fd5ae7d43cd04cc454bbabd6d3e8b99c9071c728395316362ebd61d6dcca0e788a308955b4372dba9dad3427c0c2672c96655c9b092eab1c59931a390", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5fc397c72a9a8fc0e035cb10400ca9ae08582df0e2c7c6fab537d6d2b3cf18c5fcd1853df56e31a78a1f25894ad89f62841a0fcbcbe7baab55016de0047b29af"}' ========= master_lag: 228.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 3 mins, 48 secs) (at 2016-05-12 07:34:49.445020) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 07:34:49.445400) ========= 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=0e2a256762fed810e2f0f810000001b3-1463059451.618068-841884228 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004777 ========= master_lag: 0.43 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 07:34:49.879375) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-12 07:34:49.879719) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-12 07:34:50.447870) ========= ========= Total master_lag: 476.76 =========