builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-008 starttime: 1464588263.3 results: success (0) buildid: 20160529203123 builduid: 81dfeed2bc48454697f2eb853adc93d8 revision: e0354aa795ba11ec139cbe286e7217ba4fd0ad3e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-29 23:04:23.300594) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-29 23:04:23.301298) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-29 23:04:23.301767) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-29 23:04:23.331212) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 23:04:23.331773) ========= 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=32c5991c409366f7fec8a718000001d2-1464587935.651288-1955508040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-29 23:04:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 88.2M=0s 2016-05-29 23:04:24 (88.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087159 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 23:04:23.436281) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 23:04:23.436815) ========= 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=32c5991c409366f7fec8a718000001d2-1464587935.651288-1955508040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014758 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 23:04:23.489419) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 23:04:23.490105) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e0354aa795ba11ec139cbe286e7217ba4fd0ad3e --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 e0354aa795ba11ec139cbe286e7217ba4fd0ad3e --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=32c5991c409366f7fec8a718000001d2-1464587935.651288-1955508040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-29 23:04:24,163 truncating revision to first 12 chars 2016-05-29 23:04:24,163 Setting DEBUG logging. 2016-05-29 23:04:24,163 attempt 1/10 2016-05-29 23:04:24,163 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e0354aa795ba?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-29 23:04:24,624 unpacking tar archive at: fx-team-e0354aa795ba/testing/mozharness/ program finished with exit code 0 elapsedTime=0.824414 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 23:04:24.329165) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-29 23:04:24.329545) ========= script_repo_revision: e0354aa795ba11ec139cbe286e7217ba4fd0ad3e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-29 23:04:24.329993) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-29 23:04:24.330261) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-29 23:04:24.339471) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-05-29 23:04:24.339890) ========= /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=32c5991c409366f7fec8a718000001d2-1464587935.651288-1955508040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:04:25 INFO - MultiFileLogger online at 20160529 23:04:25 in /builds/slave/test 23:04:25 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 23:04:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:04:25 INFO - {'append_to_log': False, 23:04:25 INFO - 'base_work_dir': '/builds/slave/test', 23:04:25 INFO - 'blob_upload_branch': 'Fx-Team', 23:04:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:04:25 INFO - 'branch': 'Fx-Team', 23:04:25 INFO - 'buildbot_json_path': 'buildprops.json', 23:04:25 INFO - 'config_files': ('talos/linux_config.py',), 23:04:25 INFO - 'default_actions': ('clobber', 23:04:25 INFO - 'read-buildbot-config', 23:04:25 INFO - 'download-and-extract', 23:04:25 INFO - 'populate-webroot', 23:04:25 INFO - 'create-virtualenv', 23:04:25 INFO - 'install', 23:04:25 INFO - 'run-tests'), 23:04:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:04:25 INFO - 'download_minidump_stackwalk': True, 23:04:25 INFO - 'download_symbols': 'ondemand', 23:04:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:04:25 INFO - 'tooltool.py': '/tools/tooltool.py', 23:04:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:04:25 INFO - '/tools/misc-python/virtualenv.py')}, 23:04:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:04:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:04:25 INFO - 'installer_path': 'installer.exe', 23:04:25 INFO - 'log_level': 'info', 23:04:25 INFO - 'log_name': 'talos', 23:04:25 INFO - 'log_to_console': True, 23:04:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:04:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:04:25 INFO - 'opt_config_files': (), 23:04:25 INFO - 'pip_index': False, 23:04:25 INFO - 'sps_profile': False, 23:04:25 INFO - 'sps_profile_interval': 0, 23:04:25 INFO - 'suite': 'dromaeojs', 23:04:25 INFO - 'system_bits': '32', 23:04:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:04:25 INFO - 'title': 'talos-linux64-ix-008', 23:04:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:04:25 INFO - 'use_talos_json': True, 23:04:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:04:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:04:25 INFO - 'work_dir': 'build'} 23:04:25 INFO - ##### 23:04:25 INFO - ##### Running clobber step. 23:04:25 INFO - ##### 23:04:25 INFO - Running pre-action listener: _resource_record_pre_action 23:04:25 INFO - Running main action method: clobber 23:04:25 INFO - rmtree: /builds/slave/test/build 23:04:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:04:25 INFO - Running post-action listener: _resource_record_post_action 23:04:25 INFO - ##### 23:04:25 INFO - ##### Finished clobber step (success) 23:04:25 INFO - ##### 23:04:25 INFO - ##### 23:04:25 INFO - ##### Running read-buildbot-config step. 23:04:25 INFO - ##### 23:04:25 INFO - Running pre-action listener: _resource_record_pre_action 23:04:25 INFO - Running main action method: read_buildbot_config 23:04:25 INFO - Using buildbot properties: 23:04:25 INFO - { 23:04:25 INFO - "project": "", 23:04:25 INFO - "product": "firefox", 23:04:25 INFO - "script_repo_revision": "production", 23:04:25 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 23:04:25 INFO - "repository": "", 23:04:25 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 23:04:25 INFO - "buildid": "20160529203123", 23:04:25 INFO - "pgo_build": "True", 23:04:25 INFO - "basedir": "/builds/slave/test", 23:04:25 INFO - "buildnumber": 733, 23:04:25 INFO - "slavename": "talos-linux64-ix-008", 23:04:25 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:04:25 INFO - "platform": "ubuntu64_hw", 23:04:25 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:04:25 INFO - "branch": "fx-team", 23:04:25 INFO - "repo_path": "integration/fx-team", 23:04:25 INFO - "revision": "e0354aa795ba11ec139cbe286e7217ba4fd0ad3e", 23:04:25 INFO - "stage_platform": "linux64-pgo", 23:04:25 INFO - "builduid": "81dfeed2bc48454697f2eb853adc93d8", 23:04:25 INFO - "slavebuilddir": "test" 23:04:25 INFO - } 23:04:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/S76xzm6FSVujY9rMjXc8BQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 23:04:25 INFO - Running post-action listener: _resource_record_post_action 23:04:25 INFO - ##### 23:04:25 INFO - ##### Finished read-buildbot-config step (success) 23:04:25 INFO - ##### 23:04:25 INFO - ##### 23:04:25 INFO - ##### Running download-and-extract step. 23:04:25 INFO - ##### 23:04:25 INFO - Running pre-action listener: _resource_record_pre_action 23:04:25 INFO - Running main action method: download_and_extract 23:04:25 INFO - mkdir: /builds/slave/test/build/tests 23:04:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:04:25 INFO - https://queue.taskcluster.net/v1/task/S76xzm6FSVujY9rMjXc8BQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:04:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S76xzm6FSVujY9rMjXc8BQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:04:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S76xzm6FSVujY9rMjXc8BQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:04:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S76xzm6FSVujY9rMjXc8BQ/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 23:04:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S76xzm6FSVujY9rMjXc8BQ/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 23:04:32 INFO - Downloaded 1361 bytes. 23:04:32 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:04:32 INFO - Using the following test package requirements: 23:04:32 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 23:04:32 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:04:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:04:32 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:04:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:04:32 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:04:32 INFO - u'jsshell-linux-x86_64.zip'], 23:04:32 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:04:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:04:32 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 23:04:32 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:04:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:04:32 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:04:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:04:32 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:04:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:04:32 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:04:32 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:04:32 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:04:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:04:32 INFO - https://queue.taskcluster.net/v1/task/S76xzm6FSVujY9rMjXc8BQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:04:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S76xzm6FSVujY9rMjXc8BQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:04:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S76xzm6FSVujY9rMjXc8BQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:04:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S76xzm6FSVujY9rMjXc8BQ/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 23:04:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S76xzm6FSVujY9rMjXc8BQ/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 23:04:45 INFO - Downloaded 24410635 bytes. 23:04:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:04:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:04:46 INFO - Return code: 0 23:04:46 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 23:04:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:04:46 INFO - https://queue.taskcluster.net/v1/task/S76xzm6FSVujY9rMjXc8BQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:04:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S76xzm6FSVujY9rMjXc8BQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:04:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S76xzm6FSVujY9rMjXc8BQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:04:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S76xzm6FSVujY9rMjXc8BQ/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 23:04:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S76xzm6FSVujY9rMjXc8BQ/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 23:04:47 INFO - Downloaded 24410635 bytes. 23:04:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:04:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:04:49 INFO - Return code: 0 23:04: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')]} 23:04:49 INFO - https://queue.taskcluster.net/v1/task/S76xzm6FSVujY9rMjXc8BQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:04:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S76xzm6FSVujY9rMjXc8BQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:04:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S76xzm6FSVujY9rMjXc8BQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:04:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S76xzm6FSVujY9rMjXc8BQ/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 23:04:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S76xzm6FSVujY9rMjXc8BQ/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 23:04:50 INFO - Downloaded 10834034 bytes. 23:04:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:04:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 23:04:50 INFO - Return code: 0 23:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:04:50 INFO - https://queue.taskcluster.net/v1/task/S76xzm6FSVujY9rMjXc8BQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:04:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S76xzm6FSVujY9rMjXc8BQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:04:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S76xzm6FSVujY9rMjXc8BQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:04:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S76xzm6FSVujY9rMjXc8BQ/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 23:04:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S76xzm6FSVujY9rMjXc8BQ/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 23:04:52 INFO - Downloaded 58756592 bytes. 23:04:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S76xzm6FSVujY9rMjXc8BQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:04:52 INFO - mkdir: /builds/slave/test/properties 23:04:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:04:52 INFO - Writing to file /builds/slave/test/properties/build_url 23:04:52 INFO - Contents: 23:04:52 INFO - build_url:https://queue.taskcluster.net/v1/task/S76xzm6FSVujY9rMjXc8BQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:04:53 INFO - Running post-action listener: _resource_record_post_action 23:04:53 INFO - Running post-action listener: set_extra_try_arguments 23:04:53 INFO - ##### 23:04:53 INFO - ##### Finished download-and-extract step (success) 23:04:53 INFO - ##### 23:04:53 INFO - ##### 23:04:53 INFO - ##### Running populate-webroot step. 23:04:53 INFO - ##### 23:04:53 INFO - Running pre-action listener: _resource_record_pre_action 23:04:53 INFO - Running main action method: populate_webroot 23:04:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:04:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:04:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:04:53 INFO - '--tppagecycles', 23:04:53 INFO - '7'], 23:04:53 INFO - 'tests': ['tsvgm']}}, 23:04:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:04:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:04:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:04:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:04:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:04:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:04:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:04:53 INFO - 'talos_options': ['--disable-e10s'], 23:04:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:04:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:04:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:04:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:04:53 INFO - 'talos_options': ['--disable-e10s'], 23:04:53 INFO - 'tests': ['damp', 'tps']}, 23:04:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:04:53 INFO - 'tests': ['damp', 'tps']}, 23:04:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:04:53 INFO - 'tests': ['dromaeo_dom']}, 23:04:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:04:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:04:53 INFO - 'tests': ['a11yr', 23:04:53 INFO - 'ts_paint', 23:04:53 INFO - 'tpaint', 23:04:53 INFO - 'sessionrestore', 23:04:53 INFO - 'sessionrestore_no_auto_restore', 23:04:53 INFO - 'tabpaint']}, 23:04:53 INFO - 'other-e10s': {'tests': ['a11yr', 23:04:53 INFO - 'ts_paint', 23:04:53 INFO - 'tpaint', 23:04:53 INFO - 'sessionrestore', 23:04:53 INFO - 'sessionrestore_no_auto_restore', 23:04:53 INFO - 'tabpaint']}, 23:04:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:04:53 INFO - 'ts_paint', 23:04:53 INFO - 'tpaint', 23:04:53 INFO - 'sessionrestore', 23:04:53 INFO - 'sessionrestore_no_auto_restore', 23:04:53 INFO - 'tabpaint']}, 23:04:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:04:53 INFO - 'ts_paint', 23:04:53 INFO - 'tpaint', 23:04:53 INFO - 'sessionrestore', 23:04:53 INFO - 'sessionrestore_no_auto_restore', 23:04:53 INFO - 'tabpaint']}, 23:04:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:04:53 INFO - 'tests': ['a11yr', 23:04:53 INFO - 'ts_paint', 23:04:53 INFO - 'tpaint', 23:04:53 INFO - 'sessionrestore', 23:04:53 INFO - 'sessionrestore_no_auto_restore', 23:04:53 INFO - 'tabpaint']}, 23:04:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:04:53 INFO - 'tests': ['a11yr', 23:04:53 INFO - 'ts_paint', 23:04:53 INFO - 'tpaint', 23:04:53 INFO - 'sessionrestore', 23:04:53 INFO - 'sessionrestore_no_auto_restore', 23:04:53 INFO - 'tabpaint']}, 23:04:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:04:53 INFO - 'tests': ['tsvgx', 23:04:53 INFO - 'tsvgr_opacity', 23:04:53 INFO - 'tart', 23:04:53 INFO - 'tscrollx', 23:04:53 INFO - 'cart']}, 23:04:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:04:53 INFO - 'tsvgr_opacity', 23:04:53 INFO - 'tart', 23:04:53 INFO - 'tscrollx', 23:04:53 INFO - 'cart']}, 23:04:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:04:53 INFO - 'talos_options': ['--disable-e10s'], 23:04:53 INFO - 'tests': ['tp5o']}, 23:04:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:04:53 INFO - 'tests': ['tp5o']}, 23:04:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:04:53 INFO - 'talos_options': ['--disable-e10s', 23:04:53 INFO - '--xperf_path', 23:04:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:04:53 INFO - 'tests': ['tp5n']}, 23:04:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:04:53 INFO - 'talos_options': ['--xperf_path', 23:04:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:04:53 INFO - 'tests': ['tp5n']}}, 23:04:53 INFO - 'talos.zip': {'path': '', 23:04:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:04:53 INFO - Running post-action listener: _resource_record_post_action 23:04:53 INFO - ##### 23:04:53 INFO - ##### Finished populate-webroot step (success) 23:04:53 INFO - ##### 23:04:53 INFO - ##### 23:04:53 INFO - ##### Running create-virtualenv step. 23:04:53 INFO - ##### 23:04:53 INFO - Running pre-action listener: _resource_record_pre_action 23:04:53 INFO - Running main action method: create_virtualenv 23:04:53 INFO - Creating virtualenv /builds/slave/test/build/venv 23:04:53 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 23:04:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:04:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:04:53 INFO - Using real prefix '/usr' 23:04:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:04:54 INFO - Installing distribute.............................................................................................................................................................................................done. 23:04:56 INFO - Installing pip.................done. 23:04:56 INFO - Return code: 0 23:04:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:04:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:04:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:04:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:04:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc84f51ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2042770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d19c0>, '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 0x20d28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d2d50>, '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': '32c5991c409366f7fec8a718000001d2-1464587935.651288-1955508040', '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 23:04:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:04:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:04:56 INFO - Using env: {'DISPLAY': ':0', 23:04:56 INFO - 'HOME': '/home/cltbld', 23:04:56 INFO - 'LANG': 'en_US.UTF-8', 23:04:56 INFO - 'LANGUAGE': 'en_US:en', 23:04:56 INFO - 'LOGNAME': 'cltbld', 23:04:56 INFO - 'MAIL': '/var/mail/cltbld', 23:04:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:04:56 INFO - 'MOZ_NO_REMOTE': '1', 23:04:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:04:56 INFO - 'NO_EM_RESTART': '1', 23:04:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:04:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:04:56 INFO - 'PWD': '/builds/slave/test', 23:04:56 INFO - 'SHELL': '/bin/bash', 23:04:56 INFO - 'SHLVL': '1', 23:04:56 INFO - 'TERM': 'linux', 23:04:56 INFO - 'TMOUT': '86400', 23:04:56 INFO - 'USER': 'cltbld', 23:04:56 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464587935.651288-1955508040', 23:04:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:04:56 INFO - '_': '/tools/buildbot/bin/python'} 23:04:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:04:56 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 23:04:56 INFO - Cleaning up... 23:04:56 INFO - Return code: 0 23:04:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:04:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:04:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:04:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:04:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc84f51ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2042770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d19c0>, '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 0x20d28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d2d50>, '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': '32c5991c409366f7fec8a718000001d2-1464587935.651288-1955508040', '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 23:04:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:04:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:04:56 INFO - Using env: {'DISPLAY': ':0', 23:04:56 INFO - 'HOME': '/home/cltbld', 23:04:56 INFO - 'LANG': 'en_US.UTF-8', 23:04:56 INFO - 'LANGUAGE': 'en_US:en', 23:04:56 INFO - 'LOGNAME': 'cltbld', 23:04:56 INFO - 'MAIL': '/var/mail/cltbld', 23:04:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:04:56 INFO - 'MOZ_NO_REMOTE': '1', 23:04:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:04:56 INFO - 'NO_EM_RESTART': '1', 23:04:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:04:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:04:56 INFO - 'PWD': '/builds/slave/test', 23:04:56 INFO - 'SHELL': '/bin/bash', 23:04:56 INFO - 'SHLVL': '1', 23:04:56 INFO - 'TERM': 'linux', 23:04:56 INFO - 'TMOUT': '86400', 23:04:56 INFO - 'USER': 'cltbld', 23:04:56 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464587935.651288-1955508040', 23:04:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:04:56 INFO - '_': '/tools/buildbot/bin/python'} 23:04:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:04:56 INFO - Downloading/unpacking psutil>=3.1.1 23:04: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 23:04: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 23:04: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 23:04: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 23:04: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 23:04: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 23:04:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:04:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:04:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:04:58 INFO - Installing collected packages: psutil 23:04:58 INFO - Running setup.py install for psutil 23:04:58 INFO - building 'psutil._psutil_linux' extension 23:04:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 23:04:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 23:04:58 INFO - building 'psutil._psutil_posix' extension 23:04:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 23:04:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 23:04:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:04:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:04:59 INFO - Successfully installed psutil 23:04:59 INFO - Cleaning up... 23:04:59 INFO - Return code: 0 23:04:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:04:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:04:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:04:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:04:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc84f51ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2042770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d19c0>, '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 0x20d28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d2d50>, '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': '32c5991c409366f7fec8a718000001d2-1464587935.651288-1955508040', '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 23:04:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:04:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:04:59 INFO - Using env: {'DISPLAY': ':0', 23:04:59 INFO - 'HOME': '/home/cltbld', 23:04:59 INFO - 'LANG': 'en_US.UTF-8', 23:04:59 INFO - 'LANGUAGE': 'en_US:en', 23:04:59 INFO - 'LOGNAME': 'cltbld', 23:04:59 INFO - 'MAIL': '/var/mail/cltbld', 23:04:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:04:59 INFO - 'MOZ_NO_REMOTE': '1', 23:04:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:04:59 INFO - 'NO_EM_RESTART': '1', 23:04:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:04:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:04:59 INFO - 'PWD': '/builds/slave/test', 23:04:59 INFO - 'SHELL': '/bin/bash', 23:04:59 INFO - 'SHLVL': '1', 23:04:59 INFO - 'TERM': 'linux', 23:04:59 INFO - 'TMOUT': '86400', 23:04:59 INFO - 'USER': 'cltbld', 23:04:59 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464587935.651288-1955508040', 23:04:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:04:59 INFO - '_': '/tools/buildbot/bin/python'} 23:04:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:04:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:04:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:04:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:04:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:04:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:05:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:05:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:05:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:05:01 INFO - Installing collected packages: mozsystemmonitor 23:05:01 INFO - Running setup.py install for mozsystemmonitor 23:05:01 INFO - Successfully installed mozsystemmonitor 23:05:01 INFO - Cleaning up... 23:05:01 INFO - Return code: 0 23:05:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:05:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc84f51ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2042770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d19c0>, '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 0x20d28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d2d50>, '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': '32c5991c409366f7fec8a718000001d2-1464587935.651288-1955508040', '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 23:05:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:05:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:05:01 INFO - Using env: {'DISPLAY': ':0', 23:05:01 INFO - 'HOME': '/home/cltbld', 23:05:01 INFO - 'LANG': 'en_US.UTF-8', 23:05:01 INFO - 'LANGUAGE': 'en_US:en', 23:05:01 INFO - 'LOGNAME': 'cltbld', 23:05:01 INFO - 'MAIL': '/var/mail/cltbld', 23:05:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:01 INFO - 'MOZ_NO_REMOTE': '1', 23:05:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:01 INFO - 'NO_EM_RESTART': '1', 23:05:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:05:01 INFO - 'PWD': '/builds/slave/test', 23:05:01 INFO - 'SHELL': '/bin/bash', 23:05:01 INFO - 'SHLVL': '1', 23:05:01 INFO - 'TERM': 'linux', 23:05:01 INFO - 'TMOUT': '86400', 23:05:01 INFO - 'USER': 'cltbld', 23:05:01 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464587935.651288-1955508040', 23:05:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:01 INFO - '_': '/tools/buildbot/bin/python'} 23:05:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:01 INFO - Downloading/unpacking blobuploader==1.2.4 23:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:05:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:05:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:05:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:05:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:05:03 INFO - Downloading blobuploader-1.2.4.tar.gz 23:05:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:05:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:05:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:05:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:05:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:05:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:05:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:05:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:05:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:05:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:05:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:05:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:05:04 INFO - Downloading docopt-0.6.1.tar.gz 23:05:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:05:04 INFO - Installing collected packages: blobuploader, requests, docopt 23:05:04 INFO - Running setup.py install for blobuploader 23:05:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:05:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:05:04 INFO - Running setup.py install for requests 23:05:05 INFO - Running setup.py install for docopt 23:05:05 INFO - Successfully installed blobuploader requests docopt 23:05:05 INFO - Cleaning up... 23:05:05 INFO - Return code: 0 23:05:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:05 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 0x7fc84f51ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2042770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d19c0>, '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 0x20d28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d2d50>, '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': '32c5991c409366f7fec8a718000001d2-1464587935.651288-1955508040', '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 23:05:05 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 23:05:05 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 23:05:05 INFO - Using env: {'DISPLAY': ':0', 23:05:05 INFO - 'HOME': '/home/cltbld', 23:05:05 INFO - 'LANG': 'en_US.UTF-8', 23:05:05 INFO - 'LANGUAGE': 'en_US:en', 23:05:05 INFO - 'LOGNAME': 'cltbld', 23:05:05 INFO - 'MAIL': '/var/mail/cltbld', 23:05:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:05 INFO - 'MOZ_NO_REMOTE': '1', 23:05:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:05 INFO - 'NO_EM_RESTART': '1', 23:05:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:05:05 INFO - 'PWD': '/builds/slave/test', 23:05:05 INFO - 'SHELL': '/bin/bash', 23:05:05 INFO - 'SHLVL': '1', 23:05:05 INFO - 'TERM': 'linux', 23:05:05 INFO - 'TMOUT': '86400', 23:05:05 INFO - 'USER': 'cltbld', 23:05:05 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464587935.651288-1955508040', 23:05:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:05 INFO - '_': '/tools/buildbot/bin/python'} 23:05:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:05:05 INFO - Running setup.py (path:/tmp/pip-_O_Qvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:05:05 INFO - Running setup.py (path:/tmp/pip-0hvYN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:05:05 INFO - Running setup.py (path:/tmp/pip-dPVU0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:05:05 INFO - Running setup.py (path:/tmp/pip-wtlj0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:05:05 INFO - Running setup.py (path:/tmp/pip-Jm9jo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:05:05 INFO - Running setup.py (path:/tmp/pip-MVAf4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:05:05 INFO - Running setup.py (path:/tmp/pip-ng_zBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:05:05 INFO - Running setup.py (path:/tmp/pip-oCOs5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:05:05 INFO - Running setup.py (path:/tmp/pip-IVp9cd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:05:06 INFO - Running setup.py (path:/tmp/pip-8FiKvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:05:06 INFO - Running setup.py (path:/tmp/pip-R2LtHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:05:06 INFO - Running setup.py (path:/tmp/pip-QRpdsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:05:06 INFO - Running setup.py (path:/tmp/pip-wn9YOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:05:06 INFO - Running setup.py (path:/tmp/pip-v7NqIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:05:06 INFO - Running setup.py (path:/tmp/pip-Sv6agi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:05:06 INFO - Running setup.py (path:/tmp/pip-0J_fRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:05:06 INFO - Running setup.py (path:/tmp/pip-ikMqiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:05:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:05:06 INFO - Running setup.py install for manifestparser 23:05:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:05:06 INFO - Running setup.py install for mozcrash 23:05:06 INFO - Running setup.py install for mozdebug 23:05:06 INFO - Running setup.py install for mozdevice 23:05:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:05:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:05:07 INFO - Running setup.py install for mozfile 23:05:07 INFO - Running setup.py install for mozhttpd 23:05:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:05:07 INFO - Running setup.py install for mozinfo 23:05:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:05:07 INFO - Running setup.py install for mozInstall 23:05:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:05:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:05:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:05:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:05:07 INFO - Running setup.py install for mozleak 23:05:07 INFO - Running setup.py install for mozlog 23:05:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:05:07 INFO - Running setup.py install for moznetwork 23:05:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:05:07 INFO - Running setup.py install for mozprocess 23:05:07 INFO - Running setup.py install for mozprofile 23:05:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:05:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:05:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:05:07 INFO - Running setup.py install for mozrunner 23:05:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:05:08 INFO - Running setup.py install for mozscreenshot 23:05:08 INFO - Running setup.py install for moztest 23:05:08 INFO - Running setup.py install for mozversion 23:05:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:05:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:05:08 INFO - Cleaning up... 23:05:08 INFO - Return code: 0 23:05:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:05:08 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')]} 23:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:08 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')]} 23:05:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:08 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 0x7fc84f51ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2042770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d19c0>, '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 0x20d28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d2d50>, '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': '32c5991c409366f7fec8a718000001d2-1464587935.651288-1955508040', '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 23:05:08 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 23:05:08 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 23:05:08 INFO - Using env: {'DISPLAY': ':0', 23:05:08 INFO - 'HOME': '/home/cltbld', 23:05:08 INFO - 'LANG': 'en_US.UTF-8', 23:05:08 INFO - 'LANGUAGE': 'en_US:en', 23:05:08 INFO - 'LOGNAME': 'cltbld', 23:05:08 INFO - 'MAIL': '/var/mail/cltbld', 23:05:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:08 INFO - 'MOZ_NO_REMOTE': '1', 23:05:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:08 INFO - 'NO_EM_RESTART': '1', 23:05:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:05:08 INFO - 'PWD': '/builds/slave/test', 23:05:08 INFO - 'SHELL': '/bin/bash', 23:05:08 INFO - 'SHLVL': '1', 23:05:08 INFO - 'TERM': 'linux', 23:05:08 INFO - 'TMOUT': '86400', 23:05:08 INFO - 'USER': 'cltbld', 23:05:08 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464587935.651288-1955508040', 23:05:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:08 INFO - '_': '/tools/buildbot/bin/python'} 23:05:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:05:08 INFO - Running setup.py (path:/tmp/pip-CKOUz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:05:08 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)) 23:05:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:05:08 INFO - Running setup.py (path:/tmp/pip-9pll75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:05:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:05:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:05:08 INFO - Running setup.py (path:/tmp/pip-a375vG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:05:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:05:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:05:08 INFO - Running setup.py (path:/tmp/pip-wMP_kS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:05:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:05:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:05:08 INFO - Running setup.py (path:/tmp/pip-ngD7zG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:05:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 23:05:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:05:08 INFO - Running setup.py (path:/tmp/pip-Te4f1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:05:09 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)) 23:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:05:09 INFO - Running setup.py (path:/tmp/pip-oqggiv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:05:09 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)) 23:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:05:09 INFO - Running setup.py (path:/tmp/pip-zNafSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:05:09 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)) 23:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:05:09 INFO - Running setup.py (path:/tmp/pip-H1ksTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:05:09 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)) 23:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:05:09 INFO - Running setup.py (path:/tmp/pip-p78xEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:05:09 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)) 23:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:05:09 INFO - Running setup.py (path:/tmp/pip-h0bZ7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:05:09 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)) 23:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:05:09 INFO - Running setup.py (path:/tmp/pip-gxvfeY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:05:09 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)) 23:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:05:09 INFO - Running setup.py (path:/tmp/pip-UMxunO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:05:09 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)) 23:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:05:09 INFO - Running setup.py (path:/tmp/pip-wZ4VFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:05:09 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)) 23:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:05:09 INFO - Running setup.py (path:/tmp/pip-rNidCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 23:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:05:09 INFO - Running setup.py (path:/tmp/pip-49EY0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 23:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:05:09 INFO - Running setup.py (path:/tmp/pip-Bhlln9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 23:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:05:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:05: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 23:05: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 23:05: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 23:05: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 23:05: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 23:05: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 23:05:11 INFO - Downloading blessings-1.6.tar.gz 23:05:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:05:11 INFO - Installing collected packages: blessings 23:05:11 INFO - Running setup.py install for blessings 23:05:11 INFO - Successfully installed blessings 23:05:11 INFO - Cleaning up... 23:05:11 INFO - Return code: 0 23:05:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:05:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:05:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:05:12 INFO - Reading from file tmpfile_stdout 23:05:12 INFO - Current package versions: 23:05:12 INFO - argparse == 1.2.1 23:05:12 INFO - blessings == 1.6 23:05:12 INFO - blobuploader == 1.2.4 23:05:12 INFO - docopt == 0.6.1 23:05:12 INFO - manifestparser == 1.1 23:05:12 INFO - mozInstall == 1.12 23:05:12 INFO - mozcrash == 0.17 23:05:12 INFO - mozdebug == 0.1 23:05:12 INFO - mozdevice == 0.48 23:05:12 INFO - mozfile == 1.2 23:05:12 INFO - mozhttpd == 0.7 23:05:12 INFO - mozinfo == 0.9 23:05:12 INFO - mozleak == 0.1 23:05:12 INFO - mozlog == 3.2 23:05:12 INFO - moznetwork == 0.27 23:05:12 INFO - mozprocess == 0.22 23:05:12 INFO - mozprofile == 0.28 23:05:12 INFO - mozrunner == 6.11 23:05:12 INFO - mozscreenshot == 0.1 23:05:12 INFO - mozsystemmonitor == 0.3 23:05:12 INFO - moztest == 0.7 23:05:12 INFO - mozversion == 1.4 23:05:12 INFO - psutil == 3.1.1 23:05:12 INFO - requests == 1.2.3 23:05:12 INFO - wsgiref == 0.1.2 23:05:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:12 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 0x7fc84f51ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2042770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d19c0>, '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 0x20d28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d2d50>, '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': '32c5991c409366f7fec8a718000001d2-1464587935.651288-1955508040', '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 23:05:12 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 23:05:12 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 23:05:12 INFO - Using env: {'DISPLAY': ':0', 23:05:12 INFO - 'HOME': '/home/cltbld', 23:05:12 INFO - 'LANG': 'en_US.UTF-8', 23:05:12 INFO - 'LANGUAGE': 'en_US:en', 23:05:12 INFO - 'LOGNAME': 'cltbld', 23:05:12 INFO - 'MAIL': '/var/mail/cltbld', 23:05:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:12 INFO - 'MOZ_NO_REMOTE': '1', 23:05:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:12 INFO - 'NO_EM_RESTART': '1', 23:05:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:05:12 INFO - 'PWD': '/builds/slave/test', 23:05:12 INFO - 'SHELL': '/bin/bash', 23:05:12 INFO - 'SHLVL': '1', 23:05:12 INFO - 'TERM': 'linux', 23:05:12 INFO - 'TMOUT': '86400', 23:05:12 INFO - 'USER': 'cltbld', 23:05:12 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464587935.651288-1955508040', 23:05:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:12 INFO - '_': '/tools/buildbot/bin/python'} 23:05:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:12 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)) 23:05:12 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)) 23:05:12 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)) 23:05:12 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)) 23:05:12 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)) 23:05:12 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)) 23:05:12 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)) 23:05:12 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)) 23:05:12 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)) 23:05:12 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)) 23:05:12 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)) 23:05:12 INFO - Cleaning up... 23:05:12 INFO - Return code: 0 23:05:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc84f51ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2042770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d19c0>, '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 0x20d28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d2d50>, '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': '32c5991c409366f7fec8a718000001d2-1464587935.651288-1955508040', '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 23:05:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:05:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:05:12 INFO - Using env: {'DISPLAY': ':0', 23:05:12 INFO - 'HOME': '/home/cltbld', 23:05:12 INFO - 'LANG': 'en_US.UTF-8', 23:05:12 INFO - 'LANGUAGE': 'en_US:en', 23:05:12 INFO - 'LOGNAME': 'cltbld', 23:05:12 INFO - 'MAIL': '/var/mail/cltbld', 23:05:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:12 INFO - 'MOZ_NO_REMOTE': '1', 23:05:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:12 INFO - 'NO_EM_RESTART': '1', 23:05:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:05:12 INFO - 'PWD': '/builds/slave/test', 23:05:12 INFO - 'SHELL': '/bin/bash', 23:05:12 INFO - 'SHLVL': '1', 23:05:12 INFO - 'TERM': 'linux', 23:05:12 INFO - 'TMOUT': '86400', 23:05:12 INFO - 'USER': 'cltbld', 23:05:12 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464587935.651288-1955508040', 23:05:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:12 INFO - '_': '/tools/buildbot/bin/python'} 23:05:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:12 INFO - Downloading/unpacking jsonschema 23:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:05:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:05:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:05:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:05:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:05:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:05:14 INFO - Downloading/unpacking functools32 (from jsonschema) 23:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:05:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:05:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:05:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:05:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:05:14 INFO - Downloading functools32-3.2.3-2.tar.gz 23:05:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:05:14 INFO - warning: no files found matching '*.txt' 23:05:14 INFO - no previously-included directories found matching 'build' 23:05:14 INFO - no previously-included directories found matching 'dist' 23:05:14 INFO - no previously-included directories found matching '.git*' 23:05:14 INFO - Installing collected packages: jsonschema, functools32 23:05:14 INFO - Running setup.py install for functools32 23:05:14 INFO - warning: no files found matching '*.txt' 23:05:14 INFO - no previously-included directories found matching 'build' 23:05:14 INFO - no previously-included directories found matching 'dist' 23:05:14 INFO - no previously-included directories found matching '.git*' 23:05:14 INFO - Successfully installed jsonschema functools32 23:05:14 INFO - Cleaning up... 23:05:14 INFO - Return code: 0 23:05:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:05:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc84f51ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2042770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d19c0>, '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 0x20d28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d2d50>, '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': '32c5991c409366f7fec8a718000001d2-1464587935.651288-1955508040', '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 23:05:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 23:05:15 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 23:05:15 INFO - Using env: {'DISPLAY': ':0', 23:05:15 INFO - 'HOME': '/home/cltbld', 23:05:15 INFO - 'LANG': 'en_US.UTF-8', 23:05:15 INFO - 'LANGUAGE': 'en_US:en', 23:05:15 INFO - 'LOGNAME': 'cltbld', 23:05:15 INFO - 'MAIL': '/var/mail/cltbld', 23:05:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:15 INFO - 'MOZ_NO_REMOTE': '1', 23:05:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:15 INFO - 'NO_EM_RESTART': '1', 23:05:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:05:15 INFO - 'PWD': '/builds/slave/test', 23:05:15 INFO - 'SHELL': '/bin/bash', 23:05:15 INFO - 'SHLVL': '1', 23:05:15 INFO - 'TERM': 'linux', 23:05:15 INFO - 'TMOUT': '86400', 23:05:15 INFO - 'USER': 'cltbld', 23:05:15 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464587935.651288-1955508040', 23:05:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:15 INFO - '_': '/tools/buildbot/bin/python'} 23:05:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:15 INFO - Downloading/unpacking flake8 23:05:15 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 23:05:15 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 23:05:15 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 23:05:15 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 23:05:15 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 23:05:15 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 23:05:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:05:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:05:17 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 23:05:17 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 23:05:17 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 23:05:17 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 23:05:17 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 23:05:17 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 23:05:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:05:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:05:17 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 23:05:17 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 23:05:17 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 23:05:17 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 23:05:17 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 23:05:17 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 23:05:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:05:17 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 23:05:17 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 23:05:17 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 23:05:17 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 23:05:17 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 23:05:17 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 23:05:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:05:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:05:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:05:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:05:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:05:17 INFO - no previously-included directories found matching 'docs/_build' 23:05:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:05:17 INFO - Running setup.py install for pep8 23:05:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:05:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:05:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:05:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:05:17 INFO - no previously-included directories found matching 'docs/_build' 23:05:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:05:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:05:18 INFO - Cleaning up... 23:05:18 INFO - Return code: 0 23:05:18 INFO - Running post-action listener: _resource_record_post_action 23:05:18 INFO - Running post-action listener: _start_resource_monitoring 23:05:18 INFO - Starting resource monitoring. 23:05:18 INFO - ##### 23:05:18 INFO - ##### Finished create-virtualenv step (success) 23:05:18 INFO - ##### 23:05:18 INFO - ##### 23:05:18 INFO - ##### Running install step. 23:05:18 INFO - ##### 23:05:18 INFO - Running pre-action listener: _resource_record_pre_action 23:05:18 INFO - Running main action method: install 23:05:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:05:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:05:18 INFO - Reading from file tmpfile_stdout 23:05:18 INFO - Detecting whether we're running mozinstall >=1.0... 23:05:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:05:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:05:18 INFO - Reading from file tmpfile_stdout 23:05:18 INFO - Output received: 23:05:18 INFO - Usage: mozinstall [options] installer 23:05:18 INFO - Options: 23:05:18 INFO - -h, --help show this help message and exit 23:05:18 INFO - -d DEST, --destination=DEST 23:05:18 INFO - Directory to install application into. [default: 23:05:18 INFO - "/builds/slave/test"] 23:05:18 INFO - --app=APP Application being installed. [default: firefox] 23:05:18 INFO - mkdir: /builds/slave/test/build/application 23:05:18 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'] 23:05:18 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 23:05:35 INFO - Reading from file tmpfile_stdout 23:05:35 INFO - Output received: 23:05:35 INFO - /builds/slave/test/build/application/firefox/firefox 23:05:35 INFO - Running post-action listener: _resource_record_post_action 23:05:35 INFO - ##### 23:05:35 INFO - ##### Finished install step (success) 23:05:35 INFO - ##### 23:05:35 INFO - ##### 23:05:35 INFO - ##### Running run-tests step. 23:05:35 INFO - ##### 23:05:35 INFO - Running pre-action listener: _resource_record_pre_action 23:05:35 INFO - Running main action method: run_tests 23:05:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:05:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:05:35 INFO - Python 2.7.3 23:05:35 INFO - Return code: 0 23:05:35 INFO - grabbing minidump binary from tooltool 23:05: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')]} 23:05:35 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 0x20d19c0>, '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 0x20d28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d2d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:05:35 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 23:05:35 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 23:05:35 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 23:05:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:05:35 INFO - Return code: 0 23:05:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:05:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:05:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:05:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:05:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:05:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:05:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:05:36 INFO - Return code: 0 23:05:36 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/S76xzm6FSVujY9rMjXc8BQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 23:05:36 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/S76xzm6FSVujY9rMjXc8BQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 23:05:36 INFO - Using env: {'DISPLAY': ':0', 23:05:36 INFO - 'HOME': '/home/cltbld', 23:05:36 INFO - 'LANG': 'en_US.UTF-8', 23:05:36 INFO - 'LANGUAGE': 'en_US:en', 23:05:36 INFO - 'LOGNAME': 'cltbld', 23:05:36 INFO - 'MAIL': '/var/mail/cltbld', 23:05:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:05:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:05:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:36 INFO - 'MOZ_NO_REMOTE': '1', 23:05:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:05:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:36 INFO - 'NO_EM_RESTART': '1', 23:05:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:05:36 INFO - 'PWD': '/builds/slave/test', 23:05:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:05:36 INFO - 'SHELL': '/bin/bash', 23:05:36 INFO - 'SHLVL': '1', 23:05:36 INFO - 'TERM': 'linux', 23:05:36 INFO - 'TMOUT': '86400', 23:05:36 INFO - 'USER': 'cltbld', 23:05:36 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1464587935.651288-1955508040', 23:05:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:36 INFO - '_': '/tools/buildbot/bin/python'} 23:05:36 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/S76xzm6FSVujY9rMjXc8BQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 23:05:36 INFO - mozversion application_buildid: 20160529203123 23:05:36 INFO - mozversion application_changeset: e0354aa795ba11ec139cbe286e7217ba4fd0ad3e 23:05:36 INFO - mozversion application_display_name: Nightly 23:05:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:05:36 INFO - mozversion application_name: Firefox 23:05:36 INFO - mozversion application_remotingname: firefox 23:05:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:05:36 INFO - mozversion application_vendor: Mozilla 23:05:36 INFO - mozversion application_version: 49.0a1 23:05:36 INFO - mozversion platform_buildid: 20160529203123 23:05:36 INFO - mozversion platform_changeset: e0354aa795ba11ec139cbe286e7217ba4fd0ad3e 23:05:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:05:36 INFO - mozversion platform_version: 49.0a1 23:05:36 INFO - using testdate: 1464588336 23:05:36 INFO - actual date: 1464588336 23:05:36 INFO - starting webserver on 'localhost:40372' 23:05:36 INFO - SUITE-START | Running 2 tests 23:05:36 INFO - TEST-START | dromaeo_css 23:05:36 INFO - operating with platform_type : linux_ 23:05:36 INFO - Initialising browser for dromaeo_css test... 23:05:36 INFO - TEST-INFO | started process 7327 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWf0QyB/profile http://localhost:40372/getInfo.html) 23:05:40 INFO - PROCESS | 7327 | __metrics Screen width/height:1600/1200 23:05:40 INFO - PROCESS | 7327 | colorDepth:24 23:05:40 INFO - PROCESS | 7327 | Browser inner width/height: 1024/697 23:05:40 INFO - PROCESS | 7327 | __metrics 23:05:41 ERROR - PROCESS | 7327 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:05:42 INFO - TEST-INFO | 7327: exit 0 23:05:42 INFO - Browser initialized. 23:05:42 INFO - Running cycle 1/1 for dromaeo_css test... 23:05:42 INFO - TEST-INFO | started process 7407 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWf0QyB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:05:54 INFO - PROCESS | 7407 | RSS: Main: 156086272 23:05:54 INFO - PROCESS | 7407 | 23:06:45 INFO - PROCESS | 7407 | 1464588405224 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] 23:08:53 INFO - PROCESS | 7407 | Cycle 1(1): loaded http://localhost:40372/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40372/tests/dromaeo/cssquery-ext.html) 23:08:54 INFO - PROCESS | 7407 | RSS: Main: 263442432 23:08:54 INFO - PROCESS | 7407 | 23:11:56 INFO - PROCESS | 7407 | Cycle 1(1): loaded http://localhost:40372/tests/dromaeo/cssquery-ext.html (next: http://localhost:40372/tests/dromaeo/cssquery-jquery.html) 23:11:57 INFO - PROCESS | 7407 | RSS: Main: 252862464 23:11:57 INFO - PROCESS | 7407 | 23:14:59 INFO - PROCESS | 7407 | Cycle 1(1): loaded http://localhost:40372/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40372/tests/dromaeo/cssquery-mootools.html) 23:14:59 INFO - PROCESS | 7407 | RSS: Main: 251482112 23:14:59 INFO - PROCESS | 7407 | 23:18:01 INFO - PROCESS | 7407 | Cycle 1(1): loaded http://localhost:40372/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40372/tests/dromaeo/cssquery-prototype.html) 23:18:02 INFO - PROCESS | 7407 | RSS: Main: 231464960 23:18:02 INFO - PROCESS | 7407 | 23:21:05 INFO - PROCESS | 7407 | Cycle 1(1): loaded http://localhost:40372/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40372/tests/dromaeo/cssquery-yui.html) 23:21:05 INFO - PROCESS | 7407 | RSS: Main: 204013568 23:21:05 INFO - PROCESS | 7407 | 23:24:08 INFO - PROCESS | 7407 | Cycle 1(1): loaded http://localhost:40372/tests/dromaeo/cssquery-yui.html (next: http://localhost:40372/tests/dromaeo/cssquery-dojo.html) 23:24:08 INFO - PROCESS | 7407 | RSS: Main: 291713024 23:24:08 INFO - PROCESS | 7407 | 23:24:08 INFO - PROCESS | 7407 | __start_tp_report 23:24:08 INFO - PROCESS | 7407 | _x_x_mozilla_page_load 23:24:08 INFO - PROCESS | 7407 | _x_x_mozilla_page_load_details 23:24:08 INFO - PROCESS | 7407 | |i|pagename|runs| 23:24:08 INFO - PROCESS | 7407 | |0;dojo.html;3132.624085109786;3139.68603139686;3161.9051428457146;3175.1903264667535;3192.1700357906952;5280.735963201843;5322.095243808552;5355.812546560871;5450.100733378993;5456.4543545645365;5346.705931173784;5388.9191662125;5415.025295446818;5420.078586640271;5466.781328746845;4866.391701037371;4955.231939049453;4966.478519755427;4968.57767089796;5087.7710503027265;4983.651144419892;4992.925106123393;5038.949610503903;5046.394432668085;5060.620453465986;4831.613470922318;4842.29786680931;4907.190313598252;4914.754262286871;4929;4912.238603016538;4934.6052315815;4973.154563724175;4993.375828021497;5011.57401620859;4857.82997595086;4957.5786058185095;4962.503749625044;4974.825881094181;4997.475265097185;5320.920186197211;5364.7317634118135;5372.382176049765;5418.376886658046;5443.727813609344;5842.824715258549;5851.4148585141575;5873.735681894283;5876.265466816648;5880.558958078162;5597.916031259534;5746.339170995306;5753.482186603226;5837.036888913367;5876.1479585459865;5438.53772429344;5448.809291674812;5456.61803673747;5461.399246082928;5464.098423760035;6000.519958403317;6035.969820150871;6037.486813620892;6043.244594425697;6046.818595442144;5515.338159420895;5692.0608099663095;5717.542596592262;5738.995675756726;5782.335031471434;5838.824835254949;5848.2689663792025;5894.145348924468;5899.76400943966;5900.822975310747;5815.680137592389;5817.0983497557945;5819.923314186889;5829.912551311733;5832.591718579743;5517.282753242052;5725.026745453283;5766.855828604234;5788.27646544182;5839.854003649943;4423.358613001097;4427.313766366218;4429.468463784367;4429.689921705514;4466.240739074366;3826.253880493277;3941.507311586052;3962.2669806085964;3977.3835055566433;3982.26328129297;5431.456854314537;5465.808696695596;5495.890082198333;5534.059209934321;5540.390557038803;5778.104393818965;5779.537636989031;5783.624064435799;5787.074068149076;5832.9708351457975;5310.415854256029;5446.618736688473;5475.09660905954;5477.260569823023;5477.698726570077;4985.227289770091;5010.2735103409805;5015.448300686921;5033.974830125826;5057.393112826484;6043.335233124353;6049.879002419927;6055;6061.121137435047;6064.636121832704;5538.889222215453;5772.451617096369;5780.190773291659;5848.824535263949;5865.765369385347;5991.7902873399225;6017.247844019497;6019.337872833898;6020.277566692025;6054.424829641177;5700.315962084411;5745.770169193353;5746.281714785652;5750.741216645178;5760.740766665426;5651.88696226065;5801.738921748616;5821.534277257894;5844.357120716632;5861.325947515919;5742.196092546963;5744.626599271034;5747.7413516391025;5754.367019627922;5764.279465066867;5691.601587888808;5723.7996670116345;5745.626534275259;5745.712714364348;5752.626079304831;5405.486478784509;5486.725663716718;5504.2018907257425;5549.556035517068;5576.804811831566;5689.77240910359;5707.543396528351;5728.283964504437;5742.109972954198;5754.338251101177;5422.9186562202385;5539.086050801734;5588.050031494575;5590.804321848878;5598.216249725123 23:24:08 INFO - PROCESS | 7407 | |1;ext.html;591.2934043817637;616.5591602004566;635.974561017559;650.1418128070945;667.869765395748;30278.39443211137;42568.787156064216;43162.46794086619;43409.78295108528;43515.564844351546;44713;45071.77464112675;45098;45200.09599808002;45221.54778452215;8554.828903421927;8782.165694259034;8793.384463087586;8796.208341249287;8799.34004949628;8645.178708022728;8770.780730481725;8775.780605484882;8777.868331974994;8782.560871956408;8813.647454101829;8851.557422128868;8856.335774816882;8858.73423797287;8860.645574177026;8786.384953053288;8811.118888111201;8840.690575829847;8845.557722113868;8845.955770221171;8651.783705407352;8740.781480462976;8743.868841967376;8746.125387461267;8747.343949203772;39326.21347573061;39521.20957580861;39561.80219098915;39569.40645890314;39655.20689586192;3378;3452.3095380923664;3581.6418358163974;3975.662068724162;4097.426360309559;29735.70264297351;31738.653237781542;32393.51409728856;32447.351052978807;32459;4337.783110844445;4372.956270437287;4443.733375997451;4535.223836200473;4572.885677858047;349845;349967;350680;351630;351688;59940;60833.69583152144;61168.69415652893;61217.38782612206;61219.38780612137;63763.68118159472;63866.68066659637;63917.36082639207;63922;64010.35989640044;15837.287322070535;16110.355585776437;16111.597210069607;16114.355425782838;16119.435819746488;12202.572909948109;12322.938385308016;12330.81503777444;12332.32172230536;12335.753284934251;18704.652734276704;19408.070682858186;19489.122974545637;19507.7511275726;19557.8935810221;7005.229424763374;7110.1823290321245;7286.417086633057;7442.516236444614;7486.7005319786595;1008.5814387029301;1024.1192574386023;1068.8289873620183;1086.7228856641507;1101.0255923507752;32091;32232.677673222966;32482.187945301557;32550.34899302001;33368;1133.3426612564692;1149.4712432281244;1181.69126445951;1188.738477534941;1258.672745086284;16472.25874835635;16681.582960425843;16769.580760481087;17011.149442527825;17105.694937502034;559949;560673;565771;566098;568773;58281.70859145762;58592.414075858695;58964.70517647384;59084.70457647684;59164.704176478845;1266.120046567645;1352.6415499892537;1364.3382959264748;1365.4674676876027;1383.2115694054494;29422.852885735436;31593.8420307897;33019.17452063622;33284.500732488545;33804.66195338113;55487.890242194124;55642.72178639081;56063.43936560745;56116;56687.43312566821;500787;505952;506935;508372;509321;36914.63085369112;41745.16509669729;42773.57226427696;43086.56913430826;43424.56575434205;47301.29048064213;48222.517774821805;48493.5150648489;49318.26022609736;49403.752981234866;40002.79635076253;41230.587694122674;41371.793141034104;41537.1692566153;42237.78881105575;39764;40124;40532.79733601313;41158.1768364637;41414.1717165661;40740.185196295315;41331.380029300184;41431.7928410356;41814;41838.372424414265;34487.82756086203;35676.82161589176;36579.451308229865;36736.63263367332;36910.815445923676;27998;28047.859760701067;28306;28414.57378139371;28493.715062849107 23:24:08 INFO - PROCESS | 7407 | |2;jquery.html;374.9062734316421;377.7697774314613;383.89634798604396;387.1656580069949;393.47471126046725;15225.086494810319;17129.400470983517;17978.190981405834;20274;20298.797012029892;17486.562835929075;17661;17819.821801781978;17828.465146045608;19672.21311147556;5551.611387202907;5714.857128571798;5772.105323674838;5802.332731735841;5841.15303281024;4130.297849365615;5665.3201615806165;6087.269527656666;6393.904091438632;6405.711742971577;6342.302346741878;6364.33174516676;6430.196225471816;6452.709628066748;6465.224173099211;6167.969160154215;6331.081993111019;6437.259715132773;6439.774607888725;6457.2896981332015;5410.565245639478;5492.642978206443;5497.945020549823;5512.366077901052;5591.2731344925305;20466.897665511726;20472.283470078477;20490.077946492445;23443.88278058616;23652.881735591385;2428.6964129483813;2455.3370589940796;2633.249523885683;2633.3548280671357;2855.286178455386;14104.294785260696;14390.352434140385;14479.638009049753;14818.110913345234;14871;1938.185961896007;1962.6369121712528;1976.179885347579;1976.3082920977686;2085.8227050700707;79439.20560794376;79827;81074.18925810726;81287;82420;10012.549435275285;10033.598656053822;10057.547410366551;10142.645007424851;10156.949215253877;13873.930630346986;13934.512292069932;13940.930295348458;13951.58145255644;13963;7404.407647388196;7415.295546923034;7538.585377804274;7599.316061554487;7687.6156192190165;7227.387996618732;7308.8305871060375;7348.63256837156;7372.004779354718;7458.925410745932;6339.415146213447;6385.7126429309865;6429.935700642934;6461;6568.277489476154;1628.5033064915078;1708.470374184007;1798.2267624921149;1803.2786885246007;1832.4227868221467;941.6421759731395;995.6415690351467;1044.639599338227;1092.1208427216009;1157.4444266752007;18611.90694046548;18921;19213;20156.798432015494;20395.388138355873;973.6689525561343;988.6935050134481;1011.0546638892512;1075.2634445404922;1090.0788833435734;10614.522346494427;11144.33134011962;11147.331160130418;11175.944120279346;11184.888151118384;501822;505532;505702;516839;517979;62739.6863015682;88575.55712221526;95047;96903;100864;1023.1967905194387;1035.0477560644226;1037.4397825174321;1048.3866937841296;1050.186105768036;17384.47846564605;17492.421607116336;17659.823401765818;17750.822491774918;17825.197866096318;41201.79399102985;42262.15475690408;43595;43890.56109438992;43917.341239880785;60530;60571;61480;62207.37792622016;62525.37474625195;7185.676644551112;8191.180881911761;8328.750137495885;8455.069942306465;8494.447860889022;11405.714857128638;13390.196588204739;13413.463461461432;13734.862651373358;13755.17468951866;11909.642710718692;11909.702257443287;12133.69665758363;12138.75722485563;12141;11373.488193031168;11389.04464414187;11471.254368466023;11526.423678816192;11776.528938842694;11702.765944681229;12044.457999390224;12125;12214;12230.510779569073;7457.2542745724995;7485.214052524407;7516.47384683067;7628.732994345171;7697.65360558765;11366.204365694653;11928.403579821148;11961.401929903295;11976;12080 23:24:08 INFO - PROCESS | 7407 | |3;mootools.html;1333.3866421446135;1537.7539593665015;1555.7044161609294;1741.7648617436641;1862.6647203503373;8845.203931646158;9197.0802919708;9197.678081267157;9490.76273093173;9495.667651632195;9170.220531254852;9396.389234699756;9401.623935042608;9422.52887355633;9432.52837358131;2347.800436962856;2374.7743964323363;2376.536575367804;2377.072941552787;2381.273711517986;2348.7768661977084;2397.832151749378;2403.0267741564694;2403.4472071423497;2405.0259644843777;2327.650852372149;2333.3349995251356;2358.492924021335;2363.728171260301;2365.7161140663143;2187.7374715034216;2187.73747150343;2204.9889750551306;2208.4920468292303;2256.5670799042728;2212.7455342635644;2216.5345277491747;2216.56776928499;2221.766714494971;2227.9331620051425;8826.823463530758;9008.144226298491;9249.861252081157;9312.255019598484;9312.487813170274;5158.380994280673;5269.815556455544;5281.683099014072;5281.735913204363;5288.68267903927;3323.5347051412823;3352.3127758809387;3363.1087761743156;3428.5542879425516;3432.5880894292595;1080.200651517879;1131.6209069961574;1133.846930664358;1161.1755653486034;1163.9825402618967;13034.41345139471;13183.934080329633;13189;13195.472181112744;13198.076134670673;4464.933026004613;4483.125790470827;4572.314152877095;4578.336141259499;4598.954010459853;10219.540120694586;10310.432926188982;10365.740856478498;10375.066244038073;10382.273240873066;5253.317068781034;5256.421793602701;5259.316288882497;5265.104932161542;5270.604704647167;4269.786510674516;4623.976880115578;4712.670113092051;4732.313814496879;4819.807207711722;3775.6601905828607;3807.7524960877454;3830.272248272819;3844.4041173618134;3871.2451072041245;1025.1542477456128;1156.988430115705;1159.4087015622094;1167.830664553635;1181.255808840425;827.6399766101765;863.3956230638453;889.8531742262454;933.3140141995764;949.5110018340561;5933.821985340447;6086.878262434815;6311.652859092794;6412.166418365676;6435.06691529735;441.3247730971619;451.54845154845157;451.58454222115734;464.8884267775777;624.073251221935;4163.562825903297;4193.098483825992;4235;4275.486941567032;4290.249206388869;11562.595309164308;11833.704157395961;11943.954291655573;11978.940105299418;11987.700307492383;11693.239939404082;11767.23512971654;11814.232074915102;11831.645050648494;11834.349110798988;8119.959400202961;8601.22588966996;8640.222379985831;8645.524496152646;8658;5963.821085367446;6158.476529494864;6243.906341404973;6265.310815810166;6320.273168585672;10544.525496352837;10718.24972251935;10829.891701082888;10893.01962823318;10991.120710343313;10957.561697532328;10965.396903170402;11006.174536909924;11101.38942358178;11105.167112466435;7097.148342198969;7429.182789893215;7615.923840761743;7639.312461878458;7898.723544675909;9269.67556135532;9287.67493137764;9300.302477314093;9338.066193380879;9339.719808405758;7705.922940770521;7917.643706033357;7923.326517246099;7969.733927371474;8041.597920104088;7693.538387696756;7750.7674769756995;7831.608419578884;7851.293383595504;7873.645685944261;7382.852342953218;7521.097468303619;7609.809754756176;7621.1616722161625;7622.771316860503;5350.143976963667;5358.517733404013;5373.194020896896;5397.70312632809;5514.972425137848;5193.714345711022;5281.366236051698;5289.444608316226;5389.56883449331;5444.537214336826 23:24:08 INFO - PROCESS | 7407 | |4;prototype.html;317.7092959941652;319.3819958380534;324.85706289232724;325.2584108233228;329.170490364282;5407.729613519328;5418.78077432578;5434.212039254311;5457.508824205831;5470.835874923749;5318.547923426513;5342.465753424655;5342.759575819097;5352.652077614952;5384.838454846361;3995.880123596297;4018.557958624549;4200.873973780776;4210.3894935234375;4214.641755450791;4137.317342638461;4146.3780432935155;4173.268093741094;4183.351580505011;4186.58134186582;3952.288588054149;4145.709800313979;4152.501699796014;4153.335466325389;4160.854370097048;4025.496812898388;4137.91724165518;4142.668586513087;4155.794819502341;4161.479815023122;3631.5097461842843;3638.6179451157514;3645.7447978641508;3654.7391150053454;3655.3054919565197;5139.511746384088;5144.6141539384325;5179.300794392747;5203.19350500673;5227.45111763267;4418.447694038246;4661.720296782204;4674.20043283335;4678.672492925497;4679.15775160471;5471;5485.50630443262;5487.533559647435;5498.285222921035;5520.66875987438;3915.2561013407644;3918.0988372674447;3945.4081887716784;3945.4081887716784;3947.743396679207;5670.744816483269;5729.656220626817;5760.971195143998;5777.682227477487;5783.21926539916;3974.5826688197903;3988.262171498282;3995.640392364643;4022.5977402260123;4026.2350153470748;4080.591940805896;4086.203190377907;4103.097318589906;4103.938440923389;4110.219058378899;4528.320751887178;4636.26140197426;4700.153972285021;4706.411698537683;4764.4520880098535;5601.467860553323;5631.521320687705;5641.153826925912;5647.463490968352;5672.517835983987;1374.4845682868925;1399.4262352435655;1402.8527004664363;1404.9578512644637;1408.1762169130968;868.5917618719192;887.238830920622;891.8584212208384;894.4141587260225;898.910108989109;5169.638125331191;5203.713795741195;5229.843104706865;5326.334208223972;5333.679979201261;5717.599768016282;5724.141378793214;5725.971370143123;5742.368339482654;5761.942380576224;5191.117510023305;5398.271233383443;5407.188921661782;5408.161734931092;5414.729263536808;3013.8794448222266;3016.4570377332293;3023.805596789256;3035.3474003089;3060.158456424501;5814.592978491465;5835.912461313083;5848.356680765112;5858.794942177088;5864.9736296148;5531.84258139326;5874.795666888278;5925.903707814068;5964.642121472725;5978.85052873673;5922.911156332744;5934.495567876779;5978.790742323998;6006.699665016732;6026.758929642853;5515.758954235265;5705.885882282248;5740.0815869460685;5758.568107391879;5804.65172089676;5683.914741278802;5685.289338832646;5697.604086998712;5714.5999780015;5725.022988046109;5851.444112809277;5896.528277737856;5904.114382842608;5934.347221805511;5975.34271230173;3820.522434695663;4013.8394464221105;4025.315696331689;4029.37544680575;4031.6573091286396;5679.318481782213;5699.829005129853;5728.713564321851;5761.567882408753;5768.53851691872;5371.650842695212;5560.470870510642;5595.860103497445;5596.692181930033;5622.6064175508955;5283.630145889751;5469.429368196941;5522.475364840334;5540.279763630702;5599.832005039855;5477.726113694379;5498.285222921155;5501.229827824028;5503.724813759376;5507.366652834975;5349.812756553502;5557.499825015768;5569.164625306236;5609.803656872153;5622.606417550732;5546.473085056913;5558.527525160245;5574.749136288958;5585.374873809303;5590.965671350813 23:24:08 INFO - PROCESS | 7407 | |5;yui.html;752.8833030880212;764.6482617995722;785.9096203936546;788.3732432715991;839.4543546694648;13487.527936522223;14261.572152835406;14284.71430571388;14287.571372858818;14300.28498575071;13558.050936434454;13591.524296649619;13605.387757550909;13608;13618.591442256748;668.8796016716989;769.9076110866675;794.3486341200218;797.4059325802285;802.0896282719127;793.5278509286965;794.3327604811957;794.5153456391597;799.5122974985284;801.6993627389729;841.8610929196675;843.1020962674762;843.439112989861;844.025150950653;844.6494704697543;693.2478261086727;825.4180802534229;840.1178762299561;840.3277378097528;848.465466755946;628.5066223014911;628.673089993201;628.9967501834567;629.5215636116538;629.527854109418;14076.859231407658;14109.78835317471;14113;14138.363773630108;14147.929260353736;13268.40292186854;13352.732945341137;13398.665033374145;13679.726405471934;13884.4446222151;12469.625911222678;12616.81074783879;12704.364781760874;12790.808137877939;12905.35473226335;4452.3989261449615;4479.484859241164;4499.865004049851;4581.67928245023;4665.790039448233;57635.42364576385;57940.42059579435;57988.71005644987;58159;58176.70911645415;11051.447427628586;11054.944725276322;11095.667129986114;11242.887571124347;11250.156238282161;20457.795422045885;20484;20538.17847286122;20538.897305513674;20543.178272868918;7924.366050715929;7953.443258971932;7997.680382736783;8030.759077227693;8216.055153657406;4564.566366195206;4624.28323609841;4636.165490211727;4680;4791.089692958327;3337.5494308268558;3492.965070349264;3493.2489514753943;3541.11472131967;3542.1498840278146;588.785093440891;613.1262950295811;662.5792621685265;694.7047504810537;701.9719211231494;651.5406638319973;686.5228666077128;719.6365835253164;735.3528894572742;751.1624538639378;9311.993967296428;9333.579988900516;9437.150656440954;9536.856947145798;9594.328397012281;617.8084793713963;700.9509334346649;737.7454778101546;752.5371896283856;760.4562737642613;4544.341070544752;4655.627549796008;4657.301404789241;4659.394278743742;4676.251799712029;75046.62476687582;76827;77651.61174194093;80574;80966.59516702378;65011.67494162499;66054.66972665106;67101;68581.65709171422;71419.28580714126;51337.74331128395;51607.48392516102;53491.197632034775;60321;60561;10028.498575071364;10054.949725251327;10154.492275386054;10158.171529124533;10256.641017564349;37690;37994.620053800216;38300;38423.03942401462;38693.613063869;47352.52647473619;51235.23147152721;51617;51649.741751291;53644.463555363945;12451.875481245072;12735;12772.680682982627;12777;13094.541691040768;13891.235982021086;14305.141691498544;14327.856721432652;14443.3500492476;14487.130772153705;13505.729885402434;13630.318484075955;13840.169589824643;13893.444262229397;14436.783448248074;13413.463461461432;13466.596002119952;13619.25094119833;13808.861911380758;13963.58109256724;13145.737085258432;13391.732165356443;13627.114237574526;13633;14059.507917222849;10994.780104398027;11151.16366272549;11343.489542970421;11604.535818567501;11800.409979501163;10664.680059598224;10674;11136.665900023012;11166.441677916235;11455.36995465224 23:24:08 INFO - PROCESS | 7407 | __end_tp_report 23:24:08 INFO - PROCESS | 7407 | __start_cc_report 23:24:08 INFO - PROCESS | 7407 | _x_x_mozilla_cycle_collect,871 23:24:08 INFO - PROCESS | 7407 | __end_cc_report 23:24:08 INFO - PROCESS | 7407 | __startTimestamp1464589448563__endTimestamp 23:24:08 INFO - PROCESS | 7407 | 23:24:08 INFO - PROCESS | 7407 | ------- Summary: start ------- 23:24:08 INFO - PROCESS | 7407 | Number of tests: 6 23:24:08 INFO - PROCESS | 7407 | 23:24:08 INFO - PROCESS | 7407 | [#0] dojo.html Cycles:165 Average:5396.91 Median:5540.39 stddev:614.96 (11.1%) stddev-sans-first:590.64 23:24:08 INFO - PROCESS | 7407 | Values: 3132.6 3139.7 3161.9 3175.2 3192.2 5280.7 5322.1 5355.8 5450.1 5456.5 5346.7 5388.9 5415.0 5420.1 5466.8 4866.4 4955.2 4966.5 4968.6 5087.8 4983.7 4992.9 5038.9 5046.4 5060.6 4831.6 4842.3 4907.2 4914.8 4929.0 4912.2 4934.6 4973.2 4993.4 5011.6 4857.8 4957.6 4962.5 4974.8 4997.5 5320.9 5364.7 5372.4 5418.4 5443.7 5842.8 5851.4 5873.7 5876.3 5880.6 5597.9 5746.3 5753.5 5837.0 5876.1 5438.5 5448.8 5456.6 5461.4 5464.1 6000.5 6036.0 6037.5 6043.2 6046.8 5515.3 5692.1 5717.5 5739.0 5782.3 5838.8 5848.3 5894.1 5899.8 5900.8 5815.7 5817.1 5819.9 5829.9 5832.6 5517.3 5725.0 5766.9 5788.3 5839.9 4423.4 4427.3 4429.5 4429.7 4466.2 3826.3 3941.5 3962.3 3977.4 3982.3 5431.5 5465.8 5495.9 5534.1 5540.4 5778.1 5779.5 5783.6 5787.1 5833.0 5310.4 5446.6 5475.1 5477.3 5477.7 4985.2 5010.3 5015.4 5034.0 5057.4 6043.3 6049.9 6055.0 6061.1 6064.6 5538.9 5772.5 5780.2 5848.8 5865.8 5991.8 6017.2 6019.3 6020.3 6054.4 5700.3 5745.8 5746.3 5750.7 5760.7 5651.9 5801.7 5821.5 5844.4 5861.3 5742.2 5744.6 5747.7 5754.4 5764.3 5691.6 5723.8 5745.6 5745.7 5752.6 5405.5 5486.7 5504.2 5549.6 5576.8 5689.8 5707.5 5728.3 5742.1 5754.3 5422.9 5539.1 5588.1 5590.8 5598.2 23:24:08 INFO - PROCESS | 7407 | 23:24:08 INFO - PROCESS | 7407 | [#1] ext.html Cycles:180 Average:63566.25 Median:41826.19 stddev:128142.24 (306.4%) stddev-sans-first:128414.48 23:24:08 INFO - PROCESS | 7407 | Values: 591.3 616.6 636.0 650.1 667.9 30278.4 42568.8 43162.5 43409.8 43515.6 44713.0 45071.8 45098.0 45200.1 45221.5 8554.8 8782.2 8793.4 8796.2 8799.3 8645.2 8770.8 8775.8 8777.9 8782.6 8813.6 8851.6 8856.3 8858.7 8860.6 8786.4 8811.1 8840.7 8845.6 8846.0 8651.8 8740.8 8743.9 8746.1 8747.3 39326.2 39521.2 39561.8 39569.4 39655.2 3378.0 3452.3 3581.6 3975.7 4097.4 29735.7 31738.7 32393.5 32447.4 32459.0 4337.8 4373.0 4443.7 4535.2 4572.9 349845.0 349967.0 350680.0 351630.0 351688.0 59940.0 60833.7 61168.7 61217.4 61219.4 63763.7 63866.7 63917.4 63922.0 64010.4 15837.3 16110.4 16111.6 16114.4 16119.4 12202.6 12322.9 12330.8 12332.3 12335.8 18704.7 19408.1 19489.1 19507.8 19557.9 7005.2 7110.2 7286.4 7442.5 7486.7 1008.6 1024.1 1068.8 1086.7 1101.0 32091.0 32232.7 32482.2 32550.3 33368.0 1133.3 1149.5 1181.7 1188.7 1258.7 16472.3 16681.6 16769.6 17011.1 17105.7 559949.0 560673.0 565771.0 566098.0 568773.0 58281.7 58592.4 58964.7 59084.7 59164.7 1266.1 1352.6 1364.3 1365.5 1383.2 29422.9 31593.8 33019.2 33284.5 33804.7 55487.9 55642.7 56063.4 56116.0 56687.4 500787.0 505952.0 506935.0 508372.0 509321.0 36914.6 41745.2 42773.6 43086.6 43424.6 47301.3 48222.5 48493.5 49318.3 49403.8 40002.8 41230.6 41371.8 41537.2 42237.8 39764.0 40124.0 40532.8 41158.2 41414.2 40740.2 41331.4 41431.8 41814.0 41838.4 34487.8 35676.8 36579.5 36736.6 36910.8 27998.0 28047.9 28306.0 28414.6 28493.7 23:24:08 INFO - PROCESS | 7407 | 23:24:08 INFO - PROCESS | 7407 | [#2] jquery.html Cycles:180 Average:29597.66 Median:23548.38 stddev:83910.93 (356.3%) stddev-sans-first:84117.63 23:24:08 INFO - PROCESS | 7407 | Values: 374.9 377.8 383.9 387.2 393.5 15225.1 17129.4 17978.2 20274.0 20298.8 17486.6 17661.0 17819.8 17828.5 19672.2 5551.6 5714.9 5772.1 5802.3 5841.2 4130.3 5665.3 6087.3 6393.9 6405.7 6342.3 6364.3 6430.2 6452.7 6465.2 6168.0 6331.1 6437.3 6439.8 6457.3 5410.6 5492.6 5497.9 5512.4 5591.3 20466.9 20472.3 20490.1 23443.9 23652.9 2428.7 2455.3 2633.2 2633.4 2855.3 14104.3 14390.4 14479.6 14818.1 14871.0 1938.2 1962.6 1976.2 1976.3 2085.8 79439.2 79827.0 81074.2 81287.0 82420.0 10012.5 10033.6 10057.5 10142.6 10156.9 13873.9 13934.5 13940.9 13951.6 13963.0 7404.4 7415.3 7538.6 7599.3 7687.6 7227.4 7308.8 7348.6 7372.0 7458.9 6339.4 6385.7 6429.9 6461.0 6568.3 1628.5 1708.5 1798.2 1803.3 1832.4 941.6 995.6 1044.6 1092.1 1157.4 18611.9 18921.0 19213.0 20156.8 20395.4 973.7 988.7 1011.1 1075.3 1090.1 10614.5 11144.3 11147.3 11175.9 11184.9 501822.0 505532.0 505702.0 516839.0 517979.0 62739.7 88575.6 95047.0 96903.0 100864.0 1023.2 1035.0 1037.4 1048.4 1050.2 17384.5 17492.4 17659.8 17750.8 17825.2 41201.8 42262.2 43595.0 43890.6 43917.3 60530.0 60571.0 61480.0 62207.4 62525.4 7185.7 8191.2 8328.8 8455.1 8494.4 11405.7 13390.2 13413.5 13734.9 13755.2 11909.6 11909.7 12133.7 12138.8 12141.0 11373.5 11389.0 11471.3 11526.4 11776.5 11702.8 12044.5 12125.0 12214.0 12230.5 7457.3 7485.2 7516.5 7628.7 7697.7 11366.2 11928.4 11961.4 11976.0 12080.0 23:24:08 INFO - PROCESS | 7407 | 23:24:08 INFO - PROCESS | 7407 | [#3] mootools.html Cycles:180 Average:6011.77 Median:2511.95 stddev:3582.09 (142.6%) stddev-sans-first:3574.89 23:24:08 INFO - PROCESS | 7407 | Values: 1333.4 1537.8 1555.7 1741.8 1862.7 8845.2 9197.1 9197.7 9490.8 9495.7 9170.2 9396.4 9401.6 9422.5 9432.5 2347.8 2374.8 2376.5 2377.1 2381.3 2348.8 2397.8 2403.0 2403.4 2405.0 2327.7 2333.3 2358.5 2363.7 2365.7 2187.7 2187.7 2205.0 2208.5 2256.6 2212.7 2216.5 2216.6 2221.8 2227.9 8826.8 9008.1 9249.9 9312.3 9312.5 5158.4 5269.8 5281.7 5281.7 5288.7 3323.5 3352.3 3363.1 3428.6 3432.6 1080.2 1131.6 1133.8 1161.2 1164.0 13034.4 13183.9 13189.0 13195.5 13198.1 4464.9 4483.1 4572.3 4578.3 4599.0 10219.5 10310.4 10365.7 10375.1 10382.3 5253.3 5256.4 5259.3 5265.1 5270.6 4269.8 4624.0 4712.7 4732.3 4819.8 3775.7 3807.8 3830.3 3844.4 3871.2 1025.2 1157.0 1159.4 1167.8 1181.3 827.6 863.4 889.9 933.3 949.5 5933.8 6086.9 6311.7 6412.2 6435.1 441.3 451.5 451.6 464.9 624.1 4163.6 4193.1 4235.0 4275.5 4290.2 11562.6 11833.7 11944.0 11978.9 11987.7 11693.2 11767.2 11814.2 11831.6 11834.3 8120.0 8601.2 8640.2 8645.5 8658.0 5963.8 6158.5 6243.9 6265.3 6320.3 10544.5 10718.2 10829.9 10893.0 10991.1 10957.6 10965.4 11006.2 11101.4 11105.2 7097.1 7429.2 7615.9 7639.3 7898.7 9269.7 9287.7 9300.3 9338.1 9339.7 7705.9 7917.6 7923.3 7969.7 8041.6 7693.5 7750.8 7831.6 7851.3 7873.6 7382.9 7521.1 7609.8 7621.2 7622.8 5350.1 5358.5 5373.2 5397.7 5515.0 5193.7 5281.4 5289.4 5389.6 5444.5 23:24:08 INFO - PROCESS | 7407 | 23:24:08 INFO - PROCESS | 7407 | [#4] prototype.html Cycles:180 Average:4685.47 Median:5407.46 stddev:1395.50 (25.8%) stddev-sans-first:1360.36 23:24:08 INFO - PROCESS | 7407 | Values: 317.7 319.4 324.9 325.3 329.2 5407.7 5418.8 5434.2 5457.5 5470.8 5318.5 5342.5 5342.8 5352.7 5384.8 3995.9 4018.6 4200.9 4210.4 4214.6 4137.3 4146.4 4173.3 4183.4 4186.6 3952.3 4145.7 4152.5 4153.3 4160.9 4025.5 4137.9 4142.7 4155.8 4161.5 3631.5 3638.6 3645.7 3654.7 3655.3 5139.5 5144.6 5179.3 5203.2 5227.5 4418.4 4661.7 4674.2 4678.7 4679.2 5471.0 5485.5 5487.5 5498.3 5520.7 3915.3 3918.1 3945.4 3945.4 3947.7 5670.7 5729.7 5761.0 5777.7 5783.2 3974.6 3988.3 3995.6 4022.6 4026.2 4080.6 4086.2 4103.1 4103.9 4110.2 4528.3 4636.3 4700.2 4706.4 4764.5 5601.5 5631.5 5641.2 5647.5 5672.5 1374.5 1399.4 1402.9 1405.0 1408.2 868.6 887.2 891.9 894.4 898.9 5169.6 5203.7 5229.8 5326.3 5333.7 5717.6 5724.1 5726.0 5742.4 5761.9 5191.1 5398.3 5407.2 5408.2 5414.7 3013.9 3016.5 3023.8 3035.3 3060.2 5814.6 5835.9 5848.4 5858.8 5865.0 5531.8 5874.8 5925.9 5964.6 5978.9 5922.9 5934.5 5978.8 6006.7 6026.8 5515.8 5705.9 5740.1 5758.6 5804.7 5683.9 5685.3 5697.6 5714.6 5725.0 5851.4 5896.5 5904.1 5934.3 5975.3 3820.5 4013.8 4025.3 4029.4 4031.7 5679.3 5699.8 5728.7 5761.6 5768.5 5371.7 5560.5 5595.9 5596.7 5622.6 5283.6 5469.4 5522.5 5540.3 5599.8 5477.7 5498.3 5501.2 5503.7 5507.4 5349.8 5557.5 5569.2 5609.8 5622.6 5546.5 5558.5 5574.7 5585.4 5591.0 23:24:08 INFO - PROCESS | 7407 | 23:24:08 INFO - PROCESS | 7407 | [#5] yui.html Cycles:180 Average:16402.11 Median:4602.98 stddev:20152.45 (437.8%) stddev-sans-first:20174.72 23:24:08 INFO - PROCESS | 7407 | Values: 752.9 764.6 785.9 788.4 839.5 13487.5 14261.6 14284.7 14287.6 14300.3 13558.1 13591.5 13605.4 13608.0 13618.6 668.9 769.9 794.3 797.4 802.1 793.5 794.3 794.5 799.5 801.7 841.9 843.1 843.4 844.0 844.6 693.2 825.4 840.1 840.3 848.5 628.5 628.7 629.0 629.5 629.5 14076.9 14109.8 14113.0 14138.4 14147.9 13268.4 13352.7 13398.7 13679.7 13884.4 12469.6 12616.8 12704.4 12790.8 12905.4 4452.4 4479.5 4499.9 4581.7 4665.8 57635.4 57940.4 57988.7 58159.0 58176.7 11051.4 11054.9 11095.7 11242.9 11250.2 20457.8 20484.0 20538.2 20538.9 20543.2 7924.4 7953.4 7997.7 8030.8 8216.1 4564.6 4624.3 4636.2 4680.0 4791.1 3337.5 3493.0 3493.2 3541.1 3542.1 588.8 613.1 662.6 694.7 702.0 651.5 686.5 719.6 735.4 751.2 9312.0 9333.6 9437.2 9536.9 9594.3 617.8 701.0 737.7 752.5 760.5 4544.3 4655.6 4657.3 4659.4 4676.3 75046.6 76827.0 77651.6 80574.0 80966.6 65011.7 66054.7 67101.0 68581.7 71419.3 51337.7 51607.5 53491.2 60321.0 60561.0 10028.5 10054.9 10154.5 10158.2 10256.6 37690.0 37994.6 38300.0 38423.0 38693.6 47352.5 51235.2 51617.0 51649.7 53644.5 12451.9 12735.0 12772.7 12777.0 13094.5 13891.2 14305.1 14327.9 14443.4 14487.1 13505.7 13630.3 13840.2 13893.4 14436.8 13413.5 13466.6 13619.3 13808.9 13963.6 13145.7 13391.7 13627.1 13633.0 14059.5 10994.8 11151.2 11343.5 11604.5 11800.4 10664.7 10674.0 11136.7 11166.4 11455.4 23:24:08 INFO - PROCESS | 7407 | -------- Summary: end -------- 23:24:08 INFO - PROCESS | 7407 | 23:24:09 INFO - TEST-INFO | 7407: exit 0 23:24:09 INFO - TEST-OK | dromaeo_css | took 1113009ms 23:24:09 INFO - TEST-START | kraken 23:24:09 INFO - operating with platform_type : linux_ 23:24:09 INFO - Initialising browser for kraken test... 23:24:09 INFO - TEST-INFO | started process 7587 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPvxNMh/profile http://localhost:40372/getInfo.html) 23:24:13 INFO - PROCESS | 7587 | __metrics Screen width/height:1600/1200 23:24:13 INFO - PROCESS | 7587 | colorDepth:24 23:24:13 INFO - PROCESS | 7587 | Browser inner width/height: 1024/697 23:24:13 INFO - PROCESS | 7587 | __metrics 23:24:13 ERROR - PROCESS | 7587 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:24:14 INFO - TEST-INFO | 7587: exit 0 23:24:14 INFO - Browser initialized. 23:24:14 INFO - Running cycle 1/1 for kraken test... 23:24:14 INFO - TEST-INFO | started process 7668 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPvxNMh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:24:26 INFO - PROCESS | 7668 | RSS: Main: 155901952 23:24:26 INFO - PROCESS | 7668 | 23:24:28 INFO - PROCESS | 7668 | Cycle 1(1): loaded http://localhost:40372/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40372/tests/kraken/driver.html?testName=audio-beat-detection) 23:24:29 INFO - PROCESS | 7668 | RSS: Main: 214437888 23:24:29 INFO - PROCESS | 7668 | 23:24:32 INFO - PROCESS | 7668 | Cycle 1(1): loaded http://localhost:40372/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40372/tests/kraken/driver.html?testName=audio-dft) 23:24:33 INFO - PROCESS | 7668 | RSS: Main: 199655424 23:24:33 INFO - PROCESS | 7668 | 23:24:36 INFO - PROCESS | 7668 | Cycle 1(1): loaded http://localhost:40372/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40372/tests/kraken/driver.html?testName=audio-fft) 23:24:36 INFO - PROCESS | 7668 | RSS: Main: 269103104 23:24:36 INFO - PROCESS | 7668 | 23:24:38 INFO - PROCESS | 7668 | Cycle 1(1): loaded http://localhost:40372/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40372/tests/kraken/driver.html?testName=audio-oscillator) 23:24:39 INFO - PROCESS | 7668 | RSS: Main: 179433472 23:24:39 INFO - PROCESS | 7668 | 23:24:41 INFO - PROCESS | 7668 | Cycle 1(1): loaded http://localhost:40372/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40372/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:24:42 INFO - PROCESS | 7668 | RSS: Main: 183554048 23:24:42 INFO - PROCESS | 7668 | 23:24:45 INFO - PROCESS | 7668 | Cycle 1(1): loaded http://localhost:40372/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40372/tests/kraken/driver.html?testName=imaging-darkroom) 23:24:45 INFO - PROCESS | 7668 | RSS: Main: 217628672 23:24:45 INFO - PROCESS | 7668 | 23:24:49 INFO - PROCESS | 7668 | Cycle 1(1): loaded http://localhost:40372/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40372/tests/kraken/driver.html?testName=imaging-desaturate) 23:24:49 INFO - PROCESS | 7668 | RSS: Main: 219598848 23:24:49 INFO - PROCESS | 7668 | 23:24:52 INFO - PROCESS | 7668 | Cycle 1(1): loaded http://localhost:40372/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40372/tests/kraken/driver.html?testName=json-parse-financial) 23:24:53 INFO - PROCESS | 7668 | RSS: Main: 220483584 23:24:53 INFO - PROCESS | 7668 | 23:24:54 INFO - PROCESS | 7668 | Cycle 1(1): loaded http://localhost:40372/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40372/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:24:55 INFO - PROCESS | 7668 | RSS: Main: 208867328 23:24:55 INFO - PROCESS | 7668 | 23:24:57 INFO - PROCESS | 7668 | Cycle 1(1): loaded http://localhost:40372/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40372/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:24:57 INFO - PROCESS | 7668 | RSS: Main: 210681856 23:24:57 INFO - PROCESS | 7668 | 23:24:59 INFO - PROCESS | 7668 | Cycle 1(1): loaded http://localhost:40372/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40372/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:25:00 INFO - PROCESS | 7668 | RSS: Main: 216965120 23:25:00 INFO - PROCESS | 7668 | 23:25:02 INFO - PROCESS | 7668 | Cycle 1(1): loaded http://localhost:40372/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40372/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:25:03 INFO - PROCESS | 7668 | RSS: Main: 222048256 23:25:03 INFO - PROCESS | 7668 | 23:25:06 INFO - PROCESS | 7668 | Cycle 1(1): loaded http://localhost:40372/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40372/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:25:06 INFO - PROCESS | 7668 | RSS: Main: 222351360 23:25:06 INFO - PROCESS | 7668 | 23:25:08 INFO - PROCESS | 7668 | Cycle 1(1): loaded http://localhost:40372/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40372/tests/kraken/driver.html?testName=ai-astar) 23:25:08 INFO - PROCESS | 7668 | RSS: Main: 265363456 23:25:08 INFO - PROCESS | 7668 | 23:25:08 INFO - PROCESS | 7668 | __start_tp_report 23:25:08 INFO - PROCESS | 7668 | _x_x_mozilla_page_load 23:25:08 INFO - PROCESS | 7668 | _x_x_mozilla_page_load_details 23:25:08 INFO - PROCESS | 7668 | |i|pagename|runs| 23:25:08 INFO - PROCESS | 7668 | |0;ai-astar;113;107;111;109;111;111;110;109;109;110 23:25:08 INFO - PROCESS | 7668 | |1;audio-beat-detection;148;123;129;176;129;126;155;128;163;130 23:25:08 INFO - PROCESS | 7668 | |2;audio-dft;159;160;161;158;162;159;161;162;160;161 23:25:08 INFO - PROCESS | 7668 | |3;audio-fft;74;74;74;107;75;75;73;75;107;73 23:25:08 INFO - PROCESS | 7668 | |4;audio-oscillator;82;83;105;83;84;84;129;83;84;119 23:25:08 INFO - PROCESS | 7668 | |5;imaging-gaussian-blur;117;116;116;116;116;116;116;117;116;116 23:25:08 INFO - PROCESS | 7668 | |6;imaging-darkroom;146;146;145;146;145;147;146;145;145;145 23:25:08 INFO - PROCESS | 7668 | |7;imaging-desaturate;95;95;94;95;94;94;95;95;95;94 23:25:08 INFO - PROCESS | 7668 | |8;json-parse-financial;55;53;55;54;59;53;55;52;54;63 23:25:08 INFO - PROCESS | 7668 | |9;json-stringify-tinderbox;63;62;62;62;63;62;65;62;63;63 23:25:08 INFO - PROCESS | 7668 | |10;stanford-crypto-aes;79;84;82;79;78;80;85;85;110;85 23:25:08 INFO - PROCESS | 7668 | |11;stanford-crypto-ccm;120;117;127;125;118;124;117;127;123;136 23:25:08 INFO - PROCESS | 7668 | |12;stanford-crypto-pbkdf2;164;160;159;158;160;158;159;158;156;157 23:25:08 INFO - PROCESS | 7668 | |13;stanford-crypto-sha256-iterative;63;65;65;62;62;63;62;61;61;61 23:25:08 INFO - PROCESS | 7668 | __end_tp_report 23:25:08 INFO - PROCESS | 7668 | __start_cc_report 23:25:08 INFO - PROCESS | 7668 | _x_x_mozilla_cycle_collect,1602 23:25:08 INFO - PROCESS | 7668 | __end_cc_report 23:25:08 INFO - PROCESS | 7668 | __startTimestamp1464589508793__endTimestamp 23:25:08 INFO - PROCESS | 7668 | 23:25:08 INFO - PROCESS | 7668 | ------- Summary: start ------- 23:25:08 INFO - PROCESS | 7668 | Number of tests: 14 23:25:08 INFO - PROCESS | 7668 | 23:25:08 INFO - PROCESS | 7668 | [#0] ai-astar Cycles:10 Average:110.00 Median:110.50 stddev:1.63 (1.5%) stddev-sans-first:1.32 23:25:08 INFO - PROCESS | 7668 | Values: 113.0 107.0 111.0 109.0 111.0 111.0 110.0 109.0 109.0 110.0 23:25:08 INFO - PROCESS | 7668 | 23:25:08 INFO - PROCESS | 7668 | [#1] audio-beat-detection Cycles:10 Average:140.70 Median:139.00 stddev:18.50 (13.3%) stddev-sans-first:19.43 23:25:08 INFO - PROCESS | 7668 | Values: 148.0 123.0 129.0 176.0 129.0 126.0 155.0 128.0 163.0 130.0 23:25:08 INFO - PROCESS | 7668 | 23:25:08 INFO - PROCESS | 7668 | [#2] audio-dft Cycles:10 Average:160.30 Median:161.00 stddev:1.34 (0.8%) stddev-sans-first:1.33 23:25:08 INFO - PROCESS | 7668 | Values: 159.0 160.0 161.0 158.0 162.0 159.0 161.0 162.0 160.0 161.0 23:25:08 INFO - PROCESS | 7668 | 23:25:08 INFO - PROCESS | 7668 | [#3] audio-fft Cycles:10 Average:80.70 Median:74.00 stddev:13.88 (18.8%) stddev-sans-first:14.51 23:25:08 INFO - PROCESS | 7668 | Values: 74.0 74.0 74.0 107.0 75.0 75.0 73.0 75.0 107.0 73.0 23:25:08 INFO - PROCESS | 7668 | 23:25:08 INFO - PROCESS | 7668 | [#4] audio-oscillator Cycles:10 Average:93.60 Median:83.00 stddev:17.56 (21.2%) stddev-sans-first:18.12 23:25:08 INFO - PROCESS | 7668 | Values: 82.0 83.0 105.0 83.0 84.0 84.0 129.0 83.0 84.0 119.0 23:25:08 INFO - PROCESS | 7668 | 23:25:08 INFO - PROCESS | 7668 | [#5] imaging-gaussian-blur Cycles:10 Average:116.20 Median:116.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 23:25:08 INFO - PROCESS | 7668 | Values: 117.0 116.0 116.0 116.0 116.0 116.0 116.0 117.0 116.0 116.0 23:25:08 INFO - PROCESS | 7668 | 23:25:08 INFO - PROCESS | 7668 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 23:25:08 INFO - PROCESS | 7668 | Values: 146.0 146.0 145.0 146.0 145.0 147.0 146.0 145.0 145.0 145.0 23:25:08 INFO - PROCESS | 7668 | 23:25:08 INFO - PROCESS | 7668 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 23:25:08 INFO - PROCESS | 7668 | Values: 95.0 95.0 94.0 95.0 94.0 94.0 95.0 95.0 95.0 94.0 23:25:08 INFO - PROCESS | 7668 | 23:25:08 INFO - PROCESS | 7668 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.00 stddev:3.30 (6.0%) stddev-sans-first:3.50 23:25:08 INFO - PROCESS | 7668 | Values: 55.0 53.0 55.0 54.0 59.0 53.0 55.0 52.0 54.0 63.0 23:25:08 INFO - PROCESS | 7668 | 23:25:08 INFO - PROCESS | 7668 | [#9] json-stringify-tinderbox Cycles:10 Average:62.70 Median:63.00 stddev:0.95 (1.5%) stddev-sans-first:1.00 23:25:08 INFO - PROCESS | 7668 | Values: 63.0 62.0 62.0 62.0 63.0 62.0 65.0 62.0 63.0 63.0 23:25:08 INFO - PROCESS | 7668 | 23:25:08 INFO - PROCESS | 7668 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:83.00 stddev:9.31 (11.2%) stddev-sans-first:9.64 23:25:08 INFO - PROCESS | 7668 | Values: 79.0 84.0 82.0 79.0 78.0 80.0 85.0 85.0 110.0 85.0 23:25:08 INFO - PROCESS | 7668 | 23:25:08 INFO - PROCESS | 7668 | [#11] stanford-crypto-ccm Cycles:10 Average:123.40 Median:124.50 stddev:5.87 (4.7%) stddev-sans-first:6.10 23:25:08 INFO - PROCESS | 7668 | Values: 120.0 117.0 127.0 125.0 118.0 124.0 117.0 127.0 123.0 136.0 23:25:08 INFO - PROCESS | 7668 | 23:25:08 INFO - PROCESS | 7668 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.90 Median:159.00 stddev:2.18 (1.4%) stddev-sans-first:1.32 23:25:08 INFO - PROCESS | 7668 | Values: 164.0 160.0 159.0 158.0 160.0 158.0 159.0 158.0 156.0 157.0 23:25:08 INFO - PROCESS | 7668 | 23:25:08 INFO - PROCESS | 7668 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.50 Median:62.50 stddev:1.51 (2.4%) stddev-sans-first:1.59 23:25:08 INFO - PROCESS | 7668 | Values: 63.0 65.0 65.0 62.0 62.0 63.0 62.0 61.0 61.0 61.0 23:25:08 INFO - PROCESS | 7668 | -------- Summary: end -------- 23:25:08 INFO - PROCESS | 7668 | 23:25:09 INFO - TEST-INFO | 7668: exit 0 23:25:09 INFO - TEST-OK | kraken | took 60502ms 23:25:09 INFO - SUITE-END | took 1173s 23:25:09 INFO - Completed test suite (00:19:33) 23:25:09 INFO - javascript benchmark 23:25:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3132.624085109786, 3139.68603139686, 3161.9051428457146, 3175.1903264667535, 3192.1700357906952, 5280.735963201843, 5322.095243808552, 5355.812546560871, 5450.100733378993, 5456.4543545645365, 5346.705931173784, 5388.9191662125, 5415.025295446818, 5420.078586640271, 5466.781328746845, 4866.391701037371, 4955.231939049453, 4966.478519755427, 4968.57767089796, 5087.7710503027265, 4983.651144419892, 4992.925106123393, 5038.949610503903, 5046.394432668085, 5060.620453465986, 4831.613470922318, 4842.29786680931, 4907.190313598252, 4914.754262286871, 4929.0, 4912.238603016538, 4934.6052315815, 4973.154563724175, 4993.375828021497, 5011.57401620859, 4857.82997595086, 4957.5786058185095, 4962.503749625044, 4974.825881094181, 4997.475265097185, 5320.920186197211, 5364.7317634118135, 5372.382176049765, 5418.376886658046, 5443.727813609344, 5842.824715258549, 5851.4148585141575, 5873.735681894283, 5876.265466816648, 5880.558958078162, 5597.916031259534, 5746.339170995306, 5753.482186603226, 5837.036888913367, 5876.1479585459865, 5438.53772429344, 5448.809291674812, 5456.61803673747, 5461.399246082928, 5464.098423760035, 6000.519958403317, 6035.969820150871, 6037.486813620892, 6043.244594425697, 6046.818595442144, 5515.338159420895, 5692.0608099663095, 5717.542596592262, 5738.995675756726, 5782.335031471434, 5838.824835254949, 5848.2689663792025, 5894.145348924468, 5899.76400943966, 5900.822975310747, 5815.680137592389, 5817.0983497557945, 5819.923314186889, 5829.912551311733, 5832.591718579743, 5517.282753242052, 5725.026745453283, 5766.855828604234, 5788.27646544182, 5839.854003649943, 4423.358613001097, 4427.313766366218, 4429.468463784367, 4429.689921705514, 4466.240739074366, 3826.253880493277, 3941.507311586052, 3962.2669806085964, 3977.3835055566433, 3982.26328129297, 5431.456854314537, 5465.808696695596, 5495.890082198333, 5534.059209934321, 5540.390557038803, 5778.104393818965, 5779.537636989031, 5783.624064435799, 5787.074068149076, 5832.9708351457975, 5310.415854256029, 5446.618736688473, 5475.09660905954, 5477.260569823023, 5477.698726570077, 4985.227289770091, 5010.2735103409805, 5015.448300686921, 5033.974830125826, 5057.393112826484, 6043.335233124353, 6049.879002419927, 6055.0, 6061.121137435047, 6064.636121832704, 5538.889222215453, 5772.451617096369, 5780.190773291659, 5848.824535263949, 5865.765369385347, 5991.7902873399225, 6017.247844019497, 6019.337872833898, 6020.277566692025, 6054.424829641177, 5700.315962084411, 5745.770169193353, 5746.281714785652, 5750.741216645178, 5760.740766665426, 5651.88696226065, 5801.738921748616, 5821.534277257894, 5844.357120716632, 5861.325947515919, 5742.196092546963, 5744.626599271034, 5747.7413516391025, 5754.367019627922, 5764.279465066867, 5691.601587888808, 5723.7996670116345, 5745.626534275259, 5745.712714364348, 5752.626079304831, 5405.486478784509, 5486.725663716718, 5504.2018907257425, 5549.556035517068, 5576.804811831566, 5689.77240910359, 5707.543396528351, 5728.283964504437, 5742.109972954198, 5754.338251101177, 5422.9186562202385, 5539.086050801734, 5588.050031494575, 5590.804321848878, 5598.216249725123], "value": 5355.405997366035, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.2934043817637, 616.5591602004566, 635.974561017559, 650.1418128070945, 667.869765395748, 30278.39443211137, 42568.787156064216, 43162.46794086619, 43409.78295108528, 43515.564844351546, 44713.0, 45071.77464112675, 45098.0, 45200.09599808002, 45221.54778452215, 8554.828903421927, 8782.165694259034, 8793.384463087586, 8796.208341249287, 8799.34004949628, 8645.178708022728, 8770.780730481725, 8775.780605484882, 8777.868331974994, 8782.560871956408, 8813.647454101829, 8851.557422128868, 8856.335774816882, 8858.73423797287, 8860.645574177026, 8786.384953053288, 8811.118888111201, 8840.690575829847, 8845.557722113868, 8845.955770221171, 8651.783705407352, 8740.781480462976, 8743.868841967376, 8746.125387461267, 8747.343949203772, 39326.21347573061, 39521.20957580861, 39561.80219098915, 39569.40645890314, 39655.20689586192, 3378.0, 3452.3095380923664, 3581.6418358163974, 3975.662068724162, 4097.426360309559, 29735.70264297351, 31738.653237781542, 32393.51409728856, 32447.351052978807, 32459.0, 4337.783110844445, 4372.956270437287, 4443.733375997451, 4535.223836200473, 4572.885677858047, 349845.0, 349967.0, 350680.0, 351630.0, 351688.0, 59940.0, 60833.69583152144, 61168.69415652893, 61217.38782612206, 61219.38780612137, 63763.68118159472, 63866.68066659637, 63917.36082639207, 63922.0, 64010.35989640044, 15837.287322070535, 16110.355585776437, 16111.597210069607, 16114.355425782838, 16119.435819746488, 12202.572909948109, 12322.938385308016, 12330.81503777444, 12332.32172230536, 12335.753284934251, 18704.652734276704, 19408.070682858186, 19489.122974545637, 19507.7511275726, 19557.8935810221, 7005.229424763374, 7110.1823290321245, 7286.417086633057, 7442.516236444614, 7486.7005319786595, 1008.5814387029301, 1024.1192574386023, 1068.8289873620183, 1086.7228856641507, 1101.0255923507752, 32091.0, 32232.677673222966, 32482.187945301557, 32550.34899302001, 33368.0, 1133.3426612564692, 1149.4712432281244, 1181.69126445951, 1188.738477534941, 1258.672745086284, 16472.25874835635, 16681.582960425843, 16769.580760481087, 17011.149442527825, 17105.694937502034, 559949.0, 560673.0, 565771.0, 566098.0, 568773.0, 58281.70859145762, 58592.414075858695, 58964.70517647384, 59084.70457647684, 59164.704176478845, 1266.120046567645, 1352.6415499892537, 1364.3382959264748, 1365.4674676876027, 1383.2115694054494, 29422.852885735436, 31593.8420307897, 33019.17452063622, 33284.500732488545, 33804.66195338113, 55487.890242194124, 55642.72178639081, 56063.43936560745, 56116.0, 56687.43312566821, 500787.0, 505952.0, 506935.0, 508372.0, 509321.0, 36914.63085369112, 41745.16509669729, 42773.57226427696, 43086.56913430826, 43424.56575434205, 47301.29048064213, 48222.517774821805, 48493.5150648489, 49318.26022609736, 49403.752981234866, 40002.79635076253, 41230.587694122674, 41371.793141034104, 41537.1692566153, 42237.78881105575, 39764.0, 40124.0, 40532.79733601313, 41158.1768364637, 41414.1717165661, 40740.185196295315, 41331.380029300184, 41431.7928410356, 41814.0, 41838.372424414265, 34487.82756086203, 35676.82161589176, 36579.451308229865, 36736.63263367332, 36910.815445923676, 27998.0, 28047.859760701067, 28306.0, 28414.57378139371, 28493.715062849107], "value": 20570.46107482097, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.9062734316421, 377.7697774314613, 383.89634798604396, 387.1656580069949, 393.47471126046725, 15225.086494810319, 17129.400470983517, 17978.190981405834, 20274.0, 20298.797012029892, 17486.562835929075, 17661.0, 17819.821801781978, 17828.465146045608, 19672.21311147556, 5551.611387202907, 5714.857128571798, 5772.105323674838, 5802.332731735841, 5841.15303281024, 4130.297849365615, 5665.3201615806165, 6087.269527656666, 6393.904091438632, 6405.711742971577, 6342.302346741878, 6364.33174516676, 6430.196225471816, 6452.709628066748, 6465.224173099211, 6167.969160154215, 6331.081993111019, 6437.259715132773, 6439.774607888725, 6457.2896981332015, 5410.565245639478, 5492.642978206443, 5497.945020549823, 5512.366077901052, 5591.2731344925305, 20466.897665511726, 20472.283470078477, 20490.077946492445, 23443.88278058616, 23652.881735591385, 2428.6964129483813, 2455.3370589940796, 2633.249523885683, 2633.3548280671357, 2855.286178455386, 14104.294785260696, 14390.352434140385, 14479.638009049753, 14818.110913345234, 14871.0, 1938.185961896007, 1962.6369121712528, 1976.179885347579, 1976.3082920977686, 2085.8227050700707, 79439.20560794376, 79827.0, 81074.18925810726, 81287.0, 82420.0, 10012.549435275285, 10033.598656053822, 10057.547410366551, 10142.645007424851, 10156.949215253877, 13873.930630346986, 13934.512292069932, 13940.930295348458, 13951.58145255644, 13963.0, 7404.407647388196, 7415.295546923034, 7538.585377804274, 7599.316061554487, 7687.6156192190165, 7227.387996618732, 7308.8305871060375, 7348.63256837156, 7372.004779354718, 7458.925410745932, 6339.415146213447, 6385.7126429309865, 6429.935700642934, 6461.0, 6568.277489476154, 1628.5033064915078, 1708.470374184007, 1798.2267624921149, 1803.2786885246007, 1832.4227868221467, 941.6421759731395, 995.6415690351467, 1044.639599338227, 1092.1208427216009, 1157.4444266752007, 18611.90694046548, 18921.0, 19213.0, 20156.798432015494, 20395.388138355873, 973.6689525561343, 988.6935050134481, 1011.0546638892512, 1075.2634445404922, 1090.0788833435734, 10614.522346494427, 11144.33134011962, 11147.331160130418, 11175.944120279346, 11184.888151118384, 501822.0, 505532.0, 505702.0, 516839.0, 517979.0, 62739.6863015682, 88575.55712221526, 95047.0, 96903.0, 100864.0, 1023.1967905194387, 1035.0477560644226, 1037.4397825174321, 1048.3866937841296, 1050.186105768036, 17384.47846564605, 17492.421607116336, 17659.823401765818, 17750.822491774918, 17825.197866096318, 41201.79399102985, 42262.15475690408, 43595.0, 43890.56109438992, 43917.341239880785, 60530.0, 60571.0, 61480.0, 62207.37792622016, 62525.37474625195, 7185.676644551112, 8191.180881911761, 8328.750137495885, 8455.069942306465, 8494.447860889022, 11405.714857128638, 13390.196588204739, 13413.463461461432, 13734.862651373358, 13755.17468951866, 11909.642710718692, 11909.702257443287, 12133.69665758363, 12138.75722485563, 12141.0, 11373.488193031168, 11389.04464414187, 11471.254368466023, 11526.423678816192, 11776.528938842694, 11702.765944681229, 12044.457999390224, 12125.0, 12214.0, 12230.510779569073, 7457.2542745724995, 7485.214052524407, 7516.47384683067, 7628.732994345171, 7697.65360558765, 11366.204365694653, 11928.403579821148, 11961.401929903295, 11976.0, 12080.0], "value": 9346.655294162256, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1333.3866421446135, 1537.7539593665015, 1555.7044161609294, 1741.7648617436641, 1862.6647203503373, 8845.203931646158, 9197.0802919708, 9197.678081267157, 9490.76273093173, 9495.667651632195, 9170.220531254852, 9396.389234699756, 9401.623935042608, 9422.52887355633, 9432.52837358131, 2347.800436962856, 2374.7743964323363, 2376.536575367804, 2377.072941552787, 2381.273711517986, 2348.7768661977084, 2397.832151749378, 2403.0267741564694, 2403.4472071423497, 2405.0259644843777, 2327.650852372149, 2333.3349995251356, 2358.492924021335, 2363.728171260301, 2365.7161140663143, 2187.7374715034216, 2187.73747150343, 2204.9889750551306, 2208.4920468292303, 2256.5670799042728, 2212.7455342635644, 2216.5345277491747, 2216.56776928499, 2221.766714494971, 2227.9331620051425, 8826.823463530758, 9008.144226298491, 9249.861252081157, 9312.255019598484, 9312.487813170274, 5158.380994280673, 5269.815556455544, 5281.683099014072, 5281.735913204363, 5288.68267903927, 3323.5347051412823, 3352.3127758809387, 3363.1087761743156, 3428.5542879425516, 3432.5880894292595, 1080.200651517879, 1131.6209069961574, 1133.846930664358, 1161.1755653486034, 1163.9825402618967, 13034.41345139471, 13183.934080329633, 13189.0, 13195.472181112744, 13198.076134670673, 4464.933026004613, 4483.125790470827, 4572.314152877095, 4578.336141259499, 4598.954010459853, 10219.540120694586, 10310.432926188982, 10365.740856478498, 10375.066244038073, 10382.273240873066, 5253.317068781034, 5256.421793602701, 5259.316288882497, 5265.104932161542, 5270.604704647167, 4269.786510674516, 4623.976880115578, 4712.670113092051, 4732.313814496879, 4819.807207711722, 3775.6601905828607, 3807.7524960877454, 3830.272248272819, 3844.4041173618134, 3871.2451072041245, 1025.1542477456128, 1156.988430115705, 1159.4087015622094, 1167.830664553635, 1181.255808840425, 827.6399766101765, 863.3956230638453, 889.8531742262454, 933.3140141995764, 949.5110018340561, 5933.821985340447, 6086.878262434815, 6311.652859092794, 6412.166418365676, 6435.06691529735, 441.3247730971619, 451.54845154845157, 451.58454222115734, 464.8884267775777, 624.073251221935, 4163.562825903297, 4193.098483825992, 4235.0, 4275.486941567032, 4290.249206388869, 11562.595309164308, 11833.704157395961, 11943.954291655573, 11978.940105299418, 11987.700307492383, 11693.239939404082, 11767.23512971654, 11814.232074915102, 11831.645050648494, 11834.349110798988, 8119.959400202961, 8601.22588966996, 8640.222379985831, 8645.524496152646, 8658.0, 5963.821085367446, 6158.476529494864, 6243.906341404973, 6265.310815810166, 6320.273168585672, 10544.525496352837, 10718.24972251935, 10829.891701082888, 10893.01962823318, 10991.120710343313, 10957.561697532328, 10965.396903170402, 11006.174536909924, 11101.38942358178, 11105.167112466435, 7097.148342198969, 7429.182789893215, 7615.923840761743, 7639.312461878458, 7898.723544675909, 9269.67556135532, 9287.67493137764, 9300.302477314093, 9338.066193380879, 9339.719808405758, 7705.922940770521, 7917.643706033357, 7923.326517246099, 7969.733927371474, 8041.597920104088, 7693.538387696756, 7750.7674769756995, 7831.608419578884, 7851.293383595504, 7873.645685944261, 7382.852342953218, 7521.097468303619, 7609.809754756176, 7621.1616722161625, 7622.771316860503, 5350.143976963667, 5358.517733404013, 5373.194020896896, 5397.70312632809, 5514.972425137848, 5193.714345711022, 5281.366236051698, 5289.444608316226, 5389.56883449331, 5444.537214336826], "value": 4646.783423663728, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.7092959941652, 319.3819958380534, 324.85706289232724, 325.2584108233228, 329.170490364282, 5407.729613519328, 5418.78077432578, 5434.212039254311, 5457.508824205831, 5470.835874923749, 5318.547923426513, 5342.465753424655, 5342.759575819097, 5352.652077614952, 5384.838454846361, 3995.880123596297, 4018.557958624549, 4200.873973780776, 4210.3894935234375, 4214.641755450791, 4137.317342638461, 4146.3780432935155, 4173.268093741094, 4183.351580505011, 4186.58134186582, 3952.288588054149, 4145.709800313979, 4152.501699796014, 4153.335466325389, 4160.854370097048, 4025.496812898388, 4137.91724165518, 4142.668586513087, 4155.794819502341, 4161.479815023122, 3631.5097461842843, 3638.6179451157514, 3645.7447978641508, 3654.7391150053454, 3655.3054919565197, 5139.511746384088, 5144.6141539384325, 5179.300794392747, 5203.19350500673, 5227.45111763267, 4418.447694038246, 4661.720296782204, 4674.20043283335, 4678.672492925497, 4679.15775160471, 5471.0, 5485.50630443262, 5487.533559647435, 5498.285222921035, 5520.66875987438, 3915.2561013407644, 3918.0988372674447, 3945.4081887716784, 3945.4081887716784, 3947.743396679207, 5670.744816483269, 5729.656220626817, 5760.971195143998, 5777.682227477487, 5783.21926539916, 3974.5826688197903, 3988.262171498282, 3995.640392364643, 4022.5977402260123, 4026.2350153470748, 4080.591940805896, 4086.203190377907, 4103.097318589906, 4103.938440923389, 4110.219058378899, 4528.320751887178, 4636.26140197426, 4700.153972285021, 4706.411698537683, 4764.4520880098535, 5601.467860553323, 5631.521320687705, 5641.153826925912, 5647.463490968352, 5672.517835983987, 1374.4845682868925, 1399.4262352435655, 1402.8527004664363, 1404.9578512644637, 1408.1762169130968, 868.5917618719192, 887.238830920622, 891.8584212208384, 894.4141587260225, 898.910108989109, 5169.638125331191, 5203.713795741195, 5229.843104706865, 5326.334208223972, 5333.679979201261, 5717.599768016282, 5724.141378793214, 5725.971370143123, 5742.368339482654, 5761.942380576224, 5191.117510023305, 5398.271233383443, 5407.188921661782, 5408.161734931092, 5414.729263536808, 3013.8794448222266, 3016.4570377332293, 3023.805596789256, 3035.3474003089, 3060.158456424501, 5814.592978491465, 5835.912461313083, 5848.356680765112, 5858.794942177088, 5864.9736296148, 5531.84258139326, 5874.795666888278, 5925.903707814068, 5964.642121472725, 5978.85052873673, 5922.911156332744, 5934.495567876779, 5978.790742323998, 6006.699665016732, 6026.758929642853, 5515.758954235265, 5705.885882282248, 5740.0815869460685, 5758.568107391879, 5804.65172089676, 5683.914741278802, 5685.289338832646, 5697.604086998712, 5714.5999780015, 5725.022988046109, 5851.444112809277, 5896.528277737856, 5904.114382842608, 5934.347221805511, 5975.34271230173, 3820.522434695663, 4013.8394464221105, 4025.315696331689, 4029.37544680575, 4031.6573091286396, 5679.318481782213, 5699.829005129853, 5728.713564321851, 5761.567882408753, 5768.53851691872, 5371.650842695212, 5560.470870510642, 5595.860103497445, 5596.692181930033, 5622.6064175508955, 5283.630145889751, 5469.429368196941, 5522.475364840334, 5540.279763630702, 5599.832005039855, 5477.726113694379, 5498.285222921155, 5501.229827824028, 5503.724813759376, 5507.366652834975, 5349.812756553502, 5557.499825015768, 5569.164625306236, 5609.803656872153, 5622.606417550732, 5546.473085056913, 5558.527525160245, 5574.749136288958, 5585.374873809303, 5590.965671350813], "value": 4232.8696236006845, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.8833030880212, 764.6482617995722, 785.9096203936546, 788.3732432715991, 839.4543546694648, 13487.527936522223, 14261.572152835406, 14284.71430571388, 14287.571372858818, 14300.28498575071, 13558.050936434454, 13591.524296649619, 13605.387757550909, 13608.0, 13618.591442256748, 668.8796016716989, 769.9076110866675, 794.3486341200218, 797.4059325802285, 802.0896282719127, 793.5278509286965, 794.3327604811957, 794.5153456391597, 799.5122974985284, 801.6993627389729, 841.8610929196675, 843.1020962674762, 843.439112989861, 844.025150950653, 844.6494704697543, 693.2478261086727, 825.4180802534229, 840.1178762299561, 840.3277378097528, 848.465466755946, 628.5066223014911, 628.673089993201, 628.9967501834567, 629.5215636116538, 629.527854109418, 14076.859231407658, 14109.78835317471, 14113.0, 14138.363773630108, 14147.929260353736, 13268.40292186854, 13352.732945341137, 13398.665033374145, 13679.726405471934, 13884.4446222151, 12469.625911222678, 12616.81074783879, 12704.364781760874, 12790.808137877939, 12905.35473226335, 4452.3989261449615, 4479.484859241164, 4499.865004049851, 4581.67928245023, 4665.790039448233, 57635.42364576385, 57940.42059579435, 57988.71005644987, 58159.0, 58176.70911645415, 11051.447427628586, 11054.944725276322, 11095.667129986114, 11242.887571124347, 11250.156238282161, 20457.795422045885, 20484.0, 20538.17847286122, 20538.897305513674, 20543.178272868918, 7924.366050715929, 7953.443258971932, 7997.680382736783, 8030.759077227693, 8216.055153657406, 4564.566366195206, 4624.28323609841, 4636.165490211727, 4680.0, 4791.089692958327, 3337.5494308268558, 3492.965070349264, 3493.2489514753943, 3541.11472131967, 3542.1498840278146, 588.785093440891, 613.1262950295811, 662.5792621685265, 694.7047504810537, 701.9719211231494, 651.5406638319973, 686.5228666077128, 719.6365835253164, 735.3528894572742, 751.1624538639378, 9311.993967296428, 9333.579988900516, 9437.150656440954, 9536.856947145798, 9594.328397012281, 617.8084793713963, 700.9509334346649, 737.7454778101546, 752.5371896283856, 760.4562737642613, 4544.341070544752, 4655.627549796008, 4657.301404789241, 4659.394278743742, 4676.251799712029, 75046.62476687582, 76827.0, 77651.61174194093, 80574.0, 80966.59516702378, 65011.67494162499, 66054.66972665106, 67101.0, 68581.65709171422, 71419.28580714126, 51337.74331128395, 51607.48392516102, 53491.197632034775, 60321.0, 60561.0, 10028.498575071364, 10054.949725251327, 10154.492275386054, 10158.171529124533, 10256.641017564349, 37690.0, 37994.620053800216, 38300.0, 38423.03942401462, 38693.613063869, 47352.52647473619, 51235.23147152721, 51617.0, 51649.741751291, 53644.463555363945, 12451.875481245072, 12735.0, 12772.680682982627, 12777.0, 13094.541691040768, 13891.235982021086, 14305.141691498544, 14327.856721432652, 14443.3500492476, 14487.130772153705, 13505.729885402434, 13630.318484075955, 13840.169589824643, 13893.444262229397, 14436.783448248074, 13413.463461461432, 13466.596002119952, 13619.25094119833, 13808.861911380758, 13963.58109256724, 13145.737085258432, 13391.732165356443, 13627.114237574526, 13633.0, 14059.507917222849, 10994.780104398027, 11151.16366272549, 11343.489542970421, 11604.535818567501, 11800.409979501163, 10664.680059598224, 10674.0, 11136.665900023012, 11166.441677916235, 11455.36995465224], "value": 7066.988702687987, "unit": "score"}], "name": "dromaeo_css", "value": 7232.582195883146, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 107.0, 111.0, 109.0, 111.0, 111.0, 110.0, 109.0, 109.0, 110.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 123.0, 129.0, 176.0, 129.0, 126.0, 155.0, 128.0, 163.0, 130.0], "value": 140.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 161.0, 158.0, 162.0, 159.0, 161.0, 162.0, 160.0, 161.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 107.0, 75.0, 75.0, 73.0, 75.0, 107.0, 73.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 105.0, 83.0, 84.0, 84.0, 129.0, 83.0, 84.0, 119.0], "value": 93.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 116.0, 116.0, 116.0, 116.0, 117.0, 116.0, 116.0], "value": 116.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 145.0, 147.0, 146.0, 145.0, 145.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 55.0, 54.0, 59.0, 53.0, 55.0, 52.0, 54.0, 63.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 62.0, 63.0, 62.0, 65.0, 62.0, 63.0, 63.0], "value": 62.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 84.0, 82.0, 79.0, 78.0, 80.0, 85.0, 85.0, 110.0, 85.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 117.0, 127.0, 125.0, 118.0, 124.0, 117.0, 127.0, 123.0, 136.0], "value": 123.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 160.0, 159.0, 158.0, 160.0, 158.0, 159.0, 158.0, 156.0, 157.0], "value": 158.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 65.0, 62.0, 62.0, 63.0, 62.0, 61.0, 61.0, 61.0], "value": 62.5, "unit": "score"}], "name": "kraken", "value": 1489.2000000000003, "alertThreshold": 2.0}]} 23:25:10 INFO - Return code: 0 23:25:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:25:10 ERROR - # TBPL SUCCESS # 23:25:10 INFO - Running post-action listener: _resource_record_post_action 23:25:10 INFO - ##### 23:25:10 INFO - ##### Finished run-tests step (success) 23:25:10 INFO - ##### 23:25:10 INFO - Running post-run listener: _resource_record_post_run 23:25:10 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 541503488; Read time: 12; Write time: 474800 23:25:10 INFO - TinderboxPrint: CPU usage
13.0% 23:25:10 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 23:25:10 INFO - TinderboxPrint: I/O write bytes / time
541,503,488 / 474,800 23:25:10 INFO - TinderboxPrint: CPU idle
8,264.8 (86.9%) 23:25:10 INFO - TinderboxPrint: CPU user
1,198.1 (12.6%) 23:25:10 INFO - TinderboxPrint: Swap in / out
0 / 0 23:25:10 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 238239744; Read time: 0; Write time: 228736 23:25:10 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291934208; Read time: 12; Write time: 228248 23:25:10 INFO - Running post-run listener: _upload_blobber_files 23:25:10 INFO - Blob upload gear active. 23:25:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:25:10 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 23:25:10 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'] 23:25:10 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 23:25:11 INFO - (blobuploader) - INFO - Open directory for files ... 23:25:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:25:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:25:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:25:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:25:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:25:15 INFO - (blobuploader) - INFO - Done attempting. 23:25:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:25:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:25:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:25:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:25:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:25:16 INFO - (blobuploader) - INFO - Done attempting. 23:25:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:25:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:25:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:25:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:25:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:25:17 INFO - (blobuploader) - INFO - Done attempting. 23:25:17 INFO - (blobuploader) - INFO - Iteration through files over. 23:25:17 INFO - Return code: 0 23:25:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:25:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:25:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/308457874e67fb8fc9bc4491eaeda9a234d6143878f9a6542bc548e8c9d792f1bfe524d395fd8338e9bf136beb5f7df0fa84b7a6ad4b90e525be002dda18a4e3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f449f4892a7aaf60a02540eff8755b8453dc993ba5ac7b56d251d5bc759ce364bd3a9463f2296af0eb2772ab11ab5248be5cb25f302df27aec4a4da8e6d4e7f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/03ffcd709372bc2317ce2f9bb9e7d9e4de89bfab56a02a5324890bc1c855436362d756d8ce468d9e0f434e9bedc33fd0ecdf05653c09343013469e37893ea559"} 23:25:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:25:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:25:17 INFO - Contents: 23:25:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/308457874e67fb8fc9bc4491eaeda9a234d6143878f9a6542bc548e8c9d792f1bfe524d395fd8338e9bf136beb5f7df0fa84b7a6ad4b90e525be002dda18a4e3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f449f4892a7aaf60a02540eff8755b8453dc993ba5ac7b56d251d5bc759ce364bd3a9463f2296af0eb2772ab11ab5248be5cb25f302df27aec4a4da8e6d4e7f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/03ffcd709372bc2317ce2f9bb9e7d9e4de89bfab56a02a5324890bc1c855436362d756d8ce468d9e0f434e9bedc33fd0ecdf05653c09343013469e37893ea559"} 23:25:17 INFO - Running post-run listener: copy_logs_to_upload_dir 23:25:17 INFO - Copying logs to upload dir... 23:25:17 INFO - mkdir: /builds/slave/test/build/upload/logs 23:25:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.173283 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-05-29 23:25:16.523855) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-29 23:25:16.528037) ========= 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=32c5991c409366f7fec8a718000001d2-1464587935.651288-1955508040 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/308457874e67fb8fc9bc4491eaeda9a234d6143878f9a6542bc548e8c9d792f1bfe524d395fd8338e9bf136beb5f7df0fa84b7a6ad4b90e525be002dda18a4e3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f449f4892a7aaf60a02540eff8755b8453dc993ba5ac7b56d251d5bc759ce364bd3a9463f2296af0eb2772ab11ab5248be5cb25f302df27aec4a4da8e6d4e7f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/03ffcd709372bc2317ce2f9bb9e7d9e4de89bfab56a02a5324890bc1c855436362d756d8ce468d9e0f434e9bedc33fd0ecdf05653c09343013469e37893ea559"} build_url:https://queue.taskcluster.net/v1/task/S76xzm6FSVujY9rMjXc8BQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011333 build_url: 'https://queue.taskcluster.net/v1/task/S76xzm6FSVujY9rMjXc8BQ/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/308457874e67fb8fc9bc4491eaeda9a234d6143878f9a6542bc548e8c9d792f1bfe524d395fd8338e9bf136beb5f7df0fa84b7a6ad4b90e525be002dda18a4e3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f449f4892a7aaf60a02540eff8755b8453dc993ba5ac7b56d251d5bc759ce364bd3a9463f2296af0eb2772ab11ab5248be5cb25f302df27aec4a4da8e6d4e7f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/03ffcd709372bc2317ce2f9bb9e7d9e4de89bfab56a02a5324890bc1c855436362d756d8ce468d9e0f434e9bedc33fd0ecdf05653c09343013469e37893ea559"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-29 23:25:16.553572) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 23:25:16.553910) ========= 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=32c5991c409366f7fec8a718000001d2-1464587935.651288-1955508040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004405 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 23:25:16.637549) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-29 23:25:16.637870) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-29 23:25:16.638181) ========= ========= Total master_lag: 0.17 =========