builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-030 starttime: 1464308672.27 results: success (0) buildid: 20160526143026 builduid: 26fd448f3453427792d7b9e492f82509 revision: def937e0dda7f3e9409e3f5bd70a659c4232782f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 17:24:32.269786) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 17:24:32.270382) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 17:24:32.270675) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 17:24:32.408757) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 17:24:32.409104) ========= 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=4ac8d263c7293b36a1be1aed000001be-1464308466.321735-1641749886 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-26 17:24:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 80.4M=0s 2016-05-26 17:24:32 (80.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.069431 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 17:24:32.516922) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 17:24:32.517236) ========= 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=4ac8d263c7293b36a1be1aed000001be-1464308466.321735-1641749886 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015260 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 17:24:32.567355) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-26 17:24:32.567724) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev def937e0dda7f3e9409e3f5bd70a659c4232782f --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 def937e0dda7f3e9409e3f5bd70a659c4232782f --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=4ac8d263c7293b36a1be1aed000001be-1464308466.321735-1641749886 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-26 17:24:32,814 truncating revision to first 12 chars 2016-05-26 17:24:32,814 Setting DEBUG logging. 2016-05-26 17:24:32,815 attempt 1/10 2016-05-26 17:24:32,815 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/def937e0dda7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-26 17:24:33,652 unpacking tar archive at: fx-team-def937e0dda7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.164474 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-26 17:24:33.747246) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 17:24:33.747629) ========= script_repo_revision: def937e0dda7f3e9409e3f5bd70a659c4232782f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 17:24:33.748052) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 17:24:33.748330) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 17:24:33.758973) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-26 17:24:33.759580) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4ac8d263c7293b36a1be1aed000001be-1464308466.321735-1641749886 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:24:34 INFO - MultiFileLogger online at 20160526 17:24:34 in /builds/slave/test 17:24:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:24:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:24:34 INFO - {'append_to_log': False, 17:24:34 INFO - 'base_work_dir': '/builds/slave/test', 17:24:34 INFO - 'blob_upload_branch': 'Fx-Team', 17:24:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:24:34 INFO - 'branch': 'Fx-Team', 17:24:34 INFO - 'buildbot_json_path': 'buildprops.json', 17:24:34 INFO - 'config_files': ('talos/linux_config.py',), 17:24:34 INFO - 'default_actions': ('clobber', 17:24:34 INFO - 'read-buildbot-config', 17:24:34 INFO - 'download-and-extract', 17:24:34 INFO - 'populate-webroot', 17:24:34 INFO - 'create-virtualenv', 17:24:34 INFO - 'install', 17:24:34 INFO - 'run-tests'), 17:24:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:24:34 INFO - 'download_minidump_stackwalk': True, 17:24:34 INFO - 'download_symbols': 'ondemand', 17:24:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:24:34 INFO - 'tooltool.py': '/tools/tooltool.py', 17:24:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:24:34 INFO - '/tools/misc-python/virtualenv.py')}, 17:24:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:24:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:24:34 INFO - 'installer_path': 'installer.exe', 17:24:34 INFO - 'log_level': 'info', 17:24:34 INFO - 'log_name': 'talos', 17:24:34 INFO - 'log_to_console': True, 17:24:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:24:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:24:34 INFO - 'opt_config_files': (), 17:24:34 INFO - 'pip_index': False, 17:24:34 INFO - 'sps_profile': False, 17:24:34 INFO - 'sps_profile_interval': 0, 17:24:34 INFO - 'suite': 'dromaeojs', 17:24:34 INFO - 'system_bits': '32', 17:24:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:24:34 INFO - 'title': 'talos-linux64-ix-030', 17:24:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:24:34 INFO - 'use_talos_json': True, 17:24:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:24:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:24:34 INFO - 'work_dir': 'build'} 17:24:34 INFO - ##### 17:24:34 INFO - ##### Running clobber step. 17:24:34 INFO - ##### 17:24:34 INFO - Running pre-action listener: _resource_record_pre_action 17:24:34 INFO - Running main action method: clobber 17:24:34 INFO - rmtree: /builds/slave/test/build 17:24:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:24:35 INFO - Running post-action listener: _resource_record_post_action 17:24:35 INFO - ##### 17:24:35 INFO - ##### Finished clobber step (success) 17:24:35 INFO - ##### 17:24:35 INFO - ##### 17:24:35 INFO - ##### Running read-buildbot-config step. 17:24:35 INFO - ##### 17:24:35 INFO - Running pre-action listener: _resource_record_pre_action 17:24:35 INFO - Running main action method: read_buildbot_config 17:24:35 INFO - Using buildbot properties: 17:24:35 INFO - { 17:24:35 INFO - "project": "", 17:24:35 INFO - "product": "firefox", 17:24:35 INFO - "script_repo_revision": "production", 17:24:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:24:35 INFO - "repository": "", 17:24:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:24:35 INFO - "buildid": "20160526143026", 17:24:35 INFO - "pgo_build": "True", 17:24:35 INFO - "basedir": "/builds/slave/test", 17:24:35 INFO - "buildnumber": 720, 17:24:35 INFO - "slavename": "talos-linux64-ix-030", 17:24:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:24:35 INFO - "platform": "ubuntu64_hw", 17:24:35 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:24:35 INFO - "branch": "fx-team", 17:24:35 INFO - "repo_path": "integration/fx-team", 17:24:35 INFO - "revision": "def937e0dda7f3e9409e3f5bd70a659c4232782f", 17:24:35 INFO - "stage_platform": "linux64-pgo", 17:24:35 INFO - "builduid": "26fd448f3453427792d7b9e492f82509", 17:24:35 INFO - "slavebuilddir": "test" 17:24:35 INFO - } 17:24:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/eMwlnTHwQFWcwnCUMQo59Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 17:24:35 INFO - Running post-action listener: _resource_record_post_action 17:24:35 INFO - ##### 17:24:35 INFO - ##### Finished read-buildbot-config step (success) 17:24:35 INFO - ##### 17:24:35 INFO - ##### 17:24:35 INFO - ##### Running download-and-extract step. 17:24:35 INFO - ##### 17:24:35 INFO - Running pre-action listener: _resource_record_pre_action 17:24:35 INFO - Running main action method: download_and_extract 17:24:35 INFO - mkdir: /builds/slave/test/build/tests 17:24: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')]} 17:24:35 INFO - https://queue.taskcluster.net/v1/task/eMwlnTHwQFWcwnCUMQo59Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:24:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eMwlnTHwQFWcwnCUMQo59Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:24:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eMwlnTHwQFWcwnCUMQo59Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:24:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eMwlnTHwQFWcwnCUMQo59Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:24:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eMwlnTHwQFWcwnCUMQo59Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:24:35 INFO - Downloaded 1361 bytes. 17:24:35 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:24:35 INFO - Using the following test package requirements: 17:24:35 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:24:35 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:24:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:24:35 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:24:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:24:35 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:24:35 INFO - u'jsshell-linux-x86_64.zip'], 17:24:35 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:24:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:24:35 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:24:35 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:24:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:24:35 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:24:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:24:35 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:24:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:24:35 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:24:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:24:35 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:24: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')]} 17:24:35 INFO - https://queue.taskcluster.net/v1/task/eMwlnTHwQFWcwnCUMQo59Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:24:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eMwlnTHwQFWcwnCUMQo59Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:24:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eMwlnTHwQFWcwnCUMQo59Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:24:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eMwlnTHwQFWcwnCUMQo59Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:24:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eMwlnTHwQFWcwnCUMQo59Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:24:37 INFO - Downloaded 24408388 bytes. 17:24:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:24:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:24:38 INFO - Return code: 0 17:24:38 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:24:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:38 INFO - https://queue.taskcluster.net/v1/task/eMwlnTHwQFWcwnCUMQo59Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:24:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eMwlnTHwQFWcwnCUMQo59Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:24:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eMwlnTHwQFWcwnCUMQo59Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:24:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eMwlnTHwQFWcwnCUMQo59Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:24:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eMwlnTHwQFWcwnCUMQo59Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:24:39 INFO - Downloaded 24408388 bytes. 17:24:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:24:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:24:41 INFO - Return code: 0 17:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:41 INFO - https://queue.taskcluster.net/v1/task/eMwlnTHwQFWcwnCUMQo59Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:24:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eMwlnTHwQFWcwnCUMQo59Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:24:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eMwlnTHwQFWcwnCUMQo59Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:24:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eMwlnTHwQFWcwnCUMQo59Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:24:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eMwlnTHwQFWcwnCUMQo59Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:24:42 INFO - Downloaded 10834034 bytes. 17:24:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:24:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:24:42 INFO - Return code: 0 17:24:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:42 INFO - https://queue.taskcluster.net/v1/task/eMwlnTHwQFWcwnCUMQo59Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:24:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eMwlnTHwQFWcwnCUMQo59Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:24:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eMwlnTHwQFWcwnCUMQo59Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:24:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eMwlnTHwQFWcwnCUMQo59Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:24:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eMwlnTHwQFWcwnCUMQo59Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:24:45 INFO - Downloaded 58708302 bytes. 17:24:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eMwlnTHwQFWcwnCUMQo59Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:24:45 INFO - mkdir: /builds/slave/test/properties 17:24:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:24:45 INFO - Writing to file /builds/slave/test/properties/build_url 17:24:45 INFO - Contents: 17:24:45 INFO - build_url:https://queue.taskcluster.net/v1/task/eMwlnTHwQFWcwnCUMQo59Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:24:46 INFO - Running post-action listener: _resource_record_post_action 17:24:46 INFO - Running post-action listener: set_extra_try_arguments 17:24:46 INFO - ##### 17:24:46 INFO - ##### Finished download-and-extract step (success) 17:24:46 INFO - ##### 17:24:46 INFO - ##### 17:24:46 INFO - ##### Running populate-webroot step. 17:24:46 INFO - ##### 17:24:46 INFO - Running pre-action listener: _resource_record_pre_action 17:24:46 INFO - Running main action method: populate_webroot 17:24:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:24:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:24:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:24:46 INFO - '--tppagecycles', 17:24:46 INFO - '7'], 17:24:46 INFO - 'tests': ['tsvgm']}}, 17:24:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:24:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:24:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:24:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:24:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:24:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:24:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:46 INFO - 'talos_options': ['--disable-e10s'], 17:24:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:24:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:24:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:46 INFO - 'talos_options': ['--disable-e10s'], 17:24:46 INFO - 'tests': ['damp', 'tps']}, 17:24:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:46 INFO - 'tests': ['damp', 'tps']}, 17:24:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:24:46 INFO - 'tests': ['dromaeo_dom']}, 17:24:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:24:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:24:46 INFO - 'tests': ['a11yr', 17:24:46 INFO - 'ts_paint', 17:24:46 INFO - 'tpaint', 17:24:46 INFO - 'sessionrestore', 17:24:46 INFO - 'sessionrestore_no_auto_restore', 17:24:46 INFO - 'tabpaint']}, 17:24:46 INFO - 'other-e10s': {'tests': ['a11yr', 17:24:46 INFO - 'ts_paint', 17:24:46 INFO - 'tpaint', 17:24:46 INFO - 'sessionrestore', 17:24:46 INFO - 'sessionrestore_no_auto_restore', 17:24:46 INFO - 'tabpaint']}, 17:24:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:24:46 INFO - 'ts_paint', 17:24:46 INFO - 'tpaint', 17:24:46 INFO - 'sessionrestore', 17:24:46 INFO - 'sessionrestore_no_auto_restore', 17:24:46 INFO - 'tabpaint']}, 17:24:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:24:46 INFO - 'ts_paint', 17:24:46 INFO - 'tpaint', 17:24:46 INFO - 'sessionrestore', 17:24:46 INFO - 'sessionrestore_no_auto_restore', 17:24:46 INFO - 'tabpaint']}, 17:24:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:24:46 INFO - 'tests': ['a11yr', 17:24:46 INFO - 'ts_paint', 17:24:46 INFO - 'tpaint', 17:24:46 INFO - 'sessionrestore', 17:24:46 INFO - 'sessionrestore_no_auto_restore', 17:24:46 INFO - 'tabpaint']}, 17:24:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:24:46 INFO - 'tests': ['a11yr', 17:24:46 INFO - 'ts_paint', 17:24:46 INFO - 'tpaint', 17:24:46 INFO - 'sessionrestore', 17:24:46 INFO - 'sessionrestore_no_auto_restore', 17:24:46 INFO - 'tabpaint']}, 17:24:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:24:46 INFO - 'tests': ['tsvgx', 17:24:46 INFO - 'tsvgr_opacity', 17:24:46 INFO - 'tart', 17:24:46 INFO - 'tscrollx', 17:24:46 INFO - 'cart']}, 17:24:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:24:46 INFO - 'tsvgr_opacity', 17:24:46 INFO - 'tart', 17:24:46 INFO - 'tscrollx', 17:24:46 INFO - 'cart']}, 17:24:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:46 INFO - 'talos_options': ['--disable-e10s'], 17:24:46 INFO - 'tests': ['tp5o']}, 17:24:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:46 INFO - 'tests': ['tp5o']}, 17:24:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:46 INFO - 'talos_options': ['--disable-e10s', 17:24:46 INFO - '--xperf_path', 17:24:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:24:46 INFO - 'tests': ['tp5n']}, 17:24:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:46 INFO - 'talos_options': ['--xperf_path', 17:24:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:24:46 INFO - 'tests': ['tp5n']}}, 17:24:46 INFO - 'talos.zip': {'path': '', 17:24:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:24:46 INFO - Running post-action listener: _resource_record_post_action 17:24:46 INFO - ##### 17:24:46 INFO - ##### Finished populate-webroot step (success) 17:24:46 INFO - ##### 17:24:46 INFO - ##### 17:24:46 INFO - ##### Running create-virtualenv step. 17:24:46 INFO - ##### 17:24:46 INFO - Running pre-action listener: _resource_record_pre_action 17:24:46 INFO - Running main action method: create_virtualenv 17:24:46 INFO - Creating virtualenv /builds/slave/test/build/venv 17:24:46 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:24:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:24:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:24:46 INFO - Using real prefix '/usr' 17:24:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:24:46 INFO - Installing distribute.............................................................................................................................................................................................done. 17:24:48 INFO - Installing pip.................done. 17:24:48 INFO - Return code: 0 17:24:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:48 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 0x7fa40b96df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20339c0>, '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 0x20348c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2034d50>, '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': '4ac8d263c7293b36a1be1aed000001be-1464308466.321735-1641749886', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:24:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:24:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:24:48 INFO - Using env: {'DISPLAY': ':0', 17:24:48 INFO - 'HOME': '/home/cltbld', 17:24:48 INFO - 'LANG': 'en_US.UTF-8', 17:24:48 INFO - 'LANGUAGE': 'en_US:en', 17:24:48 INFO - 'LOGNAME': 'cltbld', 17:24:48 INFO - 'MAIL': '/var/mail/cltbld', 17:24:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:48 INFO - 'MOZ_NO_REMOTE': '1', 17:24:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:48 INFO - 'NO_EM_RESTART': '1', 17:24:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:48 INFO - 'PWD': '/builds/slave/test', 17:24:48 INFO - 'SHELL': '/bin/bash', 17:24:48 INFO - 'SHLVL': '1', 17:24:48 INFO - 'TERM': 'linux', 17:24:48 INFO - 'TMOUT': '86400', 17:24:48 INFO - 'USER': 'cltbld', 17:24:48 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1464308466.321735-1641749886', 17:24:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:48 INFO - '_': '/tools/buildbot/bin/python'} 17:24:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:24:49 INFO - Cleaning up... 17:24:49 INFO - Return code: 0 17:24:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:24: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')]} 17:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24: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')]} 17:24:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24: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', '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 0x7fa40b96df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20339c0>, '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 0x20348c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2034d50>, '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': '4ac8d263c7293b36a1be1aed000001be-1464308466.321735-1641749886', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:24: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', 'psutil>=3.1.1'] in /builds/slave/test/build 17:24: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 psutil>=3.1.1 17:24:49 INFO - Using env: {'DISPLAY': ':0', 17:24:49 INFO - 'HOME': '/home/cltbld', 17:24:49 INFO - 'LANG': 'en_US.UTF-8', 17:24:49 INFO - 'LANGUAGE': 'en_US:en', 17:24:49 INFO - 'LOGNAME': 'cltbld', 17:24:49 INFO - 'MAIL': '/var/mail/cltbld', 17:24:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:49 INFO - 'MOZ_NO_REMOTE': '1', 17:24:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:49 INFO - 'NO_EM_RESTART': '1', 17:24:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:49 INFO - 'PWD': '/builds/slave/test', 17:24:49 INFO - 'SHELL': '/bin/bash', 17:24:49 INFO - 'SHLVL': '1', 17:24:49 INFO - 'TERM': 'linux', 17:24:49 INFO - 'TMOUT': '86400', 17:24:49 INFO - 'USER': 'cltbld', 17:24:49 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1464308466.321735-1641749886', 17:24:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:49 INFO - '_': '/tools/buildbot/bin/python'} 17:24:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:49 INFO - Downloading/unpacking psutil>=3.1.1 17:24: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 17:24: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 17:24: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 17:24: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 17:24: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 17:24: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 17:24:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:24:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:24:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:24:51 INFO - Installing collected packages: psutil 17:24:51 INFO - Running setup.py install for psutil 17:24:51 INFO - building 'psutil._psutil_linux' extension 17:24:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:24:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:24:51 INFO - building 'psutil._psutil_posix' extension 17:24:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:24:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:24:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:24:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:24:51 INFO - Successfully installed psutil 17:24:51 INFO - Cleaning up... 17:24:51 INFO - Return code: 0 17:24:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:24:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:51 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 0x7fa40b96df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20339c0>, '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 0x20348c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2034d50>, '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': '4ac8d263c7293b36a1be1aed000001be-1464308466.321735-1641749886', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:24:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:24:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:24:51 INFO - Using env: {'DISPLAY': ':0', 17:24:51 INFO - 'HOME': '/home/cltbld', 17:24:51 INFO - 'LANG': 'en_US.UTF-8', 17:24:51 INFO - 'LANGUAGE': 'en_US:en', 17:24:51 INFO - 'LOGNAME': 'cltbld', 17:24:51 INFO - 'MAIL': '/var/mail/cltbld', 17:24:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:51 INFO - 'MOZ_NO_REMOTE': '1', 17:24:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:51 INFO - 'NO_EM_RESTART': '1', 17:24:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:51 INFO - 'PWD': '/builds/slave/test', 17:24:51 INFO - 'SHELL': '/bin/bash', 17:24:51 INFO - 'SHLVL': '1', 17:24:51 INFO - 'TERM': 'linux', 17:24:51 INFO - 'TMOUT': '86400', 17:24:51 INFO - 'USER': 'cltbld', 17:24:51 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1464308466.321735-1641749886', 17:24:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:51 INFO - '_': '/tools/buildbot/bin/python'} 17:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:24:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:24:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:24:53 INFO - Installing collected packages: mozsystemmonitor 17:24:53 INFO - Running setup.py install for mozsystemmonitor 17:24:54 INFO - Successfully installed mozsystemmonitor 17:24:54 INFO - Cleaning up... 17:24:54 INFO - Return code: 0 17:24:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:54 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 0x7fa40b96df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20339c0>, '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 0x20348c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2034d50>, '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': '4ac8d263c7293b36a1be1aed000001be-1464308466.321735-1641749886', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:24:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:24:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:24:54 INFO - Using env: {'DISPLAY': ':0', 17:24:54 INFO - 'HOME': '/home/cltbld', 17:24:54 INFO - 'LANG': 'en_US.UTF-8', 17:24:54 INFO - 'LANGUAGE': 'en_US:en', 17:24:54 INFO - 'LOGNAME': 'cltbld', 17:24:54 INFO - 'MAIL': '/var/mail/cltbld', 17:24:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:54 INFO - 'MOZ_NO_REMOTE': '1', 17:24:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:54 INFO - 'NO_EM_RESTART': '1', 17:24:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:54 INFO - 'PWD': '/builds/slave/test', 17:24:54 INFO - 'SHELL': '/bin/bash', 17:24:54 INFO - 'SHLVL': '1', 17:24:54 INFO - 'TERM': 'linux', 17:24:54 INFO - 'TMOUT': '86400', 17:24:54 INFO - 'USER': 'cltbld', 17:24:54 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1464308466.321735-1641749886', 17:24:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:54 INFO - '_': '/tools/buildbot/bin/python'} 17:24:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:54 INFO - Downloading/unpacking blobuploader==1.2.4 17:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:56 INFO - Downloading blobuploader-1.2.4.tar.gz 17:24:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:24:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:24:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:56 INFO - Downloading docopt-0.6.1.tar.gz 17:24:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:24:56 INFO - Installing collected packages: blobuploader, requests, docopt 17:24:56 INFO - Running setup.py install for blobuploader 17:24:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:24:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:24:57 INFO - Running setup.py install for requests 17:24:57 INFO - Running setup.py install for docopt 17:24:57 INFO - Successfully installed blobuploader requests docopt 17:24:57 INFO - Cleaning up... 17:24:57 INFO - Return code: 0 17:24:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:57 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 0x7fa40b96df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20339c0>, '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 0x20348c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2034d50>, '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': '4ac8d263c7293b36a1be1aed000001be-1464308466.321735-1641749886', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:24:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:24:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:24:57 INFO - Using env: {'DISPLAY': ':0', 17:24:57 INFO - 'HOME': '/home/cltbld', 17:24:57 INFO - 'LANG': 'en_US.UTF-8', 17:24:57 INFO - 'LANGUAGE': 'en_US:en', 17:24:57 INFO - 'LOGNAME': 'cltbld', 17:24:57 INFO - 'MAIL': '/var/mail/cltbld', 17:24:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:57 INFO - 'MOZ_NO_REMOTE': '1', 17:24:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:57 INFO - 'NO_EM_RESTART': '1', 17:24:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:57 INFO - 'PWD': '/builds/slave/test', 17:24:57 INFO - 'SHELL': '/bin/bash', 17:24:57 INFO - 'SHLVL': '1', 17:24:57 INFO - 'TERM': 'linux', 17:24:57 INFO - 'TMOUT': '86400', 17:24:57 INFO - 'USER': 'cltbld', 17:24:57 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1464308466.321735-1641749886', 17:24:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:57 INFO - '_': '/tools/buildbot/bin/python'} 17:24:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:24:57 INFO - Running setup.py (path:/tmp/pip-eJm1r0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:24:57 INFO - Running setup.py (path:/tmp/pip-DSfWYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:24:57 INFO - Running setup.py (path:/tmp/pip-fTfj_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:24:58 INFO - Running setup.py (path:/tmp/pip-OHLeCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:24:58 INFO - Running setup.py (path:/tmp/pip-a0ZzFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:24:58 INFO - Running setup.py (path:/tmp/pip-JrfLjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:24:58 INFO - Running setup.py (path:/tmp/pip-oF5jx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:24:58 INFO - Running setup.py (path:/tmp/pip-WMxvAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:24:58 INFO - Running setup.py (path:/tmp/pip-9_mkL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:24:58 INFO - Running setup.py (path:/tmp/pip-qHHz96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:24:58 INFO - Running setup.py (path:/tmp/pip-uCspT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:24:58 INFO - Running setup.py (path:/tmp/pip-RX0ULU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:24:58 INFO - Running setup.py (path:/tmp/pip-Y8k5Ad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:24:58 INFO - Running setup.py (path:/tmp/pip-ZnoSe7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:24:58 INFO - Running setup.py (path:/tmp/pip-Odqic_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:24:58 INFO - Running setup.py (path:/tmp/pip-6rhuZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:24:58 INFO - Running setup.py (path:/tmp/pip-orVwof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:24:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:24:59 INFO - Running setup.py install for manifestparser 17:24:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:24:59 INFO - Running setup.py install for mozcrash 17:24:59 INFO - Running setup.py install for mozdebug 17:24:59 INFO - Running setup.py install for mozdevice 17:24:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:24:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:24:59 INFO - Running setup.py install for mozfile 17:24:59 INFO - Running setup.py install for mozhttpd 17:24:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:24:59 INFO - Running setup.py install for mozinfo 17:24:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:24:59 INFO - Running setup.py install for mozInstall 17:24:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:24:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:24:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:24:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:24:59 INFO - Running setup.py install for mozleak 17:24:59 INFO - Running setup.py install for mozlog 17:25:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:25:00 INFO - Running setup.py install for moznetwork 17:25:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:25:00 INFO - Running setup.py install for mozprocess 17:25:00 INFO - Running setup.py install for mozprofile 17:25:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:25:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:25:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:25:00 INFO - Running setup.py install for mozrunner 17:25:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:25:00 INFO - Running setup.py install for mozscreenshot 17:25:00 INFO - Running setup.py install for moztest 17:25:00 INFO - Running setup.py install for mozversion 17:25:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:25:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:25:00 INFO - Cleaning up... 17:25:00 INFO - Return code: 0 17:25:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:25:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:00 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 0x7fa40b96df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20339c0>, '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 0x20348c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2034d50>, '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': '4ac8d263c7293b36a1be1aed000001be-1464308466.321735-1641749886', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:25:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:25:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:25:00 INFO - Using env: {'DISPLAY': ':0', 17:25:00 INFO - 'HOME': '/home/cltbld', 17:25:00 INFO - 'LANG': 'en_US.UTF-8', 17:25:00 INFO - 'LANGUAGE': 'en_US:en', 17:25:00 INFO - 'LOGNAME': 'cltbld', 17:25:00 INFO - 'MAIL': '/var/mail/cltbld', 17:25:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:00 INFO - 'MOZ_NO_REMOTE': '1', 17:25:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:00 INFO - 'NO_EM_RESTART': '1', 17:25:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:00 INFO - 'PWD': '/builds/slave/test', 17:25:00 INFO - 'SHELL': '/bin/bash', 17:25:00 INFO - 'SHLVL': '1', 17:25:00 INFO - 'TERM': 'linux', 17:25:00 INFO - 'TMOUT': '86400', 17:25:00 INFO - 'USER': 'cltbld', 17:25:00 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1464308466.321735-1641749886', 17:25:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:00 INFO - '_': '/tools/buildbot/bin/python'} 17:25:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:25:01 INFO - Running setup.py (path:/tmp/pip-vwEkQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:25:01 INFO - Running setup.py (path:/tmp/pip-XR2zdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:25:01 INFO - Running setup.py (path:/tmp/pip-jK9ZxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:25:01 INFO - Running setup.py (path:/tmp/pip-RAzm7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:25:01 INFO - Running setup.py (path:/tmp/pip-c1L6_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:25:01 INFO - Running setup.py (path:/tmp/pip-CMOTXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:25:01 INFO - Running setup.py (path:/tmp/pip-kQ4rD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:25:01 INFO - Running setup.py (path:/tmp/pip-jlJYzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:25:01 INFO - Running setup.py (path:/tmp/pip-FZccxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:25:01 INFO - Running setup.py (path:/tmp/pip-cpjqUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:25:01 INFO - Running setup.py (path:/tmp/pip-rC3ugT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:25:01 INFO - Running setup.py (path:/tmp/pip-vV2C88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:25:01 INFO - Running setup.py (path:/tmp/pip-WQZ1bE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:25:01 INFO - Running setup.py (path:/tmp/pip-SwFOfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:25:02 INFO - Running setup.py (path:/tmp/pip-lzSUCf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:25:02 INFO - Running setup.py (path:/tmp/pip-xX4mFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:25:02 INFO - Running setup.py (path:/tmp/pip-TNqtTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:25:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:25: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 17:25: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 17:25: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 17:25: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 17:25: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 17:25: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 17:25:04 INFO - Downloading blessings-1.6.tar.gz 17:25:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:25:04 INFO - Installing collected packages: blessings 17:25:04 INFO - Running setup.py install for blessings 17:25:04 INFO - Successfully installed blessings 17:25:04 INFO - Cleaning up... 17:25:04 INFO - Return code: 0 17:25:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:25:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:25:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:25:04 INFO - Reading from file tmpfile_stdout 17:25:04 INFO - Current package versions: 17:25:04 INFO - argparse == 1.2.1 17:25:04 INFO - blessings == 1.6 17:25:04 INFO - blobuploader == 1.2.4 17:25:04 INFO - docopt == 0.6.1 17:25:04 INFO - manifestparser == 1.1 17:25:04 INFO - mozInstall == 1.12 17:25:04 INFO - mozcrash == 0.17 17:25:04 INFO - mozdebug == 0.1 17:25:04 INFO - mozdevice == 0.48 17:25:04 INFO - mozfile == 1.2 17:25:04 INFO - mozhttpd == 0.7 17:25:04 INFO - mozinfo == 0.9 17:25:04 INFO - mozleak == 0.1 17:25:04 INFO - mozlog == 3.2 17:25:04 INFO - moznetwork == 0.27 17:25:04 INFO - mozprocess == 0.22 17:25:04 INFO - mozprofile == 0.28 17:25:04 INFO - mozrunner == 6.11 17:25:04 INFO - mozscreenshot == 0.1 17:25:04 INFO - mozsystemmonitor == 0.3 17:25:04 INFO - moztest == 0.7 17:25:04 INFO - mozversion == 1.4 17:25:04 INFO - psutil == 3.1.1 17:25:04 INFO - requests == 1.2.3 17:25:04 INFO - wsgiref == 0.1.2 17:25:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:25:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:04 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 0x7fa40b96df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20339c0>, '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 0x20348c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2034d50>, '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': '4ac8d263c7293b36a1be1aed000001be-1464308466.321735-1641749886', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:25:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:25:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:25:04 INFO - Using env: {'DISPLAY': ':0', 17:25:04 INFO - 'HOME': '/home/cltbld', 17:25:04 INFO - 'LANG': 'en_US.UTF-8', 17:25:04 INFO - 'LANGUAGE': 'en_US:en', 17:25:04 INFO - 'LOGNAME': 'cltbld', 17:25:04 INFO - 'MAIL': '/var/mail/cltbld', 17:25:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:04 INFO - 'MOZ_NO_REMOTE': '1', 17:25:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:04 INFO - 'NO_EM_RESTART': '1', 17:25:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:04 INFO - 'PWD': '/builds/slave/test', 17:25:04 INFO - 'SHELL': '/bin/bash', 17:25:04 INFO - 'SHLVL': '1', 17:25:04 INFO - 'TERM': 'linux', 17:25:04 INFO - 'TMOUT': '86400', 17:25:04 INFO - 'USER': 'cltbld', 17:25:04 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1464308466.321735-1641749886', 17:25:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:04 INFO - '_': '/tools/buildbot/bin/python'} 17:25:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:25:04 INFO - Cleaning up... 17:25:04 INFO - Return code: 0 17:25:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:25:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:04 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 0x7fa40b96df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20339c0>, '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 0x20348c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2034d50>, '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': '4ac8d263c7293b36a1be1aed000001be-1464308466.321735-1641749886', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:25:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:25:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:25:04 INFO - Using env: {'DISPLAY': ':0', 17:25:04 INFO - 'HOME': '/home/cltbld', 17:25:04 INFO - 'LANG': 'en_US.UTF-8', 17:25:04 INFO - 'LANGUAGE': 'en_US:en', 17:25:04 INFO - 'LOGNAME': 'cltbld', 17:25:04 INFO - 'MAIL': '/var/mail/cltbld', 17:25:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:04 INFO - 'MOZ_NO_REMOTE': '1', 17:25:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:04 INFO - 'NO_EM_RESTART': '1', 17:25:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:04 INFO - 'PWD': '/builds/slave/test', 17:25:04 INFO - 'SHELL': '/bin/bash', 17:25:04 INFO - 'SHLVL': '1', 17:25:04 INFO - 'TERM': 'linux', 17:25:04 INFO - 'TMOUT': '86400', 17:25:04 INFO - 'USER': 'cltbld', 17:25:04 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1464308466.321735-1641749886', 17:25:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:04 INFO - '_': '/tools/buildbot/bin/python'} 17:25:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:05 INFO - Downloading/unpacking jsonschema 17:25: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 17:25: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 17:25: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 17:25: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 17:25: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 17:25: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 17:25:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:25:06 INFO - Downloading/unpacking functools32 (from jsonschema) 17:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:07 INFO - Downloading functools32-3.2.3-2.tar.gz 17:25:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:25:07 INFO - warning: no files found matching '*.txt' 17:25:07 INFO - no previously-included directories found matching 'build' 17:25:07 INFO - no previously-included directories found matching 'dist' 17:25:07 INFO - no previously-included directories found matching '.git*' 17:25:07 INFO - Installing collected packages: jsonschema, functools32 17:25:07 INFO - Running setup.py install for functools32 17:25:07 INFO - warning: no files found matching '*.txt' 17:25:07 INFO - no previously-included directories found matching 'build' 17:25:07 INFO - no previously-included directories found matching 'dist' 17:25:07 INFO - no previously-included directories found matching '.git*' 17:25:07 INFO - Successfully installed jsonschema functools32 17:25:07 INFO - Cleaning up... 17:25:07 INFO - Return code: 0 17:25:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:25:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:07 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 0x7fa40b96df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20339c0>, '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 0x20348c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2034d50>, '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': '4ac8d263c7293b36a1be1aed000001be-1464308466.321735-1641749886', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:25:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:25:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:25:07 INFO - Using env: {'DISPLAY': ':0', 17:25:07 INFO - 'HOME': '/home/cltbld', 17:25:07 INFO - 'LANG': 'en_US.UTF-8', 17:25:07 INFO - 'LANGUAGE': 'en_US:en', 17:25:07 INFO - 'LOGNAME': 'cltbld', 17:25:07 INFO - 'MAIL': '/var/mail/cltbld', 17:25:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:07 INFO - 'MOZ_NO_REMOTE': '1', 17:25:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:07 INFO - 'NO_EM_RESTART': '1', 17:25:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:07 INFO - 'PWD': '/builds/slave/test', 17:25:07 INFO - 'SHELL': '/bin/bash', 17:25:07 INFO - 'SHLVL': '1', 17:25:07 INFO - 'TERM': 'linux', 17:25:07 INFO - 'TMOUT': '86400', 17:25:07 INFO - 'USER': 'cltbld', 17:25:07 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1464308466.321735-1641749886', 17:25:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:07 INFO - '_': '/tools/buildbot/bin/python'} 17:25:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:07 INFO - Downloading/unpacking flake8 17:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:25:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:25:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:25:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:25:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:25:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:25:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:25:10 INFO - no previously-included directories found matching 'docs/_build' 17:25:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:25:10 INFO - Running setup.py install for pep8 17:25:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:25:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:25:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:25:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:25:10 INFO - no previously-included directories found matching 'docs/_build' 17:25:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:25:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:25:10 INFO - Cleaning up... 17:25:10 INFO - Return code: 0 17:25:10 INFO - Running post-action listener: _resource_record_post_action 17:25:10 INFO - Running post-action listener: _start_resource_monitoring 17:25:10 INFO - Starting resource monitoring. 17:25:10 INFO - ##### 17:25:10 INFO - ##### Finished create-virtualenv step (success) 17:25:10 INFO - ##### 17:25:10 INFO - ##### 17:25:10 INFO - ##### Running install step. 17:25:10 INFO - ##### 17:25:10 INFO - Running pre-action listener: _resource_record_pre_action 17:25:10 INFO - Running main action method: install 17:25:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:25:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:25:10 INFO - Reading from file tmpfile_stdout 17:25:10 INFO - Detecting whether we're running mozinstall >=1.0... 17:25:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:25:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:25:10 INFO - Reading from file tmpfile_stdout 17:25:10 INFO - Output received: 17:25:10 INFO - Usage: mozinstall [options] installer 17:25:10 INFO - Options: 17:25:10 INFO - -h, --help show this help message and exit 17:25:10 INFO - -d DEST, --destination=DEST 17:25:10 INFO - Directory to install application into. [default: 17:25:10 INFO - "/builds/slave/test"] 17:25:10 INFO - --app=APP Application being installed. [default: firefox] 17:25:10 INFO - mkdir: /builds/slave/test/build/application 17:25:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:25:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:25:27 INFO - Reading from file tmpfile_stdout 17:25:27 INFO - Output received: 17:25:27 INFO - /builds/slave/test/build/application/firefox/firefox 17:25:27 INFO - Running post-action listener: _resource_record_post_action 17:25:27 INFO - ##### 17:25:27 INFO - ##### Finished install step (success) 17:25:27 INFO - ##### 17:25:27 INFO - ##### 17:25:27 INFO - ##### Running run-tests step. 17:25:27 INFO - ##### 17:25:27 INFO - Running pre-action listener: _resource_record_pre_action 17:25:27 INFO - Running main action method: run_tests 17:25:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:25:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:25:27 INFO - Python 2.7.3 17:25:27 INFO - Return code: 0 17:25:27 INFO - grabbing minidump binary from tooltool 17:25:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:27 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 0x20339c0>, '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 0x20348c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2034d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:25:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:25:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:25:27 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:25:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:25:27 INFO - Return code: 0 17:25:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:25:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:25:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:25:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:25:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:25:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:25:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:25:28 INFO - Return code: 0 17:25:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eMwlnTHwQFWcwnCUMQo59Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 17:25:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eMwlnTHwQFWcwnCUMQo59Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --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 17:25:28 INFO - Using env: {'DISPLAY': ':0', 17:25:28 INFO - 'HOME': '/home/cltbld', 17:25:28 INFO - 'LANG': 'en_US.UTF-8', 17:25:28 INFO - 'LANGUAGE': 'en_US:en', 17:25:28 INFO - 'LOGNAME': 'cltbld', 17:25:28 INFO - 'MAIL': '/var/mail/cltbld', 17:25:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:25:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:25:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:28 INFO - 'MOZ_NO_REMOTE': '1', 17:25:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:25:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:28 INFO - 'NO_EM_RESTART': '1', 17:25:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:28 INFO - 'PWD': '/builds/slave/test', 17:25:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:25:28 INFO - 'SHELL': '/bin/bash', 17:25:28 INFO - 'SHLVL': '1', 17:25:28 INFO - 'TERM': 'linux', 17:25:28 INFO - 'TMOUT': '86400', 17:25:28 INFO - 'USER': 'cltbld', 17:25:28 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1464308466.321735-1641749886', 17:25:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:28 INFO - '_': '/tools/buildbot/bin/python'} 17:25:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eMwlnTHwQFWcwnCUMQo59Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 17:25:28 INFO - mozversion application_buildid: 20160526143026 17:25:28 INFO - mozversion application_changeset: def937e0dda7f3e9409e3f5bd70a659c4232782f 17:25:28 INFO - mozversion application_display_name: Nightly 17:25:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:25:28 INFO - mozversion application_name: Firefox 17:25:28 INFO - mozversion application_remotingname: firefox 17:25:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:25:28 INFO - mozversion application_vendor: Mozilla 17:25:28 INFO - mozversion application_version: 49.0a1 17:25:28 INFO - mozversion platform_buildid: 20160526143026 17:25:28 INFO - mozversion platform_changeset: def937e0dda7f3e9409e3f5bd70a659c4232782f 17:25:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:25:28 INFO - mozversion platform_version: 49.0a1 17:25:28 INFO - using testdate: 1464308728 17:25:28 INFO - actual date: 1464308728 17:25:28 INFO - starting webserver on 'localhost:39014' 17:25:28 INFO - SUITE-START | Running 2 tests 17:25:28 INFO - TEST-START | dromaeo_css 17:25:28 INFO - operating with platform_type : linux_ 17:25:28 INFO - Initialising browser for dromaeo_css test... 17:25:28 INFO - TEST-INFO | started process 25536 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk1N_IB/profile http://localhost:39014/getInfo.html) 17:25:32 INFO - PROCESS | 25536 | __metrics Screen width/height:1600/1200 17:25:32 INFO - PROCESS | 25536 | colorDepth:24 17:25:32 INFO - PROCESS | 25536 | Browser inner width/height: 1024/697 17:25:32 INFO - PROCESS | 25536 | __metrics 17:25:33 ERROR - PROCESS | 25536 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:25:34 INFO - TEST-INFO | 25536: exit 0 17:25:34 INFO - Browser initialized. 17:25:34 INFO - Running cycle 1/1 for dromaeo_css test... 17:25:34 INFO - TEST-INFO | started process 25618 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk1N_IB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:25:46 INFO - PROCESS | 25618 | RSS: Main: 155111424 17:25:46 INFO - PROCESS | 25618 | 17:26:37 INFO - PROCESS | 25618 | 1464308797126 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:28:45 INFO - PROCESS | 25618 | Cycle 1(1): loaded http://localhost:39014/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39014/tests/dromaeo/cssquery-ext.html) 17:28:46 INFO - PROCESS | 25618 | RSS: Main: 261668864 17:28:46 INFO - PROCESS | 25618 | 17:31:48 INFO - PROCESS | 25618 | Cycle 1(1): loaded http://localhost:39014/tests/dromaeo/cssquery-ext.html (next: http://localhost:39014/tests/dromaeo/cssquery-jquery.html) 17:31:49 INFO - PROCESS | 25618 | RSS: Main: 233123840 17:31:49 INFO - PROCESS | 25618 | 17:34:51 INFO - PROCESS | 25618 | Cycle 1(1): loaded http://localhost:39014/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39014/tests/dromaeo/cssquery-mootools.html) 17:34:51 INFO - PROCESS | 25618 | RSS: Main: 241491968 17:34:51 INFO - PROCESS | 25618 | 17:37:53 INFO - PROCESS | 25618 | Cycle 1(1): loaded http://localhost:39014/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39014/tests/dromaeo/cssquery-prototype.html) 17:37:54 INFO - PROCESS | 25618 | RSS: Main: 232869888 17:37:54 INFO - PROCESS | 25618 | 17:40:57 INFO - PROCESS | 25618 | Cycle 1(1): loaded http://localhost:39014/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39014/tests/dromaeo/cssquery-yui.html) 17:40:57 INFO - PROCESS | 25618 | RSS: Main: 227205120 17:40:57 INFO - PROCESS | 25618 | 17:44:00 INFO - PROCESS | 25618 | Cycle 1(1): loaded http://localhost:39014/tests/dromaeo/cssquery-yui.html (next: http://localhost:39014/tests/dromaeo/cssquery-dojo.html) 17:44:00 INFO - PROCESS | 25618 | RSS: Main: 280293376 17:44:00 INFO - PROCESS | 25618 | 17:44:00 INFO - PROCESS | 25618 | __start_tp_report 17:44:00 INFO - PROCESS | 25618 | _x_x_mozilla_page_load 17:44:00 INFO - PROCESS | 25618 | _x_x_mozilla_page_load_details 17:44:00 INFO - PROCESS | 25618 | |i|pagename|runs| 17:44:00 INFO - PROCESS | 25618 | |0;dojo.html;3122.7033431823975;3129.1394866411747;3157.2264795125197;3172.2228054126745;3183.8726450941963;5366.570674346052;5403.621746477748;5420.5392541633955;5491.560675145989;5528.391876893544;5504.559635229182;5539.612227144092;5571.9721401392935;5594.13290939904;5627.6904770237625;4932.63005274605;5019;5201.739913004353;5244.554212891909;5269.077911365515;4961.875953101166;5166.328377310963;5175.534201921826;5187.092258854705;5259.368875734917;5001.1248031594505;5028.170351891933;5062.164742817467;5070.847874563769;5074.13739664258;5080.110980578384;5088.92366614501;5091.7963281469065;5098.6685865419;5140.922886156711;4925.532074452921;4953.405591329028;5021.39743230811;5073.771680274396;5087.109755792759;5450.018996580614;5507.807226747044;5533.861653458655;5540.141278101901;5556.722163891789;5938.970305148489;5998.28020637522;6000.069989151689;6000.969995149996;6003.909941350883;5809.88380232393;5872.412758724136;5901.763929442817;5980.730867110947;6040.969795150996;5670.404607516192;5691.573132015033;5695.943040569624;5696.401877802854;5698.088305871082;6158.353372895871;6160.691965401712;6174.351693072163;6174.598651087665;6178.567500274938;5682.54539636828;5791.797287095016;5829.854253643608;5843.883122337529;5960.135780311917;5916.467517923407;6011;6023.548233882477;6031.276246850406;6032.276126864805;5846.093855452412;5909.2908850938165;5911.349751527328;5945.9891818390115;5946.70266486674;5766.711664416763;5824.446677565625;5884.205632239678;5890.028145356054;5938.732757025944;4474.798634061475;4475.373447717322;4475.910481790346;4484.372187893698;4516.119356725473;3940.704447166474;3998.7800670962793;4003.4195041718785;4019.4774679291504;4047.2310261050307;5659.971700141473;5714.914276285859;5721.284839395075;5725.8568535786935;5756.107803290497;6089.391060893875;6098.360004765077;6099.884870379942;6108.6164113122;6137.895178867758;5495.697736624524;5657.12314591239;5743.4543718346695;5744.741486633112;5749.252597162425;5162.6902385856965;5205.843824685266;5209.661372010807;5211.140161873324;5250.448702886142;6269.404406581368;6275.466585340206;6283.5287353448675;6285.402886725754;6290.811275661646;5857.150713146655;5899.970500147472;5947.91078133837;6052.515798736179;6073.757049717962;6172.722227499684;6185.072239164161;6186.876262474815;6194.721237544231;6195.535334849814;5831.7667293307795;5884.598036154105;5899.380565040609;5908.438698323653;5911.527077833849;5865.090910908816;5900.70496475166;5905.970470147622;5983.102534619842;5988.6706231157705;5826.359100499027;5829.213056237354;5831.0378787499585;5839.124131380327;5873.500752436091;5813.476787089182;5817.214676018683;5818.040023396092;5832.94167058324;5833.095870140135;5687.203791469115;5697.116946873241;5697.373288938131;5702.885942281048;5753.079507278815;5895.970520147372;5902.793402231073;5939.881202376015;5947.018741907536;5954.345022047658;5743;5757.683327417032;5758.481736643722;5759.769609215585;5762.596618236683 17:44:00 INFO - PROCESS | 25618 | |1;ext.html;597.5070566782402;610.1336102734118;632.5698525002997;635.9014352775322;663.4526515624611;42558.787206063964;43941.12117757643;43960.120797584066;48409;48477;46111.76944115283;46814;46825.53174468254;46826.29760553595;46856.53143468573;8121.066077401086;8761.342899282563;8965.417247878899;10548.208884333668;10835.891641083606;10620.628278010272;10757.677269681923;10759;10765.569377224941;10766.623168189115;10748.408837513934;10829.620963266287;10832.458377081115;10834.295770774874;10841.024307812295;8128;10455.4772261387;10695.786084278348;10698.893011069946;11122.49948752308;10633.149348052137;10706.41114738689;10723.624673136403;10723.62467313648;10732.087772539344;42912.78543607293;42974.35538466925;43168.78415607902;43371.783141084095;43385.56614433847;3523.4714792781033;3551.8401671924826;3571.4642803579413;3595.280943811248;3612.205314830733;32947.176320591934;33235;33468.832655836806;33827.6617233827;33839.83080084608;4092.386142078682;4158.355454904495;4282.464691913511;4305.720128191658;4309.612134907842;342410;342564.287178565;346239;346567.9999999975;346616;63037.36962630407;63539.6823015882;63839;64117;64246.35753642497;32878.506822397685;33346.3330733384;33354.49968250478;33372.332553348795;67044.66477667581;13740.93129534346;14668.706625867637;14932.104073755609;14936;14946.103233806007;10968.945155274172;11209.159313051554;11218.66344009681;11462.025727813229;11470.426478676032;19682.212711491666;19771.802281977285;19888.005599719956;19923.501912452015;20014.399568012985;7121.359077683033;7243.0946131733535;7276.490645654859;7303.853922921512;7319.377852882458;1002.3084071990303;1057.1384321777728;1060.8143574874366;1128.9266197697123;1148.5463242019355;32818.67181328204;32858;32909.50635740466;33175;33423.16442088919;1114.7826173896012;1116.6482557994207;1127.0420142878652;1141.937193454368;1187.6674531131298;16908.746368804477;17256.568585785455;17487;17594.372988751773;17700.734488982675;492272;789220;800220;802631;802665;60019.39980600226;60415.69792151011;60662.39337606567;60736.69631651902;60833.69583152144;1267.9112462127562;1286.12543470441;1298.1432254712033;1364.6179069860455;1396.4693416501664;29678.851605741835;33293.83353083219;34038.65961340454;34309;34402.82798585991;50332.24501632552;50673.74663126661;50839.49160508347;50936.74531627318;51016;392503;394927;396452;396976;396993;24469.632955506037;24685.259442216764;28587.571186431804;28872.2781930445;30514.847425762728;47683.284750728075;48451.27323090086;48605;49259.75370123127;49271;40770.592294076676;40888;41073.38389924094;41260.1747965045;42448.36327455152;40770.5152433238;41076.383854242806;41194.38208426936;42074.57925420706;42204.366934495396;40572;40721.18557628772;41359;41996;42220.788896055325;35817.283654326246;37552.43671344878;37844.62155378411;38083.23833523369;38615;28482.57276140818;28637.28406789847;29084.56373154362;29199.270018248862;29403.264918377212 17:44:00 INFO - PROCESS | 25618 | |2;jquery.html;366.40459253712714;381.8377189694379;389.5131086142321;402.55316598575575;402.71608515996223;18107.366242181528;19850.801491985076;20479.385618431454;20509.38471845847;20518.89740551297;18897.527561810926;18939.905300473478;19505.51236219095;19599.804001959976;19677.311294104707;5420;5579.302587176603;5738.684372359518;5803.390643982384;5826.242588463494;3858.3633700439395;5483.287172667548;5742.770289188427;5764.827055188351;5774.422557744234;5852.707364631751;5867.031939729939;5871.031279838821;5876.882462350772;5893.410658934094;6405.775797847076;6423.678816059179;6431.324710905358;6442.613443193423;6446.194225721785;5469.699166545838;5673.553243922774;5675.41088495222;5737.454941780524;5746.339170995348;13088.083834131614;13302.733945321039;13371.53199638008;13949.511767088103;22397.66403503949;2261.7512073671883;2370.111208296889;2389.2712722619594;2455.6193789962585;2474.715407728116;9628;9673.564689588915;10240.385576865412;12119.272843629411;13732.519361822388;1954.042519165613;1969.2123150739676;1979.7129416234566;1998.1308130962932;2018.6770116781245;77276.22723772803;77285.61357193234;77634;79742.99999999942;81420;10573.682789516326;10762.515686794113;10840.891591083988;11100.167487438475;11132.666020019251;15437.84562154364;15452.150131742863;15480.148591827558;15498.457553985781;15514.224288785741;7365.7790266292095;7583.393328533704;7653.387728981668;7714.961425192838;7716.112647045549;7061.9293807062295;7079.327463890922;7156.141263048467;7164.319389657974;7282.162551306562;4515.729056256635;4569.543045695404;4697.95302046982;4738.265568836836;4896.681715688469;1767.8320559546823;1833.2453720760989;2000.1399398258598;2002.909869055896;2011.3865271092166;924.5377311344328;990.7473594233425;1004.3020101029861;1015.7257540464182;1037.6108959140322;18379.90810045941;18954.81045189558;19261.422157335302;19396;19636.41090767279;930.7300882743929;988.9752756181153;1007.3049595778889;1008.3193844155165;1099.2140619457127;10504.579816807242;10887.564497420015;10940.781184376427;11032.172587056002;11042.503087361089;440865;443730;443786;453693;455621;92236.53881730548;93989;94816.52591736997;97299;98536;1032.7986042721748;1044.2846650044744;1056.867891513576;1066.2962444786403;1068.1721665709138;16409.405366497398;17078.658426831644;17129.400470983954;17357.132143392526;17567.560810979827;40532.79733601313;41093.79453102715;41734.79132604439;42013.57986420219;42364.576354237295;59456.70271648614;59610.701946491725;59693;59917.40082599118;60402.39597604144;7453.142888567667;7903.3677305816545;7919.208079192034;8067.515949043076;8576.356773241907;9148.227338272693;10357.844632330673;12082.637520874388;13299.26854023038;13370.732585348043;11214.102871770076;11227.831582526433;11358.26171298863;11364.602238921598;11475.8278625819;5767.913481297868;10465.953404659473;11376.203665743318;11934.164608477324;12054.75890482168;11333.829992550283;11460.770784584429;11492.94253528727;12112.880245956747;12212.633620991384;8062.27549663618;8237.011558613005;8267.462614930011;8319.251267385964;8476.321894248322;8525.786855328666;10431;11083.833742493707;11179.720506987065;11207 17:44:00 INFO - PROCESS | 25618 | |3;mootools.html;1410.9082909610868;1536.7771673107395;1568.6078480379906;1705.7867766529184;1841.8618603604732;8697.869531957018;9076.90923090769;9093.318001149915;9420.434773913554;9454;9084.727458176265;9332.90667093329;9335.3465257432;9337.066293370659;9341.766455838608;2037.5313677854103;2350.3654013416367;2398.9640155397637;2429.416939934412;2446.13162327373;2448.608222684371;2460.6555082288496;2468.0374653885;2476.566600844854;2478.677771889652;2366.9171578994738;2382.344855164826;2391.390195500154;2392.5932591459496;2398.244552965819;2039.694045893113;2327.3367090379247;2404.290734233405;2408.1089996701157;2422.9757702422926;2330.988345058264;2338.625819868813;2339.82451316152;2367.7040369953756;2413.3483959331056;9307.488088155149;9381.859272110923;9384.67153649619;9387.62449502019;9393.107654772853;5322.946770532284;5455.18172274158;5458.153986132156;5469.835904922858;5470.617056806025;3313.5692359993045;3350.832458377096;3410.07927859479;3418.6923176914197;3461.9826900865332;1078.735709751108;1106;1135.9375234362108;1147.1511081799492;1152.654203738875;12997.090203685746;13220.933895330558;13222.801657975138;13228.603141905854;13239.338033098404;4553.180427523078;4655.208614535537;4735.337052812609;4747.335373047776;4771;10338.638147664795;10342.844857327145;10357.274990750575;10369.444583312563;10370.118539924191;4627.097715945426;5240.633155679142;5243.8164664236565;5245.580353571705;5246.685198888079;4734.502877197913;4840.298156767249;4855.44162421319;4869.70781753096;4878.975605121952;4000.439938408625;4000.510745295211;4036.2532931407195;4071.796410179479;4071.816768245436;1160.048760016795;1162.105179012156;1188.6612315490045;1203.8374819399444;1228.416502161466;863.8488264553678;903.915301638037;944.593824655391;986.3835103060587;1060.8992145746142;6096.329403765582;6102.298235702862;6185.165002724664;6337.841553961096;6383.138276332728;958.6117622362954;966.4153187321709;990.3958585262984;997.4165113408737;1029.5881647341123;4311.33174357975;4358.629516491071;4375.956240437555;4418.160549495586;4472.306792447176;11432.657020289405;11880.524779008743;11990.760184796256;11995.160338776202;12041.819372709417;11641.010514106227;11806.704832379259;11807.586734464252;11832.290062596272;11836.585719499777;8260.586970651444;8584.270337021424;8593.183647553473;8650.697225597074;8821.470711757187;6179.84550386226;6325.4939604832425;6363.5545511813725;6440.6135631862235;6577.408033277028;10376.896231037896;10908.78182436331;10950.835737463785;11014.00873921351;11027.779444410906;10947.452627368759;11063.50214240345;11077.778444431227;11085.556577736801;11354.886451135382;7202.567845929261;7474.850502989801;7474.962625186839;8186.877196841933;8366.916330836613;8218.096009438837;8798.868016979623;9157.908420915706;9162.908370916206;9164.6792362267;7972.561509117054;8028.518288902685;8100.0279966404405;8285.088640249447;8340.249377556049;7888.566128862968;8053.718119865776;8104.392170587112;8146.185381461806;8210.58947052657;7333.926660733325;7334.156571994075;7359.521631093961;7387.445941554298;7479.289467500579;5329.09405401075;5404;5510.862228444321;5518.944810551843;5576.804811831566;5518.061929471919;5532.695701736443;5595.188697638901;5629.155626656035;5701.629394089371 17:44:00 INFO - PROCESS | 25618 | |4;prototype.html;325.54748899030335;330.9106541233867;338.0837929211835;341.0756848939374;341.17946339054583;5262.500062494067;5402.702851343174;5430.72846357682;5442.210879422486;5445.945540544593;5364.356277246726;5396.217548455472;5403.891922161564;5418.566514678826;5421.268128802611;4164.833846522978;4172.812223449952;4193.350030745224;4234.89412764681;4249.08644641402;3984.521857377119;4114.691398145151;4240.660747140221;4241.172971270604;4263.616274535291;4188.738081436021;4198.433211516452;4202.348635961415;4210.410542524049;4236.894077648052;4188.958110418903;4202.579742025803;4209.2633789086785;4216.683748718828;4216.9578304216875;3685.7051435885064;3705.6664900158844;3760.511133552648;3794.7912864792424;3802.6007269236607;5131.61512886535;5134.897302053975;5142.30578871855;5153.742312884378;5167.4057483389515;4761.262004389325;4768.26091955744;4805.37530121082;4811.759412029384;4826.975865120652;5269.341332333458;5510.476504732044;5546.77812887484;5577.386487486373;5626.409227031144;4106.938395924063;4128.112455821983;4143.047099167208;4150.107726838744;4164.500259968793;5842.561807864385;5851.619644723122;5877.588568800185;5880.294364676266;5893.322267939199;4084.101497670508;4200.256893389209;4220.2192594370135;4222.719731345101;4240.236757383639;4201.159768046342;4224.746515209097;4235.661147108224;4242;4247.214265360856;4761.761941895063;4783.784729687172;4784.258439941815;4789.95210047902;4806.759662016885;5548.667079975134;5601.5238704709745;5642;5678.829635110953;5685.800996965087;1392.9512467063807;1445.6964037552232;1460.7662773956329;1480.25247250138;1481.4666719980798;943.5470973932551;944.7779771753633;956.4213650741341;960.4429430930184;962.4658314635304;4740.3837501124635;4795.664303498722;4826.565609095198;4826.565609095198;4924.852254432301;5130.79476820923;5185.0148471790235;5190.480951904779;5205.9219111713355;5210.723372773695;4554.043650833296;4791.712497250176;4881.584340541203;4916.475892473345;4934;2703.864806759654;2730.6586676665415;2746.2036009557405;2751.834889906612;2762.668479782439;5235.377033119745;5236.869078273074;5272.604554658416;5288.2596436498925;5310.203469479609;4923.679960802608;5240.790368385298;5263.578913686896;5273.868153296122;5279.44565820591;5168.940367224785;5185.559227465632;5255.553277971415;5311.920321195263;5338.279332290246;4980.5019498049905;5008.899822003613;5018.498150185098;5135.894283343811;5201.817936372209;4707.8587642370785;4990.700557966534;4991.5258050485145;5054.444011158843;5146.8970620588125;5122.923156152586;5149.742512874416;5217;5306.575473962151;5309.469053094814;3806.8477260909253;3806.91502921666;3836.7889766063136;3844.9231015380096;3862.710296727813;4903.460619331942;4997.250412438163;5092.312537807348;5603.719814009201;5644.85887852807;5557.388687244481;5634.690092044813;5646.576506761927;5651.124075768263;5662.518685911744;5549.361823390201;5563.805266815642;5610.831675049755;5622.353429355677;5623.634463759842;5298.549623282064;5543.695096769555;5594.832155035356;5600;5604.579656525859;5689;5703.173039909107;5713.228899041311;5722.341930678025;5728.570357223141;5437.918431223614;5499.890002200013;5559.360673522435;5576.776928922797;5596.776128954796 17:44:00 INFO - PROCESS | 25618 | |5;yui.html;808.5876203136401;823.0987069159269;830.8006078541152;832.4547421438956;851.9999999999998;14888.330025148867;15875.04749715015;15899.364025438983;15917.363305467781;15925;14141.151530908128;14376.49682261121;14405.20771357575;14416.423343066292;14423.062500937433;655.8557117434157;765.0857225615392;789.1398375770424;800.4676889868231;806.0528878567688;793.9166387529312;798.2496453333847;803.9316658084041;804.3163311185504;805.1063319715112;840.0675250471971;843.3759018326425;844.2950136635916;844.3371953016883;844.4553263145268;684.9965750171242;805.5529181304373;834.7746108550688;838.6226198210769;842.2083241752733;611.0589691874508;611.6972098811073;611.7736437518103;612.1368869893473;612.4304396910871;14374.35315410809;14383.78424323636;14411.495597654137;14422.71154576913;14432.855671443256;13424.194548327034;13785.448582056706;13895.513657021957;13904.58286251414;14097;12287.508499660004;12439.689007774787;12570.371481425893;12650.620481385482;12656.303903285316;4507.797149128297;4512.593866552026;4546.090781843644;4557.567031132037;4657.580817726421;56494.43505564974;56668.149977749956;58207;58405.415945840425;58412.41587584112;10054.547545360476;10422;10447.164226861833;11123.221374503868;11223.270487418291;20001.399818023565;20236.69644955327;20241.19035238574;20244.696329555067;20257.898710506353;8304.916950830535;8545.572721363907;8596.699115530926;8755.60599772999;8762.38663293576;4470.240059189946;4481.462224533077;4582.335561343653;4626.653001024936;4629.675922685447;3320.6513316101946;3401.166714155048;3408.0968543336035;3422.8973130806116;3436.055084851686;550.8953298873201;609.7073404765737;615.8152554233712;617.2099712368176;635.0949896397707;652.9249136349381;685.2222727204659;708.5748550869437;713.0730050933869;734.4161391693616;9198.770030749285;9561.569729362196;9720.708378748648;9772.706818795448;9875.358101723365;658.9637569933603;691.882379995402;699;720.4092644031844;731.9560826350436;4319.762413067248;4405.537418571004;4410.0738844842945;4467.419235499365;4497.482789479186;71767;72212.27787722161;73466.26533734701;74692.25307746962;75197.62401188069;62069;62329.688351558856;62995;63790.043149352794;63819.680901595195;57527;57883;58228;58284.4171558279;58654.413455864895;8599.828003440021;8616.913830861862;8658.350623703122;8706.956465217634;8816.162464565856;38314;38652.85957629625;38757.41863871988;38774.2245155101;39111.804440978754;52437;52589.47410525846;52890.47109529009;53173.734131329096;53480.46519534755;11795.233309835177;12217.755644887231;12265.938670306592;12314.13801033955;12577.245365278113;12425.894479697567;12507.74984500323;12973;13106.541271055466;13473.86526134726;12332.938335308267;12437.62687119388;12451.190672606252;12504.624861254177;12714.682132946751;12362.505499779909;12409.689757756129;12468.06489513272;12691.746165076462;12759.170653907466;12286.508539658313;12346.320952347707;12442.688932776753;12514.374281286082;12662.936685316883;9842.261830362895;9890.604375825174;10108.494575271354;10268.229882758673;10385.117265032557;10689.465526723789;10780.514876830719;10781.353118812896;10845.186611004048;10851.45742712877 17:44:00 INFO - PROCESS | 25618 | __end_tp_report 17:44:00 INFO - PROCESS | 25618 | __start_cc_report 17:44:00 INFO - PROCESS | 25618 | _x_x_mozilla_cycle_collect,894 17:44:00 INFO - PROCESS | 25618 | __end_cc_report 17:44:00 INFO - PROCESS | 25618 | __startTimestamp1464309840540__endTimestamp 17:44:00 INFO - PROCESS | 25618 | 17:44:00 INFO - PROCESS | 25618 | ------- Summary: start ------- 17:44:00 INFO - PROCESS | 25618 | Number of tests: 6 17:44:00 INFO - PROCESS | 25618 | 17:44:00 INFO - PROCESS | 25618 | [#0] dojo.html Cycles:165 Average:5545.17 Median:5757.68 stddev:651.05 (11.3%) stddev-sans-first:624.70 17:44:00 INFO - PROCESS | 25618 | Values: 3122.7 3129.1 3157.2 3172.2 3183.9 5366.6 5403.6 5420.5 5491.6 5528.4 5504.6 5539.6 5572.0 5594.1 5627.7 4932.6 5019.0 5201.7 5244.6 5269.1 4961.9 5166.3 5175.5 5187.1 5259.4 5001.1 5028.2 5062.2 5070.8 5074.1 5080.1 5088.9 5091.8 5098.7 5140.9 4925.5 4953.4 5021.4 5073.8 5087.1 5450.0 5507.8 5533.9 5540.1 5556.7 5939.0 5998.3 6000.1 6001.0 6003.9 5809.9 5872.4 5901.8 5980.7 6041.0 5670.4 5691.6 5695.9 5696.4 5698.1 6158.4 6160.7 6174.4 6174.6 6178.6 5682.5 5791.8 5829.9 5843.9 5960.1 5916.5 6011.0 6023.5 6031.3 6032.3 5846.1 5909.3 5911.3 5946.0 5946.7 5766.7 5824.4 5884.2 5890.0 5938.7 4474.8 4475.4 4475.9 4484.4 4516.1 3940.7 3998.8 4003.4 4019.5 4047.2 5660.0 5714.9 5721.3 5725.9 5756.1 6089.4 6098.4 6099.9 6108.6 6137.9 5495.7 5657.1 5743.5 5744.7 5749.3 5162.7 5205.8 5209.7 5211.1 5250.4 6269.4 6275.5 6283.5 6285.4 6290.8 5857.2 5900.0 5947.9 6052.5 6073.8 6172.7 6185.1 6186.9 6194.7 6195.5 5831.8 5884.6 5899.4 5908.4 5911.5 5865.1 5900.7 5906.0 5983.1 5988.7 5826.4 5829.2 5831.0 5839.1 5873.5 5813.5 5817.2 5818.0 5832.9 5833.1 5687.2 5697.1 5697.4 5702.9 5753.1 5896.0 5902.8 5939.9 5947.0 5954.3 5743.0 5757.7 5758.5 5759.8 5762.6 17:44:00 INFO - PROCESS | 25618 | 17:44:00 INFO - PROCESS | 25618 | [#1] ext.html Cycles:180 Average:64692.00 Median:3537.66 stddev:141546.96 (4001.2%) stddev-sans-first:141862.24 17:44:00 INFO - PROCESS | 25618 | Values: 597.5 610.1 632.6 635.9 663.5 42558.8 43941.1 43960.1 48409.0 48477.0 46111.8 46814.0 46825.5 46826.3 46856.5 8121.1 8761.3 8965.4 10548.2 10835.9 10620.6 10757.7 10759.0 10765.6 10766.6 10748.4 10829.6 10832.5 10834.3 10841.0 8128.0 10455.5 10695.8 10698.9 11122.5 10633.1 10706.4 10723.6 10723.6 10732.1 42912.8 42974.4 43168.8 43371.8 43385.6 3523.5 3551.8 3571.5 3595.3 3612.2 32947.2 33235.0 33468.8 33827.7 33839.8 4092.4 4158.4 4282.5 4305.7 4309.6 342410.0 342564.3 346239.0 346568.0 346616.0 63037.4 63539.7 63839.0 64117.0 64246.4 32878.5 33346.3 33354.5 33372.3 67044.7 13740.9 14668.7 14932.1 14936.0 14946.1 10968.9 11209.2 11218.7 11462.0 11470.4 19682.2 19771.8 19888.0 19923.5 20014.4 7121.4 7243.1 7276.5 7303.9 7319.4 1002.3 1057.1 1060.8 1128.9 1148.5 32818.7 32858.0 32909.5 33175.0 33423.2 1114.8 1116.6 1127.0 1141.9 1187.7 16908.7 17256.6 17487.0 17594.4 17700.7 492272.0 789220.0 800220.0 802631.0 802665.0 60019.4 60415.7 60662.4 60736.7 60833.7 1267.9 1286.1 1298.1 1364.6 1396.5 29678.9 33293.8 34038.7 34309.0 34402.8 50332.2 50673.7 50839.5 50936.7 51016.0 392503.0 394927.0 396452.0 396976.0 396993.0 24469.6 24685.3 28587.6 28872.3 30514.8 47683.3 48451.3 48605.0 49259.8 49271.0 40770.6 40888.0 41073.4 41260.2 42448.4 40770.5 41076.4 41194.4 42074.6 42204.4 40572.0 40721.2 41359.0 41996.0 42220.8 35817.3 37552.4 37844.6 38083.2 38615.0 28482.6 28637.3 29084.6 29199.3 29403.3 17:44:00 INFO - PROCESS | 25618 | 17:44:00 INFO - PROCESS | 25618 | [#2] jquery.html Cycles:180 Average:27551.32 Median:1420.56 stddev:74171.34 (5221.3%) stddev-sans-first:74351.33 17:44:00 INFO - PROCESS | 25618 | Values: 366.4 381.8 389.5 402.6 402.7 18107.4 19850.8 20479.4 20509.4 20518.9 18897.5 18939.9 19505.5 19599.8 19677.3 5420.0 5579.3 5738.7 5803.4 5826.2 3858.4 5483.3 5742.8 5764.8 5774.4 5852.7 5867.0 5871.0 5876.9 5893.4 6405.8 6423.7 6431.3 6442.6 6446.2 5469.7 5673.6 5675.4 5737.5 5746.3 13088.1 13302.7 13371.5 13949.5 22397.7 2261.8 2370.1 2389.3 2455.6 2474.7 9628.0 9673.6 10240.4 12119.3 13732.5 1954.0 1969.2 1979.7 1998.1 2018.7 77276.2 77285.6 77634.0 79743.0 81420.0 10573.7 10762.5 10840.9 11100.2 11132.7 15437.8 15452.2 15480.1 15498.5 15514.2 7365.8 7583.4 7653.4 7715.0 7716.1 7061.9 7079.3 7156.1 7164.3 7282.2 4515.7 4569.5 4698.0 4738.3 4896.7 1767.8 1833.2 2000.1 2002.9 2011.4 924.5 990.7 1004.3 1015.7 1037.6 18379.9 18954.8 19261.4 19396.0 19636.4 930.7 989.0 1007.3 1008.3 1099.2 10504.6 10887.6 10940.8 11032.2 11042.5 440865.0 443730.0 443786.0 453693.0 455621.0 92236.5 93989.0 94816.5 97299.0 98536.0 1032.8 1044.3 1056.9 1066.3 1068.2 16409.4 17078.7 17129.4 17357.1 17567.6 40532.8 41093.8 41734.8 42013.6 42364.6 59456.7 59610.7 59693.0 59917.4 60402.4 7453.1 7903.4 7919.2 8067.5 8576.4 9148.2 10357.8 12082.6 13299.3 13370.7 11214.1 11227.8 11358.3 11364.6 11475.8 5767.9 10466.0 11376.2 11934.2 12054.8 11333.8 11460.8 11492.9 12112.9 12212.6 8062.3 8237.0 8267.5 8319.3 8476.3 8525.8 10431.0 11083.8 11179.7 11207.0 17:44:00 INFO - PROCESS | 25618 | 17:44:00 INFO - PROCESS | 25618 | [#3] mootools.html Cycles:180 Average:6085.46 Median:4734.92 stddev:3546.64 (74.9%) stddev-sans-first:3539.19 17:44:00 INFO - PROCESS | 25618 | Values: 1410.9 1536.8 1568.6 1705.8 1841.9 8697.9 9076.9 9093.3 9420.4 9454.0 9084.7 9332.9 9335.3 9337.1 9341.8 2037.5 2350.4 2399.0 2429.4 2446.1 2448.6 2460.7 2468.0 2476.6 2478.7 2366.9 2382.3 2391.4 2392.6 2398.2 2039.7 2327.3 2404.3 2408.1 2423.0 2331.0 2338.6 2339.8 2367.7 2413.3 9307.5 9381.9 9384.7 9387.6 9393.1 5322.9 5455.2 5458.2 5469.8 5470.6 3313.6 3350.8 3410.1 3418.7 3462.0 1078.7 1106.0 1135.9 1147.2 1152.7 12997.1 13220.9 13222.8 13228.6 13239.3 4553.2 4655.2 4735.3 4747.3 4771.0 10338.6 10342.8 10357.3 10369.4 10370.1 4627.1 5240.6 5243.8 5245.6 5246.7 4734.5 4840.3 4855.4 4869.7 4879.0 4000.4 4000.5 4036.3 4071.8 4071.8 1160.0 1162.1 1188.7 1203.8 1228.4 863.8 903.9 944.6 986.4 1060.9 6096.3 6102.3 6185.2 6337.8 6383.1 958.6 966.4 990.4 997.4 1029.6 4311.3 4358.6 4376.0 4418.2 4472.3 11432.7 11880.5 11990.8 11995.2 12041.8 11641.0 11806.7 11807.6 11832.3 11836.6 8260.6 8584.3 8593.2 8650.7 8821.5 6179.8 6325.5 6363.6 6440.6 6577.4 10376.9 10908.8 10950.8 11014.0 11027.8 10947.5 11063.5 11077.8 11085.6 11354.9 7202.6 7474.9 7475.0 8186.9 8366.9 8218.1 8798.9 9157.9 9162.9 9164.7 7972.6 8028.5 8100.0 8285.1 8340.2 7888.6 8053.7 8104.4 8146.2 8210.6 7333.9 7334.2 7359.5 7387.4 7479.3 5329.1 5404.0 5510.9 5518.9 5576.8 5518.1 5532.7 5595.2 5629.2 5701.6 17:44:00 INFO - PROCESS | 25618 | 17:44:00 INFO - PROCESS | 25618 | [#4] prototype.html Cycles:180 Average:4555.42 Median:5107.62 stddev:1300.04 (25.5%) stddev-sans-first:1264.33 17:44:00 INFO - PROCESS | 25618 | Values: 325.5 330.9 338.1 341.1 341.2 5262.5 5402.7 5430.7 5442.2 5445.9 5364.4 5396.2 5403.9 5418.6 5421.3 4164.8 4172.8 4193.4 4234.9 4249.1 3984.5 4114.7 4240.7 4241.2 4263.6 4188.7 4198.4 4202.3 4210.4 4236.9 4189.0 4202.6 4209.3 4216.7 4217.0 3685.7 3705.7 3760.5 3794.8 3802.6 5131.6 5134.9 5142.3 5153.7 5167.4 4761.3 4768.3 4805.4 4811.8 4827.0 5269.3 5510.5 5546.8 5577.4 5626.4 4106.9 4128.1 4143.0 4150.1 4164.5 5842.6 5851.6 5877.6 5880.3 5893.3 4084.1 4200.3 4220.2 4222.7 4240.2 4201.2 4224.7 4235.7 4242.0 4247.2 4761.8 4783.8 4784.3 4790.0 4806.8 5548.7 5601.5 5642.0 5678.8 5685.8 1393.0 1445.7 1460.8 1480.3 1481.5 943.5 944.8 956.4 960.4 962.5 4740.4 4795.7 4826.6 4826.6 4924.9 5130.8 5185.0 5190.5 5205.9 5210.7 4554.0 4791.7 4881.6 4916.5 4934.0 2703.9 2730.7 2746.2 2751.8 2762.7 5235.4 5236.9 5272.6 5288.3 5310.2 4923.7 5240.8 5263.6 5273.9 5279.4 5168.9 5185.6 5255.6 5311.9 5338.3 4980.5 5008.9 5018.5 5135.9 5201.8 4707.9 4990.7 4991.5 5054.4 5146.9 5122.9 5149.7 5217.0 5306.6 5309.5 3806.8 3806.9 3836.8 3844.9 3862.7 4903.5 4997.3 5092.3 5603.7 5644.9 5557.4 5634.7 5646.6 5651.1 5662.5 5549.4 5563.8 5610.8 5622.4 5623.6 5298.5 5543.7 5594.8 5600.0 5604.6 5689.0 5703.2 5713.2 5722.3 5728.6 5437.9 5499.9 5559.4 5576.8 5596.8 17:44:00 INFO - PROCESS | 25618 | 17:44:00 INFO - PROCESS | 25618 | [#5] yui.html Cycles:180 Average:16096.97 Median:4628.16 stddev:19699.42 (425.6%) stddev-sans-first:19721.23 17:44:00 INFO - PROCESS | 25618 | Values: 808.6 823.1 830.8 832.5 852.0 14888.3 15875.0 15899.4 15917.4 15925.0 14141.2 14376.5 14405.2 14416.4 14423.1 655.9 765.1 789.1 800.5 806.1 793.9 798.2 803.9 804.3 805.1 840.1 843.4 844.3 844.3 844.5 685.0 805.6 834.8 838.6 842.2 611.1 611.7 611.8 612.1 612.4 14374.4 14383.8 14411.5 14422.7 14432.9 13424.2 13785.4 13895.5 13904.6 14097.0 12287.5 12439.7 12570.4 12650.6 12656.3 4507.8 4512.6 4546.1 4557.6 4657.6 56494.4 56668.1 58207.0 58405.4 58412.4 10054.5 10422.0 10447.2 11123.2 11223.3 20001.4 20236.7 20241.2 20244.7 20257.9 8304.9 8545.6 8596.7 8755.6 8762.4 4470.2 4481.5 4582.3 4626.7 4629.7 3320.7 3401.2 3408.1 3422.9 3436.1 550.9 609.7 615.8 617.2 635.1 652.9 685.2 708.6 713.1 734.4 9198.8 9561.6 9720.7 9772.7 9875.4 659.0 691.9 699.0 720.4 732.0 4319.8 4405.5 4410.1 4467.4 4497.5 71767.0 72212.3 73466.3 74692.3 75197.6 62069.0 62329.7 62995.0 63790.0 63819.7 57527.0 57883.0 58228.0 58284.4 58654.4 8599.8 8616.9 8658.4 8707.0 8816.2 38314.0 38652.9 38757.4 38774.2 39111.8 52437.0 52589.5 52890.5 53173.7 53480.5 11795.2 12217.8 12265.9 12314.1 12577.2 12425.9 12507.7 12973.0 13106.5 13473.9 12332.9 12437.6 12451.2 12504.6 12714.7 12362.5 12409.7 12468.1 12691.7 12759.2 12286.5 12346.3 12442.7 12514.4 12662.9 9842.3 9890.6 10108.5 10268.2 10385.1 10689.5 10780.5 10781.4 10845.2 10851.5 17:44:00 INFO - PROCESS | 25618 | -------- Summary: end -------- 17:44:00 INFO - PROCESS | 25618 | 17:44:01 INFO - TEST-INFO | 25618: exit 0 17:44:01 INFO - TEST-OK | dromaeo_css | took 1112579ms 17:44:01 INFO - TEST-START | kraken 17:44:01 INFO - operating with platform_type : linux_ 17:44:01 INFO - Initialising browser for kraken test... 17:44:01 INFO - TEST-INFO | started process 25801 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpilHGUy/profile http://localhost:39014/getInfo.html) 17:44:05 INFO - PROCESS | 25801 | __metrics Screen width/height:1600/1200 17:44:05 INFO - PROCESS | 25801 | colorDepth:24 17:44:05 INFO - PROCESS | 25801 | Browser inner width/height: 1024/697 17:44:05 INFO - PROCESS | 25801 | __metrics 17:44:06 ERROR - PROCESS | 25801 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:44:06 INFO - TEST-INFO | 25801: exit 0 17:44:06 INFO - Browser initialized. 17:44:06 INFO - Running cycle 1/1 for kraken test... 17:44:06 INFO - TEST-INFO | started process 25883 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpilHGUy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:44:18 INFO - PROCESS | 25883 | RSS: Main: 155295744 17:44:18 INFO - PROCESS | 25883 | 17:44:21 INFO - PROCESS | 25883 | Cycle 1(1): loaded http://localhost:39014/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39014/tests/kraken/driver.html?testName=audio-beat-detection) 17:44:22 INFO - PROCESS | 25883 | RSS: Main: 211742720 17:44:22 INFO - PROCESS | 25883 | 17:44:24 INFO - PROCESS | 25883 | Cycle 1(1): loaded http://localhost:39014/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39014/tests/kraken/driver.html?testName=audio-dft) 17:44:25 INFO - PROCESS | 25883 | RSS: Main: 199852032 17:44:25 INFO - PROCESS | 25883 | 17:44:28 INFO - PROCESS | 25883 | Cycle 1(1): loaded http://localhost:39014/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39014/tests/kraken/driver.html?testName=audio-fft) 17:44:29 INFO - PROCESS | 25883 | RSS: Main: 268152832 17:44:29 INFO - PROCESS | 25883 | 17:44:31 INFO - PROCESS | 25883 | Cycle 1(1): loaded http://localhost:39014/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39014/tests/kraken/driver.html?testName=audio-oscillator) 17:44:31 INFO - PROCESS | 25883 | RSS: Main: 177700864 17:44:31 INFO - PROCESS | 25883 | 17:44:33 INFO - PROCESS | 25883 | Cycle 1(1): loaded http://localhost:39014/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39014/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:44:34 INFO - PROCESS | 25883 | RSS: Main: 181772288 17:44:34 INFO - PROCESS | 25883 | 17:44:37 INFO - PROCESS | 25883 | Cycle 1(1): loaded http://localhost:39014/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39014/tests/kraken/driver.html?testName=imaging-darkroom) 17:44:38 INFO - PROCESS | 25883 | RSS: Main: 217698304 17:44:38 INFO - PROCESS | 25883 | 17:44:41 INFO - PROCESS | 25883 | Cycle 1(1): loaded http://localhost:39014/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39014/tests/kraken/driver.html?testName=imaging-desaturate) 17:44:42 INFO - PROCESS | 25883 | RSS: Main: 218091520 17:44:42 INFO - PROCESS | 25883 | 17:44:44 INFO - PROCESS | 25883 | Cycle 1(1): loaded http://localhost:39014/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39014/tests/kraken/driver.html?testName=json-parse-financial) 17:44:45 INFO - PROCESS | 25883 | RSS: Main: 218816512 17:44:45 INFO - PROCESS | 25883 | 17:44:47 INFO - PROCESS | 25883 | Cycle 1(1): loaded http://localhost:39014/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39014/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:44:47 INFO - PROCESS | 25883 | RSS: Main: 204935168 17:44:47 INFO - PROCESS | 25883 | 17:44:49 INFO - PROCESS | 25883 | Cycle 1(1): loaded http://localhost:39014/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39014/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:44:49 INFO - PROCESS | 25883 | RSS: Main: 209367040 17:44:49 INFO - PROCESS | 25883 | 17:44:51 INFO - PROCESS | 25883 | Cycle 1(1): loaded http://localhost:39014/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39014/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:44:52 INFO - PROCESS | 25883 | RSS: Main: 219713536 17:44:52 INFO - PROCESS | 25883 | 17:44:55 INFO - PROCESS | 25883 | Cycle 1(1): loaded http://localhost:39014/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39014/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:44:55 INFO - PROCESS | 25883 | RSS: Main: 225996800 17:44:55 INFO - PROCESS | 25883 | 17:44:58 INFO - PROCESS | 25883 | Cycle 1(1): loaded http://localhost:39014/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39014/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:44:59 INFO - PROCESS | 25883 | RSS: Main: 224600064 17:44:59 INFO - PROCESS | 25883 | 17:45:00 INFO - PROCESS | 25883 | Cycle 1(1): loaded http://localhost:39014/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39014/tests/kraken/driver.html?testName=ai-astar) 17:45:01 INFO - PROCESS | 25883 | RSS: Main: 270077952 17:45:01 INFO - PROCESS | 25883 | 17:45:01 INFO - PROCESS | 25883 | __start_tp_report 17:45:01 INFO - PROCESS | 25883 | _x_x_mozilla_page_load 17:45:01 INFO - PROCESS | 25883 | _x_x_mozilla_page_load_details 17:45:01 INFO - PROCESS | 25883 | |i|pagename|runs| 17:45:01 INFO - PROCESS | 25883 | |0;ai-astar;112;107;111;110;110;112;111;110;110;110 17:45:01 INFO - PROCESS | 25883 | |1;audio-beat-detection;158;130;134;175;127;155;156;126;177;126 17:45:01 INFO - PROCESS | 25883 | |2;audio-dft;161;161;160;160;160;160;162;161;162;161 17:45:01 INFO - PROCESS | 25883 | |3;audio-fft;75;75;73;112;75;74;75;74;96;74 17:45:01 INFO - PROCESS | 25883 | |4;audio-oscillator;84;83;120;85;83;83;122;83;84;122 17:45:01 INFO - PROCESS | 25883 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;116;117;116 17:45:01 INFO - PROCESS | 25883 | |6;imaging-darkroom;145;146;146;145;146;145;145;145;145;145 17:45:01 INFO - PROCESS | 25883 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 17:45:01 INFO - PROCESS | 25883 | |8;json-parse-financial;55;57;58;55;56;64;55;76;54;52 17:45:01 INFO - PROCESS | 25883 | |9;json-stringify-tinderbox;62;61;61;61;61;61;61;61;62;65 17:45:01 INFO - PROCESS | 25883 | |10;stanford-crypto-aes;78;78;80;77;85;80;80;79;79;84 17:45:01 INFO - PROCESS | 25883 | |11;stanford-crypto-ccm;129;124;119;124;125;124;117;117;164;124 17:45:01 INFO - PROCESS | 25883 | |12;stanford-crypto-pbkdf2;161;160;163;156;156;157;160;162;162;157 17:45:01 INFO - PROCESS | 25883 | |13;stanford-crypto-sha256-iterative;62;62;62;62;61;62;62;60;62;63 17:45:01 INFO - PROCESS | 25883 | __end_tp_report 17:45:01 INFO - PROCESS | 25883 | __start_cc_report 17:45:01 INFO - PROCESS | 25883 | _x_x_mozilla_cycle_collect,1643 17:45:01 INFO - PROCESS | 25883 | __end_cc_report 17:45:01 INFO - PROCESS | 25883 | __startTimestamp1464309901058__endTimestamp 17:45:01 INFO - PROCESS | 25883 | 17:45:01 INFO - PROCESS | 25883 | ------- Summary: start ------- 17:45:01 INFO - PROCESS | 25883 | Number of tests: 14 17:45:01 INFO - PROCESS | 25883 | 17:45:01 INFO - PROCESS | 25883 | [#0] ai-astar Cycles:10 Average:110.30 Median:110.50 stddev:1.42 (1.3%) stddev-sans-first:1.36 17:45:01 INFO - PROCESS | 25883 | Values: 112.0 107.0 111.0 110.0 110.0 112.0 111.0 110.0 110.0 110.0 17:45:01 INFO - PROCESS | 25883 | 17:45:01 INFO - PROCESS | 25883 | [#1] audio-beat-detection Cycles:10 Average:146.40 Median:155.50 stddev:20.24 (13.0%) stddev-sans-first:21.03 17:45:01 INFO - PROCESS | 25883 | Values: 158.0 130.0 134.0 175.0 127.0 155.0 156.0 126.0 177.0 126.0 17:45:01 INFO - PROCESS | 25883 | 17:45:01 INFO - PROCESS | 25883 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 17:45:01 INFO - PROCESS | 25883 | Values: 161.0 161.0 160.0 160.0 160.0 160.0 162.0 161.0 162.0 161.0 17:45:01 INFO - PROCESS | 25883 | 17:45:01 INFO - PROCESS | 25883 | [#3] audio-fft Cycles:10 Average:80.30 Median:75.00 stddev:13.06 (17.4%) stddev-sans-first:13.72 17:45:01 INFO - PROCESS | 25883 | Values: 75.0 75.0 73.0 112.0 75.0 74.0 75.0 74.0 96.0 74.0 17:45:01 INFO - PROCESS | 25883 | 17:45:01 INFO - PROCESS | 25883 | [#4] audio-oscillator Cycles:10 Average:94.90 Median:83.00 stddev:18.26 (22.0%) stddev-sans-first:18.94 17:45:01 INFO - PROCESS | 25883 | Values: 84.0 83.0 120.0 85.0 83.0 83.0 122.0 83.0 84.0 122.0 17:45:01 INFO - PROCESS | 25883 | 17:45:01 INFO - PROCESS | 25883 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 17:45:01 INFO - PROCESS | 25883 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 17:45:01 INFO - PROCESS | 25883 | 17:45:01 INFO - PROCESS | 25883 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 17:45:01 INFO - PROCESS | 25883 | Values: 145.0 146.0 146.0 145.0 146.0 145.0 145.0 145.0 145.0 145.0 17:45:01 INFO - PROCESS | 25883 | 17:45:01 INFO - PROCESS | 25883 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 17:45:01 INFO - PROCESS | 25883 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 17:45:01 INFO - PROCESS | 25883 | 17:45:01 INFO - PROCESS | 25883 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:56.50 stddev:7.02 (12.4%) stddev-sans-first:7.35 17:45:01 INFO - PROCESS | 25883 | Values: 55.0 57.0 58.0 55.0 56.0 64.0 55.0 76.0 54.0 52.0 17:45:01 INFO - PROCESS | 25883 | 17:45:01 INFO - PROCESS | 25883 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:61.00 stddev:1.26 (2.1%) stddev-sans-first:1.33 17:45:01 INFO - PROCESS | 25883 | Values: 62.0 61.0 61.0 61.0 61.0 61.0 61.0 61.0 62.0 65.0 17:45:01 INFO - PROCESS | 25883 | 17:45:01 INFO - PROCESS | 25883 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:80.00 stddev:2.58 (3.2%) stddev-sans-first:2.64 17:45:01 INFO - PROCESS | 25883 | Values: 78.0 78.0 80.0 77.0 85.0 80.0 80.0 79.0 79.0 84.0 17:45:01 INFO - PROCESS | 25883 | 17:45:01 INFO - PROCESS | 25883 | [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:124.00 stddev:13.65 (11.0%) stddev-sans-first:14.45 17:45:01 INFO - PROCESS | 25883 | Values: 129.0 124.0 119.0 124.0 125.0 124.0 117.0 117.0 164.0 124.0 17:45:01 INFO - PROCESS | 25883 | 17:45:01 INFO - PROCESS | 25883 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.40 Median:160.50 stddev:2.67 (1.7%) stddev-sans-first:2.77 17:45:01 INFO - PROCESS | 25883 | Values: 161.0 160.0 163.0 156.0 156.0 157.0 160.0 162.0 162.0 157.0 17:45:01 INFO - PROCESS | 25883 | 17:45:01 INFO - PROCESS | 25883 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.80 Median:62.00 stddev:0.79 (1.3%) stddev-sans-first:0.83 17:45:01 INFO - PROCESS | 25883 | Values: 62.0 62.0 62.0 62.0 61.0 62.0 62.0 60.0 62.0 63.0 17:45:01 INFO - PROCESS | 25883 | -------- Summary: end -------- 17:45:01 INFO - PROCESS | 25883 | 17:45:01 INFO - TEST-INFO | 25883: exit 0 17:45:02 INFO - TEST-OK | kraken | took 60753ms 17:45:02 INFO - SUITE-END | took 1173s 17:45:02 INFO - Completed test suite (00:19:33) 17:45:02 INFO - javascript benchmark 17:45:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3122.7033431823975, 3129.1394866411747, 3157.2264795125197, 3172.2228054126745, 3183.8726450941963, 5366.570674346052, 5403.621746477748, 5420.5392541633955, 5491.560675145989, 5528.391876893544, 5504.559635229182, 5539.612227144092, 5571.9721401392935, 5594.13290939904, 5627.6904770237625, 4932.63005274605, 5019.0, 5201.739913004353, 5244.554212891909, 5269.077911365515, 4961.875953101166, 5166.328377310963, 5175.534201921826, 5187.092258854705, 5259.368875734917, 5001.1248031594505, 5028.170351891933, 5062.164742817467, 5070.847874563769, 5074.13739664258, 5080.110980578384, 5088.92366614501, 5091.7963281469065, 5098.6685865419, 5140.922886156711, 4925.532074452921, 4953.405591329028, 5021.39743230811, 5073.771680274396, 5087.109755792759, 5450.018996580614, 5507.807226747044, 5533.861653458655, 5540.141278101901, 5556.722163891789, 5938.970305148489, 5998.28020637522, 6000.069989151689, 6000.969995149996, 6003.909941350883, 5809.88380232393, 5872.412758724136, 5901.763929442817, 5980.730867110947, 6040.969795150996, 5670.404607516192, 5691.573132015033, 5695.943040569624, 5696.401877802854, 5698.088305871082, 6158.353372895871, 6160.691965401712, 6174.351693072163, 6174.598651087665, 6178.567500274938, 5682.54539636828, 5791.797287095016, 5829.854253643608, 5843.883122337529, 5960.135780311917, 5916.467517923407, 6011.0, 6023.548233882477, 6031.276246850406, 6032.276126864805, 5846.093855452412, 5909.2908850938165, 5911.349751527328, 5945.9891818390115, 5946.70266486674, 5766.711664416763, 5824.446677565625, 5884.205632239678, 5890.028145356054, 5938.732757025944, 4474.798634061475, 4475.373447717322, 4475.910481790346, 4484.372187893698, 4516.119356725473, 3940.704447166474, 3998.7800670962793, 4003.4195041718785, 4019.4774679291504, 4047.2310261050307, 5659.971700141473, 5714.914276285859, 5721.284839395075, 5725.8568535786935, 5756.107803290497, 6089.391060893875, 6098.360004765077, 6099.884870379942, 6108.6164113122, 6137.895178867758, 5495.697736624524, 5657.12314591239, 5743.4543718346695, 5744.741486633112, 5749.252597162425, 5162.6902385856965, 5205.843824685266, 5209.661372010807, 5211.140161873324, 5250.448702886142, 6269.404406581368, 6275.466585340206, 6283.5287353448675, 6285.402886725754, 6290.811275661646, 5857.150713146655, 5899.970500147472, 5947.91078133837, 6052.515798736179, 6073.757049717962, 6172.722227499684, 6185.072239164161, 6186.876262474815, 6194.721237544231, 6195.535334849814, 5831.7667293307795, 5884.598036154105, 5899.380565040609, 5908.438698323653, 5911.527077833849, 5865.090910908816, 5900.70496475166, 5905.970470147622, 5983.102534619842, 5988.6706231157705, 5826.359100499027, 5829.213056237354, 5831.0378787499585, 5839.124131380327, 5873.500752436091, 5813.476787089182, 5817.214676018683, 5818.040023396092, 5832.94167058324, 5833.095870140135, 5687.203791469115, 5697.116946873241, 5697.373288938131, 5702.885942281048, 5753.079507278815, 5895.970520147372, 5902.793402231073, 5939.881202376015, 5947.018741907536, 5954.345022047658, 5743.0, 5757.683327417032, 5758.481736643722, 5759.769609215585, 5762.596618236683], "value": 5499.2276895352215, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.5070566782402, 610.1336102734118, 632.5698525002997, 635.9014352775322, 663.4526515624611, 42558.787206063964, 43941.12117757643, 43960.120797584066, 48409.0, 48477.0, 46111.76944115283, 46814.0, 46825.53174468254, 46826.29760553595, 46856.53143468573, 8121.066077401086, 8761.342899282563, 8965.417247878899, 10548.208884333668, 10835.891641083606, 10620.628278010272, 10757.677269681923, 10759.0, 10765.569377224941, 10766.623168189115, 10748.408837513934, 10829.620963266287, 10832.458377081115, 10834.295770774874, 10841.024307812295, 8128.0, 10455.4772261387, 10695.786084278348, 10698.893011069946, 11122.49948752308, 10633.149348052137, 10706.41114738689, 10723.624673136403, 10723.62467313648, 10732.087772539344, 42912.78543607293, 42974.35538466925, 43168.78415607902, 43371.783141084095, 43385.56614433847, 3523.4714792781033, 3551.8401671924826, 3571.4642803579413, 3595.280943811248, 3612.205314830733, 32947.176320591934, 33235.0, 33468.832655836806, 33827.6617233827, 33839.83080084608, 4092.386142078682, 4158.355454904495, 4282.464691913511, 4305.720128191658, 4309.612134907842, 342410.0, 342564.287178565, 346239.0, 346567.9999999975, 346616.0, 63037.36962630407, 63539.6823015882, 63839.0, 64117.0, 64246.35753642497, 32878.506822397685, 33346.3330733384, 33354.49968250478, 33372.332553348795, 67044.66477667581, 13740.93129534346, 14668.706625867637, 14932.104073755609, 14936.0, 14946.103233806007, 10968.945155274172, 11209.159313051554, 11218.66344009681, 11462.025727813229, 11470.426478676032, 19682.212711491666, 19771.802281977285, 19888.005599719956, 19923.501912452015, 20014.399568012985, 7121.359077683033, 7243.0946131733535, 7276.490645654859, 7303.853922921512, 7319.377852882458, 1002.3084071990303, 1057.1384321777728, 1060.8143574874366, 1128.9266197697123, 1148.5463242019355, 32818.67181328204, 32858.0, 32909.50635740466, 33175.0, 33423.16442088919, 1114.7826173896012, 1116.6482557994207, 1127.0420142878652, 1141.937193454368, 1187.6674531131298, 16908.746368804477, 17256.568585785455, 17487.0, 17594.372988751773, 17700.734488982675, 492272.0, 789220.0, 800220.0, 802631.0, 802665.0, 60019.39980600226, 60415.69792151011, 60662.39337606567, 60736.69631651902, 60833.69583152144, 1267.9112462127562, 1286.12543470441, 1298.1432254712033, 1364.6179069860455, 1396.4693416501664, 29678.851605741835, 33293.83353083219, 34038.65961340454, 34309.0, 34402.82798585991, 50332.24501632552, 50673.74663126661, 50839.49160508347, 50936.74531627318, 51016.0, 392503.0, 394927.0, 396452.0, 396976.0, 396993.0, 24469.632955506037, 24685.259442216764, 28587.571186431804, 28872.2781930445, 30514.847425762728, 47683.284750728075, 48451.27323090086, 48605.0, 49259.75370123127, 49271.0, 40770.592294076676, 40888.0, 41073.38389924094, 41260.1747965045, 42448.36327455152, 40770.5152433238, 41076.383854242806, 41194.38208426936, 42074.57925420706, 42204.366934495396, 40572.0, 40721.18557628772, 41359.0, 41996.0, 42220.788896055325, 35817.283654326246, 37552.43671344878, 37844.62155378411, 38083.23833523369, 38615.0, 28482.57276140818, 28637.28406789847, 29084.56373154362, 29199.270018248862, 29403.264918377212], "value": 20627.086312788353, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.40459253712714, 381.8377189694379, 389.5131086142321, 402.55316598575575, 402.71608515996223, 18107.366242181528, 19850.801491985076, 20479.385618431454, 20509.38471845847, 20518.89740551297, 18897.527561810926, 18939.905300473478, 19505.51236219095, 19599.804001959976, 19677.311294104707, 5420.0, 5579.302587176603, 5738.684372359518, 5803.390643982384, 5826.242588463494, 3858.3633700439395, 5483.287172667548, 5742.770289188427, 5764.827055188351, 5774.422557744234, 5852.707364631751, 5867.031939729939, 5871.031279838821, 5876.882462350772, 5893.410658934094, 6405.775797847076, 6423.678816059179, 6431.324710905358, 6442.613443193423, 6446.194225721785, 5469.699166545838, 5673.553243922774, 5675.41088495222, 5737.454941780524, 5746.339170995348, 13088.083834131614, 13302.733945321039, 13371.53199638008, 13949.511767088103, 22397.66403503949, 2261.7512073671883, 2370.111208296889, 2389.2712722619594, 2455.6193789962585, 2474.715407728116, 9628.0, 9673.564689588915, 10240.385576865412, 12119.272843629411, 13732.519361822388, 1954.042519165613, 1969.2123150739676, 1979.7129416234566, 1998.1308130962932, 2018.6770116781245, 77276.22723772803, 77285.61357193234, 77634.0, 79742.99999999942, 81420.0, 10573.682789516326, 10762.515686794113, 10840.891591083988, 11100.167487438475, 11132.666020019251, 15437.84562154364, 15452.150131742863, 15480.148591827558, 15498.457553985781, 15514.224288785741, 7365.7790266292095, 7583.393328533704, 7653.387728981668, 7714.961425192838, 7716.112647045549, 7061.9293807062295, 7079.327463890922, 7156.141263048467, 7164.319389657974, 7282.162551306562, 4515.729056256635, 4569.543045695404, 4697.95302046982, 4738.265568836836, 4896.681715688469, 1767.8320559546823, 1833.2453720760989, 2000.1399398258598, 2002.909869055896, 2011.3865271092166, 924.5377311344328, 990.7473594233425, 1004.3020101029861, 1015.7257540464182, 1037.6108959140322, 18379.90810045941, 18954.81045189558, 19261.422157335302, 19396.0, 19636.41090767279, 930.7300882743929, 988.9752756181153, 1007.3049595778889, 1008.3193844155165, 1099.2140619457127, 10504.579816807242, 10887.564497420015, 10940.781184376427, 11032.172587056002, 11042.503087361089, 440865.0, 443730.0, 443786.0, 453693.0, 455621.0, 92236.53881730548, 93989.0, 94816.52591736997, 97299.0, 98536.0, 1032.7986042721748, 1044.2846650044744, 1056.867891513576, 1066.2962444786403, 1068.1721665709138, 16409.405366497398, 17078.658426831644, 17129.400470983954, 17357.132143392526, 17567.560810979827, 40532.79733601313, 41093.79453102715, 41734.79132604439, 42013.57986420219, 42364.576354237295, 59456.70271648614, 59610.701946491725, 59693.0, 59917.40082599118, 60402.39597604144, 7453.142888567667, 7903.3677305816545, 7919.208079192034, 8067.515949043076, 8576.356773241907, 9148.227338272693, 10357.844632330673, 12082.637520874388, 13299.26854023038, 13370.732585348043, 11214.102871770076, 11227.831582526433, 11358.26171298863, 11364.602238921598, 11475.8278625819, 5767.913481297868, 10465.953404659473, 11376.203665743318, 11934.164608477324, 12054.75890482168, 11333.829992550283, 11460.770784584429, 11492.94253528727, 12112.880245956747, 12212.633620991384, 8062.27549663618, 8237.011558613005, 8267.462614930011, 8319.251267385964, 8476.321894248322, 8525.786855328666, 10431.0, 11083.833742493707, 11179.720506987065, 11207.0], "value": 8996.200732220062, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1410.9082909610868, 1536.7771673107395, 1568.6078480379906, 1705.7867766529184, 1841.8618603604732, 8697.869531957018, 9076.90923090769, 9093.318001149915, 9420.434773913554, 9454.0, 9084.727458176265, 9332.90667093329, 9335.3465257432, 9337.066293370659, 9341.766455838608, 2037.5313677854103, 2350.3654013416367, 2398.9640155397637, 2429.416939934412, 2446.13162327373, 2448.608222684371, 2460.6555082288496, 2468.0374653885, 2476.566600844854, 2478.677771889652, 2366.9171578994738, 2382.344855164826, 2391.390195500154, 2392.5932591459496, 2398.244552965819, 2039.694045893113, 2327.3367090379247, 2404.290734233405, 2408.1089996701157, 2422.9757702422926, 2330.988345058264, 2338.625819868813, 2339.82451316152, 2367.7040369953756, 2413.3483959331056, 9307.488088155149, 9381.859272110923, 9384.67153649619, 9387.62449502019, 9393.107654772853, 5322.946770532284, 5455.18172274158, 5458.153986132156, 5469.835904922858, 5470.617056806025, 3313.5692359993045, 3350.832458377096, 3410.07927859479, 3418.6923176914197, 3461.9826900865332, 1078.735709751108, 1106.0, 1135.9375234362108, 1147.1511081799492, 1152.654203738875, 12997.090203685746, 13220.933895330558, 13222.801657975138, 13228.603141905854, 13239.338033098404, 4553.180427523078, 4655.208614535537, 4735.337052812609, 4747.335373047776, 4771.0, 10338.638147664795, 10342.844857327145, 10357.274990750575, 10369.444583312563, 10370.118539924191, 4627.097715945426, 5240.633155679142, 5243.8164664236565, 5245.580353571705, 5246.685198888079, 4734.502877197913, 4840.298156767249, 4855.44162421319, 4869.70781753096, 4878.975605121952, 4000.439938408625, 4000.510745295211, 4036.2532931407195, 4071.796410179479, 4071.816768245436, 1160.048760016795, 1162.105179012156, 1188.6612315490045, 1203.8374819399444, 1228.416502161466, 863.8488264553678, 903.915301638037, 944.593824655391, 986.3835103060587, 1060.8992145746142, 6096.329403765582, 6102.298235702862, 6185.165002724664, 6337.841553961096, 6383.138276332728, 958.6117622362954, 966.4153187321709, 990.3958585262984, 997.4165113408737, 1029.5881647341123, 4311.33174357975, 4358.629516491071, 4375.956240437555, 4418.160549495586, 4472.306792447176, 11432.657020289405, 11880.524779008743, 11990.760184796256, 11995.160338776202, 12041.819372709417, 11641.010514106227, 11806.704832379259, 11807.586734464252, 11832.290062596272, 11836.585719499777, 8260.586970651444, 8584.270337021424, 8593.183647553473, 8650.697225597074, 8821.470711757187, 6179.84550386226, 6325.4939604832425, 6363.5545511813725, 6440.6135631862235, 6577.408033277028, 10376.896231037896, 10908.78182436331, 10950.835737463785, 11014.00873921351, 11027.779444410906, 10947.452627368759, 11063.50214240345, 11077.778444431227, 11085.556577736801, 11354.886451135382, 7202.567845929261, 7474.850502989801, 7474.962625186839, 8186.877196841933, 8366.916330836613, 8218.096009438837, 8798.868016979623, 9157.908420915706, 9162.908370916206, 9164.6792362267, 7972.561509117054, 8028.518288902685, 8100.0279966404405, 8285.088640249447, 8340.249377556049, 7888.566128862968, 8053.718119865776, 8104.392170587112, 8146.185381461806, 8210.58947052657, 7333.926660733325, 7334.156571994075, 7359.521631093961, 7387.445941554298, 7479.289467500579, 5329.09405401075, 5404.0, 5510.862228444321, 5518.944810551843, 5576.804811831566, 5518.061929471919, 5532.695701736443, 5595.188697638901, 5629.155626656035, 5701.629394089371], "value": 4813.405247424527, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.54748899030335, 330.9106541233867, 338.0837929211835, 341.0756848939374, 341.17946339054583, 5262.500062494067, 5402.702851343174, 5430.72846357682, 5442.210879422486, 5445.945540544593, 5364.356277246726, 5396.217548455472, 5403.891922161564, 5418.566514678826, 5421.268128802611, 4164.833846522978, 4172.812223449952, 4193.350030745224, 4234.89412764681, 4249.08644641402, 3984.521857377119, 4114.691398145151, 4240.660747140221, 4241.172971270604, 4263.616274535291, 4188.738081436021, 4198.433211516452, 4202.348635961415, 4210.410542524049, 4236.894077648052, 4188.958110418903, 4202.579742025803, 4209.2633789086785, 4216.683748718828, 4216.9578304216875, 3685.7051435885064, 3705.6664900158844, 3760.511133552648, 3794.7912864792424, 3802.6007269236607, 5131.61512886535, 5134.897302053975, 5142.30578871855, 5153.742312884378, 5167.4057483389515, 4761.262004389325, 4768.26091955744, 4805.37530121082, 4811.759412029384, 4826.975865120652, 5269.341332333458, 5510.476504732044, 5546.77812887484, 5577.386487486373, 5626.409227031144, 4106.938395924063, 4128.112455821983, 4143.047099167208, 4150.107726838744, 4164.500259968793, 5842.561807864385, 5851.619644723122, 5877.588568800185, 5880.294364676266, 5893.322267939199, 4084.101497670508, 4200.256893389209, 4220.2192594370135, 4222.719731345101, 4240.236757383639, 4201.159768046342, 4224.746515209097, 4235.661147108224, 4242.0, 4247.214265360856, 4761.761941895063, 4783.784729687172, 4784.258439941815, 4789.95210047902, 4806.759662016885, 5548.667079975134, 5601.5238704709745, 5642.0, 5678.829635110953, 5685.800996965087, 1392.9512467063807, 1445.6964037552232, 1460.7662773956329, 1480.25247250138, 1481.4666719980798, 943.5470973932551, 944.7779771753633, 956.4213650741341, 960.4429430930184, 962.4658314635304, 4740.3837501124635, 4795.664303498722, 4826.565609095198, 4826.565609095198, 4924.852254432301, 5130.79476820923, 5185.0148471790235, 5190.480951904779, 5205.9219111713355, 5210.723372773695, 4554.043650833296, 4791.712497250176, 4881.584340541203, 4916.475892473345, 4934.0, 2703.864806759654, 2730.6586676665415, 2746.2036009557405, 2751.834889906612, 2762.668479782439, 5235.377033119745, 5236.869078273074, 5272.604554658416, 5288.2596436498925, 5310.203469479609, 4923.679960802608, 5240.790368385298, 5263.578913686896, 5273.868153296122, 5279.44565820591, 5168.940367224785, 5185.559227465632, 5255.553277971415, 5311.920321195263, 5338.279332290246, 4980.5019498049905, 5008.899822003613, 5018.498150185098, 5135.894283343811, 5201.817936372209, 4707.8587642370785, 4990.700557966534, 4991.5258050485145, 5054.444011158843, 5146.8970620588125, 5122.923156152586, 5149.742512874416, 5217.0, 5306.575473962151, 5309.469053094814, 3806.8477260909253, 3806.91502921666, 3836.7889766063136, 3844.9231015380096, 3862.710296727813, 4903.460619331942, 4997.250412438163, 5092.312537807348, 5603.719814009201, 5644.85887852807, 5557.388687244481, 5634.690092044813, 5646.576506761927, 5651.124075768263, 5662.518685911744, 5549.361823390201, 5563.805266815642, 5610.831675049755, 5622.353429355677, 5623.634463759842, 5298.549623282064, 5543.695096769555, 5594.832155035356, 5600.0, 5604.579656525859, 5689.0, 5703.173039909107, 5713.228899041311, 5722.341930678025, 5728.570357223141, 5437.918431223614, 5499.890002200013, 5559.360673522435, 5576.776928922797, 5596.776128954796], "value": 4146.381177151087, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [808.5876203136401, 823.0987069159269, 830.8006078541152, 832.4547421438956, 851.9999999999998, 14888.330025148867, 15875.04749715015, 15899.364025438983, 15917.363305467781, 15925.0, 14141.151530908128, 14376.49682261121, 14405.20771357575, 14416.423343066292, 14423.062500937433, 655.8557117434157, 765.0857225615392, 789.1398375770424, 800.4676889868231, 806.0528878567688, 793.9166387529312, 798.2496453333847, 803.9316658084041, 804.3163311185504, 805.1063319715112, 840.0675250471971, 843.3759018326425, 844.2950136635916, 844.3371953016883, 844.4553263145268, 684.9965750171242, 805.5529181304373, 834.7746108550688, 838.6226198210769, 842.2083241752733, 611.0589691874508, 611.6972098811073, 611.7736437518103, 612.1368869893473, 612.4304396910871, 14374.35315410809, 14383.78424323636, 14411.495597654137, 14422.71154576913, 14432.855671443256, 13424.194548327034, 13785.448582056706, 13895.513657021957, 13904.58286251414, 14097.0, 12287.508499660004, 12439.689007774787, 12570.371481425893, 12650.620481385482, 12656.303903285316, 4507.797149128297, 4512.593866552026, 4546.090781843644, 4557.567031132037, 4657.580817726421, 56494.43505564974, 56668.149977749956, 58207.0, 58405.415945840425, 58412.41587584112, 10054.547545360476, 10422.0, 10447.164226861833, 11123.221374503868, 11223.270487418291, 20001.399818023565, 20236.69644955327, 20241.19035238574, 20244.696329555067, 20257.898710506353, 8304.916950830535, 8545.572721363907, 8596.699115530926, 8755.60599772999, 8762.38663293576, 4470.240059189946, 4481.462224533077, 4582.335561343653, 4626.653001024936, 4629.675922685447, 3320.6513316101946, 3401.166714155048, 3408.0968543336035, 3422.8973130806116, 3436.055084851686, 550.8953298873201, 609.7073404765737, 615.8152554233712, 617.2099712368176, 635.0949896397707, 652.9249136349381, 685.2222727204659, 708.5748550869437, 713.0730050933869, 734.4161391693616, 9198.770030749285, 9561.569729362196, 9720.708378748648, 9772.706818795448, 9875.358101723365, 658.9637569933603, 691.882379995402, 699.0, 720.4092644031844, 731.9560826350436, 4319.762413067248, 4405.537418571004, 4410.0738844842945, 4467.419235499365, 4497.482789479186, 71767.0, 72212.27787722161, 73466.26533734701, 74692.25307746962, 75197.62401188069, 62069.0, 62329.688351558856, 62995.0, 63790.043149352794, 63819.680901595195, 57527.0, 57883.0, 58228.0, 58284.4171558279, 58654.413455864895, 8599.828003440021, 8616.913830861862, 8658.350623703122, 8706.956465217634, 8816.162464565856, 38314.0, 38652.85957629625, 38757.41863871988, 38774.2245155101, 39111.804440978754, 52437.0, 52589.47410525846, 52890.47109529009, 53173.734131329096, 53480.46519534755, 11795.233309835177, 12217.755644887231, 12265.938670306592, 12314.13801033955, 12577.245365278113, 12425.894479697567, 12507.74984500323, 12973.0, 13106.541271055466, 13473.86526134726, 12332.938335308267, 12437.62687119388, 12451.190672606252, 12504.624861254177, 12714.682132946751, 12362.505499779909, 12409.689757756129, 12468.06489513272, 12691.746165076462, 12759.170653907466, 12286.508539658313, 12346.320952347707, 12442.688932776753, 12514.374281286082, 12662.936685316883, 9842.261830362895, 9890.604375825174, 10108.494575271354, 10268.229882758673, 10385.117265032557, 10689.465526723789, 10780.514876830719, 10781.353118812896, 10845.186611004048, 10851.45742712877], "value": 6926.029020312377, "unit": "score"}], "name": "dromaeo_css", "value": 7215.087159310414, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 107.0, 111.0, 110.0, 110.0, 112.0, 111.0, 110.0, 110.0, 110.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 130.0, 134.0, 175.0, 127.0, 155.0, 156.0, 126.0, 177.0, 126.0], "value": 146.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 160.0, 160.0, 160.0, 162.0, 161.0, 162.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 73.0, 112.0, 75.0, 74.0, 75.0, 74.0, 96.0, 74.0], "value": 80.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 120.0, 85.0, 83.0, 83.0, 122.0, 83.0, 84.0, 122.0], "value": 94.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 58.0, 55.0, 56.0, 64.0, 55.0, 76.0, 54.0, 52.0], "value": 58.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 62.0, 65.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 80.0, 77.0, 85.0, 80.0, 80.0, 79.0, 79.0, 84.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 124.0, 119.0, 124.0, 125.0, 124.0, 117.0, 117.0, 164.0, 124.0], "value": 126.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 163.0, 156.0, 156.0, 157.0, 160.0, 162.0, 162.0, 157.0], "value": 159.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 61.0, 62.0, 62.0, 60.0, 62.0, 63.0], "value": 61.8, "unit": "score"}], "name": "kraken", "value": 1497.4, "alertThreshold": 2.0}]} 17:45:02 INFO - Return code: 0 17:45:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:45:02 ERROR - # TBPL SUCCESS # 17:45:02 INFO - Running post-action listener: _resource_record_post_action 17:45:02 INFO - ##### 17:45:02 INFO - ##### Finished run-tests step (success) 17:45:02 INFO - ##### 17:45:02 INFO - Running post-run listener: _resource_record_post_run 17:45:02 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 551809024; Read time: 12; Write time: 547988 17:45:02 INFO - TinderboxPrint: CPU usage
13.2% 17:45:02 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 17:45:02 INFO - TinderboxPrint: I/O write bytes / time
551,809,024 / 547,988 17:45:02 INFO - TinderboxPrint: CPU idle
8,247.8 (86.8%) 17:45:02 INFO - TinderboxPrint: CPU user
1,212.2 (12.8%) 17:45:02 INFO - TinderboxPrint: Swap in / out
0 / 0 17:45:02 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 259473408; Read time: 0; Write time: 265172 17:45:02 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292335616; Read time: 12; Write time: 282816 17:45:02 INFO - Running post-run listener: _upload_blobber_files 17:45:02 INFO - Blob upload gear active. 17:45:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:45:02 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:45:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:45:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:45:03 INFO - (blobuploader) - INFO - Open directory for files ... 17:45:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:45:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:45:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:45:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:45:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:45:04 INFO - (blobuploader) - INFO - Done attempting. 17:45:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:45:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:45:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:45:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:45:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:45:05 INFO - (blobuploader) - INFO - Done attempting. 17:45:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:45:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:45:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:45:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:45:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:45:10 INFO - (blobuploader) - INFO - Done attempting. 17:45:10 INFO - (blobuploader) - INFO - Iteration through files over. 17:45:10 INFO - Return code: 0 17:45:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:45:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:45:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a148be1c9429fbec0147dc78bdee22d917985882686237746a8ac19a6112fc84894607348d056078b3902d3fe8118a50355e1943866905787727342ad9591ac2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/82af0e665d68d3a6f4a5552b65de3f9daab06851345d98b95b3fcb7969586ea0b58c36442ca2bdcd3197606bcd53be42e30cad5e6a1c6a1fee7fbd09810eb846", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/af048c4fc95ff6f42a9ca750bdd18f54fd4dabaa12dbb6c20f43f1cd7b5fb6c8c91aa2c02423b2714a1b85242019f1c3d9f5326e553658d08660f05f7d422d1f"} 17:45:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:45:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:45:10 INFO - Contents: 17:45:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a148be1c9429fbec0147dc78bdee22d917985882686237746a8ac19a6112fc84894607348d056078b3902d3fe8118a50355e1943866905787727342ad9591ac2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/82af0e665d68d3a6f4a5552b65de3f9daab06851345d98b95b3fcb7969586ea0b58c36442ca2bdcd3197606bcd53be42e30cad5e6a1c6a1fee7fbd09810eb846", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/af048c4fc95ff6f42a9ca750bdd18f54fd4dabaa12dbb6c20f43f1cd7b5fb6c8c91aa2c02423b2714a1b85242019f1c3d9f5326e553658d08660f05f7d422d1f"} 17:45:10 INFO - Running post-run listener: copy_logs_to_upload_dir 17:45:10 INFO - Copying logs to upload dir... 17:45:10 INFO - mkdir: /builds/slave/test/build/upload/logs 17:45:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.137177 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-26 17:45:09.925523) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 17:45:09.928926) ========= 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=4ac8d263c7293b36a1be1aed000001be-1464308466.321735-1641749886 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a148be1c9429fbec0147dc78bdee22d917985882686237746a8ac19a6112fc84894607348d056078b3902d3fe8118a50355e1943866905787727342ad9591ac2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/82af0e665d68d3a6f4a5552b65de3f9daab06851345d98b95b3fcb7969586ea0b58c36442ca2bdcd3197606bcd53be42e30cad5e6a1c6a1fee7fbd09810eb846", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/af048c4fc95ff6f42a9ca750bdd18f54fd4dabaa12dbb6c20f43f1cd7b5fb6c8c91aa2c02423b2714a1b85242019f1c3d9f5326e553658d08660f05f7d422d1f"} build_url:https://queue.taskcluster.net/v1/task/eMwlnTHwQFWcwnCUMQo59Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011339 build_url: 'https://queue.taskcluster.net/v1/task/eMwlnTHwQFWcwnCUMQo59Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a148be1c9429fbec0147dc78bdee22d917985882686237746a8ac19a6112fc84894607348d056078b3902d3fe8118a50355e1943866905787727342ad9591ac2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/82af0e665d68d3a6f4a5552b65de3f9daab06851345d98b95b3fcb7969586ea0b58c36442ca2bdcd3197606bcd53be42e30cad5e6a1c6a1fee7fbd09810eb846", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/af048c4fc95ff6f42a9ca750bdd18f54fd4dabaa12dbb6c20f43f1cd7b5fb6c8c91aa2c02423b2714a1b85242019f1c3d9f5326e553658d08660f05f7d422d1f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 17:45:09.954628) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 17:45:09.954979) ========= 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=4ac8d263c7293b36a1be1aed000001be-1464308466.321735-1641749886 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004444 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 17:45:10.040685) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 17:45:10.041324) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 17:45:10.041875) ========= ========= Total master_lag: 0.21 =========