builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-063 starttime: 1464953550.32 results: success (0) buildid: 20160603033811 builduid: c57d571a48bc47a6877d9d4832f08942 revision: 4874ff5d90f81aca0bb57d2f74586210cbee3cf6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 04:32:30.317779) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 04:32:30.318261) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 04:32:30.318568) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 04:32:30.333222) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 04:32:30.333616) ========= 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=33d5923976266a1c518c4bf7000001ab-1464953549.664238-1306211226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-03 04:32:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-06-03 04:32:30 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132100 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 04:32:30.479483) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 04:32:30.479825) ========= 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=33d5923976266a1c518c4bf7000001ab-1464953549.664238-1306211226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017963 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 04:32:30.529538) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 04:32:30.529904) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4874ff5d90f81aca0bb57d2f74586210cbee3cf6 --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 4874ff5d90f81aca0bb57d2f74586210cbee3cf6 --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=33d5923976266a1c518c4bf7000001ab-1464953549.664238-1306211226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-03 04:32:30,626 truncating revision to first 12 chars 2016-06-03 04:32:30,626 Setting DEBUG logging. 2016-06-03 04:32:30,626 attempt 1/10 2016-06-03 04:32:30,626 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4874ff5d90f8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-03 04:32:30,942 unpacking tar archive at: fx-team-4874ff5d90f8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.624633 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 04:32:31.168408) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 04:32:31.168759) ========= script_repo_revision: 4874ff5d90f81aca0bb57d2f74586210cbee3cf6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 04:32:31.169164) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 04:32:31.169443) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 04:32:31.178450) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-06-03 04:32:31.178814) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=33d5923976266a1c518c4bf7000001ab-1464953549.664238-1306211226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:32:31 INFO - MultiFileLogger online at 20160603 04:32:31 in /builds/slave/test 04:32:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 04:32:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:32:31 INFO - {'append_to_log': False, 04:32:31 INFO - 'base_work_dir': '/builds/slave/test', 04:32:31 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:32:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:32:31 INFO - 'branch': 'Fx-Team-Non-PGO', 04:32:31 INFO - 'buildbot_json_path': 'buildprops.json', 04:32:31 INFO - 'config_files': ('talos/linux_config.py',), 04:32:31 INFO - 'default_actions': ('clobber', 04:32:31 INFO - 'read-buildbot-config', 04:32:31 INFO - 'download-and-extract', 04:32:31 INFO - 'populate-webroot', 04:32:31 INFO - 'create-virtualenv', 04:32:31 INFO - 'install', 04:32:31 INFO - 'run-tests'), 04:32:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:32:31 INFO - 'download_minidump_stackwalk': True, 04:32:31 INFO - 'download_symbols': 'ondemand', 04:32:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:32:31 INFO - 'tooltool.py': '/tools/tooltool.py', 04:32:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:32:31 INFO - '/tools/misc-python/virtualenv.py')}, 04:32:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:32:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:32:31 INFO - 'installer_path': 'installer.exe', 04:32:31 INFO - 'log_level': 'info', 04:32:31 INFO - 'log_name': 'talos', 04:32:31 INFO - 'log_to_console': True, 04:32:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:32:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:32:31 INFO - 'opt_config_files': (), 04:32:31 INFO - 'pip_index': False, 04:32:31 INFO - 'sps_profile': False, 04:32:31 INFO - 'sps_profile_interval': 0, 04:32:31 INFO - 'suite': 'dromaeojs', 04:32:31 INFO - 'system_bits': '32', 04:32:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:32:31 INFO - 'title': 'talos-linux64-ix-063', 04:32:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:32:31 INFO - 'use_talos_json': True, 04:32:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:32:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:32:31 INFO - 'work_dir': 'build'} 04:32:31 INFO - ##### 04:32:31 INFO - ##### Running clobber step. 04:32:31 INFO - ##### 04:32:31 INFO - Running pre-action listener: _resource_record_pre_action 04:32:31 INFO - Running main action method: clobber 04:32:31 INFO - rmtree: /builds/slave/test/build 04:32:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:32:31 INFO - Running post-action listener: _resource_record_post_action 04:32:31 INFO - ##### 04:32:31 INFO - ##### Finished clobber step (success) 04:32:31 INFO - ##### 04:32:31 INFO - ##### 04:32:31 INFO - ##### Running read-buildbot-config step. 04:32:31 INFO - ##### 04:32:31 INFO - Running pre-action listener: _resource_record_pre_action 04:32:31 INFO - Running main action method: read_buildbot_config 04:32:31 INFO - Using buildbot properties: 04:32:31 INFO - { 04:32:31 INFO - "project": "", 04:32:31 INFO - "product": "firefox", 04:32:31 INFO - "script_repo_revision": "production", 04:32:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:32:31 INFO - "repository": "", 04:32:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:32:31 INFO - "buildid": "20160603033811", 04:32:31 INFO - "pgo_build": "False", 04:32:31 INFO - "basedir": "/builds/slave/test", 04:32:31 INFO - "buildnumber": 1811, 04:32:31 INFO - "slavename": "talos-linux64-ix-063", 04:32:31 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:32:31 INFO - "platform": "ubuntu64_hw", 04:32:31 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:32:31 INFO - "branch": "fx-team", 04:32:31 INFO - "repo_path": "integration/fx-team", 04:32:31 INFO - "revision": "4874ff5d90f81aca0bb57d2f74586210cbee3cf6", 04:32:31 INFO - "stage_platform": "linux64", 04:32:31 INFO - "builduid": "c57d571a48bc47a6877d9d4832f08942", 04:32:31 INFO - "slavebuilddir": "test" 04:32:31 INFO - } 04:32:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/e6pu5doPTiqK2goLzX48ig/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 04:32:31 INFO - Running post-action listener: _resource_record_post_action 04:32:31 INFO - ##### 04:32:31 INFO - ##### Finished read-buildbot-config step (success) 04:32:31 INFO - ##### 04:32:31 INFO - ##### 04:32:31 INFO - ##### Running download-and-extract step. 04:32:31 INFO - ##### 04:32:31 INFO - Running pre-action listener: _resource_record_pre_action 04:32:31 INFO - Running main action method: download_and_extract 04:32:31 INFO - mkdir: /builds/slave/test/build/tests 04:32:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:31 INFO - https://queue.taskcluster.net/v1/task/e6pu5doPTiqK2goLzX48ig/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:32:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e6pu5doPTiqK2goLzX48ig/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:32:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e6pu5doPTiqK2goLzX48ig/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:32:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e6pu5doPTiqK2goLzX48ig/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 04:32:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e6pu5doPTiqK2goLzX48ig/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 04:32:32 INFO - Downloaded 1361 bytes. 04:32:32 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:32:32 INFO - Using the following test package requirements: 04:32:32 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:32:32 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:32:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:32:32 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:32:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:32:32 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:32:32 INFO - u'jsshell-linux-x86_64.zip'], 04:32:32 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:32:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:32:32 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:32:32 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:32:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:32:32 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:32:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:32:32 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:32:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:32:32 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:32:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:32:32 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:32:32 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')]} 04:32:32 INFO - https://queue.taskcluster.net/v1/task/e6pu5doPTiqK2goLzX48ig/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:32:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e6pu5doPTiqK2goLzX48ig/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:32:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e6pu5doPTiqK2goLzX48ig/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:32:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e6pu5doPTiqK2goLzX48ig/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 04:32:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e6pu5doPTiqK2goLzX48ig/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 04:32:33 INFO - Downloaded 22866938 bytes. 04:32:33 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'] 04:32:33 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 04:32:35 INFO - Return code: 0 04:32:35 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:32:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:35 INFO - https://queue.taskcluster.net/v1/task/e6pu5doPTiqK2goLzX48ig/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:32:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e6pu5doPTiqK2goLzX48ig/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:32:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e6pu5doPTiqK2goLzX48ig/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:32:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e6pu5doPTiqK2goLzX48ig/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 04:32:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e6pu5doPTiqK2goLzX48ig/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 04:32:36 INFO - Downloaded 22866938 bytes. 04:32:36 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'] 04:32:36 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 04:32:37 INFO - Return code: 0 04:32:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:37 INFO - https://queue.taskcluster.net/v1/task/e6pu5doPTiqK2goLzX48ig/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:32:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e6pu5doPTiqK2goLzX48ig/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:32:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e6pu5doPTiqK2goLzX48ig/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:32:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e6pu5doPTiqK2goLzX48ig/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 04:32:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e6pu5doPTiqK2goLzX48ig/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 04:32:38 INFO - Downloaded 10834055 bytes. 04:32:38 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'] 04:32:38 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 04:32:39 INFO - Return code: 0 04:32:39 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')]} 04:32:39 INFO - https://queue.taskcluster.net/v1/task/e6pu5doPTiqK2goLzX48ig/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:32:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e6pu5doPTiqK2goLzX48ig/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:32:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e6pu5doPTiqK2goLzX48ig/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:32:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e6pu5doPTiqK2goLzX48ig/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 04:32:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e6pu5doPTiqK2goLzX48ig/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 04:32:40 INFO - Downloaded 55085280 bytes. 04:32:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e6pu5doPTiqK2goLzX48ig/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:32:40 INFO - mkdir: /builds/slave/test/properties 04:32:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:32:40 INFO - Writing to file /builds/slave/test/properties/build_url 04:32:40 INFO - Contents: 04:32:40 INFO - build_url:https://queue.taskcluster.net/v1/task/e6pu5doPTiqK2goLzX48ig/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:32:41 INFO - Running post-action listener: _resource_record_post_action 04:32:41 INFO - Running post-action listener: set_extra_try_arguments 04:32:41 INFO - ##### 04:32:41 INFO - ##### Finished download-and-extract step (success) 04:32:41 INFO - ##### 04:32:41 INFO - ##### 04:32:41 INFO - ##### Running populate-webroot step. 04:32:41 INFO - ##### 04:32:41 INFO - Running pre-action listener: _resource_record_pre_action 04:32:41 INFO - Running main action method: populate_webroot 04:32:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:32:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:32:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:32:41 INFO - '--tppagecycles', 04:32:41 INFO - '7'], 04:32:41 INFO - 'tests': ['tsvgm']}}, 04:32:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:32:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:32:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:32:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:32:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:32:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:32:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:41 INFO - 'talos_options': ['--disable-e10s'], 04:32:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:32:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:32:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:41 INFO - 'talos_options': ['--disable-e10s'], 04:32:41 INFO - 'tests': ['damp', 'tps']}, 04:32:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:41 INFO - 'tests': ['damp', 'tps']}, 04:32:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:32:41 INFO - 'tests': ['dromaeo_dom']}, 04:32:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:32:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:32:41 INFO - 'tests': ['a11yr', 04:32:41 INFO - 'ts_paint', 04:32:41 INFO - 'tpaint', 04:32:41 INFO - 'sessionrestore', 04:32:41 INFO - 'sessionrestore_no_auto_restore', 04:32:41 INFO - 'tabpaint']}, 04:32:41 INFO - 'other-e10s': {'tests': ['a11yr', 04:32:41 INFO - 'ts_paint', 04:32:41 INFO - 'tpaint', 04:32:41 INFO - 'sessionrestore', 04:32:41 INFO - 'sessionrestore_no_auto_restore', 04:32:41 INFO - 'tabpaint']}, 04:32:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:32:41 INFO - 'ts_paint', 04:32:41 INFO - 'tpaint', 04:32:41 INFO - 'sessionrestore', 04:32:41 INFO - 'sessionrestore_no_auto_restore', 04:32:41 INFO - 'tabpaint']}, 04:32:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:32:41 INFO - 'ts_paint', 04:32:41 INFO - 'tpaint', 04:32:41 INFO - 'sessionrestore', 04:32:41 INFO - 'sessionrestore_no_auto_restore', 04:32:41 INFO - 'tabpaint']}, 04:32:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:32:41 INFO - 'tests': ['a11yr', 04:32:41 INFO - 'ts_paint', 04:32:41 INFO - 'tpaint', 04:32:41 INFO - 'sessionrestore', 04:32:41 INFO - 'sessionrestore_no_auto_restore', 04:32:41 INFO - 'tabpaint']}, 04:32:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:32:41 INFO - 'tests': ['a11yr', 04:32:41 INFO - 'ts_paint', 04:32:41 INFO - 'tpaint', 04:32:41 INFO - 'sessionrestore', 04:32:41 INFO - 'sessionrestore_no_auto_restore', 04:32:41 INFO - 'tabpaint']}, 04:32:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:32:41 INFO - 'tests': ['tsvgx', 04:32:41 INFO - 'tsvgr_opacity', 04:32:41 INFO - 'tart', 04:32:41 INFO - 'tscrollx', 04:32:41 INFO - 'cart']}, 04:32:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:32:41 INFO - 'tsvgr_opacity', 04:32:41 INFO - 'tart', 04:32:41 INFO - 'tscrollx', 04:32:41 INFO - 'cart']}, 04:32:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:41 INFO - 'talos_options': ['--disable-e10s'], 04:32:41 INFO - 'tests': ['tp5o']}, 04:32:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:41 INFO - 'tests': ['tp5o']}, 04:32:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:41 INFO - 'talos_options': ['--disable-e10s', 04:32:41 INFO - '--xperf_path', 04:32:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:32:41 INFO - 'tests': ['tp5n']}, 04:32:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:41 INFO - 'talos_options': ['--xperf_path', 04:32:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:32:41 INFO - 'tests': ['tp5n']}}, 04:32:41 INFO - 'talos.zip': {'path': '', 04:32:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:32:41 INFO - Running post-action listener: _resource_record_post_action 04:32:41 INFO - ##### 04:32:41 INFO - ##### Finished populate-webroot step (success) 04:32:41 INFO - ##### 04:32:41 INFO - ##### 04:32:41 INFO - ##### Running create-virtualenv step. 04:32:41 INFO - ##### 04:32:41 INFO - Running pre-action listener: _resource_record_pre_action 04:32:41 INFO - Running main action method: create_virtualenv 04:32:41 INFO - Creating virtualenv /builds/slave/test/build/venv 04:32:41 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 04:32:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:32:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:32:41 INFO - Using real prefix '/usr' 04:32:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:32:41 INFO - Installing distribute.............................................................................................................................................................................................done. 04:32:43 INFO - Installing pip.................done. 04:32:43 INFO - Return code: 0 04:32:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:32: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')]} 04:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32: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')]} 04:32:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:43 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 0x7f0390ed1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11899c0>, '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 0x118a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118ad50>, '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': '33d5923976266a1c518c4bf7000001ab-1464953549.664238-1306211226', '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 04:32:43 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 04:32:43 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 04:32:43 INFO - Using env: {'DISPLAY': ':0', 04:32:43 INFO - 'HOME': '/home/cltbld', 04:32:43 INFO - 'LANG': 'en_US.UTF-8', 04:32:43 INFO - 'LANGUAGE': 'en_US:en', 04:32:43 INFO - 'LOGNAME': 'cltbld', 04:32:43 INFO - 'MAIL': '/var/mail/cltbld', 04:32:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:43 INFO - 'MOZ_NO_REMOTE': '1', 04:32:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:43 INFO - 'NO_EM_RESTART': '1', 04:32:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:43 INFO - 'PWD': '/builds/slave/test', 04:32:43 INFO - 'SHELL': '/bin/bash', 04:32:43 INFO - 'SHLVL': '1', 04:32:43 INFO - 'TERM': 'linux', 04:32:43 INFO - 'TMOUT': '86400', 04:32:43 INFO - 'USER': 'cltbld', 04:32:43 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464953549.664238-1306211226', 04:32:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:43 INFO - '_': '/tools/buildbot/bin/python'} 04:32:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:44 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 04:32:44 INFO - Cleaning up... 04:32:44 INFO - Return code: 0 04:32:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:32:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:44 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 0x7f0390ed1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11899c0>, '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 0x118a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118ad50>, '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': '33d5923976266a1c518c4bf7000001ab-1464953549.664238-1306211226', '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 04:32:44 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 04:32:44 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 04:32:44 INFO - Using env: {'DISPLAY': ':0', 04:32:44 INFO - 'HOME': '/home/cltbld', 04:32:44 INFO - 'LANG': 'en_US.UTF-8', 04:32:44 INFO - 'LANGUAGE': 'en_US:en', 04:32:44 INFO - 'LOGNAME': 'cltbld', 04:32:44 INFO - 'MAIL': '/var/mail/cltbld', 04:32:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:44 INFO - 'MOZ_NO_REMOTE': '1', 04:32:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:44 INFO - 'NO_EM_RESTART': '1', 04:32:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:44 INFO - 'PWD': '/builds/slave/test', 04:32:44 INFO - 'SHELL': '/bin/bash', 04:32:44 INFO - 'SHLVL': '1', 04:32:44 INFO - 'TERM': 'linux', 04:32:44 INFO - 'TMOUT': '86400', 04:32:44 INFO - 'USER': 'cltbld', 04:32:44 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464953549.664238-1306211226', 04:32:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:44 INFO - '_': '/tools/buildbot/bin/python'} 04:32:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:44 INFO - Downloading/unpacking psutil>=3.1.1 04:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:32:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:32:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:32:46 INFO - Installing collected packages: psutil 04:32:46 INFO - Running setup.py install for psutil 04:32:46 INFO - building 'psutil._psutil_linux' extension 04:32:46 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 04:32:46 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 04:32:46 INFO - building 'psutil._psutil_posix' extension 04:32:46 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 04:32:46 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 04:32:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:32:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:32:46 INFO - Successfully installed psutil 04:32:46 INFO - Cleaning up... 04:32:46 INFO - Return code: 0 04:32:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:46 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 0x7f0390ed1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11899c0>, '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 0x118a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118ad50>, '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': '33d5923976266a1c518c4bf7000001ab-1464953549.664238-1306211226', '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 04:32:46 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 04:32:46 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 04:32:46 INFO - Using env: {'DISPLAY': ':0', 04:32:46 INFO - 'HOME': '/home/cltbld', 04:32:46 INFO - 'LANG': 'en_US.UTF-8', 04:32:46 INFO - 'LANGUAGE': 'en_US:en', 04:32:46 INFO - 'LOGNAME': 'cltbld', 04:32:46 INFO - 'MAIL': '/var/mail/cltbld', 04:32:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:46 INFO - 'MOZ_NO_REMOTE': '1', 04:32:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:46 INFO - 'NO_EM_RESTART': '1', 04:32:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:46 INFO - 'PWD': '/builds/slave/test', 04:32:46 INFO - 'SHELL': '/bin/bash', 04:32:46 INFO - 'SHLVL': '1', 04:32:46 INFO - 'TERM': 'linux', 04:32:46 INFO - 'TMOUT': '86400', 04:32:46 INFO - 'USER': 'cltbld', 04:32:46 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464953549.664238-1306211226', 04:32:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:46 INFO - '_': '/tools/buildbot/bin/python'} 04:32:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:32:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:32:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:32:49 INFO - Installing collected packages: mozsystemmonitor 04:32:49 INFO - Running setup.py install for mozsystemmonitor 04:32:49 INFO - Successfully installed mozsystemmonitor 04:32:49 INFO - Cleaning up... 04:32:49 INFO - Return code: 0 04:32:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:32: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')]} 04:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32: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')]} 04:32:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:49 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 0x7f0390ed1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11899c0>, '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 0x118a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118ad50>, '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': '33d5923976266a1c518c4bf7000001ab-1464953549.664238-1306211226', '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 04:32:49 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 04:32:49 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 04:32:49 INFO - Using env: {'DISPLAY': ':0', 04:32:49 INFO - 'HOME': '/home/cltbld', 04:32:49 INFO - 'LANG': 'en_US.UTF-8', 04:32:49 INFO - 'LANGUAGE': 'en_US:en', 04:32:49 INFO - 'LOGNAME': 'cltbld', 04:32:49 INFO - 'MAIL': '/var/mail/cltbld', 04:32:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:49 INFO - 'MOZ_NO_REMOTE': '1', 04:32:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:49 INFO - 'NO_EM_RESTART': '1', 04:32:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:49 INFO - 'PWD': '/builds/slave/test', 04:32:49 INFO - 'SHELL': '/bin/bash', 04:32:49 INFO - 'SHLVL': '1', 04:32:49 INFO - 'TERM': 'linux', 04:32:49 INFO - 'TMOUT': '86400', 04:32:49 INFO - 'USER': 'cltbld', 04:32:49 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464953549.664238-1306211226', 04:32:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:49 INFO - '_': '/tools/buildbot/bin/python'} 04:32:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:49 INFO - Downloading/unpacking blobuploader==1.2.4 04:32:49 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 04:32:49 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 04:32:49 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 04:32:49 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 04:32:49 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 04:32:49 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 04:32:51 INFO - Downloading blobuploader-1.2.4.tar.gz 04:32:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:32:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:32:51 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 04:32:51 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 04:32:51 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 04:32:51 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 04:32:51 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 04:32:51 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 04:32:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:32:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:32:51 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 04:32:51 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 04:32:51 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 04:32:51 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 04:32:51 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 04:32:51 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 04:32:52 INFO - Downloading docopt-0.6.1.tar.gz 04:32:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:32:52 INFO - Installing collected packages: blobuploader, requests, docopt 04:32:52 INFO - Running setup.py install for blobuploader 04:32:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:32:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:32:52 INFO - Running setup.py install for requests 04:32:52 INFO - Running setup.py install for docopt 04:32:52 INFO - Successfully installed blobuploader requests docopt 04:32:52 INFO - Cleaning up... 04:32:52 INFO - Return code: 0 04:32:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:52 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 0x7f0390ed1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11899c0>, '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 0x118a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118ad50>, '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': '33d5923976266a1c518c4bf7000001ab-1464953549.664238-1306211226', '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 04:32:52 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 04:32:52 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 04:32:52 INFO - Using env: {'DISPLAY': ':0', 04:32:52 INFO - 'HOME': '/home/cltbld', 04:32:52 INFO - 'LANG': 'en_US.UTF-8', 04:32:52 INFO - 'LANGUAGE': 'en_US:en', 04:32:52 INFO - 'LOGNAME': 'cltbld', 04:32:52 INFO - 'MAIL': '/var/mail/cltbld', 04:32:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:52 INFO - 'MOZ_NO_REMOTE': '1', 04:32:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:52 INFO - 'NO_EM_RESTART': '1', 04:32:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:52 INFO - 'PWD': '/builds/slave/test', 04:32:52 INFO - 'SHELL': '/bin/bash', 04:32:52 INFO - 'SHLVL': '1', 04:32:52 INFO - 'TERM': 'linux', 04:32:52 INFO - 'TMOUT': '86400', 04:32:52 INFO - 'USER': 'cltbld', 04:32:52 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464953549.664238-1306211226', 04:32:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:52 INFO - '_': '/tools/buildbot/bin/python'} 04:32:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:32:52 INFO - Running setup.py (path:/tmp/pip-hIsMkM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:32:53 INFO - Running setup.py (path:/tmp/pip-RssWzD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:32:53 INFO - Running setup.py (path:/tmp/pip-HawZYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:32:53 INFO - Running setup.py (path:/tmp/pip-tPs4X9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:32:53 INFO - Running setup.py (path:/tmp/pip-dyIodo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:32:53 INFO - Running setup.py (path:/tmp/pip-VXXrp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:32:53 INFO - Running setup.py (path:/tmp/pip-jN0T6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:32:53 INFO - Running setup.py (path:/tmp/pip-Ti1JRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:32:53 INFO - Running setup.py (path:/tmp/pip-4yQKcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:32:53 INFO - Running setup.py (path:/tmp/pip-O58UKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:32:53 INFO - Running setup.py (path:/tmp/pip-HQdzED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:32:53 INFO - Running setup.py (path:/tmp/pip-pPt8gz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:32:53 INFO - Running setup.py (path:/tmp/pip-gXHj76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:32:53 INFO - Running setup.py (path:/tmp/pip-8L2clS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:53 INFO - Running setup.py (path:/tmp/pip-pr6Eo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:32:54 INFO - Running setup.py (path:/tmp/pip-DkaHYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:32:54 INFO - Running setup.py (path:/tmp/pip-CO0HGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:32:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:32:54 INFO - Running setup.py install for manifestparser 04:32:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:32:54 INFO - Running setup.py install for mozcrash 04:32:54 INFO - Running setup.py install for mozdebug 04:32:54 INFO - Running setup.py install for mozdevice 04:32:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:32:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:32:54 INFO - Running setup.py install for mozfile 04:32:54 INFO - Running setup.py install for mozhttpd 04:32:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:32:54 INFO - Running setup.py install for mozinfo 04:32:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:32:54 INFO - Running setup.py install for mozInstall 04:32:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:32:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:32:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:32:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:32:54 INFO - Running setup.py install for mozleak 04:32:55 INFO - Running setup.py install for mozlog 04:32:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:32:55 INFO - Running setup.py install for moznetwork 04:32:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:32:55 INFO - Running setup.py install for mozprocess 04:32:55 INFO - Running setup.py install for mozprofile 04:32:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:32:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:32:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:32:55 INFO - Running setup.py install for mozrunner 04:32:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:32:55 INFO - Running setup.py install for mozscreenshot 04:32:55 INFO - Running setup.py install for moztest 04:32:55 INFO - Running setup.py install for mozversion 04:32:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:32:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:32:55 INFO - Cleaning up... 04:32:55 INFO - Return code: 0 04:32:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32: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')]} 04:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32: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')]} 04:32:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:55 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 0x7f0390ed1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11899c0>, '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 0x118a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118ad50>, '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': '33d5923976266a1c518c4bf7000001ab-1464953549.664238-1306211226', '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 04:32:55 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 04:32:55 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 04:32:55 INFO - Using env: {'DISPLAY': ':0', 04:32:55 INFO - 'HOME': '/home/cltbld', 04:32:55 INFO - 'LANG': 'en_US.UTF-8', 04:32:55 INFO - 'LANGUAGE': 'en_US:en', 04:32:55 INFO - 'LOGNAME': 'cltbld', 04:32:55 INFO - 'MAIL': '/var/mail/cltbld', 04:32:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:55 INFO - 'MOZ_NO_REMOTE': '1', 04:32:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:55 INFO - 'NO_EM_RESTART': '1', 04:32:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:55 INFO - 'PWD': '/builds/slave/test', 04:32:55 INFO - 'SHELL': '/bin/bash', 04:32:55 INFO - 'SHLVL': '1', 04:32:55 INFO - 'TERM': 'linux', 04:32:55 INFO - 'TMOUT': '86400', 04:32:55 INFO - 'USER': 'cltbld', 04:32:55 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464953549.664238-1306211226', 04:32:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:55 INFO - '_': '/tools/buildbot/bin/python'} 04:32:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:32:56 INFO - Running setup.py (path:/tmp/pip-1rGH7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:32:56 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)) 04:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:32:56 INFO - Running setup.py (path:/tmp/pip-ydYOBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:32:56 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)) 04:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:32:56 INFO - Running setup.py (path:/tmp/pip-qrgPd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:32:56 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)) 04:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:32:56 INFO - Running setup.py (path:/tmp/pip-zNPZYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:32:56 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)) 04:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:32:56 INFO - Running setup.py (path:/tmp/pip-BQFH91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:32:56 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)) 04:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:32:56 INFO - Running setup.py (path:/tmp/pip-lBioI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:32:56 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)) 04:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:32:56 INFO - Running setup.py (path:/tmp/pip-VxDhGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:32:56 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)) 04:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:32:56 INFO - Running setup.py (path:/tmp/pip-YmDwF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:32:56 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)) 04:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:32:56 INFO - Running setup.py (path:/tmp/pip-evCQXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:32:56 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)) 04:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:32:56 INFO - Running setup.py (path:/tmp/pip-vIZzOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:32:56 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)) 04:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:32:56 INFO - Running setup.py (path:/tmp/pip-UNInlv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:32:56 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)) 04:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:32:56 INFO - Running setup.py (path:/tmp/pip-7Qevh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:32:57 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)) 04:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:32:57 INFO - Running setup.py (path:/tmp/pip-Ri2eDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:32:57 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)) 04:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:32:57 INFO - Running setup.py (path:/tmp/pip-oNbFs_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:32:57 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)) 04:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:57 INFO - Running setup.py (path:/tmp/pip-3zXM1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:57 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)) 04:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:32:57 INFO - Running setup.py (path:/tmp/pip-Vi53Mu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:32:57 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)) 04:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:32:57 INFO - Running setup.py (path:/tmp/pip-6EcG5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:32:57 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)) 04:32:57 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)) 04:32:57 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)) 04:32:57 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)) 04:32:57 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)) 04:32:57 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)) 04:32:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:32:57 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 04:32:57 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 04:32:57 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 04:32:57 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 04:32:57 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 04:32:57 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 04:32:59 INFO - Downloading blessings-1.6.tar.gz 04:32:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:32:59 INFO - Installing collected packages: blessings 04:32:59 INFO - Running setup.py install for blessings 04:32:59 INFO - Successfully installed blessings 04:32:59 INFO - Cleaning up... 04:32:59 INFO - Return code: 0 04:32:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:32:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:32:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:32:59 INFO - Reading from file tmpfile_stdout 04:32:59 INFO - Current package versions: 04:32:59 INFO - argparse == 1.2.1 04:32:59 INFO - blessings == 1.6 04:32:59 INFO - blobuploader == 1.2.4 04:32:59 INFO - docopt == 0.6.1 04:32:59 INFO - manifestparser == 1.1 04:32:59 INFO - mozInstall == 1.12 04:32:59 INFO - mozcrash == 0.17 04:32:59 INFO - mozdebug == 0.1 04:32:59 INFO - mozdevice == 0.48 04:32:59 INFO - mozfile == 1.2 04:32:59 INFO - mozhttpd == 0.7 04:32:59 INFO - mozinfo == 0.9 04:32:59 INFO - mozleak == 0.1 04:32:59 INFO - mozlog == 3.2 04:32:59 INFO - moznetwork == 0.27 04:32:59 INFO - mozprocess == 0.22 04:32:59 INFO - mozprofile == 0.28 04:32:59 INFO - mozrunner == 6.11 04:32:59 INFO - mozscreenshot == 0.1 04:32:59 INFO - mozsystemmonitor == 0.3 04:32:59 INFO - moztest == 0.7 04:32:59 INFO - mozversion == 1.4 04:32:59 INFO - psutil == 3.1.1 04:32:59 INFO - requests == 1.2.3 04:32:59 INFO - wsgiref == 0.1.2 04:32:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:59 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 0x7f0390ed1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11899c0>, '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 0x118a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118ad50>, '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': '33d5923976266a1c518c4bf7000001ab-1464953549.664238-1306211226', '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 04:32:59 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 04:32:59 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 04:32:59 INFO - Using env: {'DISPLAY': ':0', 04:32:59 INFO - 'HOME': '/home/cltbld', 04:32:59 INFO - 'LANG': 'en_US.UTF-8', 04:32:59 INFO - 'LANGUAGE': 'en_US:en', 04:32:59 INFO - 'LOGNAME': 'cltbld', 04:32:59 INFO - 'MAIL': '/var/mail/cltbld', 04:32:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:59 INFO - 'MOZ_NO_REMOTE': '1', 04:32:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:59 INFO - 'NO_EM_RESTART': '1', 04:32:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:59 INFO - 'PWD': '/builds/slave/test', 04:32:59 INFO - 'SHELL': '/bin/bash', 04:32:59 INFO - 'SHLVL': '1', 04:32:59 INFO - 'TERM': 'linux', 04:32:59 INFO - 'TMOUT': '86400', 04:32:59 INFO - 'USER': 'cltbld', 04:32:59 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464953549.664238-1306211226', 04:32:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:59 INFO - '_': '/tools/buildbot/bin/python'} 04:32:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:59 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)) 04:32:59 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)) 04:32:59 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)) 04:32:59 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)) 04:32:59 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)) 04:32:59 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)) 04:32:59 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)) 04:32:59 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)) 04:32:59 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)) 04:32:59 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)) 04:32:59 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)) 04:32:59 INFO - Cleaning up... 04:32:59 INFO - Return code: 0 04:32:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:32:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:59 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 0x7f0390ed1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11899c0>, '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 0x118a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118ad50>, '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': '33d5923976266a1c518c4bf7000001ab-1464953549.664238-1306211226', '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 04:32:59 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 04:32:59 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 04:32:59 INFO - Using env: {'DISPLAY': ':0', 04:32:59 INFO - 'HOME': '/home/cltbld', 04:32:59 INFO - 'LANG': 'en_US.UTF-8', 04:32:59 INFO - 'LANGUAGE': 'en_US:en', 04:32:59 INFO - 'LOGNAME': 'cltbld', 04:32:59 INFO - 'MAIL': '/var/mail/cltbld', 04:32:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:59 INFO - 'MOZ_NO_REMOTE': '1', 04:32:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:59 INFO - 'NO_EM_RESTART': '1', 04:32:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:59 INFO - 'PWD': '/builds/slave/test', 04:32:59 INFO - 'SHELL': '/bin/bash', 04:32:59 INFO - 'SHLVL': '1', 04:32:59 INFO - 'TERM': 'linux', 04:32:59 INFO - 'TMOUT': '86400', 04:32:59 INFO - 'USER': 'cltbld', 04:32:59 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464953549.664238-1306211226', 04:32:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:59 INFO - '_': '/tools/buildbot/bin/python'} 04:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:00 INFO - Downloading/unpacking jsonschema 04:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:33:02 INFO - Downloading/unpacking functools32 (from jsonschema) 04:33:02 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 04:33:02 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 04:33:02 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 04:33:02 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 04:33:02 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 04:33:02 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 04:33:02 INFO - Downloading functools32-3.2.3-2.tar.gz 04:33:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:33:02 INFO - warning: no files found matching '*.txt' 04:33:02 INFO - no previously-included directories found matching 'build' 04:33:02 INFO - no previously-included directories found matching 'dist' 04:33:02 INFO - no previously-included directories found matching '.git*' 04:33:02 INFO - Installing collected packages: jsonschema, functools32 04:33:02 INFO - Running setup.py install for functools32 04:33:02 INFO - warning: no files found matching '*.txt' 04:33:02 INFO - no previously-included directories found matching 'build' 04:33:02 INFO - no previously-included directories found matching 'dist' 04:33:02 INFO - no previously-included directories found matching '.git*' 04:33:02 INFO - Successfully installed jsonschema functools32 04:33:02 INFO - Cleaning up... 04:33:02 INFO - Return code: 0 04:33:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:02 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 0x7f0390ed1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11899c0>, '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 0x118a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118ad50>, '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': '33d5923976266a1c518c4bf7000001ab-1464953549.664238-1306211226', '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 04:33:02 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 04:33:02 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 04:33:02 INFO - Using env: {'DISPLAY': ':0', 04:33:02 INFO - 'HOME': '/home/cltbld', 04:33:02 INFO - 'LANG': 'en_US.UTF-8', 04:33:02 INFO - 'LANGUAGE': 'en_US:en', 04:33:02 INFO - 'LOGNAME': 'cltbld', 04:33:02 INFO - 'MAIL': '/var/mail/cltbld', 04:33:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:02 INFO - 'MOZ_NO_REMOTE': '1', 04:33:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:33:02 INFO - 'NO_EM_RESTART': '1', 04:33:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:33:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:02 INFO - 'PWD': '/builds/slave/test', 04:33:02 INFO - 'SHELL': '/bin/bash', 04:33:02 INFO - 'SHLVL': '1', 04:33:02 INFO - 'TERM': 'linux', 04:33:02 INFO - 'TMOUT': '86400', 04:33:02 INFO - 'USER': 'cltbld', 04:33:02 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464953549.664238-1306211226', 04:33:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:02 INFO - '_': '/tools/buildbot/bin/python'} 04:33:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:02 INFO - Downloading/unpacking flake8 04:33:02 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 04:33:02 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 04:33:02 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 04:33:02 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 04:33:02 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 04:33:02 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 04:33:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:33:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:33:04 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 04:33:04 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 04:33:04 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 04:33:04 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 04:33:04 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 04:33:04 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 04:33:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:33:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:33:04 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 04:33:04 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 04:33:04 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 04:33:04 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 04:33:04 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 04:33:04 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 04:33:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:33:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:33:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:33:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:33:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:33:05 INFO - no previously-included directories found matching 'docs/_build' 04:33:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:33:05 INFO - Running setup.py install for pep8 04:33:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:33:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:33:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:33:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:33:05 INFO - no previously-included directories found matching 'docs/_build' 04:33:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:33:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:33:05 INFO - Cleaning up... 04:33:05 INFO - Return code: 0 04:33:05 INFO - Running post-action listener: _resource_record_post_action 04:33:05 INFO - Running post-action listener: _start_resource_monitoring 04:33:05 INFO - Starting resource monitoring. 04:33:05 INFO - ##### 04:33:05 INFO - ##### Finished create-virtualenv step (success) 04:33:05 INFO - ##### 04:33:05 INFO - ##### 04:33:05 INFO - ##### Running install step. 04:33:05 INFO - ##### 04:33:05 INFO - Running pre-action listener: _resource_record_pre_action 04:33:05 INFO - Running main action method: install 04:33:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:33:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:33:05 INFO - Reading from file tmpfile_stdout 04:33:05 INFO - Detecting whether we're running mozinstall >=1.0... 04:33:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:33:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:33:05 INFO - Reading from file tmpfile_stdout 04:33:05 INFO - Output received: 04:33:05 INFO - Usage: mozinstall [options] installer 04:33:05 INFO - Options: 04:33:05 INFO - -h, --help show this help message and exit 04:33:05 INFO - -d DEST, --destination=DEST 04:33:05 INFO - Directory to install application into. [default: 04:33:05 INFO - "/builds/slave/test"] 04:33:05 INFO - --app=APP Application being installed. [default: firefox] 04:33:05 INFO - mkdir: /builds/slave/test/build/application 04:33:05 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'] 04:33:05 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 04:33:21 INFO - Reading from file tmpfile_stdout 04:33:21 INFO - Output received: 04:33:21 INFO - /builds/slave/test/build/application/firefox/firefox 04:33:21 INFO - Running post-action listener: _resource_record_post_action 04:33:21 INFO - ##### 04:33:21 INFO - ##### Finished install step (success) 04:33:21 INFO - ##### 04:33:21 INFO - ##### 04:33:21 INFO - ##### Running run-tests step. 04:33:21 INFO - ##### 04:33:21 INFO - Running pre-action listener: _resource_record_pre_action 04:33:21 INFO - Running main action method: run_tests 04:33:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:33:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:33:21 INFO - Python 2.7.3 04:33:21 INFO - Return code: 0 04:33:21 INFO - grabbing minidump binary from tooltool 04:33:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:21 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 0x11899c0>, '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 0x118a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118ad50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:33:21 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 04:33:21 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 04:33:21 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 04:33:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:33:21 INFO - Return code: 0 04:33:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:33:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:33:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:33:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:33:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:33:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:33:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:33:22 INFO - Return code: 0 04:33:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e6pu5doPTiqK2goLzX48ig/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 04:33:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/e6pu5doPTiqK2goLzX48ig/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --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 04:33:22 INFO - Using env: {'DISPLAY': ':0', 04:33:22 INFO - 'HOME': '/home/cltbld', 04:33:22 INFO - 'LANG': 'en_US.UTF-8', 04:33:22 INFO - 'LANGUAGE': 'en_US:en', 04:33:22 INFO - 'LOGNAME': 'cltbld', 04:33:22 INFO - 'MAIL': '/var/mail/cltbld', 04:33:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:33:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:33:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:22 INFO - 'MOZ_NO_REMOTE': '1', 04:33:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:33:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:33:22 INFO - 'NO_EM_RESTART': '1', 04:33:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:33:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:22 INFO - 'PWD': '/builds/slave/test', 04:33:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:33:22 INFO - 'SHELL': '/bin/bash', 04:33:22 INFO - 'SHLVL': '1', 04:33:22 INFO - 'TERM': 'linux', 04:33:22 INFO - 'TMOUT': '86400', 04:33:22 INFO - 'USER': 'cltbld', 04:33:22 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464953549.664238-1306211226', 04:33:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:22 INFO - '_': '/tools/buildbot/bin/python'} 04:33:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e6pu5doPTiqK2goLzX48ig/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 04:33:23 INFO - mozversion application_buildid: 20160603033811 04:33:23 INFO - mozversion application_changeset: 4874ff5d90f81aca0bb57d2f74586210cbee3cf6 04:33:23 INFO - mozversion application_display_name: Nightly 04:33:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:33:23 INFO - mozversion application_name: Firefox 04:33:23 INFO - mozversion application_remotingname: firefox 04:33:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:33:23 INFO - mozversion application_vendor: Mozilla 04:33:23 INFO - mozversion application_version: 49.0a1 04:33:23 INFO - mozversion platform_buildid: 20160603033811 04:33:23 INFO - mozversion platform_changeset: 4874ff5d90f81aca0bb57d2f74586210cbee3cf6 04:33:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:33:23 INFO - mozversion platform_version: 49.0a1 04:33:23 INFO - using testdate: 1464953603 04:33:23 INFO - actual date: 1464953603 04:33:23 INFO - starting webserver on 'localhost:51089' 04:33:23 INFO - SUITE-START | Running 2 tests 04:33:23 INFO - TEST-START | dromaeo_css 04:33:23 INFO - operating with platform_type : linux_ 04:33:23 INFO - Initialising browser for dromaeo_css test... 04:33:23 INFO - TEST-INFO | started process 14298 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnk5JXH/profile http://localhost:51089/getInfo.html) 04:33:35 INFO - PROCESS | 14298 | __metrics Screen width/height:1600/1200 04:33:35 INFO - PROCESS | 14298 | colorDepth:24 04:33:35 INFO - PROCESS | 14298 | Browser inner width/height: 1024/697 04:33:35 INFO - PROCESS | 14298 | __metrics 04:33:37 ERROR - PROCESS | 14298 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:33:38 INFO - TEST-INFO | 14298: exit 0 04:33:38 INFO - Browser initialized. 04:33:38 INFO - Running cycle 1/1 for dromaeo_css test... 04:33:38 INFO - TEST-INFO | started process 14381 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnk5JXH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:33:50 INFO - PROCESS | 14381 | RSS: Main: 157429760 04:33:50 INFO - PROCESS | 14381 | 04:34:41 INFO - PROCESS | 14381 | 1464953681739 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] 04:36:55 INFO - PROCESS | 14381 | Cycle 1(1): loaded http://localhost:51089/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51089/tests/dromaeo/cssquery-ext.html) 04:36:56 INFO - PROCESS | 14381 | RSS: Main: 262037504 04:36:56 INFO - PROCESS | 14381 | 04:39:59 INFO - PROCESS | 14381 | Cycle 1(1): loaded http://localhost:51089/tests/dromaeo/cssquery-ext.html (next: http://localhost:51089/tests/dromaeo/cssquery-jquery.html) 04:40:00 INFO - PROCESS | 14381 | RSS: Main: 240869376 04:40:00 INFO - PROCESS | 14381 | 04:43:02 INFO - PROCESS | 14381 | Cycle 1(1): loaded http://localhost:51089/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51089/tests/dromaeo/cssquery-mootools.html) 04:43:02 INFO - PROCESS | 14381 | RSS: Main: 246571008 04:43:02 INFO - PROCESS | 14381 | 04:46:05 INFO - PROCESS | 14381 | Cycle 1(1): loaded http://localhost:51089/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51089/tests/dromaeo/cssquery-prototype.html) 04:46:05 INFO - PROCESS | 14381 | RSS: Main: 235208704 04:46:05 INFO - PROCESS | 14381 | 04:49:08 INFO - PROCESS | 14381 | Cycle 1(1): loaded http://localhost:51089/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51089/tests/dromaeo/cssquery-yui.html) 04:49:09 INFO - PROCESS | 14381 | RSS: Main: 212660224 04:49:09 INFO - PROCESS | 14381 | 04:52:12 INFO - PROCESS | 14381 | Cycle 1(1): loaded http://localhost:51089/tests/dromaeo/cssquery-yui.html (next: http://localhost:51089/tests/dromaeo/cssquery-dojo.html) 04:52:12 INFO - PROCESS | 14381 | RSS: Main: 265469952 04:52:12 INFO - PROCESS | 14381 | 04:52:12 INFO - PROCESS | 14381 | __start_tp_report 04:52:12 INFO - PROCESS | 14381 | _x_x_mozilla_page_load 04:52:12 INFO - PROCESS | 14381 | _x_x_mozilla_page_load_details 04:52:12 INFO - PROCESS | 14381 | |i|pagename|runs| 04:52:12 INFO - PROCESS | 14381 | |0;dojo.html;2639.788816894648;2702.554078577032;2720.959185612215;2746.9973459687194;2750.57366108253;4696.97651511742;4702.976485117578;4738.597219236369;4790.856274311776;4863.537963893429;4753.4533528644215;4790.305405716178;4828.348172996644;4830.830920917769;4867.756612169395;4235.1529694061155;4402.097569998143;4471.441069866267;4524.140413321458;4628.213203755369;4529.932051019254;4571.634269258468;4582.656300777438;4582.885427864297;4613.838515651953;4312.78436078198;4332.718373305725;4353.804078816461;4410.316400957857;4425.092855964552;4293.806778694966;4296.033392486696;4336.696431249814;4342.261815491374;4354.56454354562;4331.740095594275;4384.802683879233;4401.075774087413;4408.272635015219;4437.889052773674;4580.290055041441;4625.167469855424;4668.743219122947;4726.621870250372;4730.219513780222;4987.401511818605;5062.898742025176;5066.138756411419;5142.357205349332;5148.716820574867;5190.8183213587345;5220.060389129955;5222.791088356461;5244.213367994793;5244.39689435716;4598.540145985442;4686.36734040907;4828.565429111397;4881.267809828519;4889.828855990023;5255.921161182585;5348.411674715856;5371.194320851903;5373.032854086224;5374.758135883894;5092.592592592584;5100.923486147711;5142.331496905378;5145.76844042019;5148.768305426265;5023.924641130386;5081.618878584121;5139.974300128551;5159.071367153948;5170.302009228782;5111.182210846321;5116.462771409023;5116.513931176532;5146;5190.169572868398;5096.05722941257;5103.923441148386;5105.183170692671;5106.948930510647;5191.091558977164;4227.112306415625;4250.617444429954;4314.050908800059;4381.978090109529;4428.623566996841;3805.5813860475328;3809.657130858236;3821.5796262411113;3839.424086387064;3899.1421887184774;4451.844185453494;4472.508024117345;4478.865634030984;4523.547645235516;4525.321201819754;4987.5760560352055;5058.595312375001;5059.316992206005;5192.818251361185;5257.921131183035;4395.099004704028;4416.6025057744955;4449.154660614473;4487.910241795146;4500.977495112504;4673.953260467351;4676.696014759098;4676.836310729108;4684.344191813149;4724.196886529298;4803.447603525499;4842.370491836109;4857.441394239708;4858.562729354305;4893.6085113191575;4989.151844186569;5108;5159.17453207485;5173.560247378864;5197.194434862602;4830.347903033045;4845.733484658378;4847.515248475124;4849.80600775965;4891.26631005352;4930.802767889244;5102.668326558762;5108.489151084862;5110.029094472038;5164.251183578285;5060.165072762953;5100.923486147785;5107.616928730435;5135.614828887774;5136.2552429898205;5001.624878134227;5022.070916880389;5022.096022715946;5026.34657494538;5071.594272458121;4856.368672072608;4876.707397556158;5008.524190201925;5021.6735912165595;5027.120253955616;4825.324454576432;4921.704697718148;4941.085899108676;4947.876303092307;4948.134076536519;4996.225585034325;4996.300517927566;5000.64995450315;5000.799968001239;5036.345275114359;4831.661783675109;4903.387076615423;4913.803447862046;4939.678920870132;4958.479359667183 04:52:12 INFO - PROCESS | 14381 | |1;ext.html;544.1767750008488;578.6585914310557;579.4118969246216;590.2385922160413;605.500462118752;27810;31006.224844378845;31040.53439198411;31083.067507974796;31098.844505777466;30828.38343233134;41300.173996520054;42106.57893421065;42255.78872105643;47408.76295618526;7804.531728096318;7940.483868548526;7948.602569871512;7957.761267161965;7970.442069055169;7633.313001829834;7782.9221707783045;7867.567283799389;7921.524708517507;7947.443678942476;9946.602135914554;10282.383057016565;10289.382637041765;10629.468526573679;10648.62729804457;10164.339317944346;10270.7432314192;10274.332168409066;10279;10285.742856428575;7536.773896783106;9680.661176858846;10082.495875206283;10117.494125293779;10178.982101789836;39745.40381894274;40184.799076004725;40194.19611607752;40291.798541007105;40309.193816123516;3097.90706278812;3100.829454380008;3145.653978062411;3178.300773829754;3231.644519102897;30422.84788576065;30892;30948.690513094807;30978.380432391452;31342.05973820789;3516.4813412708945;3545.840437180333;3574.249407624402;3577.6422357764277;3618.203995121069;264348;264777.67611162015;265030;266081;266143;56618;57240.427595724344;57279;57331.713341433024;57399;54337;54404.72797635986;54453.72773136188;54550.72724636431;54587.18119228215;14990.400383984737;15439.382424702886;15449.768253476206;15450.381984720485;15455.149966751711;11723.706907327214;11753.236039657395;11792.52829886795;11810.291382517076;11814.232074915102;15895.966762160422;18044.85831290576;18227.54431139232;18812.435626931216;18927.337543185924;6934.583924964519;6940.583564986117;7120.216776154619;7149.7497587584185;7313.744018959311;809.3323008517996;946.4510583861344;952.4428209497521;969.520087556664;984.8424252119627;28541.286467838054;29519.704802952125;29734.702652973625;29761.851190743906;29955.70044299529;953.3612479638658;980.3726014281651;981.1709105805583;997.7106639074732;1079.09895237476;15557.433023550988;15574.844251557339;15592.92203538975;15620.218989050501;15802.762958555631;373573;373765;376422;377644;378923;50748;51217;51235.487645123816;51248.23127653088;51426.74286628618;1249.743802520481;1253.254313683357;1269.2891980490954;1276.7063575377529;1284.794432890733;27155.72844271611;28479.18874221432;28601.713982859907;28730.42539149247;28955;44701.55298446974;44847.77576112099;44927.550724492336;45096.77451612852;45148;316861;318436;318762;318849;320658;25830;25930.481390372464;26444;26598.335041624116;26608.866955665097;33179.668203317655;36392.454113188855;37383.43924841075;43311.783441083855;44349;36343.273134536634;37269.813650931574;39202.2159556813;41435.585644144376;41802.163956721306;38141.427878581286;38347;38360.23279534338;38509.42235866408;38663;37407.251854962204;37612.2477550442;37787.43318850274;38114.80942595269;38357.6164238354;32595.511067333533;34025.65974340225;34686.30627387387;35048.299034018666;35101.297974040885;26149.73850261473;26215.73784262133;26264;26316.342091447867;26405.92894049094 04:52:12 INFO - PROCESS | 14381 | |2;jquery.html;364.72710241258;378.3171375666921;381.9713521485891;384.74799006650653;387.7673395962421;15278;16448.58878528036;16751.91624041881;16885.831141688595;17074.31702731889;16012.43956461524;16456.259468323926;16948;16960.491185264433;16981.405650802226;5067.670601410915;5231.398389185235;5233.136532472156;5245.527902488775;5247.475252474741;3706.721995850322;3892.2020985697864;5156.149235376159;5757.68332741699;6058.515318774487;6068.423499767515;6087.543434242428;6097.939020609803;6122.234720659918;6127.387261273881;5949.940500594982;5995.040793473046;6080.209572755558;6088.96955515224;6091.817245482621;3356.580427446569;4962.950370496285;5251.894962100737;5295.073362161645;5296.443873393316;19358.4192474226;20089.8995505023;20101.497462563406;20194.49513762153;20250;2033.0241484087574;2103.8842863642494;2120.7879212078824;2360.6931098957198;2401.7958473529598;12989.740205195843;13129.934350328283;13131.343432828417;13144.86855131446;13689;1755.9561010974828;1760.5510594798372;1772.8936263824212;1842.447265820262;1849.0444118597256;41419.7929010356;44236;65687.0146947801;66151;66582;9448.433094014381;9746.319762065488;9832.901670983341;9862;9988.101070903509;13262.602121936357;13302.135361201492;13327.466901323838;13388.263645499592;13403.195808251341;7432.554046757212;7445.218252083561;7459.664315105833;7683.658732815941;7758.961205194051;7456.813579660444;7469.813254668568;7473.327400533978;7583.090029196532;7585;6188.277158050443;6217.316095229521;6228.968855155696;6262.624242545462;6282.403171698681;1617.7249867522548;1648.7691723158766;1765.6910040742819;1768.6374293269848;1791.6148028174005;843.8860753798282;885.9335549833788;896.394933419939;952.3190918493173;999.6651121874254;16724.58188545296;17072.82927170737;17402.651946961243;17484.47546573605;17660.911695441442;891.4695756025154;894.4096896048577;937.1565590968047;980.3872579637726;1009.2380252909006;10010.749731256778;10043.246756493292;10236.53935572901;10253.897461025443;10263.640772572924;341827;342304;343336;348191;349841;64563;64790.67604661947;65534.344656553774;66690.33309666938;67370.66314668395;912.0696889173006;932.2495391210006;949.852772820214;979.9412035277907;985.3348989432104;15138.545843624708;15305.464308749586;15391.153486558347;15471.690566188838;15694.529164125095;23712.40718982039;26186.476270474104;30902.381952360378;32085.03744887657;32120.67879321177;41306;41431.37852932148;41541.37687934744;41739;41820.79089604533;7768.067831860213;7802.687892484464;7824.21757824213;7835.84328313442;7892.05295364537;11558.364289964133;11744.647660570197;11762.58830940913;11876.58431954912;12194.634160975185;9644;9768.804623907625;10029.247806414402;10112.544935477774;10135.847962280719;9790.951045244728;9923;9930.304878658424;10206.948965255424;10312.123469505175;9681.66114186;9880.703578892644;10143.89856101459;10215.336003159771;10643.192558547866;7586.203448638034;7624.27569380908;7666.8083297918;7785.610719464117;7806.297433231037;10376.273660843668;10430.947845260725;10568.735781605521;10630.043296103388;10681.626143084955 04:52:12 INFO - PROCESS | 14381 | |3;mootools.html;1282.051282051281;1367.4666879916833;1413.7031223443078;1478.327361050722;1692.2046638080105;6269.090981807635;6798.354156355151;6969.407600353963;6997.26528714484;7007.29927007299;6870.3473170048765;6932.27211142829;7007.789766307019;7155.105611798525;7163.749268775594;2032.959340813183;2082.2607974169177;2083.489545061462;2085.17635533964;2089.780573039832;2076.563921576471;2114.2071723103836;2117.5129720164373;2119.1417475922276;2120.8621439606454;2028.3002364184406;2035.7964203579597;2036.521417466894;2038.1032345767815;2056.845736569756;2054.7123402723555;2056.311135769519;2061.2270398600526;2061.5361543652634;2062.092679221153;1980.9504762380911;1981.782003979561;2010.4672261850621;2013.7684166320914;2018.4852862519963;6782.287859774751;6907.240203577602;7064.540804847668;7066.434685225169;7087.8228044298785;4312.3531470279395;4465.709728867646;4470.26240670289;4474.217012022916;4476.686631935766;2718.6329845470805;2833.4758069757163;2876.5397536394075;2881.366099458137;2884.307766136112;895.8477058900003;905.9048799875984;907.3693782820942;913.3743385780695;922.921551668109;8930.19628233462;9040.050794666597;9081.318901082379;9088.318376121751;9098.181163695299;3895.2988462076532;3931.7051221157953;4066.5933406659688;4070.247004304213;4074.7351422157467;8081.272685458337;8144.552049637208;8145.796355091052;8149.225823546753;8155.143709910492;4352.042550638855;4417.271150260235;4417.845375411909;4424.889377765581;4426.026274219666;3563.6970857476886;3902.8829135125993;4030.1536677298095;4057.9797101014306;4059.573744756817;3500.317438099546;3507.000504856104;3563.2695297463956;3596.730245231618;3697.8890633281044;1132.2017977325966;1134.7219931116765;1165.9941700291445;1172.6423440850451;1173;758.7116895579754;810.9472884262505;822.321584692631;837.5267973594899;869.1742844297816;4894;4955.157623204064;4961.801527938842;4969.155243608595;5020.899582008339;409.55767770807455;905.40319664782;910.517425764346;980.8773903262093;1010.4442556593845;3487.302539492112;3530.6469353065004;3549.538559987185;3571.821408929543;3699.0197597636648;8552.88812454377;8746.86879696805;8791.780205494913;8825.646974121091;8851.911480885237;8652.178043085896;8714.302855771522;8724.8691269631;8726.083761204982;8762.211400973816;6735.292794256533;6855.108835851307;6875.312468753084;6882.518223724392;6882.69027893746;5111.284420181103;5183.105299189324;5244.396894357198;5357.919631205613;5437.40188579248;7898.644560994884;7944.602769861368;8128.9593552031865;8185.140560241327;8196.672133114847;8153.388495862715;8169.223923727474;8194;8220.63007164691;8258.958705206676;5717.799877004285;6158.784442544489;6190;6305.2433707953505;6394.840128996812;7020.684069217;7041.859162816818;7063.1524217094275;7084.964575177091;7091.1490621125795;6285.685715714288;6409.7115629795835;6466.967665161832;6491.967540162269;6591.604503729792;6249.031400132987;6266.091416744638;6302.905456418066;6363.490920726424;6376.681165941777;6038.758449661965;6071.696415179312;6104.17593624855;6109.633421994695;6120.571559990758;4404.580684316843;4487.865364039084;4565.703229290086;4577.473590536998;4594.333821595917;4548.88627784308;4553.8406155785715;4573.5426457354;4623.445186577632;4637.443506779073 04:52:12 INFO - PROCESS | 14381 | |4;prototype.html;300.1041889958474;303.2736595852932;310.58381768430297;311.11953172521766;311.563810665069;4836.322914791927;4892.608591312695;4896.412430508344;4901.852944411665;4917.508249175085;4828.324034635154;4840.298156767267;4843.782029808658;4865.14859899518;4868.221084626461;3624.619414961424;3760.6803421709187;3761.2665530221616;3792.7724336539895;3812.7902965336893;3710.5361829771277;3790.2608991246716;3804.334241507725;3818.770873747584;3870.6516413522777;3775.320442320381;3780.621937806211;3783.3920583751933;3796.1838204785968;3828.712846536507;3638.399664055428;3787.58336582977;3792.8672496462627;3801.505804245458;3830.9042273943373;3363.1760218746317;3364.2766805136766;3372.7133193678324;3373.460246360595;3385.2044769479153;4589.105124500724;4621.590414923447;4629.328747331618;4630.166570017395;4639.5824375806005;4161.313383291753;4302.827886884521;4343.4787825460835;4359.411479450266;4361.345798130305;5069.112905241568;5079;5079.720615366154;5079.847604571832;5090.98180363925;3587.7488575799703;3622.2755448910325;3625.9093522662142;3640.271945610862;3701.148735790783;5023.79904803811;5226.3989641191365;5226.81706140287;5237.921431178535;5286.233496143076;3749.1751814600743;3768.962310376916;3779.7921114338974;3783.5785097537596;3786.2238241160494;3813.904652383713;3820.3123437781464;3827.5024246847734;3840.423936409505;3842.8462861485227;4302.935455968163;4308.202982448257;4329.567043295709;4343.5656434356315;4349.391085248068;4820.903581928342;5001.89996200074;5016.347874776256;5031.245313202976;5039.21892106724;1321.0950498908087;1340.2896464873634;1342.4294674763187;1346.6364081697886;1349.7165595224917;838.4990866349167;842.4481964313385;873.2446433834688;888.1873086126251;894.2979760887672;4353.434053573079;4426.291793313055;4502.19912035182;4502.5047244803045;4510.797014134372;5177.58579313654;5187.766550505161;5204.66169698976;5225.23062776729;5227.111391063529;4452;4468.4414448193975;4478.619317358061;4488.438945131858;4513.210188217049;2635.683717953858;2791.972080279171;2797.860106994642;2810;2815.2821030637465;4876.171435711608;4924.75376231187;4933.703977761345;4937.851864444073;4950.356453661001;5227.660202086929;5386.946130538645;5390.9191362129595;5407.999520088796;5422.8915421691345;4840.249761287007;4859.73646851814;4887.7556122194455;4897.751073476241;4917.278952366714;5216.504432078947;5252.9737351313;5270.97216042868;5272.920906186334;5287.550558202442;4873.220284754422;5143.459936706592;5149.510796474329;5174.14626586624;5192.169252919514;4906.165951788276;4906.190478570996;4914.385701787277;4918.336024636628;4926.3842019747535;3586.9103272418397;3637.636236376341;3642.8724994625063;3645.5807582127336;3662;5188.558972487381;5241.240020197126;5310.362756469249;5323.961827443612;5350.438203988525;5077.77150028257;5096.821611243588;5109.7700603472185;5111.744412779271;5116.872078198075;5097.235414687826;5098.209777484496;5100.5409513143995;5107.9233811493605;5122.513361230677;4878.829240976549;4977.352944117241;5031.723255220998;5043.36957880265;5053.393592768891;4826.565609095198;4976.253561965734;5107.616928730435;5116.641835071509;5143.948560514347;5008.499150084962;5010.87472813168;5014.473480284518;5027.949720502895;5050.116229659869 04:52:12 INFO - PROCESS | 14381 | |5;yui.html;632.8734253149371;635.7806556737924;665.4077870695079;685.7771224352086;739.9334059934606;12219.938900305497;13221;13249.138805977605;13257.867421325784;13263.270520121401;13767.518136865212;14469.493567725132;14494.637634059154;14992.700145997074;15007.774883376758;644.4361183964031;776.1888826176659;823.9134890836451;824.3487644760631;829.5147338806775;821.9630116644736;832.3590835057003;833.8123922117536;833.912439193885;833.945793523422;850.0097386544668;854.4616891358436;855.3883972959333;855.3883972959333;855.4525103933488;672.7040102354948;842.5787106446777;847.9279261262769;848.5629900601165;871.2028493928049;615.5198944823045;616.2389449030444;617.2500411999397;617.6355949989528;617.9134921111048;12962;13087.541936032194;13115.803262951064;13120;13124.015698822626;13198.47206111764;13808.757211850882;13896.374663140183;13917.373718182705;14131.081479703786;10036.64871729486;10583.10043646291;10897.128229741602;11048.944755276252;11198.720031999184;4282.743035417885;4320.870373888788;4335.379544854824;4414.271645178542;4510.052888893337;59463.70268148675;59554;59568.702156488944;59678.403215967715;60122.69938650323;10445.84331235032;10569;10759;10921.945390273157;11266.66200014001;19145.904270478557;19281.903590482238;19291.324803631807;19311.710324345146;19325.51686207856;6952.165740111219;7029.22678505364;7229;7235.746748863765;7298.744543940937;3789.8484060637816;3889.4943657324934;3918.3730603103936;3957.0305275207184;3957.3470377387407;3073.2163298358773;3218.3563287342627;3220.436423625856;3220.9838950805565;3224.1294850390263;552.8396764938122;556.5047108073818;560.0423276197747;566.7166416791604;573.2118337286231;477.6632474105817;518.5229588778333;569.6952130610103;582.5892745614332;587.4272584230341;8192.098869124391;8275.95862020686;8327.292180164633;8357.164283571594;8526.275266602408;526.4130494498683;538.3217146395491;581.7469400810576;587.1624927716799;597.3339726205337;3610.8736194233074;3828.3683192272965;3842.654161125512;3848.8845334640005;3849.846006159722;80754.59622701966;84487;86463;86880.56559717287;89804.5509772447;65233;68852;74258;74958;78290.21709782943;70897;71162.64418677977;71421.28578714251;71973.28026719876;73555.26444735484;7950.801229969297;8088.79778005531;8138.674453021813;8180.100188979327;8295.875561866698;33585.496217557244;37553.6244637561;42378;43305.56694433015;43459.782701087555;53158.46841531535;53898.19152712634;54632;54843.17735233895;55212.44787552234;10408.219383546113;10680.519376628226;11168.331019658886;11214.551417943518;11326.37704926237;9826.06652368024;11599.942000289944;11957.282563046245;12358.50565977351;12540.05949553769;11501.252418592765;11670.416479175838;11740.119491038036;12347.69130771738;12414.503419863104;11380;11797.233179843282;11811.350375729417;12316.076294277786;12414.689632759253;11446.37044962535;11667.533298667959;11812.82280765772;12266.938665306616;12385.876141238472;8845.69040083594;9146.817063658822;9278.211352035152;9308.208802251613;9321.906780932104;9167.266618670623;9322.720318390458;9416.764580885532;9434.48110353937;9484.288678349289 04:52:12 INFO - PROCESS | 14381 | __end_tp_report 04:52:12 INFO - PROCESS | 14381 | __start_cc_report 04:52:12 INFO - PROCESS | 14381 | _x_x_mozilla_cycle_collect,956 04:52:12 INFO - PROCESS | 14381 | __end_cc_report 04:52:12 INFO - PROCESS | 14381 | __startTimestamp1464954732609__endTimestamp 04:52:12 INFO - PROCESS | 14381 | 04:52:12 INFO - PROCESS | 14381 | ------- Summary: start ------- 04:52:12 INFO - PROCESS | 14381 | Number of tests: 6 04:52:12 INFO - PROCESS | 14381 | 04:52:12 INFO - PROCESS | 14381 | [#0] dojo.html Cycles:165 Average:4749.20 Median:4863.54 stddev:495.21 (10.2%) stddev-sans-first:468.27 04:52:12 INFO - PROCESS | 14381 | Values: 2639.8 2702.6 2721.0 2747.0 2750.6 4697.0 4703.0 4738.6 4790.9 4863.5 4753.5 4790.3 4828.3 4830.8 4867.8 4235.2 4402.1 4471.4 4524.1 4628.2 4529.9 4571.6 4582.7 4582.9 4613.8 4312.8 4332.7 4353.8 4410.3 4425.1 4293.8 4296.0 4336.7 4342.3 4354.6 4331.7 4384.8 4401.1 4408.3 4437.9 4580.3 4625.2 4668.7 4726.6 4730.2 4987.4 5062.9 5066.1 5142.4 5148.7 5190.8 5220.1 5222.8 5244.2 5244.4 4598.5 4686.4 4828.6 4881.3 4889.8 5255.9 5348.4 5371.2 5373.0 5374.8 5092.6 5100.9 5142.3 5145.8 5148.8 5023.9 5081.6 5140.0 5159.1 5170.3 5111.2 5116.5 5116.5 5146.0 5190.2 5096.1 5103.9 5105.2 5106.9 5191.1 4227.1 4250.6 4314.1 4382.0 4428.6 3805.6 3809.7 3821.6 3839.4 3899.1 4451.8 4472.5 4478.9 4523.5 4525.3 4987.6 5058.6 5059.3 5192.8 5257.9 4395.1 4416.6 4449.2 4487.9 4501.0 4674.0 4676.7 4676.8 4684.3 4724.2 4803.4 4842.4 4857.4 4858.6 4893.6 4989.2 5108.0 5159.2 5173.6 5197.2 4830.3 4845.7 4847.5 4849.8 4891.3 4930.8 5102.7 5108.5 5110.0 5164.3 5060.2 5100.9 5107.6 5135.6 5136.3 5001.6 5022.1 5022.1 5026.3 5071.6 4856.4 4876.7 5008.5 5021.7 5027.1 4825.3 4921.7 4941.1 4947.9 4948.1 4996.2 4996.3 5000.6 5000.8 5036.3 4831.7 4903.4 4913.8 4939.7 4958.5 04:52:12 INFO - PROCESS | 14381 | 04:52:12 INFO - PROCESS | 14381 | [#1] ext.html Cycles:180 Average:48150.30 Median:3531.16 stddev:84833.74 (2402.4%) stddev-sans-first:84996.42 04:52:12 INFO - PROCESS | 14381 | Values: 544.2 578.7 579.4 590.2 605.5 27810.0 31006.2 31040.5 31083.1 31098.8 30828.4 41300.2 42106.6 42255.8 47408.8 7804.5 7940.5 7948.6 7957.8 7970.4 7633.3 7782.9 7867.6 7921.5 7947.4 9946.6 10282.4 10289.4 10629.5 10648.6 10164.3 10270.7 10274.3 10279.0 10285.7 7536.8 9680.7 10082.5 10117.5 10179.0 39745.4 40184.8 40194.2 40291.8 40309.2 3097.9 3100.8 3145.7 3178.3 3231.6 30422.8 30892.0 30948.7 30978.4 31342.1 3516.5 3545.8 3574.2 3577.6 3618.2 264348.0 264777.7 265030.0 266081.0 266143.0 56618.0 57240.4 57279.0 57331.7 57399.0 54337.0 54404.7 54453.7 54550.7 54587.2 14990.4 15439.4 15449.8 15450.4 15455.1 11723.7 11753.2 11792.5 11810.3 11814.2 15896.0 18044.9 18227.5 18812.4 18927.3 6934.6 6940.6 7120.2 7149.7 7313.7 809.3 946.5 952.4 969.5 984.8 28541.3 29519.7 29734.7 29761.9 29955.7 953.4 980.4 981.2 997.7 1079.1 15557.4 15574.8 15592.9 15620.2 15802.8 373573.0 373765.0 376422.0 377644.0 378923.0 50748.0 51217.0 51235.5 51248.2 51426.7 1249.7 1253.3 1269.3 1276.7 1284.8 27155.7 28479.2 28601.7 28730.4 28955.0 44701.6 44847.8 44927.6 45096.8 45148.0 316861.0 318436.0 318762.0 318849.0 320658.0 25830.0 25930.5 26444.0 26598.3 26608.9 33179.7 36392.5 37383.4 43311.8 44349.0 36343.3 37269.8 39202.2 41435.6 41802.2 38141.4 38347.0 38360.2 38509.4 38663.0 37407.3 37612.2 37787.4 38114.8 38357.6 32595.5 34025.7 34686.3 35048.3 35101.3 26149.7 26215.7 26264.0 26316.3 26405.9 04:52:12 INFO - PROCESS | 14381 | 04:52:12 INFO - PROCESS | 14381 | [#2] jquery.html Cycles:180 Average:22107.42 Median:2139.98 stddev:56629.33 (2646.2%) stddev-sans-first:56764.66 04:52:12 INFO - PROCESS | 14381 | Values: 364.7 378.3 382.0 384.7 387.8 15278.0 16448.6 16751.9 16885.8 17074.3 16012.4 16456.3 16948.0 16960.5 16981.4 5067.7 5231.4 5233.1 5245.5 5247.5 3706.7 3892.2 5156.1 5757.7 6058.5 6068.4 6087.5 6097.9 6122.2 6127.4 5949.9 5995.0 6080.2 6089.0 6091.8 3356.6 4963.0 5251.9 5295.1 5296.4 19358.4 20089.9 20101.5 20194.5 20250.0 2033.0 2103.9 2120.8 2360.7 2401.8 12989.7 13129.9 13131.3 13144.9 13689.0 1756.0 1760.6 1772.9 1842.4 1849.0 41419.8 44236.0 65687.0 66151.0 66582.0 9448.4 9746.3 9832.9 9862.0 9988.1 13262.6 13302.1 13327.5 13388.3 13403.2 7432.6 7445.2 7459.7 7683.7 7759.0 7456.8 7469.8 7473.3 7583.1 7585.0 6188.3 6217.3 6229.0 6262.6 6282.4 1617.7 1648.8 1765.7 1768.6 1791.6 843.9 885.9 896.4 952.3 999.7 16724.6 17072.8 17402.7 17484.5 17660.9 891.5 894.4 937.2 980.4 1009.2 10010.7 10043.2 10236.5 10253.9 10263.6 341827.0 342304.0 343336.0 348191.0 349841.0 64563.0 64790.7 65534.3 66690.3 67370.7 912.1 932.2 949.9 979.9 985.3 15138.5 15305.5 15391.2 15471.7 15694.5 23712.4 26186.5 30902.4 32085.0 32120.7 41306.0 41431.4 41541.4 41739.0 41820.8 7768.1 7802.7 7824.2 7835.8 7892.1 11558.4 11744.6 11762.6 11876.6 12194.6 9644.0 9768.8 10029.2 10112.5 10135.8 9791.0 9923.0 9930.3 10206.9 10312.1 9681.7 9880.7 10143.9 10215.3 10643.2 7586.2 7624.3 7666.8 7785.6 7806.3 10376.3 10430.9 10568.7 10630.0 10681.6 04:52:12 INFO - PROCESS | 14381 | 04:52:12 INFO - PROCESS | 14381 | [#3] mootools.html Cycles:180 Average:4783.46 Median:5397.66 stddev:2545.63 (47.2%) stddev-sans-first:2539.17 04:52:12 INFO - PROCESS | 14381 | Values: 1282.1 1367.5 1413.7 1478.3 1692.2 6269.1 6798.4 6969.4 6997.3 7007.3 6870.3 6932.3 7007.8 7155.1 7163.7 2033.0 2082.3 2083.5 2085.2 2089.8 2076.6 2114.2 2117.5 2119.1 2120.9 2028.3 2035.8 2036.5 2038.1 2056.8 2054.7 2056.3 2061.2 2061.5 2062.1 1981.0 1981.8 2010.5 2013.8 2018.5 6782.3 6907.2 7064.5 7066.4 7087.8 4312.4 4465.7 4470.3 4474.2 4476.7 2718.6 2833.5 2876.5 2881.4 2884.3 895.8 905.9 907.4 913.4 922.9 8930.2 9040.1 9081.3 9088.3 9098.2 3895.3 3931.7 4066.6 4070.2 4074.7 8081.3 8144.6 8145.8 8149.2 8155.1 4352.0 4417.3 4417.8 4424.9 4426.0 3563.7 3902.9 4030.2 4058.0 4059.6 3500.3 3507.0 3563.3 3596.7 3697.9 1132.2 1134.7 1166.0 1172.6 1173.0 758.7 810.9 822.3 837.5 869.2 4894.0 4955.2 4961.8 4969.2 5020.9 409.6 905.4 910.5 980.9 1010.4 3487.3 3530.6 3549.5 3571.8 3699.0 8552.9 8746.9 8791.8 8825.6 8851.9 8652.2 8714.3 8724.9 8726.1 8762.2 6735.3 6855.1 6875.3 6882.5 6882.7 5111.3 5183.1 5244.4 5357.9 5437.4 7898.6 7944.6 8129.0 8185.1 8196.7 8153.4 8169.2 8194.0 8220.6 8259.0 5717.8 6158.8 6190.0 6305.2 6394.8 7020.7 7041.9 7063.2 7085.0 7091.1 6285.7 6409.7 6467.0 6492.0 6591.6 6249.0 6266.1 6302.9 6363.5 6376.7 6038.8 6071.7 6104.2 6109.6 6120.6 4404.6 4487.9 4565.7 4577.5 4594.3 4548.9 4553.8 4573.5 4623.4 4637.4 04:52:12 INFO - PROCESS | 14381 | 04:52:12 INFO - PROCESS | 14381 | [#4] prototype.html Cycles:180 Average:4223.27 Median:4842.04 stddev:1218.72 (25.2%) stddev-sans-first:1186.03 04:52:12 INFO - PROCESS | 14381 | Values: 300.1 303.3 310.6 311.1 311.6 4836.3 4892.6 4896.4 4901.9 4917.5 4828.3 4840.3 4843.8 4865.1 4868.2 3624.6 3760.7 3761.3 3792.8 3812.8 3710.5 3790.3 3804.3 3818.8 3870.7 3775.3 3780.6 3783.4 3796.2 3828.7 3638.4 3787.6 3792.9 3801.5 3830.9 3363.2 3364.3 3372.7 3373.5 3385.2 4589.1 4621.6 4629.3 4630.2 4639.6 4161.3 4302.8 4343.5 4359.4 4361.3 5069.1 5079.0 5079.7 5079.8 5091.0 3587.7 3622.3 3625.9 3640.3 3701.1 5023.8 5226.4 5226.8 5237.9 5286.2 3749.2 3769.0 3779.8 3783.6 3786.2 3813.9 3820.3 3827.5 3840.4 3842.8 4302.9 4308.2 4329.6 4343.6 4349.4 4820.9 5001.9 5016.3 5031.2 5039.2 1321.1 1340.3 1342.4 1346.6 1349.7 838.5 842.4 873.2 888.2 894.3 4353.4 4426.3 4502.2 4502.5 4510.8 5177.6 5187.8 5204.7 5225.2 5227.1 4452.0 4468.4 4478.6 4488.4 4513.2 2635.7 2792.0 2797.9 2810.0 2815.3 4876.2 4924.8 4933.7 4937.9 4950.4 5227.7 5386.9 5390.9 5408.0 5422.9 4840.2 4859.7 4887.8 4897.8 4917.3 5216.5 5253.0 5271.0 5272.9 5287.6 4873.2 5143.5 5149.5 5174.1 5192.2 4906.2 4906.2 4914.4 4918.3 4926.4 3586.9 3637.6 3642.9 3645.6 3662.0 5188.6 5241.2 5310.4 5324.0 5350.4 5077.8 5096.8 5109.8 5111.7 5116.9 5097.2 5098.2 5100.5 5107.9 5122.5 4878.8 4977.4 5031.7 5043.4 5053.4 4826.6 4976.3 5107.6 5116.6 5143.9 5008.5 5010.9 5014.5 5027.9 5050.1 04:52:12 INFO - PROCESS | 14381 | 04:52:12 INFO - PROCESS | 14381 | [#5] yui.html Cycles:180 Average:16701.06 Median:54737.59 stddev:22612.75 (41.3%) stddev-sans-first:22643.99 04:52:12 INFO - PROCESS | 14381 | Values: 632.9 635.8 665.4 685.8 739.9 12219.9 13221.0 13249.1 13257.9 13263.3 13767.5 14469.5 14494.6 14992.7 15007.8 644.4 776.2 823.9 824.3 829.5 822.0 832.4 833.8 833.9 833.9 850.0 854.5 855.4 855.4 855.5 672.7 842.6 847.9 848.6 871.2 615.5 616.2 617.3 617.6 617.9 12962.0 13087.5 13115.8 13120.0 13124.0 13198.5 13808.8 13896.4 13917.4 14131.1 10036.6 10583.1 10897.1 11048.9 11198.7 4282.7 4320.9 4335.4 4414.3 4510.1 59463.7 59554.0 59568.7 59678.4 60122.7 10445.8 10569.0 10759.0 10921.9 11266.7 19145.9 19281.9 19291.3 19311.7 19325.5 6952.2 7029.2 7229.0 7235.7 7298.7 3789.8 3889.5 3918.4 3957.0 3957.3 3073.2 3218.4 3220.4 3221.0 3224.1 552.8 556.5 560.0 566.7 573.2 477.7 518.5 569.7 582.6 587.4 8192.1 8276.0 8327.3 8357.2 8526.3 526.4 538.3 581.7 587.2 597.3 3610.9 3828.4 3842.7 3848.9 3849.8 80754.6 84487.0 86463.0 86880.6 89804.6 65233.0 68852.0 74258.0 74958.0 78290.2 70897.0 71162.6 71421.3 71973.3 73555.3 7950.8 8088.8 8138.7 8180.1 8295.9 33585.5 37553.6 42378.0 43305.6 43459.8 53158.5 53898.2 54632.0 54843.2 55212.4 10408.2 10680.5 11168.3 11214.6 11326.4 9826.1 11599.9 11957.3 12358.5 12540.1 11501.3 11670.4 11740.1 12347.7 12414.5 11380.0 11797.2 11811.4 12316.1 12414.7 11446.4 11667.5 11812.8 12266.9 12385.9 8845.7 9146.8 9278.2 9308.2 9321.9 9167.3 9322.7 9416.8 9434.5 9484.3 04:52:12 INFO - PROCESS | 14381 | -------- Summary: end -------- 04:52:12 INFO - PROCESS | 14381 | 04:52:13 INFO - TEST-INFO | 14381: exit 0 04:52:13 INFO - TEST-OK | dromaeo_css | took 1130466ms 04:52:13 INFO - TEST-START | kraken 04:52:13 INFO - operating with platform_type : linux_ 04:52:13 INFO - Initialising browser for kraken test... 04:52:13 INFO - TEST-INFO | started process 14563 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoCCeRu/profile http://localhost:51089/getInfo.html) 04:52:19 INFO - PROCESS | 14563 | __metrics Screen width/height:1600/1200 04:52:19 INFO - PROCESS | 14563 | colorDepth:24 04:52:19 INFO - PROCESS | 14563 | Browser inner width/height: 1024/697 04:52:19 INFO - PROCESS | 14563 | __metrics 04:52:21 ERROR - PROCESS | 14563 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:52:21 INFO - PROCESS | 14563 | console.error: PushService: 04:52:21 INFO - PROCESS | 14563 | stateChangeProcessEnqueue: Error transitioning state 04:52:21 INFO - PROCESS | 14563 | UnknownError 04:52:22 INFO - TEST-INFO | 14563: exit 0 04:52:22 INFO - Browser initialized. 04:52:22 INFO - Running cycle 1/1 for kraken test... 04:52:22 INFO - TEST-INFO | started process 14647 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoCCeRu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:52:34 INFO - PROCESS | 14647 | RSS: Main: 157802496 04:52:34 INFO - PROCESS | 14647 | 04:52:37 INFO - PROCESS | 14647 | Cycle 1(1): loaded http://localhost:51089/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51089/tests/kraken/driver.html?testName=audio-beat-detection) 04:52:38 INFO - PROCESS | 14647 | RSS: Main: 214237184 04:52:38 INFO - PROCESS | 14647 | 04:52:41 INFO - PROCESS | 14647 | Cycle 1(1): loaded http://localhost:51089/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51089/tests/kraken/driver.html?testName=audio-dft) 04:52:41 INFO - PROCESS | 14647 | RSS: Main: 201281536 04:52:41 INFO - PROCESS | 14647 | 04:52:44 INFO - PROCESS | 14647 | Cycle 1(1): loaded http://localhost:51089/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51089/tests/kraken/driver.html?testName=audio-fft) 04:52:45 INFO - PROCESS | 14647 | RSS: Main: 269783040 04:52:45 INFO - PROCESS | 14647 | 04:52:47 INFO - PROCESS | 14647 | Cycle 1(1): loaded http://localhost:51089/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51089/tests/kraken/driver.html?testName=audio-oscillator) 04:52:48 INFO - PROCESS | 14647 | RSS: Main: 180224000 04:52:48 INFO - PROCESS | 14647 | 04:52:50 INFO - PROCESS | 14647 | Cycle 1(1): loaded http://localhost:51089/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51089/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:52:51 INFO - PROCESS | 14647 | RSS: Main: 184635392 04:52:51 INFO - PROCESS | 14647 | 04:52:54 INFO - PROCESS | 14647 | Cycle 1(1): loaded http://localhost:51089/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51089/tests/kraken/driver.html?testName=imaging-darkroom) 04:52:55 INFO - PROCESS | 14647 | RSS: Main: 220618752 04:52:55 INFO - PROCESS | 14647 | 04:52:58 INFO - PROCESS | 14647 | Cycle 1(1): loaded http://localhost:51089/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51089/tests/kraken/driver.html?testName=imaging-desaturate) 04:52:59 INFO - PROCESS | 14647 | RSS: Main: 216711168 04:52:59 INFO - PROCESS | 14647 | 04:53:02 INFO - PROCESS | 14647 | Cycle 1(1): loaded http://localhost:51089/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51089/tests/kraken/driver.html?testName=json-parse-financial) 04:53:02 INFO - PROCESS | 14647 | RSS: Main: 219484160 04:53:02 INFO - PROCESS | 14647 | 04:53:04 INFO - PROCESS | 14647 | Cycle 1(1): loaded http://localhost:51089/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51089/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:53:05 INFO - PROCESS | 14647 | RSS: Main: 207478784 04:53:05 INFO - PROCESS | 14647 | 04:53:06 INFO - PROCESS | 14647 | Cycle 1(1): loaded http://localhost:51089/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51089/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:53:07 INFO - PROCESS | 14647 | RSS: Main: 209956864 04:53:07 INFO - PROCESS | 14647 | 04:53:09 INFO - PROCESS | 14647 | Cycle 1(1): loaded http://localhost:51089/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51089/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:53:10 INFO - PROCESS | 14647 | RSS: Main: 216051712 04:53:10 INFO - PROCESS | 14647 | 04:53:13 INFO - PROCESS | 14647 | Cycle 1(1): loaded http://localhost:51089/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51089/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:53:13 INFO - PROCESS | 14647 | RSS: Main: 225349632 04:53:13 INFO - PROCESS | 14647 | 04:53:16 INFO - PROCESS | 14647 | Cycle 1(1): loaded http://localhost:51089/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51089/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:53:17 INFO - PROCESS | 14647 | RSS: Main: 224387072 04:53:17 INFO - PROCESS | 14647 | 04:53:19 INFO - PROCESS | 14647 | Cycle 1(1): loaded http://localhost:51089/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51089/tests/kraken/driver.html?testName=ai-astar) 04:53:19 INFO - PROCESS | 14647 | RSS: Main: 266948608 04:53:19 INFO - PROCESS | 14647 | 04:53:19 INFO - PROCESS | 14647 | __start_tp_report 04:53:19 INFO - PROCESS | 14647 | _x_x_mozilla_page_load 04:53:19 INFO - PROCESS | 14647 | _x_x_mozilla_page_load_details 04:53:19 INFO - PROCESS | 14647 | |i|pagename|runs| 04:53:19 INFO - PROCESS | 14647 | |0;ai-astar;116;110;113;116;117;115;115;114;115;115 04:53:19 INFO - PROCESS | 14647 | |1;audio-beat-detection;159;130;133;186;130;132;151;129;183;129 04:53:19 INFO - PROCESS | 14647 | |2;audio-dft;162;160;162;166;160;161;161;161;161;159 04:53:19 INFO - PROCESS | 14647 | |3;audio-fft;75;75;77;134;76;77;74;75;98;76 04:53:19 INFO - PROCESS | 14647 | |4;audio-oscillator;85;84;116;85;86;84;121;85;85;130 04:53:19 INFO - PROCESS | 14647 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;117;117;117 04:53:19 INFO - PROCESS | 14647 | |6;imaging-darkroom;146;147;145;146;146;145;147;146;146;146 04:53:19 INFO - PROCESS | 14647 | |7;imaging-desaturate;95;94;95;95;95;95;95;94;95;94 04:53:19 INFO - PROCESS | 14647 | |8;json-parse-financial;66;65;65;65;65;65;67;65;64;65 04:53:19 INFO - PROCESS | 14647 | |9;json-stringify-tinderbox;65;65;66;64;66;65;65;66;66;65 04:53:19 INFO - PROCESS | 14647 | |10;stanford-crypto-aes;92;86;92;83;89;87;91;92;122;84 04:53:19 INFO - PROCESS | 14647 | |11;stanford-crypto-ccm;132;130;130;130;127;125;129;133;160;138 04:53:19 INFO - PROCESS | 14647 | |12;stanford-crypto-pbkdf2;176;177;170;174;173;174;177;176;186;175 04:53:19 INFO - PROCESS | 14647 | |13;stanford-crypto-sha256-iterative;68;75;68;67;67;67;67;67;66;65 04:53:19 INFO - PROCESS | 14647 | __end_tp_report 04:53:19 INFO - PROCESS | 14647 | __start_cc_report 04:53:19 INFO - PROCESS | 14647 | _x_x_mozilla_cycle_collect,1925 04:53:19 INFO - PROCESS | 14647 | __end_cc_report 04:53:19 INFO - PROCESS | 14647 | __startTimestamp1464954799433__endTimestamp 04:53:19 INFO - PROCESS | 14647 | 04:53:19 INFO - PROCESS | 14647 | ------- Summary: start ------- 04:53:19 INFO - PROCESS | 14647 | Number of tests: 14 04:53:19 INFO - PROCESS | 14647 | 04:53:19 INFO - PROCESS | 14647 | [#0] ai-astar Cycles:10 Average:114.60 Median:115.00 stddev:1.96 (1.7%) stddev-sans-first:2.01 04:53:19 INFO - PROCESS | 14647 | Values: 116.0 110.0 113.0 116.0 117.0 115.0 115.0 114.0 115.0 115.0 04:53:19 INFO - PROCESS | 14647 | 04:53:19 INFO - PROCESS | 14647 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:142.00 stddev:22.65 (16.0%) stddev-sans-first:23.55 04:53:19 INFO - PROCESS | 14647 | Values: 159.0 130.0 133.0 186.0 130.0 132.0 151.0 129.0 183.0 129.0 04:53:19 INFO - PROCESS | 14647 | 04:53:19 INFO - PROCESS | 14647 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:1.89 (1.2%) stddev-sans-first:1.99 04:53:19 INFO - PROCESS | 14647 | Values: 162.0 160.0 162.0 166.0 160.0 161.0 161.0 161.0 161.0 159.0 04:53:19 INFO - PROCESS | 14647 | 04:53:19 INFO - PROCESS | 14647 | [#3] audio-fft Cycles:10 Average:83.70 Median:76.00 stddev:19.04 (25.1%) stddev-sans-first:19.94 04:53:19 INFO - PROCESS | 14647 | Values: 75.0 75.0 77.0 134.0 76.0 77.0 74.0 75.0 98.0 76.0 04:53:19 INFO - PROCESS | 14647 | 04:53:19 INFO - PROCESS | 14647 | [#4] audio-oscillator Cycles:10 Average:96.10 Median:85.00 stddev:18.42 (21.7%) stddev-sans-first:19.09 04:53:19 INFO - PROCESS | 14647 | Values: 85.0 84.0 116.0 85.0 86.0 84.0 121.0 85.0 85.0 130.0 04:53:19 INFO - PROCESS | 14647 | 04:53:19 INFO - PROCESS | 14647 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:53:19 INFO - PROCESS | 14647 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 04:53:19 INFO - PROCESS | 14647 | 04:53:19 INFO - PROCESS | 14647 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 04:53:19 INFO - PROCESS | 14647 | Values: 146.0 147.0 145.0 146.0 146.0 145.0 147.0 146.0 146.0 146.0 04:53:19 INFO - PROCESS | 14647 | 04:53:19 INFO - PROCESS | 14647 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 04:53:19 INFO - PROCESS | 14647 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 04:53:19 INFO - PROCESS | 14647 | 04:53:19 INFO - PROCESS | 14647 | [#8] json-parse-financial Cycles:10 Average:65.20 Median:65.00 stddev:0.79 (1.2%) stddev-sans-first:0.78 04:53:19 INFO - PROCESS | 14647 | Values: 66.0 65.0 65.0 65.0 65.0 65.0 67.0 65.0 64.0 65.0 04:53:19 INFO - PROCESS | 14647 | 04:53:19 INFO - PROCESS | 14647 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.50 stddev:0.67 (1.0%) stddev-sans-first:0.71 04:53:19 INFO - PROCESS | 14647 | Values: 65.0 65.0 66.0 64.0 66.0 65.0 65.0 66.0 66.0 65.0 04:53:19 INFO - PROCESS | 14647 | 04:53:19 INFO - PROCESS | 14647 | [#10] stanford-crypto-aes Cycles:10 Average:91.80 Median:90.00 stddev:11.13 (12.4%) stddev-sans-first:11.81 04:53:19 INFO - PROCESS | 14647 | Values: 92.0 86.0 92.0 83.0 89.0 87.0 91.0 92.0 122.0 84.0 04:53:19 INFO - PROCESS | 14647 | 04:53:19 INFO - PROCESS | 14647 | [#11] stanford-crypto-ccm Cycles:10 Average:133.40 Median:131.00 stddev:9.98 (7.6%) stddev-sans-first:10.57 04:53:19 INFO - PROCESS | 14647 | Values: 132.0 130.0 130.0 130.0 127.0 125.0 129.0 133.0 160.0 138.0 04:53:19 INFO - PROCESS | 14647 | 04:53:19 INFO - PROCESS | 14647 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.80 Median:176.00 stddev:4.16 (2.4%) stddev-sans-first:4.41 04:53:19 INFO - PROCESS | 14647 | Values: 176.0 177.0 170.0 174.0 173.0 174.0 177.0 176.0 186.0 175.0 04:53:19 INFO - PROCESS | 14647 | 04:53:19 INFO - PROCESS | 14647 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:67.00 stddev:2.71 (4.0%) stddev-sans-first:2.87 04:53:19 INFO - PROCESS | 14647 | Values: 68.0 75.0 68.0 67.0 67.0 67.0 67.0 67.0 66.0 65.0 04:53:19 INFO - PROCESS | 14647 | -------- Summary: end -------- 04:53:19 INFO - PROCESS | 14647 | 04:53:20 INFO - TEST-INFO | 14647: exit 0 04:53:20 INFO - TEST-OK | kraken | took 67146ms 04:53:20 INFO - SUITE-END | took 1197s 04:53:21 INFO - Completed test suite (00:19:58) 04:53:21 INFO - javascript benchmark 04:53:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2639.788816894648, 2702.554078577032, 2720.959185612215, 2746.9973459687194, 2750.57366108253, 4696.97651511742, 4702.976485117578, 4738.597219236369, 4790.856274311776, 4863.537963893429, 4753.4533528644215, 4790.305405716178, 4828.348172996644, 4830.830920917769, 4867.756612169395, 4235.1529694061155, 4402.097569998143, 4471.441069866267, 4524.140413321458, 4628.213203755369, 4529.932051019254, 4571.634269258468, 4582.656300777438, 4582.885427864297, 4613.838515651953, 4312.78436078198, 4332.718373305725, 4353.804078816461, 4410.316400957857, 4425.092855964552, 4293.806778694966, 4296.033392486696, 4336.696431249814, 4342.261815491374, 4354.56454354562, 4331.740095594275, 4384.802683879233, 4401.075774087413, 4408.272635015219, 4437.889052773674, 4580.290055041441, 4625.167469855424, 4668.743219122947, 4726.621870250372, 4730.219513780222, 4987.401511818605, 5062.898742025176, 5066.138756411419, 5142.357205349332, 5148.716820574867, 5190.8183213587345, 5220.060389129955, 5222.791088356461, 5244.213367994793, 5244.39689435716, 4598.540145985442, 4686.36734040907, 4828.565429111397, 4881.267809828519, 4889.828855990023, 5255.921161182585, 5348.411674715856, 5371.194320851903, 5373.032854086224, 5374.758135883894, 5092.592592592584, 5100.923486147711, 5142.331496905378, 5145.76844042019, 5148.768305426265, 5023.924641130386, 5081.618878584121, 5139.974300128551, 5159.071367153948, 5170.302009228782, 5111.182210846321, 5116.462771409023, 5116.513931176532, 5146.0, 5190.169572868398, 5096.05722941257, 5103.923441148386, 5105.183170692671, 5106.948930510647, 5191.091558977164, 4227.112306415625, 4250.617444429954, 4314.050908800059, 4381.978090109529, 4428.623566996841, 3805.5813860475328, 3809.657130858236, 3821.5796262411113, 3839.424086387064, 3899.1421887184774, 4451.844185453494, 4472.508024117345, 4478.865634030984, 4523.547645235516, 4525.321201819754, 4987.5760560352055, 5058.595312375001, 5059.316992206005, 5192.818251361185, 5257.921131183035, 4395.099004704028, 4416.6025057744955, 4449.154660614473, 4487.910241795146, 4500.977495112504, 4673.953260467351, 4676.696014759098, 4676.836310729108, 4684.344191813149, 4724.196886529298, 4803.447603525499, 4842.370491836109, 4857.441394239708, 4858.562729354305, 4893.6085113191575, 4989.151844186569, 5108.0, 5159.17453207485, 5173.560247378864, 5197.194434862602, 4830.347903033045, 4845.733484658378, 4847.515248475124, 4849.80600775965, 4891.26631005352, 4930.802767889244, 5102.668326558762, 5108.489151084862, 5110.029094472038, 5164.251183578285, 5060.165072762953, 5100.923486147785, 5107.616928730435, 5135.614828887774, 5136.2552429898205, 5001.624878134227, 5022.070916880389, 5022.096022715946, 5026.34657494538, 5071.594272458121, 4856.368672072608, 4876.707397556158, 5008.524190201925, 5021.6735912165595, 5027.120253955616, 4825.324454576432, 4921.704697718148, 4941.085899108676, 4947.876303092307, 4948.134076536519, 4996.225585034325, 4996.300517927566, 5000.64995450315, 5000.799968001239, 5036.345275114359, 4831.661783675109, 4903.387076615423, 4913.803447862046, 4939.678920870132, 4958.479359667183], "value": 4718.088848750171, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.1767750008488, 578.6585914310557, 579.4118969246216, 590.2385922160413, 605.500462118752, 27810.0, 31006.224844378845, 31040.53439198411, 31083.067507974796, 31098.844505777466, 30828.38343233134, 41300.173996520054, 42106.57893421065, 42255.78872105643, 47408.76295618526, 7804.531728096318, 7940.483868548526, 7948.602569871512, 7957.761267161965, 7970.442069055169, 7633.313001829834, 7782.9221707783045, 7867.567283799389, 7921.524708517507, 7947.443678942476, 9946.602135914554, 10282.383057016565, 10289.382637041765, 10629.468526573679, 10648.62729804457, 10164.339317944346, 10270.7432314192, 10274.332168409066, 10279.0, 10285.742856428575, 7536.773896783106, 9680.661176858846, 10082.495875206283, 10117.494125293779, 10178.982101789836, 39745.40381894274, 40184.799076004725, 40194.19611607752, 40291.798541007105, 40309.193816123516, 3097.90706278812, 3100.829454380008, 3145.653978062411, 3178.300773829754, 3231.644519102897, 30422.84788576065, 30892.0, 30948.690513094807, 30978.380432391452, 31342.05973820789, 3516.4813412708945, 3545.840437180333, 3574.249407624402, 3577.6422357764277, 3618.203995121069, 264348.0, 264777.67611162015, 265030.0, 266081.0, 266143.0, 56618.0, 57240.427595724344, 57279.0, 57331.713341433024, 57399.0, 54337.0, 54404.72797635986, 54453.72773136188, 54550.72724636431, 54587.18119228215, 14990.400383984737, 15439.382424702886, 15449.768253476206, 15450.381984720485, 15455.149966751711, 11723.706907327214, 11753.236039657395, 11792.52829886795, 11810.291382517076, 11814.232074915102, 15895.966762160422, 18044.85831290576, 18227.54431139232, 18812.435626931216, 18927.337543185924, 6934.583924964519, 6940.583564986117, 7120.216776154619, 7149.7497587584185, 7313.744018959311, 809.3323008517996, 946.4510583861344, 952.4428209497521, 969.520087556664, 984.8424252119627, 28541.286467838054, 29519.704802952125, 29734.702652973625, 29761.851190743906, 29955.70044299529, 953.3612479638658, 980.3726014281651, 981.1709105805583, 997.7106639074732, 1079.09895237476, 15557.433023550988, 15574.844251557339, 15592.92203538975, 15620.218989050501, 15802.762958555631, 373573.0, 373765.0, 376422.0, 377644.0, 378923.0, 50748.0, 51217.0, 51235.487645123816, 51248.23127653088, 51426.74286628618, 1249.743802520481, 1253.254313683357, 1269.2891980490954, 1276.7063575377529, 1284.794432890733, 27155.72844271611, 28479.18874221432, 28601.713982859907, 28730.42539149247, 28955.0, 44701.55298446974, 44847.77576112099, 44927.550724492336, 45096.77451612852, 45148.0, 316861.0, 318436.0, 318762.0, 318849.0, 320658.0, 25830.0, 25930.481390372464, 26444.0, 26598.335041624116, 26608.866955665097, 33179.668203317655, 36392.454113188855, 37383.43924841075, 43311.783441083855, 44349.0, 36343.273134536634, 37269.813650931574, 39202.2159556813, 41435.585644144376, 41802.163956721306, 38141.427878581286, 38347.0, 38360.23279534338, 38509.42235866408, 38663.0, 37407.251854962204, 37612.2477550442, 37787.43318850274, 38114.80942595269, 38357.6164238354, 32595.511067333533, 34025.65974340225, 34686.30627387387, 35048.299034018666, 35101.297974040885, 26149.73850261473, 26215.73784262133, 26264.0, 26316.342091447867, 26405.92894049094], "value": 18278.74594449302, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.72710241258, 378.3171375666921, 381.9713521485891, 384.74799006650653, 387.7673395962421, 15278.0, 16448.58878528036, 16751.91624041881, 16885.831141688595, 17074.31702731889, 16012.43956461524, 16456.259468323926, 16948.0, 16960.491185264433, 16981.405650802226, 5067.670601410915, 5231.398389185235, 5233.136532472156, 5245.527902488775, 5247.475252474741, 3706.721995850322, 3892.2020985697864, 5156.149235376159, 5757.68332741699, 6058.515318774487, 6068.423499767515, 6087.543434242428, 6097.939020609803, 6122.234720659918, 6127.387261273881, 5949.940500594982, 5995.040793473046, 6080.209572755558, 6088.96955515224, 6091.817245482621, 3356.580427446569, 4962.950370496285, 5251.894962100737, 5295.073362161645, 5296.443873393316, 19358.4192474226, 20089.8995505023, 20101.497462563406, 20194.49513762153, 20250.0, 2033.0241484087574, 2103.8842863642494, 2120.7879212078824, 2360.6931098957198, 2401.7958473529598, 12989.740205195843, 13129.934350328283, 13131.343432828417, 13144.86855131446, 13689.0, 1755.9561010974828, 1760.5510594798372, 1772.8936263824212, 1842.447265820262, 1849.0444118597256, 41419.7929010356, 44236.0, 65687.0146947801, 66151.0, 66582.0, 9448.433094014381, 9746.319762065488, 9832.901670983341, 9862.0, 9988.101070903509, 13262.602121936357, 13302.135361201492, 13327.466901323838, 13388.263645499592, 13403.195808251341, 7432.554046757212, 7445.218252083561, 7459.664315105833, 7683.658732815941, 7758.961205194051, 7456.813579660444, 7469.813254668568, 7473.327400533978, 7583.090029196532, 7585.0, 6188.277158050443, 6217.316095229521, 6228.968855155696, 6262.624242545462, 6282.403171698681, 1617.7249867522548, 1648.7691723158766, 1765.6910040742819, 1768.6374293269848, 1791.6148028174005, 843.8860753798282, 885.9335549833788, 896.394933419939, 952.3190918493173, 999.6651121874254, 16724.58188545296, 17072.82927170737, 17402.651946961243, 17484.47546573605, 17660.911695441442, 891.4695756025154, 894.4096896048577, 937.1565590968047, 980.3872579637726, 1009.2380252909006, 10010.749731256778, 10043.246756493292, 10236.53935572901, 10253.897461025443, 10263.640772572924, 341827.0, 342304.0, 343336.0, 348191.0, 349841.0, 64563.0, 64790.67604661947, 65534.344656553774, 66690.33309666938, 67370.66314668395, 912.0696889173006, 932.2495391210006, 949.852772820214, 979.9412035277907, 985.3348989432104, 15138.545843624708, 15305.464308749586, 15391.153486558347, 15471.690566188838, 15694.529164125095, 23712.40718982039, 26186.476270474104, 30902.381952360378, 32085.03744887657, 32120.67879321177, 41306.0, 41431.37852932148, 41541.37687934744, 41739.0, 41820.79089604533, 7768.067831860213, 7802.687892484464, 7824.21757824213, 7835.84328313442, 7892.05295364537, 11558.364289964133, 11744.647660570197, 11762.58830940913, 11876.58431954912, 12194.634160975185, 9644.0, 9768.804623907625, 10029.247806414402, 10112.544935477774, 10135.847962280719, 9790.951045244728, 9923.0, 9930.304878658424, 10206.948965255424, 10312.123469505175, 9681.66114186, 9880.703578892644, 10143.89856101459, 10215.336003159771, 10643.192558547866, 7586.203448638034, 7624.27569380908, 7666.8083297918, 7785.610719464117, 7806.297433231037, 10376.273660843668, 10430.947845260725, 10568.735781605521, 10630.043296103388, 10681.626143084955], "value": 8262.234574275872, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1282.051282051281, 1367.4666879916833, 1413.7031223443078, 1478.327361050722, 1692.2046638080105, 6269.090981807635, 6798.354156355151, 6969.407600353963, 6997.26528714484, 7007.29927007299, 6870.3473170048765, 6932.27211142829, 7007.789766307019, 7155.105611798525, 7163.749268775594, 2032.959340813183, 2082.2607974169177, 2083.489545061462, 2085.17635533964, 2089.780573039832, 2076.563921576471, 2114.2071723103836, 2117.5129720164373, 2119.1417475922276, 2120.8621439606454, 2028.3002364184406, 2035.7964203579597, 2036.521417466894, 2038.1032345767815, 2056.845736569756, 2054.7123402723555, 2056.311135769519, 2061.2270398600526, 2061.5361543652634, 2062.092679221153, 1980.9504762380911, 1981.782003979561, 2010.4672261850621, 2013.7684166320914, 2018.4852862519963, 6782.287859774751, 6907.240203577602, 7064.540804847668, 7066.434685225169, 7087.8228044298785, 4312.3531470279395, 4465.709728867646, 4470.26240670289, 4474.217012022916, 4476.686631935766, 2718.6329845470805, 2833.4758069757163, 2876.5397536394075, 2881.366099458137, 2884.307766136112, 895.8477058900003, 905.9048799875984, 907.3693782820942, 913.3743385780695, 922.921551668109, 8930.19628233462, 9040.050794666597, 9081.318901082379, 9088.318376121751, 9098.181163695299, 3895.2988462076532, 3931.7051221157953, 4066.5933406659688, 4070.247004304213, 4074.7351422157467, 8081.272685458337, 8144.552049637208, 8145.796355091052, 8149.225823546753, 8155.143709910492, 4352.042550638855, 4417.271150260235, 4417.845375411909, 4424.889377765581, 4426.026274219666, 3563.6970857476886, 3902.8829135125993, 4030.1536677298095, 4057.9797101014306, 4059.573744756817, 3500.317438099546, 3507.000504856104, 3563.2695297463956, 3596.730245231618, 3697.8890633281044, 1132.2017977325966, 1134.7219931116765, 1165.9941700291445, 1172.6423440850451, 1173.0, 758.7116895579754, 810.9472884262505, 822.321584692631, 837.5267973594899, 869.1742844297816, 4894.0, 4955.157623204064, 4961.801527938842, 4969.155243608595, 5020.899582008339, 409.55767770807455, 905.40319664782, 910.517425764346, 980.8773903262093, 1010.4442556593845, 3487.302539492112, 3530.6469353065004, 3549.538559987185, 3571.821408929543, 3699.0197597636648, 8552.88812454377, 8746.86879696805, 8791.780205494913, 8825.646974121091, 8851.911480885237, 8652.178043085896, 8714.302855771522, 8724.8691269631, 8726.083761204982, 8762.211400973816, 6735.292794256533, 6855.108835851307, 6875.312468753084, 6882.518223724392, 6882.69027893746, 5111.284420181103, 5183.105299189324, 5244.396894357198, 5357.919631205613, 5437.40188579248, 7898.644560994884, 7944.602769861368, 8128.9593552031865, 8185.140560241327, 8196.672133114847, 8153.388495862715, 8169.223923727474, 8194.0, 8220.63007164691, 8258.958705206676, 5717.799877004285, 6158.784442544489, 6190.0, 6305.2433707953505, 6394.840128996812, 7020.684069217, 7041.859162816818, 7063.1524217094275, 7084.964575177091, 7091.1490621125795, 6285.685715714288, 6409.7115629795835, 6466.967665161832, 6491.967540162269, 6591.604503729792, 6249.031400132987, 6266.091416744638, 6302.905456418066, 6363.490920726424, 6376.681165941777, 6038.758449661965, 6071.696415179312, 6104.17593624855, 6109.633421994695, 6120.571559990758, 4404.580684316843, 4487.865364039084, 4565.703229290086, 4577.473590536998, 4594.333821595917, 4548.88627784308, 4553.8406155785715, 4573.5426457354, 4623.445186577632, 4637.443506779073], "value": 3913.107614186078, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.1041889958474, 303.2736595852932, 310.58381768430297, 311.11953172521766, 311.563810665069, 4836.322914791927, 4892.608591312695, 4896.412430508344, 4901.852944411665, 4917.508249175085, 4828.324034635154, 4840.298156767267, 4843.782029808658, 4865.14859899518, 4868.221084626461, 3624.619414961424, 3760.6803421709187, 3761.2665530221616, 3792.7724336539895, 3812.7902965336893, 3710.5361829771277, 3790.2608991246716, 3804.334241507725, 3818.770873747584, 3870.6516413522777, 3775.320442320381, 3780.621937806211, 3783.3920583751933, 3796.1838204785968, 3828.712846536507, 3638.399664055428, 3787.58336582977, 3792.8672496462627, 3801.505804245458, 3830.9042273943373, 3363.1760218746317, 3364.2766805136766, 3372.7133193678324, 3373.460246360595, 3385.2044769479153, 4589.105124500724, 4621.590414923447, 4629.328747331618, 4630.166570017395, 4639.5824375806005, 4161.313383291753, 4302.827886884521, 4343.4787825460835, 4359.411479450266, 4361.345798130305, 5069.112905241568, 5079.0, 5079.720615366154, 5079.847604571832, 5090.98180363925, 3587.7488575799703, 3622.2755448910325, 3625.9093522662142, 3640.271945610862, 3701.148735790783, 5023.79904803811, 5226.3989641191365, 5226.81706140287, 5237.921431178535, 5286.233496143076, 3749.1751814600743, 3768.962310376916, 3779.7921114338974, 3783.5785097537596, 3786.2238241160494, 3813.904652383713, 3820.3123437781464, 3827.5024246847734, 3840.423936409505, 3842.8462861485227, 4302.935455968163, 4308.202982448257, 4329.567043295709, 4343.5656434356315, 4349.391085248068, 4820.903581928342, 5001.89996200074, 5016.347874776256, 5031.245313202976, 5039.21892106724, 1321.0950498908087, 1340.2896464873634, 1342.4294674763187, 1346.6364081697886, 1349.7165595224917, 838.4990866349167, 842.4481964313385, 873.2446433834688, 888.1873086126251, 894.2979760887672, 4353.434053573079, 4426.291793313055, 4502.19912035182, 4502.5047244803045, 4510.797014134372, 5177.58579313654, 5187.766550505161, 5204.66169698976, 5225.23062776729, 5227.111391063529, 4452.0, 4468.4414448193975, 4478.619317358061, 4488.438945131858, 4513.210188217049, 2635.683717953858, 2791.972080279171, 2797.860106994642, 2810.0, 2815.2821030637465, 4876.171435711608, 4924.75376231187, 4933.703977761345, 4937.851864444073, 4950.356453661001, 5227.660202086929, 5386.946130538645, 5390.9191362129595, 5407.999520088796, 5422.8915421691345, 4840.249761287007, 4859.73646851814, 4887.7556122194455, 4897.751073476241, 4917.278952366714, 5216.504432078947, 5252.9737351313, 5270.97216042868, 5272.920906186334, 5287.550558202442, 4873.220284754422, 5143.459936706592, 5149.510796474329, 5174.14626586624, 5192.169252919514, 4906.165951788276, 4906.190478570996, 4914.385701787277, 4918.336024636628, 4926.3842019747535, 3586.9103272418397, 3637.636236376341, 3642.8724994625063, 3645.5807582127336, 3662.0, 5188.558972487381, 5241.240020197126, 5310.362756469249, 5323.961827443612, 5350.438203988525, 5077.77150028257, 5096.821611243588, 5109.7700603472185, 5111.744412779271, 5116.872078198075, 5097.235414687826, 5098.209777484496, 5100.5409513143995, 5107.9233811493605, 5122.513361230677, 4878.829240976549, 4977.352944117241, 5031.723255220998, 5043.36957880265, 5053.393592768891, 4826.565609095198, 4976.253561965734, 5107.616928730435, 5116.641835071509, 5143.948560514347, 5008.499150084962, 5010.87472813168, 5014.473480284518, 5027.949720502895, 5050.116229659869], "value": 3839.0702271837677, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [632.8734253149371, 635.7806556737924, 665.4077870695079, 685.7771224352086, 739.9334059934606, 12219.938900305497, 13221.0, 13249.138805977605, 13257.867421325784, 13263.270520121401, 13767.518136865212, 14469.493567725132, 14494.637634059154, 14992.700145997074, 15007.774883376758, 644.4361183964031, 776.1888826176659, 823.9134890836451, 824.3487644760631, 829.5147338806775, 821.9630116644736, 832.3590835057003, 833.8123922117536, 833.912439193885, 833.945793523422, 850.0097386544668, 854.4616891358436, 855.3883972959333, 855.3883972959333, 855.4525103933488, 672.7040102354948, 842.5787106446777, 847.9279261262769, 848.5629900601165, 871.2028493928049, 615.5198944823045, 616.2389449030444, 617.2500411999397, 617.6355949989528, 617.9134921111048, 12962.0, 13087.541936032194, 13115.803262951064, 13120.0, 13124.015698822626, 13198.47206111764, 13808.757211850882, 13896.374663140183, 13917.373718182705, 14131.081479703786, 10036.64871729486, 10583.10043646291, 10897.128229741602, 11048.944755276252, 11198.720031999184, 4282.743035417885, 4320.870373888788, 4335.379544854824, 4414.271645178542, 4510.052888893337, 59463.70268148675, 59554.0, 59568.702156488944, 59678.403215967715, 60122.69938650323, 10445.84331235032, 10569.0, 10759.0, 10921.945390273157, 11266.66200014001, 19145.904270478557, 19281.903590482238, 19291.324803631807, 19311.710324345146, 19325.51686207856, 6952.165740111219, 7029.22678505364, 7229.0, 7235.746748863765, 7298.744543940937, 3789.8484060637816, 3889.4943657324934, 3918.3730603103936, 3957.0305275207184, 3957.3470377387407, 3073.2163298358773, 3218.3563287342627, 3220.436423625856, 3220.9838950805565, 3224.1294850390263, 552.8396764938122, 556.5047108073818, 560.0423276197747, 566.7166416791604, 573.2118337286231, 477.6632474105817, 518.5229588778333, 569.6952130610103, 582.5892745614332, 587.4272584230341, 8192.098869124391, 8275.95862020686, 8327.292180164633, 8357.164283571594, 8526.275266602408, 526.4130494498683, 538.3217146395491, 581.7469400810576, 587.1624927716799, 597.3339726205337, 3610.8736194233074, 3828.3683192272965, 3842.654161125512, 3848.8845334640005, 3849.846006159722, 80754.59622701966, 84487.0, 86463.0, 86880.56559717287, 89804.5509772447, 65233.0, 68852.0, 74258.0, 74958.0, 78290.21709782943, 70897.0, 71162.64418677977, 71421.28578714251, 71973.28026719876, 73555.26444735484, 7950.801229969297, 8088.79778005531, 8138.674453021813, 8180.100188979327, 8295.875561866698, 33585.496217557244, 37553.6244637561, 42378.0, 43305.56694433015, 43459.782701087555, 53158.46841531535, 53898.19152712634, 54632.0, 54843.17735233895, 55212.44787552234, 10408.219383546113, 10680.519376628226, 11168.331019658886, 11214.551417943518, 11326.37704926237, 9826.06652368024, 11599.942000289944, 11957.282563046245, 12358.50565977351, 12540.05949553769, 11501.252418592765, 11670.416479175838, 11740.119491038036, 12347.69130771738, 12414.503419863104, 11380.0, 11797.233179843282, 11811.350375729417, 12316.076294277786, 12414.689632759253, 11446.37044962535, 11667.533298667959, 11812.82280765772, 12266.938665306616, 12385.876141238472, 8845.69040083594, 9146.817063658822, 9278.211352035152, 9308.208802251613, 9321.906780932104, 9167.266618670623, 9322.720318390458, 9416.764580885532, 9434.48110353937, 9484.288678349289], "value": 6571.29199123015, "unit": "score"}], "name": "dromaeo_css", "value": 6425.056331471129, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 110.0, 113.0, 116.0, 117.0, 115.0, 115.0, 114.0, 115.0, 115.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 130.0, 133.0, 186.0, 130.0, 132.0, 151.0, 129.0, 183.0, 129.0], "value": 146.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 162.0, 166.0, 160.0, 161.0, 161.0, 161.0, 161.0, 159.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 134.0, 76.0, 77.0, 74.0, 75.0, 98.0, 76.0], "value": 83.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 116.0, 85.0, 86.0, 84.0, 121.0, 85.0, 85.0, 130.0], "value": 96.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 145.0, 146.0, 146.0, 145.0, 147.0, 146.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 65.0, 65.0, 65.0, 67.0, 65.0, 64.0, 65.0], "value": 65.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 64.0, 66.0, 65.0, 65.0, 66.0, 66.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 86.0, 92.0, 83.0, 89.0, 87.0, 91.0, 92.0, 122.0, 84.0], "value": 91.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 130.0, 130.0, 130.0, 127.0, 125.0, 129.0, 133.0, 160.0, 138.0], "value": 133.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 177.0, 170.0, 174.0, 173.0, 174.0, 177.0, 176.0, 186.0, 175.0], "value": 175.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 75.0, 68.0, 67.0, 67.0, 67.0, 67.0, 67.0, 66.0, 65.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1558.7, "alertThreshold": 2.0}]} 04:53:21 INFO - Return code: 0 04:53:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:53:21 ERROR - # TBPL SUCCESS # 04:53:21 INFO - Running post-action listener: _resource_record_post_action 04:53:21 INFO - ##### 04:53:21 INFO - ##### Finished run-tests step (success) 04:53:21 INFO - ##### 04:53:21 INFO - Running post-run listener: _resource_record_post_run 04:53:21 INFO - Total resource usage - Wall time: 1215s; CPU: 14.0%; Read bytes: 8192; Write bytes: 527585280; Read time: 368; Write time: 4093992 04:53:21 INFO - TinderboxPrint: CPU usage
13.6% 04:53:21 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 368 04:53:21 INFO - TinderboxPrint: I/O write bytes / time
527,585,280 / 4,093,992 04:53:21 INFO - TinderboxPrint: CPU idle
8,378.7 (86.4%) 04:53:21 INFO - TinderboxPrint: CPU user
1,212.7 (12.5%) 04:53:21 INFO - TinderboxPrint: Swap in / out
0 / 0 04:53:21 INFO - install - Wall time: 16s; CPU: 27.0%; Read bytes: 0; Write bytes: 165347328; Read time: 0; Write time: 1237012 04:53:21 INFO - run-tests - Wall time: 1199s; CPU: 13.0%; Read bytes: 8192; Write bytes: 355708928; Read time: 368; Write time: 2714408 04:53:21 INFO - Running post-run listener: _upload_blobber_files 04:53:21 INFO - Blob upload gear active. 04:53:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:53:21 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 04:53:21 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:53:21 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:53:22 INFO - (blobuploader) - INFO - Open directory for files ... 04:53:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:53:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:53:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:53:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:53:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:53:23 INFO - (blobuploader) - INFO - Done attempting. 04:53:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:53:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:53:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:53:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:53:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:53:27 INFO - (blobuploader) - INFO - Done attempting. 04:53:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:53:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:53:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:53:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:53:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:53:27 INFO - (blobuploader) - INFO - Done attempting. 04:53:27 INFO - (blobuploader) - INFO - Iteration through files over. 04:53:27 INFO - Return code: 0 04:53:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:53:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:53:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ba970bd23df2f5870b71e3f1be598bfceebb6cfe42763d213747547a2809cb796b88b74ca79fac50d1488f81abe9bd22ff02e2645829ebe2b6d996ba63f5418d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/121bb248578f5dfb9df67ac232dd688eef5d7cd742d2928d5bbdf7fa679d66e3eaba5c33da1804b55abf3de3d39a3dc3fa8f5d97a9b8cb7d7b11b9d1aa836e0c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e91291f1e5662b8d0b30918d4be8f2d3d3c8784296c090d61c4b165cafb83bf7a105ef7a5b8812f0f3dae67e58d17b143706b5c74f4db65dc83eb5b45fa9a7ff"} 04:53:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:53:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:53:27 INFO - Contents: 04:53:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ba970bd23df2f5870b71e3f1be598bfceebb6cfe42763d213747547a2809cb796b88b74ca79fac50d1488f81abe9bd22ff02e2645829ebe2b6d996ba63f5418d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/121bb248578f5dfb9df67ac232dd688eef5d7cd742d2928d5bbdf7fa679d66e3eaba5c33da1804b55abf3de3d39a3dc3fa8f5d97a9b8cb7d7b11b9d1aa836e0c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e91291f1e5662b8d0b30918d4be8f2d3d3c8784296c090d61c4b165cafb83bf7a105ef7a5b8812f0f3dae67e58d17b143706b5c74f4db65dc83eb5b45fa9a7ff"} 04:53:27 INFO - Running post-run listener: copy_logs_to_upload_dir 04:53:27 INFO - Copying logs to upload dir... 04:53:27 INFO - mkdir: /builds/slave/test/build/upload/logs 04:53:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.618546 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-06-03 04:53:27.805218) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 04:53:27.809230) ========= 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=33d5923976266a1c518c4bf7000001ab-1464953549.664238-1306211226 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-Non-PGO/sha512/ba970bd23df2f5870b71e3f1be598bfceebb6cfe42763d213747547a2809cb796b88b74ca79fac50d1488f81abe9bd22ff02e2645829ebe2b6d996ba63f5418d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/121bb248578f5dfb9df67ac232dd688eef5d7cd742d2928d5bbdf7fa679d66e3eaba5c33da1804b55abf3de3d39a3dc3fa8f5d97a9b8cb7d7b11b9d1aa836e0c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e91291f1e5662b8d0b30918d4be8f2d3d3c8784296c090d61c4b165cafb83bf7a105ef7a5b8812f0f3dae67e58d17b143706b5c74f4db65dc83eb5b45fa9a7ff"} build_url:https://queue.taskcluster.net/v1/task/e6pu5doPTiqK2goLzX48ig/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011506 build_url: 'https://queue.taskcluster.net/v1/task/e6pu5doPTiqK2goLzX48ig/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-Non-PGO/sha512/ba970bd23df2f5870b71e3f1be598bfceebb6cfe42763d213747547a2809cb796b88b74ca79fac50d1488f81abe9bd22ff02e2645829ebe2b6d996ba63f5418d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/121bb248578f5dfb9df67ac232dd688eef5d7cd742d2928d5bbdf7fa679d66e3eaba5c33da1804b55abf3de3d39a3dc3fa8f5d97a9b8cb7d7b11b9d1aa836e0c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e91291f1e5662b8d0b30918d4be8f2d3d3c8784296c090d61c4b165cafb83bf7a105ef7a5b8812f0f3dae67e58d17b143706b5c74f4db65dc83eb5b45fa9a7ff"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 04:53:27.836688) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 04:53:27.837039) ========= 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=33d5923976266a1c518c4bf7000001ab-1464953549.664238-1306211226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004581 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 04:53:27.919800) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 04:53:27.920129) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 04:53:27.920461) ========= ========= Total master_lag: 0.16 =========