builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-016 starttime: 1463789852.91 results: success (0) buildid: 20160520160630 builduid: 77ce1d51c5184298ba7687e7b6564ef5 revision: 45709b7b6466abcd984d5736c0e64eb12b0044cc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-20 17:17:32.914742) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-20 17:17:32.915192) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-20 17:17:32.915521) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-20 17:17:32.943266) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 17:17:32.943576) ========= 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=00204705a9daa57ed339a427000001b9-1463787216.969482-232306169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-20 17:17:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-05-20 17:17:33 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.294526 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 17:17:33.252081) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 17:17:33.252450) ========= 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=00204705a9daa57ed339a427000001b9-1463787216.969482-232306169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022949 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 17:17:33.302368) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-20 17:17:33.302753) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 45709b7b6466abcd984d5736c0e64eb12b0044cc --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 45709b7b6466abcd984d5736c0e64eb12b0044cc --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=00204705a9daa57ed339a427000001b9-1463787216.969482-232306169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-20 17:17:33,935 truncating revision to first 12 chars 2016-05-20 17:17:33,935 Setting DEBUG logging. 2016-05-20 17:17:33,935 attempt 1/10 2016-05-20 17:17:33,935 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/45709b7b6466?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-20 17:17:34,700 unpacking tar archive at: mozilla-central-45709b7b6466/testing/mozharness/ program finished with exit code 0 elapsedTime=1.038460 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-20 17:17:34.358085) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-20 17:17:34.358935) ========= script_repo_revision: 45709b7b6466abcd984d5736c0e64eb12b0044cc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-20 17:17:34.359838) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-20 17:17:34.360166) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-20 17:17:34.371245) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-05-20 17:17:34.371974) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1463787216.969482-232306169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:17:35 INFO - MultiFileLogger online at 20160520 17:17:35 in /builds/slave/test 17:17:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 17:17:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:17:35 INFO - {'append_to_log': False, 17:17:35 INFO - 'base_work_dir': '/builds/slave/test', 17:17:35 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:17:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:17:35 INFO - 'branch': 'Firefox-Non-PGO', 17:17:35 INFO - 'buildbot_json_path': 'buildprops.json', 17:17:35 INFO - 'config_files': ('talos/linux_config.py',), 17:17:35 INFO - 'default_actions': ('clobber', 17:17:35 INFO - 'read-buildbot-config', 17:17:35 INFO - 'download-and-extract', 17:17:35 INFO - 'populate-webroot', 17:17:35 INFO - 'create-virtualenv', 17:17:35 INFO - 'install', 17:17:35 INFO - 'run-tests'), 17:17:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:17:35 INFO - 'download_minidump_stackwalk': True, 17:17:35 INFO - 'download_symbols': 'ondemand', 17:17:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:17:35 INFO - 'tooltool.py': '/tools/tooltool.py', 17:17:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:17:35 INFO - '/tools/misc-python/virtualenv.py')}, 17:17:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:17:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:17:35 INFO - 'installer_path': 'installer.exe', 17:17:35 INFO - 'log_level': 'info', 17:17:35 INFO - 'log_name': 'talos', 17:17:35 INFO - 'log_to_console': True, 17:17:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:17:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:17:35 INFO - 'opt_config_files': (), 17:17:35 INFO - 'pip_index': False, 17:17:35 INFO - 'sps_profile': False, 17:17:35 INFO - 'sps_profile_interval': 0, 17:17:35 INFO - 'suite': 'dromaeojs-e10s', 17:17:35 INFO - 'system_bits': '32', 17:17:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:17:35 INFO - 'title': 'talos-linux64-ix-016', 17:17:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:17:35 INFO - 'use_talos_json': True, 17:17:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:17:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:17:35 INFO - 'work_dir': 'build'} 17:17:35 INFO - ##### 17:17:35 INFO - ##### Running clobber step. 17:17:35 INFO - ##### 17:17:35 INFO - Running pre-action listener: _resource_record_pre_action 17:17:35 INFO - Running main action method: clobber 17:17:35 INFO - rmtree: /builds/slave/test/build 17:17:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:17:36 INFO - Running post-action listener: _resource_record_post_action 17:17:36 INFO - ##### 17:17:36 INFO - ##### Finished clobber step (success) 17:17:36 INFO - ##### 17:17:36 INFO - ##### 17:17:36 INFO - ##### Running read-buildbot-config step. 17:17:36 INFO - ##### 17:17:36 INFO - Running pre-action listener: _resource_record_pre_action 17:17:36 INFO - Running main action method: read_buildbot_config 17:17:36 INFO - Using buildbot properties: 17:17:36 INFO - { 17:17:36 INFO - "project": "", 17:17:36 INFO - "product": "firefox", 17:17:36 INFO - "script_repo_revision": "production", 17:17:36 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 17:17:36 INFO - "repository": "", 17:17:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 17:17:36 INFO - "buildid": "20160520160630", 17:17:36 INFO - "pgo_build": "False", 17:17:36 INFO - "basedir": "/builds/slave/test", 17:17:36 INFO - "buildnumber": 64, 17:17:36 INFO - "slavename": "talos-linux64-ix-016", 17:17:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:17:36 INFO - "platform": "ubuntu64_hw", 17:17:36 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 17:17:36 INFO - "branch": "mozilla-central", 17:17:36 INFO - "repo_path": "mozilla-central", 17:17:36 INFO - "revision": "45709b7b6466abcd984d5736c0e64eb12b0044cc", 17:17:36 INFO - "stage_platform": "linux64", 17:17:36 INFO - "builduid": "77ce1d51c5184298ba7687e7b6564ef5", 17:17:36 INFO - "slavebuilddir": "test" 17:17:36 INFO - } 17:17:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 17:17:36 INFO - Running post-action listener: _resource_record_post_action 17:17:36 INFO - ##### 17:17:36 INFO - ##### Finished read-buildbot-config step (success) 17:17:36 INFO - ##### 17:17:36 INFO - ##### 17:17:36 INFO - ##### Running download-and-extract step. 17:17:36 INFO - ##### 17:17:36 INFO - Running pre-action listener: _resource_record_pre_action 17:17:36 INFO - Running main action method: download_and_extract 17:17:36 INFO - mkdir: /builds/slave/test/build/tests 17:17:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:36 INFO - https://queue.taskcluster.net/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:17:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:17:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:17:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:17:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:17:40 INFO - Downloaded 1361 bytes. 17:17:40 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:17:40 INFO - Using the following test package requirements: 17:17:40 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:17:40 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:17:40 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:17:40 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:40 INFO - u'jsshell-linux-x86_64.zip'], 17:17:40 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:17:40 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:17:40 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:17:40 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:17:40 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:17:40 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:17:40 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:17: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')]} 17:17:40 INFO - https://queue.taskcluster.net/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:17:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:17:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:17:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:17:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:17:42 INFO - Downloaded 22814329 bytes. 17:17:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:17:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:17:44 INFO - Return code: 0 17:17:44 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:17:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:44 INFO - https://queue.taskcluster.net/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:17:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:17:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:17:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:17:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:17:45 INFO - Downloaded 22814329 bytes. 17:17:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:17:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:17:46 INFO - Return code: 0 17:17:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:46 INFO - https://queue.taskcluster.net/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:17:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:17:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:17:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:17:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:17:48 INFO - Downloaded 10840359 bytes. 17:17:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:17:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:17:48 INFO - Return code: 0 17:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:48 INFO - https://queue.taskcluster.net/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:17:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:17:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:17:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:17:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:17:50 INFO - Downloaded 54820439 bytes. 17:17:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:17:50 INFO - mkdir: /builds/slave/test/properties 17:17:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:17:50 INFO - Writing to file /builds/slave/test/properties/build_url 17:17:50 INFO - Contents: 17:17:50 INFO - build_url:https://queue.taskcluster.net/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:17:51 INFO - Running post-action listener: _resource_record_post_action 17:17:51 INFO - Running post-action listener: set_extra_try_arguments 17:17:51 INFO - ##### 17:17:51 INFO - ##### Finished download-and-extract step (success) 17:17:51 INFO - ##### 17:17:51 INFO - ##### 17:17:51 INFO - ##### Running populate-webroot step. 17:17:51 INFO - ##### 17:17:51 INFO - Running pre-action listener: _resource_record_pre_action 17:17:51 INFO - Running main action method: populate_webroot 17:17:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:17:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:17:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:17:51 INFO - '--tppagecycles', 17:17:51 INFO - '7'], 17:17:51 INFO - 'tests': ['tsvgm']}}, 17:17:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:17:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:17:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:17:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:17:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:17:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:17:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:51 INFO - 'talos_options': ['--disable-e10s'], 17:17:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:17:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:17:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:51 INFO - 'talos_options': ['--disable-e10s'], 17:17:51 INFO - 'tests': ['damp', 'tps']}, 17:17:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:51 INFO - 'tests': ['damp', 'tps']}, 17:17:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:17:51 INFO - 'tests': ['dromaeo_dom']}, 17:17:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:17:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:17:51 INFO - 'tests': ['a11yr', 17:17:51 INFO - 'ts_paint', 17:17:51 INFO - 'tpaint', 17:17:51 INFO - 'sessionrestore', 17:17:51 INFO - 'sessionrestore_no_auto_restore', 17:17:51 INFO - 'tabpaint']}, 17:17:51 INFO - 'other-e10s': {'tests': ['a11yr', 17:17:51 INFO - 'ts_paint', 17:17:51 INFO - 'tpaint', 17:17:51 INFO - 'sessionrestore', 17:17:51 INFO - 'sessionrestore_no_auto_restore', 17:17:51 INFO - 'tabpaint']}, 17:17:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:17:51 INFO - 'ts_paint', 17:17:51 INFO - 'tpaint', 17:17:51 INFO - 'sessionrestore', 17:17:51 INFO - 'sessionrestore_no_auto_restore', 17:17:51 INFO - 'tabpaint']}, 17:17:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:17:51 INFO - 'ts_paint', 17:17:51 INFO - 'tpaint', 17:17:51 INFO - 'sessionrestore', 17:17:51 INFO - 'sessionrestore_no_auto_restore', 17:17:51 INFO - 'tabpaint']}, 17:17:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:17:51 INFO - 'tests': ['a11yr', 17:17:51 INFO - 'ts_paint', 17:17:51 INFO - 'tpaint', 17:17:51 INFO - 'sessionrestore', 17:17:51 INFO - 'sessionrestore_no_auto_restore', 17:17:51 INFO - 'tabpaint']}, 17:17:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:17:51 INFO - 'tests': ['a11yr', 17:17:51 INFO - 'ts_paint', 17:17:51 INFO - 'tpaint', 17:17:51 INFO - 'sessionrestore', 17:17:51 INFO - 'sessionrestore_no_auto_restore', 17:17:51 INFO - 'tabpaint']}, 17:17:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:17:51 INFO - 'tests': ['tsvgx', 17:17:51 INFO - 'tsvgr_opacity', 17:17:51 INFO - 'tart', 17:17:51 INFO - 'tscrollx', 17:17:51 INFO - 'cart']}, 17:17:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:17:51 INFO - 'tsvgr_opacity', 17:17:51 INFO - 'tart', 17:17:51 INFO - 'tscrollx', 17:17:51 INFO - 'cart']}, 17:17:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:51 INFO - 'talos_options': ['--disable-e10s'], 17:17:51 INFO - 'tests': ['tp5o']}, 17:17:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:51 INFO - 'tests': ['tp5o']}, 17:17:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:51 INFO - 'talos_options': ['--disable-e10s', 17:17:51 INFO - '--xperf_path', 17:17:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:17:51 INFO - 'tests': ['tp5n']}, 17:17:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:51 INFO - 'talos_options': ['--xperf_path', 17:17:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:17:51 INFO - 'tests': ['tp5n']}}, 17:17:51 INFO - 'talos.zip': {'path': '', 17:17:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:17:51 INFO - Running post-action listener: _resource_record_post_action 17:17:51 INFO - ##### 17:17:51 INFO - ##### Finished populate-webroot step (success) 17:17:51 INFO - ##### 17:17:51 INFO - ##### 17:17:51 INFO - ##### Running create-virtualenv step. 17:17:51 INFO - ##### 17:17:51 INFO - Running pre-action listener: _resource_record_pre_action 17:17:51 INFO - Running main action method: create_virtualenv 17:17:51 INFO - Creating virtualenv /builds/slave/test/build/venv 17:17:51 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:17:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:17:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:17:51 INFO - Using real prefix '/usr' 17:17:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:17:51 INFO - Installing distribute.............................................................................................................................................................................................done. 17:17:53 INFO - Installing pip.................done. 17:17:53 INFO - Return code: 0 17:17:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:17: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')]} 17:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17: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')]} 17:17:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb040258f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1506770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15959c0>, '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 0x15968c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1596d50>, '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': '00204705a9daa57ed339a427000001b9-1463787216.969482-232306169', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:17: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', 'pip>=1.5'] in /builds/slave/test/build 17:17: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 pip>=1.5 17:17:53 INFO - Using env: {'DISPLAY': ':0', 17:17:53 INFO - 'HOME': '/home/cltbld', 17:17:53 INFO - 'LANG': 'en_US.UTF-8', 17:17:53 INFO - 'LANGUAGE': 'en_US:en', 17:17:53 INFO - 'LOGNAME': 'cltbld', 17:17:53 INFO - 'MAIL': '/var/mail/cltbld', 17:17:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:53 INFO - 'MOZ_NO_REMOTE': '1', 17:17:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:53 INFO - 'NO_EM_RESTART': '1', 17:17:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:53 INFO - 'PWD': '/builds/slave/test', 17:17:53 INFO - 'SHELL': '/bin/bash', 17:17:53 INFO - 'SHLVL': '1', 17:17:53 INFO - 'TERM': 'linux', 17:17:53 INFO - 'TMOUT': '86400', 17:17:53 INFO - 'USER': 'cltbld', 17:17:53 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1463787216.969482-232306169', 17:17:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:53 INFO - '_': '/tools/buildbot/bin/python'} 17:17:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:53 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:17:53 INFO - Cleaning up... 17:17:53 INFO - Return code: 0 17:17:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:17: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')]} 17:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17: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')]} 17:17:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17: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', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb040258f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1506770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15959c0>, '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 0x15968c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1596d50>, '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': '00204705a9daa57ed339a427000001b9-1463787216.969482-232306169', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:17: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', 'psutil>=3.1.1'] in /builds/slave/test/build 17:17: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 psutil>=3.1.1 17:17:53 INFO - Using env: {'DISPLAY': ':0', 17:17:53 INFO - 'HOME': '/home/cltbld', 17:17:53 INFO - 'LANG': 'en_US.UTF-8', 17:17:53 INFO - 'LANGUAGE': 'en_US:en', 17:17:53 INFO - 'LOGNAME': 'cltbld', 17:17:53 INFO - 'MAIL': '/var/mail/cltbld', 17:17:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:53 INFO - 'MOZ_NO_REMOTE': '1', 17:17:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:53 INFO - 'NO_EM_RESTART': '1', 17:17:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:53 INFO - 'PWD': '/builds/slave/test', 17:17:53 INFO - 'SHELL': '/bin/bash', 17:17:53 INFO - 'SHLVL': '1', 17:17:53 INFO - 'TERM': 'linux', 17:17:53 INFO - 'TMOUT': '86400', 17:17:53 INFO - 'USER': 'cltbld', 17:17:53 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1463787216.969482-232306169', 17:17:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:53 INFO - '_': '/tools/buildbot/bin/python'} 17:17:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:54 INFO - Downloading/unpacking psutil>=3.1.1 17:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:17:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:17:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:17:56 INFO - Installing collected packages: psutil 17:17:56 INFO - Running setup.py install for psutil 17:17:56 INFO - building 'psutil._psutil_linux' extension 17:17:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:17:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:17:56 INFO - building 'psutil._psutil_posix' extension 17:17:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:17:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:17:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:17:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:17:56 INFO - Successfully installed psutil 17:17:56 INFO - Cleaning up... 17:17:56 INFO - Return code: 0 17:17:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:17:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb040258f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1506770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15959c0>, '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 0x15968c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1596d50>, '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': '00204705a9daa57ed339a427000001b9-1463787216.969482-232306169', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:17:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:17: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 mozsystemmonitor==0.3 17:17:56 INFO - Using env: {'DISPLAY': ':0', 17:17:56 INFO - 'HOME': '/home/cltbld', 17:17:56 INFO - 'LANG': 'en_US.UTF-8', 17:17:56 INFO - 'LANGUAGE': 'en_US:en', 17:17:56 INFO - 'LOGNAME': 'cltbld', 17:17:56 INFO - 'MAIL': '/var/mail/cltbld', 17:17:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:56 INFO - 'MOZ_NO_REMOTE': '1', 17:17:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:56 INFO - 'NO_EM_RESTART': '1', 17:17:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:56 INFO - 'PWD': '/builds/slave/test', 17:17:56 INFO - 'SHELL': '/bin/bash', 17:17:56 INFO - 'SHLVL': '1', 17:17:56 INFO - 'TERM': 'linux', 17:17:56 INFO - 'TMOUT': '86400', 17:17:56 INFO - 'USER': 'cltbld', 17:17:56 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1463787216.969482-232306169', 17:17:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:56 INFO - '_': '/tools/buildbot/bin/python'} 17:17:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:17: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 17:17: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 17:17: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 17:17: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 17:17: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 17:17: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 17:17:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:17:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:17:58 INFO - Installing collected packages: mozsystemmonitor 17:17:58 INFO - Running setup.py install for mozsystemmonitor 17:17:58 INFO - Successfully installed mozsystemmonitor 17:17:58 INFO - Cleaning up... 17:17:58 INFO - Return code: 0 17:17:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:58 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 0x7fb040258f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1506770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15959c0>, '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 0x15968c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1596d50>, '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': '00204705a9daa57ed339a427000001b9-1463787216.969482-232306169', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:17:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:17:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:17:58 INFO - Using env: {'DISPLAY': ':0', 17:17:58 INFO - 'HOME': '/home/cltbld', 17:17:58 INFO - 'LANG': 'en_US.UTF-8', 17:17:58 INFO - 'LANGUAGE': 'en_US:en', 17:17:58 INFO - 'LOGNAME': 'cltbld', 17:17:58 INFO - 'MAIL': '/var/mail/cltbld', 17:17:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:58 INFO - 'MOZ_NO_REMOTE': '1', 17:17:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:58 INFO - 'NO_EM_RESTART': '1', 17:17:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:58 INFO - 'PWD': '/builds/slave/test', 17:17:58 INFO - 'SHELL': '/bin/bash', 17:17:58 INFO - 'SHLVL': '1', 17:17:58 INFO - 'TERM': 'linux', 17:17:58 INFO - 'TMOUT': '86400', 17:17:58 INFO - 'USER': 'cltbld', 17:17:58 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1463787216.969482-232306169', 17:17:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:58 INFO - '_': '/tools/buildbot/bin/python'} 17:17:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:59 INFO - Downloading/unpacking blobuploader==1.2.4 17:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:01 INFO - Downloading blobuploader-1.2.4.tar.gz 17:18:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:18:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:18:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:01 INFO - Downloading docopt-0.6.1.tar.gz 17:18:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:18:01 INFO - Installing collected packages: blobuploader, requests, docopt 17:18:01 INFO - Running setup.py install for blobuploader 17:18:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:18:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:18:01 INFO - Running setup.py install for requests 17:18:02 INFO - Running setup.py install for docopt 17:18:02 INFO - Successfully installed blobuploader requests docopt 17:18:02 INFO - Cleaning up... 17:18:02 INFO - Return code: 0 17:18:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:18:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:02 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 0x7fb040258f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1506770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15959c0>, '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 0x15968c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1596d50>, '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': '00204705a9daa57ed339a427000001b9-1463787216.969482-232306169', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:18:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:18:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:18:02 INFO - Using env: {'DISPLAY': ':0', 17:18:02 INFO - 'HOME': '/home/cltbld', 17:18:02 INFO - 'LANG': 'en_US.UTF-8', 17:18:02 INFO - 'LANGUAGE': 'en_US:en', 17:18:02 INFO - 'LOGNAME': 'cltbld', 17:18:02 INFO - 'MAIL': '/var/mail/cltbld', 17:18:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:02 INFO - 'MOZ_NO_REMOTE': '1', 17:18:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:02 INFO - 'NO_EM_RESTART': '1', 17:18:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:02 INFO - 'PWD': '/builds/slave/test', 17:18:02 INFO - 'SHELL': '/bin/bash', 17:18:02 INFO - 'SHLVL': '1', 17:18:02 INFO - 'TERM': 'linux', 17:18:02 INFO - 'TMOUT': '86400', 17:18:02 INFO - 'USER': 'cltbld', 17:18:02 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1463787216.969482-232306169', 17:18:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:02 INFO - '_': '/tools/buildbot/bin/python'} 17:18:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:18:02 INFO - Running setup.py (path:/tmp/pip-b5C_NU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:18:02 INFO - Running setup.py (path:/tmp/pip-bYxHQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:18:02 INFO - Running setup.py (path:/tmp/pip-TJRXC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:18:02 INFO - Running setup.py (path:/tmp/pip-3_rjWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:18:02 INFO - Running setup.py (path:/tmp/pip-zDzija-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:18:03 INFO - Running setup.py (path:/tmp/pip-5FRE7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:18:03 INFO - Running setup.py (path:/tmp/pip-zkKgjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:18:03 INFO - Running setup.py (path:/tmp/pip-bZ29VP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:18:03 INFO - Running setup.py (path:/tmp/pip-9t7a3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:18:03 INFO - Running setup.py (path:/tmp/pip-A47AxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:18:03 INFO - Running setup.py (path:/tmp/pip-2IFnYq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:18:03 INFO - Running setup.py (path:/tmp/pip-ztH3PV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:18:03 INFO - Running setup.py (path:/tmp/pip-OFLrtZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:18:03 INFO - Running setup.py (path:/tmp/pip-M1Bk0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:18:03 INFO - Running setup.py (path:/tmp/pip-7ZgEdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:18:03 INFO - Running setup.py (path:/tmp/pip-M3TSMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:18:03 INFO - Running setup.py (path:/tmp/pip-cigMe7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:18:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:18:03 INFO - Running setup.py install for manifestparser 17:18:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:18:04 INFO - Running setup.py install for mozcrash 17:18:04 INFO - Running setup.py install for mozdebug 17:18:04 INFO - Running setup.py install for mozdevice 17:18:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:18:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:18:04 INFO - Running setup.py install for mozfile 17:18:04 INFO - Running setup.py install for mozhttpd 17:18:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:18:04 INFO - Running setup.py install for mozinfo 17:18:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:18:04 INFO - Running setup.py install for mozInstall 17:18:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:18:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:18:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:18:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:18:04 INFO - Running setup.py install for mozleak 17:18:04 INFO - Running setup.py install for mozlog 17:18:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:18:04 INFO - Running setup.py install for moznetwork 17:18:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:18:05 INFO - Running setup.py install for mozprocess 17:18:05 INFO - Running setup.py install for mozprofile 17:18:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:18:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:18:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:18:05 INFO - Running setup.py install for mozrunner 17:18:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:18:05 INFO - Running setup.py install for mozscreenshot 17:18:05 INFO - Running setup.py install for moztest 17:18:05 INFO - Running setup.py install for mozversion 17:18:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:18:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:18:05 INFO - Cleaning up... 17:18:05 INFO - Return code: 0 17:18:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:18:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:05 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 0x7fb040258f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1506770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15959c0>, '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 0x15968c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1596d50>, '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': '00204705a9daa57ed339a427000001b9-1463787216.969482-232306169', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:18:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:18:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:18:05 INFO - Using env: {'DISPLAY': ':0', 17:18:05 INFO - 'HOME': '/home/cltbld', 17:18:05 INFO - 'LANG': 'en_US.UTF-8', 17:18:05 INFO - 'LANGUAGE': 'en_US:en', 17:18:05 INFO - 'LOGNAME': 'cltbld', 17:18:05 INFO - 'MAIL': '/var/mail/cltbld', 17:18:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:05 INFO - 'MOZ_NO_REMOTE': '1', 17:18:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:05 INFO - 'NO_EM_RESTART': '1', 17:18:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:05 INFO - 'PWD': '/builds/slave/test', 17:18:05 INFO - 'SHELL': '/bin/bash', 17:18:05 INFO - 'SHLVL': '1', 17:18:05 INFO - 'TERM': 'linux', 17:18:05 INFO - 'TMOUT': '86400', 17:18:05 INFO - 'USER': 'cltbld', 17:18:05 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1463787216.969482-232306169', 17:18:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:05 INFO - '_': '/tools/buildbot/bin/python'} 17:18:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:18:05 INFO - Running setup.py (path:/tmp/pip-NdH3DE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:18:05 INFO - Running setup.py (path:/tmp/pip-1Rx1L4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:18:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:18:06 INFO - Running setup.py (path:/tmp/pip-TKM5Cb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:18:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:18:06 INFO - Running setup.py (path:/tmp/pip-b5s_Qd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:18:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:18:06 INFO - Running setup.py (path:/tmp/pip-N9ZiRl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:18:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:18:06 INFO - Running setup.py (path:/tmp/pip-2itHyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:18:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:18:06 INFO - Running setup.py (path:/tmp/pip-Y1dt0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:18:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:18:06 INFO - Running setup.py (path:/tmp/pip-vJtlYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:18:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:18:06 INFO - Running setup.py (path:/tmp/pip-8i87jz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:18:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:18:06 INFO - Running setup.py (path:/tmp/pip-FqytrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:18:06 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)) 17:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:18:06 INFO - Running setup.py (path:/tmp/pip-s8jWmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:18:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:18:06 INFO - Running setup.py (path:/tmp/pip-g8CNOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:18:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:18:06 INFO - Running setup.py (path:/tmp/pip-s9xAEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:18:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:18:06 INFO - Running setup.py (path:/tmp/pip-cGz9NR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:18:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:18:06 INFO - Running setup.py (path:/tmp/pip-8sYCjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:18:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:18:06 INFO - Running setup.py (path:/tmp/pip-_h50O2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:18:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:18:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:18:07 INFO - Running setup.py (path:/tmp/pip-moER19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:18:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:18:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:18:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:18:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:18:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:18:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:18:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:18:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:08 INFO - Downloading blessings-1.6.tar.gz 17:18:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:18:09 INFO - Installing collected packages: blessings 17:18:09 INFO - Running setup.py install for blessings 17:18:09 INFO - Successfully installed blessings 17:18:09 INFO - Cleaning up... 17:18:09 INFO - Return code: 0 17:18:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:18:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:18:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:18:09 INFO - Reading from file tmpfile_stdout 17:18:09 INFO - Current package versions: 17:18:09 INFO - argparse == 1.2.1 17:18:09 INFO - blessings == 1.6 17:18:09 INFO - blobuploader == 1.2.4 17:18:09 INFO - docopt == 0.6.1 17:18:09 INFO - manifestparser == 1.1 17:18:09 INFO - mozInstall == 1.12 17:18:09 INFO - mozcrash == 0.17 17:18:09 INFO - mozdebug == 0.1 17:18:09 INFO - mozdevice == 0.48 17:18:09 INFO - mozfile == 1.2 17:18:09 INFO - mozhttpd == 0.7 17:18:09 INFO - mozinfo == 0.9 17:18:09 INFO - mozleak == 0.1 17:18:09 INFO - mozlog == 3.2 17:18:09 INFO - moznetwork == 0.27 17:18:09 INFO - mozprocess == 0.22 17:18:09 INFO - mozprofile == 0.28 17:18:09 INFO - mozrunner == 6.11 17:18:09 INFO - mozscreenshot == 0.1 17:18:09 INFO - mozsystemmonitor == 0.3 17:18:09 INFO - moztest == 0.7 17:18:09 INFO - mozversion == 1.4 17:18:09 INFO - psutil == 3.1.1 17:18:09 INFO - requests == 1.2.3 17:18:09 INFO - wsgiref == 0.1.2 17:18:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:18:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:09 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 0x7fb040258f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1506770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15959c0>, '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 0x15968c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1596d50>, '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': '00204705a9daa57ed339a427000001b9-1463787216.969482-232306169', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:18:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:18:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:18:09 INFO - Using env: {'DISPLAY': ':0', 17:18:09 INFO - 'HOME': '/home/cltbld', 17:18:09 INFO - 'LANG': 'en_US.UTF-8', 17:18:09 INFO - 'LANGUAGE': 'en_US:en', 17:18:09 INFO - 'LOGNAME': 'cltbld', 17:18:09 INFO - 'MAIL': '/var/mail/cltbld', 17:18:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:09 INFO - 'MOZ_NO_REMOTE': '1', 17:18:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:09 INFO - 'NO_EM_RESTART': '1', 17:18:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:09 INFO - 'PWD': '/builds/slave/test', 17:18:09 INFO - 'SHELL': '/bin/bash', 17:18:09 INFO - 'SHLVL': '1', 17:18:09 INFO - 'TERM': 'linux', 17:18:09 INFO - 'TMOUT': '86400', 17:18:09 INFO - 'USER': 'cltbld', 17:18:09 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1463787216.969482-232306169', 17:18:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:09 INFO - '_': '/tools/buildbot/bin/python'} 17:18:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:18:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:18:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:18:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:18:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:18:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:18:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:18:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:18:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:18:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:18:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:18:09 INFO - Cleaning up... 17:18:09 INFO - Return code: 0 17:18:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:18:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:09 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 0x7fb040258f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1506770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15959c0>, '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 0x15968c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1596d50>, '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': '00204705a9daa57ed339a427000001b9-1463787216.969482-232306169', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:18:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:18:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:18:09 INFO - Using env: {'DISPLAY': ':0', 17:18:09 INFO - 'HOME': '/home/cltbld', 17:18:09 INFO - 'LANG': 'en_US.UTF-8', 17:18:09 INFO - 'LANGUAGE': 'en_US:en', 17:18:09 INFO - 'LOGNAME': 'cltbld', 17:18:09 INFO - 'MAIL': '/var/mail/cltbld', 17:18:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:09 INFO - 'MOZ_NO_REMOTE': '1', 17:18:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:09 INFO - 'NO_EM_RESTART': '1', 17:18:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:09 INFO - 'PWD': '/builds/slave/test', 17:18:09 INFO - 'SHELL': '/bin/bash', 17:18:09 INFO - 'SHLVL': '1', 17:18:09 INFO - 'TERM': 'linux', 17:18:09 INFO - 'TMOUT': '86400', 17:18:09 INFO - 'USER': 'cltbld', 17:18:09 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1463787216.969482-232306169', 17:18:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:09 INFO - '_': '/tools/buildbot/bin/python'} 17:18:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:09 INFO - Downloading/unpacking jsonschema 17:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:18:11 INFO - Downloading/unpacking functools32 (from jsonschema) 17:18:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:12 INFO - Downloading functools32-3.2.3-2.tar.gz 17:18:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:18:12 INFO - warning: no files found matching '*.txt' 17:18:12 INFO - no previously-included directories found matching 'build' 17:18:12 INFO - no previously-included directories found matching 'dist' 17:18:12 INFO - no previously-included directories found matching '.git*' 17:18:12 INFO - Installing collected packages: jsonschema, functools32 17:18:12 INFO - Running setup.py install for functools32 17:18:12 INFO - warning: no files found matching '*.txt' 17:18:12 INFO - no previously-included directories found matching 'build' 17:18:12 INFO - no previously-included directories found matching 'dist' 17:18:12 INFO - no previously-included directories found matching '.git*' 17:18:12 INFO - Successfully installed jsonschema functools32 17:18:12 INFO - Cleaning up... 17:18:12 INFO - Return code: 0 17:18:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:18:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:12 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 0x7fb040258f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1506770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15959c0>, '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 0x15968c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1596d50>, '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': '00204705a9daa57ed339a427000001b9-1463787216.969482-232306169', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:18:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:18:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:18:12 INFO - Using env: {'DISPLAY': ':0', 17:18:12 INFO - 'HOME': '/home/cltbld', 17:18:12 INFO - 'LANG': 'en_US.UTF-8', 17:18:12 INFO - 'LANGUAGE': 'en_US:en', 17:18:12 INFO - 'LOGNAME': 'cltbld', 17:18:12 INFO - 'MAIL': '/var/mail/cltbld', 17:18:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:12 INFO - 'MOZ_NO_REMOTE': '1', 17:18:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:12 INFO - 'NO_EM_RESTART': '1', 17:18:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:12 INFO - 'PWD': '/builds/slave/test', 17:18:12 INFO - 'SHELL': '/bin/bash', 17:18:12 INFO - 'SHLVL': '1', 17:18:12 INFO - 'TERM': 'linux', 17:18:12 INFO - 'TMOUT': '86400', 17:18:12 INFO - 'USER': 'cltbld', 17:18:12 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1463787216.969482-232306169', 17:18:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:12 INFO - '_': '/tools/buildbot/bin/python'} 17:18:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:12 INFO - Downloading/unpacking flake8 17:18:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:18:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:18:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:18:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:18:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:18:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:18:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:18:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:18:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:18:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:18:15 INFO - no previously-included directories found matching 'docs/_build' 17:18:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:18:15 INFO - Running setup.py install for pep8 17:18:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:18:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:18:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:18:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:18:15 INFO - no previously-included directories found matching 'docs/_build' 17:18:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:18:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:18:15 INFO - Cleaning up... 17:18:15 INFO - Return code: 0 17:18:15 INFO - Running post-action listener: _resource_record_post_action 17:18:15 INFO - Running post-action listener: _start_resource_monitoring 17:18:15 INFO - Starting resource monitoring. 17:18:15 INFO - ##### 17:18:15 INFO - ##### Finished create-virtualenv step (success) 17:18:15 INFO - ##### 17:18:15 INFO - ##### 17:18:15 INFO - ##### Running install step. 17:18:15 INFO - ##### 17:18:15 INFO - Running pre-action listener: _resource_record_pre_action 17:18:15 INFO - Running main action method: install 17:18:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:18:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:18:15 INFO - Reading from file tmpfile_stdout 17:18:15 INFO - Detecting whether we're running mozinstall >=1.0... 17:18:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:18:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:18:15 INFO - Reading from file tmpfile_stdout 17:18:15 INFO - Output received: 17:18:15 INFO - Usage: mozinstall [options] installer 17:18:15 INFO - Options: 17:18:15 INFO - -h, --help show this help message and exit 17:18:15 INFO - -d DEST, --destination=DEST 17:18:15 INFO - Directory to install application into. [default: 17:18:15 INFO - "/builds/slave/test"] 17:18:15 INFO - --app=APP Application being installed. [default: firefox] 17:18:15 INFO - mkdir: /builds/slave/test/build/application 17:18:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:18:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:18:31 INFO - Reading from file tmpfile_stdout 17:18:31 INFO - Output received: 17:18:31 INFO - /builds/slave/test/build/application/firefox/firefox 17:18:31 INFO - Running post-action listener: _resource_record_post_action 17:18:31 INFO - ##### 17:18:31 INFO - ##### Finished install step (success) 17:18:31 INFO - ##### 17:18:31 INFO - ##### 17:18:31 INFO - ##### Running run-tests step. 17:18:31 INFO - ##### 17:18:31 INFO - Running pre-action listener: _resource_record_pre_action 17:18:31 INFO - Running main action method: run_tests 17:18:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:18:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:18:31 INFO - Python 2.7.3 17:18:31 INFO - Return code: 0 17:18:31 INFO - grabbing minidump binary from tooltool 17:18:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:31 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 0x15959c0>, '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 0x15968c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1596d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:18:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:18:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:18:31 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 17:18:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:18:31 INFO - Return code: 0 17:18:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:18:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:18:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:18:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:18:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:18:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:18:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:18:32 INFO - Return code: 0 17:18:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:18:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:18:32 INFO - Using env: {'DISPLAY': ':0', 17:18:32 INFO - 'HOME': '/home/cltbld', 17:18:32 INFO - 'LANG': 'en_US.UTF-8', 17:18:32 INFO - 'LANGUAGE': 'en_US:en', 17:18:32 INFO - 'LOGNAME': 'cltbld', 17:18:32 INFO - 'MAIL': '/var/mail/cltbld', 17:18:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:18:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:18:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:32 INFO - 'MOZ_NO_REMOTE': '1', 17:18:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:18:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:32 INFO - 'NO_EM_RESTART': '1', 17:18:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:32 INFO - 'PWD': '/builds/slave/test', 17:18:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:18:32 INFO - 'SHELL': '/bin/bash', 17:18:32 INFO - 'SHLVL': '1', 17:18:32 INFO - 'TERM': 'linux', 17:18:32 INFO - 'TMOUT': '86400', 17:18:32 INFO - 'USER': 'cltbld', 17:18:32 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1463787216.969482-232306169', 17:18:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:32 INFO - '_': '/tools/buildbot/bin/python'} 17:18:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:18:32 INFO - mozversion application_buildid: 20160520160630 17:18:32 INFO - mozversion application_changeset: 45709b7b6466abcd984d5736c0e64eb12b0044cc 17:18:32 INFO - mozversion application_display_name: Nightly 17:18:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:18:32 INFO - mozversion application_name: Firefox 17:18:32 INFO - mozversion application_remotingname: firefox 17:18:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:18:32 INFO - mozversion application_vendor: Mozilla 17:18:32 INFO - mozversion application_version: 49.0a1 17:18:32 INFO - mozversion platform_buildid: 20160520160630 17:18:32 INFO - mozversion platform_changeset: 45709b7b6466abcd984d5736c0e64eb12b0044cc 17:18:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:18:32 INFO - mozversion platform_version: 49.0a1 17:18:32 INFO - using testdate: 1463789912 17:18:32 INFO - actual date: 1463789912 17:18:32 INFO - starting webserver on 'localhost:60378' 17:18:32 INFO - SUITE-START | Running 2 tests 17:18:32 INFO - TEST-START | dromaeo_css 17:18:32 INFO - operating with platform_type : linux_ 17:18:32 INFO - Initialising browser for dromaeo_css test... 17:18:32 INFO - TEST-INFO | started process 21046 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn1nfrm/profile http://localhost:60378/getInfo.html) 17:18:36 INFO - PROCESS | 21046 | 17:18:36 INFO - PROCESS | 21046 | (process:21113): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:18:37 INFO - PROCESS | 21046 | __metrics Screen width/height:1600/1200 17:18:37 INFO - PROCESS | 21046 | colorDepth:24 17:18:37 INFO - PROCESS | 21046 | Browser inner width/height: 1024/697 17:18:37 INFO - PROCESS | 21046 | __metrics 17:18:38 ERROR - PROCESS | 21046 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 17:18:39 INFO - TEST-INFO | 21046: exit 0 17:18:39 INFO - Browser initialized. 17:18:39 INFO - Running cycle 1/1 for dromaeo_css test... 17:18:39 INFO - TEST-INFO | started process 21164 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn1nfrm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:18:41 INFO - PROCESS | 21164 | 17:18:41 INFO - PROCESS | 21164 | (process:21227): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:18:51 INFO - PROCESS | 21164 | RSS: Main: 165269504 17:18:51 INFO - PROCESS | 21164 | 17:19:40 INFO - PROCESS | 21164 | 1463789980684 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:21:52 INFO - PROCESS | 21164 | Cycle 1(1): loaded http://localhost:60378/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60378/tests/dromaeo/cssquery-ext.html) 17:21:53 INFO - PROCESS | 21164 | RSS: Main: 167792640 17:21:53 INFO - PROCESS | 21164 | 17:24:55 INFO - PROCESS | 21164 | Cycle 1(1): loaded http://localhost:60378/tests/dromaeo/cssquery-ext.html (next: http://localhost:60378/tests/dromaeo/cssquery-jquery.html) 17:24:56 INFO - PROCESS | 21164 | RSS: Main: 166912000 17:24:56 INFO - PROCESS | 21164 | 17:27:57 INFO - PROCESS | 21164 | Cycle 1(1): loaded http://localhost:60378/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60378/tests/dromaeo/cssquery-mootools.html) 17:27:58 INFO - PROCESS | 21164 | RSS: Main: 167948288 17:27:58 INFO - PROCESS | 21164 | 17:31:00 INFO - PROCESS | 21164 | Cycle 1(1): loaded http://localhost:60378/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60378/tests/dromaeo/cssquery-prototype.html) 17:31:01 INFO - PROCESS | 21164 | RSS: Main: 165679104 17:31:01 INFO - PROCESS | 21164 | 17:34:03 INFO - PROCESS | 21164 | Cycle 1(1): loaded http://localhost:60378/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60378/tests/dromaeo/cssquery-yui.html) 17:34:04 INFO - PROCESS | 21164 | RSS: Main: 166924288 17:34:04 INFO - PROCESS | 21164 | 17:37:07 INFO - PROCESS | 21164 | Cycle 1(1): loaded http://localhost:60378/tests/dromaeo/cssquery-yui.html (next: http://localhost:60378/tests/dromaeo/cssquery-dojo.html) 17:37:07 INFO - PROCESS | 21164 | RSS: Main: 168685568 17:37:07 INFO - PROCESS | 21164 | 17:37:07 INFO - PROCESS | 21164 | __start_tp_report 17:37:07 INFO - PROCESS | 21164 | _x_x_mozilla_page_load 17:37:07 INFO - PROCESS | 21164 | _x_x_mozilla_page_load_details 17:37:07 INFO - PROCESS | 21164 | |i|pagename|runs| 17:37:07 INFO - PROCESS | 21164 | |0;dojo.html;2662.7337266273375;2701.3246688327918;2722.2513808702615;2725.2641786717586;2742.8902843886244;4693.225617773068;4707.78814953327;4727.90544189116;4808.086463571919;4832.903341933159;4648.674592778507;4767.547083027115;4776.832810851621;4783.42598888133;4813.085513752393;4366.97816510917;4400.537943515933;4477;4496.865094047167;4508.864734057984;4194.370844373338;4439.689221754478;4467.106578684276;4523.819047238107;4525.864224073283;4256.59562341577;4297.570242975708;4325.718828276184;4361.280388735855;4423.4028406165235;4361.389405483234;4370.672199585012;4390.934135987963;4427.291633338683;4432.53458386868;4359.607635312837;4395.58248943466;4406.317020861771;4441.067375851075;4460.353248778942;4595.954040459586;4682.180618391768;4697.412823397075;4703.764811759398;4706.294055891643;5112.156494178456;5118.513741194581;5132.178851383761;5132.28148059272;5174.09453345663;5134.486551344836;5157.045946499909;5173.560247378978;5194.792208311663;5196.8960620787375;4842.854714358575;4850.781714822841;4854.101991131652;4861.586765124968;4891.951080489185;5318.973405133027;5322.36131664195;5322.414534401213;5323.467653234646;5330.360356757136;4887.682300650446;4994;5029.899402011939;5052.191649336089;5092.337996060489;4950.25746138075;5132.666376685578;5137.51193636604;5147.6396652234735;5152.381714194245;5015.573676237488;5061.772220250097;5074.314967479417;5093.439721630618;5106.719130447861;4897.7795999180125;5035.546800787946;5063.1645778446145;5082.1360368737405;5093.770780314895;4406.096750166208;4417.867463976086;4426.822927082881;4456.131054444352;4474.798634061475;3843.55799083109;3847.9230415392094;3868.574456809749;3888.3972984187494;3939.074317535434;4183.895402614959;4366.279563871925;4404;4408;4410.448693913261;5136.280920671109;5177.042247184283;5177.715225662625;5185.092608793446;5250.422453530108;4396.098799746044;4398.384226208269;4406.228909940812;4419.558044195554;4435.866923992286;4475.216837053503;4602.05657840142;4612.262038073892;4663.370444989951;4681.485036645966;4797.088553174885;4813.6483201645115;4816.735079570517;4817.373741413594;4862.927056094161;4942.901141977212;5184.144616138295;5198.142306519533;5201.635885488131;5259.921101183409;4764.547368000034;4769.093872164278;4810.5670489656095;4824.059308434821;4835.516448355136;5097.235414687826;5108.591312694901;5109.565686916505;5113.360829896263;5177.042247184283;4977.402711674622;5111.514406131411;5192.350956130484;5194.091034069098;5194.844154675366;4832.855014349575;4929.630277729113;4974.552290293891;4995.625328100335;5090.465501122477;5005.224190250517;5005.299258103942;5016.824411145592;5018.673786203885;5050.797968081236;4737.123632127929;4892.535209155125;4901.583365413837;4918.8770280743265;4920.901581968412;5021.297018417352;5050.848474545623;5081.314022606901;5095.617828662939;5099.6175286852895;4951.851444456672;4977.875553111201;4991.550760431579;5004;5044.1172794761505 17:37:07 INFO - PROCESS | 21164 | |1;ext.html;545.5564427736088;583.810261664959;592.2064433658902;594.7234535940787;614.0758158970748;39068.60931390689;40343;40420.19159616806;43526.782366088126;43712;40635;40828.18343633126;41158.794206029;41263.79368103163;41275.380869286986;7600.1639819619795;7638.427117966147;7677.884831727529;7692.384609231248;7695.692172313101;7681.462297639167;7823.178566250547;7858.174891636381;7861.2531809478005;7870.921290787076;7795.688172473123;7809.3752499799875;7819.804504887395;7828.178041305667;7899.249571290718;7758.301752842243;7784.338331241851;7796.883046754331;7802.297793198611;7815.570143642098;7762.650680719381;7807.297343239079;7813.218678132198;7816.960915195445;7850.450468467209;37858.62141378578;37983.24033519342;38208.235835283136;38274;38450;3113.984430077835;3155.195425166568;3167;3280.9343813123605;3352.0949343677316;29413.852930735422;29508.852455737582;29526;29532.70467295321;29916.850415748;3211.5182722591567;3277.72139368154;3349.681780230874;3461.3250416168858;3526.5415495985612;277757;277967;278000.6099969507;278924;281119;31837.204069897976;32908.83545582257;56238;56757.43242567604;57063;34388;34395.484067739;34496.310073798384;34517.65482345194;34532.65467345345;11574.247673901169;11606.30362178272;11694.649160525198;11701.239419437708;11706.24406339039;9258.583363748647;9293.67472138472;9351.625934962525;9353.064693530729;9365.672201472917;7943.404244681672;8007.479513831582;8072.233137851895;8089.676412943534;8113.675452981933;3118.7504999600433;3141.5287706844156;3157.400093982182;3172;3196.840157992091;857.8155696525278;904.8823652925078;911.6080085563271;911.7674992876774;924.1313165624292;27853.442931141264;28470.572941405895;28638.284042899093;29040.41919161605;29330.266743331587;922.9169374756304;960.5341409416427;964.2912459342377;975.8926518083006;979.5445118020154;14547.27263636814;14706.485273015393;14996.250187490581;15076;15132.546023619308;387457;390263;391268;392496;394436;48570;48746.512534874906;49083.75458122758;49194;49294.50705492899;1186.9494418394793;1219.914605977573;1221.047582885351;1229.1825935752804;1240.6464157715188;25416.872915636042;26793.464130717668;27209.86395068012;27483.17550473409;27530.862345688143;42248;42480.57519424766;42662.14675706407;42795;42899.5710042908;313587;320075;320101;320124;322546;23542.88228558915;23886.761132388452;24119.879400602884;24131.63802542928;24140.155094572307;41661;42822.571774283104;43055.1388972225;43238.78380608077;43800;36655.633443665225;37051.25897482089;37091.07272318214;37242.44136337903;37298.440523391626;34576.30847382988;36326.27347453089;36572;36685.81657091698;36955.63044369522;31102.37795244128;35366.46950295799;35625.643743562236;36235.45646815353;36927.63072369242;32119.678803212602;33113.834430827694;33719.32561348809;33864;34125.82937085299;25234.495310094062;25540.2337929855;25735.485290294462;25843.353916152246;25899.61150582705 17:37:07 INFO - PROCESS | 21164 | |2;jquery.html;365.34238370932326;366.29853829915703;369.6691461142278;379.8081968605857;383.0462149248372;15169.2415379231;15660.608484787886;16831.663366732675;16860.74708879368;16914.74627880583;15213.391464341414;16094.678106437865;16653.25060372283;16690.916545417287;16720.08039557824;5022.974885125578;5183.688978661293;5217.034848553029;5217.921731174036;5220.425753167148;5020.924686129711;5162.8193013244545;5215.035218484573;5217.921731174036;5239.790408383679;5058.822941197059;5110.259012443194;5121.28302037715;5122.3084883540805;5144.8971020579565;4875.390576177978;5070.619703522232;5073.162928116893;5101.744912754366;5113.718745468997;4566.406367172246;4593.954060459386;4595;4600.631949444037;4602.677812553123;19229.326973556;19614.803851961584;20317.18731250748;20337.18651253948;20352;1951.834094102003;1975.0815870620231;2006.147387360366;2106.29439137889;2276.2943487518924;8647.178518040777;13181.60455186346;13342.866571334356;13716.862831371758;13718.519851805238;1624.7969003874516;1626.8047834259846;1734.3496188929153;1770.9557261068448;1779.172684701607;51114.48885511135;58786.70606646939;59733.70133149307;70588.29408208012;72374.63812680903;9721.173700235418;9824.312298139062;10072.798544029078;10105.191584673208;10182.592696292066;13758.862411375958;13995.650108747363;14074.788878166835;14096.224707640973;14158.150510969375;6385.904211436832;6390.169277993831;6508.544401891822;6587.73649054042;6621.569597976212;5488.890222195534;5551.084071128299;5574.16387541872;5594.720263986785;5793.884122317614;4318.762468064224;4364.934525982113;4395.516493185747;4481.1933851906315;4527.818887244473;1850.7964123946356;1861.1252711225702;1890.886546807196;1901.7622797150357;1932.6327997680396;906.6917248135666;931.5156118818177;943.8301105801022;987.713563066717;990.9058639429243;16119.435819746253;16776.916115419346;16899.662006759794;17121.571960701083;17386.47840564785;857.9142085791495;883.2271762208068;890.3633901760272;920.406337912043;952.1668540027476;9447.716568502956;9641.903580964101;9720.07659272382;9740.659076932274;9887.700774014602;392493;405709;406386;410372;410680;71806.64096679483;74673.62663186758;75167.62416187883;75636;76679;909.981800363989;921.4149015375151;927.7587827164986;938.2306508662967;940.041158018817;15014.47449339268;15032.92483537619;15059.924700376867;15099.924500377429;15420.768688469458;35006.64993350034;35183.29633407369;35189.47215791714;35881.64118358783;36343.74704767958;48141.518584813704;49158.26262605992;49544.50455495399;49816.50183498119;49861.750691246314;7408.296211859864;7411.8147046324275;7493.325600695745;7544.0569928758905;7586.279303466162;10014.449205293779;10873.184511161853;10905.890941090487;10940.671779846618;11117.666470005914;9348.485833279236;9446.811063778823;9451.621935122794;9530.571124299562;9846.60613575449;4961.578265847444;9445.858312125187;9701;9715.902840971783;9885.752856178653;9278.164965153168;9564;9788.853167202355;9875.604975800887;10106.595736170471;7294.854102918018;7375.8156046099275;7407.8148046299275;7554.169041405331;7556;9417.952910235404;9428.15146636806;9581.808363832824;9598;9643.27675424332 17:37:07 INFO - PROCESS | 21164 | |3;mootools.html;1433.512605714057;1460.6348412896775;1568.2707540993435;1742.128935532234;1750.439859245042;6791.320867913206;7522.586257755821;7558.659860306286;8063.314618257448;8068.072171700249;7703.268189522;7987.440879138463;8036;8043.6380362883665;8053.557054362008;2215.2246713650215;2245.6743772153027;2260.050778672953;2260.864348139117;2266.1841736974757;2172.5654869026257;2185.67214917762;2250.414892128042;2253.8985745641485;2259.2996171186983;2196.6814811852273;2206.293985924505;2206.9889650551727;2239.5632851593946;2271.068861766676;2146.806787389127;2152.5156839711094;2161.2111579273533;2169.663702126173;2174.1194816099505;2128.435964469417;2132.41358626379;2132.6800979853147;2152.4726442021806;2154.3213887625348;7958.721444749463;7992.400569957276;8003.079645840687;8009.239122283374;8054.758357249233;4320.7839608019785;4414.977925110386;4416.24923762961;4424.690271680984;4431.423914891076;2731.1533424638424;2785.7632101271215;2884;2894.1028281232675;2900.7244311790346;825.636719843273;862.361852229352;875.2516598308482;878.2490970220497;881.7795551112222;10538.156947444186;10610.416427096507;10620.415877126756;10647.57409703611;10705.83941240882;4211.957880421157;4265.1469706058915;4355.259605867011;4366.083122544238;4387.495438024668;9182;9250.67622633218;9251.90748092524;9255.67605133817;9267.702521646976;4450.554944505524;4496.348029535764;4510.1656193604285;4554.4990051094355;4563.54364563541;3552.6802587767224;4009.578994205625;4082.346824508124;4090.8159132839096;4145.2952997990415;3710.888673339804;3729.1422972716427;3837.347650899298;3845.2117315950163;3959;1185.8754830742648;1195.0738177912187;1198.7003249187703;1205.7588482303574;1212.6847019774923;852.3138873207004;862.5385418801037;866.2204016385303;876.075740094194;892.4734406700078;5400.783968641289;5444.346678398618;5461.7276589401035;5489.533389661844;5610.831675049673;402.4385981555772;413.6298013278099;416.4128578704013;417.75352542000365;422.10724318067065;3804.410316400962;3944.1914407546383;3959.366501359826;3982.761034337949;4018.6985976051915;9406.38858474197;9738.074882886114;9753.707388778348;9760.267979901535;9786.217102631916;9144.588493517675;9594.60878172661;9599.376040557341;9679.758006049906;9878.753031174134;7269.382102521345;7387.482876198722;7402.74090406844;7435.591042492715;7461.738839140604;5427.6200665953;5546.750396232099;5676;5676.148577713376;5706.629069110494;8641.95679021626;8771.16673915977;8904.688335908211;8964.417312874642;8974.01285858568;8426.578671066545;8880.245179159843;8959.41763785352;8965.058668839678;9211.710360549394;5933.940660593512;6397.776077837253;6700.095487109178;6772.627505487048;6829.419499342612;7603.505772124794;7639.923600763921;7657.846843063219;7664.80837979055;7721.961390193013;6692.933070669231;7007.194172670208;7058.470614703815;7099.609521476368;7195.316444937723;6902.309769023258;6915.965420173068;6922.965385173042;7045.929540704732;7081.645917704197;6182.917989351936;6525.8694826104165;6526.24948130971;6541;6672.232693240339;4784;4802.51974802517;4879.268109783561;4884.340614017205;4900.779464924159;4832.130216561053;4862.610991120772;4871;4888.413390393175;4893.926591101065 17:37:07 INFO - PROCESS | 21164 | |4;prototype.html;291.09034267912773;298.62075164541034;299.75120649860617;301.3175158266526;303.89819410497483;4926.408830940292;5034.370703662043;5136.922946155806;5140.999999999995;5161.148410512265;4874.902501949968;5040.949590504094;5044.596432285418;5057;5075.010372977271;3992.361222204448;3998.980005099978;4019.437278780973;4027.375756757707;4056.127932494513;3924.5879182685835;4003.898927794851;4021.3163762160357;4021.822760019581;4037.939430908524;3962.128331767007;3977.2244412339605;3977.482927219472;3978.4629075074786;4001.619846114629;3959.5050618672667;3998.480197574311;4002.2795896738576;4019.196160767829;4026.1947610477728;3574.58803772511;3577.7853328800356;3579;3579.1231148368815;3583.62371950944;4713.387259656257;4855.805767769285;4867.8783030424165;4874.951250487486;4944.307796908436;4506.932396014063;4510.345999830039;4531.388262584542;4534.79593418297;4539.364488971547;5196.428392876781;5267.499587539178;5278.706716854395;5286.524212820865;5303.7082960437165;3419.5212670226188;3635.218428037958;3653.7077033837495;3849.788261645608;3852.306584814732;5514.255575497296;5571.8885622287735;5588.636738611977;5595.440455954413;5614.466625670596;3856.46009558662;3856.749311294757;3862.5364956205435;3871.303165430193;3879.631435013669;3691.1325838427947;3889.436031775433;3890.4747859039235;3909.706771992112;3921.5882332355263;4413.3821265022925;4427.29163333865;4427.490838553543;4432.445944256968;4487.237169681162;5252.632315737938;5299.5760339172775;5317.335333083364;5330.600204984564;5357.151782634985;1246.1588427811191;1305.6344223617402;1344.5764584156154;1350.770369037266;1360.5850215684113;841.4110122913985;850.7532815483564;871.2507243770352;872.1801506583791;875.0112373018576;4078.9796051019557;4098.323776576832;4105.91788164235;4134;4182.644475219579;4847.40035788189;4888.560029597354;4889.215436365772;4898.608111351084;4910.238912968495;4112.157007813451;4139.234241665302;4141.302066152863;4146.854860079883;4169.958300417018;2623.698274698396;2745.450909818004;2967.213688372583;2980.418818330405;2987.327851233455;5176;5184.429712731597;5214.418862663006;5221.582273418194;5224.7126408047925;5312.389075256395;5581.441855814386;5585;5587.38538760736;5596.3284405871555;5130.743462826844;5135.281060651511;5160.7935682573025;5176.4047134578495;5178.171492561097;5540.196671482693;5551.333839939233;5557.583181261502;5563.276774019351;5570.328901329503;5283.882509319366;5413.323334583177;5433.809816656398;5472.890542189213;5474.507294343528;5102.642815003062;5137.6660517066275;5168.664036837594;5200.60995425337;5209.6092793041435;3775.3393156197008;3816.778630838105;3821;3825;3876.9418458722575;5255.7925671218945;5423.430539793265;5581.9162712560155;5601.467860553241;5660.632058916157;5123.74381280927;5308.575313974796;5310.256564081109;5318.574514038945;5333.813316533902;5322.574194064543;5336.866578335573;5345.492178243061;5365.463453654604;5370.248165256945;4970.478099799469;5145.048166089286;5157.510036546522;5203.323567936295;5294.311739473844;5420.593455490775;5428.7557059931605;5431.592630552804;5437.13005919051;5461.754221060141;5266.762995665128;5294.841154765363;5301.522862942354;5319;5382.246485491956 17:37:07 INFO - PROCESS | 21164 | |5;yui.html;680.0784936411164;706.5795851468376;713.1270770691565;760.2283682062707;785.4698078796818;11830.349330786803;12526.436310366033;12536.999999999989;12558.246505209694;12560.246385216893;11571.594994175206;11573.363465009443;11590.188686791927;11605.767884642322;11616.593419230328;611.6360765344613;750.0511852506584;757.6476938223739;774.7908064822494;775.5928137727682;751.7631945937039;758.3288789421347;760.9239076092374;762.8779395296754;763.496092578898;821.2936874288107;827.6027506796742;831.1605278668528;833.8790875323075;834.7287131682198;817.795551112216;822.1655020154548;826.8759686047081;826.9338452923752;827.0447632983883;601.2184160591214;602.8975074237391;603.4267445926343;604.1029071828332;604.1360853978808;12547.435365408579;12599.811002834966;12605.621831345074;12608;12618.305993170372;12357.691057723629;12650.240985540897;12724.300163491005;12725.236485810789;12941.029422793328;9749.658761943298;10554.208434367376;10804.459777011118;11029.503672334684;11113.611023614134;4052.6150015748754;4067.3085575452246;4122.2786012448005;4189.91620167598;4238.385434112037;45448;45546.316805247945;45693;46150.30774538385;46239;9450.85823712645;9580.856287155699;9591.184749296248;9657.806843863083;10077.697669069794;16539.25573349202;16614.83385166157;16667.24997375121;16831.242594083295;16835.158242087848;6354.618722876642;6525.086487891699;6625.503087268474;6654.367835055662;6786.117804685359;3631.1829838286176;3683.944740828836;3715.5727091384297;3720.069982504374;3793.962060379416;2642.960355594629;2736.65791776028;2737;2743.4513097380604;2749.8625068746483;503.93952725673154;506.3898002906489;509.76041260607457;515.6261710260031;518.2071430711018;597.4801922327603;616.2450997528082;618.0844351036146;620.6152185644929;627.6108812536256;7493.4379921505015;7506;7522.623868806538;7661.157272699998;7667.693292268358;496.96878976124685;567.4920945753528;598.643806934873;604.1813342920368;605.3039005144032;3786.110264087992;3807.809609519513;3845.288621605012;3846.211526637033;3877.515310586177;53821;54364.72817635886;54748.72625636846;54840;55075.17387239195;26604;50340.74829625829;51159.74420127876;52034.47965520372;52368.47631523636;45552.772236138604;47229.76385118053;47657;47684;48272;7466;8380.120087390736;8499.277561407349;8530.274926631306;8650.26472749798;30959.226019349695;32776.67223327832;33317.16707082342;33964.150896227795;34607.13482162966;40764.79617601893;43466.348004780586;44503.33245001392;44507.55492445034;44744.42044636356;11497.885021149681;11507.424628768695;11523.250988685708;11632.18574699763;11968.640940771791;11577.131715121568;12102.636920892388;12128;12163.087768417226;12337.814932776195;10011.949940250544;10248.487575621339;10740.946295268473;11292.491837867152;11837.467313971065;11472.254303470248;11472.655820325404;11490.77018459643;11999.340036298088;12081.093917956012;10911.072558832271;10960;11009.174311926477;11083.445827708421;11225.494852731483;9553.754867605969;9663.9033609663;9702.951485242529;9779.706608801747;9986.650467233612;8531.786705332168;8560.529170895661;8632.827343453222;8647.135286471303;8932.86600700977 17:37:07 INFO - PROCESS | 21164 | __end_tp_report 17:37:07 INFO - PROCESS | 21164 | __start_cc_report 17:37:07 INFO - PROCESS | 21164 | _x_x_mozilla_cycle_collect,375 17:37:07 INFO - PROCESS | 21164 | __end_cc_report 17:37:07 INFO - PROCESS | 21164 | __startTimestamp1463791027378__endTimestamp 17:37:07 INFO - PROCESS | 21164 | 17:37:07 INFO - PROCESS | 21164 | ------- Summary: start ------- 17:37:07 INFO - PROCESS | 21164 | Number of tests: 6 17:37:07 INFO - PROCESS | 21164 | 17:37:07 INFO - PROCESS | 21164 | [#0] dojo.html Cycles:165 Average:4741.21 Median:4850.78 stddev:494.06 (10.2%) stddev-sans-first:467.90 17:37:07 INFO - PROCESS | 21164 | Values: 2662.7 2701.3 2722.3 2725.3 2742.9 4693.2 4707.8 4727.9 4808.1 4832.9 4648.7 4767.5 4776.8 4783.4 4813.1 4367.0 4400.5 4477.0 4496.9 4508.9 4194.4 4439.7 4467.1 4523.8 4525.9 4256.6 4297.6 4325.7 4361.3 4423.4 4361.4 4370.7 4390.9 4427.3 4432.5 4359.6 4395.6 4406.3 4441.1 4460.4 4596.0 4682.2 4697.4 4703.8 4706.3 5112.2 5118.5 5132.2 5132.3 5174.1 5134.5 5157.0 5173.6 5194.8 5196.9 4842.9 4850.8 4854.1 4861.6 4892.0 5319.0 5322.4 5322.4 5323.5 5330.4 4887.7 4994.0 5029.9 5052.2 5092.3 4950.3 5132.7 5137.5 5147.6 5152.4 5015.6 5061.8 5074.3 5093.4 5106.7 4897.8 5035.5 5063.2 5082.1 5093.8 4406.1 4417.9 4426.8 4456.1 4474.8 3843.6 3847.9 3868.6 3888.4 3939.1 4183.9 4366.3 4404.0 4408.0 4410.4 5136.3 5177.0 5177.7 5185.1 5250.4 4396.1 4398.4 4406.2 4419.6 4435.9 4475.2 4602.1 4612.3 4663.4 4681.5 4797.1 4813.6 4816.7 4817.4 4862.9 4942.9 5184.1 5198.1 5201.6 5259.9 4764.5 4769.1 4810.6 4824.1 4835.5 5097.2 5108.6 5109.6 5113.4 5177.0 4977.4 5111.5 5192.4 5194.1 5194.8 4832.9 4929.6 4974.6 4995.6 5090.5 5005.2 5005.3 5016.8 5018.7 5050.8 4737.1 4892.5 4901.6 4918.9 4920.9 5021.3 5050.8 5081.3 5095.6 5099.6 4951.9 4977.9 4991.6 5004.0 5044.1 17:37:07 INFO - PROCESS | 21164 | 17:37:07 INFO - PROCESS | 21164 | [#1] ext.html Cycles:180 Average:47179.90 Median:37270.44 stddev:87889.69 (235.8%) stddev-sans-first:88066.50 17:37:07 INFO - PROCESS | 21164 | Values: 545.6 583.8 592.2 594.7 614.1 39068.6 40343.0 40420.2 43526.8 43712.0 40635.0 40828.2 41158.8 41263.8 41275.4 7600.2 7638.4 7677.9 7692.4 7695.7 7681.5 7823.2 7858.2 7861.3 7870.9 7795.7 7809.4 7819.8 7828.2 7899.2 7758.3 7784.3 7796.9 7802.3 7815.6 7762.7 7807.3 7813.2 7817.0 7850.5 37858.6 37983.2 38208.2 38274.0 38450.0 3114.0 3155.2 3167.0 3280.9 3352.1 29413.9 29508.9 29526.0 29532.7 29916.9 3211.5 3277.7 3349.7 3461.3 3526.5 277757.0 277967.0 278000.6 278924.0 281119.0 31837.2 32908.8 56238.0 56757.4 57063.0 34388.0 34395.5 34496.3 34517.7 34532.7 11574.2 11606.3 11694.6 11701.2 11706.2 9258.6 9293.7 9351.6 9353.1 9365.7 7943.4 8007.5 8072.2 8089.7 8113.7 3118.8 3141.5 3157.4 3172.0 3196.8 857.8 904.9 911.6 911.8 924.1 27853.4 28470.6 28638.3 29040.4 29330.3 922.9 960.5 964.3 975.9 979.5 14547.3 14706.5 14996.3 15076.0 15132.5 387457.0 390263.0 391268.0 392496.0 394436.0 48570.0 48746.5 49083.8 49194.0 49294.5 1186.9 1219.9 1221.0 1229.2 1240.6 25416.9 26793.5 27209.9 27483.2 27530.9 42248.0 42480.6 42662.1 42795.0 42899.6 313587.0 320075.0 320101.0 320124.0 322546.0 23542.9 23886.8 24119.9 24131.6 24140.2 41661.0 42822.6 43055.1 43238.8 43800.0 36655.6 37051.3 37091.1 37242.4 37298.4 34576.3 36326.3 36572.0 36685.8 36955.6 31102.4 35366.5 35625.6 36235.5 36927.6 32119.7 33113.8 33719.3 33864.0 34125.8 25234.5 25540.2 25735.5 25843.4 25899.6 17:37:07 INFO - PROCESS | 21164 | 17:37:07 INFO - PROCESS | 21164 | [#2] jquery.html Cycles:180 Average:24212.03 Median:5021.95 stddev:66672.86 (1327.6%) stddev-sans-first:66835.85 17:37:07 INFO - PROCESS | 21164 | Values: 365.3 366.3 369.7 379.8 383.0 15169.2 15660.6 16831.7 16860.7 16914.7 15213.4 16094.7 16653.3 16690.9 16720.1 5023.0 5183.7 5217.0 5217.9 5220.4 5020.9 5162.8 5215.0 5217.9 5239.8 5058.8 5110.3 5121.3 5122.3 5144.9 4875.4 5070.6 5073.2 5101.7 5113.7 4566.4 4594.0 4595.0 4600.6 4602.7 19229.3 19614.8 20317.2 20337.2 20352.0 1951.8 1975.1 2006.1 2106.3 2276.3 8647.2 13181.6 13342.9 13716.9 13718.5 1624.8 1626.8 1734.3 1771.0 1779.2 51114.5 58786.7 59733.7 70588.3 72374.6 9721.2 9824.3 10072.8 10105.2 10182.6 13758.9 13995.7 14074.8 14096.2 14158.2 6385.9 6390.2 6508.5 6587.7 6621.6 5488.9 5551.1 5574.2 5594.7 5793.9 4318.8 4364.9 4395.5 4481.2 4527.8 1850.8 1861.1 1890.9 1901.8 1932.6 906.7 931.5 943.8 987.7 990.9 16119.4 16776.9 16899.7 17121.6 17386.5 857.9 883.2 890.4 920.4 952.2 9447.7 9641.9 9720.1 9740.7 9887.7 392493.0 405709.0 406386.0 410372.0 410680.0 71806.6 74673.6 75167.6 75636.0 76679.0 910.0 921.4 927.8 938.2 940.0 15014.5 15032.9 15059.9 15099.9 15420.8 35006.6 35183.3 35189.5 35881.6 36343.7 48141.5 49158.3 49544.5 49816.5 49861.8 7408.3 7411.8 7493.3 7544.1 7586.3 10014.4 10873.2 10905.9 10940.7 11117.7 9348.5 9446.8 9451.6 9530.6 9846.6 4961.6 9445.9 9701.0 9715.9 9885.8 9278.2 9564.0 9788.9 9875.6 10106.6 7294.9 7375.8 7407.8 7554.2 7556.0 9418.0 9428.2 9581.8 9598.0 9643.3 17:37:07 INFO - PROCESS | 21164 | 17:37:07 INFO - PROCESS | 21164 | [#3] mootools.html Cycles:180 Average:5195.76 Median:5414.20 stddev:2904.90 (53.7%) stddev-sans-first:2899.29 17:37:07 INFO - PROCESS | 21164 | Values: 1433.5 1460.6 1568.3 1742.1 1750.4 6791.3 7522.6 7558.7 8063.3 8068.1 7703.3 7987.4 8036.0 8043.6 8053.6 2215.2 2245.7 2260.1 2260.9 2266.2 2172.6 2185.7 2250.4 2253.9 2259.3 2196.7 2206.3 2207.0 2239.6 2271.1 2146.8 2152.5 2161.2 2169.7 2174.1 2128.4 2132.4 2132.7 2152.5 2154.3 7958.7 7992.4 8003.1 8009.2 8054.8 4320.8 4415.0 4416.2 4424.7 4431.4 2731.2 2785.8 2884.0 2894.1 2900.7 825.6 862.4 875.3 878.2 881.8 10538.2 10610.4 10620.4 10647.6 10705.8 4212.0 4265.1 4355.3 4366.1 4387.5 9182.0 9250.7 9251.9 9255.7 9267.7 4450.6 4496.3 4510.2 4554.5 4563.5 3552.7 4009.6 4082.3 4090.8 4145.3 3710.9 3729.1 3837.3 3845.2 3959.0 1185.9 1195.1 1198.7 1205.8 1212.7 852.3 862.5 866.2 876.1 892.5 5400.8 5444.3 5461.7 5489.5 5610.8 402.4 413.6 416.4 417.8 422.1 3804.4 3944.2 3959.4 3982.8 4018.7 9406.4 9738.1 9753.7 9760.3 9786.2 9144.6 9594.6 9599.4 9679.8 9878.8 7269.4 7387.5 7402.7 7435.6 7461.7 5427.6 5546.8 5676.0 5676.1 5706.6 8642.0 8771.2 8904.7 8964.4 8974.0 8426.6 8880.2 8959.4 8965.1 9211.7 5933.9 6397.8 6700.1 6772.6 6829.4 7603.5 7639.9 7657.8 7664.8 7722.0 6692.9 7007.2 7058.5 7099.6 7195.3 6902.3 6916.0 6923.0 7045.9 7081.6 6182.9 6525.9 6526.2 6541.0 6672.2 4784.0 4802.5 4879.3 4884.3 4900.8 4832.1 4862.6 4871.0 4888.4 4893.9 17:37:07 INFO - PROCESS | 21164 | 17:37:07 INFO - PROCESS | 21164 | [#4] prototype.html Cycles:180 Average:4373.16 Median:4935.36 stddev:1286.78 (26.1%) stddev-sans-first:1253.38 17:37:07 INFO - PROCESS | 21164 | Values: 291.1 298.6 299.8 301.3 303.9 4926.4 5034.4 5136.9 5141.0 5161.1 4874.9 5040.9 5044.6 5057.0 5075.0 3992.4 3999.0 4019.4 4027.4 4056.1 3924.6 4003.9 4021.3 4021.8 4037.9 3962.1 3977.2 3977.5 3978.5 4001.6 3959.5 3998.5 4002.3 4019.2 4026.2 3574.6 3577.8 3579.0 3579.1 3583.6 4713.4 4855.8 4867.9 4875.0 4944.3 4506.9 4510.3 4531.4 4534.8 4539.4 5196.4 5267.5 5278.7 5286.5 5303.7 3419.5 3635.2 3653.7 3849.8 3852.3 5514.3 5571.9 5588.6 5595.4 5614.5 3856.5 3856.7 3862.5 3871.3 3879.6 3691.1 3889.4 3890.5 3909.7 3921.6 4413.4 4427.3 4427.5 4432.4 4487.2 5252.6 5299.6 5317.3 5330.6 5357.2 1246.2 1305.6 1344.6 1350.8 1360.6 841.4 850.8 871.3 872.2 875.0 4079.0 4098.3 4105.9 4134.0 4182.6 4847.4 4888.6 4889.2 4898.6 4910.2 4112.2 4139.2 4141.3 4146.9 4170.0 2623.7 2745.5 2967.2 2980.4 2987.3 5176.0 5184.4 5214.4 5221.6 5224.7 5312.4 5581.4 5585.0 5587.4 5596.3 5130.7 5135.3 5160.8 5176.4 5178.2 5540.2 5551.3 5557.6 5563.3 5570.3 5283.9 5413.3 5433.8 5472.9 5474.5 5102.6 5137.7 5168.7 5200.6 5209.6 3775.3 3816.8 3821.0 3825.0 3876.9 5255.8 5423.4 5581.9 5601.5 5660.6 5123.7 5308.6 5310.3 5318.6 5333.8 5322.6 5336.9 5345.5 5365.5 5370.2 4970.5 5145.0 5157.5 5203.3 5294.3 5420.6 5428.8 5431.6 5437.1 5461.8 5266.8 5294.8 5301.5 5319.0 5382.2 17:37:07 INFO - PROCESS | 21164 | 17:37:07 INFO - PROCESS | 21164 | [#5] yui.html Cycles:180 Average:13218.71 Median:46194.65 stddev:15349.51 (33.2%) stddev-sans-first:15363.69 17:37:07 INFO - PROCESS | 21164 | Values: 680.1 706.6 713.1 760.2 785.5 11830.3 12526.4 12537.0 12558.2 12560.2 11571.6 11573.4 11590.2 11605.8 11616.6 611.6 750.1 757.6 774.8 775.6 751.8 758.3 760.9 762.9 763.5 821.3 827.6 831.2 833.9 834.7 817.8 822.2 826.9 826.9 827.0 601.2 602.9 603.4 604.1 604.1 12547.4 12599.8 12605.6 12608.0 12618.3 12357.7 12650.2 12724.3 12725.2 12941.0 9749.7 10554.2 10804.5 11029.5 11113.6 4052.6 4067.3 4122.3 4189.9 4238.4 45448.0 45546.3 45693.0 46150.3 46239.0 9450.9 9580.9 9591.2 9657.8 10077.7 16539.3 16614.8 16667.2 16831.2 16835.2 6354.6 6525.1 6625.5 6654.4 6786.1 3631.2 3683.9 3715.6 3720.1 3794.0 2643.0 2736.7 2737.0 2743.5 2749.9 503.9 506.4 509.8 515.6 518.2 597.5 616.2 618.1 620.6 627.6 7493.4 7506.0 7522.6 7661.2 7667.7 497.0 567.5 598.6 604.2 605.3 3786.1 3807.8 3845.3 3846.2 3877.5 53821.0 54364.7 54748.7 54840.0 55075.2 26604.0 50340.7 51159.7 52034.5 52368.5 45552.8 47229.8 47657.0 47684.0 48272.0 7466.0 8380.1 8499.3 8530.3 8650.3 30959.2 32776.7 33317.2 33964.2 34607.1 40764.8 43466.3 44503.3 44507.6 44744.4 11497.9 11507.4 11523.3 11632.2 11968.6 11577.1 12102.6 12128.0 12163.1 12337.8 10011.9 10248.5 10740.9 11292.5 11837.5 11472.3 11472.7 11490.8 11999.3 12081.1 10911.1 10960.0 11009.2 11083.4 11225.5 9553.8 9663.9 9703.0 9779.7 9986.7 8531.8 8560.5 8632.8 8647.1 8932.9 17:37:07 INFO - PROCESS | 21164 | -------- Summary: end -------- 17:37:07 INFO - PROCESS | 21164 | 17:37:07 INFO - PROCESS | 21164 | 17:37:07 INFO - PROCESS | 21164 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2C0042,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 17:37:07 INFO - PROCESS | 21164 | 17:37:07 INFO - PROCESS | 21164 | 17:37:07 INFO - PROCESS | 21164 | ###!!! [Child][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 17:37:07 INFO - PROCESS | 21164 | 17:37:08 INFO - TEST-INFO | 21164: exit 0 17:37:08 INFO - TEST-OK | dromaeo_css | took 1115492ms 17:37:08 INFO - TEST-START | kraken 17:37:08 INFO - operating with platform_type : linux_ 17:37:08 INFO - Initialising browser for kraken test... 17:37:08 INFO - TEST-INFO | started process 21397 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMKPENQ/profile http://localhost:60378/getInfo.html) 17:37:12 INFO - PROCESS | 21397 | 17:37:12 INFO - PROCESS | 21397 | (process:21468): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:37:12 INFO - PROCESS | 21397 | __metrics Screen width/height:1600/1200 17:37:12 INFO - PROCESS | 21397 | colorDepth:24 17:37:12 INFO - PROCESS | 21397 | Browser inner width/height: 1024/697 17:37:12 INFO - PROCESS | 21397 | __metrics 17:37:13 ERROR - PROCESS | 21397 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 17:37:14 INFO - TEST-INFO | 21397: exit 0 17:37:14 INFO - Browser initialized. 17:37:14 INFO - Running cycle 1/1 for kraken test... 17:37:14 INFO - TEST-INFO | started process 21519 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMKPENQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:37:16 INFO - PROCESS | 21519 | 17:37:16 INFO - PROCESS | 21519 | (process:21579): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:37:26 INFO - PROCESS | 21519 | RSS: Main: 165269504 17:37:26 INFO - PROCESS | 21519 | 17:37:29 INFO - PROCESS | 21519 | Cycle 1(1): loaded http://localhost:60378/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60378/tests/kraken/driver.html?testName=audio-beat-detection) 17:37:30 INFO - PROCESS | 21519 | RSS: Main: 168771584 17:37:30 INFO - PROCESS | 21519 | 17:37:33 INFO - PROCESS | 21519 | Cycle 1(1): loaded http://localhost:60378/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60378/tests/kraken/driver.html?testName=audio-dft) 17:37:33 INFO - PROCESS | 21519 | RSS: Main: 168488960 17:37:33 INFO - PROCESS | 21519 | 17:37:36 INFO - PROCESS | 21519 | Cycle 1(1): loaded http://localhost:60378/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60378/tests/kraken/driver.html?testName=audio-fft) 17:37:37 INFO - PROCESS | 21519 | RSS: Main: 164249600 17:37:37 INFO - PROCESS | 21519 | 17:37:39 INFO - PROCESS | 21519 | Cycle 1(1): loaded http://localhost:60378/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60378/tests/kraken/driver.html?testName=audio-oscillator) 17:37:40 INFO - PROCESS | 21519 | RSS: Main: 165462016 17:37:40 INFO - PROCESS | 21519 | 17:37:42 INFO - PROCESS | 21519 | Cycle 1(1): loaded http://localhost:60378/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60378/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:37:43 INFO - PROCESS | 21519 | RSS: Main: 165658624 17:37:43 INFO - PROCESS | 21519 | 17:37:46 INFO - PROCESS | 21519 | Cycle 1(1): loaded http://localhost:60378/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60378/tests/kraken/driver.html?testName=imaging-darkroom) 17:37:47 INFO - PROCESS | 21519 | RSS: Main: 165265408 17:37:47 INFO - PROCESS | 21519 | 17:37:50 INFO - PROCESS | 21519 | Cycle 1(1): loaded http://localhost:60378/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60378/tests/kraken/driver.html?testName=imaging-desaturate) 17:37:51 INFO - PROCESS | 21519 | RSS: Main: 163766272 17:37:51 INFO - PROCESS | 21519 | 17:37:54 INFO - PROCESS | 21519 | Cycle 1(1): loaded http://localhost:60378/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60378/tests/kraken/driver.html?testName=json-parse-financial) 17:37:55 INFO - PROCESS | 21519 | RSS: Main: 163979264 17:37:55 INFO - PROCESS | 21519 | 17:37:56 INFO - PROCESS | 21519 | Cycle 1(1): loaded http://localhost:60378/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60378/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:37:57 INFO - PROCESS | 21519 | RSS: Main: 163844096 17:37:57 INFO - PROCESS | 21519 | 17:37:59 INFO - PROCESS | 21519 | Cycle 1(1): loaded http://localhost:60378/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60378/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:38:00 INFO - PROCESS | 21519 | RSS: Main: 165171200 17:38:00 INFO - PROCESS | 21519 | 17:38:02 INFO - PROCESS | 21519 | Cycle 1(1): loaded http://localhost:60378/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60378/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:38:03 INFO - PROCESS | 21519 | RSS: Main: 165392384 17:38:03 INFO - PROCESS | 21519 | 17:38:05 INFO - PROCESS | 21519 | Cycle 1(1): loaded http://localhost:60378/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60378/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:38:06 INFO - PROCESS | 21519 | RSS: Main: 165298176 17:38:06 INFO - PROCESS | 21519 | 17:38:09 INFO - PROCESS | 21519 | Cycle 1(1): loaded http://localhost:60378/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60378/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:38:10 INFO - PROCESS | 21519 | RSS: Main: 165474304 17:38:10 INFO - PROCESS | 21519 | 17:38:11 INFO - PROCESS | 21519 | Cycle 1(1): loaded http://localhost:60378/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60378/tests/kraken/driver.html?testName=ai-astar) 17:38:12 INFO - PROCESS | 21519 | RSS: Main: 167575552 17:38:12 INFO - PROCESS | 21519 | 17:38:12 INFO - PROCESS | 21519 | __start_tp_report 17:38:12 INFO - PROCESS | 21519 | _x_x_mozilla_page_load 17:38:12 INFO - PROCESS | 21519 | _x_x_mozilla_page_load_details 17:38:12 INFO - PROCESS | 21519 | |i|pagename|runs| 17:38:12 INFO - PROCESS | 21519 | |0;ai-astar;117;109;115;115;115;116;114;113;116;115 17:38:12 INFO - PROCESS | 21519 | |1;audio-beat-detection;163;132;151;212;130;157;159;131;182;133 17:38:12 INFO - PROCESS | 21519 | |2;audio-dft;163;164;166;167;164;162;163;164;166;163 17:38:12 INFO - PROCESS | 21519 | |3;audio-fft;77;75;75;176;76;75;76;76;165;76 17:38:12 INFO - PROCESS | 21519 | |4;audio-oscillator;95;93;173;94;94;94;156;95;95;139 17:38:12 INFO - PROCESS | 21519 | |5;imaging-gaussian-blur;118;117;117;118;118;118;119;117;117;118 17:38:12 INFO - PROCESS | 21519 | |6;imaging-darkroom;148;148;148;148;148;149;149;156;148;147 17:38:12 INFO - PROCESS | 21519 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;98;100 17:38:12 INFO - PROCESS | 21519 | |8;json-parse-financial;66;69;64;65;64;65;65;66;64;67 17:38:12 INFO - PROCESS | 21519 | |9;json-stringify-tinderbox;65;71;65;66;65;66;65;65;66;70 17:38:12 INFO - PROCESS | 21519 | |10;stanford-crypto-aes;82;82;81;83;82;83;85;86;139;82 17:38:12 INFO - PROCESS | 21519 | |11;stanford-crypto-ccm;143;132;138;129;132;139;136;137;160;132 17:38:12 INFO - PROCESS | 21519 | |12;stanford-crypto-pbkdf2;175;176;173;171;168;170;179;174;172;170 17:38:12 INFO - PROCESS | 21519 | |13;stanford-crypto-sha256-iterative;70;68;68;67;65;66;68;67;71;65 17:38:12 INFO - PROCESS | 21519 | __end_tp_report 17:38:12 INFO - PROCESS | 21519 | __start_cc_report 17:38:12 INFO - PROCESS | 21519 | _x_x_mozilla_cycle_collect,942 17:38:12 INFO - PROCESS | 21519 | __end_cc_report 17:38:12 INFO - PROCESS | 21519 | __startTimestamp1463791092171__endTimestamp 17:38:12 INFO - PROCESS | 21519 | 17:38:12 INFO - PROCESS | 21519 | ------- Summary: start ------- 17:38:12 INFO - PROCESS | 21519 | Number of tests: 14 17:38:12 INFO - PROCESS | 21519 | 17:38:12 INFO - PROCESS | 21519 | [#0] ai-astar Cycles:10 Average:114.50 Median:115.00 stddev:2.22 (1.9%) stddev-sans-first:2.17 17:38:12 INFO - PROCESS | 21519 | Values: 117.0 109.0 115.0 115.0 115.0 116.0 114.0 113.0 116.0 115.0 17:38:12 INFO - PROCESS | 21519 | 17:38:12 INFO - PROCESS | 21519 | [#1] audio-beat-detection Cycles:10 Average:155.00 Median:158.00 stddev:26.44 (16.7%) stddev-sans-first:27.89 17:38:12 INFO - PROCESS | 21519 | Values: 163.0 132.0 151.0 212.0 130.0 157.0 159.0 131.0 182.0 133.0 17:38:12 INFO - PROCESS | 21519 | 17:38:12 INFO - PROCESS | 21519 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.00 stddev:1.62 (1.0%) stddev-sans-first:1.66 17:38:12 INFO - PROCESS | 21519 | Values: 163.0 164.0 166.0 167.0 164.0 162.0 163.0 164.0 166.0 163.0 17:38:12 INFO - PROCESS | 21519 | 17:38:12 INFO - PROCESS | 21519 | [#3] audio-fft Cycles:10 Average:94.70 Median:76.00 stddev:40.04 (52.7%) stddev-sans-first:41.95 17:38:12 INFO - PROCESS | 21519 | Values: 77.0 75.0 75.0 176.0 76.0 75.0 76.0 76.0 165.0 76.0 17:38:12 INFO - PROCESS | 21519 | 17:38:12 INFO - PROCESS | 21519 | [#4] audio-oscillator Cycles:10 Average:112.80 Median:94.00 stddev:30.88 (32.8%) stddev-sans-first:32.07 17:38:12 INFO - PROCESS | 21519 | Values: 95.0 93.0 173.0 94.0 94.0 94.0 156.0 95.0 95.0 139.0 17:38:12 INFO - PROCESS | 21519 | 17:38:12 INFO - PROCESS | 21519 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 17:38:12 INFO - PROCESS | 21519 | Values: 118.0 117.0 117.0 118.0 118.0 118.0 119.0 117.0 117.0 118.0 17:38:12 INFO - PROCESS | 21519 | 17:38:12 INFO - PROCESS | 21519 | [#6] imaging-darkroom Cycles:10 Average:148.90 Median:148.00 stddev:2.56 (1.7%) stddev-sans-first:2.69 17:38:12 INFO - PROCESS | 21519 | Values: 148.0 148.0 148.0 148.0 148.0 149.0 149.0 156.0 148.0 147.0 17:38:12 INFO - PROCESS | 21519 | 17:38:12 INFO - PROCESS | 21519 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:95.00 stddev:1.75 (1.8%) stddev-sans-first:1.83 17:38:12 INFO - PROCESS | 21519 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 98.0 100.0 17:38:12 INFO - PROCESS | 21519 | 17:38:12 INFO - PROCESS | 21519 | [#8] json-parse-financial Cycles:10 Average:65.50 Median:65.50 stddev:1.58 (2.4%) stddev-sans-first:1.67 17:38:12 INFO - PROCESS | 21519 | Values: 66.0 69.0 64.0 65.0 64.0 65.0 65.0 66.0 64.0 67.0 17:38:12 INFO - PROCESS | 21519 | 17:38:12 INFO - PROCESS | 21519 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:66.00 stddev:2.22 (3.4%) stddev-sans-first:2.30 17:38:12 INFO - PROCESS | 21519 | Values: 65.0 71.0 65.0 66.0 65.0 66.0 65.0 65.0 66.0 70.0 17:38:12 INFO - PROCESS | 21519 | 17:38:12 INFO - PROCESS | 21519 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:82.50 stddev:17.81 (21.6%) stddev-sans-first:18.73 17:38:12 INFO - PROCESS | 21519 | Values: 82.0 82.0 81.0 83.0 82.0 83.0 85.0 86.0 139.0 82.0 17:38:12 INFO - PROCESS | 21519 | 17:38:12 INFO - PROCESS | 21519 | [#11] stanford-crypto-ccm Cycles:10 Average:137.80 Median:137.50 stddev:8.84 (6.4%) stddev-sans-first:9.18 17:38:12 INFO - PROCESS | 21519 | Values: 143.0 132.0 138.0 129.0 132.0 139.0 136.0 137.0 160.0 132.0 17:38:12 INFO - PROCESS | 21519 | 17:38:12 INFO - PROCESS | 21519 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.80 Median:173.50 stddev:3.29 (1.9%) stddev-sans-first:3.40 17:38:12 INFO - PROCESS | 21519 | Values: 175.0 176.0 173.0 171.0 168.0 170.0 179.0 174.0 172.0 170.0 17:38:12 INFO - PROCESS | 21519 | 17:38:12 INFO - PROCESS | 21519 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:1.96 (2.9%) stddev-sans-first:1.86 17:38:12 INFO - PROCESS | 21519 | Values: 70.0 68.0 68.0 67.0 65.0 66.0 68.0 67.0 71.0 65.0 17:38:12 INFO - PROCESS | 21519 | -------- Summary: end -------- 17:38:12 INFO - PROCESS | 21519 | 17:38:13 INFO - TEST-INFO | 21519: exit 0 17:38:13 INFO - TEST-OK | kraken | took 65072ms 17:38:13 INFO - SUITE-END | took 1180s 17:38:13 INFO - Completed test suite (00:19:40) 17:38:13 INFO - javascript benchmark 17:38:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6268.876947557183, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2662.7337266273375, 2701.3246688327918, 2722.2513808702615, 2725.2641786717586, 2742.8902843886244, 4693.225617773068, 4707.78814953327, 4727.90544189116, 4808.086463571919, 4832.903341933159, 4648.674592778507, 4767.547083027115, 4776.832810851621, 4783.42598888133, 4813.085513752393, 4366.97816510917, 4400.537943515933, 4477.0, 4496.865094047167, 4508.864734057984, 4194.370844373338, 4439.689221754478, 4467.106578684276, 4523.819047238107, 4525.864224073283, 4256.59562341577, 4297.570242975708, 4325.718828276184, 4361.280388735855, 4423.4028406165235, 4361.389405483234, 4370.672199585012, 4390.934135987963, 4427.291633338683, 4432.53458386868, 4359.607635312837, 4395.58248943466, 4406.317020861771, 4441.067375851075, 4460.353248778942, 4595.954040459586, 4682.180618391768, 4697.412823397075, 4703.764811759398, 4706.294055891643, 5112.156494178456, 5118.513741194581, 5132.178851383761, 5132.28148059272, 5174.09453345663, 5134.486551344836, 5157.045946499909, 5173.560247378978, 5194.792208311663, 5196.8960620787375, 4842.854714358575, 4850.781714822841, 4854.101991131652, 4861.586765124968, 4891.951080489185, 5318.973405133027, 5322.36131664195, 5322.414534401213, 5323.467653234646, 5330.360356757136, 4887.682300650446, 4994.0, 5029.899402011939, 5052.191649336089, 5092.337996060489, 4950.25746138075, 5132.666376685578, 5137.51193636604, 5147.6396652234735, 5152.381714194245, 5015.573676237488, 5061.772220250097, 5074.314967479417, 5093.439721630618, 5106.719130447861, 4897.7795999180125, 5035.546800787946, 5063.1645778446145, 5082.1360368737405, 5093.770780314895, 4406.096750166208, 4417.867463976086, 4426.822927082881, 4456.131054444352, 4474.798634061475, 3843.55799083109, 3847.9230415392094, 3868.574456809749, 3888.3972984187494, 3939.074317535434, 4183.895402614959, 4366.279563871925, 4404.0, 4408.0, 4410.448693913261, 5136.280920671109, 5177.042247184283, 5177.715225662625, 5185.092608793446, 5250.422453530108, 4396.098799746044, 4398.384226208269, 4406.228909940812, 4419.558044195554, 4435.866923992286, 4475.216837053503, 4602.05657840142, 4612.262038073892, 4663.370444989951, 4681.485036645966, 4797.088553174885, 4813.6483201645115, 4816.735079570517, 4817.373741413594, 4862.927056094161, 4942.901141977212, 5184.144616138295, 5198.142306519533, 5201.635885488131, 5259.921101183409, 4764.547368000034, 4769.093872164278, 4810.5670489656095, 4824.059308434821, 4835.516448355136, 5097.235414687826, 5108.591312694901, 5109.565686916505, 5113.360829896263, 5177.042247184283, 4977.402711674622, 5111.514406131411, 5192.350956130484, 5194.091034069098, 5194.844154675366, 4832.855014349575, 4929.630277729113, 4974.552290293891, 4995.625328100335, 5090.465501122477, 5005.224190250517, 5005.299258103942, 5016.824411145592, 5018.673786203885, 5050.797968081236, 4737.123632127929, 4892.535209155125, 4901.583365413837, 4918.8770280743265, 4920.901581968412, 5021.297018417352, 5050.848474545623, 5081.314022606901, 5095.617828662939, 5099.6175286852895, 4951.851444456672, 4977.875553111201, 4991.550760431579, 5004.0, 5044.1172794761505], "value": 4710.297586184958, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.5564427736088, 583.810261664959, 592.2064433658902, 594.7234535940787, 614.0758158970748, 39068.60931390689, 40343.0, 40420.19159616806, 43526.782366088126, 43712.0, 40635.0, 40828.18343633126, 41158.794206029, 41263.79368103163, 41275.380869286986, 7600.1639819619795, 7638.427117966147, 7677.884831727529, 7692.384609231248, 7695.692172313101, 7681.462297639167, 7823.178566250547, 7858.174891636381, 7861.2531809478005, 7870.921290787076, 7795.688172473123, 7809.3752499799875, 7819.804504887395, 7828.178041305667, 7899.249571290718, 7758.301752842243, 7784.338331241851, 7796.883046754331, 7802.297793198611, 7815.570143642098, 7762.650680719381, 7807.297343239079, 7813.218678132198, 7816.960915195445, 7850.450468467209, 37858.62141378578, 37983.24033519342, 38208.235835283136, 38274.0, 38450.0, 3113.984430077835, 3155.195425166568, 3167.0, 3280.9343813123605, 3352.0949343677316, 29413.852930735422, 29508.852455737582, 29526.0, 29532.70467295321, 29916.850415748, 3211.5182722591567, 3277.72139368154, 3349.681780230874, 3461.3250416168858, 3526.5415495985612, 277757.0, 277967.0, 278000.6099969507, 278924.0, 281119.0, 31837.204069897976, 32908.83545582257, 56238.0, 56757.43242567604, 57063.0, 34388.0, 34395.484067739, 34496.310073798384, 34517.65482345194, 34532.65467345345, 11574.247673901169, 11606.30362178272, 11694.649160525198, 11701.239419437708, 11706.24406339039, 9258.583363748647, 9293.67472138472, 9351.625934962525, 9353.064693530729, 9365.672201472917, 7943.404244681672, 8007.479513831582, 8072.233137851895, 8089.676412943534, 8113.675452981933, 3118.7504999600433, 3141.5287706844156, 3157.400093982182, 3172.0, 3196.840157992091, 857.8155696525278, 904.8823652925078, 911.6080085563271, 911.7674992876774, 924.1313165624292, 27853.442931141264, 28470.572941405895, 28638.284042899093, 29040.41919161605, 29330.266743331587, 922.9169374756304, 960.5341409416427, 964.2912459342377, 975.8926518083006, 979.5445118020154, 14547.27263636814, 14706.485273015393, 14996.250187490581, 15076.0, 15132.546023619308, 387457.0, 390263.0, 391268.0, 392496.0, 394436.0, 48570.0, 48746.512534874906, 49083.75458122758, 49194.0, 49294.50705492899, 1186.9494418394793, 1219.914605977573, 1221.047582885351, 1229.1825935752804, 1240.6464157715188, 25416.872915636042, 26793.464130717668, 27209.86395068012, 27483.17550473409, 27530.862345688143, 42248.0, 42480.57519424766, 42662.14675706407, 42795.0, 42899.5710042908, 313587.0, 320075.0, 320101.0, 320124.0, 322546.0, 23542.88228558915, 23886.761132388452, 24119.879400602884, 24131.63802542928, 24140.155094572307, 41661.0, 42822.571774283104, 43055.1388972225, 43238.78380608077, 43800.0, 36655.633443665225, 37051.25897482089, 37091.07272318214, 37242.44136337903, 37298.440523391626, 34576.30847382988, 36326.27347453089, 36572.0, 36685.81657091698, 36955.63044369522, 31102.37795244128, 35366.46950295799, 35625.643743562236, 36235.45646815353, 36927.63072369242, 32119.678803212602, 33113.834430827694, 33719.32561348809, 33864.0, 34125.82937085299, 25234.495310094062, 25540.2337929855, 25735.485290294462, 25843.353916152246, 25899.61150582705], "value": 16422.08460454139, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.34238370932326, 366.29853829915703, 369.6691461142278, 379.8081968605857, 383.0462149248372, 15169.2415379231, 15660.608484787886, 16831.663366732675, 16860.74708879368, 16914.74627880583, 15213.391464341414, 16094.678106437865, 16653.25060372283, 16690.916545417287, 16720.08039557824, 5022.974885125578, 5183.688978661293, 5217.034848553029, 5217.921731174036, 5220.425753167148, 5020.924686129711, 5162.8193013244545, 5215.035218484573, 5217.921731174036, 5239.790408383679, 5058.822941197059, 5110.259012443194, 5121.28302037715, 5122.3084883540805, 5144.8971020579565, 4875.390576177978, 5070.619703522232, 5073.162928116893, 5101.744912754366, 5113.718745468997, 4566.406367172246, 4593.954060459386, 4595.0, 4600.631949444037, 4602.677812553123, 19229.326973556, 19614.803851961584, 20317.18731250748, 20337.18651253948, 20352.0, 1951.834094102003, 1975.0815870620231, 2006.147387360366, 2106.29439137889, 2276.2943487518924, 8647.178518040777, 13181.60455186346, 13342.866571334356, 13716.862831371758, 13718.519851805238, 1624.7969003874516, 1626.8047834259846, 1734.3496188929153, 1770.9557261068448, 1779.172684701607, 51114.48885511135, 58786.70606646939, 59733.70133149307, 70588.29408208012, 72374.63812680903, 9721.173700235418, 9824.312298139062, 10072.798544029078, 10105.191584673208, 10182.592696292066, 13758.862411375958, 13995.650108747363, 14074.788878166835, 14096.224707640973, 14158.150510969375, 6385.904211436832, 6390.169277993831, 6508.544401891822, 6587.73649054042, 6621.569597976212, 5488.890222195534, 5551.084071128299, 5574.16387541872, 5594.720263986785, 5793.884122317614, 4318.762468064224, 4364.934525982113, 4395.516493185747, 4481.1933851906315, 4527.818887244473, 1850.7964123946356, 1861.1252711225702, 1890.886546807196, 1901.7622797150357, 1932.6327997680396, 906.6917248135666, 931.5156118818177, 943.8301105801022, 987.713563066717, 990.9058639429243, 16119.435819746253, 16776.916115419346, 16899.662006759794, 17121.571960701083, 17386.47840564785, 857.9142085791495, 883.2271762208068, 890.3633901760272, 920.406337912043, 952.1668540027476, 9447.716568502956, 9641.903580964101, 9720.07659272382, 9740.659076932274, 9887.700774014602, 392493.0, 405709.0, 406386.0, 410372.0, 410680.0, 71806.64096679483, 74673.62663186758, 75167.62416187883, 75636.0, 76679.0, 909.981800363989, 921.4149015375151, 927.7587827164986, 938.2306508662967, 940.041158018817, 15014.47449339268, 15032.92483537619, 15059.924700376867, 15099.924500377429, 15420.768688469458, 35006.64993350034, 35183.29633407369, 35189.47215791714, 35881.64118358783, 36343.74704767958, 48141.518584813704, 49158.26262605992, 49544.50455495399, 49816.50183498119, 49861.750691246314, 7408.296211859864, 7411.8147046324275, 7493.325600695745, 7544.0569928758905, 7586.279303466162, 10014.449205293779, 10873.184511161853, 10905.890941090487, 10940.671779846618, 11117.666470005914, 9348.485833279236, 9446.811063778823, 9451.621935122794, 9530.571124299562, 9846.60613575449, 4961.578265847444, 9445.858312125187, 9701.0, 9715.902840971783, 9885.752856178653, 9278.164965153168, 9564.0, 9788.853167202355, 9875.604975800887, 10106.595736170471, 7294.854102918018, 7375.8156046099275, 7407.8148046299275, 7554.169041405331, 7556.0, 9417.952910235404, 9428.15146636806, 9581.808363832824, 9598.0, 9643.27675424332], "value": 8020.402907417705, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1433.512605714057, 1460.6348412896775, 1568.2707540993435, 1742.128935532234, 1750.439859245042, 6791.320867913206, 7522.586257755821, 7558.659860306286, 8063.314618257448, 8068.072171700249, 7703.268189522, 7987.440879138463, 8036.0, 8043.6380362883665, 8053.557054362008, 2215.2246713650215, 2245.6743772153027, 2260.050778672953, 2260.864348139117, 2266.1841736974757, 2172.5654869026257, 2185.67214917762, 2250.414892128042, 2253.8985745641485, 2259.2996171186983, 2196.6814811852273, 2206.293985924505, 2206.9889650551727, 2239.5632851593946, 2271.068861766676, 2146.806787389127, 2152.5156839711094, 2161.2111579273533, 2169.663702126173, 2174.1194816099505, 2128.435964469417, 2132.41358626379, 2132.6800979853147, 2152.4726442021806, 2154.3213887625348, 7958.721444749463, 7992.400569957276, 8003.079645840687, 8009.239122283374, 8054.758357249233, 4320.7839608019785, 4414.977925110386, 4416.24923762961, 4424.690271680984, 4431.423914891076, 2731.1533424638424, 2785.7632101271215, 2884.0, 2894.1028281232675, 2900.7244311790346, 825.636719843273, 862.361852229352, 875.2516598308482, 878.2490970220497, 881.7795551112222, 10538.156947444186, 10610.416427096507, 10620.415877126756, 10647.57409703611, 10705.83941240882, 4211.957880421157, 4265.1469706058915, 4355.259605867011, 4366.083122544238, 4387.495438024668, 9182.0, 9250.67622633218, 9251.90748092524, 9255.67605133817, 9267.702521646976, 4450.554944505524, 4496.348029535764, 4510.1656193604285, 4554.4990051094355, 4563.54364563541, 3552.6802587767224, 4009.578994205625, 4082.346824508124, 4090.8159132839096, 4145.2952997990415, 3710.888673339804, 3729.1422972716427, 3837.347650899298, 3845.2117315950163, 3959.0, 1185.8754830742648, 1195.0738177912187, 1198.7003249187703, 1205.7588482303574, 1212.6847019774923, 852.3138873207004, 862.5385418801037, 866.2204016385303, 876.075740094194, 892.4734406700078, 5400.783968641289, 5444.346678398618, 5461.7276589401035, 5489.533389661844, 5610.831675049673, 402.4385981555772, 413.6298013278099, 416.4128578704013, 417.75352542000365, 422.10724318067065, 3804.410316400962, 3944.1914407546383, 3959.366501359826, 3982.761034337949, 4018.6985976051915, 9406.38858474197, 9738.074882886114, 9753.707388778348, 9760.267979901535, 9786.217102631916, 9144.588493517675, 9594.60878172661, 9599.376040557341, 9679.758006049906, 9878.753031174134, 7269.382102521345, 7387.482876198722, 7402.74090406844, 7435.591042492715, 7461.738839140604, 5427.6200665953, 5546.750396232099, 5676.0, 5676.148577713376, 5706.629069110494, 8641.95679021626, 8771.16673915977, 8904.688335908211, 8964.417312874642, 8974.01285858568, 8426.578671066545, 8880.245179159843, 8959.41763785352, 8965.058668839678, 9211.710360549394, 5933.940660593512, 6397.776077837253, 6700.095487109178, 6772.627505487048, 6829.419499342612, 7603.505772124794, 7639.923600763921, 7657.846843063219, 7664.80837979055, 7721.961390193013, 6692.933070669231, 7007.194172670208, 7058.470614703815, 7099.609521476368, 7195.316444937723, 6902.309769023258, 6915.965420173068, 6922.965385173042, 7045.929540704732, 7081.645917704197, 6182.917989351936, 6525.8694826104165, 6526.24948130971, 6541.0, 6672.232693240339, 4784.0, 4802.51974802517, 4879.268109783561, 4884.340614017205, 4900.779464924159, 4832.130216561053, 4862.610991120772, 4871.0, 4888.413390393175, 4893.926591101065], "value": 4116.22689329716, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.09034267912773, 298.62075164541034, 299.75120649860617, 301.3175158266526, 303.89819410497483, 4926.408830940292, 5034.370703662043, 5136.922946155806, 5140.999999999995, 5161.148410512265, 4874.902501949968, 5040.949590504094, 5044.596432285418, 5057.0, 5075.010372977271, 3992.361222204448, 3998.980005099978, 4019.437278780973, 4027.375756757707, 4056.127932494513, 3924.5879182685835, 4003.898927794851, 4021.3163762160357, 4021.822760019581, 4037.939430908524, 3962.128331767007, 3977.2244412339605, 3977.482927219472, 3978.4629075074786, 4001.619846114629, 3959.5050618672667, 3998.480197574311, 4002.2795896738576, 4019.196160767829, 4026.1947610477728, 3574.58803772511, 3577.7853328800356, 3579.0, 3579.1231148368815, 3583.62371950944, 4713.387259656257, 4855.805767769285, 4867.8783030424165, 4874.951250487486, 4944.307796908436, 4506.932396014063, 4510.345999830039, 4531.388262584542, 4534.79593418297, 4539.364488971547, 5196.428392876781, 5267.499587539178, 5278.706716854395, 5286.524212820865, 5303.7082960437165, 3419.5212670226188, 3635.218428037958, 3653.7077033837495, 3849.788261645608, 3852.306584814732, 5514.255575497296, 5571.8885622287735, 5588.636738611977, 5595.440455954413, 5614.466625670596, 3856.46009558662, 3856.749311294757, 3862.5364956205435, 3871.303165430193, 3879.631435013669, 3691.1325838427947, 3889.436031775433, 3890.4747859039235, 3909.706771992112, 3921.5882332355263, 4413.3821265022925, 4427.29163333865, 4427.490838553543, 4432.445944256968, 4487.237169681162, 5252.632315737938, 5299.5760339172775, 5317.335333083364, 5330.600204984564, 5357.151782634985, 1246.1588427811191, 1305.6344223617402, 1344.5764584156154, 1350.770369037266, 1360.5850215684113, 841.4110122913985, 850.7532815483564, 871.2507243770352, 872.1801506583791, 875.0112373018576, 4078.9796051019557, 4098.323776576832, 4105.91788164235, 4134.0, 4182.644475219579, 4847.40035788189, 4888.560029597354, 4889.215436365772, 4898.608111351084, 4910.238912968495, 4112.157007813451, 4139.234241665302, 4141.302066152863, 4146.854860079883, 4169.958300417018, 2623.698274698396, 2745.450909818004, 2967.213688372583, 2980.418818330405, 2987.327851233455, 5176.0, 5184.429712731597, 5214.418862663006, 5221.582273418194, 5224.7126408047925, 5312.389075256395, 5581.441855814386, 5585.0, 5587.38538760736, 5596.3284405871555, 5130.743462826844, 5135.281060651511, 5160.7935682573025, 5176.4047134578495, 5178.171492561097, 5540.196671482693, 5551.333839939233, 5557.583181261502, 5563.276774019351, 5570.328901329503, 5283.882509319366, 5413.323334583177, 5433.809816656398, 5472.890542189213, 5474.507294343528, 5102.642815003062, 5137.6660517066275, 5168.664036837594, 5200.60995425337, 5209.6092793041435, 3775.3393156197008, 3816.778630838105, 3821.0, 3825.0, 3876.9418458722575, 5255.7925671218945, 5423.430539793265, 5581.9162712560155, 5601.467860553241, 5660.632058916157, 5123.74381280927, 5308.575313974796, 5310.256564081109, 5318.574514038945, 5333.813316533902, 5322.574194064543, 5336.866578335573, 5345.492178243061, 5365.463453654604, 5370.248165256945, 4970.478099799469, 5145.048166089286, 5157.510036546522, 5203.323567936295, 5294.311739473844, 5420.593455490775, 5428.7557059931605, 5431.592630552804, 5437.13005919051, 5461.754221060141, 5266.762995665128, 5294.841154765363, 5301.522862942354, 5319.0, 5382.246485491956], "value": 3958.520890899121, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [680.0784936411164, 706.5795851468376, 713.1270770691565, 760.2283682062707, 785.4698078796818, 11830.349330786803, 12526.436310366033, 12536.999999999989, 12558.246505209694, 12560.246385216893, 11571.594994175206, 11573.363465009443, 11590.188686791927, 11605.767884642322, 11616.593419230328, 611.6360765344613, 750.0511852506584, 757.6476938223739, 774.7908064822494, 775.5928137727682, 751.7631945937039, 758.3288789421347, 760.9239076092374, 762.8779395296754, 763.496092578898, 821.2936874288107, 827.6027506796742, 831.1605278668528, 833.8790875323075, 834.7287131682198, 817.795551112216, 822.1655020154548, 826.8759686047081, 826.9338452923752, 827.0447632983883, 601.2184160591214, 602.8975074237391, 603.4267445926343, 604.1029071828332, 604.1360853978808, 12547.435365408579, 12599.811002834966, 12605.621831345074, 12608.0, 12618.305993170372, 12357.691057723629, 12650.240985540897, 12724.300163491005, 12725.236485810789, 12941.029422793328, 9749.658761943298, 10554.208434367376, 10804.459777011118, 11029.503672334684, 11113.611023614134, 4052.6150015748754, 4067.3085575452246, 4122.2786012448005, 4189.91620167598, 4238.385434112037, 45448.0, 45546.316805247945, 45693.0, 46150.30774538385, 46239.0, 9450.85823712645, 9580.856287155699, 9591.184749296248, 9657.806843863083, 10077.697669069794, 16539.25573349202, 16614.83385166157, 16667.24997375121, 16831.242594083295, 16835.158242087848, 6354.618722876642, 6525.086487891699, 6625.503087268474, 6654.367835055662, 6786.117804685359, 3631.1829838286176, 3683.944740828836, 3715.5727091384297, 3720.069982504374, 3793.962060379416, 2642.960355594629, 2736.65791776028, 2737.0, 2743.4513097380604, 2749.8625068746483, 503.93952725673154, 506.3898002906489, 509.76041260607457, 515.6261710260031, 518.2071430711018, 597.4801922327603, 616.2450997528082, 618.0844351036146, 620.6152185644929, 627.6108812536256, 7493.4379921505015, 7506.0, 7522.623868806538, 7661.157272699998, 7667.693292268358, 496.96878976124685, 567.4920945753528, 598.643806934873, 604.1813342920368, 605.3039005144032, 3786.110264087992, 3807.809609519513, 3845.288621605012, 3846.211526637033, 3877.515310586177, 53821.0, 54364.72817635886, 54748.72625636846, 54840.0, 55075.17387239195, 26604.0, 50340.74829625829, 51159.74420127876, 52034.47965520372, 52368.47631523636, 45552.772236138604, 47229.76385118053, 47657.0, 47684.0, 48272.0, 7466.0, 8380.120087390736, 8499.277561407349, 8530.274926631306, 8650.26472749798, 30959.226019349695, 32776.67223327832, 33317.16707082342, 33964.150896227795, 34607.13482162966, 40764.79617601893, 43466.348004780586, 44503.33245001392, 44507.55492445034, 44744.42044636356, 11497.885021149681, 11507.424628768695, 11523.250988685708, 11632.18574699763, 11968.640940771791, 11577.131715121568, 12102.636920892388, 12128.0, 12163.087768417226, 12337.814932776195, 10011.949940250544, 10248.487575621339, 10740.946295268473, 11292.491837867152, 11837.467313971065, 11472.254303470248, 11472.655820325404, 11490.77018459643, 11999.340036298088, 12081.093917956012, 10911.072558832271, 10960.0, 11009.174311926477, 11083.445827708421, 11225.494852731483, 9553.754867605969, 9663.9033609663, 9702.951485242529, 9779.706608801747, 9986.650467233612, 8531.786705332168, 8560.529170895661, 8632.827343453222, 8647.135286471303, 8932.86600700977], "value": 6003.28180018543, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1602.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 109.0, 115.0, 115.0, 115.0, 116.0, 114.0, 113.0, 116.0, 115.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 132.0, 151.0, 212.0, 130.0, 157.0, 159.0, 131.0, 182.0, 133.0], "value": 155.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 166.0, 167.0, 164.0, 162.0, 163.0, 164.0, 166.0, 163.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 176.0, 76.0, 75.0, 76.0, 76.0, 165.0, 76.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 93.0, 173.0, 94.0, 94.0, 94.0, 156.0, 95.0, 95.0, 139.0], "value": 112.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 119.0, 117.0, 117.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 148.0, 148.0, 149.0, 149.0, 156.0, 148.0, 147.0], "value": 148.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 98.0, 100.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 64.0, 65.0, 64.0, 65.0, 65.0, 66.0, 64.0, 67.0], "value": 65.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 71.0, 65.0, 66.0, 65.0, 66.0, 65.0, 65.0, 66.0, 70.0], "value": 66.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 81.0, 83.0, 82.0, 83.0, 85.0, 86.0, 139.0, 82.0], "value": 88.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 132.0, 138.0, 129.0, 132.0, 139.0, 136.0, 137.0, 160.0, 132.0], "value": 137.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 176.0, 173.0, 171.0, 168.0, 170.0, 179.0, 174.0, 172.0, 170.0], "value": 172.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 68.0, 67.0, 65.0, 66.0, 68.0, 67.0, 71.0, 65.0], "value": 67.5, "unit": "score"}]}]} 17:38:13 INFO - Return code: 0 17:38:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:38:13 ERROR - # TBPL SUCCESS # 17:38:13 INFO - Running post-action listener: _resource_record_post_action 17:38:13 INFO - ##### 17:38:13 INFO - ##### Finished run-tests step (success) 17:38:13 INFO - ##### 17:38:13 INFO - Running post-run listener: _resource_record_post_run 17:38:13 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 8192; Write bytes: 541540352; Read time: 204; Write time: 432940 17:38:13 INFO - TinderboxPrint: CPU usage
13.3% 17:38:13 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 204 17:38:13 INFO - TinderboxPrint: I/O write bytes / time
541,540,352 / 432,940 17:38:13 INFO - TinderboxPrint: CPU idle
8,283.7 (86.6%) 17:38:13 INFO - TinderboxPrint: CPU user
1,224.8 (12.8%) 17:38:13 INFO - TinderboxPrint: Swap in / out
0 / 0 17:38:13 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 201879552; Read time: 68; Write time: 224500 17:38:13 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296153088; Read time: 136; Write time: 189488 17:38:14 INFO - Running post-run listener: _upload_blobber_files 17:38:14 INFO - Blob upload gear active. 17:38:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:38:14 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:38:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:38:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:38:14 INFO - (blobuploader) - INFO - Open directory for files ... 17:38:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:38:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:38:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:38:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:38:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:38:15 INFO - (blobuploader) - INFO - Done attempting. 17:38:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:38:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:38:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:38:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:38:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:38:16 INFO - (blobuploader) - INFO - Done attempting. 17:38:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:38:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:38:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:38:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:38:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:38:20 INFO - (blobuploader) - INFO - Done attempting. 17:38:20 INFO - (blobuploader) - INFO - Iteration through files over. 17:38:20 INFO - Return code: 0 17:38:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:38:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:38:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f3a4dad81580c427d8e22fb6b3f3e2cf78267464687ee4d6135c84d783db45ad077883ad7e041a240c20bc475a35ee389a32968281fbe77ca2407b828039ce13", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/04948e1396f85a56461fa0ccf4a3ed77361c9e8383cbc8bb0a450efe5099fead636a5d8686ee7dd70335ec4a6a534579ce5053ad610ca0ee553da006db7633bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6a8e0102730006ab4256ca8e86fa7df30b15f24856a4f9770e9c4cdbbc18f5282f5a67a5b0764cb09321858dfe71628ca2c3b1b5380b90534783b8d3dfb880c9"} 17:38:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:38:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:38:20 INFO - Contents: 17:38:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f3a4dad81580c427d8e22fb6b3f3e2cf78267464687ee4d6135c84d783db45ad077883ad7e041a240c20bc475a35ee389a32968281fbe77ca2407b828039ce13", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/04948e1396f85a56461fa0ccf4a3ed77361c9e8383cbc8bb0a450efe5099fead636a5d8686ee7dd70335ec4a6a534579ce5053ad610ca0ee553da006db7633bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6a8e0102730006ab4256ca8e86fa7df30b15f24856a4f9770e9c4cdbbc18f5282f5a67a5b0764cb09321858dfe71628ca2c3b1b5380b90534783b8d3dfb880c9"} 17:38:20 INFO - Running post-run listener: copy_logs_to_upload_dir 17:38:20 INFO - Copying logs to upload dir... 17:38:20 INFO - mkdir: /builds/slave/test/build/upload/logs 17:38:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.154416 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-05-20 17:38:19.551496) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-20 17:38:19.554888) ========= 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=00204705a9daa57ed339a427000001b9-1463787216.969482-232306169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f3a4dad81580c427d8e22fb6b3f3e2cf78267464687ee4d6135c84d783db45ad077883ad7e041a240c20bc475a35ee389a32968281fbe77ca2407b828039ce13", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/04948e1396f85a56461fa0ccf4a3ed77361c9e8383cbc8bb0a450efe5099fead636a5d8686ee7dd70335ec4a6a534579ce5053ad610ca0ee553da006db7633bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6a8e0102730006ab4256ca8e86fa7df30b15f24856a4f9770e9c4cdbbc18f5282f5a67a5b0764cb09321858dfe71628ca2c3b1b5380b90534783b8d3dfb880c9"} build_url:https://queue.taskcluster.net/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011430 build_url: 'https://queue.taskcluster.net/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f3a4dad81580c427d8e22fb6b3f3e2cf78267464687ee4d6135c84d783db45ad077883ad7e041a240c20bc475a35ee389a32968281fbe77ca2407b828039ce13", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/04948e1396f85a56461fa0ccf4a3ed77361c9e8383cbc8bb0a450efe5099fead636a5d8686ee7dd70335ec4a6a534579ce5053ad610ca0ee553da006db7633bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6a8e0102730006ab4256ca8e86fa7df30b15f24856a4f9770e9c4cdbbc18f5282f5a67a5b0764cb09321858dfe71628ca2c3b1b5380b90534783b8d3dfb880c9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-20 17:38:19.583819) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 17:38:19.584159) ========= 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=00204705a9daa57ed339a427000001b9-1463787216.969482-232306169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004495 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 17:38:19.666309) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-20 17:38:19.666648) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-20 17:38:19.666955) ========= ========= Total master_lag: 0.18 =========