builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-022 starttime: 1463821277.75 results: success (0) buildid: 20160520233021 builduid: 0b61c1134ba44a4f9fad29cae09397c2 revision: 54ebf85e87313800ab3b4412861a9d49cef7e2ff ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-21 02:01:17.750199) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-21 02:01:17.750676) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-21 02:01:17.750954) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-21 02:01:17.813147) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 02:01:17.813476) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1463819972.160150-1898091784 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-21 02:01:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.8M=0s 2016-05-21 02:01:18 (42.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103870 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 02:01:17.938993) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 02:01:17.939295) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1463819972.160150-1898091784 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015504 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 02:01:18.010421) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 02:01:18.010929) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 54ebf85e87313800ab3b4412861a9d49cef7e2ff --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 54ebf85e87313800ab3b4412861a9d49cef7e2ff --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=9c43b49b387003dc8f5b4e5c000001c4-1463819972.160150-1898091784 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-21 02:01:18,301 truncating revision to first 12 chars 2016-05-21 02:01:18,301 Setting DEBUG logging. 2016-05-21 02:01:18,301 attempt 1/10 2016-05-21 02:01:18,301 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/54ebf85e8731?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-21 02:01:18,735 unpacking tar archive at: fx-team-54ebf85e8731/testing/mozharness/ program finished with exit code 0 elapsedTime=0.746245 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 02:01:18.779930) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-21 02:01:18.780248) ========= script_repo_revision: 54ebf85e87313800ab3b4412861a9d49cef7e2ff ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-21 02:01:18.783687) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-21 02:01:18.783983) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-21 02:01:18.821297) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-05-21 02:01:18.821628) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1463819972.160150-1898091784 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:01:19 INFO - MultiFileLogger online at 20160521 02:01:19 in /builds/slave/test 02:01:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:01:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:01:19 INFO - {'append_to_log': False, 02:01:19 INFO - 'base_work_dir': '/builds/slave/test', 02:01:19 INFO - 'blob_upload_branch': 'Fx-Team', 02:01:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:01:19 INFO - 'branch': 'Fx-Team', 02:01:19 INFO - 'buildbot_json_path': 'buildprops.json', 02:01:19 INFO - 'config_files': ('talos/linux_config.py',), 02:01:19 INFO - 'default_actions': ('clobber', 02:01:19 INFO - 'read-buildbot-config', 02:01:19 INFO - 'download-and-extract', 02:01:19 INFO - 'populate-webroot', 02:01:19 INFO - 'create-virtualenv', 02:01:19 INFO - 'install', 02:01:19 INFO - 'run-tests'), 02:01:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:01:19 INFO - 'download_minidump_stackwalk': True, 02:01:19 INFO - 'download_symbols': 'ondemand', 02:01:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:01:19 INFO - 'tooltool.py': '/tools/tooltool.py', 02:01:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:01:19 INFO - '/tools/misc-python/virtualenv.py')}, 02:01:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:01:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:01:19 INFO - 'installer_path': 'installer.exe', 02:01:19 INFO - 'log_level': 'info', 02:01:19 INFO - 'log_name': 'talos', 02:01:19 INFO - 'log_to_console': True, 02:01:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:01:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:01:19 INFO - 'opt_config_files': (), 02:01:19 INFO - 'pip_index': False, 02:01:19 INFO - 'sps_profile': False, 02:01:19 INFO - 'sps_profile_interval': 0, 02:01:19 INFO - 'suite': 'dromaeojs-e10s', 02:01:19 INFO - 'system_bits': '32', 02:01:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:01:19 INFO - 'title': 'talos-linux64-ix-022', 02:01:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:01:19 INFO - 'use_talos_json': True, 02:01:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:01:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:01:19 INFO - 'work_dir': 'build'} 02:01:19 INFO - ##### 02:01:19 INFO - ##### Running clobber step. 02:01:19 INFO - ##### 02:01:19 INFO - Running pre-action listener: _resource_record_pre_action 02:01:19 INFO - Running main action method: clobber 02:01:19 INFO - rmtree: /builds/slave/test/build 02:01:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:01:19 INFO - Running post-action listener: _resource_record_post_action 02:01:19 INFO - ##### 02:01:19 INFO - ##### Finished clobber step (success) 02:01:19 INFO - ##### 02:01:19 INFO - ##### 02:01:19 INFO - ##### Running read-buildbot-config step. 02:01:19 INFO - ##### 02:01:19 INFO - Running pre-action listener: _resource_record_pre_action 02:01:19 INFO - Running main action method: read_buildbot_config 02:01:19 INFO - Using buildbot properties: 02:01:19 INFO - { 02:01:19 INFO - "project": "", 02:01:19 INFO - "product": "firefox", 02:01:19 INFO - "script_repo_revision": "production", 02:01:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 02:01:19 INFO - "repository": "", 02:01:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 02:01:19 INFO - "buildid": "20160520233021", 02:01:19 INFO - "pgo_build": "True", 02:01:19 INFO - "basedir": "/builds/slave/test", 02:01:19 INFO - "buildnumber": 357, 02:01:19 INFO - "slavename": "talos-linux64-ix-022", 02:01:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:01:19 INFO - "platform": "ubuntu64_hw", 02:01:19 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:01:19 INFO - "branch": "fx-team", 02:01:19 INFO - "repo_path": "integration/fx-team", 02:01:19 INFO - "revision": "54ebf85e87313800ab3b4412861a9d49cef7e2ff", 02:01:19 INFO - "stage_platform": "linux64-pgo", 02:01:19 INFO - "builduid": "0b61c1134ba44a4f9fad29cae09397c2", 02:01:19 INFO - "slavebuilddir": "test" 02:01:19 INFO - } 02:01:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/bXgxElAYTAeIGqpicwVoRg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 02:01:19 INFO - Running post-action listener: _resource_record_post_action 02:01:19 INFO - ##### 02:01:19 INFO - ##### Finished read-buildbot-config step (success) 02:01:19 INFO - ##### 02:01:19 INFO - ##### 02:01:19 INFO - ##### Running download-and-extract step. 02:01:19 INFO - ##### 02:01:19 INFO - Running pre-action listener: _resource_record_pre_action 02:01:19 INFO - Running main action method: download_and_extract 02:01:19 INFO - mkdir: /builds/slave/test/build/tests 02:01:19 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')]} 02:01:19 INFO - https://queue.taskcluster.net/v1/task/bXgxElAYTAeIGqpicwVoRg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:01:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bXgxElAYTAeIGqpicwVoRg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:01:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bXgxElAYTAeIGqpicwVoRg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:01:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bXgxElAYTAeIGqpicwVoRg/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 02:01:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bXgxElAYTAeIGqpicwVoRg/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 02:01:30 INFO - Downloaded 1361 bytes. 02:01:30 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:01:30 INFO - Using the following test package requirements: 02:01:30 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:01:30 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:01:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:01:30 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:01:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:01:30 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:01:30 INFO - u'jsshell-linux-x86_64.zip'], 02:01:30 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:01:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:01:30 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:01:30 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:01:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:01:30 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:01:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:01:30 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:01:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:01:30 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:01:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:01:30 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:01:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:30 INFO - https://queue.taskcluster.net/v1/task/bXgxElAYTAeIGqpicwVoRg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:01:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bXgxElAYTAeIGqpicwVoRg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:01:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bXgxElAYTAeIGqpicwVoRg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:01:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bXgxElAYTAeIGqpicwVoRg/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 02:01:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bXgxElAYTAeIGqpicwVoRg/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 02:01:34 INFO - Downloaded 24389240 bytes. 02:01:34 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'] 02:01:34 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 02:01:35 INFO - Return code: 0 02:01:35 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 02:01:35 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')]} 02:01:35 INFO - https://queue.taskcluster.net/v1/task/bXgxElAYTAeIGqpicwVoRg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:01:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bXgxElAYTAeIGqpicwVoRg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:01:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bXgxElAYTAeIGqpicwVoRg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:01:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bXgxElAYTAeIGqpicwVoRg/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 02:01:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bXgxElAYTAeIGqpicwVoRg/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 02:01:39 INFO - Downloaded 24389240 bytes. 02:01:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:01:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:01:41 INFO - Return code: 0 02:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:41 INFO - https://queue.taskcluster.net/v1/task/bXgxElAYTAeIGqpicwVoRg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:01:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bXgxElAYTAeIGqpicwVoRg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:01:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bXgxElAYTAeIGqpicwVoRg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:01:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bXgxElAYTAeIGqpicwVoRg/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 02:01:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bXgxElAYTAeIGqpicwVoRg/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 02:01:42 INFO - Downloaded 10840359 bytes. 02:01:42 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'] 02:01:42 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 02:01:42 INFO - Return code: 0 02:01:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:42 INFO - https://queue.taskcluster.net/v1/task/bXgxElAYTAeIGqpicwVoRg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:01:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bXgxElAYTAeIGqpicwVoRg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:01:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bXgxElAYTAeIGqpicwVoRg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:01:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bXgxElAYTAeIGqpicwVoRg/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 02:01:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bXgxElAYTAeIGqpicwVoRg/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 02:01:43 INFO - Downloaded 58614074 bytes. 02:01:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bXgxElAYTAeIGqpicwVoRg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:01:43 INFO - mkdir: /builds/slave/test/properties 02:01:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:01:43 INFO - Writing to file /builds/slave/test/properties/build_url 02:01:43 INFO - Contents: 02:01:43 INFO - build_url:https://queue.taskcluster.net/v1/task/bXgxElAYTAeIGqpicwVoRg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:01:44 INFO - Running post-action listener: _resource_record_post_action 02:01:44 INFO - Running post-action listener: set_extra_try_arguments 02:01:44 INFO - ##### 02:01:44 INFO - ##### Finished download-and-extract step (success) 02:01:44 INFO - ##### 02:01:44 INFO - ##### 02:01:44 INFO - ##### Running populate-webroot step. 02:01:44 INFO - ##### 02:01:44 INFO - Running pre-action listener: _resource_record_pre_action 02:01:44 INFO - Running main action method: populate_webroot 02:01:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:01:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:01:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:01:44 INFO - '--tppagecycles', 02:01:44 INFO - '7'], 02:01:44 INFO - 'tests': ['tsvgm']}}, 02:01:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:01:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:01:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:01:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:01:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:01:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:01:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:44 INFO - 'talos_options': ['--disable-e10s'], 02:01:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:01:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:01:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:44 INFO - 'talos_options': ['--disable-e10s'], 02:01:44 INFO - 'tests': ['damp', 'tps']}, 02:01:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:44 INFO - 'tests': ['damp', 'tps']}, 02:01:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:01:44 INFO - 'tests': ['dromaeo_dom']}, 02:01:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:01:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:01:44 INFO - 'tests': ['a11yr', 02:01:44 INFO - 'ts_paint', 02:01:44 INFO - 'tpaint', 02:01:44 INFO - 'sessionrestore', 02:01:44 INFO - 'sessionrestore_no_auto_restore', 02:01:44 INFO - 'tabpaint']}, 02:01:44 INFO - 'other-e10s': {'tests': ['a11yr', 02:01:44 INFO - 'ts_paint', 02:01:44 INFO - 'tpaint', 02:01:44 INFO - 'sessionrestore', 02:01:44 INFO - 'sessionrestore_no_auto_restore', 02:01:44 INFO - 'tabpaint']}, 02:01:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:01:44 INFO - 'ts_paint', 02:01:44 INFO - 'tpaint', 02:01:44 INFO - 'sessionrestore', 02:01:44 INFO - 'sessionrestore_no_auto_restore', 02:01:44 INFO - 'tabpaint']}, 02:01:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:01:44 INFO - 'ts_paint', 02:01:44 INFO - 'tpaint', 02:01:44 INFO - 'sessionrestore', 02:01:44 INFO - 'sessionrestore_no_auto_restore', 02:01:44 INFO - 'tabpaint']}, 02:01:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:01:44 INFO - 'tests': ['a11yr', 02:01:44 INFO - 'ts_paint', 02:01:44 INFO - 'tpaint', 02:01:44 INFO - 'sessionrestore', 02:01:44 INFO - 'sessionrestore_no_auto_restore', 02:01:44 INFO - 'tabpaint']}, 02:01:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:01:44 INFO - 'tests': ['a11yr', 02:01:44 INFO - 'ts_paint', 02:01:44 INFO - 'tpaint', 02:01:44 INFO - 'sessionrestore', 02:01:44 INFO - 'sessionrestore_no_auto_restore', 02:01:44 INFO - 'tabpaint']}, 02:01:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:01:44 INFO - 'tests': ['tsvgx', 02:01:44 INFO - 'tsvgr_opacity', 02:01:44 INFO - 'tart', 02:01:44 INFO - 'tscrollx', 02:01:44 INFO - 'cart']}, 02:01:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:01:44 INFO - 'tsvgr_opacity', 02:01:44 INFO - 'tart', 02:01:44 INFO - 'tscrollx', 02:01:44 INFO - 'cart']}, 02:01:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:44 INFO - 'talos_options': ['--disable-e10s'], 02:01:44 INFO - 'tests': ['tp5o']}, 02:01:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:44 INFO - 'tests': ['tp5o']}, 02:01:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:44 INFO - 'talos_options': ['--disable-e10s', 02:01:44 INFO - '--xperf_path', 02:01:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:01:44 INFO - 'tests': ['tp5n']}, 02:01:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:44 INFO - 'talos_options': ['--xperf_path', 02:01:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:01:44 INFO - 'tests': ['tp5n']}}, 02:01:44 INFO - 'talos.zip': {'path': '', 02:01:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:01:44 INFO - Running post-action listener: _resource_record_post_action 02:01:44 INFO - ##### 02:01:44 INFO - ##### Finished populate-webroot step (success) 02:01:44 INFO - ##### 02:01:44 INFO - ##### 02:01:44 INFO - ##### Running create-virtualenv step. 02:01:44 INFO - ##### 02:01:44 INFO - Running pre-action listener: _resource_record_pre_action 02:01:44 INFO - Running main action method: create_virtualenv 02:01:44 INFO - Creating virtualenv /builds/slave/test/build/venv 02:01:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:01:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:01:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:01:44 INFO - Using real prefix '/usr' 02:01:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:01:45 INFO - Installing distribute.............................................................................................................................................................................................done. 02:01:47 INFO - Installing pip.................done. 02:01:47 INFO - Return code: 0 02:01:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:01:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa161674f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16759c0>, '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 0x16768c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1676d50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1463819972.160150-1898091784', '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 02:01:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:01:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:01:47 INFO - Using env: {'DISPLAY': ':0', 02:01:47 INFO - 'HOME': '/home/cltbld', 02:01:47 INFO - 'LANG': 'en_US.UTF-8', 02:01:47 INFO - 'LANGUAGE': 'en_US:en', 02:01:47 INFO - 'LOGNAME': 'cltbld', 02:01:47 INFO - 'MAIL': '/var/mail/cltbld', 02:01:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:47 INFO - 'MOZ_NO_REMOTE': '1', 02:01:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:01:47 INFO - 'NO_EM_RESTART': '1', 02:01:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:01:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:47 INFO - 'PWD': '/builds/slave/test', 02:01:47 INFO - 'SHELL': '/bin/bash', 02:01:47 INFO - 'SHLVL': '1', 02:01:47 INFO - 'TERM': 'linux', 02:01:47 INFO - 'TMOUT': '86400', 02:01:47 INFO - 'USER': 'cltbld', 02:01:47 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1463819972.160150-1898091784', 02:01:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:47 INFO - '_': '/tools/buildbot/bin/python'} 02:01:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:47 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:01:47 INFO - Cleaning up... 02:01:47 INFO - Return code: 0 02:01:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:01:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa161674f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16759c0>, '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 0x16768c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1676d50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1463819972.160150-1898091784', '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 02:01:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:01:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:01:47 INFO - Using env: {'DISPLAY': ':0', 02:01:47 INFO - 'HOME': '/home/cltbld', 02:01:47 INFO - 'LANG': 'en_US.UTF-8', 02:01:47 INFO - 'LANGUAGE': 'en_US:en', 02:01:47 INFO - 'LOGNAME': 'cltbld', 02:01:47 INFO - 'MAIL': '/var/mail/cltbld', 02:01:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:47 INFO - 'MOZ_NO_REMOTE': '1', 02:01:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:01:47 INFO - 'NO_EM_RESTART': '1', 02:01:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:01:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:47 INFO - 'PWD': '/builds/slave/test', 02:01:47 INFO - 'SHELL': '/bin/bash', 02:01:47 INFO - 'SHLVL': '1', 02:01:47 INFO - 'TERM': 'linux', 02:01:47 INFO - 'TMOUT': '86400', 02:01:47 INFO - 'USER': 'cltbld', 02:01:47 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1463819972.160150-1898091784', 02:01:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:47 INFO - '_': '/tools/buildbot/bin/python'} 02:01:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:47 INFO - Downloading/unpacking psutil>=3.1.1 02:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:01:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:01:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:01:49 INFO - Installing collected packages: psutil 02:01:49 INFO - Running setup.py install for psutil 02:01:49 INFO - building 'psutil._psutil_linux' extension 02:01:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:01:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:01:49 INFO - building 'psutil._psutil_posix' extension 02:01:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:01:50 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 02:01:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:01:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:01:50 INFO - Successfully installed psutil 02:01:50 INFO - Cleaning up... 02:01:50 INFO - Return code: 0 02:01:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa161674f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16759c0>, '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 0x16768c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1676d50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1463819972.160150-1898091784', '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 02:01:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:01:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:01:50 INFO - Using env: {'DISPLAY': ':0', 02:01:50 INFO - 'HOME': '/home/cltbld', 02:01:50 INFO - 'LANG': 'en_US.UTF-8', 02:01:50 INFO - 'LANGUAGE': 'en_US:en', 02:01:50 INFO - 'LOGNAME': 'cltbld', 02:01:50 INFO - 'MAIL': '/var/mail/cltbld', 02:01:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:50 INFO - 'MOZ_NO_REMOTE': '1', 02:01:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:01:50 INFO - 'NO_EM_RESTART': '1', 02:01:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:01:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:50 INFO - 'PWD': '/builds/slave/test', 02:01:50 INFO - 'SHELL': '/bin/bash', 02:01:50 INFO - 'SHLVL': '1', 02:01:50 INFO - 'TERM': 'linux', 02:01:50 INFO - 'TMOUT': '86400', 02:01:50 INFO - 'USER': 'cltbld', 02:01:50 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1463819972.160150-1898091784', 02:01:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:50 INFO - '_': '/tools/buildbot/bin/python'} 02:01:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:01:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:01:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:01:52 INFO - Installing collected packages: mozsystemmonitor 02:01:52 INFO - Running setup.py install for mozsystemmonitor 02:01:52 INFO - Successfully installed mozsystemmonitor 02:01:52 INFO - Cleaning up... 02:01:52 INFO - Return code: 0 02:01:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa161674f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16759c0>, '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 0x16768c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1676d50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1463819972.160150-1898091784', '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 02:01:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:01:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:01:52 INFO - Using env: {'DISPLAY': ':0', 02:01:52 INFO - 'HOME': '/home/cltbld', 02:01:52 INFO - 'LANG': 'en_US.UTF-8', 02:01:52 INFO - 'LANGUAGE': 'en_US:en', 02:01:52 INFO - 'LOGNAME': 'cltbld', 02:01:52 INFO - 'MAIL': '/var/mail/cltbld', 02:01:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:52 INFO - 'MOZ_NO_REMOTE': '1', 02:01:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:01:52 INFO - 'NO_EM_RESTART': '1', 02:01:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:01:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:52 INFO - 'PWD': '/builds/slave/test', 02:01:52 INFO - 'SHELL': '/bin/bash', 02:01:52 INFO - 'SHLVL': '1', 02:01:52 INFO - 'TERM': 'linux', 02:01:52 INFO - 'TMOUT': '86400', 02:01:52 INFO - 'USER': 'cltbld', 02:01:52 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1463819972.160150-1898091784', 02:01:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:52 INFO - '_': '/tools/buildbot/bin/python'} 02:01:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:52 INFO - Downloading/unpacking blobuploader==1.2.4 02:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:54 INFO - Downloading blobuploader-1.2.4.tar.gz 02:01:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:01:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:01: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 02:01: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 02:01: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 02:01: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 02:01: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 02:01: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 02:01:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:01:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:55 INFO - Downloading docopt-0.6.1.tar.gz 02:01:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:01:55 INFO - Installing collected packages: blobuploader, requests, docopt 02:01:55 INFO - Running setup.py install for blobuploader 02:01:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:01:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:01:55 INFO - Running setup.py install for requests 02:01:55 INFO - Running setup.py install for docopt 02:01:55 INFO - Successfully installed blobuploader requests docopt 02:01:55 INFO - Cleaning up... 02:01:55 INFO - Return code: 0 02:01:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:01:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa161674f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16759c0>, '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 0x16768c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1676d50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1463819972.160150-1898091784', '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 02:01:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:01:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:01:55 INFO - Using env: {'DISPLAY': ':0', 02:01:55 INFO - 'HOME': '/home/cltbld', 02:01:55 INFO - 'LANG': 'en_US.UTF-8', 02:01:55 INFO - 'LANGUAGE': 'en_US:en', 02:01:55 INFO - 'LOGNAME': 'cltbld', 02:01:55 INFO - 'MAIL': '/var/mail/cltbld', 02:01:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:55 INFO - 'MOZ_NO_REMOTE': '1', 02:01:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:01:55 INFO - 'NO_EM_RESTART': '1', 02:01:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:01:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:55 INFO - 'PWD': '/builds/slave/test', 02:01:55 INFO - 'SHELL': '/bin/bash', 02:01:55 INFO - 'SHLVL': '1', 02:01:55 INFO - 'TERM': 'linux', 02:01:55 INFO - 'TMOUT': '86400', 02:01:55 INFO - 'USER': 'cltbld', 02:01:55 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1463819972.160150-1898091784', 02:01:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:55 INFO - '_': '/tools/buildbot/bin/python'} 02:01:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:01:56 INFO - Running setup.py (path:/tmp/pip-Rctqou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:01:56 INFO - Running setup.py (path:/tmp/pip-6EdGSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:01:56 INFO - Running setup.py (path:/tmp/pip-bX2ecb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:01:56 INFO - Running setup.py (path:/tmp/pip-yuqpxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:01:56 INFO - Running setup.py (path:/tmp/pip-WA4SnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:01:56 INFO - Running setup.py (path:/tmp/pip-RfzUik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:01:56 INFO - Running setup.py (path:/tmp/pip-jEBP6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:01:56 INFO - Running setup.py (path:/tmp/pip-mTyv1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:01:56 INFO - Running setup.py (path:/tmp/pip-KRJcWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:01:56 INFO - Running setup.py (path:/tmp/pip-q3zFRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:01:56 INFO - Running setup.py (path:/tmp/pip-Eb0V5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:01:56 INFO - Running setup.py (path:/tmp/pip-9dMU78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:01:57 INFO - Running setup.py (path:/tmp/pip-GSlt_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:01:57 INFO - Running setup.py (path:/tmp/pip-U4qNhR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:01:57 INFO - Running setup.py (path:/tmp/pip-ByQCGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:01:57 INFO - Running setup.py (path:/tmp/pip-poZCSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:01:57 INFO - Running setup.py (path:/tmp/pip-VIG5Qf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:01:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:01:57 INFO - Running setup.py install for manifestparser 02:01:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:01:57 INFO - Running setup.py install for mozcrash 02:01:57 INFO - Running setup.py install for mozdebug 02:01:57 INFO - Running setup.py install for mozdevice 02:01:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:01:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:01:57 INFO - Running setup.py install for mozfile 02:01:57 INFO - Running setup.py install for mozhttpd 02:01:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:01:58 INFO - Running setup.py install for mozinfo 02:01:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:01:58 INFO - Running setup.py install for mozInstall 02:01:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:01:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:01:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:01:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:01:58 INFO - Running setup.py install for mozleak 02:01:58 INFO - Running setup.py install for mozlog 02:01:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:01:58 INFO - Running setup.py install for moznetwork 02:01:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:01:58 INFO - Running setup.py install for mozprocess 02:01:58 INFO - Running setup.py install for mozprofile 02:01:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:01:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:01:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:01:58 INFO - Running setup.py install for mozrunner 02:01:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:01:58 INFO - Running setup.py install for mozscreenshot 02:01:58 INFO - Running setup.py install for moztest 02:01:59 INFO - Running setup.py install for mozversion 02:01:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:01:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:01:59 INFO - Cleaning up... 02:01:59 INFO - Return code: 0 02:01:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:01:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa161674f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16759c0>, '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 0x16768c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1676d50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1463819972.160150-1898091784', '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 02:01:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:01:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:01:59 INFO - Using env: {'DISPLAY': ':0', 02:01:59 INFO - 'HOME': '/home/cltbld', 02:01:59 INFO - 'LANG': 'en_US.UTF-8', 02:01:59 INFO - 'LANGUAGE': 'en_US:en', 02:01:59 INFO - 'LOGNAME': 'cltbld', 02:01:59 INFO - 'MAIL': '/var/mail/cltbld', 02:01:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:59 INFO - 'MOZ_NO_REMOTE': '1', 02:01:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:01:59 INFO - 'NO_EM_RESTART': '1', 02:01:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:01:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:59 INFO - 'PWD': '/builds/slave/test', 02:01:59 INFO - 'SHELL': '/bin/bash', 02:01:59 INFO - 'SHLVL': '1', 02:01:59 INFO - 'TERM': 'linux', 02:01:59 INFO - 'TMOUT': '86400', 02:01:59 INFO - 'USER': 'cltbld', 02:01:59 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1463819972.160150-1898091784', 02:01:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:59 INFO - '_': '/tools/buildbot/bin/python'} 02:01:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:01:59 INFO - Running setup.py (path:/tmp/pip-TLfz2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:01:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:01:59 INFO - Running setup.py (path:/tmp/pip-kd_xUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:01:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:01:59 INFO - Running setup.py (path:/tmp/pip-KtHE8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:01:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:01:59 INFO - Running setup.py (path:/tmp/pip-FLApe4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:01:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:01:59 INFO - Running setup.py (path:/tmp/pip-Cmz68a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:01:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:01:59 INFO - Running setup.py (path:/tmp/pip-sd0S0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:01:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:01:59 INFO - Running setup.py (path:/tmp/pip-UV5wsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:01:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:01:59 INFO - Running setup.py (path:/tmp/pip-ycBWto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:02:00 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)) 02:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:02:00 INFO - Running setup.py (path:/tmp/pip-XNcmiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:02:00 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)) 02:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:02:00 INFO - Running setup.py (path:/tmp/pip-CGnduX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:02:00 INFO - Running setup.py (path:/tmp/pip-EJiMUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:02:00 INFO - Running setup.py (path:/tmp/pip-BUTvPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:02:00 INFO - Running setup.py (path:/tmp/pip-MOlSZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:02:00 INFO - Running setup.py (path:/tmp/pip-uOJwjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:02:00 INFO - Running setup.py (path:/tmp/pip-NhL5h2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:02:00 INFO - Running setup.py (path:/tmp/pip-egFv8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:02:00 INFO - Running setup.py (path:/tmp/pip-DNGzFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:02:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:02 INFO - Downloading blessings-1.6.tar.gz 02:02:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:02:02 INFO - Installing collected packages: blessings 02:02:02 INFO - Running setup.py install for blessings 02:02:02 INFO - Successfully installed blessings 02:02:02 INFO - Cleaning up... 02:02:02 INFO - Return code: 0 02:02:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:02:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:02:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:02:03 INFO - Reading from file tmpfile_stdout 02:02:03 INFO - Current package versions: 02:02:03 INFO - argparse == 1.2.1 02:02:03 INFO - blessings == 1.6 02:02:03 INFO - blobuploader == 1.2.4 02:02:03 INFO - docopt == 0.6.1 02:02:03 INFO - manifestparser == 1.1 02:02:03 INFO - mozInstall == 1.12 02:02:03 INFO - mozcrash == 0.17 02:02:03 INFO - mozdebug == 0.1 02:02:03 INFO - mozdevice == 0.48 02:02:03 INFO - mozfile == 1.2 02:02:03 INFO - mozhttpd == 0.7 02:02:03 INFO - mozinfo == 0.9 02:02:03 INFO - mozleak == 0.1 02:02:03 INFO - mozlog == 3.2 02:02:03 INFO - moznetwork == 0.27 02:02:03 INFO - mozprocess == 0.22 02:02:03 INFO - mozprofile == 0.28 02:02:03 INFO - mozrunner == 6.11 02:02:03 INFO - mozscreenshot == 0.1 02:02:03 INFO - mozsystemmonitor == 0.3 02:02:03 INFO - moztest == 0.7 02:02:03 INFO - mozversion == 1.4 02:02:03 INFO - psutil == 3.1.1 02:02:03 INFO - requests == 1.2.3 02:02:03 INFO - wsgiref == 0.1.2 02:02:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:03 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 0x7fa161674f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16759c0>, '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 0x16768c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1676d50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1463819972.160150-1898091784', '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 02:02:03 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 02:02:03 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 02:02:03 INFO - Using env: {'DISPLAY': ':0', 02:02:03 INFO - 'HOME': '/home/cltbld', 02:02:03 INFO - 'LANG': 'en_US.UTF-8', 02:02:03 INFO - 'LANGUAGE': 'en_US:en', 02:02:03 INFO - 'LOGNAME': 'cltbld', 02:02:03 INFO - 'MAIL': '/var/mail/cltbld', 02:02:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:03 INFO - 'MOZ_NO_REMOTE': '1', 02:02:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:03 INFO - 'NO_EM_RESTART': '1', 02:02:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:03 INFO - 'PWD': '/builds/slave/test', 02:02:03 INFO - 'SHELL': '/bin/bash', 02:02:03 INFO - 'SHLVL': '1', 02:02:03 INFO - 'TERM': 'linux', 02:02:03 INFO - 'TMOUT': '86400', 02:02:03 INFO - 'USER': 'cltbld', 02:02:03 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1463819972.160150-1898091784', 02:02:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:03 INFO - '_': '/tools/buildbot/bin/python'} 02:02:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:02:03 INFO - Cleaning up... 02:02:03 INFO - Return code: 0 02:02:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa161674f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16759c0>, '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 0x16768c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1676d50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1463819972.160150-1898091784', '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 02:02:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:02:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:02:03 INFO - Using env: {'DISPLAY': ':0', 02:02:03 INFO - 'HOME': '/home/cltbld', 02:02:03 INFO - 'LANG': 'en_US.UTF-8', 02:02:03 INFO - 'LANGUAGE': 'en_US:en', 02:02:03 INFO - 'LOGNAME': 'cltbld', 02:02:03 INFO - 'MAIL': '/var/mail/cltbld', 02:02:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:03 INFO - 'MOZ_NO_REMOTE': '1', 02:02:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:03 INFO - 'NO_EM_RESTART': '1', 02:02:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:03 INFO - 'PWD': '/builds/slave/test', 02:02:03 INFO - 'SHELL': '/bin/bash', 02:02:03 INFO - 'SHLVL': '1', 02:02:03 INFO - 'TERM': 'linux', 02:02:03 INFO - 'TMOUT': '86400', 02:02:03 INFO - 'USER': 'cltbld', 02:02:03 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1463819972.160150-1898091784', 02:02:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:03 INFO - '_': '/tools/buildbot/bin/python'} 02:02:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:03 INFO - Downloading/unpacking jsonschema 02:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:02:05 INFO - Downloading/unpacking functools32 (from jsonschema) 02:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:05 INFO - Downloading functools32-3.2.3-2.tar.gz 02:02:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:02:05 INFO - warning: no files found matching '*.txt' 02:02:05 INFO - no previously-included directories found matching 'build' 02:02:05 INFO - no previously-included directories found matching 'dist' 02:02:05 INFO - no previously-included directories found matching '.git*' 02:02:05 INFO - Installing collected packages: jsonschema, functools32 02:02:05 INFO - Running setup.py install for functools32 02:02:05 INFO - warning: no files found matching '*.txt' 02:02:05 INFO - no previously-included directories found matching 'build' 02:02:05 INFO - no previously-included directories found matching 'dist' 02:02:05 INFO - no previously-included directories found matching '.git*' 02:02:05 INFO - Successfully installed jsonschema functools32 02:02:05 INFO - Cleaning up... 02:02:05 INFO - Return code: 0 02:02:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:02: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')]} 02:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02: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')]} 02:02:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa161674f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16759c0>, '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 0x16768c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1676d50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1463819972.160150-1898091784', '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 02:02:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:02:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:02:05 INFO - Using env: {'DISPLAY': ':0', 02:02:05 INFO - 'HOME': '/home/cltbld', 02:02:05 INFO - 'LANG': 'en_US.UTF-8', 02:02:05 INFO - 'LANGUAGE': 'en_US:en', 02:02:05 INFO - 'LOGNAME': 'cltbld', 02:02:05 INFO - 'MAIL': '/var/mail/cltbld', 02:02:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:05 INFO - 'MOZ_NO_REMOTE': '1', 02:02:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:05 INFO - 'NO_EM_RESTART': '1', 02:02:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:05 INFO - 'PWD': '/builds/slave/test', 02:02:05 INFO - 'SHELL': '/bin/bash', 02:02:05 INFO - 'SHLVL': '1', 02:02:05 INFO - 'TERM': 'linux', 02:02:05 INFO - 'TMOUT': '86400', 02:02:05 INFO - 'USER': 'cltbld', 02:02:05 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1463819972.160150-1898091784', 02:02:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:05 INFO - '_': '/tools/buildbot/bin/python'} 02:02:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:06 INFO - Downloading/unpacking flake8 02:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:02:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:02: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 02:02: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 02:02: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 02:02: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 02:02: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 02:02: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 02:02:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:02:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:02:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:02:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:02:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:02:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:02:08 INFO - no previously-included directories found matching 'docs/_build' 02:02:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:02:08 INFO - Running setup.py install for pep8 02:02:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:02:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:02:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:02:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:02:08 INFO - no previously-included directories found matching 'docs/_build' 02:02:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:02:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:02:08 INFO - Cleaning up... 02:02:08 INFO - Return code: 0 02:02:08 INFO - Running post-action listener: _resource_record_post_action 02:02:08 INFO - Running post-action listener: _start_resource_monitoring 02:02:08 INFO - Starting resource monitoring. 02:02:08 INFO - ##### 02:02:08 INFO - ##### Finished create-virtualenv step (success) 02:02:08 INFO - ##### 02:02:08 INFO - ##### 02:02:08 INFO - ##### Running install step. 02:02:08 INFO - ##### 02:02:08 INFO - Running pre-action listener: _resource_record_pre_action 02:02:08 INFO - Running main action method: install 02:02:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:02:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:02:09 INFO - Reading from file tmpfile_stdout 02:02:09 INFO - Detecting whether we're running mozinstall >=1.0... 02:02:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:02:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:02:09 INFO - Reading from file tmpfile_stdout 02:02:09 INFO - Output received: 02:02:09 INFO - Usage: mozinstall [options] installer 02:02:09 INFO - Options: 02:02:09 INFO - -h, --help show this help message and exit 02:02:09 INFO - -d DEST, --destination=DEST 02:02:09 INFO - Directory to install application into. [default: 02:02:09 INFO - "/builds/slave/test"] 02:02:09 INFO - --app=APP Application being installed. [default: firefox] 02:02:09 INFO - mkdir: /builds/slave/test/build/application 02:02:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:02:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:02:25 INFO - Reading from file tmpfile_stdout 02:02:25 INFO - Output received: 02:02:25 INFO - /builds/slave/test/build/application/firefox/firefox 02:02:25 INFO - Running post-action listener: _resource_record_post_action 02:02:25 INFO - ##### 02:02:25 INFO - ##### Finished install step (success) 02:02:25 INFO - ##### 02:02:25 INFO - ##### 02:02:25 INFO - ##### Running run-tests step. 02:02:25 INFO - ##### 02:02:25 INFO - Running pre-action listener: _resource_record_pre_action 02:02:25 INFO - Running main action method: run_tests 02:02:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:02:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:02:25 INFO - Python 2.7.3 02:02:25 INFO - Return code: 0 02:02:25 INFO - grabbing minidump binary from tooltool 02:02:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:25 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16759c0>, '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 0x16768c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1676d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:02:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:02:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:02:25 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:02:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:02:25 INFO - Return code: 0 02:02:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:02:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:02:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:02:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:02:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:02:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:02:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:02:26 INFO - Return code: 0 02:02:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bXgxElAYTAeIGqpicwVoRg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 02:02:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bXgxElAYTAeIGqpicwVoRg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 02:02:26 INFO - Using env: {'DISPLAY': ':0', 02:02:26 INFO - 'HOME': '/home/cltbld', 02:02:26 INFO - 'LANG': 'en_US.UTF-8', 02:02:26 INFO - 'LANGUAGE': 'en_US:en', 02:02:26 INFO - 'LOGNAME': 'cltbld', 02:02:26 INFO - 'MAIL': '/var/mail/cltbld', 02:02:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:02:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:02:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:26 INFO - 'MOZ_NO_REMOTE': '1', 02:02:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:02:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:26 INFO - 'NO_EM_RESTART': '1', 02:02:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:26 INFO - 'PWD': '/builds/slave/test', 02:02:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:02:26 INFO - 'SHELL': '/bin/bash', 02:02:26 INFO - 'SHLVL': '1', 02:02:26 INFO - 'TERM': 'linux', 02:02:26 INFO - 'TMOUT': '86400', 02:02:26 INFO - 'USER': 'cltbld', 02:02:26 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1463819972.160150-1898091784', 02:02:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:26 INFO - '_': '/tools/buildbot/bin/python'} 02:02:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bXgxElAYTAeIGqpicwVoRg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 02:02:27 INFO - mozversion application_buildid: 20160520233021 02:02:27 INFO - mozversion application_changeset: 54ebf85e87313800ab3b4412861a9d49cef7e2ff 02:02:27 INFO - mozversion application_display_name: Nightly 02:02:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:02:27 INFO - mozversion application_name: Firefox 02:02:27 INFO - mozversion application_remotingname: firefox 02:02:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:02:27 INFO - mozversion application_vendor: Mozilla 02:02:27 INFO - mozversion application_version: 49.0a1 02:02:27 INFO - mozversion platform_buildid: 20160520233021 02:02:27 INFO - mozversion platform_changeset: 54ebf85e87313800ab3b4412861a9d49cef7e2ff 02:02:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:02:27 INFO - mozversion platform_version: 49.0a1 02:02:27 INFO - using testdate: 1463821347 02:02:27 INFO - actual date: 1463821347 02:02:27 INFO - starting webserver on 'localhost:35983' 02:02:27 INFO - SUITE-START | Running 2 tests 02:02:27 INFO - TEST-START | dromaeo_css 02:02:27 INFO - operating with platform_type : linux_ 02:02:27 INFO - Initialising browser for dromaeo_css test... 02:02:27 INFO - TEST-INFO | started process 5743 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXEI4qr/profile http://localhost:35983/getInfo.html) 02:02:30 INFO - PROCESS | 5743 | 02:02:30 INFO - PROCESS | 5743 | (process:5812): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:02:31 INFO - PROCESS | 5743 | __metrics Screen width/height:1600/1200 02:02:31 INFO - PROCESS | 5743 | colorDepth:24 02:02:31 INFO - PROCESS | 5743 | Browser inner width/height: 1024/697 02:02:31 INFO - PROCESS | 5743 | __metrics 02:02:32 ERROR - PROCESS | 5743 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 02:02:33 INFO - TEST-INFO | 5743: exit 0 02:02:33 INFO - Browser initialized. 02:02:33 INFO - Running cycle 1/1 for dromaeo_css test... 02:02:33 INFO - TEST-INFO | started process 5863 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXEI4qr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:02:35 INFO - PROCESS | 5863 | 02:02:35 INFO - PROCESS | 5863 | (process:5924): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:02:45 INFO - PROCESS | 5863 | RSS: Main: 164233216 02:02:45 INFO - PROCESS | 5863 | 02:03:34 INFO - PROCESS | 5863 | 1463821414661 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] 02:05:42 INFO - PROCESS | 5863 | Cycle 1(1): loaded http://localhost:35983/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35983/tests/dromaeo/cssquery-ext.html) 02:05:43 INFO - PROCESS | 5863 | RSS: Main: 167927808 02:05:43 INFO - PROCESS | 5863 | 02:08:45 INFO - PROCESS | 5863 | Cycle 1(1): loaded http://localhost:35983/tests/dromaeo/cssquery-ext.html (next: http://localhost:35983/tests/dromaeo/cssquery-jquery.html) 02:08:46 INFO - PROCESS | 5863 | RSS: Main: 167407616 02:08:46 INFO - PROCESS | 5863 | 02:11:47 INFO - PROCESS | 5863 | Cycle 1(1): loaded http://localhost:35983/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35983/tests/dromaeo/cssquery-mootools.html) 02:11:48 INFO - PROCESS | 5863 | RSS: Main: 168083456 02:11:48 INFO - PROCESS | 5863 | 02:14:50 INFO - PROCESS | 5863 | Cycle 1(1): loaded http://localhost:35983/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35983/tests/dromaeo/cssquery-prototype.html) 02:14:50 INFO - PROCESS | 5863 | RSS: Main: 166023168 02:14:50 INFO - PROCESS | 5863 | 02:17:53 INFO - PROCESS | 5863 | Cycle 1(1): loaded http://localhost:35983/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35983/tests/dromaeo/cssquery-yui.html) 02:17:54 INFO - PROCESS | 5863 | RSS: Main: 167186432 02:17:54 INFO - PROCESS | 5863 | 02:20:56 INFO - PROCESS | 5863 | Cycle 1(1): loaded http://localhost:35983/tests/dromaeo/cssquery-yui.html (next: http://localhost:35983/tests/dromaeo/cssquery-dojo.html) 02:20:57 INFO - PROCESS | 5863 | RSS: Main: 169230336 02:20:57 INFO - PROCESS | 5863 | 02:20:57 INFO - PROCESS | 5863 | __start_tp_report 02:20:57 INFO - PROCESS | 5863 | _x_x_mozilla_page_load 02:20:57 INFO - PROCESS | 5863 | _x_x_mozilla_page_load_details 02:20:57 INFO - PROCESS | 5863 | |i|pagename|runs| 02:20:57 INFO - PROCESS | 5863 | |0;dojo.html;3069.109958112147;3108.720215180633;3128.8904888328907;3153.132888455674;3170.5719727836736;5410.810621628244;5445.401005889354;5480.040992826254;5507.449255074491;5520.227168196456;5248.816291429801;5396.622236443451;5419.810306639269;5424.593155513333;5477.534409575181;4905.362302900627;4921.753912304388;5030.320906677588;5076.746162691869;5113.360829896263;853.037940587964;4838.9274160887435;4885.584725298354;4900.166971614834;5026.045051440215;4877.244027175793;4903.53416425439;4909.779059942293;4944.752762361867;4950.826721064764;4994.126027945132;5000.249962505617;5002.24966255061;5006.774695138727;5012.498750124995;4892.9510704892855;4923.507649235084;4956.677815941988;4978.029284289565;4979.45226025137;5348.812791552277;5388.515033646991;5416.268803711488;5429.918551221735;5433.293671822677;5629.6340737852315;5726;5851.824445266649;5870.706464676749;5873.735681894325;5780.624259423124;5812.534997200214;5836.737346819361;5852.063669812852;5890.646561206341;5454.699991500466;5460;5465.125579907235;5473.480019398111;5473.644213126134;5843.211166492554;5888.175655408247;5944.494717949023;5963.254593175853;5970;5725.799597014167;5728.198052272685;5735.11105778605;5735.713214339266;5756.827295181151;5882.617629854046;5900.43945825146;5903.468687818117;5908.763649454059;5928.288605367297;5813.680247586423;5882.294124705063;5888.5289176865745;5901.911471327933;5911.320198177179;5850.707464626752;5885.676287804126;5885.823425297248;5892.528597712173;5902.291724993029;4345.3699213613845;4354.934675979863;4355.390245365651;4359.651227901823;4391.297392417262;3750.306193354238;3785.2051069275763;3857.9807100964317;3886.106195574977;3893.3381325174787;5485.9725701371235;5502.147167189092;5508.788066625336;5525.419830917776;5543.944560554423;5801.9129713054335;5835.153902684172;5840.445157710011;5846.269216347957;5865.677387743715;5433.728313584384;5543.916841247385;5593.328800543961;5599.44005599445;5634.126710359901;4908.04293162837;4910.779014944336;4915.926261106087;4920.458749537548;4990.476000020019;5875.647461152259;6042.365551617105;6049.062395328731;6050.848728781815;6084.209052823105;5844.12338149281;5848.736806843617;5865.765369385177;5934.287885453773;5939.227900372924;6095.695215239309;6097.695115244132;6103.206583144163;6103.328633850362;6122.326544080237;5622.887542249214;5703.914441283467;5818.738156782871;5830.038043722739;5832.066869300891;5863.736131874161;5882.794102206402;5922.466977972003;5928.377520360473;5973.163757073926;5704.515116215168;5717.971410142923;5718.857028574319;5764.538836892954;5780.913286300793;5498.862528436821;5653.038983372754;5749.741261643152;5754.7122643866805;5765.942340576708;5621.578381621313;5646.830595082154;5683.062294721325;5707.571932105026;5717.456841600041;5757.9424205757405;5783.16144159103;5786.537077033911;5795.7391917362975;5808.215890854681;5468.070428027166;5516.586256030733;5544.0575102231915;5678.943210567842;5690.715464226855 02:20:57 INFO - PROCESS | 5863 | |1;ext.html;599.0893841361132;631.1983780598637;645.1033064040984;661.8080756580592;676.3034074902852;38566.61433385669;42523.57476425235;42571.574284257185;42583.361249581205;42788;41192.17615647685;41516.37725434121;41658.58341416585;41768.164636707326;41768.79115604418;8594.054653988056;8758.693445729401;8769.166929141753;8786.165314295164;8796.164364385373;8604.440711353773;8659.09079546648;8721.215090641841;8751.299896008304;8751.431156974777;8725.64752463366;8795.692150774725;8800.251978581828;8844.336674749387;8853.71621114938;8772.166644168794;8796.208341249254;8796.560171991376;8820.823583528294;8849.070847561043;8674.826503469958;8691.739247822576;8722.651093956234;8741.125887411272;8774.473531588124;40650.18699626021;40798.38802417966;41042.58957410447;41077.38383924244;41249.58750412518;3820.732548721591;4252.638525725317;4274.166537525184;4317.69776115672;4443;32481.51277730836;32958.17604559881;33392.16519587005;33552.66447335544;35216.471752923724;4228.873133805991;4254.340577210537;4264.360345948102;4316.482022157361;4433.224185767478;334601;335174;335470;335763.321183395;336888;35060.474092888624;36036;61162.388376116556;61184.69407652933;61445.38554614486;37447.06382340409;37453.81273093617;37676.246475070344;37716.81141594274;37754;15648.139352335504;15961.122138282506;15971.44099956496;16000.599985000468;16005.759913601305;13170.60488185356;13204.669883252996;13259.403326850315;13286.867131328756;13343;8508;8539.231469167804;8569.742907712654;8571.271441927382;8599.355048371272;3316.08807577918;3320.5019247113128;3338.8664453421593;3339.098443420263;3363.899083027513;1065.8827528971806;1099.912007039435;1117.6591139702307;1170.7834050700649;1185.6028230542865;32657.67342326594;33009.46797799915;33120.50319245213;33183.502247466306;33262.66737332644;1064.9787004259872;1131.4964840645835;1150.0799360511558;1155.4338374196584;1205.9035277177804;17220.913895430444;17499.737503937453;17507.73738393925;17571.121443927754;17669.55826104332;535168;537132;540556;542485;542660;59140.40859591349;60037;60113.699431502566;60165.39834601598;60227.39772602218;1316.6576690060654;1386.6048176269917;1404.5435233549138;1412.4773833681604;1418.2341535570883;31689.20776980594;32425.35149297048;32916.83541582373;33022.50466243056;33075.83462082674;52394.214086787964;53016.469835301155;53296;53372;53421;434192;435467;436066;436603;438210;26853.731462685122;27309.86345068262;27599.448011039265;27662.446751064464;27714.445711086068;46013.309800352356;47007.52992470031;47404.762976184895;47727;48265.517344826105;40647.39028914628;40654.39018414785;40714.389284161356;40752.388714168716;40773.59226407698;39764;39965.600343996186;40102;40144.598554015254;40960.79519602383;38580.228395431375;39535.40696889492;39986.60013399829;40540.797296013334;40559.797201013804;33016.83491582527;35792.82103589465;36064.459033114;36452;36528;27657;27686.8925242988;27929;27941.161765147077;27950.3012424691 02:20:57 INFO - PROCESS | 5863 | |2;jquery.html;381.6221940279124;385.46805408536216;391.43242298666934;398.83049703875844;406.39447223636773;17595.736063959033;19596.9020154899;19744.111514981825;20163.59672806543;20244.08901599428;18415.171317290722;18457.169427375768;18702.71945920809;18989.33537326194;19176.52058698533;5532.419095994923;5605.215269862222;5686.0333743263745;5720.427957204288;5737.454941780524;5434.375046869602;5615.578831587627;5615.606907516475;5638.267025286727;5652.586853286678;5377.784888604451;5581.553475721953;5586.273784408021;5589.944100558983;5639.6334238274585;5596.636218645775;5633.633813802131;5669.886602267952;5689.374168841445;5704.458076482748;5297.47025297471;5423.484768946943;5478;5479.945200548023;5528.917066244009;12711.936440317739;12998.610041698765;14036.43854245839;22391.664125038136;22475.213367532222;2233.609118404289;2463.322586288767;2812.6840271886153;2868.4263147370402;2912.533994560881;8877.845880035618;9231.261499080125;9785.217182625373;9865.1614612758;9892;1775.3963652358132;1828.424046425385;1851.1577232359243;1855.3691744806831;1870.9625807483774;78728.60635696842;82124.58937705333;84482.73275900928;85870.57064714699;86601.56699216463;9762.219022478184;9997.150242229347;10051.899481005097;10279.537420816081;10444.791104177873;13612.387442565108;13623.318834058258;13700.45198192081;13716.314184290746;13742;7819.530828150329;7890.210978902064;7908.248716371935;8002.5998700064765;8155.388345873965;7767.825008997377;7901.407394445439;7980.3615710743;8054.959725201336;8129.024517057991;4172.351920991191;4330.826766929287;4352.586504282088;4379.49635791888;4429.734215946989;1787.294018862542;1846.3168627607872;1853.9629207415776;1876.5214870208283;1892.1674463236131;871.3377832847082;979.6375341123687;986.9654562090292;1010.883748368947;1071.3518321415588;18428.723569146474;19028.143733532026;19149;19344.226230950884;19381.51546211328;988.322998745847;995.4723996281982;1008.2186305613062;1037.9117774989058;1061.9681409557725;10363.170946324426;10700.250982431311;10745.301555398873;10790.622328218475;10846.945765271123;347292;353035;355096;453743;455917;94938;98048;100725;101188;102421;1024.283001898674;1032.7211652853837;1066.9306495077794;1067.7223921780394;1068.70610582089;17265.39735760146;17291.394801181897;17369.652606947537;17696.115194240494;17762.644747105245;38429.231415370974;42771.35842962296;43296.56703433051;43414;45454.545454545034;54009;57059.71470142623;58457;59873.40126598678;59983.80113392195;8076.919230807616;8315.210055044761;8434.367422443218;8505.192006759347;8578.056413794602;9055.637774488947;13034.283114428417;13818.309084545934;13990.230537320545;14184;12027.879721203026;12073.456694448947;12263.4057572515;12272.386380680751;12307.630771076882;11930.821037684269;12146.939265303618;12282.015192805136;12320.630381088582;12407.689807754878;6448.1295025171;7630.809229769078;12558.43487043067;12609.621711348675;12639.494420223087;8198.549079800669;8360.916390836013;8409.2431681149;8515.148485151683;8550.102239264788;10827.783444330911;12317.07621928341;12326.568570100004;12497.37513124322;12571.748565028465 02:20:57 INFO - PROCESS | 5863 | |3;mootools.html;1540.8998415103022;1564.890457667963;1718.3470281293107;1841.7421560981456;1842.4472658202535;8125.390595705331;8758.86861697075;8798.384113112084;9365.250779937605;9365.67220147295;8903.198712115909;9158.450492970427;9170;9233.49215793131;9282.211012063966;2336.392537940135;2344.1443872986324;2351.200591798788;2362.83460157789;2364.373441038126;2329.7087864017;2338.462153704649;2340.9882950585225;2354.234873666057;2365.562370961378;2221.3780141560387;2238.9776102238934;2250.22367283287;2297.2993237062774;2311.6070268054386;2293.8279629027807;2320.8375413721046;2323.76762323768;2343.3438637181703;2343.6718859359703;2197.7362716473967;2213.4908970936613;2217.645176771709;2221.2447767758877;2225.054351900436;9029.954850225773;9152.267818574499;9184.724458266262;9186.448813071238;9232.307576931757;5329.147336426192;5423.620346575742;5446.782128714846;5455.945440545584;5467.125259958428;3349.3803646325264;3454.6890779829937;3513.2797776455764;3601.4957905893198;3631.328204282216;1065.8667666541683;1072.2976450424985;1082.6860210538935;1090.7545802194522;1104.3705088099787;12507.249565026128;12584.370781460982;12612.936935315356;12733.108682392236;12749.681257968532;4712.057588482317;4712.128256272601;4768.022555376139;4808.495108013608;4837.9032419351415;10701.411422371688;10704.839427408595;10724.14206863449;10741.838872416763;10821.783564328669;5428.782848686087;5463.262459567987;5483.8080667176455;5485.862853428696;5541.667499950016;4394.846180383671;4863.270509423614;5065.11360511909;5077.796888124508;5086.847394578169;4075.735077219971;4147.359590956297;4188.6649068074485;4239.194553034913;4260.2970509866145;1310.1418570836117;1329.2356894785537;1348.2584578481992;1348.5414958914016;1349.0354396606278;925;1017.3743147964096;1046.9738256543646;1051.405955635079;1055.3615062886997;6193.969030154821;6238.563300568917;6321.747130114744;6343.9682801585695;6564.343565643493;955.2644463762864;985.3496692183124;1005.9949700251452;1008.8813491667586;1024.574801457387;4256.7445953242905;4352.042550638855;4401.471823381215;4412.624926881251;4421.734695918255;10968.725781855357;11391.544338226544;11403.543858245743;11425.143114266462;11438.599649012245;10861.67414977552;11202.719932001603;11247.550097996153;11434.771304573862;11484.598039068593;8116.675332986614;8296.87554686668;8332.16678332174;8350.707725229588;8399.62201700925;6113.724882380215;6377.426031656987;6416.935830641633;6455.903161452488;6469.935300646934;9855;10444.373337599769;10537.209709271681;10623;10650.360978341325;10342.793144136924;10569.260151789302;10598.364098154136;10606.734831629272;10635.734106647396;7021.473389495706;7806.06327240712;7879.409044321814;8052.476589021695;8209.302209312274;8945.955270223607;9026.232770214605;9030.819383612423;9070.410423322463;9082.45505269686;7958.681652733826;8227.588620569068;8234.464759790595;8308.418410711192;8321;7963.362930965393;8027.478213916077;8048.235417635316;8162.735554723574;8251.917480825356;6745.021971814158;6749.831254218684;6750.0887380205;6754.831129221612;6827.283135270725;5365.034293827149;5415.268938693226;5458.9454105458435;5476.479734425223;5477.20580515815;5431.972840135774;5516.117421212747;5525.392206857323;5707.143928410772;5747.7413516391025 02:20:57 INFO - PROCESS | 5863 | |4;prototype.html;322.90312906128156;323.19524384283136;327.9081857080018;328.67297039445754;331.51267636574227;5586.553075753935;5655.4061823508555;5656.745446454909;5660.773569057243;5739.741711622976;5602.747876345564;5610.859728506779;5649.864325299457;5704.286964129484;5742.741576629051;4136.751794892301;4195.139996300766;4256.914861702764;4295.582457788938;4316.740995540262;4322.351647252905;4328.372386004027;4355.586219309161;4356.7821608919585;4374.60628543431;4311.611954924057;4312.482502099737;4329.978350108245;4339.589633369152;4353.521112677603;4002.6397624213814;4176.91646167078;4196.874093777161;4200.201961627312;4334.804933777972;3600.6939410150167;3609.62098979606;3617.2946275476293;3631.2737452509605;3638.2905333459985;5376.8118115865755;5394.298741163663;5400.351957765054;5434.510894019518;5462.3445186577865;4612.192866248393;4790.544898234697;4822.300766388889;4860.396069297159;4908.233036106999;5729.369769325371;5864.091065884794;5864.824055278348;5879.706014699248;5895.410458954113;4034.536028356747;4059.451973983504;4068.572799856032;4070.4708387909677;4077.408775727503;5924.318703349127;6019.976603977334;6051.364606716275;6143.969280153616;6163.445289923883;4123;4138.482689663792;4152.667786577066;4160.9375859362135;4162.854300099542;4179.916401672011;4204.4324016257415;4215.178040282116;4222.155568886235;4230.259704551691;4644.3265726470145;4822.71063736177;4844.273358996179;4865.56209941107;4867.34290870735;5821.38875418075;5835.328937172195;5894.233749612523;5902.701405690741;5907.202527658797;1421.4953691439391;1439.855315024558;1441.9062760920506;1443.2062365698823;1445.0607105381375;868.9956550217208;890.1676932068536;891.777055736066;928.6099838068028;946.2902822882838;5416.83749487516;5569.359523654751;5585.357683866408;5591.580631452576;5599.7480113394995;5800.506956908625;5821.7380217890295;5831.416858314219;5851.9707401463575;5883.441073098049;5446.673199607957;5594.916076258859;5642.802501912413;5658.462446067617;5662.405447428043;3163.9367212655616;3186.9043928682177;3212.3093534889645;3215.1640573450604;3215.807051576866;5845.357010728816;6119.877602447926;6137.815865524041;6152.138700581922;6169.598976066542;6044.455998960027;6057.3336932937345;6066.211392518944;6082.482988945989;6093.177421048191;6052;6082.391760823883;6134.693265336805;6161.4454699076405;6181.381861813783;5722.799702010409;5958.702064896651;5984.743203927224;6018.699065046642;6097.207363042776;5958.314793798595;5969.582129250911;5977.22296101504;5994.520438364833;6005.279366476051;5925.644461332334;6217.129601855834;6220.844478888064;6244.906326405198;6250.343658930478;4111.691623128338;4140.627343539096;4150.211459822624;4152.38399808119;4156.397322388298;5963.880722385615;5977.671228082497;6013.278406591237;6015.157877897185;6040.6677632730625;5624.240727501735;5891.381404952418;5922.289325280994;5935.495482883831;5956.493698035715;5899.705014749159;5946.375630558729;5948.940510595012;5974.133750606051;5990.940090599038;5599.748011339418;5687.658740475419;5816.156657284585;5830.271216097988;5898.94101058984;5945.762169513171;5956.672383018802;5973.910391344047;5975.954208013667;6005.288492779537;5582.804601838916;5860.853478663067;5888.293404791452;5904.468597826216;5924.437178468039 02:20:57 INFO - PROCESS | 5863 | |5;yui.html;834.6786487202427;840.8276303357812;852.8081181734115;852.9423514841594;873.148680036964;12746.362681865905;14736.484223052183;14821.851781482183;15018.474353397633;15018.699626007501;13910.860891391083;14506.782398264035;14896.404143834234;14923.776143357858;15451;806.8547661420941;811.6266517402003;816.5019338203691;818.378032695153;819.5697258939045;806.4999700185894;813.9633716482742;814.3322475570035;839.1398816213369;841.3017195727562;861.9784505387385;867.8177582707639;867.9479231246114;868.4138206710477;869.395769939892;852.0584753847003;858.1804376820122;859.4113032572676;861.0399404663817;864.9913500865006;624.5284809968445;627.8147946355836;629.8519847835755;629.9370062993664;632.1686981619156;12857.871421285854;12906.612801615967;12909.741805163843;12969.092163548556;12997.675058123528;13989;14017.85982140186;14033.228172450512;14057.71884562303;14086.436542538286;11319.151063670175;11366.26119302251;11454.370009649549;11474.48364823585;11497.770044599145;3591.174029973121;3599.3161299353037;3629.4192929131477;3632.2553876455263;3664.9816750916343;58382.416175838545;59499;59681;59862;60077.69961150167;10563.63027294041;10640.680779576625;10662.94668526668;10805.783884322269;10942.781144377068;19758.604827903648;20023.399298021082;20046.298379556647;20095.598088038158;20188.39434816958;7424.331810137113;7428.294312040348;7441.665125069385;7487.588182649898;7558.13081495624;4275.187714334266;4384;4384.758838263862;4520.773961301922;4624.421947256593;3529.3470707918605;3595.3528364894046;3622.7826330420257;3632.164602141522;3658.048907284125;631.5326658272937;640.5708175522411;648.7307767276621;649.7563413719855;650.4958657040737;734.2987446988113;766.1227894061269;767.681412213925;778.4473024152802;788.3181048393213;8783.736487905373;8902.777430564287;8924.152205540593;9014.368994170345;9029.864552031724;702.817267510451;739.6375775869892;779.380392587894;788.6332855222349;795.1849354411775;4378.540253273361;4730.905381892343;4766.94809411997;4833.709977401367;4850.223964165787;64468.355316447174;65207.34792652108;66089.33910660927;66880.66559667171;67390;59992.70003650041;60348.39651603516;60482.39517604768;60541.27564259619;62047;54423.99999999921;54622.726886365315;54832.72583637136;55015.724921375935;56561.71719141378;8789.649123683817;8854.424462409923;8975.28197744192;8994.280457563511;9106.772330691785;36671.266574668894;37027.25945481129;37071.443928341636;37275.62724372721;37365;44658;47907.757105660465;48369.75815120902;48457;49082.509174909224;11481.425928703698;11488.712782180512;11693.415329233334;11723.120765942418;11760.76478470443;12973.351332433529;13069.346532673138;13102.344882755633;13183.53857614979;13190;11945.223560468541;12469.75060498803;12473.625791226277;12810.103292769416;12834.29411382383;11843;12271.018318534318;12648.114631975674;12654.304013279358;12658.11393202467;11776.411179440822;12256.14207005501;12296.631101066982;12538.185017973803;12648.936755316165;10458.797238317691;10692.305000174963;10829.729256768644;10851.45742712877;10887.673369798918;10425.218108641731;10941.83587246208;10944.452777361259;10953.780924381626;10966.232363734462 02:20:57 INFO - PROCESS | 5863 | __end_tp_report 02:20:57 INFO - PROCESS | 5863 | __start_cc_report 02:20:57 INFO - PROCESS | 5863 | _x_x_mozilla_cycle_collect,335 02:20:57 INFO - PROCESS | 5863 | __end_cc_report 02:20:57 INFO - PROCESS | 5863 | __startTimestamp1463822457005__endTimestamp 02:20:57 INFO - PROCESS | 5863 | 02:20:57 INFO - PROCESS | 5863 | ------- Summary: start ------- 02:20:57 INFO - PROCESS | 5863 | Number of tests: 6 02:20:57 INFO - PROCESS | 5863 | 02:20:57 INFO - PROCESS | 5863 | [#0] dojo.html Cycles:165 Average:5393.21 Median:5653.04 stddev:735.18 (13.0%) stddev-sans-first:714.47 02:20:57 INFO - PROCESS | 5863 | Values: 3069.1 3108.7 3128.9 3153.1 3170.6 5410.8 5445.4 5480.0 5507.4 5520.2 5248.8 5396.6 5419.8 5424.6 5477.5 4905.4 4921.8 5030.3 5076.7 5113.4 853.0 4838.9 4885.6 4900.2 5026.0 4877.2 4903.5 4909.8 4944.8 4950.8 4994.1 5000.2 5002.2 5006.8 5012.5 4893.0 4923.5 4956.7 4978.0 4979.5 5348.8 5388.5 5416.3 5429.9 5433.3 5629.6 5726.0 5851.8 5870.7 5873.7 5780.6 5812.5 5836.7 5852.1 5890.6 5454.7 5460.0 5465.1 5473.5 5473.6 5843.2 5888.2 5944.5 5963.3 5970.0 5725.8 5728.2 5735.1 5735.7 5756.8 5882.6 5900.4 5903.5 5908.8 5928.3 5813.7 5882.3 5888.5 5901.9 5911.3 5850.7 5885.7 5885.8 5892.5 5902.3 4345.4 4354.9 4355.4 4359.7 4391.3 3750.3 3785.2 3858.0 3886.1 3893.3 5486.0 5502.1 5508.8 5525.4 5543.9 5801.9 5835.2 5840.4 5846.3 5865.7 5433.7 5543.9 5593.3 5599.4 5634.1 4908.0 4910.8 4915.9 4920.5 4990.5 5875.6 6042.4 6049.1 6050.8 6084.2 5844.1 5848.7 5865.8 5934.3 5939.2 6095.7 6097.7 6103.2 6103.3 6122.3 5622.9 5703.9 5818.7 5830.0 5832.1 5863.7 5882.8 5922.5 5928.4 5973.2 5704.5 5718.0 5718.9 5764.5 5780.9 5498.9 5653.0 5749.7 5754.7 5765.9 5621.6 5646.8 5683.1 5707.6 5717.5 5757.9 5783.2 5786.5 5795.7 5808.2 5468.1 5516.6 5544.1 5678.9 5690.7 02:20:57 INFO - PROCESS | 5863 | 02:20:57 INFO - PROCESS | 5863 | [#1] ext.html Cycles:180 Average:58623.76 Median:40684.39 stddev:118229.22 (290.6%) stddev-sans-first:118480.61 02:20:57 INFO - PROCESS | 5863 | Values: 599.1 631.2 645.1 661.8 676.3 38566.6 42523.6 42571.6 42583.4 42788.0 41192.2 41516.4 41658.6 41768.2 41768.8 8594.1 8758.7 8769.2 8786.2 8796.2 8604.4 8659.1 8721.2 8751.3 8751.4 8725.6 8795.7 8800.3 8844.3 8853.7 8772.2 8796.2 8796.6 8820.8 8849.1 8674.8 8691.7 8722.7 8741.1 8774.5 40650.2 40798.4 41042.6 41077.4 41249.6 3820.7 4252.6 4274.2 4317.7 4443.0 32481.5 32958.2 33392.2 33552.7 35216.5 4228.9 4254.3 4264.4 4316.5 4433.2 334601.0 335174.0 335470.0 335763.3 336888.0 35060.5 36036.0 61162.4 61184.7 61445.4 37447.1 37453.8 37676.2 37716.8 37754.0 15648.1 15961.1 15971.4 16000.6 16005.8 13170.6 13204.7 13259.4 13286.9 13343.0 8508.0 8539.2 8569.7 8571.3 8599.4 3316.1 3320.5 3338.9 3339.1 3363.9 1065.9 1099.9 1117.7 1170.8 1185.6 32657.7 33009.5 33120.5 33183.5 33262.7 1065.0 1131.5 1150.1 1155.4 1205.9 17220.9 17499.7 17507.7 17571.1 17669.6 535168.0 537132.0 540556.0 542485.0 542660.0 59140.4 60037.0 60113.7 60165.4 60227.4 1316.7 1386.6 1404.5 1412.5 1418.2 31689.2 32425.4 32916.8 33022.5 33075.8 52394.2 53016.5 53296.0 53372.0 53421.0 434192.0 435467.0 436066.0 436603.0 438210.0 26853.7 27309.9 27599.4 27662.4 27714.4 46013.3 47007.5 47404.8 47727.0 48265.5 40647.4 40654.4 40714.4 40752.4 40773.6 39764.0 39965.6 40102.0 40144.6 40960.8 38580.2 39535.4 39986.6 40540.8 40559.8 33016.8 35792.8 36064.5 36452.0 36528.0 27657.0 27686.9 27929.0 27941.2 27950.3 02:20:57 INFO - PROCESS | 5863 | 02:20:57 INFO - PROCESS | 5863 | [#2] jquery.html Cycles:180 Average:26298.02 Median:177738.81 stddev:66345.31 (37.3%) stddev-sans-first:66502.89 02:20:57 INFO - PROCESS | 5863 | Values: 381.6 385.5 391.4 398.8 406.4 17595.7 19596.9 19744.1 20163.6 20244.1 18415.2 18457.2 18702.7 18989.3 19176.5 5532.4 5605.2 5686.0 5720.4 5737.5 5434.4 5615.6 5615.6 5638.3 5652.6 5377.8 5581.6 5586.3 5589.9 5639.6 5596.6 5633.6 5669.9 5689.4 5704.5 5297.5 5423.5 5478.0 5479.9 5528.9 12711.9 12998.6 14036.4 22391.7 22475.2 2233.6 2463.3 2812.7 2868.4 2912.5 8877.8 9231.3 9785.2 9865.2 9892.0 1775.4 1828.4 1851.2 1855.4 1871.0 78728.6 82124.6 84482.7 85870.6 86601.6 9762.2 9997.2 10051.9 10279.5 10444.8 13612.4 13623.3 13700.5 13716.3 13742.0 7819.5 7890.2 7908.2 8002.6 8155.4 7767.8 7901.4 7980.4 8055.0 8129.0 4172.4 4330.8 4352.6 4379.5 4429.7 1787.3 1846.3 1854.0 1876.5 1892.2 871.3 979.6 987.0 1010.9 1071.4 18428.7 19028.1 19149.0 19344.2 19381.5 988.3 995.5 1008.2 1037.9 1062.0 10363.2 10700.3 10745.3 10790.6 10846.9 347292.0 353035.0 355096.0 453743.0 455917.0 94938.0 98048.0 100725.0 101188.0 102421.0 1024.3 1032.7 1066.9 1067.7 1068.7 17265.4 17291.4 17369.7 17696.1 17762.6 38429.2 42771.4 43296.6 43414.0 45454.5 54009.0 57059.7 58457.0 59873.4 59983.8 8076.9 8315.2 8434.4 8505.2 8578.1 9055.6 13034.3 13818.3 13990.2 14184.0 12027.9 12073.5 12263.4 12272.4 12307.6 11930.8 12146.9 12282.0 12320.6 12407.7 6448.1 7630.8 12558.4 12609.6 12639.5 8198.5 8360.9 8409.2 8515.1 8550.1 10827.8 12317.1 12326.6 12497.4 12571.7 02:20:57 INFO - PROCESS | 5863 | 02:20:57 INFO - PROCESS | 5863 | [#3] mootools.html Cycles:180 Average:6008.17 Median:4417.18 stddev:3417.46 (77.4%) stddev-sans-first:3410.56 02:20:57 INFO - PROCESS | 5863 | Values: 1540.9 1564.9 1718.3 1841.7 1842.4 8125.4 8758.9 8798.4 9365.3 9365.7 8903.2 9158.5 9170.0 9233.5 9282.2 2336.4 2344.1 2351.2 2362.8 2364.4 2329.7 2338.5 2341.0 2354.2 2365.6 2221.4 2239.0 2250.2 2297.3 2311.6 2293.8 2320.8 2323.8 2343.3 2343.7 2197.7 2213.5 2217.6 2221.2 2225.1 9030.0 9152.3 9184.7 9186.4 9232.3 5329.1 5423.6 5446.8 5455.9 5467.1 3349.4 3454.7 3513.3 3601.5 3631.3 1065.9 1072.3 1082.7 1090.8 1104.4 12507.2 12584.4 12612.9 12733.1 12749.7 4712.1 4712.1 4768.0 4808.5 4837.9 10701.4 10704.8 10724.1 10741.8 10821.8 5428.8 5463.3 5483.8 5485.9 5541.7 4394.8 4863.3 5065.1 5077.8 5086.8 4075.7 4147.4 4188.7 4239.2 4260.3 1310.1 1329.2 1348.3 1348.5 1349.0 925.0 1017.4 1047.0 1051.4 1055.4 6194.0 6238.6 6321.7 6344.0 6564.3 955.3 985.3 1006.0 1008.9 1024.6 4256.7 4352.0 4401.5 4412.6 4421.7 10968.7 11391.5 11403.5 11425.1 11438.6 10861.7 11202.7 11247.6 11434.8 11484.6 8116.7 8296.9 8332.2 8350.7 8399.6 6113.7 6377.4 6416.9 6455.9 6469.9 9855.0 10444.4 10537.2 10623.0 10650.4 10342.8 10569.3 10598.4 10606.7 10635.7 7021.5 7806.1 7879.4 8052.5 8209.3 8946.0 9026.2 9030.8 9070.4 9082.5 7958.7 8227.6 8234.5 8308.4 8321.0 7963.4 8027.5 8048.2 8162.7 8251.9 6745.0 6749.8 6750.1 6754.8 6827.3 5365.0 5415.3 5458.9 5476.5 5477.2 5432.0 5516.1 5525.4 5707.1 5747.7 02:20:57 INFO - PROCESS | 5863 | 02:20:57 INFO - PROCESS | 5863 | [#4] prototype.html Cycles:180 Average:4890.00 Median:5656.08 stddev:1476.63 (26.1%) stddev-sans-first:1440.44 02:20:57 INFO - PROCESS | 5863 | Values: 322.9 323.2 327.9 328.7 331.5 5586.6 5655.4 5656.7 5660.8 5739.7 5602.7 5610.9 5649.9 5704.3 5742.7 4136.8 4195.1 4256.9 4295.6 4316.7 4322.4 4328.4 4355.6 4356.8 4374.6 4311.6 4312.5 4330.0 4339.6 4353.5 4002.6 4176.9 4196.9 4200.2 4334.8 3600.7 3609.6 3617.3 3631.3 3638.3 5376.8 5394.3 5400.4 5434.5 5462.3 4612.2 4790.5 4822.3 4860.4 4908.2 5729.4 5864.1 5864.8 5879.7 5895.4 4034.5 4059.5 4068.6 4070.5 4077.4 5924.3 6020.0 6051.4 6144.0 6163.4 4123.0 4138.5 4152.7 4160.9 4162.9 4179.9 4204.4 4215.2 4222.2 4230.3 4644.3 4822.7 4844.3 4865.6 4867.3 5821.4 5835.3 5894.2 5902.7 5907.2 1421.5 1439.9 1441.9 1443.2 1445.1 869.0 890.2 891.8 928.6 946.3 5416.8 5569.4 5585.4 5591.6 5599.7 5800.5 5821.7 5831.4 5852.0 5883.4 5446.7 5594.9 5642.8 5658.5 5662.4 3163.9 3186.9 3212.3 3215.2 3215.8 5845.4 6119.9 6137.8 6152.1 6169.6 6044.5 6057.3 6066.2 6082.5 6093.2 6052.0 6082.4 6134.7 6161.4 6181.4 5722.8 5958.7 5984.7 6018.7 6097.2 5958.3 5969.6 5977.2 5994.5 6005.3 5925.6 6217.1 6220.8 6244.9 6250.3 4111.7 4140.6 4150.2 4152.4 4156.4 5963.9 5977.7 6013.3 6015.2 6040.7 5624.2 5891.4 5922.3 5935.5 5956.5 5899.7 5946.4 5948.9 5974.1 5990.9 5599.7 5687.7 5816.2 5830.3 5898.9 5945.8 5956.7 5973.9 5976.0 6005.3 5582.8 5860.9 5888.3 5904.5 5924.4 02:20:57 INFO - PROCESS | 5863 | 02:20:57 INFO - PROCESS | 5863 | [#5] yui.html Cycles:180 Average:15463.49 Median:4572.60 stddev:18604.19 (406.9%) stddev-sans-first:18623.94 02:20:57 INFO - PROCESS | 5863 | Values: 834.7 840.8 852.8 852.9 873.1 12746.4 14736.5 14821.9 15018.5 15018.7 13910.9 14506.8 14896.4 14923.8 15451.0 806.9 811.6 816.5 818.4 819.6 806.5 814.0 814.3 839.1 841.3 862.0 867.8 867.9 868.4 869.4 852.1 858.2 859.4 861.0 865.0 624.5 627.8 629.9 629.9 632.2 12857.9 12906.6 12909.7 12969.1 12997.7 13989.0 14017.9 14033.2 14057.7 14086.4 11319.2 11366.3 11454.4 11474.5 11497.8 3591.2 3599.3 3629.4 3632.3 3665.0 58382.4 59499.0 59681.0 59862.0 60077.7 10563.6 10640.7 10662.9 10805.8 10942.8 19758.6 20023.4 20046.3 20095.6 20188.4 7424.3 7428.3 7441.7 7487.6 7558.1 4275.2 4384.0 4384.8 4520.8 4624.4 3529.3 3595.4 3622.8 3632.2 3658.0 631.5 640.6 648.7 649.8 650.5 734.3 766.1 767.7 778.4 788.3 8783.7 8902.8 8924.2 9014.4 9029.9 702.8 739.6 779.4 788.6 795.2 4378.5 4730.9 4766.9 4833.7 4850.2 64468.4 65207.3 66089.3 66880.7 67390.0 59992.7 60348.4 60482.4 60541.3 62047.0 54424.0 54622.7 54832.7 55015.7 56561.7 8789.6 8854.4 8975.3 8994.3 9106.8 36671.3 37027.3 37071.4 37275.6 37365.0 44658.0 47907.8 48369.8 48457.0 49082.5 11481.4 11488.7 11693.4 11723.1 11760.8 12973.4 13069.3 13102.3 13183.5 13190.0 11945.2 12469.8 12473.6 12810.1 12834.3 11843.0 12271.0 12648.1 12654.3 12658.1 11776.4 12256.1 12296.6 12538.2 12648.9 10458.8 10692.3 10829.7 10851.5 10887.7 10425.2 10941.8 10944.5 10953.8 10966.2 02:20:57 INFO - PROCESS | 5863 | -------- Summary: end -------- 02:20:57 INFO - PROCESS | 5863 | 02:20:57 INFO - PROCESS | 5863 | 02:20:57 INFO - PROCESS | 5863 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2C0042,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 02:20:57 INFO - PROCESS | 5863 | 02:20:57 INFO - PROCESS | 5863 | 02:20:57 INFO - PROCESS | 5863 | ###!!! [Child][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 02:20:57 INFO - PROCESS | 5863 | 02:20:57 INFO - TEST-INFO | 5863: exit 0 02:20:57 INFO - TEST-OK | dromaeo_css | took 1110610ms 02:20:57 INFO - TEST-START | kraken 02:20:57 INFO - operating with platform_type : linux_ 02:20:57 INFO - Initialising browser for kraken test... 02:20:57 INFO - TEST-INFO | started process 6095 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbN7csW/profile http://localhost:35983/getInfo.html) 02:21:01 INFO - PROCESS | 6095 | 02:21:01 INFO - PROCESS | 6095 | (process:6165): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:21:02 INFO - PROCESS | 6095 | __metrics Screen width/height:1600/1200 02:21:02 INFO - PROCESS | 6095 | colorDepth:24 02:21:02 INFO - PROCESS | 6095 | Browser inner width/height: 1024/697 02:21:02 INFO - PROCESS | 6095 | __metrics 02:21:03 ERROR - PROCESS | 6095 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 02:21:03 INFO - TEST-INFO | 6095: exit 0 02:21:03 INFO - Browser initialized. 02:21:03 INFO - Running cycle 1/1 for kraken test... 02:21:03 INFO - TEST-INFO | started process 6216 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbN7csW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:21:05 INFO - PROCESS | 6216 | 02:21:05 INFO - PROCESS | 6216 | (process:6276): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:21:15 INFO - PROCESS | 6216 | RSS: Main: 164274176 02:21:15 INFO - PROCESS | 6216 | 02:21:18 INFO - PROCESS | 6216 | Cycle 1(1): loaded http://localhost:35983/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35983/tests/kraken/driver.html?testName=audio-beat-detection) 02:21:19 INFO - PROCESS | 6216 | RSS: Main: 168652800 02:21:19 INFO - PROCESS | 6216 | 02:21:21 INFO - PROCESS | 6216 | Cycle 1(1): loaded http://localhost:35983/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35983/tests/kraken/driver.html?testName=audio-dft) 02:21:22 INFO - PROCESS | 6216 | RSS: Main: 168812544 02:21:22 INFO - PROCESS | 6216 | 02:21:25 INFO - PROCESS | 6216 | Cycle 1(1): loaded http://localhost:35983/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35983/tests/kraken/driver.html?testName=audio-fft) 02:21:26 INFO - PROCESS | 6216 | RSS: Main: 163237888 02:21:26 INFO - PROCESS | 6216 | 02:21:28 INFO - PROCESS | 6216 | Cycle 1(1): loaded http://localhost:35983/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35983/tests/kraken/driver.html?testName=audio-oscillator) 02:21:28 INFO - PROCESS | 6216 | RSS: Main: 163553280 02:21:28 INFO - PROCESS | 6216 | 02:21:31 INFO - PROCESS | 6216 | Cycle 1(1): loaded http://localhost:35983/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35983/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:21:31 INFO - PROCESS | 6216 | RSS: Main: 163688448 02:21:31 INFO - PROCESS | 6216 | 02:21:34 INFO - PROCESS | 6216 | Cycle 1(1): loaded http://localhost:35983/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35983/tests/kraken/driver.html?testName=imaging-darkroom) 02:21:35 INFO - PROCESS | 6216 | RSS: Main: 164503552 02:21:35 INFO - PROCESS | 6216 | 02:21:39 INFO - PROCESS | 6216 | Cycle 1(1): loaded http://localhost:35983/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35983/tests/kraken/driver.html?testName=imaging-desaturate) 02:21:39 INFO - PROCESS | 6216 | RSS: Main: 162955264 02:21:39 INFO - PROCESS | 6216 | 02:21:42 INFO - PROCESS | 6216 | Cycle 1(1): loaded http://localhost:35983/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35983/tests/kraken/driver.html?testName=json-parse-financial) 02:21:43 INFO - PROCESS | 6216 | RSS: Main: 163491840 02:21:43 INFO - PROCESS | 6216 | 02:21:44 INFO - PROCESS | 6216 | Cycle 1(1): loaded http://localhost:35983/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35983/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:21:45 INFO - PROCESS | 6216 | RSS: Main: 163999744 02:21:45 INFO - PROCESS | 6216 | 02:21:47 INFO - PROCESS | 6216 | Cycle 1(1): loaded http://localhost:35983/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35983/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:21:47 INFO - PROCESS | 6216 | RSS: Main: 164339712 02:21:47 INFO - PROCESS | 6216 | 02:21:50 INFO - PROCESS | 6216 | Cycle 1(1): loaded http://localhost:35983/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35983/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:21:50 INFO - PROCESS | 6216 | RSS: Main: 164777984 02:21:50 INFO - PROCESS | 6216 | 02:21:53 INFO - PROCESS | 6216 | Cycle 1(1): loaded http://localhost:35983/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35983/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:21:54 INFO - PROCESS | 6216 | RSS: Main: 164876288 02:21:54 INFO - PROCESS | 6216 | 02:21:56 INFO - PROCESS | 6216 | Cycle 1(1): loaded http://localhost:35983/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35983/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:21:57 INFO - PROCESS | 6216 | RSS: Main: 165072896 02:21:57 INFO - PROCESS | 6216 | 02:21:59 INFO - PROCESS | 6216 | Cycle 1(1): loaded http://localhost:35983/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35983/tests/kraken/driver.html?testName=ai-astar) 02:21:59 INFO - PROCESS | 6216 | RSS: Main: 166195200 02:21:59 INFO - PROCESS | 6216 | 02:21:59 INFO - PROCESS | 6216 | __start_tp_report 02:21:59 INFO - PROCESS | 6216 | _x_x_mozilla_page_load 02:21:59 INFO - PROCESS | 6216 | _x_x_mozilla_page_load_details 02:21:59 INFO - PROCESS | 6216 | |i|pagename|runs| 02:21:59 INFO - PROCESS | 6216 | |0;ai-astar;113;105;110;109;112;114;111;110;114;112 02:21:59 INFO - PROCESS | 6216 | |1;audio-beat-detection;157;125;147;215;125;162;155;126;175;133 02:21:59 INFO - PROCESS | 6216 | |2;audio-dft;162;161;162;161;164;176;163;163;162;163 02:21:59 INFO - PROCESS | 6216 | |3;audio-fft;75;76;76;157;75;75;75;75;178;75 02:21:59 INFO - PROCESS | 6216 | |4;audio-oscillator;95;94;184;93;94;93;145;93;93;147 02:21:59 INFO - PROCESS | 6216 | |5;imaging-gaussian-blur;117;118;117;117;117;118;117;119;118;118 02:21:59 INFO - PROCESS | 6216 | |6;imaging-darkroom;146;147;146;146;147;147;147;147;145;146 02:21:59 INFO - PROCESS | 6216 | |7;imaging-desaturate;95;95;94;95;94;96;95;95;96;95 02:21:59 INFO - PROCESS | 6216 | |8;json-parse-financial;55;55;55;56;55;59;54;57;56;55 02:21:59 INFO - PROCESS | 6216 | |9;json-stringify-tinderbox;62;65;62;62;62;62;62;62;60;61 02:21:59 INFO - PROCESS | 6216 | |10;stanford-crypto-aes;79;79;80;80;80;84;80;79;130;80 02:21:59 INFO - PROCESS | 6216 | |11;stanford-crypto-ccm;124;124;124;139;121;128;124;130;136;129 02:21:59 INFO - PROCESS | 6216 | |12;stanford-crypto-pbkdf2;161;158;161;163;166;164;165;166;158;158 02:21:59 INFO - PROCESS | 6216 | |13;stanford-crypto-sha256-iterative;68;63;65;63;67;63;66;63;64;63 02:21:59 INFO - PROCESS | 6216 | __end_tp_report 02:21:59 INFO - PROCESS | 6216 | __start_cc_report 02:21:59 INFO - PROCESS | 6216 | _x_x_mozilla_cycle_collect,854 02:21:59 INFO - PROCESS | 6216 | __end_cc_report 02:21:59 INFO - PROCESS | 6216 | __startTimestamp1463822519439__endTimestamp 02:21:59 INFO - PROCESS | 6216 | 02:21:59 INFO - PROCESS | 6216 | ------- Summary: start ------- 02:21:59 INFO - PROCESS | 6216 | Number of tests: 14 02:21:59 INFO - PROCESS | 6216 | 02:21:59 INFO - PROCESS | 6216 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:2.71 (2.4%) stddev-sans-first:2.77 02:21:59 INFO - PROCESS | 6216 | Values: 113.0 105.0 110.0 109.0 112.0 114.0 111.0 110.0 114.0 112.0 02:21:59 INFO - PROCESS | 6216 | 02:21:59 INFO - PROCESS | 6216 | [#1] audio-beat-detection Cycles:10 Average:152.00 Median:156.00 stddev:28.19 (18.1%) stddev-sans-first:29.84 02:21:59 INFO - PROCESS | 6216 | Values: 157.0 125.0 147.0 215.0 125.0 162.0 155.0 126.0 175.0 133.0 02:21:59 INFO - PROCESS | 6216 | 02:21:59 INFO - PROCESS | 6216 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.00 stddev:4.42 (2.7%) stddev-sans-first:4.65 02:21:59 INFO - PROCESS | 6216 | Values: 162.0 161.0 162.0 161.0 164.0 176.0 163.0 163.0 162.0 163.0 02:21:59 INFO - PROCESS | 6216 | 02:21:59 INFO - PROCESS | 6216 | [#3] audio-fft Cycles:10 Average:93.70 Median:75.00 stddev:39.21 (52.3%) stddev-sans-first:41.00 02:21:59 INFO - PROCESS | 6216 | Values: 75.0 76.0 76.0 157.0 75.0 75.0 75.0 75.0 178.0 75.0 02:21:59 INFO - PROCESS | 6216 | 02:21:59 INFO - PROCESS | 6216 | [#4] audio-oscillator Cycles:10 Average:113.10 Median:93.00 stddev:33.11 (35.6%) stddev-sans-first:34.47 02:21:59 INFO - PROCESS | 6216 | Values: 95.0 94.0 184.0 93.0 94.0 93.0 145.0 93.0 93.0 147.0 02:21:59 INFO - PROCESS | 6216 | 02:21:59 INFO - PROCESS | 6216 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 02:21:59 INFO - PROCESS | 6216 | Values: 117.0 118.0 117.0 117.0 117.0 118.0 117.0 119.0 118.0 118.0 02:21:59 INFO - PROCESS | 6216 | 02:21:59 INFO - PROCESS | 6216 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 02:21:59 INFO - PROCESS | 6216 | Values: 146.0 147.0 146.0 146.0 147.0 147.0 147.0 147.0 145.0 146.0 02:21:59 INFO - PROCESS | 6216 | 02:21:59 INFO - PROCESS | 6216 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 02:21:59 INFO - PROCESS | 6216 | Values: 95.0 95.0 94.0 95.0 94.0 96.0 95.0 95.0 96.0 95.0 02:21:59 INFO - PROCESS | 6216 | 02:21:59 INFO - PROCESS | 6216 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:55.50 stddev:1.42 (2.6%) stddev-sans-first:1.48 02:21:59 INFO - PROCESS | 6216 | Values: 55.0 55.0 55.0 56.0 55.0 59.0 54.0 57.0 56.0 55.0 02:21:59 INFO - PROCESS | 6216 | 02:21:59 INFO - PROCESS | 6216 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:1.25 (2.0%) stddev-sans-first:1.32 02:21:59 INFO - PROCESS | 6216 | Values: 62.0 65.0 62.0 62.0 62.0 62.0 62.0 62.0 60.0 61.0 02:21:59 INFO - PROCESS | 6216 | 02:21:59 INFO - PROCESS | 6216 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:80.00 stddev:15.84 (19.8%) stddev-sans-first:16.65 02:21:59 INFO - PROCESS | 6216 | Values: 79.0 79.0 80.0 80.0 80.0 84.0 80.0 79.0 130.0 80.0 02:21:59 INFO - PROCESS | 6216 | 02:21:59 INFO - PROCESS | 6216 | [#11] stanford-crypto-ccm Cycles:10 Average:127.90 Median:128.50 stddev:5.80 (4.5%) stddev-sans-first:5.98 02:21:59 INFO - PROCESS | 6216 | Values: 124.0 124.0 124.0 139.0 121.0 128.0 124.0 130.0 136.0 129.0 02:21:59 INFO - PROCESS | 6216 | 02:21:59 INFO - PROCESS | 6216 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.00 Median:163.50 stddev:3.27 (2.0%) stddev-sans-first:3.44 02:21:59 INFO - PROCESS | 6216 | Values: 161.0 158.0 161.0 163.0 166.0 164.0 165.0 166.0 158.0 158.0 02:21:59 INFO - PROCESS | 6216 | 02:21:59 INFO - PROCESS | 6216 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:64.50 stddev:1.90 (2.9%) stddev-sans-first:1.54 02:21:59 INFO - PROCESS | 6216 | Values: 68.0 63.0 65.0 63.0 67.0 63.0 66.0 63.0 64.0 63.0 02:21:59 INFO - PROCESS | 6216 | -------- Summary: end -------- 02:21:59 INFO - PROCESS | 6216 | 02:22:00 INFO - TEST-INFO | 6216: exit 0 02:22:00 INFO - TEST-OK | kraken | took 62708ms 02:22:00 INFO - SUITE-END | took 1173s 02:22:00 INFO - Completed test suite (00:19:33) 02:22:00 INFO - javascript benchmark 02:22:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7140.684812071014, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3069.109958112147, 3108.720215180633, 3128.8904888328907, 3153.132888455674, 3170.5719727836736, 5410.810621628244, 5445.401005889354, 5480.040992826254, 5507.449255074491, 5520.227168196456, 5248.816291429801, 5396.622236443451, 5419.810306639269, 5424.593155513333, 5477.534409575181, 4905.362302900627, 4921.753912304388, 5030.320906677588, 5076.746162691869, 5113.360829896263, 853.037940587964, 4838.9274160887435, 4885.584725298354, 4900.166971614834, 5026.045051440215, 4877.244027175793, 4903.53416425439, 4909.779059942293, 4944.752762361867, 4950.826721064764, 4994.126027945132, 5000.249962505617, 5002.24966255061, 5006.774695138727, 5012.498750124995, 4892.9510704892855, 4923.507649235084, 4956.677815941988, 4978.029284289565, 4979.45226025137, 5348.812791552277, 5388.515033646991, 5416.268803711488, 5429.918551221735, 5433.293671822677, 5629.6340737852315, 5726.0, 5851.824445266649, 5870.706464676749, 5873.735681894325, 5780.624259423124, 5812.534997200214, 5836.737346819361, 5852.063669812852, 5890.646561206341, 5454.699991500466, 5460.0, 5465.125579907235, 5473.480019398111, 5473.644213126134, 5843.211166492554, 5888.175655408247, 5944.494717949023, 5963.254593175853, 5970.0, 5725.799597014167, 5728.198052272685, 5735.11105778605, 5735.713214339266, 5756.827295181151, 5882.617629854046, 5900.43945825146, 5903.468687818117, 5908.763649454059, 5928.288605367297, 5813.680247586423, 5882.294124705063, 5888.5289176865745, 5901.911471327933, 5911.320198177179, 5850.707464626752, 5885.676287804126, 5885.823425297248, 5892.528597712173, 5902.291724993029, 4345.3699213613845, 4354.934675979863, 4355.390245365651, 4359.651227901823, 4391.297392417262, 3750.306193354238, 3785.2051069275763, 3857.9807100964317, 3886.106195574977, 3893.3381325174787, 5485.9725701371235, 5502.147167189092, 5508.788066625336, 5525.419830917776, 5543.944560554423, 5801.9129713054335, 5835.153902684172, 5840.445157710011, 5846.269216347957, 5865.677387743715, 5433.728313584384, 5543.916841247385, 5593.328800543961, 5599.44005599445, 5634.126710359901, 4908.04293162837, 4910.779014944336, 4915.926261106087, 4920.458749537548, 4990.476000020019, 5875.647461152259, 6042.365551617105, 6049.062395328731, 6050.848728781815, 6084.209052823105, 5844.12338149281, 5848.736806843617, 5865.765369385177, 5934.287885453773, 5939.227900372924, 6095.695215239309, 6097.695115244132, 6103.206583144163, 6103.328633850362, 6122.326544080237, 5622.887542249214, 5703.914441283467, 5818.738156782871, 5830.038043722739, 5832.066869300891, 5863.736131874161, 5882.794102206402, 5922.466977972003, 5928.377520360473, 5973.163757073926, 5704.515116215168, 5717.971410142923, 5718.857028574319, 5764.538836892954, 5780.913286300793, 5498.862528436821, 5653.038983372754, 5749.741261643152, 5754.7122643866805, 5765.942340576708, 5621.578381621313, 5646.830595082154, 5683.062294721325, 5707.571932105026, 5717.456841600041, 5757.9424205757405, 5783.16144159103, 5786.537077033911, 5795.7391917362975, 5808.215890854681, 5468.070428027166, 5516.586256030733, 5544.0575102231915, 5678.943210567842, 5690.715464226855], "value": 5342.708952180845, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.0893841361132, 631.1983780598637, 645.1033064040984, 661.8080756580592, 676.3034074902852, 38566.61433385669, 42523.57476425235, 42571.574284257185, 42583.361249581205, 42788.0, 41192.17615647685, 41516.37725434121, 41658.58341416585, 41768.164636707326, 41768.79115604418, 8594.054653988056, 8758.693445729401, 8769.166929141753, 8786.165314295164, 8796.164364385373, 8604.440711353773, 8659.09079546648, 8721.215090641841, 8751.299896008304, 8751.431156974777, 8725.64752463366, 8795.692150774725, 8800.251978581828, 8844.336674749387, 8853.71621114938, 8772.166644168794, 8796.208341249254, 8796.560171991376, 8820.823583528294, 8849.070847561043, 8674.826503469958, 8691.739247822576, 8722.651093956234, 8741.125887411272, 8774.473531588124, 40650.18699626021, 40798.38802417966, 41042.58957410447, 41077.38383924244, 41249.58750412518, 3820.732548721591, 4252.638525725317, 4274.166537525184, 4317.69776115672, 4443.0, 32481.51277730836, 32958.17604559881, 33392.16519587005, 33552.66447335544, 35216.471752923724, 4228.873133805991, 4254.340577210537, 4264.360345948102, 4316.482022157361, 4433.224185767478, 334601.0, 335174.0, 335470.0, 335763.321183395, 336888.0, 35060.474092888624, 36036.0, 61162.388376116556, 61184.69407652933, 61445.38554614486, 37447.06382340409, 37453.81273093617, 37676.246475070344, 37716.81141594274, 37754.0, 15648.139352335504, 15961.122138282506, 15971.44099956496, 16000.599985000468, 16005.759913601305, 13170.60488185356, 13204.669883252996, 13259.403326850315, 13286.867131328756, 13343.0, 8508.0, 8539.231469167804, 8569.742907712654, 8571.271441927382, 8599.355048371272, 3316.08807577918, 3320.5019247113128, 3338.8664453421593, 3339.098443420263, 3363.899083027513, 1065.8827528971806, 1099.912007039435, 1117.6591139702307, 1170.7834050700649, 1185.6028230542865, 32657.67342326594, 33009.46797799915, 33120.50319245213, 33183.502247466306, 33262.66737332644, 1064.9787004259872, 1131.4964840645835, 1150.0799360511558, 1155.4338374196584, 1205.9035277177804, 17220.913895430444, 17499.737503937453, 17507.73738393925, 17571.121443927754, 17669.55826104332, 535168.0, 537132.0, 540556.0, 542485.0, 542660.0, 59140.40859591349, 60037.0, 60113.699431502566, 60165.39834601598, 60227.39772602218, 1316.6576690060654, 1386.6048176269917, 1404.5435233549138, 1412.4773833681604, 1418.2341535570883, 31689.20776980594, 32425.35149297048, 32916.83541582373, 33022.50466243056, 33075.83462082674, 52394.214086787964, 53016.469835301155, 53296.0, 53372.0, 53421.0, 434192.0, 435467.0, 436066.0, 436603.0, 438210.0, 26853.731462685122, 27309.86345068262, 27599.448011039265, 27662.446751064464, 27714.445711086068, 46013.309800352356, 47007.52992470031, 47404.762976184895, 47727.0, 48265.517344826105, 40647.39028914628, 40654.39018414785, 40714.389284161356, 40752.388714168716, 40773.59226407698, 39764.0, 39965.600343996186, 40102.0, 40144.598554015254, 40960.79519602383, 38580.228395431375, 39535.40696889492, 39986.60013399829, 40540.797296013334, 40559.797201013804, 33016.83491582527, 35792.82103589465, 36064.459033114, 36452.0, 36528.0, 27657.0, 27686.8925242988, 27929.0, 27941.161765147077, 27950.3012424691], "value": 19043.135261214804, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.6221940279124, 385.46805408536216, 391.43242298666934, 398.83049703875844, 406.39447223636773, 17595.736063959033, 19596.9020154899, 19744.111514981825, 20163.59672806543, 20244.08901599428, 18415.171317290722, 18457.169427375768, 18702.71945920809, 18989.33537326194, 19176.52058698533, 5532.419095994923, 5605.215269862222, 5686.0333743263745, 5720.427957204288, 5737.454941780524, 5434.375046869602, 5615.578831587627, 5615.606907516475, 5638.267025286727, 5652.586853286678, 5377.784888604451, 5581.553475721953, 5586.273784408021, 5589.944100558983, 5639.6334238274585, 5596.636218645775, 5633.633813802131, 5669.886602267952, 5689.374168841445, 5704.458076482748, 5297.47025297471, 5423.484768946943, 5478.0, 5479.945200548023, 5528.917066244009, 12711.936440317739, 12998.610041698765, 14036.43854245839, 22391.664125038136, 22475.213367532222, 2233.609118404289, 2463.322586288767, 2812.6840271886153, 2868.4263147370402, 2912.533994560881, 8877.845880035618, 9231.261499080125, 9785.217182625373, 9865.1614612758, 9892.0, 1775.3963652358132, 1828.424046425385, 1851.1577232359243, 1855.3691744806831, 1870.9625807483774, 78728.60635696842, 82124.58937705333, 84482.73275900928, 85870.57064714699, 86601.56699216463, 9762.219022478184, 9997.150242229347, 10051.899481005097, 10279.537420816081, 10444.791104177873, 13612.387442565108, 13623.318834058258, 13700.45198192081, 13716.314184290746, 13742.0, 7819.530828150329, 7890.210978902064, 7908.248716371935, 8002.5998700064765, 8155.388345873965, 7767.825008997377, 7901.407394445439, 7980.3615710743, 8054.959725201336, 8129.024517057991, 4172.351920991191, 4330.826766929287, 4352.586504282088, 4379.49635791888, 4429.734215946989, 1787.294018862542, 1846.3168627607872, 1853.9629207415776, 1876.5214870208283, 1892.1674463236131, 871.3377832847082, 979.6375341123687, 986.9654562090292, 1010.883748368947, 1071.3518321415588, 18428.723569146474, 19028.143733532026, 19149.0, 19344.226230950884, 19381.51546211328, 988.322998745847, 995.4723996281982, 1008.2186305613062, 1037.9117774989058, 1061.9681409557725, 10363.170946324426, 10700.250982431311, 10745.301555398873, 10790.622328218475, 10846.945765271123, 347292.0, 353035.0, 355096.0, 453743.0, 455917.0, 94938.0, 98048.0, 100725.0, 101188.0, 102421.0, 1024.283001898674, 1032.7211652853837, 1066.9306495077794, 1067.7223921780394, 1068.70610582089, 17265.39735760146, 17291.394801181897, 17369.652606947537, 17696.115194240494, 17762.644747105245, 38429.231415370974, 42771.35842962296, 43296.56703433051, 43414.0, 45454.545454545034, 54009.0, 57059.71470142623, 58457.0, 59873.40126598678, 59983.80113392195, 8076.919230807616, 8315.210055044761, 8434.367422443218, 8505.192006759347, 8578.056413794602, 9055.637774488947, 13034.283114428417, 13818.309084545934, 13990.230537320545, 14184.0, 12027.879721203026, 12073.456694448947, 12263.4057572515, 12272.386380680751, 12307.630771076882, 11930.821037684269, 12146.939265303618, 12282.015192805136, 12320.630381088582, 12407.689807754878, 6448.1295025171, 7630.809229769078, 12558.43487043067, 12609.621711348675, 12639.494420223087, 8198.549079800669, 8360.916390836013, 8409.2431681149, 8515.148485151683, 8550.102239264788, 10827.783444330911, 12317.07621928341, 12326.568570100004, 12497.37513124322, 12571.748565028465], "value": 8995.128602663533, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1540.8998415103022, 1564.890457667963, 1718.3470281293107, 1841.7421560981456, 1842.4472658202535, 8125.390595705331, 8758.86861697075, 8798.384113112084, 9365.250779937605, 9365.67220147295, 8903.198712115909, 9158.450492970427, 9170.0, 9233.49215793131, 9282.211012063966, 2336.392537940135, 2344.1443872986324, 2351.200591798788, 2362.83460157789, 2364.373441038126, 2329.7087864017, 2338.462153704649, 2340.9882950585225, 2354.234873666057, 2365.562370961378, 2221.3780141560387, 2238.9776102238934, 2250.22367283287, 2297.2993237062774, 2311.6070268054386, 2293.8279629027807, 2320.8375413721046, 2323.76762323768, 2343.3438637181703, 2343.6718859359703, 2197.7362716473967, 2213.4908970936613, 2217.645176771709, 2221.2447767758877, 2225.054351900436, 9029.954850225773, 9152.267818574499, 9184.724458266262, 9186.448813071238, 9232.307576931757, 5329.147336426192, 5423.620346575742, 5446.782128714846, 5455.945440545584, 5467.125259958428, 3349.3803646325264, 3454.6890779829937, 3513.2797776455764, 3601.4957905893198, 3631.328204282216, 1065.8667666541683, 1072.2976450424985, 1082.6860210538935, 1090.7545802194522, 1104.3705088099787, 12507.249565026128, 12584.370781460982, 12612.936935315356, 12733.108682392236, 12749.681257968532, 4712.057588482317, 4712.128256272601, 4768.022555376139, 4808.495108013608, 4837.9032419351415, 10701.411422371688, 10704.839427408595, 10724.14206863449, 10741.838872416763, 10821.783564328669, 5428.782848686087, 5463.262459567987, 5483.8080667176455, 5485.862853428696, 5541.667499950016, 4394.846180383671, 4863.270509423614, 5065.11360511909, 5077.796888124508, 5086.847394578169, 4075.735077219971, 4147.359590956297, 4188.6649068074485, 4239.194553034913, 4260.2970509866145, 1310.1418570836117, 1329.2356894785537, 1348.2584578481992, 1348.5414958914016, 1349.0354396606278, 925.0, 1017.3743147964096, 1046.9738256543646, 1051.405955635079, 1055.3615062886997, 6193.969030154821, 6238.563300568917, 6321.747130114744, 6343.9682801585695, 6564.343565643493, 955.2644463762864, 985.3496692183124, 1005.9949700251452, 1008.8813491667586, 1024.574801457387, 4256.7445953242905, 4352.042550638855, 4401.471823381215, 4412.624926881251, 4421.734695918255, 10968.725781855357, 11391.544338226544, 11403.543858245743, 11425.143114266462, 11438.599649012245, 10861.67414977552, 11202.719932001603, 11247.550097996153, 11434.771304573862, 11484.598039068593, 8116.675332986614, 8296.87554686668, 8332.16678332174, 8350.707725229588, 8399.62201700925, 6113.724882380215, 6377.426031656987, 6416.935830641633, 6455.903161452488, 6469.935300646934, 9855.0, 10444.373337599769, 10537.209709271681, 10623.0, 10650.360978341325, 10342.793144136924, 10569.260151789302, 10598.364098154136, 10606.734831629272, 10635.734106647396, 7021.473389495706, 7806.06327240712, 7879.409044321814, 8052.476589021695, 8209.302209312274, 8945.955270223607, 9026.232770214605, 9030.819383612423, 9070.410423322463, 9082.45505269686, 7958.681652733826, 8227.588620569068, 8234.464759790595, 8308.418410711192, 8321.0, 7963.362930965393, 8027.478213916077, 8048.235417635316, 8162.735554723574, 8251.917480825356, 6745.021971814158, 6749.831254218684, 6750.0887380205, 6754.831129221612, 6827.283135270725, 5365.034293827149, 5415.268938693226, 5458.9454105458435, 5476.479734425223, 5477.20580515815, 5431.972840135774, 5516.117421212747, 5525.392206857323, 5707.143928410772, 5747.7413516391025], "value": 4796.789908320122, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.90312906128156, 323.19524384283136, 327.9081857080018, 328.67297039445754, 331.51267636574227, 5586.553075753935, 5655.4061823508555, 5656.745446454909, 5660.773569057243, 5739.741711622976, 5602.747876345564, 5610.859728506779, 5649.864325299457, 5704.286964129484, 5742.741576629051, 4136.751794892301, 4195.139996300766, 4256.914861702764, 4295.582457788938, 4316.740995540262, 4322.351647252905, 4328.372386004027, 4355.586219309161, 4356.7821608919585, 4374.60628543431, 4311.611954924057, 4312.482502099737, 4329.978350108245, 4339.589633369152, 4353.521112677603, 4002.6397624213814, 4176.91646167078, 4196.874093777161, 4200.201961627312, 4334.804933777972, 3600.6939410150167, 3609.62098979606, 3617.2946275476293, 3631.2737452509605, 3638.2905333459985, 5376.8118115865755, 5394.298741163663, 5400.351957765054, 5434.510894019518, 5462.3445186577865, 4612.192866248393, 4790.544898234697, 4822.300766388889, 4860.396069297159, 4908.233036106999, 5729.369769325371, 5864.091065884794, 5864.824055278348, 5879.706014699248, 5895.410458954113, 4034.536028356747, 4059.451973983504, 4068.572799856032, 4070.4708387909677, 4077.408775727503, 5924.318703349127, 6019.976603977334, 6051.364606716275, 6143.969280153616, 6163.445289923883, 4123.0, 4138.482689663792, 4152.667786577066, 4160.9375859362135, 4162.854300099542, 4179.916401672011, 4204.4324016257415, 4215.178040282116, 4222.155568886235, 4230.259704551691, 4644.3265726470145, 4822.71063736177, 4844.273358996179, 4865.56209941107, 4867.34290870735, 5821.38875418075, 5835.328937172195, 5894.233749612523, 5902.701405690741, 5907.202527658797, 1421.4953691439391, 1439.855315024558, 1441.9062760920506, 1443.2062365698823, 1445.0607105381375, 868.9956550217208, 890.1676932068536, 891.777055736066, 928.6099838068028, 946.2902822882838, 5416.83749487516, 5569.359523654751, 5585.357683866408, 5591.580631452576, 5599.7480113394995, 5800.506956908625, 5821.7380217890295, 5831.416858314219, 5851.9707401463575, 5883.441073098049, 5446.673199607957, 5594.916076258859, 5642.802501912413, 5658.462446067617, 5662.405447428043, 3163.9367212655616, 3186.9043928682177, 3212.3093534889645, 3215.1640573450604, 3215.807051576866, 5845.357010728816, 6119.877602447926, 6137.815865524041, 6152.138700581922, 6169.598976066542, 6044.455998960027, 6057.3336932937345, 6066.211392518944, 6082.482988945989, 6093.177421048191, 6052.0, 6082.391760823883, 6134.693265336805, 6161.4454699076405, 6181.381861813783, 5722.799702010409, 5958.702064896651, 5984.743203927224, 6018.699065046642, 6097.207363042776, 5958.314793798595, 5969.582129250911, 5977.22296101504, 5994.520438364833, 6005.279366476051, 5925.644461332334, 6217.129601855834, 6220.844478888064, 6244.906326405198, 6250.343658930478, 4111.691623128338, 4140.627343539096, 4150.211459822624, 4152.38399808119, 4156.397322388298, 5963.880722385615, 5977.671228082497, 6013.278406591237, 6015.157877897185, 6040.6677632730625, 5624.240727501735, 5891.381404952418, 5922.289325280994, 5935.495482883831, 5956.493698035715, 5899.705014749159, 5946.375630558729, 5948.940510595012, 5974.133750606051, 5990.940090599038, 5599.748011339418, 5687.658740475419, 5816.156657284585, 5830.271216097988, 5898.94101058984, 5945.762169513171, 5956.672383018802, 5973.910391344047, 5975.954208013667, 6005.288492779537, 5582.804601838916, 5860.853478663067, 5888.293404791452, 5904.468597826216, 5924.437178468039], "value": 4406.0477154821465, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [834.6786487202427, 840.8276303357812, 852.8081181734115, 852.9423514841594, 873.148680036964, 12746.362681865905, 14736.484223052183, 14821.851781482183, 15018.474353397633, 15018.699626007501, 13910.860891391083, 14506.782398264035, 14896.404143834234, 14923.776143357858, 15451.0, 806.8547661420941, 811.6266517402003, 816.5019338203691, 818.378032695153, 819.5697258939045, 806.4999700185894, 813.9633716482742, 814.3322475570035, 839.1398816213369, 841.3017195727562, 861.9784505387385, 867.8177582707639, 867.9479231246114, 868.4138206710477, 869.395769939892, 852.0584753847003, 858.1804376820122, 859.4113032572676, 861.0399404663817, 864.9913500865006, 624.5284809968445, 627.8147946355836, 629.8519847835755, 629.9370062993664, 632.1686981619156, 12857.871421285854, 12906.612801615967, 12909.741805163843, 12969.092163548556, 12997.675058123528, 13989.0, 14017.85982140186, 14033.228172450512, 14057.71884562303, 14086.436542538286, 11319.151063670175, 11366.26119302251, 11454.370009649549, 11474.48364823585, 11497.770044599145, 3591.174029973121, 3599.3161299353037, 3629.4192929131477, 3632.2553876455263, 3664.9816750916343, 58382.416175838545, 59499.0, 59681.0, 59862.0, 60077.69961150167, 10563.63027294041, 10640.680779576625, 10662.94668526668, 10805.783884322269, 10942.781144377068, 19758.604827903648, 20023.399298021082, 20046.298379556647, 20095.598088038158, 20188.39434816958, 7424.331810137113, 7428.294312040348, 7441.665125069385, 7487.588182649898, 7558.13081495624, 4275.187714334266, 4384.0, 4384.758838263862, 4520.773961301922, 4624.421947256593, 3529.3470707918605, 3595.3528364894046, 3622.7826330420257, 3632.164602141522, 3658.048907284125, 631.5326658272937, 640.5708175522411, 648.7307767276621, 649.7563413719855, 650.4958657040737, 734.2987446988113, 766.1227894061269, 767.681412213925, 778.4473024152802, 788.3181048393213, 8783.736487905373, 8902.777430564287, 8924.152205540593, 9014.368994170345, 9029.864552031724, 702.817267510451, 739.6375775869892, 779.380392587894, 788.6332855222349, 795.1849354411775, 4378.540253273361, 4730.905381892343, 4766.94809411997, 4833.709977401367, 4850.223964165787, 64468.355316447174, 65207.34792652108, 66089.33910660927, 66880.66559667171, 67390.0, 59992.70003650041, 60348.39651603516, 60482.39517604768, 60541.27564259619, 62047.0, 54423.99999999921, 54622.726886365315, 54832.72583637136, 55015.724921375935, 56561.71719141378, 8789.649123683817, 8854.424462409923, 8975.28197744192, 8994.280457563511, 9106.772330691785, 36671.266574668894, 37027.25945481129, 37071.443928341636, 37275.62724372721, 37365.0, 44658.0, 47907.757105660465, 48369.75815120902, 48457.0, 49082.509174909224, 11481.425928703698, 11488.712782180512, 11693.415329233334, 11723.120765942418, 11760.76478470443, 12973.351332433529, 13069.346532673138, 13102.344882755633, 13183.53857614979, 13190.0, 11945.223560468541, 12469.75060498803, 12473.625791226277, 12810.103292769416, 12834.29411382383, 11843.0, 12271.018318534318, 12648.114631975674, 12654.304013279358, 12658.11393202467, 11776.411179440822, 12256.14207005501, 12296.631101066982, 12538.185017973803, 12648.936755316165, 10458.797238317691, 10692.305000174963, 10829.729256768644, 10851.45742712877, 10887.673369798918, 10425.218108641731, 10941.83587246208, 10944.452777361259, 10953.780924381626, 10966.232363734462], "value": 6853.178147173598, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1549.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 105.0, 110.0, 109.0, 112.0, 114.0, 111.0, 110.0, 114.0, 112.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 125.0, 147.0, 215.0, 125.0, 162.0, 155.0, 126.0, 175.0, 133.0], "value": 152.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 161.0, 164.0, 176.0, 163.0, 163.0, 162.0, 163.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 157.0, 75.0, 75.0, 75.0, 75.0, 178.0, 75.0], "value": 93.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 184.0, 93.0, 94.0, 93.0, 145.0, 93.0, 93.0, 147.0], "value": 113.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 119.0, 118.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 145.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 94.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 56.0, 55.0, 59.0, 54.0, 57.0, 56.0, 55.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 60.0, 61.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 80.0, 80.0, 80.0, 84.0, 80.0, 79.0, 130.0, 80.0], "value": 85.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 124.0, 124.0, 139.0, 121.0, 128.0, 124.0, 130.0, 136.0, 129.0], "value": 127.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 158.0, 161.0, 163.0, 166.0, 164.0, 165.0, 166.0, 158.0, 158.0], "value": 162.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 63.0, 65.0, 63.0, 67.0, 63.0, 66.0, 63.0, 64.0, 63.0], "value": 64.5, "unit": "score"}]}]} 02:22:00 INFO - Return code: 0 02:22:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:22:00 ERROR - # TBPL SUCCESS # 02:22:00 INFO - Running post-action listener: _resource_record_post_action 02:22:00 INFO - ##### 02:22:00 INFO - ##### Finished run-tests step (success) 02:22:00 INFO - ##### 02:22:00 INFO - Running post-run listener: _resource_record_post_run 02:22:00 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 537780224; Read time: 16; Write time: 400760 02:22:00 INFO - TinderboxPrint: CPU usage
13.3% 02:22:00 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 02:22:00 INFO - TinderboxPrint: I/O write bytes / time
537,780,224 / 400,760 02:22:00 INFO - TinderboxPrint: CPU idle
8,234.4 (86.6%) 02:22:00 INFO - TinderboxPrint: CPU user
1,218.8 (12.8%) 02:22:00 INFO - TinderboxPrint: Swap in / out
0 / 0 02:22:00 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247115776; Read time: 0; Write time: 231956 02:22:00 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290664448; Read time: 16; Write time: 168804 02:22:01 INFO - Running post-run listener: _upload_blobber_files 02:22:01 INFO - Blob upload gear active. 02:22:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:22:01 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 02:22:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:22:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:22:01 INFO - (blobuploader) - INFO - Open directory for files ... 02:22:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:22:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:22:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:22:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:22:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:22:02 INFO - (blobuploader) - INFO - Done attempting. 02:22:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:22:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:22:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:22:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:22:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:22:06 INFO - (blobuploader) - INFO - Done attempting. 02:22:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:22:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:22:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:22:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:22:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:22:07 INFO - (blobuploader) - INFO - Done attempting. 02:22:07 INFO - (blobuploader) - INFO - Iteration through files over. 02:22:07 INFO - Return code: 0 02:22:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:22:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:22:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/231aec0a60ca6827e579848212ac2e43267f0814c4d164c909aad092d39505262f4d6d0256da79d2b2fdbdeefd8fe9e497520ece11dfdd46994ac040d13a763a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/325fb06c9bb26b4d69ad21f6adb57c17a95a8853b3de35f87575b37ebfe93ae7122089815344c0fe879e1f32816db78ea43306bf43efa3fcdec43e09f266f6d3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ed8fcf47358dd1818991827824d58de40f73656547099abc1540f2127c492787dffb0571c409b6c1d489234edfab4ea60c4ad92ba20ec7847b172c6e65312299"} 02:22:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:22:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:22:07 INFO - Contents: 02:22:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/231aec0a60ca6827e579848212ac2e43267f0814c4d164c909aad092d39505262f4d6d0256da79d2b2fdbdeefd8fe9e497520ece11dfdd46994ac040d13a763a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/325fb06c9bb26b4d69ad21f6adb57c17a95a8853b3de35f87575b37ebfe93ae7122089815344c0fe879e1f32816db78ea43306bf43efa3fcdec43e09f266f6d3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ed8fcf47358dd1818991827824d58de40f73656547099abc1540f2127c492787dffb0571c409b6c1d489234edfab4ea60c4ad92ba20ec7847b172c6e65312299"} 02:22:07 INFO - Running post-run listener: copy_logs_to_upload_dir 02:22:07 INFO - Copying logs to upload dir... 02:22:07 INFO - mkdir: /builds/slave/test/build/upload/logs 02:22:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.652618 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-05-21 02:22:07.503932) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-21 02:22:07.508099) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1463819972.160150-1898091784 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/231aec0a60ca6827e579848212ac2e43267f0814c4d164c909aad092d39505262f4d6d0256da79d2b2fdbdeefd8fe9e497520ece11dfdd46994ac040d13a763a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/325fb06c9bb26b4d69ad21f6adb57c17a95a8853b3de35f87575b37ebfe93ae7122089815344c0fe879e1f32816db78ea43306bf43efa3fcdec43e09f266f6d3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ed8fcf47358dd1818991827824d58de40f73656547099abc1540f2127c492787dffb0571c409b6c1d489234edfab4ea60c4ad92ba20ec7847b172c6e65312299"} build_url:https://queue.taskcluster.net/v1/task/bXgxElAYTAeIGqpicwVoRg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011283 build_url: 'https://queue.taskcluster.net/v1/task/bXgxElAYTAeIGqpicwVoRg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/231aec0a60ca6827e579848212ac2e43267f0814c4d164c909aad092d39505262f4d6d0256da79d2b2fdbdeefd8fe9e497520ece11dfdd46994ac040d13a763a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/325fb06c9bb26b4d69ad21f6adb57c17a95a8853b3de35f87575b37ebfe93ae7122089815344c0fe879e1f32816db78ea43306bf43efa3fcdec43e09f266f6d3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ed8fcf47358dd1818991827824d58de40f73656547099abc1540f2127c492787dffb0571c409b6c1d489234edfab4ea60c4ad92ba20ec7847b172c6e65312299"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-21 02:22:07.533249) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 02:22:07.533577) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1463819972.160150-1898091784 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004528 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 02:22:07.617797) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-21 02:22:07.618106) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-21 02:22:07.618408) ========= ========= Total master_lag: 0.22 =========