builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-048 starttime: 1464253720.68 results: success (0) buildid: 20160525233010 builduid: 3f1cb44f9d244a569628c16826ad3686 revision: 25566a14a7ac98674bfe9b6e73edc59fcc286c22 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 02:08:40.677659) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 02:08:40.678118) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 02:08:40.678413) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 02:08:40.696186) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 02:08:40.696533) ========= 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=fa44defc139c4ba8574fe040000001db-1464249528.487429-1766275797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-26 02:08:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-05-26 02:08:41 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.082615 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 02:08:40.793801) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 02:08:40.794083) ========= 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=fa44defc139c4ba8574fe040000001db-1464249528.487429-1766275797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018677 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 02:08:40.845134) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 02:08:40.845534) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 25566a14a7ac98674bfe9b6e73edc59fcc286c22 --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 25566a14a7ac98674bfe9b6e73edc59fcc286c22 --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=fa44defc139c4ba8574fe040000001db-1464249528.487429-1766275797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-26 02:08:41,278 truncating revision to first 12 chars 2016-05-26 02:08:41,278 Setting DEBUG logging. 2016-05-26 02:08:41,278 attempt 1/10 2016-05-26 02:08:41,278 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/25566a14a7ac?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-26 02:08:41,581 unpacking tar archive at: fx-team-25566a14a7ac/testing/mozharness/ program finished with exit code 0 elapsedTime=0.652480 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 02:08:41.515073) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 02:08:41.515340) ========= script_repo_revision: 25566a14a7ac98674bfe9b6e73edc59fcc286c22 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 02:08:41.515702) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 02:08:41.516046) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 02:08:41.526040) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-26 02:08:41.526304) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=fa44defc139c4ba8574fe040000001db-1464249528.487429-1766275797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:08:42 INFO - MultiFileLogger online at 20160526 02:08:42 in /builds/slave/test 02:08:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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:08:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:08:42 INFO - {'append_to_log': False, 02:08:42 INFO - 'base_work_dir': '/builds/slave/test', 02:08:42 INFO - 'blob_upload_branch': 'Fx-Team', 02:08:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:08:42 INFO - 'branch': 'Fx-Team', 02:08:42 INFO - 'buildbot_json_path': 'buildprops.json', 02:08:42 INFO - 'config_files': ('talos/linux_config.py',), 02:08:42 INFO - 'default_actions': ('clobber', 02:08:42 INFO - 'read-buildbot-config', 02:08:42 INFO - 'download-and-extract', 02:08:42 INFO - 'populate-webroot', 02:08:42 INFO - 'create-virtualenv', 02:08:42 INFO - 'install', 02:08:42 INFO - 'run-tests'), 02:08:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:08:42 INFO - 'download_minidump_stackwalk': True, 02:08:42 INFO - 'download_symbols': 'ondemand', 02:08:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:08:42 INFO - 'tooltool.py': '/tools/tooltool.py', 02:08:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:08:42 INFO - '/tools/misc-python/virtualenv.py')}, 02:08:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:08:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:08:42 INFO - 'installer_path': 'installer.exe', 02:08:42 INFO - 'log_level': 'info', 02:08:42 INFO - 'log_name': 'talos', 02:08:42 INFO - 'log_to_console': True, 02:08:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:08:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:08:42 INFO - 'opt_config_files': (), 02:08:42 INFO - 'pip_index': False, 02:08:42 INFO - 'sps_profile': False, 02:08:42 INFO - 'sps_profile_interval': 0, 02:08:42 INFO - 'suite': 'dromaeojs', 02:08:42 INFO - 'system_bits': '32', 02:08:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:08:42 INFO - 'title': 'talos-linux64-ix-048', 02:08:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:08:42 INFO - 'use_talos_json': True, 02:08:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:08:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:08:42 INFO - 'work_dir': 'build'} 02:08:42 INFO - ##### 02:08:42 INFO - ##### Running clobber step. 02:08:42 INFO - ##### 02:08:42 INFO - Running pre-action listener: _resource_record_pre_action 02:08:42 INFO - Running main action method: clobber 02:08:42 INFO - rmtree: /builds/slave/test/build 02:08:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:08:42 INFO - Running post-action listener: _resource_record_post_action 02:08:42 INFO - ##### 02:08:42 INFO - ##### Finished clobber step (success) 02:08:42 INFO - ##### 02:08:42 INFO - ##### 02:08:42 INFO - ##### Running read-buildbot-config step. 02:08:42 INFO - ##### 02:08:42 INFO - Running pre-action listener: _resource_record_pre_action 02:08:42 INFO - Running main action method: read_buildbot_config 02:08:42 INFO - Using buildbot properties: 02:08:42 INFO - { 02:08:42 INFO - "project": "", 02:08:42 INFO - "product": "firefox", 02:08:42 INFO - "script_repo_revision": "production", 02:08:42 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:08:42 INFO - "repository": "", 02:08:42 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 02:08:42 INFO - "buildid": "20160525233010", 02:08:42 INFO - "pgo_build": "True", 02:08:42 INFO - "basedir": "/builds/slave/test", 02:08:42 INFO - "buildnumber": 1189, 02:08:42 INFO - "slavename": "talos-linux64-ix-048", 02:08:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:08:42 INFO - "platform": "ubuntu64_hw", 02:08:42 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:08:42 INFO - "branch": "fx-team", 02:08:42 INFO - "repo_path": "integration/fx-team", 02:08:42 INFO - "revision": "25566a14a7ac98674bfe9b6e73edc59fcc286c22", 02:08:42 INFO - "stage_platform": "linux64-pgo", 02:08:42 INFO - "builduid": "3f1cb44f9d244a569628c16826ad3686", 02:08:42 INFO - "slavebuilddir": "test" 02:08:42 INFO - } 02:08:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/I7s261IMTPecN0rhP9R1hg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 02:08:42 INFO - Running post-action listener: _resource_record_post_action 02:08:42 INFO - ##### 02:08:42 INFO - ##### Finished read-buildbot-config step (success) 02:08:42 INFO - ##### 02:08:42 INFO - ##### 02:08:42 INFO - ##### Running download-and-extract step. 02:08:42 INFO - ##### 02:08:42 INFO - Running pre-action listener: _resource_record_pre_action 02:08:42 INFO - Running main action method: download_and_extract 02:08:42 INFO - mkdir: /builds/slave/test/build/tests 02:08: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:08:42 INFO - https://queue.taskcluster.net/v1/task/I7s261IMTPecN0rhP9R1hg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:08:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I7s261IMTPecN0rhP9R1hg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:08:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I7s261IMTPecN0rhP9R1hg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:08:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I7s261IMTPecN0rhP9R1hg/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:08:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I7s261IMTPecN0rhP9R1hg/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:08:43 INFO - Downloaded 1361 bytes. 02:08:43 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:08:43 INFO - Using the following test package requirements: 02:08:43 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:08:43 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:08:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:08:43 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:08:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:08:43 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:08:43 INFO - u'jsshell-linux-x86_64.zip'], 02:08:43 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:08:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:08:43 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:08:43 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:08:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:08:43 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:08:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:08:43 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:08:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:08:43 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:08:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:08:43 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:43 INFO - https://queue.taskcluster.net/v1/task/I7s261IMTPecN0rhP9R1hg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:08:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I7s261IMTPecN0rhP9R1hg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:08:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I7s261IMTPecN0rhP9R1hg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:08:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I7s261IMTPecN0rhP9R1hg/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:08:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I7s261IMTPecN0rhP9R1hg/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:08:44 INFO - Downloaded 24408666 bytes. 02:08:44 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:08:44 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:08:45 INFO - Return code: 0 02:08:45 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:08:45 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:08:45 INFO - https://queue.taskcluster.net/v1/task/I7s261IMTPecN0rhP9R1hg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:08:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I7s261IMTPecN0rhP9R1hg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:08:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I7s261IMTPecN0rhP9R1hg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:08:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I7s261IMTPecN0rhP9R1hg/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:08:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I7s261IMTPecN0rhP9R1hg/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:08:47 INFO - Downloaded 24408666 bytes. 02:08:47 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:08:47 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:08:49 INFO - Return code: 0 02:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:49 INFO - https://queue.taskcluster.net/v1/task/I7s261IMTPecN0rhP9R1hg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:08:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I7s261IMTPecN0rhP9R1hg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:08:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I7s261IMTPecN0rhP9R1hg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:08:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I7s261IMTPecN0rhP9R1hg/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:08:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I7s261IMTPecN0rhP9R1hg/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:08:50 INFO - Downloaded 10834034 bytes. 02:08:50 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:08:50 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:08:50 INFO - Return code: 0 02:08: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:08:50 INFO - https://queue.taskcluster.net/v1/task/I7s261IMTPecN0rhP9R1hg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:08:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I7s261IMTPecN0rhP9R1hg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:08:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I7s261IMTPecN0rhP9R1hg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:08:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I7s261IMTPecN0rhP9R1hg/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:08:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I7s261IMTPecN0rhP9R1hg/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:08:52 INFO - Downloaded 58674028 bytes. 02:08:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I7s261IMTPecN0rhP9R1hg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:08:52 INFO - mkdir: /builds/slave/test/properties 02:08:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:08:52 INFO - Writing to file /builds/slave/test/properties/build_url 02:08:52 INFO - Contents: 02:08:52 INFO - build_url:https://queue.taskcluster.net/v1/task/I7s261IMTPecN0rhP9R1hg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:08:53 INFO - Running post-action listener: _resource_record_post_action 02:08:53 INFO - Running post-action listener: set_extra_try_arguments 02:08:53 INFO - ##### 02:08:53 INFO - ##### Finished download-and-extract step (success) 02:08:53 INFO - ##### 02:08:53 INFO - ##### 02:08:53 INFO - ##### Running populate-webroot step. 02:08:53 INFO - ##### 02:08:53 INFO - Running pre-action listener: _resource_record_pre_action 02:08:53 INFO - Running main action method: populate_webroot 02:08:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:08:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:08:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:08:53 INFO - '--tppagecycles', 02:08:53 INFO - '7'], 02:08:53 INFO - 'tests': ['tsvgm']}}, 02:08:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:08:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:08:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:08:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:08:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:08:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:08:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:53 INFO - 'talos_options': ['--disable-e10s'], 02:08:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:08:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:08:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:53 INFO - 'talos_options': ['--disable-e10s'], 02:08:53 INFO - 'tests': ['damp', 'tps']}, 02:08:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:53 INFO - 'tests': ['damp', 'tps']}, 02:08:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:08:53 INFO - 'tests': ['dromaeo_dom']}, 02:08:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:08:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:08:53 INFO - 'tests': ['a11yr', 02:08:53 INFO - 'ts_paint', 02:08:53 INFO - 'tpaint', 02:08:53 INFO - 'sessionrestore', 02:08:53 INFO - 'sessionrestore_no_auto_restore', 02:08:53 INFO - 'tabpaint']}, 02:08:53 INFO - 'other-e10s': {'tests': ['a11yr', 02:08:53 INFO - 'ts_paint', 02:08:53 INFO - 'tpaint', 02:08:53 INFO - 'sessionrestore', 02:08:53 INFO - 'sessionrestore_no_auto_restore', 02:08:53 INFO - 'tabpaint']}, 02:08:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:08:53 INFO - 'ts_paint', 02:08:53 INFO - 'tpaint', 02:08:53 INFO - 'sessionrestore', 02:08:53 INFO - 'sessionrestore_no_auto_restore', 02:08:53 INFO - 'tabpaint']}, 02:08:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:08:53 INFO - 'ts_paint', 02:08:53 INFO - 'tpaint', 02:08:53 INFO - 'sessionrestore', 02:08:53 INFO - 'sessionrestore_no_auto_restore', 02:08:53 INFO - 'tabpaint']}, 02:08:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:08:53 INFO - 'tests': ['a11yr', 02:08:53 INFO - 'ts_paint', 02:08:53 INFO - 'tpaint', 02:08:53 INFO - 'sessionrestore', 02:08:53 INFO - 'sessionrestore_no_auto_restore', 02:08:53 INFO - 'tabpaint']}, 02:08:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:08:53 INFO - 'tests': ['a11yr', 02:08:53 INFO - 'ts_paint', 02:08:53 INFO - 'tpaint', 02:08:53 INFO - 'sessionrestore', 02:08:53 INFO - 'sessionrestore_no_auto_restore', 02:08:53 INFO - 'tabpaint']}, 02:08:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:08:53 INFO - 'tests': ['tsvgx', 02:08:53 INFO - 'tsvgr_opacity', 02:08:53 INFO - 'tart', 02:08:53 INFO - 'tscrollx', 02:08:53 INFO - 'cart']}, 02:08:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:08:53 INFO - 'tsvgr_opacity', 02:08:53 INFO - 'tart', 02:08:53 INFO - 'tscrollx', 02:08:53 INFO - 'cart']}, 02:08:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:53 INFO - 'talos_options': ['--disable-e10s'], 02:08:53 INFO - 'tests': ['tp5o']}, 02:08:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:53 INFO - 'tests': ['tp5o']}, 02:08:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:53 INFO - 'talos_options': ['--disable-e10s', 02:08:53 INFO - '--xperf_path', 02:08:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:08:53 INFO - 'tests': ['tp5n']}, 02:08:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:53 INFO - 'talos_options': ['--xperf_path', 02:08:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:08:53 INFO - 'tests': ['tp5n']}}, 02:08:53 INFO - 'talos.zip': {'path': '', 02:08:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:08:53 INFO - Running post-action listener: _resource_record_post_action 02:08:53 INFO - ##### 02:08:53 INFO - ##### Finished populate-webroot step (success) 02:08:53 INFO - ##### 02:08:53 INFO - ##### 02:08:53 INFO - ##### Running create-virtualenv step. 02:08:53 INFO - ##### 02:08:53 INFO - Running pre-action listener: _resource_record_pre_action 02:08:53 INFO - Running main action method: create_virtualenv 02:08:53 INFO - Creating virtualenv /builds/slave/test/build/venv 02:08:53 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:08:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:08:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:08:53 INFO - Using real prefix '/usr' 02:08:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:08:53 INFO - Installing distribute.............................................................................................................................................................................................done. 02:08:55 INFO - Installing pip.................done. 02:08:55 INFO - Return code: 0 02:08:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:08: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:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08: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:08:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd1b839f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1805770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18949c0>, '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 0x18958c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1895d50>, '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': 'fa44defc139c4ba8574fe040000001db-1464249528.487429-1766275797', '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:08:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:08:55 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:08:55 INFO - Using env: {'DISPLAY': ':0', 02:08:55 INFO - 'HOME': '/home/cltbld', 02:08:55 INFO - 'LANG': 'en_US.UTF-8', 02:08:55 INFO - 'LANGUAGE': 'en_US:en', 02:08:55 INFO - 'LOGNAME': 'cltbld', 02:08:55 INFO - 'MAIL': '/var/mail/cltbld', 02:08:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:55 INFO - 'MOZ_NO_REMOTE': '1', 02:08:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:08:55 INFO - 'NO_EM_RESTART': '1', 02:08:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:08:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:55 INFO - 'PWD': '/builds/slave/test', 02:08:55 INFO - 'SHELL': '/bin/bash', 02:08:55 INFO - 'SHLVL': '1', 02:08:55 INFO - 'TERM': 'linux', 02:08:55 INFO - 'TMOUT': '86400', 02:08:55 INFO - 'USER': 'cltbld', 02:08:55 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464249528.487429-1766275797', 02:08:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:55 INFO - '_': '/tools/buildbot/bin/python'} 02:08:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:55 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:08:55 INFO - Cleaning up... 02:08:55 INFO - Return code: 0 02:08:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:08: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:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08: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:08:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcd1b839f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1805770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18949c0>, '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 0x18958c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1895d50>, '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': 'fa44defc139c4ba8574fe040000001db-1464249528.487429-1766275797', '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:08:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:08:55 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:08:55 INFO - Using env: {'DISPLAY': ':0', 02:08:55 INFO - 'HOME': '/home/cltbld', 02:08:55 INFO - 'LANG': 'en_US.UTF-8', 02:08:55 INFO - 'LANGUAGE': 'en_US:en', 02:08:55 INFO - 'LOGNAME': 'cltbld', 02:08:55 INFO - 'MAIL': '/var/mail/cltbld', 02:08:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:55 INFO - 'MOZ_NO_REMOTE': '1', 02:08:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:08:55 INFO - 'NO_EM_RESTART': '1', 02:08:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:08:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:55 INFO - 'PWD': '/builds/slave/test', 02:08:55 INFO - 'SHELL': '/bin/bash', 02:08:55 INFO - 'SHLVL': '1', 02:08:55 INFO - 'TERM': 'linux', 02:08:55 INFO - 'TMOUT': '86400', 02:08:55 INFO - 'USER': 'cltbld', 02:08:55 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464249528.487429-1766275797', 02:08:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:55 INFO - '_': '/tools/buildbot/bin/python'} 02:08:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:56 INFO - Downloading/unpacking psutil>=3.1.1 02:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:08:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:08:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:08:58 INFO - Installing collected packages: psutil 02:08:58 INFO - Running setup.py install for psutil 02:08:58 INFO - building 'psutil._psutil_linux' extension 02:08:58 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:08:58 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:08:58 INFO - building 'psutil._psutil_posix' extension 02:08:58 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:08:58 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:08:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:08:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:08:58 INFO - Successfully installed psutil 02:08:58 INFO - Cleaning up... 02:08:58 INFO - Return code: 0 02:08:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd1b839f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1805770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18949c0>, '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 0x18958c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1895d50>, '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': 'fa44defc139c4ba8574fe040000001db-1464249528.487429-1766275797', '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:08:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:08:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:08:58 INFO - Using env: {'DISPLAY': ':0', 02:08:58 INFO - 'HOME': '/home/cltbld', 02:08:58 INFO - 'LANG': 'en_US.UTF-8', 02:08:58 INFO - 'LANGUAGE': 'en_US:en', 02:08:58 INFO - 'LOGNAME': 'cltbld', 02:08:58 INFO - 'MAIL': '/var/mail/cltbld', 02:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:58 INFO - 'MOZ_NO_REMOTE': '1', 02:08:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:08:58 INFO - 'NO_EM_RESTART': '1', 02:08:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:58 INFO - 'PWD': '/builds/slave/test', 02:08:58 INFO - 'SHELL': '/bin/bash', 02:08:58 INFO - 'SHLVL': '1', 02:08:58 INFO - 'TERM': 'linux', 02:08:58 INFO - 'TMOUT': '86400', 02:08:58 INFO - 'USER': 'cltbld', 02:08:58 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464249528.487429-1766275797', 02:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:58 INFO - '_': '/tools/buildbot/bin/python'} 02:08:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:09:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:09:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:09:00 INFO - Installing collected packages: mozsystemmonitor 02:09:00 INFO - Running setup.py install for mozsystemmonitor 02:09:00 INFO - Successfully installed mozsystemmonitor 02:09:00 INFO - Cleaning up... 02:09:01 INFO - Return code: 0 02:09:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:09:01 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:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:01 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:09:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:01 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 0x7fcd1b839f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1805770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18949c0>, '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 0x18958c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1895d50>, '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': 'fa44defc139c4ba8574fe040000001db-1464249528.487429-1766275797', '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:09:01 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:09:01 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:09:01 INFO - Using env: {'DISPLAY': ':0', 02:09:01 INFO - 'HOME': '/home/cltbld', 02:09:01 INFO - 'LANG': 'en_US.UTF-8', 02:09:01 INFO - 'LANGUAGE': 'en_US:en', 02:09:01 INFO - 'LOGNAME': 'cltbld', 02:09:01 INFO - 'MAIL': '/var/mail/cltbld', 02:09:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:01 INFO - 'MOZ_NO_REMOTE': '1', 02:09:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:09:01 INFO - 'NO_EM_RESTART': '1', 02:09:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:09:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:01 INFO - 'PWD': '/builds/slave/test', 02:09:01 INFO - 'SHELL': '/bin/bash', 02:09:01 INFO - 'SHLVL': '1', 02:09:01 INFO - 'TERM': 'linux', 02:09:01 INFO - 'TMOUT': '86400', 02:09:01 INFO - 'USER': 'cltbld', 02:09:01 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464249528.487429-1766275797', 02:09:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:01 INFO - '_': '/tools/buildbot/bin/python'} 02:09:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:01 INFO - Downloading/unpacking blobuploader==1.2.4 02:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:03 INFO - Downloading blobuploader-1.2.4.tar.gz 02:09:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:09:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:09: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:09: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:09: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:09: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:09: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:09: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:09:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:09:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:09: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:09: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:09: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:09: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:09: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:09: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:09:03 INFO - Downloading docopt-0.6.1.tar.gz 02:09:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:09:03 INFO - Installing collected packages: blobuploader, requests, docopt 02:09:03 INFO - Running setup.py install for blobuploader 02:09:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:09:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:09:03 INFO - Running setup.py install for requests 02:09:04 INFO - Running setup.py install for docopt 02:09:04 INFO - Successfully installed blobuploader requests docopt 02:09:04 INFO - Cleaning up... 02:09:04 INFO - Return code: 0 02:09:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:09:04 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:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:04 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:09:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:04 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 0x7fcd1b839f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1805770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18949c0>, '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 0x18958c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1895d50>, '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': 'fa44defc139c4ba8574fe040000001db-1464249528.487429-1766275797', '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:09:04 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:09:04 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:09:04 INFO - Using env: {'DISPLAY': ':0', 02:09:04 INFO - 'HOME': '/home/cltbld', 02:09:04 INFO - 'LANG': 'en_US.UTF-8', 02:09:04 INFO - 'LANGUAGE': 'en_US:en', 02:09:04 INFO - 'LOGNAME': 'cltbld', 02:09:04 INFO - 'MAIL': '/var/mail/cltbld', 02:09:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:04 INFO - 'MOZ_NO_REMOTE': '1', 02:09:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:09:04 INFO - 'NO_EM_RESTART': '1', 02:09:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:09:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:04 INFO - 'PWD': '/builds/slave/test', 02:09:04 INFO - 'SHELL': '/bin/bash', 02:09:04 INFO - 'SHLVL': '1', 02:09:04 INFO - 'TERM': 'linux', 02:09:04 INFO - 'TMOUT': '86400', 02:09:04 INFO - 'USER': 'cltbld', 02:09:04 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464249528.487429-1766275797', 02:09:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:04 INFO - '_': '/tools/buildbot/bin/python'} 02:09:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:09:04 INFO - Running setup.py (path:/tmp/pip-OAnh5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:09:04 INFO - Running setup.py (path:/tmp/pip-c767bA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:09:04 INFO - Running setup.py (path:/tmp/pip-qPMRlm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:09:04 INFO - Running setup.py (path:/tmp/pip-6dcsdQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:09:04 INFO - Running setup.py (path:/tmp/pip-qnQ4ci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:09:05 INFO - Running setup.py (path:/tmp/pip-Xm5ERH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:09:05 INFO - Running setup.py (path:/tmp/pip-XXNg97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:09:05 INFO - Running setup.py (path:/tmp/pip-5mVzB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:09:05 INFO - Running setup.py (path:/tmp/pip-_oesNq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:09:05 INFO - Running setup.py (path:/tmp/pip-kM1aOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:09:05 INFO - Running setup.py (path:/tmp/pip-iBaPB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:09:05 INFO - Running setup.py (path:/tmp/pip-dEyvRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:09:05 INFO - Running setup.py (path:/tmp/pip-CDbMug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:09:05 INFO - Running setup.py (path:/tmp/pip-QnWlJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:09:05 INFO - Running setup.py (path:/tmp/pip-zfLYhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:09:05 INFO - Running setup.py (path:/tmp/pip-Ll0o1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:09:05 INFO - Running setup.py (path:/tmp/pip-tiE0vm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:09:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:09:05 INFO - Running setup.py install for manifestparser 02:09:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:09:06 INFO - Running setup.py install for mozcrash 02:09:06 INFO - Running setup.py install for mozdebug 02:09:06 INFO - Running setup.py install for mozdevice 02:09:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:09:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:09:06 INFO - Running setup.py install for mozfile 02:09:06 INFO - Running setup.py install for mozhttpd 02:09:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:09:06 INFO - Running setup.py install for mozinfo 02:09:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:09:06 INFO - Running setup.py install for mozInstall 02:09:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:09:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:09:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:09:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:09:06 INFO - Running setup.py install for mozleak 02:09:06 INFO - Running setup.py install for mozlog 02:09:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:09:06 INFO - Running setup.py install for moznetwork 02:09:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:09:07 INFO - Running setup.py install for mozprocess 02:09:07 INFO - Running setup.py install for mozprofile 02:09:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:09:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:09:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:09:07 INFO - Running setup.py install for mozrunner 02:09:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:09:07 INFO - Running setup.py install for mozscreenshot 02:09:07 INFO - Running setup.py install for moztest 02:09:07 INFO - Running setup.py install for mozversion 02:09:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:09:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:09:07 INFO - Cleaning up... 02:09:07 INFO - Return code: 0 02:09:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:09:07 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:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:07 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:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:07 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 0x7fcd1b839f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1805770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18949c0>, '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 0x18958c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1895d50>, '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': 'fa44defc139c4ba8574fe040000001db-1464249528.487429-1766275797', '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:09:07 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:09:07 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:09:07 INFO - Using env: {'DISPLAY': ':0', 02:09:07 INFO - 'HOME': '/home/cltbld', 02:09:07 INFO - 'LANG': 'en_US.UTF-8', 02:09:07 INFO - 'LANGUAGE': 'en_US:en', 02:09:07 INFO - 'LOGNAME': 'cltbld', 02:09:07 INFO - 'MAIL': '/var/mail/cltbld', 02:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:07 INFO - 'MOZ_NO_REMOTE': '1', 02:09:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:09:07 INFO - 'NO_EM_RESTART': '1', 02:09:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:07 INFO - 'PWD': '/builds/slave/test', 02:09:07 INFO - 'SHELL': '/bin/bash', 02:09:07 INFO - 'SHLVL': '1', 02:09:07 INFO - 'TERM': 'linux', 02:09:07 INFO - 'TMOUT': '86400', 02:09:07 INFO - 'USER': 'cltbld', 02:09:07 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464249528.487429-1766275797', 02:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:07 INFO - '_': '/tools/buildbot/bin/python'} 02:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:09:07 INFO - Running setup.py (path:/tmp/pip-8fbj3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:09:07 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:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:09:07 INFO - Running setup.py (path:/tmp/pip-IxglIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:09:08 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:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:09:08 INFO - Running setup.py (path:/tmp/pip-5w_fYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:09:08 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:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:09:08 INFO - Running setup.py (path:/tmp/pip-W4NQcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:09:08 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:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:09:08 INFO - Running setup.py (path:/tmp/pip-jbrqgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:09:08 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:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:09:08 INFO - Running setup.py (path:/tmp/pip-VysIKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:09:08 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:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:09:08 INFO - Running setup.py (path:/tmp/pip-09TvTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:09:08 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:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:09:08 INFO - Running setup.py (path:/tmp/pip-5qfrMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:09:08 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:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:09:08 INFO - Running setup.py (path:/tmp/pip-rFVQdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:09:08 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:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:09:08 INFO - Running setup.py (path:/tmp/pip-F3vaLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:09:08 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:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:09:08 INFO - Running setup.py (path:/tmp/pip-TJrzvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:09:08 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:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:09:08 INFO - Running setup.py (path:/tmp/pip-vjVVzh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:09:08 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:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:09:08 INFO - Running setup.py (path:/tmp/pip-fT65VY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:09:08 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:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:09:08 INFO - Running setup.py (path:/tmp/pip-gHv8LD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:09:08 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:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:09:08 INFO - Running setup.py (path:/tmp/pip-IV9DlE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:09:09 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:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:09:09 INFO - Running setup.py (path:/tmp/pip-qhYTKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:09:09 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:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:09:09 INFO - Running setup.py (path:/tmp/pip-6NII2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:09:09 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:09:09 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:09:09 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:09:09 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:09:09 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:09:09 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:09:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:11 INFO - Downloading blessings-1.6.tar.gz 02:09:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:09:11 INFO - Installing collected packages: blessings 02:09:11 INFO - Running setup.py install for blessings 02:09:11 INFO - Successfully installed blessings 02:09:11 INFO - Cleaning up... 02:09:11 INFO - Return code: 0 02:09:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:09:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:09:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:09:11 INFO - Reading from file tmpfile_stdout 02:09:11 INFO - Current package versions: 02:09:11 INFO - argparse == 1.2.1 02:09:11 INFO - blessings == 1.6 02:09:11 INFO - blobuploader == 1.2.4 02:09:11 INFO - docopt == 0.6.1 02:09:11 INFO - manifestparser == 1.1 02:09:11 INFO - mozInstall == 1.12 02:09:11 INFO - mozcrash == 0.17 02:09:11 INFO - mozdebug == 0.1 02:09:11 INFO - mozdevice == 0.48 02:09:11 INFO - mozfile == 1.2 02:09:11 INFO - mozhttpd == 0.7 02:09:11 INFO - mozinfo == 0.9 02:09:11 INFO - mozleak == 0.1 02:09:11 INFO - mozlog == 3.2 02:09:11 INFO - moznetwork == 0.27 02:09:11 INFO - mozprocess == 0.22 02:09:11 INFO - mozprofile == 0.28 02:09:11 INFO - mozrunner == 6.11 02:09:11 INFO - mozscreenshot == 0.1 02:09:11 INFO - mozsystemmonitor == 0.3 02:09:11 INFO - moztest == 0.7 02:09:11 INFO - mozversion == 1.4 02:09:11 INFO - psutil == 3.1.1 02:09:11 INFO - requests == 1.2.3 02:09:11 INFO - wsgiref == 0.1.2 02:09:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:09:11 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:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:11 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:09:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:11 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 0x7fcd1b839f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1805770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18949c0>, '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 0x18958c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1895d50>, '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': 'fa44defc139c4ba8574fe040000001db-1464249528.487429-1766275797', '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:09:11 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:09:11 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:09:11 INFO - Using env: {'DISPLAY': ':0', 02:09:11 INFO - 'HOME': '/home/cltbld', 02:09:11 INFO - 'LANG': 'en_US.UTF-8', 02:09:11 INFO - 'LANGUAGE': 'en_US:en', 02:09:11 INFO - 'LOGNAME': 'cltbld', 02:09:11 INFO - 'MAIL': '/var/mail/cltbld', 02:09:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:11 INFO - 'MOZ_NO_REMOTE': '1', 02:09:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:09:11 INFO - 'NO_EM_RESTART': '1', 02:09:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:09:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:11 INFO - 'PWD': '/builds/slave/test', 02:09:11 INFO - 'SHELL': '/bin/bash', 02:09:11 INFO - 'SHLVL': '1', 02:09:11 INFO - 'TERM': 'linux', 02:09:11 INFO - 'TMOUT': '86400', 02:09:11 INFO - 'USER': 'cltbld', 02:09:11 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464249528.487429-1766275797', 02:09:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:11 INFO - '_': '/tools/buildbot/bin/python'} 02:09:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:11 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:09:11 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:09:11 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:09:11 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:09:11 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:09:11 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:09:11 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:09:11 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:09:11 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:09:11 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:09:11 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:09:11 INFO - Cleaning up... 02:09:11 INFO - Return code: 0 02:09:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:09:11 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:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:11 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:09:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:11 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 0x7fcd1b839f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1805770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18949c0>, '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 0x18958c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1895d50>, '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': 'fa44defc139c4ba8574fe040000001db-1464249528.487429-1766275797', '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:09:11 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:09:11 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:09:11 INFO - Using env: {'DISPLAY': ':0', 02:09:11 INFO - 'HOME': '/home/cltbld', 02:09:11 INFO - 'LANG': 'en_US.UTF-8', 02:09:11 INFO - 'LANGUAGE': 'en_US:en', 02:09:11 INFO - 'LOGNAME': 'cltbld', 02:09:11 INFO - 'MAIL': '/var/mail/cltbld', 02:09:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:11 INFO - 'MOZ_NO_REMOTE': '1', 02:09:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:09:11 INFO - 'NO_EM_RESTART': '1', 02:09:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:09:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:11 INFO - 'PWD': '/builds/slave/test', 02:09:11 INFO - 'SHELL': '/bin/bash', 02:09:11 INFO - 'SHLVL': '1', 02:09:11 INFO - 'TERM': 'linux', 02:09:11 INFO - 'TMOUT': '86400', 02:09:11 INFO - 'USER': 'cltbld', 02:09:11 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464249528.487429-1766275797', 02:09:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:11 INFO - '_': '/tools/buildbot/bin/python'} 02:09:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:11 INFO - Downloading/unpacking jsonschema 02:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:09:13 INFO - Downloading/unpacking functools32 (from jsonschema) 02:09:13 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:09:13 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:09:13 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:09:13 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:09:13 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:09:13 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:09:13 INFO - Downloading functools32-3.2.3-2.tar.gz 02:09:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:09:14 INFO - warning: no files found matching '*.txt' 02:09:14 INFO - no previously-included directories found matching 'build' 02:09:14 INFO - no previously-included directories found matching 'dist' 02:09:14 INFO - no previously-included directories found matching '.git*' 02:09:14 INFO - Installing collected packages: jsonschema, functools32 02:09:14 INFO - Running setup.py install for functools32 02:09:14 INFO - warning: no files found matching '*.txt' 02:09:14 INFO - no previously-included directories found matching 'build' 02:09:14 INFO - no previously-included directories found matching 'dist' 02:09:14 INFO - no previously-included directories found matching '.git*' 02:09:14 INFO - Successfully installed jsonschema functools32 02:09:14 INFO - Cleaning up... 02:09:14 INFO - Return code: 0 02:09:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:09:14 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:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:14 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:09:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:14 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 0x7fcd1b839f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1805770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18949c0>, '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 0x18958c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1895d50>, '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': 'fa44defc139c4ba8574fe040000001db-1464249528.487429-1766275797', '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:09:14 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:09:14 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:09:14 INFO - Using env: {'DISPLAY': ':0', 02:09:14 INFO - 'HOME': '/home/cltbld', 02:09:14 INFO - 'LANG': 'en_US.UTF-8', 02:09:14 INFO - 'LANGUAGE': 'en_US:en', 02:09:14 INFO - 'LOGNAME': 'cltbld', 02:09:14 INFO - 'MAIL': '/var/mail/cltbld', 02:09:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:14 INFO - 'MOZ_NO_REMOTE': '1', 02:09:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:09:14 INFO - 'NO_EM_RESTART': '1', 02:09:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:09:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:14 INFO - 'PWD': '/builds/slave/test', 02:09:14 INFO - 'SHELL': '/bin/bash', 02:09:14 INFO - 'SHLVL': '1', 02:09:14 INFO - 'TERM': 'linux', 02:09:14 INFO - 'TMOUT': '86400', 02:09:14 INFO - 'USER': 'cltbld', 02:09:14 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464249528.487429-1766275797', 02:09:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:14 INFO - '_': '/tools/buildbot/bin/python'} 02:09:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:14 INFO - Downloading/unpacking flake8 02:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:09:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:09:16 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:09:16 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:09:16 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:09:16 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:09:16 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:09:16 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:09:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:09:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:09:16 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:09:16 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:09:16 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:09:16 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:09:16 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:09:16 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:09:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:09:16 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:09:16 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:09:16 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:09:16 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:09:16 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:09:16 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:09:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:09:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:09:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:09:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:09:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:09:17 INFO - no previously-included directories found matching 'docs/_build' 02:09:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:09:17 INFO - Running setup.py install for pep8 02:09:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:09:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:09:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:09:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:09:17 INFO - no previously-included directories found matching 'docs/_build' 02:09:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:09:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:09:17 INFO - Cleaning up... 02:09:17 INFO - Return code: 0 02:09:17 INFO - Running post-action listener: _resource_record_post_action 02:09:17 INFO - Running post-action listener: _start_resource_monitoring 02:09:17 INFO - Starting resource monitoring. 02:09:17 INFO - ##### 02:09:17 INFO - ##### Finished create-virtualenv step (success) 02:09:17 INFO - ##### 02:09:17 INFO - ##### 02:09:17 INFO - ##### Running install step. 02:09:17 INFO - ##### 02:09:17 INFO - Running pre-action listener: _resource_record_pre_action 02:09:17 INFO - Running main action method: install 02:09:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:09:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:09:17 INFO - Reading from file tmpfile_stdout 02:09:17 INFO - Detecting whether we're running mozinstall >=1.0... 02:09:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:09:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:09:17 INFO - Reading from file tmpfile_stdout 02:09:17 INFO - Output received: 02:09:17 INFO - Usage: mozinstall [options] installer 02:09:17 INFO - Options: 02:09:17 INFO - -h, --help show this help message and exit 02:09:17 INFO - -d DEST, --destination=DEST 02:09:17 INFO - Directory to install application into. [default: 02:09:17 INFO - "/builds/slave/test"] 02:09:17 INFO - --app=APP Application being installed. [default: firefox] 02:09:17 INFO - mkdir: /builds/slave/test/build/application 02:09:17 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:09:17 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:09:34 INFO - Reading from file tmpfile_stdout 02:09:34 INFO - Output received: 02:09:34 INFO - /builds/slave/test/build/application/firefox/firefox 02:09:34 INFO - Running post-action listener: _resource_record_post_action 02:09:34 INFO - ##### 02:09:34 INFO - ##### Finished install step (success) 02:09:34 INFO - ##### 02:09:34 INFO - ##### 02:09:34 INFO - ##### Running run-tests step. 02:09:34 INFO - ##### 02:09:34 INFO - Running pre-action listener: _resource_record_pre_action 02:09:34 INFO - Running main action method: run_tests 02:09:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:09:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:09:34 INFO - Python 2.7.3 02:09:34 INFO - Return code: 0 02:09:34 INFO - grabbing minidump binary from tooltool 02:09:34 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:09:34 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 0x18949c0>, '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 0x18958c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1895d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:09:34 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:09:34 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:09:34 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:09:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:09:34 INFO - Return code: 0 02:09:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:09:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:09:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:09:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:09:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:09:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:09:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:09:35 INFO - Return code: 0 02:09:35 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I7s261IMTPecN0rhP9R1hg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:09:35 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/I7s261IMTPecN0rhP9R1hg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:09:35 INFO - Using env: {'DISPLAY': ':0', 02:09:35 INFO - 'HOME': '/home/cltbld', 02:09:35 INFO - 'LANG': 'en_US.UTF-8', 02:09:35 INFO - 'LANGUAGE': 'en_US:en', 02:09:35 INFO - 'LOGNAME': 'cltbld', 02:09:35 INFO - 'MAIL': '/var/mail/cltbld', 02:09:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:09:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:09:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:35 INFO - 'MOZ_NO_REMOTE': '1', 02:09:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:09:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:09:35 INFO - 'NO_EM_RESTART': '1', 02:09:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:09:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:35 INFO - 'PWD': '/builds/slave/test', 02:09:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:09:35 INFO - 'SHELL': '/bin/bash', 02:09:35 INFO - 'SHLVL': '1', 02:09:35 INFO - 'TERM': 'linux', 02:09:35 INFO - 'TMOUT': '86400', 02:09:35 INFO - 'USER': 'cltbld', 02:09:35 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464249528.487429-1766275797', 02:09:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:35 INFO - '_': '/tools/buildbot/bin/python'} 02:09:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I7s261IMTPecN0rhP9R1hg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:09:35 INFO - mozversion application_buildid: 20160525233010 02:09:35 INFO - mozversion application_changeset: 25566a14a7ac98674bfe9b6e73edc59fcc286c22 02:09:35 INFO - mozversion application_display_name: Nightly 02:09:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:09:35 INFO - mozversion application_name: Firefox 02:09:35 INFO - mozversion application_remotingname: firefox 02:09:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:09:35 INFO - mozversion application_vendor: Mozilla 02:09:35 INFO - mozversion application_version: 49.0a1 02:09:35 INFO - mozversion platform_buildid: 20160525233010 02:09:35 INFO - mozversion platform_changeset: 25566a14a7ac98674bfe9b6e73edc59fcc286c22 02:09:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:09:35 INFO - mozversion platform_version: 49.0a1 02:09:35 INFO - using testdate: 1464253775 02:09:35 INFO - actual date: 1464253775 02:09:35 INFO - starting webserver on 'localhost:58369' 02:09:35 INFO - SUITE-START | Running 2 tests 02:09:35 INFO - TEST-START | dromaeo_css 02:09:35 INFO - operating with platform_type : linux_ 02:09:35 INFO - Initialising browser for dromaeo_css test... 02:09:35 INFO - TEST-INFO | started process 381 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiSKZn3/profile http://localhost:58369/getInfo.html) 02:09:39 INFO - PROCESS | 381 | __metrics Screen width/height:1600/1200 02:09:39 INFO - PROCESS | 381 | colorDepth:24 02:09:39 INFO - PROCESS | 381 | Browser inner width/height: 1024/697 02:09:39 INFO - PROCESS | 381 | __metrics 02:09:40 ERROR - PROCESS | 381 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:09:41 INFO - TEST-INFO | 381: exit 0 02:09:41 INFO - Browser initialized. 02:09:41 INFO - Running cycle 1/1 for dromaeo_css test... 02:09:41 INFO - TEST-INFO | started process 465 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiSKZn3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:09:53 INFO - PROCESS | 465 | RSS: Main: 154992640 02:09:53 INFO - PROCESS | 465 | 02:10:44 INFO - PROCESS | 465 | 1464253844783 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:12:52 INFO - PROCESS | 465 | Cycle 1(1): loaded http://localhost:58369/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58369/tests/dromaeo/cssquery-ext.html) 02:12:53 INFO - PROCESS | 465 | RSS: Main: 246542336 02:12:53 INFO - PROCESS | 465 | 02:15:56 INFO - PROCESS | 465 | Cycle 1(1): loaded http://localhost:58369/tests/dromaeo/cssquery-ext.html (next: http://localhost:58369/tests/dromaeo/cssquery-jquery.html) 02:15:56 INFO - PROCESS | 465 | RSS: Main: 237694976 02:15:56 INFO - PROCESS | 465 | 02:18:58 INFO - PROCESS | 465 | Cycle 1(1): loaded http://localhost:58369/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58369/tests/dromaeo/cssquery-mootools.html) 02:18:59 INFO - PROCESS | 465 | RSS: Main: 244973568 02:18:59 INFO - PROCESS | 465 | 02:22:01 INFO - PROCESS | 465 | Cycle 1(1): loaded http://localhost:58369/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58369/tests/dromaeo/cssquery-prototype.html) 02:22:02 INFO - PROCESS | 465 | RSS: Main: 246087680 02:22:02 INFO - PROCESS | 465 | 02:25:04 INFO - PROCESS | 465 | Cycle 1(1): loaded http://localhost:58369/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58369/tests/dromaeo/cssquery-yui.html) 02:25:05 INFO - PROCESS | 465 | RSS: Main: 213106688 02:25:05 INFO - PROCESS | 465 | 02:28:07 INFO - PROCESS | 465 | Cycle 1(1): loaded http://localhost:58369/tests/dromaeo/cssquery-yui.html (next: http://localhost:58369/tests/dromaeo/cssquery-dojo.html) 02:28:08 INFO - PROCESS | 465 | RSS: Main: 278700032 02:28:08 INFO - PROCESS | 465 | 02:28:08 INFO - PROCESS | 465 | __start_tp_report 02:28:08 INFO - PROCESS | 465 | _x_x_mozilla_page_load 02:28:08 INFO - PROCESS | 465 | _x_x_mozilla_page_load_details 02:28:08 INFO - PROCESS | 465 | |i|pagename|runs| 02:28:08 INFO - PROCESS | 465 | |0;dojo.html;3117.298607813241;3124.1877111950894;3150.117966969248;3167.3031932974736;3194.7923384979977;5294.41761406245;5353.812616558421;5374;5403.756830942607;5411.756470958811;5371.086915224411;5443.346798384199;5452.372977107634;5454.945450545493;5475.808346707866;4889.242167464049;4955.801767929296;4977.50224977503;4985.451600323961;5106.69359838409;5002.799888004475;5033.798648054073;5044.344235249412;5061.6962982221;5068.518490743392;4863.68386054907;4902.436219834729;4947.431045429786;4959.181735013718;5010.5240002199735;4874.8537543873745;4886.047220791947;4892.706437613719;4898.559129678346;4988.97725966176;4923.975380123076;4942.555170034678;4943;4946.752662366904;4953.4798846121;5260.631755777097;5336.4129945705945;5422.40353561108;5424.783008679648;5433.347998240197;5849.941500585025;5890.646561206341;5901.17383566301;5902.085176797603;5909.645421274694;5876.177335173079;5899.0266606009955;5930;5941.821745347646;5948.672822994734;5317.601179911522;5323.946760532423;5352;5355.116405793039;5445.319335083114;5927.585069045212;5934.851628709231;5941.168236446901;5944.316403613553;5953.76184952597;5511.862203444865;5699.943000570024;5705.343885453143;5707.486326230659;5708.71456427177;5681.289838770153;5716.542676585863;5716.971415142898;5763.221965034667;5770.971145144247;5738.971305143447;5742.971285143631;5743.770249189985;5748.051571490657;5751.22358481608;5650.689212093374;5661.348944871393;5707.6290041147195;5717.142428635738;5722.2561067061015;4335.674824388184;4337.4795024596615;4340.978295108504;4380.2772542530765;4384.583464570861;3879.1465877506903;3887.1253967857006;3893.1824316893203;3903.980480097638;3924.2151569686175;5460.453954604508;5495.2856128703015;5566.248556444828;5581.05122129239;5613.803516876971;5807.970960145257;5845.649261044351;5870.73581688825;5884.323302820145;5922.407759224043;5558.583106267046;5569.832905012856;5572.080606699849;5583.832485025456;5587.413321601254;4870.586000189953;4928.112939670822;4969.155243608595;4972.627052970969;5013.222950442687;6082.756689732361;6096.634201947897;6097.207363042776;6106.358832322631;6132.908006379907;5870.354261031369;5875.471207591338;5877.23595932526;5882.558808089496;5885.823425297248;5854.063349864001;5981.790637327673;6008.24896887889;6058.212432383938;6071.605345652519;5689.487946084872;5736.311642602915;5736.627119237236;5738.655680659173;5751.166080918327;5817.621854579608;5837.591368604157;5841.32824725145;5842.620229685057;5843.678597676999;5567.415421380697;5666.914996275142;5697.059985102412;5726.169705392778;5762.308522977102;5673.06394444912;5673.716314184357;5678.630888992202;5681.431856814451;5682.6306290091015;5506.889862202654;5616.522595579258;5637.915431268616;5639.830805075854;5642.379338272704;5704.087346024616;5706.80026199081;5765.538756899354;5868.38381969887;5872.354041055395;5621.241132447068;5632.774689012557;5642.7460764266525;5697.230873832145;5718.542516598579 02:28:08 INFO - PROCESS | 465 | |1;ext.html;627.8681476889853;630.3822254190892;647.4981889035995;648.8345471904663;661.9470442364611;39961.80019099904;43159.56840431595;43211.35182972258;43269.7836510817;43316.783416082915;44593.55406445934;45230.54769452305;45278.773606132;45363.77318113405;45400.772996134976;7871.134175240719;8174.591270436484;8438.156184381543;10407.115395191418;10638.414887181201;10484.737881552946;10607.098396636256;10609.098226650744;10615.681529554126;10625.256232063759;8035.5580443075605;10598.947005265001;10658.78682426351;10661.733456663607;10666.573337066548;7919.881201781978;8175.059868115183;10241.897581024168;10657.200709946708;10667.093297069758;10422.530986105643;10452.581896724198;10489.632862849763;10507.474626268657;10510.474476276155;42909.57090429087;43440.56559434397;43444;43478;43479.34780978288;3514.0687717754818;3586.28274345132;3641.836117374698;3702.87039953603;3991.2416640838437;32027.679723202702;32467;32527;32966.175845603815;33725;4304.720193187432;4354.368616550582;4374.58441448062;4377.518472967971;4387.758673272969;336272;339441;339583;339731;340911.2954435237;59909.700451498335;59975.70012149911;60280;60281.69859150764;60397.69801151054;36072.27855442876;36828.815855921086;36859.26281474355;38639.80680096638;63446;14658.706825863635;14672.193029383272;14718.411263549553;14765.33555989983;14819.703605927822;11913.702157446132;11949.22330048544;11989.700257493632;12021.75956480883;12047.397630118634;19346.179561126013;19538.560584509785;19549.849516553168;19593.90203049004;19651.115699793543;6054.8183554493435;7050.788476345718;7271.418286537064;7273.418126549864;7344.192138864721;960.1502670136979;1024.460489010467;1099.2195541165702;1101.3777215873167;1114.996503147174;32831;33123.66876331254;33175.33649327;33263.83368083144;33722.831385843405;1082.182951871332;1137.562038615139;1151.41277948247;1160.802663547199;1205.5780476833213;17298.913505432643;17362.65274694499;17396.21717022737;17413.82586174122;17504.562385940455;559364;560120;563478;564415;566184;59706;60134;60144.398556014756;60173.699131504065;60259.397406025375;1278.5780692371682;1367.2001878900755;1396.3786115178648;1409.4714482069223;1416.11656496861;32769.344613107125;33658.49512257367;34021.44041989474;34095.82952085224;34231.486527702604;50719.2392114126;51267;51326.230106547686;51383.486165139366;51405;404080;406795;407455;408739;409166;24531.877340613897;26923.73076269212;27672.446551069268;27707.168784936483;28341.71658283391;49014;49134.75432622814;49549;49659;49695.50304497054;41608.791956040026;41663.79168104261;42513;42754;42892.78553607212;41328.73166522798;41479.58520414878;41552.37671434991;41866.79066604647;42420.151596968506;40729;41692.791536042125;42006.36990445085;42053.78973105237;42223;31740.682593173773;32030.359392811548;32272.193195170308;32400.675993239765;32499;28171.71828281691;28176.577351339336;28397.716022839508;28571;28617.42765144727 02:28:08 INFO - PROCESS | 465 | |2;jquery.html;383.5665697761529;389.33423845224655;391.4676040584805;392.85398599475553;413.59880915511945;14406.495772647959;18071.819281807177;18082.728759068625;19606.607867842635;19618;18140.546486337847;18766.343177988772;19073.237070517196;19204.903975480138;19239.903800480977;5584.804531841386;5640.435956404347;5682.289713785777;5706.1726049722765;5709.343425506057;3823.617638236168;4002.9799851000703;5528.44715528446;5646.068398714207;5686.772529098831;5967.880642387149;6255.061740738903;6256.843578910541;6361.395667411589;6379.744810207586;5288.81489147878;5546.140348246028;5555.055640541118;6333.113364129025;6340.302566717657;5376.731163441812;5438.3473983121885;5460.726963651801;5464.562834973192;5465.781368745245;13114.868641699319;13528.458861645522;13691.863081369158;13736.519221827188;13736.587902362946;2134.477053121995;2274.55646149001;2288.8397812153157;2355.434695673026;2359.775821296974;9439.339246252764;9731.854022189673;10043.648472303508;10184.032516910956;10303.07272345485;1854.0822292964933;1882.6987681970957;1887.4809427407436;1900.1734245603068;1921.993769470405;77765.61117194378;77947;78583.60708196422;80937.59531202365;83522.99999999939;10346.482675866328;10401.94799026;10584.417857017785;10616.575336986434;10835.945820271007;12847.421866016051;13581;14431.278436078153;14740.41038358475;14785.26073696311;7659.540427574252;7736;7804.68781248755;8000.4399692021;8056.556889371141;7572.659230334648;7898.960505197438;8026.678932842621;8130.512169269863;8158.184181581794;4562.429696287964;4620.699654522446;4643.930341044887;4654.767261636905;4667.416572928384;1895.4976931113265;1900.7053906644492;1911.8183772541586;1968.9704654430195;1971.6155349706955;895.6820328783318;950.5484894674975;1033.235405799718;1050.9211809114347;1055.6094245129352;18284;18723.812761872206;18827.435176944713;18887.90556047211;18932.810671893105;982.8525721141743;1005.2661557063385;1030.1912998296452;1041.1618646989245;1076.0745758647556;10189.847152292721;10656.893431065746;10666.520006599721;10692.893071069346;10717.46412679363;481443;488327;491413;495140;512324;83117;90017.54991225133;90120;103615;103996;1047.1151876664208;1054.6045233037612;1065.7868426314767;1070.5022164693455;1078.072857342669;11670.649880503599;14966.32651530662;16666.166691665127;17301.221445035255;17304.394346197823;43404.348934765374;43763;44035;44485.55514444814;44949.77525112354;59181;59540.70229648824;60980.695096524236;61787.69106154441;62056.689716551125;8395.118512556093;8636.222739953435;8724.260991185212;8740.737777866674;8821.823563528822;12906.80639790385;13223.3388330585;13575.932120339336;13638.93180534091;13676;11061.778764424505;11479.655610331703;11484.368359740294;11841.52633894669;11859.822102668295;11539.769204616028;11586.652400428;11683.532658693557;11811.822822657496;11904.464299106734;11427;11523.654290371302;11680.649580512598;11821.231619944676;12045.698857528632;8536.103709110454;8553.871691924502;8610.225079742853;8622.26710729595;8677.652893884175;8609.139086091342;10532.262176740753;11494.885051149382;11521.251118677259;11530.135239856876 02:28:08 INFO - PROCESS | 465 | |3;mootools.html;1353.546561901763;1523.2612183091198;1539.138082673703;1710.777598912142;1857.0807450312097;8326.458780179284;8644.049154592989;8653.783655408617;9066.957299910513;9086.909130908689;8842.806221160141;9021.639134434614;9041.683541076063;9044.23124034458;9050.81898362034;2038.3681058871723;2317.084751523147;2380.27401642499;2386.2721869829693;2413.7103547574316;2424.62418325159;2431.8419302745265;2432.3675844280438;2436.1229957215387;2440.1459489178733;2400.1719406804623;2449.9020039198413;2451.6812814334203;2453.43570978675;2455.9631605525933;2040.0411806450945;2294.288770481156;2384.701912260967;2386.7971222446113;2403.3871362802374;2270.8296877734238;2310.8960096795686;2317.0384290519414;2318.6058370076958;2337.6026075567192;9078.092190780935;9101.044390338986;9110.681126160553;9111.316651251183;9113.726588202364;5165.560927321182;5308.283381743454;5311.336082989626;5311.707856067915;5315.01672190646;3449.5688038995127;3493.441049432104;3564.1624218308675;3613.6567026132475;3633.5458067741533;957.9425234485883;969.0987381734984;1017.31839667423;1042.5360714482058;1063.6649455421596;12755.426005829668;12890.742185156245;12895.871041289562;12969.546065887744;12972.80540791889;4469.44131983502;4514.81940722374;4597.241455159861;4633;4634.165850147006;9731.367461115147;9732.951335243279;9734.853977190347;9737.707868763948;9740.853887191697;4760.357351757538;5292.073887069748;5293.682379057269;5294.073537130987;5300.31095957523;4914;5040.722760248148;5046.419661738873;5065.797368105234;5066.341375621146;3785.3943369061367;3902.239063382613;3950.644442000234;3956.723029387915;3962.425448309979;1138.6299452677913;1170.3621526268205;1175.6002958993984;1177.8351030855688;1178.1517307538559;816.5345752920778;832.7115355917075;916.3081873185836;926.2219735422277;939.7556635274877;6164.599301045418;6306.463950564162;6381.298057213703;6418.19772528434;6526.804195874131;453.78445238511443;457.17023602162635;465.28114063771557;467.4063938797708;470.17249640632735;4352.368906508538;4440.289553671397;4447.2439685253585;4489.147062058199;4537.4328208973875;10985.340879547093;11225.943870280596;11302.886971130349;11330.94334528322;11331.150163737753;11242.156838237164;11624.244424112574;11640.301581905112;11667.6499705009;11685.357305348118;8493;8521.233089022018;8613.61238744258;8632.525211113449;8740.169683880022;6226.097215903759;6239.344868788712;6268;6297.590656607489;6353.745850166127;9701.70894873155;10793.62222322215;10819.783604327711;10904.454777261264;10906.400147991937;10172.796544069226;10362.222833287382;10445.843312350473;10456.63401780934;10462.372257664565;7195.676194571152;7323.8535229296185;7927.246911543394;7929.5242285463055;8086.757397278091;8972.28221742246;8998.505082220541;9120.954395227982;9124.45253284805;9131.360804743605;8004.799880002814;8160.102388737116;8174.468659537111;8276.544790036605;8276.83446331082;7730.613469326398;7876.448648594544;7955.602219888867;8159.143289954469;8176.100628930694;7113.608751518509;7142.535735177197;7186.38915692172;7318.707251710085;7387.372073373824;5364.597655175799;5420.728963551728;5426.484483974016;5429.294191755047;5438.483344082306;5245.580353571781;5267.78928842842;5309.734513274244;5392.892142157213;5412.4237012421645 02:28:08 INFO - PROCESS | 465 | |4;prototype.html;330.45969839312716;331.2910371804339;341.786383510306;343.2054793153847;344.7207761713011;5370.248165256867;5394.406615272317;5397.4332695067;5411.404745477999;5445.37378201506;5360.785568577262;5393.2449457075945;5408.079636996027;5410.621256512046;5439.292891924044;4098.569650186732;4186.811593478301;4239.745615263087;4258.23351796678;4265.317549192115;4195.496540415154;4225.985763416773;4231.1114665920195;4238.682098842583;4253.404523366716;4201.831926722943;4211.599898009699;4219.177260434217;4230.471191101113;4235.767032813194;3977.105151340954;3990.9201815963665;4103.466549348565;4123.9381409278885;4153.356229784388;3654.488371627974;3669.5779985301765;3671.1739858531882;3684.705223582107;3690.8892733218045;4873.439554451248;5129.281900533928;5145.742712864379;5151.17581187012;5160.92258616121;4585.656075794329;4667.556582124693;4737.597304229144;4745.786439610226;4758.095961767253;5487.64330318532;5517.917231241535;5518.78586710923;5523.59148417155;5534.584906132056;3940.9014774630577;4027.939580906289;4032.717709760318;4036.374361973899;4058.655014323786;5772.769089236467;5792.565557583156;5798.217240672539;5802.245708057968;5809.24479817621;4139.130782535641;4140.772257525865;4156.376543518496;4172.937405938914;4182.644475219579;4024.7585144890813;4193.993441574061;4200.91598168041;4219.472565929259;4225.133847561243;4694.225452800318;4728.574428301469;4746.620270378361;4753.453352864396;4771.661885675994;5580.748866300945;5604;5606.719664016783;5609.887802243932;5651.660900345993;1402.6212922510865;1445.1834713387113;1453.9200343980972;1459.8905082118883;1463.1806188534454;920.1534588178891;935.9064093590723;942.7266092833139;944.9463847809643;947.7109481608038;4884.072026314989;4886.413630364379;4933.45731969483;4936.2102063669645;4959.2561115832195;5102.673304940668;5124.615653825978;5219.938124440825;5255.78976840922;5257.710825904535;4980.676256043345;5003.224500202475;5278.97360513195;5320.733963301819;5403.621746477787;3014.6533148687745;3023.9697603023687;3055.3501109400677;3059.816411015346;3080.92297692555;5762.394948530344;5990.460858522754;5993.880122397528;6003.609765365237;6008;5755.395683453177;5804.65172089676;5862.648241105548;5911.645301281937;5920.703964801743;5922.111683247547;5933.486960824962;5942.702864856827;5961.344252132262;5961.612495187799;5564.4713752193475;5686.943130568641;5753.280839895013;5765.164051212634;5786.913196302143;5593.608447408642;5624.437556244343;5635.633683810539;5668.348139963957;5672.602917795714;5776.277965254343;5931.851703707269;5931.911021334769;6030.547708921761;6050.485708714633;4177.874663760092;4179.6029377209115;4181.498220213593;4191.7275377100395;4207.97896010518;5811;5816.47651711348;5821.679807610622;5824.446677565625;5875.529957603467;5419.376771671308;5665.073874882395;5688.488036076607;5728.198052272768;5738.512226460798;5552.583556233218;5573.414791446839;5574.9442505574425;5599.244102046335;5609.382967873612;5541.972290138524;5544.695041772741;5594.888102237851;5614.41048689898;5614.5789065821045;5390.676559406448;5612.579056570855;5667.20659107717;5668.0931051033285;5697.8860422790485;5515.503604675599;5537.640053396677;5544.556435485071;5565.7217139143695;5586.273784408001 02:28:08 INFO - PROCESS | 465 | |5;yui.html;793.4525177627437;833.0628043451118;840.886480325156;844.3118858130623;851.6976473351958;14432.639184020392;14803.777943330859;15122.243887805607;15450.304736286866;15531.37874485022;14112;14122.364493597786;14286.214258215794;14301.141931484119;14359.92820035901;672.8586996730693;788.6648174525803;808.7735434078468;818.1205204405259;822.6462621072936;814.0475643497093;816.408104124508;818.6725309876037;819.2667562531531;819.6229734322219;855.5465603230298;856.3834039491556;857.1942374168293;857.459800325797;857.9871301930444;702.115334678304;817.4196320612373;845.0746432656232;846.4455781463151;855.8545047341936;616.2204810914197;616.8550390658191;618.168563282389;618.3229363846581;618.8824123416581;14207.573772786833;14215.786763198561;14238.715225695429;14246.358913848799;14254.501092461818;12049.216800907912;12276.631701048982;12483.937580312131;13099.541516046893;13340.799888001591;11447.771044579062;11504.137189710722;11645.475953582109;11659.591914282959;11737.295762254293;4248.362745588156;4297.419848320468;4320.4599425071865;4324.783760811978;4414.514403415622;58360.70819645917;59303.40696593022;60646.696766516325;60709.6964515179;61241;9847.606095756233;9971.30200885931;10029.648962286285;10040.69877903664;10253.603538607807;17082.316707331815;17097.658046838995;17127.74308385375;17128.14359282031;17173.7423938641;7571.583562904093;7611.847763044708;7620.390368770485;8049.315808156255;8482.448640838325;4233.1956928183545;4324.243257429937;4325.718828276152;4329.805158767863;4452.443444569429;3333.666633336695;3450.344434557426;3450.7929524228125;3454.4818277258614;3455.0498612881156;568.4855206038542;611.2267981004034;611.2634275697774;613.294711082259;628.1676778268721;643.1381948189448;658.6212927566669;658.8583454557294;669.6383952665506;673.061079793685;9748.658796942073;10067.446290453949;10128.797424051478;10171;10181.134603558632;609.20194545146;632.6077831744348;747.648605155576;762.5539059650056;769.0387016229713;4708.95291047092;4717.103750287503;4729.266963620645;4764.0471905619015;4802.711837289774;72397.27602723906;73337.6333118331;74896.87654685075;75759.62120189363;76038.61980690171;66266.66866665636;66790;67199.66400168066;67405.32594674088;69652.651736742;60962.390376095675;61004.38995610076;61396.693016534635;61425;62086.9999999991;9050.954745226232;9061.68284110053;9065.320100992583;9065.50139742294;9262.72211833646;38055;38063.23873522569;39227.215455691294;39389.80305098456;39586.604133958295;47920;52560.21159682684;52669.736651316496;53304.4669553315;53391.199132012276;11917.34454605005;12052.939735301268;12127.939360303142;12345.135840491079;12456.626301210616;12972.675683107998;13207.735845282848;13690.86309136896;13854.099483533539;14050.367733452224;12314.75370492603;12955.602874368567;13052.738945220852;13099.738005240033;13111.475540978254;12682.492700291885;12782.483776687894;12901.483940642269;12918.935405322913;13323.933380333036;12496.125271230927;12549.372531373578;12690.936545317214;12789.488420463078;12880.162789418659;9980.251481139088;10032.69901902944;10151.187904967732;10206.846897296398;10440.634577790044;10133;10396.480175991019;10401.115905148146;10424.957504249514;10438.269321147447 02:28:08 INFO - PROCESS | 465 | __end_tp_report 02:28:08 INFO - PROCESS | 465 | __start_cc_report 02:28:08 INFO - PROCESS | 465 | _x_x_mozilla_cycle_collect,906 02:28:08 INFO - PROCESS | 465 | __end_cc_report 02:28:08 INFO - PROCESS | 465 | __startTimestamp1464254888023__endTimestamp 02:28:08 INFO - PROCESS | 465 | 02:28:08 INFO - PROCESS | 465 | ------- Summary: start ------- 02:28:08 INFO - PROCESS | 465 | Number of tests: 6 02:28:08 INFO - PROCESS | 465 | 02:28:08 INFO - PROCESS | 465 | [#0] dojo.html Cycles:165 Average:5401.07 Median:5639.83 stddev:626.86 (11.1%) stddev-sans-first:602.64 02:28:08 INFO - PROCESS | 465 | Values: 3117.3 3124.2 3150.1 3167.3 3194.8 5294.4 5353.8 5374.0 5403.8 5411.8 5371.1 5443.3 5452.4 5454.9 5475.8 4889.2 4955.8 4977.5 4985.5 5106.7 5002.8 5033.8 5044.3 5061.7 5068.5 4863.7 4902.4 4947.4 4959.2 5010.5 4874.9 4886.0 4892.7 4898.6 4989.0 4924.0 4942.6 4943.0 4946.8 4953.5 5260.6 5336.4 5422.4 5424.8 5433.3 5849.9 5890.6 5901.2 5902.1 5909.6 5876.2 5899.0 5930.0 5941.8 5948.7 5317.6 5323.9 5352.0 5355.1 5445.3 5927.6 5934.9 5941.2 5944.3 5953.8 5511.9 5699.9 5705.3 5707.5 5708.7 5681.3 5716.5 5717.0 5763.2 5771.0 5739.0 5743.0 5743.8 5748.1 5751.2 5650.7 5661.3 5707.6 5717.1 5722.3 4335.7 4337.5 4341.0 4380.3 4384.6 3879.1 3887.1 3893.2 3904.0 3924.2 5460.5 5495.3 5566.2 5581.1 5613.8 5808.0 5845.6 5870.7 5884.3 5922.4 5558.6 5569.8 5572.1 5583.8 5587.4 4870.6 4928.1 4969.2 4972.6 5013.2 6082.8 6096.6 6097.2 6106.4 6132.9 5870.4 5875.5 5877.2 5882.6 5885.8 5854.1 5981.8 6008.2 6058.2 6071.6 5689.5 5736.3 5736.6 5738.7 5751.2 5817.6 5837.6 5841.3 5842.6 5843.7 5567.4 5666.9 5697.1 5726.2 5762.3 5673.1 5673.7 5678.6 5681.4 5682.6 5506.9 5616.5 5637.9 5639.8 5642.4 5704.1 5706.8 5765.5 5868.4 5872.4 5621.2 5632.8 5642.7 5697.2 5718.5 02:28:08 INFO - PROCESS | 465 | 02:28:08 INFO - PROCESS | 465 | [#1] ext.html Cycles:180 Average:59703.78 Median:19857.06 stddev:118412.04 (596.3%) stddev-sans-first:118661.14 02:28:08 INFO - PROCESS | 465 | Values: 627.9 630.4 647.5 648.8 661.9 39961.8 43159.6 43211.4 43269.8 43316.8 44593.6 45230.5 45278.8 45363.8 45400.8 7871.1 8174.6 8438.2 10407.1 10638.4 10484.7 10607.1 10609.1 10615.7 10625.3 8035.6 10598.9 10658.8 10661.7 10666.6 7919.9 8175.1 10241.9 10657.2 10667.1 10422.5 10452.6 10489.6 10507.5 10510.5 42909.6 43440.6 43444.0 43478.0 43479.3 3514.1 3586.3 3641.8 3702.9 3991.2 32027.7 32467.0 32527.0 32966.2 33725.0 4304.7 4354.4 4374.6 4377.5 4387.8 336272.0 339441.0 339583.0 339731.0 340911.3 59909.7 59975.7 60280.0 60281.7 60397.7 36072.3 36828.8 36859.3 38639.8 63446.0 14658.7 14672.2 14718.4 14765.3 14819.7 11913.7 11949.2 11989.7 12021.8 12047.4 19346.2 19538.6 19549.8 19593.9 19651.1 6054.8 7050.8 7271.4 7273.4 7344.2 960.2 1024.5 1099.2 1101.4 1115.0 32831.0 33123.7 33175.3 33263.8 33722.8 1082.2 1137.6 1151.4 1160.8 1205.6 17298.9 17362.7 17396.2 17413.8 17504.6 559364.0 560120.0 563478.0 564415.0 566184.0 59706.0 60134.0 60144.4 60173.7 60259.4 1278.6 1367.2 1396.4 1409.5 1416.1 32769.3 33658.5 34021.4 34095.8 34231.5 50719.2 51267.0 51326.2 51383.5 51405.0 404080.0 406795.0 407455.0 408739.0 409166.0 24531.9 26923.7 27672.4 27707.2 28341.7 49014.0 49134.8 49549.0 49659.0 49695.5 41608.8 41663.8 42513.0 42754.0 42892.8 41328.7 41479.6 41552.4 41866.8 42420.2 40729.0 41692.8 42006.4 42053.8 42223.0 31740.7 32030.4 32272.2 32400.7 32499.0 28171.7 28176.6 28397.7 28571.0 28617.4 02:28:08 INFO - PROCESS | 465 | 02:28:08 INFO - PROCESS | 465 | [#2] jquery.html Cycles:180 Average:28801.24 Median:2053.05 stddev:81554.49 (3972.4%) stddev-sans-first:81755.35 02:28:08 INFO - PROCESS | 465 | Values: 383.6 389.3 391.5 392.9 413.6 14406.5 18071.8 18082.7 19606.6 19618.0 18140.5 18766.3 19073.2 19204.9 19239.9 5584.8 5640.4 5682.3 5706.2 5709.3 3823.6 4003.0 5528.4 5646.1 5686.8 5967.9 6255.1 6256.8 6361.4 6379.7 5288.8 5546.1 5555.1 6333.1 6340.3 5376.7 5438.3 5460.7 5464.6 5465.8 13114.9 13528.5 13691.9 13736.5 13736.6 2134.5 2274.6 2288.8 2355.4 2359.8 9439.3 9731.9 10043.6 10184.0 10303.1 1854.1 1882.7 1887.5 1900.2 1922.0 77765.6 77947.0 78583.6 80937.6 83523.0 10346.5 10401.9 10584.4 10616.6 10835.9 12847.4 13581.0 14431.3 14740.4 14785.3 7659.5 7736.0 7804.7 8000.4 8056.6 7572.7 7899.0 8026.7 8130.5 8158.2 4562.4 4620.7 4643.9 4654.8 4667.4 1895.5 1900.7 1911.8 1969.0 1971.6 895.7 950.5 1033.2 1050.9 1055.6 18284.0 18723.8 18827.4 18887.9 18932.8 982.9 1005.3 1030.2 1041.2 1076.1 10189.8 10656.9 10666.5 10692.9 10717.5 481443.0 488327.0 491413.0 495140.0 512324.0 83117.0 90017.5 90120.0 103615.0 103996.0 1047.1 1054.6 1065.8 1070.5 1078.1 11670.6 14966.3 16666.2 17301.2 17304.4 43404.3 43763.0 44035.0 44485.6 44949.8 59181.0 59540.7 60980.7 61787.7 62056.7 8395.1 8636.2 8724.3 8740.7 8821.8 12906.8 13223.3 13575.9 13638.9 13676.0 11061.8 11479.7 11484.4 11841.5 11859.8 11539.8 11586.7 11683.5 11811.8 11904.5 11427.0 11523.7 11680.6 11821.2 12045.7 8536.1 8553.9 8610.2 8622.3 8677.7 8609.1 10532.3 11494.9 11521.3 11530.1 02:28:08 INFO - PROCESS | 465 | 02:28:08 INFO - PROCESS | 465 | [#3] mootools.html Cycles:180 Average:5953.71 Median:5056.11 stddev:3446.79 (68.2%) stddev-sans-first:3439.12 02:28:08 INFO - PROCESS | 465 | Values: 1353.5 1523.3 1539.1 1710.8 1857.1 8326.5 8644.0 8653.8 9067.0 9086.9 8842.8 9021.6 9041.7 9044.2 9050.8 2038.4 2317.1 2380.3 2386.3 2413.7 2424.6 2431.8 2432.4 2436.1 2440.1 2400.2 2449.9 2451.7 2453.4 2456.0 2040.0 2294.3 2384.7 2386.8 2403.4 2270.8 2310.9 2317.0 2318.6 2337.6 9078.1 9101.0 9110.7 9111.3 9113.7 5165.6 5308.3 5311.3 5311.7 5315.0 3449.6 3493.4 3564.2 3613.7 3633.5 957.9 969.1 1017.3 1042.5 1063.7 12755.4 12890.7 12895.9 12969.5 12972.8 4469.4 4514.8 4597.2 4633.0 4634.2 9731.4 9733.0 9734.9 9737.7 9740.9 4760.4 5292.1 5293.7 5294.1 5300.3 4914.0 5040.7 5046.4 5065.8 5066.3 3785.4 3902.2 3950.6 3956.7 3962.4 1138.6 1170.4 1175.6 1177.8 1178.2 816.5 832.7 916.3 926.2 939.8 6164.6 6306.5 6381.3 6418.2 6526.8 453.8 457.2 465.3 467.4 470.2 4352.4 4440.3 4447.2 4489.1 4537.4 10985.3 11225.9 11302.9 11330.9 11331.2 11242.2 11624.2 11640.3 11667.6 11685.4 8493.0 8521.2 8613.6 8632.5 8740.2 6226.1 6239.3 6268.0 6297.6 6353.7 9701.7 10793.6 10819.8 10904.5 10906.4 10172.8 10362.2 10445.8 10456.6 10462.4 7195.7 7323.9 7927.2 7929.5 8086.8 8972.3 8998.5 9121.0 9124.5 9131.4 8004.8 8160.1 8174.5 8276.5 8276.8 7730.6 7876.4 7955.6 8159.1 8176.1 7113.6 7142.5 7186.4 7318.7 7387.4 5364.6 5420.7 5426.5 5429.3 5438.5 5245.6 5267.8 5309.7 5392.9 5412.4 02:28:08 INFO - PROCESS | 465 | 02:28:08 INFO - PROCESS | 465 | [#4] prototype.html Cycles:180 Average:4697.70 Median:5380.46 stddev:1374.34 (25.5%) stddev-sans-first:1338.53 02:28:08 INFO - PROCESS | 465 | Values: 330.5 331.3 341.8 343.2 344.7 5370.2 5394.4 5397.4 5411.4 5445.4 5360.8 5393.2 5408.1 5410.6 5439.3 4098.6 4186.8 4239.7 4258.2 4265.3 4195.5 4226.0 4231.1 4238.7 4253.4 4201.8 4211.6 4219.2 4230.5 4235.8 3977.1 3990.9 4103.5 4123.9 4153.4 3654.5 3669.6 3671.2 3684.7 3690.9 4873.4 5129.3 5145.7 5151.2 5160.9 4585.7 4667.6 4737.6 4745.8 4758.1 5487.6 5517.9 5518.8 5523.6 5534.6 3940.9 4027.9 4032.7 4036.4 4058.7 5772.8 5792.6 5798.2 5802.2 5809.2 4139.1 4140.8 4156.4 4172.9 4182.6 4024.8 4194.0 4200.9 4219.5 4225.1 4694.2 4728.6 4746.6 4753.5 4771.7 5580.7 5604.0 5606.7 5609.9 5651.7 1402.6 1445.2 1453.9 1459.9 1463.2 920.2 935.9 942.7 944.9 947.7 4884.1 4886.4 4933.5 4936.2 4959.3 5102.7 5124.6 5219.9 5255.8 5257.7 4980.7 5003.2 5279.0 5320.7 5403.6 3014.7 3024.0 3055.4 3059.8 3080.9 5762.4 5990.5 5993.9 6003.6 6008.0 5755.4 5804.7 5862.6 5911.6 5920.7 5922.1 5933.5 5942.7 5961.3 5961.6 5564.5 5686.9 5753.3 5765.2 5786.9 5593.6 5624.4 5635.6 5668.3 5672.6 5776.3 5931.9 5931.9 6030.5 6050.5 4177.9 4179.6 4181.5 4191.7 4208.0 5811.0 5816.5 5821.7 5824.4 5875.5 5419.4 5665.1 5688.5 5728.2 5738.5 5552.6 5573.4 5574.9 5599.2 5609.4 5542.0 5544.7 5594.9 5614.4 5614.6 5390.7 5612.6 5667.2 5668.1 5697.9 5515.5 5537.6 5544.6 5565.7 5586.3 02:28:08 INFO - PROCESS | 465 | 02:28:08 INFO - PROCESS | 465 | [#5] yui.html Cycles:180 Average:16234.98 Median:4580.70 stddev:20391.23 (445.2%) stddev-sans-first:20415.47 02:28:08 INFO - PROCESS | 465 | Values: 793.5 833.1 840.9 844.3 851.7 14432.6 14803.8 15122.2 15450.3 15531.4 14112.0 14122.4 14286.2 14301.1 14359.9 672.9 788.7 808.8 818.1 822.6 814.0 816.4 818.7 819.3 819.6 855.5 856.4 857.2 857.5 858.0 702.1 817.4 845.1 846.4 855.9 616.2 616.9 618.2 618.3 618.9 14207.6 14215.8 14238.7 14246.4 14254.5 12049.2 12276.6 12483.9 13099.5 13340.8 11447.8 11504.1 11645.5 11659.6 11737.3 4248.4 4297.4 4320.5 4324.8 4414.5 58360.7 59303.4 60646.7 60709.7 61241.0 9847.6 9971.3 10029.6 10040.7 10253.6 17082.3 17097.7 17127.7 17128.1 17173.7 7571.6 7611.8 7620.4 8049.3 8482.4 4233.2 4324.2 4325.7 4329.8 4452.4 3333.7 3450.3 3450.8 3454.5 3455.0 568.5 611.2 611.3 613.3 628.2 643.1 658.6 658.9 669.6 673.1 9748.7 10067.4 10128.8 10171.0 10181.1 609.2 632.6 747.6 762.6 769.0 4709.0 4717.1 4729.3 4764.0 4802.7 72397.3 73337.6 74896.9 75759.6 76038.6 66266.7 66790.0 67199.7 67405.3 69652.7 60962.4 61004.4 61396.7 61425.0 62087.0 9051.0 9061.7 9065.3 9065.5 9262.7 38055.0 38063.2 39227.2 39389.8 39586.6 47920.0 52560.2 52669.7 53304.5 53391.2 11917.3 12052.9 12127.9 12345.1 12456.6 12972.7 13207.7 13690.9 13854.1 14050.4 12314.8 12955.6 13052.7 13099.7 13111.5 12682.5 12782.5 12901.5 12918.9 13323.9 12496.1 12549.4 12690.9 12789.5 12880.2 9980.3 10032.7 10151.2 10206.8 10440.6 10133.0 10396.5 10401.1 10425.0 10438.3 02:28:08 INFO - PROCESS | 465 | -------- Summary: end -------- 02:28:08 INFO - PROCESS | 465 | 02:28:08 INFO - TEST-INFO | 465: exit 0 02:28:08 INFO - TEST-OK | dromaeo_css | took 1113243ms 02:28:08 INFO - TEST-START | kraken 02:28:08 INFO - operating with platform_type : linux_ 02:28:08 INFO - Initialising browser for kraken test... 02:28:08 INFO - TEST-INFO | started process 644 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPUx8gt/profile http://localhost:58369/getInfo.html) 02:28:12 INFO - PROCESS | 644 | __metrics Screen width/height:1600/1200 02:28:12 INFO - PROCESS | 644 | colorDepth:24 02:28:12 INFO - PROCESS | 644 | Browser inner width/height: 1024/697 02:28:12 INFO - PROCESS | 644 | __metrics 02:28:14 ERROR - PROCESS | 644 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:28:14 INFO - TEST-INFO | 644: exit 0 02:28:14 INFO - Browser initialized. 02:28:14 INFO - Running cycle 1/1 for kraken test... 02:28:14 INFO - TEST-INFO | started process 730 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPUx8gt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:28:26 INFO - PROCESS | 730 | RSS: Main: 154492928 02:28:26 INFO - PROCESS | 730 | 02:28:29 INFO - PROCESS | 730 | Cycle 1(1): loaded http://localhost:58369/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58369/tests/kraken/driver.html?testName=audio-beat-detection) 02:28:30 INFO - PROCESS | 730 | RSS: Main: 211636224 02:28:30 INFO - PROCESS | 730 | 02:28:32 INFO - PROCESS | 730 | Cycle 1(1): loaded http://localhost:58369/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58369/tests/kraken/driver.html?testName=audio-dft) 02:28:33 INFO - PROCESS | 730 | RSS: Main: 199385088 02:28:33 INFO - PROCESS | 730 | 02:28:36 INFO - PROCESS | 730 | Cycle 1(1): loaded http://localhost:58369/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58369/tests/kraken/driver.html?testName=audio-fft) 02:28:37 INFO - PROCESS | 730 | RSS: Main: 267792384 02:28:37 INFO - PROCESS | 730 | 02:28:39 INFO - PROCESS | 730 | Cycle 1(1): loaded http://localhost:58369/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58369/tests/kraken/driver.html?testName=audio-oscillator) 02:28:39 INFO - PROCESS | 730 | RSS: Main: 177102848 02:28:39 INFO - PROCESS | 730 | 02:28:41 INFO - PROCESS | 730 | Cycle 1(1): loaded http://localhost:58369/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58369/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:28:42 INFO - PROCESS | 730 | RSS: Main: 181657600 02:28:42 INFO - PROCESS | 730 | 02:28:45 INFO - PROCESS | 730 | Cycle 1(1): loaded http://localhost:58369/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58369/tests/kraken/driver.html?testName=imaging-darkroom) 02:28:46 INFO - PROCESS | 730 | RSS: Main: 217477120 02:28:46 INFO - PROCESS | 730 | 02:28:49 INFO - PROCESS | 730 | Cycle 1(1): loaded http://localhost:58369/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58369/tests/kraken/driver.html?testName=imaging-desaturate) 02:28:50 INFO - PROCESS | 730 | RSS: Main: 217993216 02:28:50 INFO - PROCESS | 730 | 02:28:52 INFO - PROCESS | 730 | Cycle 1(1): loaded http://localhost:58369/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58369/tests/kraken/driver.html?testName=json-parse-financial) 02:28:53 INFO - PROCESS | 730 | RSS: Main: 218185728 02:28:53 INFO - PROCESS | 730 | 02:28:55 INFO - PROCESS | 730 | Cycle 1(1): loaded http://localhost:58369/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58369/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:28:55 INFO - PROCESS | 730 | RSS: Main: 207114240 02:28:55 INFO - PROCESS | 730 | 02:28:57 INFO - PROCESS | 730 | Cycle 1(1): loaded http://localhost:58369/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58369/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:28:58 INFO - PROCESS | 730 | RSS: Main: 208687104 02:28:58 INFO - PROCESS | 730 | 02:29:00 INFO - PROCESS | 730 | Cycle 1(1): loaded http://localhost:58369/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58369/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:29:00 INFO - PROCESS | 730 | RSS: Main: 218189824 02:29:00 INFO - PROCESS | 730 | 02:29:03 INFO - PROCESS | 730 | Cycle 1(1): loaded http://localhost:58369/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58369/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:29:03 INFO - PROCESS | 730 | RSS: Main: 226766848 02:29:03 INFO - PROCESS | 730 | 02:29:06 INFO - PROCESS | 730 | Cycle 1(1): loaded http://localhost:58369/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58369/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:29:07 INFO - PROCESS | 730 | RSS: Main: 222318592 02:29:07 INFO - PROCESS | 730 | 02:29:08 INFO - PROCESS | 730 | Cycle 1(1): loaded http://localhost:58369/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58369/tests/kraken/driver.html?testName=ai-astar) 02:29:09 INFO - PROCESS | 730 | RSS: Main: 267960320 02:29:09 INFO - PROCESS | 730 | 02:29:09 INFO - PROCESS | 730 | __start_tp_report 02:29:09 INFO - PROCESS | 730 | _x_x_mozilla_page_load 02:29:09 INFO - PROCESS | 730 | _x_x_mozilla_page_load_details 02:29:09 INFO - PROCESS | 730 | |i|pagename|runs| 02:29:09 INFO - PROCESS | 730 | |0;ai-astar;111;107;110;110;110;110;110;111;110;110 02:29:09 INFO - PROCESS | 730 | |1;audio-beat-detection;159;126;127;186;127;125;164;125;179;124 02:29:09 INFO - PROCESS | 730 | |2;audio-dft;160;160;159;162;159;161;160;162;159;162 02:29:09 INFO - PROCESS | 730 | |3;audio-fft;73;74;74;111;75;77;74;73;105;74 02:29:09 INFO - PROCESS | 730 | |4;audio-oscillator;83;84;120;83;85;84;126;83;84;123 02:29:09 INFO - PROCESS | 730 | |5;imaging-gaussian-blur;117;117;116;117;117;116;117;117;117;117 02:29:09 INFO - PROCESS | 730 | |6;imaging-darkroom;146;146;146;145;145;145;145;146;145;145 02:29:09 INFO - PROCESS | 730 | |7;imaging-desaturate;94;95;95;95;95;95;95;95;95;95 02:29:09 INFO - PROCESS | 730 | |8;json-parse-financial;54;54;55;54;53;55;55;70;53;52 02:29:09 INFO - PROCESS | 730 | |9;json-stringify-tinderbox;63;62;62;62;62;63;63;62;63;62 02:29:09 INFO - PROCESS | 730 | |10;stanford-crypto-aes;80;80;85;81;85;81;81;83;80;81 02:29:09 INFO - PROCESS | 730 | |11;stanford-crypto-ccm;119;118;131;118;120;123;120;128;160;119 02:29:09 INFO - PROCESS | 730 | |12;stanford-crypto-pbkdf2;157;158;162;157;160;163;158;155;156;159 02:29:09 INFO - PROCESS | 730 | |13;stanford-crypto-sha256-iterative;62;62;63;62;62;64;63;60;61;62 02:29:09 INFO - PROCESS | 730 | __end_tp_report 02:29:09 INFO - PROCESS | 730 | __start_cc_report 02:29:09 INFO - PROCESS | 730 | _x_x_mozilla_cycle_collect,1652 02:29:09 INFO - PROCESS | 730 | __end_cc_report 02:29:09 INFO - PROCESS | 730 | __startTimestamp1464254949112__endTimestamp 02:29:09 INFO - PROCESS | 730 | 02:29:09 INFO - PROCESS | 730 | ------- Summary: start ------- 02:29:09 INFO - PROCESS | 730 | Number of tests: 14 02:29:09 INFO - PROCESS | 730 | 02:29:09 INFO - PROCESS | 730 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.00 stddev:1.10 (1.0%) stddev-sans-first:1.09 02:29:09 INFO - PROCESS | 730 | Values: 111.0 107.0 110.0 110.0 110.0 110.0 110.0 111.0 110.0 110.0 02:29:09 INFO - PROCESS | 730 | 02:29:09 INFO - PROCESS | 730 | [#1] audio-beat-detection Cycles:10 Average:144.20 Median:143.00 stddev:25.03 (17.5%) stddev-sans-first:25.97 02:29:09 INFO - PROCESS | 730 | Values: 159.0 126.0 127.0 186.0 127.0 125.0 164.0 125.0 179.0 124.0 02:29:09 INFO - PROCESS | 730 | 02:29:09 INFO - PROCESS | 730 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.50 stddev:1.26 (0.8%) stddev-sans-first:1.33 02:29:09 INFO - PROCESS | 730 | Values: 160.0 160.0 159.0 162.0 159.0 161.0 160.0 162.0 159.0 162.0 02:29:09 INFO - PROCESS | 730 | 02:29:09 INFO - PROCESS | 730 | [#3] audio-fft Cycles:10 Average:81.00 Median:74.00 stddev:14.34 (19.4%) stddev-sans-first:14.92 02:29:09 INFO - PROCESS | 730 | Values: 73.0 74.0 74.0 111.0 75.0 77.0 74.0 73.0 105.0 74.0 02:29:09 INFO - PROCESS | 730 | 02:29:09 INFO - PROCESS | 730 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:83.50 stddev:19.04 (22.8%) stddev-sans-first:19.65 02:29:09 INFO - PROCESS | 730 | Values: 83.0 84.0 120.0 83.0 85.0 84.0 126.0 83.0 84.0 123.0 02:29:09 INFO - PROCESS | 730 | 02:29:09 INFO - PROCESS | 730 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 02:29:09 INFO - PROCESS | 730 | Values: 117.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 02:29:09 INFO - PROCESS | 730 | 02:29:09 INFO - PROCESS | 730 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 02:29:09 INFO - PROCESS | 730 | Values: 146.0 146.0 146.0 145.0 145.0 145.0 145.0 146.0 145.0 145.0 02:29:09 INFO - PROCESS | 730 | 02:29:09 INFO - PROCESS | 730 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 02:29:09 INFO - PROCESS | 730 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 02:29:09 INFO - PROCESS | 730 | 02:29:09 INFO - PROCESS | 730 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:54.50 stddev:5.19 (9.5%) stddev-sans-first:5.48 02:29:09 INFO - PROCESS | 730 | Values: 54.0 54.0 55.0 54.0 53.0 55.0 55.0 70.0 53.0 52.0 02:29:09 INFO - PROCESS | 730 | 02:29:09 INFO - PROCESS | 730 | [#9] json-stringify-tinderbox Cycles:10 Average:62.40 Median:62.50 stddev:0.52 (0.8%) stddev-sans-first:0.50 02:29:09 INFO - PROCESS | 730 | Values: 63.0 62.0 62.0 62.0 62.0 63.0 63.0 62.0 63.0 62.0 02:29:09 INFO - PROCESS | 730 | 02:29:09 INFO - PROCESS | 730 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:81.00 stddev:1.95 (2.4%) stddev-sans-first:1.96 02:29:09 INFO - PROCESS | 730 | Values: 80.0 80.0 85.0 81.0 85.0 81.0 81.0 83.0 80.0 81.0 02:29:09 INFO - PROCESS | 730 | 02:29:09 INFO - PROCESS | 730 | [#11] stanford-crypto-ccm Cycles:10 Average:125.60 Median:121.50 stddev:12.87 (10.6%) stddev-sans-first:13.43 02:29:09 INFO - PROCESS | 730 | Values: 119.0 118.0 131.0 118.0 120.0 123.0 120.0 128.0 160.0 119.0 02:29:09 INFO - PROCESS | 730 | 02:29:09 INFO - PROCESS | 730 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.50 Median:158.50 stddev:2.55 (1.6%) stddev-sans-first:2.65 02:29:09 INFO - PROCESS | 730 | Values: 157.0 158.0 162.0 157.0 160.0 163.0 158.0 155.0 156.0 159.0 02:29:09 INFO - PROCESS | 730 | 02:29:09 INFO - PROCESS | 730 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:62.00 stddev:1.10 (1.8%) stddev-sans-first:1.17 02:29:09 INFO - PROCESS | 730 | Values: 62.0 62.0 63.0 62.0 62.0 64.0 63.0 60.0 61.0 62.0 02:29:09 INFO - PROCESS | 730 | -------- Summary: end -------- 02:29:09 INFO - PROCESS | 730 | 02:29:10 INFO - TEST-INFO | 730: exit 0 02:29:10 INFO - TEST-OK | kraken | took 61283ms 02:29:10 INFO - SUITE-END | took 1174s 02:29:10 INFO - Completed test suite (00:19:34) 02:29:10 INFO - javascript benchmark 02:29:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3117.298607813241, 3124.1877111950894, 3150.117966969248, 3167.3031932974736, 3194.7923384979977, 5294.41761406245, 5353.812616558421, 5374.0, 5403.756830942607, 5411.756470958811, 5371.086915224411, 5443.346798384199, 5452.372977107634, 5454.945450545493, 5475.808346707866, 4889.242167464049, 4955.801767929296, 4977.50224977503, 4985.451600323961, 5106.69359838409, 5002.799888004475, 5033.798648054073, 5044.344235249412, 5061.6962982221, 5068.518490743392, 4863.68386054907, 4902.436219834729, 4947.431045429786, 4959.181735013718, 5010.5240002199735, 4874.8537543873745, 4886.047220791947, 4892.706437613719, 4898.559129678346, 4988.97725966176, 4923.975380123076, 4942.555170034678, 4943.0, 4946.752662366904, 4953.4798846121, 5260.631755777097, 5336.4129945705945, 5422.40353561108, 5424.783008679648, 5433.347998240197, 5849.941500585025, 5890.646561206341, 5901.17383566301, 5902.085176797603, 5909.645421274694, 5876.177335173079, 5899.0266606009955, 5930.0, 5941.821745347646, 5948.672822994734, 5317.601179911522, 5323.946760532423, 5352.0, 5355.116405793039, 5445.319335083114, 5927.585069045212, 5934.851628709231, 5941.168236446901, 5944.316403613553, 5953.76184952597, 5511.862203444865, 5699.943000570024, 5705.343885453143, 5707.486326230659, 5708.71456427177, 5681.289838770153, 5716.542676585863, 5716.971415142898, 5763.221965034667, 5770.971145144247, 5738.971305143447, 5742.971285143631, 5743.770249189985, 5748.051571490657, 5751.22358481608, 5650.689212093374, 5661.348944871393, 5707.6290041147195, 5717.142428635738, 5722.2561067061015, 4335.674824388184, 4337.4795024596615, 4340.978295108504, 4380.2772542530765, 4384.583464570861, 3879.1465877506903, 3887.1253967857006, 3893.1824316893203, 3903.980480097638, 3924.2151569686175, 5460.453954604508, 5495.2856128703015, 5566.248556444828, 5581.05122129239, 5613.803516876971, 5807.970960145257, 5845.649261044351, 5870.73581688825, 5884.323302820145, 5922.407759224043, 5558.583106267046, 5569.832905012856, 5572.080606699849, 5583.832485025456, 5587.413321601254, 4870.586000189953, 4928.112939670822, 4969.155243608595, 4972.627052970969, 5013.222950442687, 6082.756689732361, 6096.634201947897, 6097.207363042776, 6106.358832322631, 6132.908006379907, 5870.354261031369, 5875.471207591338, 5877.23595932526, 5882.558808089496, 5885.823425297248, 5854.063349864001, 5981.790637327673, 6008.24896887889, 6058.212432383938, 6071.605345652519, 5689.487946084872, 5736.311642602915, 5736.627119237236, 5738.655680659173, 5751.166080918327, 5817.621854579608, 5837.591368604157, 5841.32824725145, 5842.620229685057, 5843.678597676999, 5567.415421380697, 5666.914996275142, 5697.059985102412, 5726.169705392778, 5762.308522977102, 5673.06394444912, 5673.716314184357, 5678.630888992202, 5681.431856814451, 5682.6306290091015, 5506.889862202654, 5616.522595579258, 5637.915431268616, 5639.830805075854, 5642.379338272704, 5704.087346024616, 5706.80026199081, 5765.538756899354, 5868.38381969887, 5872.354041055395, 5621.241132447068, 5632.774689012557, 5642.7460764266525, 5697.230873832145, 5718.542516598579], "value": 5357.797392230391, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [627.8681476889853, 630.3822254190892, 647.4981889035995, 648.8345471904663, 661.9470442364611, 39961.80019099904, 43159.56840431595, 43211.35182972258, 43269.7836510817, 43316.783416082915, 44593.55406445934, 45230.54769452305, 45278.773606132, 45363.77318113405, 45400.772996134976, 7871.134175240719, 8174.591270436484, 8438.156184381543, 10407.115395191418, 10638.414887181201, 10484.737881552946, 10607.098396636256, 10609.098226650744, 10615.681529554126, 10625.256232063759, 8035.5580443075605, 10598.947005265001, 10658.78682426351, 10661.733456663607, 10666.573337066548, 7919.881201781978, 8175.059868115183, 10241.897581024168, 10657.200709946708, 10667.093297069758, 10422.530986105643, 10452.581896724198, 10489.632862849763, 10507.474626268657, 10510.474476276155, 42909.57090429087, 43440.56559434397, 43444.0, 43478.0, 43479.34780978288, 3514.0687717754818, 3586.28274345132, 3641.836117374698, 3702.87039953603, 3991.2416640838437, 32027.679723202702, 32467.0, 32527.0, 32966.175845603815, 33725.0, 4304.720193187432, 4354.368616550582, 4374.58441448062, 4377.518472967971, 4387.758673272969, 336272.0, 339441.0, 339583.0, 339731.0, 340911.2954435237, 59909.700451498335, 59975.70012149911, 60280.0, 60281.69859150764, 60397.69801151054, 36072.27855442876, 36828.815855921086, 36859.26281474355, 38639.80680096638, 63446.0, 14658.706825863635, 14672.193029383272, 14718.411263549553, 14765.33555989983, 14819.703605927822, 11913.702157446132, 11949.22330048544, 11989.700257493632, 12021.75956480883, 12047.397630118634, 19346.179561126013, 19538.560584509785, 19549.849516553168, 19593.90203049004, 19651.115699793543, 6054.8183554493435, 7050.788476345718, 7271.418286537064, 7273.418126549864, 7344.192138864721, 960.1502670136979, 1024.460489010467, 1099.2195541165702, 1101.3777215873167, 1114.996503147174, 32831.0, 33123.66876331254, 33175.33649327, 33263.83368083144, 33722.831385843405, 1082.182951871332, 1137.562038615139, 1151.41277948247, 1160.802663547199, 1205.5780476833213, 17298.913505432643, 17362.65274694499, 17396.21717022737, 17413.82586174122, 17504.562385940455, 559364.0, 560120.0, 563478.0, 564415.0, 566184.0, 59706.0, 60134.0, 60144.398556014756, 60173.699131504065, 60259.397406025375, 1278.5780692371682, 1367.2001878900755, 1396.3786115178648, 1409.4714482069223, 1416.11656496861, 32769.344613107125, 33658.49512257367, 34021.44041989474, 34095.82952085224, 34231.486527702604, 50719.2392114126, 51267.0, 51326.230106547686, 51383.486165139366, 51405.0, 404080.0, 406795.0, 407455.0, 408739.0, 409166.0, 24531.877340613897, 26923.73076269212, 27672.446551069268, 27707.168784936483, 28341.71658283391, 49014.0, 49134.75432622814, 49549.0, 49659.0, 49695.50304497054, 41608.791956040026, 41663.79168104261, 42513.0, 42754.0, 42892.78553607212, 41328.73166522798, 41479.58520414878, 41552.37671434991, 41866.79066604647, 42420.151596968506, 40729.0, 41692.791536042125, 42006.36990445085, 42053.78973105237, 42223.0, 31740.682593173773, 32030.359392811548, 32272.193195170308, 32400.675993239765, 32499.0, 28171.71828281691, 28176.577351339336, 28397.716022839508, 28571.0, 28617.42765144727], "value": 20308.328587203607, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.5665697761529, 389.33423845224655, 391.4676040584805, 392.85398599475553, 413.59880915511945, 14406.495772647959, 18071.819281807177, 18082.728759068625, 19606.607867842635, 19618.0, 18140.546486337847, 18766.343177988772, 19073.237070517196, 19204.903975480138, 19239.903800480977, 5584.804531841386, 5640.435956404347, 5682.289713785777, 5706.1726049722765, 5709.343425506057, 3823.617638236168, 4002.9799851000703, 5528.44715528446, 5646.068398714207, 5686.772529098831, 5967.880642387149, 6255.061740738903, 6256.843578910541, 6361.395667411589, 6379.744810207586, 5288.81489147878, 5546.140348246028, 5555.055640541118, 6333.113364129025, 6340.302566717657, 5376.731163441812, 5438.3473983121885, 5460.726963651801, 5464.562834973192, 5465.781368745245, 13114.868641699319, 13528.458861645522, 13691.863081369158, 13736.519221827188, 13736.587902362946, 2134.477053121995, 2274.55646149001, 2288.8397812153157, 2355.434695673026, 2359.775821296974, 9439.339246252764, 9731.854022189673, 10043.648472303508, 10184.032516910956, 10303.07272345485, 1854.0822292964933, 1882.6987681970957, 1887.4809427407436, 1900.1734245603068, 1921.993769470405, 77765.61117194378, 77947.0, 78583.60708196422, 80937.59531202365, 83522.99999999939, 10346.482675866328, 10401.94799026, 10584.417857017785, 10616.575336986434, 10835.945820271007, 12847.421866016051, 13581.0, 14431.278436078153, 14740.41038358475, 14785.26073696311, 7659.540427574252, 7736.0, 7804.68781248755, 8000.4399692021, 8056.556889371141, 7572.659230334648, 7898.960505197438, 8026.678932842621, 8130.512169269863, 8158.184181581794, 4562.429696287964, 4620.699654522446, 4643.930341044887, 4654.767261636905, 4667.416572928384, 1895.4976931113265, 1900.7053906644492, 1911.8183772541586, 1968.9704654430195, 1971.6155349706955, 895.6820328783318, 950.5484894674975, 1033.235405799718, 1050.9211809114347, 1055.6094245129352, 18284.0, 18723.812761872206, 18827.435176944713, 18887.90556047211, 18932.810671893105, 982.8525721141743, 1005.2661557063385, 1030.1912998296452, 1041.1618646989245, 1076.0745758647556, 10189.847152292721, 10656.893431065746, 10666.520006599721, 10692.893071069346, 10717.46412679363, 481443.0, 488327.0, 491413.0, 495140.0, 512324.0, 83117.0, 90017.54991225133, 90120.0, 103615.0, 103996.0, 1047.1151876664208, 1054.6045233037612, 1065.7868426314767, 1070.5022164693455, 1078.072857342669, 11670.649880503599, 14966.32651530662, 16666.166691665127, 17301.221445035255, 17304.394346197823, 43404.348934765374, 43763.0, 44035.0, 44485.55514444814, 44949.77525112354, 59181.0, 59540.70229648824, 60980.695096524236, 61787.69106154441, 62056.689716551125, 8395.118512556093, 8636.222739953435, 8724.260991185212, 8740.737777866674, 8821.823563528822, 12906.80639790385, 13223.3388330585, 13575.932120339336, 13638.93180534091, 13676.0, 11061.778764424505, 11479.655610331703, 11484.368359740294, 11841.52633894669, 11859.822102668295, 11539.769204616028, 11586.652400428, 11683.532658693557, 11811.822822657496, 11904.464299106734, 11427.0, 11523.654290371302, 11680.649580512598, 11821.231619944676, 12045.698857528632, 8536.103709110454, 8553.871691924502, 8610.225079742853, 8622.26710729595, 8677.652893884175, 8609.139086091342, 10532.262176740753, 11494.885051149382, 11521.251118677259, 11530.135239856876], "value": 8973.898212842214, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1353.546561901763, 1523.2612183091198, 1539.138082673703, 1710.777598912142, 1857.0807450312097, 8326.458780179284, 8644.049154592989, 8653.783655408617, 9066.957299910513, 9086.909130908689, 8842.806221160141, 9021.639134434614, 9041.683541076063, 9044.23124034458, 9050.81898362034, 2038.3681058871723, 2317.084751523147, 2380.27401642499, 2386.2721869829693, 2413.7103547574316, 2424.62418325159, 2431.8419302745265, 2432.3675844280438, 2436.1229957215387, 2440.1459489178733, 2400.1719406804623, 2449.9020039198413, 2451.6812814334203, 2453.43570978675, 2455.9631605525933, 2040.0411806450945, 2294.288770481156, 2384.701912260967, 2386.7971222446113, 2403.3871362802374, 2270.8296877734238, 2310.8960096795686, 2317.0384290519414, 2318.6058370076958, 2337.6026075567192, 9078.092190780935, 9101.044390338986, 9110.681126160553, 9111.316651251183, 9113.726588202364, 5165.560927321182, 5308.283381743454, 5311.336082989626, 5311.707856067915, 5315.01672190646, 3449.5688038995127, 3493.441049432104, 3564.1624218308675, 3613.6567026132475, 3633.5458067741533, 957.9425234485883, 969.0987381734984, 1017.31839667423, 1042.5360714482058, 1063.6649455421596, 12755.426005829668, 12890.742185156245, 12895.871041289562, 12969.546065887744, 12972.80540791889, 4469.44131983502, 4514.81940722374, 4597.241455159861, 4633.0, 4634.165850147006, 9731.367461115147, 9732.951335243279, 9734.853977190347, 9737.707868763948, 9740.853887191697, 4760.357351757538, 5292.073887069748, 5293.682379057269, 5294.073537130987, 5300.31095957523, 4914.0, 5040.722760248148, 5046.419661738873, 5065.797368105234, 5066.341375621146, 3785.3943369061367, 3902.239063382613, 3950.644442000234, 3956.723029387915, 3962.425448309979, 1138.6299452677913, 1170.3621526268205, 1175.6002958993984, 1177.8351030855688, 1178.1517307538559, 816.5345752920778, 832.7115355917075, 916.3081873185836, 926.2219735422277, 939.7556635274877, 6164.599301045418, 6306.463950564162, 6381.298057213703, 6418.19772528434, 6526.804195874131, 453.78445238511443, 457.17023602162635, 465.28114063771557, 467.4063938797708, 470.17249640632735, 4352.368906508538, 4440.289553671397, 4447.2439685253585, 4489.147062058199, 4537.4328208973875, 10985.340879547093, 11225.943870280596, 11302.886971130349, 11330.94334528322, 11331.150163737753, 11242.156838237164, 11624.244424112574, 11640.301581905112, 11667.6499705009, 11685.357305348118, 8493.0, 8521.233089022018, 8613.61238744258, 8632.525211113449, 8740.169683880022, 6226.097215903759, 6239.344868788712, 6268.0, 6297.590656607489, 6353.745850166127, 9701.70894873155, 10793.62222322215, 10819.783604327711, 10904.454777261264, 10906.400147991937, 10172.796544069226, 10362.222833287382, 10445.843312350473, 10456.63401780934, 10462.372257664565, 7195.676194571152, 7323.8535229296185, 7927.246911543394, 7929.5242285463055, 8086.757397278091, 8972.28221742246, 8998.505082220541, 9120.954395227982, 9124.45253284805, 9131.360804743605, 8004.799880002814, 8160.102388737116, 8174.468659537111, 8276.544790036605, 8276.83446331082, 7730.613469326398, 7876.448648594544, 7955.602219888867, 8159.143289954469, 8176.100628930694, 7113.608751518509, 7142.535735177197, 7186.38915692172, 7318.707251710085, 7387.372073373824, 5364.597655175799, 5420.728963551728, 5426.484483974016, 5429.294191755047, 5438.483344082306, 5245.580353571781, 5267.78928842842, 5309.734513274244, 5392.892142157213, 5412.4237012421645], "value": 4631.880344257851, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.45969839312716, 331.2910371804339, 341.786383510306, 343.2054793153847, 344.7207761713011, 5370.248165256867, 5394.406615272317, 5397.4332695067, 5411.404745477999, 5445.37378201506, 5360.785568577262, 5393.2449457075945, 5408.079636996027, 5410.621256512046, 5439.292891924044, 4098.569650186732, 4186.811593478301, 4239.745615263087, 4258.23351796678, 4265.317549192115, 4195.496540415154, 4225.985763416773, 4231.1114665920195, 4238.682098842583, 4253.404523366716, 4201.831926722943, 4211.599898009699, 4219.177260434217, 4230.471191101113, 4235.767032813194, 3977.105151340954, 3990.9201815963665, 4103.466549348565, 4123.9381409278885, 4153.356229784388, 3654.488371627974, 3669.5779985301765, 3671.1739858531882, 3684.705223582107, 3690.8892733218045, 4873.439554451248, 5129.281900533928, 5145.742712864379, 5151.17581187012, 5160.92258616121, 4585.656075794329, 4667.556582124693, 4737.597304229144, 4745.786439610226, 4758.095961767253, 5487.64330318532, 5517.917231241535, 5518.78586710923, 5523.59148417155, 5534.584906132056, 3940.9014774630577, 4027.939580906289, 4032.717709760318, 4036.374361973899, 4058.655014323786, 5772.769089236467, 5792.565557583156, 5798.217240672539, 5802.245708057968, 5809.24479817621, 4139.130782535641, 4140.772257525865, 4156.376543518496, 4172.937405938914, 4182.644475219579, 4024.7585144890813, 4193.993441574061, 4200.91598168041, 4219.472565929259, 4225.133847561243, 4694.225452800318, 4728.574428301469, 4746.620270378361, 4753.453352864396, 4771.661885675994, 5580.748866300945, 5604.0, 5606.719664016783, 5609.887802243932, 5651.660900345993, 1402.6212922510865, 1445.1834713387113, 1453.9200343980972, 1459.8905082118883, 1463.1806188534454, 920.1534588178891, 935.9064093590723, 942.7266092833139, 944.9463847809643, 947.7109481608038, 4884.072026314989, 4886.413630364379, 4933.45731969483, 4936.2102063669645, 4959.2561115832195, 5102.673304940668, 5124.615653825978, 5219.938124440825, 5255.78976840922, 5257.710825904535, 4980.676256043345, 5003.224500202475, 5278.97360513195, 5320.733963301819, 5403.621746477787, 3014.6533148687745, 3023.9697603023687, 3055.3501109400677, 3059.816411015346, 3080.92297692555, 5762.394948530344, 5990.460858522754, 5993.880122397528, 6003.609765365237, 6008.0, 5755.395683453177, 5804.65172089676, 5862.648241105548, 5911.645301281937, 5920.703964801743, 5922.111683247547, 5933.486960824962, 5942.702864856827, 5961.344252132262, 5961.612495187799, 5564.4713752193475, 5686.943130568641, 5753.280839895013, 5765.164051212634, 5786.913196302143, 5593.608447408642, 5624.437556244343, 5635.633683810539, 5668.348139963957, 5672.602917795714, 5776.277965254343, 5931.851703707269, 5931.911021334769, 6030.547708921761, 6050.485708714633, 4177.874663760092, 4179.6029377209115, 4181.498220213593, 4191.7275377100395, 4207.97896010518, 5811.0, 5816.47651711348, 5821.679807610622, 5824.446677565625, 5875.529957603467, 5419.376771671308, 5665.073874882395, 5688.488036076607, 5728.198052272768, 5738.512226460798, 5552.583556233218, 5573.414791446839, 5574.9442505574425, 5599.244102046335, 5609.382967873612, 5541.972290138524, 5544.695041772741, 5594.888102237851, 5614.41048689898, 5614.5789065821045, 5390.676559406448, 5612.579056570855, 5667.20659107717, 5668.0931051033285, 5697.8860422790485, 5515.503604675599, 5537.640053396677, 5544.556435485071, 5565.7217139143695, 5586.273784408001], "value": 4260.745332269392, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [793.4525177627437, 833.0628043451118, 840.886480325156, 844.3118858130623, 851.6976473351958, 14432.639184020392, 14803.777943330859, 15122.243887805607, 15450.304736286866, 15531.37874485022, 14112.0, 14122.364493597786, 14286.214258215794, 14301.141931484119, 14359.92820035901, 672.8586996730693, 788.6648174525803, 808.7735434078468, 818.1205204405259, 822.6462621072936, 814.0475643497093, 816.408104124508, 818.6725309876037, 819.2667562531531, 819.6229734322219, 855.5465603230298, 856.3834039491556, 857.1942374168293, 857.459800325797, 857.9871301930444, 702.115334678304, 817.4196320612373, 845.0746432656232, 846.4455781463151, 855.8545047341936, 616.2204810914197, 616.8550390658191, 618.168563282389, 618.3229363846581, 618.8824123416581, 14207.573772786833, 14215.786763198561, 14238.715225695429, 14246.358913848799, 14254.501092461818, 12049.216800907912, 12276.631701048982, 12483.937580312131, 13099.541516046893, 13340.799888001591, 11447.771044579062, 11504.137189710722, 11645.475953582109, 11659.591914282959, 11737.295762254293, 4248.362745588156, 4297.419848320468, 4320.4599425071865, 4324.783760811978, 4414.514403415622, 58360.70819645917, 59303.40696593022, 60646.696766516325, 60709.6964515179, 61241.0, 9847.606095756233, 9971.30200885931, 10029.648962286285, 10040.69877903664, 10253.603538607807, 17082.316707331815, 17097.658046838995, 17127.74308385375, 17128.14359282031, 17173.7423938641, 7571.583562904093, 7611.847763044708, 7620.390368770485, 8049.315808156255, 8482.448640838325, 4233.1956928183545, 4324.243257429937, 4325.718828276152, 4329.805158767863, 4452.443444569429, 3333.666633336695, 3450.344434557426, 3450.7929524228125, 3454.4818277258614, 3455.0498612881156, 568.4855206038542, 611.2267981004034, 611.2634275697774, 613.294711082259, 628.1676778268721, 643.1381948189448, 658.6212927566669, 658.8583454557294, 669.6383952665506, 673.061079793685, 9748.658796942073, 10067.446290453949, 10128.797424051478, 10171.0, 10181.134603558632, 609.20194545146, 632.6077831744348, 747.648605155576, 762.5539059650056, 769.0387016229713, 4708.95291047092, 4717.103750287503, 4729.266963620645, 4764.0471905619015, 4802.711837289774, 72397.27602723906, 73337.6333118331, 74896.87654685075, 75759.62120189363, 76038.61980690171, 66266.66866665636, 66790.0, 67199.66400168066, 67405.32594674088, 69652.651736742, 60962.390376095675, 61004.38995610076, 61396.693016534635, 61425.0, 62086.9999999991, 9050.954745226232, 9061.68284110053, 9065.320100992583, 9065.50139742294, 9262.72211833646, 38055.0, 38063.23873522569, 39227.215455691294, 39389.80305098456, 39586.604133958295, 47920.0, 52560.21159682684, 52669.736651316496, 53304.4669553315, 53391.199132012276, 11917.34454605005, 12052.939735301268, 12127.939360303142, 12345.135840491079, 12456.626301210616, 12972.675683107998, 13207.735845282848, 13690.86309136896, 13854.099483533539, 14050.367733452224, 12314.75370492603, 12955.602874368567, 13052.738945220852, 13099.738005240033, 13111.475540978254, 12682.492700291885, 12782.483776687894, 12901.483940642269, 12918.935405322913, 13323.933380333036, 12496.125271230927, 12549.372531373578, 12690.936545317214, 12789.488420463078, 12880.162789418659, 9980.251481139088, 10032.69901902944, 10151.187904967732, 10206.846897296398, 10440.634577790044, 10133.0, 10396.480175991019, 10401.115905148146, 10424.957504249514, 10438.269321147447], "value": 6892.069811447934, "unit": "score"}], "name": "dromaeo_css", "value": 7142.986332411109, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 107.0, 110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0, 110.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 126.0, 127.0, 186.0, 127.0, 125.0, 164.0, 125.0, 179.0, 124.0], "value": 144.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 159.0, 162.0, 159.0, 161.0, 160.0, 162.0, 159.0, 162.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 111.0, 75.0, 77.0, 74.0, 73.0, 105.0, 74.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 120.0, 83.0, 85.0, 84.0, 126.0, 83.0, 84.0, 123.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 54.0, 53.0, 55.0, 55.0, 70.0, 53.0, 52.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 62.0, 62.0, 63.0, 63.0, 62.0, 63.0, 62.0], "value": 62.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 85.0, 81.0, 85.0, 81.0, 81.0, 83.0, 80.0, 81.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 131.0, 118.0, 120.0, 123.0, 120.0, 128.0, 160.0, 119.0], "value": 125.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 158.0, 162.0, 157.0, 160.0, 163.0, 158.0, 155.0, 156.0, 159.0], "value": 158.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 62.0, 62.0, 64.0, 63.0, 60.0, 61.0, 62.0], "value": 62.1, "unit": "score"}], "name": "kraken", "value": 1493.8999999999999, "alertThreshold": 2.0}]} 02:29:10 INFO - Return code: 0 02:29:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:29:10 ERROR - # TBPL SUCCESS # 02:29:10 INFO - Running post-action listener: _resource_record_post_action 02:29:10 INFO - ##### 02:29:10 INFO - ##### Finished run-tests step (success) 02:29:10 INFO - ##### 02:29:10 INFO - Running post-run listener: _resource_record_post_run 02:29:10 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 547139584; Read time: 24; Write time: 590236 02:29:10 INFO - TinderboxPrint: CPU usage
13.2% 02:29:10 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 24 02:29:10 INFO - TinderboxPrint: I/O write bytes / time
547,139,584 / 590,236 02:29:10 INFO - TinderboxPrint: CPU idle
8,259.3 (86.8%) 02:29:10 INFO - TinderboxPrint: CPU user
1,208.3 (12.7%) 02:29:10 INFO - TinderboxPrint: Swap in / out
0 / 0 02:29:10 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 257236992; Read time: 0; Write time: 330176 02:29:10 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289902592; Read time: 24; Write time: 260060 02:29:11 INFO - Running post-run listener: _upload_blobber_files 02:29:11 INFO - Blob upload gear active. 02:29:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:29:11 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:29:11 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:29:11 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:29:11 INFO - (blobuploader) - INFO - Open directory for files ... 02:29:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:29:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:29:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:29:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:29:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:29:16 INFO - (blobuploader) - INFO - Done attempting. 02:29:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:29:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:29:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:29:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:29:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:29:17 INFO - (blobuploader) - INFO - Done attempting. 02:29:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:29:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:29:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:29:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:29:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:29:18 INFO - (blobuploader) - INFO - Done attempting. 02:29:18 INFO - (blobuploader) - INFO - Iteration through files over. 02:29:18 INFO - Return code: 0 02:29:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:29:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:29:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/50c67e6a636a73b2766a4b04ed4b41707ad6dcd2c26e87b000c99df50e1ba7be79341b21a82686275bbcb7e1bbc2d8982cf9251fe61e5894c4399f73cdada639", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a873ffd319f324019bb397065b31b238e74335f5f20eedb5f2ec814f3a6aabe9e4eebcc499f1567f7167590163789239aadf8bc4ffbb501c67b36795ffd57d53", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c57a2b8e15650fb68103c7eaa3da234c0b667191673a7801269c2414565e79a31e2e8e100eeb5d30fc6757186772f8ee60e0f34daf3ff1f2ca966ddae4fbdee"} 02:29:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:29:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:29:18 INFO - Contents: 02:29:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/50c67e6a636a73b2766a4b04ed4b41707ad6dcd2c26e87b000c99df50e1ba7be79341b21a82686275bbcb7e1bbc2d8982cf9251fe61e5894c4399f73cdada639", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a873ffd319f324019bb397065b31b238e74335f5f20eedb5f2ec814f3a6aabe9e4eebcc499f1567f7167590163789239aadf8bc4ffbb501c67b36795ffd57d53", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c57a2b8e15650fb68103c7eaa3da234c0b667191673a7801269c2414565e79a31e2e8e100eeb5d30fc6757186772f8ee60e0f34daf3ff1f2ca966ddae4fbdee"} 02:29:18 INFO - Running post-run listener: copy_logs_to_upload_dir 02:29:18 INFO - Copying logs to upload dir... 02:29:18 INFO - mkdir: /builds/slave/test/build/upload/logs 02:29:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.388144 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-26 02:29:17.927417) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 02:29:17.931192) ========= 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=fa44defc139c4ba8574fe040000001db-1464249528.487429-1766275797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/50c67e6a636a73b2766a4b04ed4b41707ad6dcd2c26e87b000c99df50e1ba7be79341b21a82686275bbcb7e1bbc2d8982cf9251fe61e5894c4399f73cdada639", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a873ffd319f324019bb397065b31b238e74335f5f20eedb5f2ec814f3a6aabe9e4eebcc499f1567f7167590163789239aadf8bc4ffbb501c67b36795ffd57d53", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c57a2b8e15650fb68103c7eaa3da234c0b667191673a7801269c2414565e79a31e2e8e100eeb5d30fc6757186772f8ee60e0f34daf3ff1f2ca966ddae4fbdee"} build_url:https://queue.taskcluster.net/v1/task/I7s261IMTPecN0rhP9R1hg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011359 build_url: 'https://queue.taskcluster.net/v1/task/I7s261IMTPecN0rhP9R1hg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/50c67e6a636a73b2766a4b04ed4b41707ad6dcd2c26e87b000c99df50e1ba7be79341b21a82686275bbcb7e1bbc2d8982cf9251fe61e5894c4399f73cdada639", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a873ffd319f324019bb397065b31b238e74335f5f20eedb5f2ec814f3a6aabe9e4eebcc499f1567f7167590163789239aadf8bc4ffbb501c67b36795ffd57d53", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c57a2b8e15650fb68103c7eaa3da234c0b667191673a7801269c2414565e79a31e2e8e100eeb5d30fc6757186772f8ee60e0f34daf3ff1f2ca966ddae4fbdee"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 02:29:17.957007) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 02:29:17.957381) ========= 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=fa44defc139c4ba8574fe040000001db-1464249528.487429-1766275797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004423 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 02:29:18.042780) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 02:29:18.043283) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 02:29:18.043739) ========= ========= Total master_lag: 0.17 =========