builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-006 starttime: 1459834894.42 results: success (0) buildid: 20160404210406 builduid: 08932fd83908492ba9ab4ea82c88bb49 revision: 27df9bc5af2ca94e203e132013a5958bd60e85fc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-04 22:41:34.423980) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-04 22:41:34.424516) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-04 22:41:34.424851) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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=e31afd3c0f0de4e86ebe4d94000001b5-1459834891.720199-1870903635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006284 basedir: '/builds/slave/test' ========= master_lag: 0.25 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-04 22:41:34.680909) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-04 22:41:34.681286) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-04 22:41:34.941690) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 22:41:34.942125) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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=e31afd3c0f0de4e86ebe4d94000001b5-1459834891.720199-1870903635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004713 ========= master_lag: 0.17 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 22:41:35.115603) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-04 22:41:35.116114) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-04 22:41:35.116721) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 22:41:35.117079) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1459834891.720199-1870903635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-04 22:41:35-- 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% 111M=0s 2016-04-04 22:41:36 (111 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.231730 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 22:41:35.421322) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 22:41:35.421689) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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=e31afd3c0f0de4e86ebe4d94000001b5-1459834891.720199-1870903635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015098 ========= master_lag: 0.15 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 22:41:35.582304) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-04 22:41:35.582728) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 27df9bc5af2ca94e203e132013a5958bd60e85fc --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 27df9bc5af2ca94e203e132013a5958bd60e85fc --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=e31afd3c0f0de4e86ebe4d94000001b5-1459834891.720199-1870903635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-04 22:41:36,374 truncating revision to first 12 chars 2016-04-04 22:41:36,374 Setting DEBUG logging. 2016-04-04 22:41:36,374 attempt 1/10 2016-04-04 22:41:36,374 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/27df9bc5af2c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-04 22:41:37,074 unpacking tar archive at: fx-team-27df9bc5af2c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.342642 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-04 22:41:36.989353) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-04 22:41:36.989762) ========= echo 27df9bc5af2ca94e203e132013a5958bd60e85fc in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'27df9bc5af2ca94e203e132013a5958bd60e85fc'] 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=e31afd3c0f0de4e86ebe4d94000001b5-1459834891.720199-1870903635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 27df9bc5af2ca94e203e132013a5958bd60e85fc program finished with exit code 0 elapsedTime=0.004762 script_repo_revision: '27df9bc5af2ca94e203e132013a5958bd60e85fc' ========= master_lag: 0.14 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-04 22:41:37.135211) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-04 22:41:37.135624) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-04 22:41:37.306801) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-04-04 22:41:37.307257) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1459834891.720199-1870903635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:41:38 INFO - MultiFileLogger online at 20160404 22:41:38 in /builds/slave/test 22:41:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 22:41:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:41:38 INFO - {'append_to_log': False, 22:41:38 INFO - 'base_work_dir': '/builds/slave/test', 22:41:38 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:41:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:41:38 INFO - 'branch': 'Fx-Team-Non-PGO', 22:41:38 INFO - 'buildbot_json_path': 'buildprops.json', 22:41:38 INFO - 'config_files': ('talos/linux_config.py',), 22:41:38 INFO - 'default_actions': ('clobber', 22:41:38 INFO - 'read-buildbot-config', 22:41:38 INFO - 'download-and-extract', 22:41:38 INFO - 'populate-webroot', 22:41:38 INFO - 'create-virtualenv', 22:41:38 INFO - 'install', 22:41:38 INFO - 'run-tests'), 22:41:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:41:38 INFO - 'download_minidump_stackwalk': True, 22:41:38 INFO - 'download_symbols': 'ondemand', 22:41:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:41:38 INFO - 'tooltool.py': '/tools/tooltool.py', 22:41:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:41:38 INFO - '/tools/misc-python/virtualenv.py')}, 22:41:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:41:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:41:38 INFO - 'installer_path': 'installer.exe', 22:41:38 INFO - 'log_level': 'info', 22:41:38 INFO - 'log_name': 'talos', 22:41:38 INFO - 'log_to_console': True, 22:41:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:41:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:41:38 INFO - 'opt_config_files': (), 22:41:38 INFO - 'pip_index': False, 22:41:38 INFO - 'sps_profile': False, 22:41:38 INFO - 'sps_profile_interval': 0, 22:41:38 INFO - 'suite': 'dromaeojs', 22:41:38 INFO - 'system_bits': '32', 22:41:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:41:38 INFO - 'title': 'talos-linux64-ix-006', 22:41:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:41:38 INFO - 'use_talos_json': True, 22:41:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:41:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:41:38 INFO - 'work_dir': 'build'} 22:41:38 INFO - ##### 22:41:38 INFO - ##### Running clobber step. 22:41:38 INFO - ##### 22:41:38 INFO - Running pre-action listener: _resource_record_pre_action 22:41:38 INFO - Running main action method: clobber 22:41:38 INFO - rmtree: /builds/slave/test/build 22:41:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:41:38 INFO - Running post-action listener: _resource_record_post_action 22:41:38 INFO - ##### 22:41:38 INFO - ##### Running read-buildbot-config step. 22:41:38 INFO - ##### 22:41:38 INFO - Running pre-action listener: _resource_record_pre_action 22:41:38 INFO - Running main action method: read_buildbot_config 22:41:38 INFO - Using buildbot properties: 22:41:38 INFO - { 22:41:38 INFO - "project": "", 22:41:38 INFO - "product": "firefox", 22:41:38 INFO - "script_repo_revision": "production", 22:41:38 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 22:41:38 INFO - "repository": "", 22:41:38 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 22:41:38 INFO - "buildid": "20160404210406", 22:41:38 INFO - "pgo_build": "False", 22:41:38 INFO - "basedir": "/builds/slave/test", 22:41:38 INFO - "buildnumber": 1611, 22:41:38 INFO - "slavename": "talos-linux64-ix-006", 22:41:38 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:41:38 INFO - "platform": "ubuntu64_hw", 22:41:38 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:41:38 INFO - "branch": "fx-team", 22:41:38 INFO - "repo_path": "integration/fx-team", 22:41:38 INFO - "revision": "27df9bc5af2ca94e203e132013a5958bd60e85fc", 22:41:38 INFO - "stage_platform": "linux64", 22:41:38 INFO - "builduid": "08932fd83908492ba9ab4ea82c88bb49", 22:41:38 INFO - "slavebuilddir": "test" 22:41:38 INFO - } 22:41:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/OGb9A-DNRu-acsFxzkWsCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 22:41:38 INFO - Running post-action listener: _resource_record_post_action 22:41:38 INFO - ##### 22:41:38 INFO - ##### Running download-and-extract step. 22:41:38 INFO - ##### 22:41:38 INFO - Running pre-action listener: _resource_record_pre_action 22:41:38 INFO - Running main action method: download_and_extract 22:41:38 INFO - mkdir: /builds/slave/test/build/tests 22:41:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:38 INFO - https://queue.taskcluster.net/v1/task/OGb9A-DNRu-acsFxzkWsCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:41:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OGb9A-DNRu-acsFxzkWsCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:41:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OGb9A-DNRu-acsFxzkWsCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:41:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OGb9A-DNRu-acsFxzkWsCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:41:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OGb9A-DNRu-acsFxzkWsCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:41:39 INFO - Downloaded 1361 bytes. 22:41:39 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:41:39 INFO - Using the following test package requirements: 22:41:39 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:41:39 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:41:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:41:39 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:41:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:41:39 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:41:39 INFO - u'jsshell-linux-x86_64.zip'], 22:41:39 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:41:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:41:39 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:41:39 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:41:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:41:39 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:41:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:41:39 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:41:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:41:39 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:41:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:41:39 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:41:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:39 INFO - https://queue.taskcluster.net/v1/task/OGb9A-DNRu-acsFxzkWsCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:41:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OGb9A-DNRu-acsFxzkWsCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:41:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OGb9A-DNRu-acsFxzkWsCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:41:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OGb9A-DNRu-acsFxzkWsCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:41:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OGb9A-DNRu-acsFxzkWsCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:41:48 INFO - Downloaded 22125516 bytes. 22:41:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:41:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:41:49 INFO - Return code: 0 22:41:49 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:41: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')]} 22:41:49 INFO - https://queue.taskcluster.net/v1/task/OGb9A-DNRu-acsFxzkWsCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:41:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OGb9A-DNRu-acsFxzkWsCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:41:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OGb9A-DNRu-acsFxzkWsCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:41:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OGb9A-DNRu-acsFxzkWsCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:41:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OGb9A-DNRu-acsFxzkWsCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:41:51 INFO - Downloaded 22125516 bytes. 22:41:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:41:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:41:53 INFO - Return code: 0 22:41:53 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')]} 22:41:53 INFO - https://queue.taskcluster.net/v1/task/OGb9A-DNRu-acsFxzkWsCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:41:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OGb9A-DNRu-acsFxzkWsCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:41:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OGb9A-DNRu-acsFxzkWsCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:41:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OGb9A-DNRu-acsFxzkWsCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:41:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OGb9A-DNRu-acsFxzkWsCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:41:54 INFO - Downloaded 10847584 bytes. 22:41:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:41:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 22:41:55 INFO - Return code: 0 22:41:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:55 INFO - https://queue.taskcluster.net/v1/task/OGb9A-DNRu-acsFxzkWsCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:41:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OGb9A-DNRu-acsFxzkWsCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:41:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OGb9A-DNRu-acsFxzkWsCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:41:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OGb9A-DNRu-acsFxzkWsCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:41:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OGb9A-DNRu-acsFxzkWsCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:41:56 INFO - Downloaded 54084849 bytes. 22:41:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OGb9A-DNRu-acsFxzkWsCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:41:56 INFO - mkdir: /builds/slave/test/properties 22:41:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:41:56 INFO - Writing to file /builds/slave/test/properties/build_url 22:41:56 INFO - Contents: 22:41:56 INFO - build_url:https://queue.taskcluster.net/v1/task/OGb9A-DNRu-acsFxzkWsCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:41:58 INFO - Running post-action listener: _resource_record_post_action 22:41:58 INFO - Running post-action listener: set_extra_try_arguments 22:41:58 INFO - ##### 22:41:58 INFO - ##### Running populate-webroot step. 22:41:58 INFO - ##### 22:41:58 INFO - Running pre-action listener: _resource_record_pre_action 22:41:58 INFO - Running main action method: populate_webroot 22:41:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:41:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:41:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:41:58 INFO - '--tppagecycles', 22:41:58 INFO - '7'], 22:41:58 INFO - 'tests': ['tsvgm']}}, 22:41:58 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:41:58 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:41:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:41:58 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 22:41:58 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:41:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:41:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:41:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:58 INFO - 'talos_options': ['--e10s'], 22:41:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:41:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:58 INFO - 'tests': ['damp', 'tps']}, 22:41:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:58 INFO - 'talos_options': ['--e10s'], 22:41:58 INFO - 'tests': ['damp', 'tps']}, 22:41:58 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:41:58 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 22:41:58 INFO - 'tests': ['dromaeo_dom']}, 22:41:58 INFO - 'other': {'tests': ['a11yr', 22:41:58 INFO - 'ts_paint', 22:41:58 INFO - 'tpaint', 22:41:58 INFO - 'sessionrestore', 22:41:58 INFO - 'sessionrestore_no_auto_restore', 22:41:58 INFO - 'tabpaint']}, 22:41:58 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:41:58 INFO - 'tests': ['a11yr', 22:41:58 INFO - 'ts_paint', 22:41:58 INFO - 'tpaint', 22:41:58 INFO - 'sessionrestore', 22:41:58 INFO - 'sessionrestore_no_auto_restore', 22:41:58 INFO - 'tabpaint']}, 22:41:58 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:41:58 INFO - 'tests': ['a11yr', 22:41:58 INFO - 'ts_paint', 22:41:58 INFO - 'tpaint', 22:41:58 INFO - 'sessionrestore', 22:41:58 INFO - 'sessionrestore_no_auto_restore', 22:41:58 INFO - 'tabpaint']}, 22:41:58 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:41:58 INFO - 'tests': ['a11yr', 22:41:58 INFO - 'ts_paint', 22:41:58 INFO - 'tpaint', 22:41:58 INFO - 'sessionrestore', 22:41:58 INFO - 'sessionrestore_no_auto_restore', 22:41:58 INFO - 'tabpaint']}, 22:41:58 INFO - 'other_l64': {'tests': ['a11yr', 22:41:58 INFO - 'ts_paint', 22:41:58 INFO - 'tpaint', 22:41:58 INFO - 'sessionrestore', 22:41:58 INFO - 'sessionrestore_no_auto_restore', 22:41:58 INFO - 'tabpaint']}, 22:41:58 INFO - 'other_nol64': {'tests': ['a11yr', 22:41:58 INFO - 'ts_paint', 22:41:58 INFO - 'tpaint', 22:41:58 INFO - 'sessionrestore', 22:41:58 INFO - 'sessionrestore_no_auto_restore', 22:41:58 INFO - 'tabpaint']}, 22:41:58 INFO - 'svgr': {'tests': ['tsvgx', 22:41:58 INFO - 'tsvgr_opacity', 22:41:58 INFO - 'tart', 22:41:58 INFO - 'tscrollx', 22:41:58 INFO - 'cart']}, 22:41:58 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:41:58 INFO - 'tests': ['tsvgx', 22:41:58 INFO - 'tsvgr_opacity', 22:41:58 INFO - 'tart', 22:41:58 INFO - 'tscrollx', 22:41:58 INFO - 'cart']}, 22:41:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:58 INFO - 'tests': ['tp5o']}, 22:41:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:58 INFO - 'talos_options': ['--e10s'], 22:41:58 INFO - 'tests': ['tp5o']}, 22:41:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:58 INFO - 'talos_options': ['--xperf_path', 22:41:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:41:58 INFO - 'tests': ['tp5n']}, 22:41:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:58 INFO - 'talos_options': ['--e10s', 22:41:58 INFO - '--xperf_path', 22:41:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:41:58 INFO - 'tests': ['tp5n']}}, 22:41:58 INFO - 'talos.zip': {'path': '', 22:41:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:41:58 INFO - Running post-action listener: _resource_record_post_action 22:41:58 INFO - ##### 22:41:58 INFO - ##### Running create-virtualenv step. 22:41:58 INFO - ##### 22:41:58 INFO - Running pre-action listener: _resource_record_pre_action 22:41:58 INFO - Running main action method: create_virtualenv 22:41:58 INFO - Creating virtualenv /builds/slave/test/build/venv 22:41:58 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 22:41:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:41:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:41:58 INFO - Using real prefix '/usr' 22:41:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:41:58 INFO - Installing distribute.............................................................................................................................................................................................done. 22:42:00 INFO - Installing pip.................done. 22:42:00 INFO - Return code: 0 22:42:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:42:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:42:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:00 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 0x7f96b2b10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e84410>, '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 0x1e85310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e857a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1459834891.720199-1870903635', '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 22:42:00 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 22:42:00 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 22:42:00 INFO - Using env: {'DISPLAY': ':0', 22:42:00 INFO - 'HOME': '/home/cltbld', 22:42:00 INFO - 'LANG': 'en_US.UTF-8', 22:42:00 INFO - 'LANGUAGE': 'en_US:en', 22:42:00 INFO - 'LOGNAME': 'cltbld', 22:42:00 INFO - 'MAIL': '/var/mail/cltbld', 22:42:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:00 INFO - 'MOZ_NO_REMOTE': '1', 22:42:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:00 INFO - 'NO_EM_RESTART': '1', 22:42:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:00 INFO - 'PWD': '/builds/slave/test', 22:42:00 INFO - 'SHELL': '/bin/bash', 22:42:00 INFO - 'SHLVL': '1', 22:42:00 INFO - 'TERM': 'linux', 22:42:00 INFO - 'TMOUT': '86400', 22:42:00 INFO - 'USER': 'cltbld', 22:42:00 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1459834891.720199-1870903635', 22:42:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:00 INFO - '_': '/tools/buildbot/bin/python'} 22:42:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:00 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 22:42:00 INFO - Cleaning up... 22:42:00 INFO - Return code: 0 22:42:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:42:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:42:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:00 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96b2b10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e84410>, '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 0x1e85310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e857a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1459834891.720199-1870903635', '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 22:42:00 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>=0.7.1'] in /builds/slave/test/build 22:42:00 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>=0.7.1 22:42:00 INFO - Using env: {'DISPLAY': ':0', 22:42:00 INFO - 'HOME': '/home/cltbld', 22:42:00 INFO - 'LANG': 'en_US.UTF-8', 22:42:00 INFO - 'LANGUAGE': 'en_US:en', 22:42:00 INFO - 'LOGNAME': 'cltbld', 22:42:00 INFO - 'MAIL': '/var/mail/cltbld', 22:42:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:00 INFO - 'MOZ_NO_REMOTE': '1', 22:42:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:00 INFO - 'NO_EM_RESTART': '1', 22:42:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:00 INFO - 'PWD': '/builds/slave/test', 22:42:00 INFO - 'SHELL': '/bin/bash', 22:42:00 INFO - 'SHLVL': '1', 22:42:00 INFO - 'TERM': 'linux', 22:42:00 INFO - 'TMOUT': '86400', 22:42:00 INFO - 'USER': 'cltbld', 22:42:00 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1459834891.720199-1870903635', 22:42:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:00 INFO - '_': '/tools/buildbot/bin/python'} 22:42:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:01 INFO - Downloading/unpacking psutil>=0.7.1 22:42: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 22:42: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 22:42: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 22:42: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 22:42: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 22:42: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 22:42:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:42:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:42:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:42:04 INFO - Installing collected packages: psutil 22:42:04 INFO - Running setup.py install for psutil 22:42:04 INFO - building 'psutil._psutil_linux' extension 22:42:04 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 22:42:04 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 22:42:04 INFO - building 'psutil._psutil_posix' extension 22:42:04 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 22:42:04 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 22:42:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:42:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:42:05 INFO - Successfully installed psutil 22:42:05 INFO - Cleaning up... 22:42:05 INFO - Return code: 0 22:42:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:42: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')]} 22:42:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42: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')]} 22:42:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96b2b10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e84410>, '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 0x1e85310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e857a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1459834891.720199-1870903635', '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 22:42:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 22:42:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:42:05 INFO - Using env: {'DISPLAY': ':0', 22:42:05 INFO - 'HOME': '/home/cltbld', 22:42:05 INFO - 'LANG': 'en_US.UTF-8', 22:42:05 INFO - 'LANGUAGE': 'en_US:en', 22:42:05 INFO - 'LOGNAME': 'cltbld', 22:42:05 INFO - 'MAIL': '/var/mail/cltbld', 22:42:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:05 INFO - 'MOZ_NO_REMOTE': '1', 22:42:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:05 INFO - 'NO_EM_RESTART': '1', 22:42:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:05 INFO - 'PWD': '/builds/slave/test', 22:42:05 INFO - 'SHELL': '/bin/bash', 22:42:05 INFO - 'SHLVL': '1', 22:42:05 INFO - 'TERM': 'linux', 22:42:05 INFO - 'TMOUT': '86400', 22:42:05 INFO - 'USER': 'cltbld', 22:42:05 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1459834891.720199-1870903635', 22:42:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:05 INFO - '_': '/tools/buildbot/bin/python'} 22:42:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:42:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:42:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:42:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:42:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:42:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:42:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:42:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:42:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:42:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:42:09 INFO - Installing collected packages: mozsystemmonitor 22:42:09 INFO - Running setup.py install for mozsystemmonitor 22:42:09 INFO - Successfully installed mozsystemmonitor 22:42:09 INFO - Cleaning up... 22:42:09 INFO - Return code: 0 22:42:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:42:09 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')]} 22:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:09 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')]} 22:42:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:09 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 0x7f96b2b10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e84410>, '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 0x1e85310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e857a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1459834891.720199-1870903635', '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 22:42:09 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 22:42:09 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 22:42:09 INFO - Using env: {'DISPLAY': ':0', 22:42:09 INFO - 'HOME': '/home/cltbld', 22:42:09 INFO - 'LANG': 'en_US.UTF-8', 22:42:09 INFO - 'LANGUAGE': 'en_US:en', 22:42:09 INFO - 'LOGNAME': 'cltbld', 22:42:09 INFO - 'MAIL': '/var/mail/cltbld', 22:42:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:09 INFO - 'MOZ_NO_REMOTE': '1', 22:42:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:09 INFO - 'NO_EM_RESTART': '1', 22:42:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:09 INFO - 'PWD': '/builds/slave/test', 22:42:09 INFO - 'SHELL': '/bin/bash', 22:42:09 INFO - 'SHLVL': '1', 22:42:09 INFO - 'TERM': 'linux', 22:42:09 INFO - 'TMOUT': '86400', 22:42:09 INFO - 'USER': 'cltbld', 22:42:09 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1459834891.720199-1870903635', 22:42:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:09 INFO - '_': '/tools/buildbot/bin/python'} 22:42:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:09 INFO - Downloading/unpacking blobuploader==1.2.4 22:42: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 22:42: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 22:42: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 22:42: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 22:42: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 22:42: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 22:42:14 INFO - Downloading blobuploader-1.2.4.tar.gz 22:42:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:42:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:42: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 22:42: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 22:42: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 22:42: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 22:42: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 22:42: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 22:42:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:42:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:42: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 22:42: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 22:42: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 22:42: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 22:42: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 22:42: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 22:42:16 INFO - Downloading docopt-0.6.1.tar.gz 22:42:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:42:16 INFO - Installing collected packages: blobuploader, requests, docopt 22:42:16 INFO - Running setup.py install for blobuploader 22:42:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:42:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:42:16 INFO - Running setup.py install for requests 22:42:16 INFO - Running setup.py install for docopt 22:42:16 INFO - Successfully installed blobuploader requests docopt 22:42:16 INFO - Cleaning up... 22:42:17 INFO - Return code: 0 22:42:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:42:17 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')]} 22:42:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:17 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')]} 22:42:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:17 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 0x7f96b2b10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e84410>, '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 0x1e85310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e857a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1459834891.720199-1870903635', '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 22:42:17 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 22:42:17 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 22:42:17 INFO - Using env: {'DISPLAY': ':0', 22:42:17 INFO - 'HOME': '/home/cltbld', 22:42:17 INFO - 'LANG': 'en_US.UTF-8', 22:42:17 INFO - 'LANGUAGE': 'en_US:en', 22:42:17 INFO - 'LOGNAME': 'cltbld', 22:42:17 INFO - 'MAIL': '/var/mail/cltbld', 22:42:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:17 INFO - 'MOZ_NO_REMOTE': '1', 22:42:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:17 INFO - 'NO_EM_RESTART': '1', 22:42:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:17 INFO - 'PWD': '/builds/slave/test', 22:42:17 INFO - 'SHELL': '/bin/bash', 22:42:17 INFO - 'SHLVL': '1', 22:42:17 INFO - 'TERM': 'linux', 22:42:17 INFO - 'TMOUT': '86400', 22:42:17 INFO - 'USER': 'cltbld', 22:42:17 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1459834891.720199-1870903635', 22:42:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:17 INFO - '_': '/tools/buildbot/bin/python'} 22:42:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:42:17 INFO - Running setup.py (path:/tmp/pip-rVDSro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:42:17 INFO - Running setup.py (path:/tmp/pip-9fElyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:42:17 INFO - Running setup.py (path:/tmp/pip-FvWiBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:42:17 INFO - Running setup.py (path:/tmp/pip-kTAJip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:42:17 INFO - Running setup.py (path:/tmp/pip-r6v289-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:42:17 INFO - Running setup.py (path:/tmp/pip-kAY1Kk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:42:17 INFO - Running setup.py (path:/tmp/pip-m1ZfLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:42:17 INFO - Running setup.py (path:/tmp/pip-_c_aZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:42:17 INFO - Running setup.py (path:/tmp/pip-mTMrjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:42:17 INFO - Running setup.py (path:/tmp/pip-dWVkUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:42:17 INFO - Running setup.py (path:/tmp/pip-2PRa_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:42:18 INFO - Running setup.py (path:/tmp/pip-uiDALk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:42:18 INFO - Running setup.py (path:/tmp/pip-oCfiTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:42:18 INFO - Running setup.py (path:/tmp/pip-yyMSTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:42:18 INFO - Running setup.py (path:/tmp/pip-PJ09mk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:42:18 INFO - Running setup.py (path:/tmp/pip-JNLIu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:42:18 INFO - Running setup.py (path:/tmp/pip-UA4Vfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:42:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:42:18 INFO - Running setup.py install for manifestparser 22:42:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:42:18 INFO - Running setup.py install for mozcrash 22:42:18 INFO - Running setup.py install for mozdebug 22:42:18 INFO - Running setup.py install for mozdevice 22:42:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:42:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:42:18 INFO - Running setup.py install for mozfile 22:42:18 INFO - Running setup.py install for mozhttpd 22:42:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:42:19 INFO - Running setup.py install for mozinfo 22:42:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:42:19 INFO - Running setup.py install for mozInstall 22:42:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:42:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:42:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:42:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:42:19 INFO - Running setup.py install for mozleak 22:42:19 INFO - Running setup.py install for mozlog 22:42:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:42:19 INFO - Running setup.py install for moznetwork 22:42:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:42:19 INFO - Running setup.py install for mozprocess 22:42:19 INFO - Running setup.py install for mozprofile 22:42:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:42:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:42:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:42:19 INFO - Running setup.py install for mozrunner 22:42:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:42:19 INFO - Running setup.py install for mozscreenshot 22:42:20 INFO - Running setup.py install for moztest 22:42:20 INFO - Running setup.py install for mozversion 22:42:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:42:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:42:20 INFO - Cleaning up... 22:42:20 INFO - Return code: 0 22:42:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:42:20 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')]} 22:42:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:20 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')]} 22:42:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:20 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 0x7f96b2b10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e84410>, '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 0x1e85310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e857a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1459834891.720199-1870903635', '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 22:42:20 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 22:42:20 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 22:42:20 INFO - Using env: {'DISPLAY': ':0', 22:42:20 INFO - 'HOME': '/home/cltbld', 22:42:20 INFO - 'LANG': 'en_US.UTF-8', 22:42:20 INFO - 'LANGUAGE': 'en_US:en', 22:42:20 INFO - 'LOGNAME': 'cltbld', 22:42:20 INFO - 'MAIL': '/var/mail/cltbld', 22:42:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:20 INFO - 'MOZ_NO_REMOTE': '1', 22:42:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:20 INFO - 'NO_EM_RESTART': '1', 22:42:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:20 INFO - 'PWD': '/builds/slave/test', 22:42:20 INFO - 'SHELL': '/bin/bash', 22:42:20 INFO - 'SHLVL': '1', 22:42:20 INFO - 'TERM': 'linux', 22:42:20 INFO - 'TMOUT': '86400', 22:42:20 INFO - 'USER': 'cltbld', 22:42:20 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1459834891.720199-1870903635', 22:42:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:20 INFO - '_': '/tools/buildbot/bin/python'} 22:42:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:42:20 INFO - Running setup.py (path:/tmp/pip-1meTtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:42:20 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)) 22:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:42:20 INFO - Running setup.py (path:/tmp/pip-t5b6Jb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:42:20 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)) 22:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:42:20 INFO - Running setup.py (path:/tmp/pip-22xSCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:42:20 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)) 22:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:42:20 INFO - Running setup.py (path:/tmp/pip-1Jp6cb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:42:20 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)) 22:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:42:20 INFO - Running setup.py (path:/tmp/pip-y7Qt6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:42:20 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)) 22:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:42:20 INFO - Running setup.py (path:/tmp/pip-bPHRzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:42:20 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)) 22:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:42:20 INFO - Running setup.py (path:/tmp/pip-ii7KtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:42:20 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)) 22:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:42:20 INFO - Running setup.py (path:/tmp/pip-t0W3RP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:42:21 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)) 22:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:42:21 INFO - Running setup.py (path:/tmp/pip-NGfO47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:42:21 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)) 22:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:42:21 INFO - Running setup.py (path:/tmp/pip-cc5eB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 22:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:42:21 INFO - Running setup.py (path:/tmp/pip-COScDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:42:21 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)) 22:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:42:21 INFO - Running setup.py (path:/tmp/pip-ZKy6yT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:42:21 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)) 22:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:42:21 INFO - Running setup.py (path:/tmp/pip-TcVabl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:42:21 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)) 22:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:42:21 INFO - Running setup.py (path:/tmp/pip-1oJeM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:42:21 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)) 22:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:42:21 INFO - Running setup.py (path:/tmp/pip-PMFEUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:42:21 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)) 22:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:42:21 INFO - Running setup.py (path:/tmp/pip-Y3wap0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:42:21 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)) 22:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:42:21 INFO - Running setup.py (path:/tmp/pip-foGpx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:42:21 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)) 22:42:21 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)) 22:42:21 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)) 22:42:21 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)) 22:42:21 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)) 22:42:21 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)) 22:42:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:42:21 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 22:42:21 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 22:42:21 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 22:42:21 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 22:42:21 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 22:42:21 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 22:42:27 INFO - Downloading blessings-1.6.tar.gz 22:42:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:42:27 INFO - Installing collected packages: blessings 22:42:27 INFO - Running setup.py install for blessings 22:42:27 INFO - Successfully installed blessings 22:42:27 INFO - Cleaning up... 22:42:28 INFO - Return code: 0 22:42:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:42:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:42:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:42:28 INFO - Reading from file tmpfile_stdout 22:42:28 INFO - Current package versions: 22:42:28 INFO - argparse == 1.2.1 22:42:28 INFO - blessings == 1.6 22:42:28 INFO - blobuploader == 1.2.4 22:42:28 INFO - docopt == 0.6.1 22:42:28 INFO - manifestparser == 1.1 22:42:28 INFO - mozInstall == 1.12 22:42:28 INFO - mozcrash == 0.17 22:42:28 INFO - mozdebug == 0.1 22:42:28 INFO - mozdevice == 0.48 22:42:28 INFO - mozfile == 1.2 22:42:28 INFO - mozhttpd == 0.7 22:42:28 INFO - mozinfo == 0.9 22:42:28 INFO - mozleak == 0.1 22:42:28 INFO - mozlog == 3.1 22:42:28 INFO - moznetwork == 0.27 22:42:28 INFO - mozprocess == 0.22 22:42:28 INFO - mozprofile == 0.28 22:42:28 INFO - mozrunner == 6.11 22:42:28 INFO - mozscreenshot == 0.1 22:42:28 INFO - mozsystemmonitor == 0.0 22:42:28 INFO - moztest == 0.7 22:42:28 INFO - mozversion == 1.4 22:42:28 INFO - psutil == 3.1.1 22:42:28 INFO - requests == 1.2.3 22:42:28 INFO - wsgiref == 0.1.2 22:42:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:42:28 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')]} 22:42:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:28 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')]} 22:42:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:28 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 0x7f96b2b10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e84410>, '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 0x1e85310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e857a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1459834891.720199-1870903635', '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 22:42:28 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 22:42:28 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 22:42:28 INFO - Using env: {'DISPLAY': ':0', 22:42:28 INFO - 'HOME': '/home/cltbld', 22:42:28 INFO - 'LANG': 'en_US.UTF-8', 22:42:28 INFO - 'LANGUAGE': 'en_US:en', 22:42:28 INFO - 'LOGNAME': 'cltbld', 22:42:28 INFO - 'MAIL': '/var/mail/cltbld', 22:42:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:28 INFO - 'MOZ_NO_REMOTE': '1', 22:42:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:28 INFO - 'NO_EM_RESTART': '1', 22:42:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:28 INFO - 'PWD': '/builds/slave/test', 22:42:28 INFO - 'SHELL': '/bin/bash', 22:42:28 INFO - 'SHLVL': '1', 22:42:28 INFO - 'TERM': 'linux', 22:42:28 INFO - 'TMOUT': '86400', 22:42:28 INFO - 'USER': 'cltbld', 22:42:28 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1459834891.720199-1870903635', 22:42:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:28 INFO - '_': '/tools/buildbot/bin/python'} 22:42:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:29 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)) 22:42:29 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)) 22:42:29 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)) 22:42:29 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)) 22:42:29 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)) 22:42:29 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)) 22:42:29 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)) 22:42:29 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)) 22:42:29 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)) 22:42:29 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)) 22:42:29 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)) 22:42:29 INFO - Cleaning up... 22:42:29 INFO - Return code: 0 22:42:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:42:29 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')]} 22:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:29 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')]} 22:42:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:29 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 0x7f96b2b10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e84410>, '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 0x1e85310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e857a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1459834891.720199-1870903635', '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 22:42:29 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 22:42:29 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 22:42:29 INFO - Using env: {'DISPLAY': ':0', 22:42:29 INFO - 'HOME': '/home/cltbld', 22:42:29 INFO - 'LANG': 'en_US.UTF-8', 22:42:29 INFO - 'LANGUAGE': 'en_US:en', 22:42:29 INFO - 'LOGNAME': 'cltbld', 22:42:29 INFO - 'MAIL': '/var/mail/cltbld', 22:42:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:29 INFO - 'MOZ_NO_REMOTE': '1', 22:42:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:29 INFO - 'NO_EM_RESTART': '1', 22:42:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:29 INFO - 'PWD': '/builds/slave/test', 22:42:29 INFO - 'SHELL': '/bin/bash', 22:42:29 INFO - 'SHLVL': '1', 22:42:29 INFO - 'TERM': 'linux', 22:42:29 INFO - 'TMOUT': '86400', 22:42:29 INFO - 'USER': 'cltbld', 22:42:29 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1459834891.720199-1870903635', 22:42:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:29 INFO - '_': '/tools/buildbot/bin/python'} 22:42:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:29 INFO - Downloading/unpacking jsonschema 22:42:29 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 22:42:29 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 22:42:29 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 22:42:29 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 22:42:29 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 22:42:29 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 22:42:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:42:32 INFO - Downloading/unpacking functools32 (from jsonschema) 22:42:32 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 22:42:32 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 22:42:32 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 22:42:32 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 22:42:32 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 22:42:32 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 22:42:32 INFO - Downloading functools32-3.2.3-2.tar.gz 22:42:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:42:32 INFO - warning: no files found matching '*.txt' 22:42:32 INFO - no previously-included directories found matching 'build' 22:42:32 INFO - no previously-included directories found matching 'dist' 22:42:32 INFO - no previously-included directories found matching '.git*' 22:42:32 INFO - Installing collected packages: jsonschema, functools32 22:42:32 INFO - Running setup.py install for functools32 22:42:33 INFO - warning: no files found matching '*.txt' 22:42:33 INFO - no previously-included directories found matching 'build' 22:42:33 INFO - no previously-included directories found matching 'dist' 22:42:33 INFO - no previously-included directories found matching '.git*' 22:42:33 INFO - Successfully installed jsonschema functools32 22:42:33 INFO - Cleaning up... 22:42:33 INFO - Return code: 0 22:42:33 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:42:33 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')]} 22:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:33 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')]} 22:42:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:33 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 0x7f96b2b10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e84410>, '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 0x1e85310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e857a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1459834891.720199-1870903635', '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 22:42:33 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 22:42:33 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 22:42:33 INFO - Using env: {'DISPLAY': ':0', 22:42:33 INFO - 'HOME': '/home/cltbld', 22:42:33 INFO - 'LANG': 'en_US.UTF-8', 22:42:33 INFO - 'LANGUAGE': 'en_US:en', 22:42:33 INFO - 'LOGNAME': 'cltbld', 22:42:33 INFO - 'MAIL': '/var/mail/cltbld', 22:42:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:33 INFO - 'MOZ_NO_REMOTE': '1', 22:42:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:33 INFO - 'NO_EM_RESTART': '1', 22:42:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:33 INFO - 'PWD': '/builds/slave/test', 22:42:33 INFO - 'SHELL': '/bin/bash', 22:42:33 INFO - 'SHLVL': '1', 22:42:33 INFO - 'TERM': 'linux', 22:42:33 INFO - 'TMOUT': '86400', 22:42:33 INFO - 'USER': 'cltbld', 22:42:33 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1459834891.720199-1870903635', 22:42:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:33 INFO - '_': '/tools/buildbot/bin/python'} 22:42:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:33 INFO - Downloading/unpacking flake8 22:42:33 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 22:42:33 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 22:42:33 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 22:42:33 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 22:42:33 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 22:42:33 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 22:42:37 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:42:37 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:42:37 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 22:42:37 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 22:42:37 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 22:42:37 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 22:42:37 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 22:42:37 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 22:42:37 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:42:37 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:42:37 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 22:42:37 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 22:42:37 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 22:42:37 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 22:42:37 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 22:42:37 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 22:42:37 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:42:37 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 22:42:37 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 22:42:37 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 22:42:37 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 22:42:37 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 22:42:37 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 22:42:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:42:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:42:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:42:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:42:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:42:38 INFO - no previously-included directories found matching 'docs/_build' 22:42:38 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:42:38 INFO - Running setup.py install for pep8 22:42:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:42:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:42:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:42:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:42:38 INFO - no previously-included directories found matching 'docs/_build' 22:42:38 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:42:38 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:42:38 INFO - Cleaning up... 22:42:38 INFO - Return code: 0 22:42:38 INFO - Running post-action listener: _resource_record_post_action 22:42:38 INFO - Running post-action listener: _start_resource_monitoring 22:42:38 INFO - Starting resource monitoring. 22:42:38 INFO - ##### 22:42:38 INFO - ##### Running install step. 22:42:38 INFO - ##### 22:42:38 INFO - Running pre-action listener: _resource_record_pre_action 22:42:38 INFO - Running main action method: install 22:42:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:42:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:42:38 INFO - Reading from file tmpfile_stdout 22:42:38 INFO - Detecting whether we're running mozinstall >=1.0... 22:42:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:42:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:42:38 INFO - Reading from file tmpfile_stdout 22:42:38 INFO - Output received: 22:42:38 INFO - Usage: mozinstall [options] installer 22:42:38 INFO - Options: 22:42:38 INFO - -h, --help show this help message and exit 22:42:38 INFO - -d DEST, --destination=DEST 22:42:38 INFO - Directory to install application into. [default: 22:42:38 INFO - "/builds/slave/test"] 22:42:38 INFO - --app=APP Application being installed. [default: firefox] 22:42:38 INFO - mkdir: /builds/slave/test/build/application 22:42:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:42:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:42:54 INFO - Reading from file tmpfile_stdout 22:42:54 INFO - Output received: 22:42:54 INFO - /builds/slave/test/build/application/firefox/firefox 22:42:54 INFO - Running post-action listener: _resource_record_post_action 22:42:54 INFO - ##### 22:42:54 INFO - ##### Running run-tests step. 22:42:54 INFO - ##### 22:42:54 INFO - Running pre-action listener: _resource_record_pre_action 22:42:54 INFO - Running main action method: run_tests 22:42:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:42:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:42:54 INFO - Python 2.7.3 22:42:54 INFO - Return code: 0 22:42:54 INFO - grabbing minidump binary from tooltool 22:42:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:42:54 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e84410>, '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 0x1e85310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e857a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:42:54 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 22:42:54 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 22:42:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:42:54 INFO - Return code: 0 22:42:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:42:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:42:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:42:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:42:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:42:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:42:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:42:55 INFO - Return code: 0 22:42:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OGb9A-DNRu-acsFxzkWsCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 22:42:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OGb9A-DNRu-acsFxzkWsCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --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 22:42:55 INFO - Using env: {'DISPLAY': ':0', 22:42:55 INFO - 'HOME': '/home/cltbld', 22:42:55 INFO - 'LANG': 'en_US.UTF-8', 22:42:55 INFO - 'LANGUAGE': 'en_US:en', 22:42:55 INFO - 'LOGNAME': 'cltbld', 22:42:55 INFO - 'MAIL': '/var/mail/cltbld', 22:42:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:42:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:42:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:55 INFO - 'MOZ_NO_REMOTE': '1', 22:42:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:42:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:55 INFO - 'NO_EM_RESTART': '1', 22:42:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:55 INFO - 'PWD': '/builds/slave/test', 22:42:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:42:55 INFO - 'SHELL': '/bin/bash', 22:42:55 INFO - 'SHLVL': '1', 22:42:55 INFO - 'TERM': 'linux', 22:42:55 INFO - 'TMOUT': '86400', 22:42:55 INFO - 'USER': 'cltbld', 22:42:55 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1459834891.720199-1870903635', 22:42:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:55 INFO - '_': '/tools/buildbot/bin/python'} 22:42:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OGb9A-DNRu-acsFxzkWsCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 22:42:55 INFO - mozversion application_buildid: 20160404210406 22:42:55 INFO - mozversion application_changeset: 27df9bc5af2ca94e203e132013a5958bd60e85fc 22:42:55 INFO - mozversion application_display_name: Nightly 22:42:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:42:55 INFO - mozversion application_name: Firefox 22:42:55 INFO - mozversion application_remotingname: firefox 22:42:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:42:55 INFO - mozversion application_vendor: Mozilla 22:42:55 INFO - mozversion application_version: 48.0a1 22:42:55 INFO - mozversion platform_buildid: 20160404210406 22:42:55 INFO - mozversion platform_changeset: 27df9bc5af2ca94e203e132013a5958bd60e85fc 22:42:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:42:55 INFO - mozversion platform_version: 48.0a1 22:42:55 INFO - using testdate: 1459834975 22:42:55 INFO - actual date: 1459834975 22:42:55 INFO - starting webserver on 'localhost:54729' 22:42:55 INFO - SUITE-START | Running 2 tests 22:42:55 INFO - TEST-START | dromaeo_css 22:42:55 INFO - operating with platform_type : linux_ 22:42:55 INFO - Initialising browser for dromaeo_css test... 22:42:55 INFO - TEST-INFO | started process 30228 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptMnpcb/profile http://localhost:54729/getInfo.html) 22:42:59 INFO - PROCESS | 30228 | __metrics Screen width/height:1600/1200 22:42:59 INFO - PROCESS | 30228 | colorDepth:24 22:42:59 INFO - PROCESS | 30228 | Browser inner width/height: 1024/697 22:42:59 INFO - PROCESS | 30228 | __metrics 22:43:00 ERROR - PROCESS | 30228 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:43:01 INFO - TEST-INFO | 30228: exit 0 22:43:01 INFO - Browser initialized. 22:43:01 INFO - Running cycle 1/1 for dromaeo_css test... 22:43:01 INFO - TEST-INFO | started process 30306 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptMnpcb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:43:13 INFO - PROCESS | 30306 | RSS: Main: 154947584 22:43:13 INFO - PROCESS | 30306 | 22:44:04 INFO - PROCESS | 30306 | 1459835044386 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] 22:46:15 INFO - PROCESS | 30306 | Cycle 1(1): loaded http://localhost:54729/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54729/tests/dromaeo/cssquery-ext.html) 22:46:16 INFO - PROCESS | 30306 | RSS: Main: 266813440 22:46:16 INFO - PROCESS | 30306 | 22:49:19 INFO - PROCESS | 30306 | Cycle 1(1): loaded http://localhost:54729/tests/dromaeo/cssquery-ext.html (next: http://localhost:54729/tests/dromaeo/cssquery-jquery.html) 22:49:19 INFO - PROCESS | 30306 | RSS: Main: 232665088 22:49:19 INFO - PROCESS | 30306 | 22:52:21 INFO - PROCESS | 30306 | Cycle 1(1): loaded http://localhost:54729/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54729/tests/dromaeo/cssquery-mootools.html) 22:52:22 INFO - PROCESS | 30306 | RSS: Main: 235728896 22:52:22 INFO - PROCESS | 30306 | 22:55:24 INFO - PROCESS | 30306 | Cycle 1(1): loaded http://localhost:54729/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54729/tests/dromaeo/cssquery-prototype.html) 22:55:24 INFO - PROCESS | 30306 | RSS: Main: 218537984 22:55:24 INFO - PROCESS | 30306 | 22:58:27 INFO - PROCESS | 30306 | Cycle 1(1): loaded http://localhost:54729/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54729/tests/dromaeo/cssquery-yui.html) 22:58:28 INFO - PROCESS | 30306 | RSS: Main: 223395840 22:58:28 INFO - PROCESS | 30306 | 23:01:30 INFO - PROCESS | 30306 | Cycle 1(1): loaded http://localhost:54729/tests/dromaeo/cssquery-yui.html (next: http://localhost:54729/tests/dromaeo/cssquery-dojo.html) 23:01:30 INFO - PROCESS | 30306 | RSS: Main: 265719808 23:01:30 INFO - PROCESS | 30306 | 23:01:30 INFO - PROCESS | 30306 | __start_tp_report 23:01:30 INFO - PROCESS | 30306 | _x_x_mozilla_page_load 23:01:30 INFO - PROCESS | 30306 | _x_x_mozilla_page_load_details 23:01:30 INFO - PROCESS | 30306 | |i|pagename|runs| 23:01:30 INFO - PROCESS | 30306 | |0;dojo.html;2579.3551612096976;2639.590863416171;2655.8273712208693;2663.2276639774454;2677.5983602459623;4473.686841921067;4534.863954081378;4544.545545445454;4546.227141385964;4558.7492687902195;4525.072360166167;4553.772311384426;4580.152671755719;4582.908341833169;4608.21660317746;4173.833046678137;4183.560726123759;4206.831726730927;4235.322348424253;4339.652827773771;4279.957200427987;4298.570142985692;4317.417148684935;4344.97827510862;4352.39066530686;4123.092919557693;4180.749155050677;4198.91602167958;4235.216484950263;4245.681573881956;4130.235906357333;4131.876043718693;4177.143685544456;4177.310743727281;4221.197972385267;4150.460440142792;4159.584041595846;4168.187203495319;4197.412362269285;4201.516825565038;4346.456692913386;4431.26884064129;4440.444944381952;4527.4340707411575;4542.250528662767;4863.27050942358;4870.853874383774;4884.3161957326;4951.3810773653295;4956.553910148068;4914.8771280718265;4924.138275801756;4926.827561035347;4932.605391568666;4984.227444746034;4444.133393988173;4554.567316104932;4591.632669386441;4633.814647414133;4635.58279754817;4967.379077615298;4978.2034874419915;4983;4988;5038.874028149252;4672.766361681903;4809.615230781529;4813.03739252144;4821.807127714852;4870.123377791961;4819.879503012383;4912.336834527365;4918.704877707349;4922.212446008693;4923.852284431473;4829.5653391194255;4860.4896485869185;4866.902661946812;4869.586085182728;4908.11653902301;4828.855134345975;4843.782029808667;4844.0554091951735;4852.514748525119;4900.044491324229;3994.1811928554575;4058.797060146981;4086.0193553546933;4125.64931980779;4134.37984302351;3539.752217344813;3558.6619271169197;3558.946615800765;3591.856325746993;3595.8741444049333;4208.200441916026;4209.515905670826;4211.494620645542;4214;4241.533431322552;4683.672142949961;4823.348847905488;4826.7827947742435;4956.578690811321;4960.875978100504;4275.508316543637;4285.1643929434085;4291.31338985767;4294.9785251073545;4343.435353404037;4326.394304797331;4327.545607711208;4334.436523251957;4385.51759306476;4393.0994146199955;4485.25993211123;4582.198115329737;4613.538646135359;4660.4640466345445;4662.114198302312;4889.217725163957;4938.333325001079;4940.505949405031;4943.184374578154;4966.255061740768;4554.24854898938;4683.601893839062;4703;4708.387909571734;4749.311349854321;4798.064377446364;4832.057748738962;4835.371401717754;4853.733044682435;4886.047220792054;4891.388576427947;4935.358403407534;4939.6542242042715;4939.678920870132;4976.8755781105765;4656.115338085753;4730.172219861579;4782.330473733749;4803.711777293373;4849.587785038311;4726.85819425404;4751;4777.95222047789;4785.234362501983;4818.518148185153;4657.813687452464;4691.812327506861;4699.765011749467;4701.694389864648;4736.313234581035;4612.584867361954;4682.461516925461;4723.433188017322;4808.35087263229;4809.591184749335;4587.472440669366;4668.463126740468;4672.602828759457;4709.105269998689;4721.00858819638 23:01:30 INFO - PROCESS | 30306 | |1;ext.html;542.1325878594248;545.9153831156169;558.1739026241163;565.0563558856709;565.375260337327;27202.319942001435;34430.82784586077;35162.12094697634;35185.648143518556;35232.471512927325;38440.23119537607;38970.22059558807;39002.804985975105;39004;39008.804955975254;7586.165521792612;7767.689292428325;7774.261445162729;7776.183500732426;7777.18339574345;7621.3521850642765;7748.845023099535;7751.069871615414;7752.302292793647;7930.801729956739;7895.644695988694;7969.760907172794;7973.681052757912;7976.042874855026;7978.441509094366;7870.173631768667;7932.048154221501;7932.722354717557;7935.64289606969;7935.801604959922;7792.1428642849805;7997.200279971957;8003.759887203393;8008.119106898236;8015.919840801575;38432.61567384318;39004.21991560181;39013.219735605126;39050.21899562021;39074.218515629815;3262.2333751568362;3268.3299923515624;3361.7478689098416;3416.5046068319953;3615.4396068609144;29290.267743306376;29782.02179782026;29872;30144.84927575348;30801.229969250722;3488.8778892738633;3505.7750550998558;3534.540509733718;3543.5747710274672;3644.344018076745;243071;244438;244503;244559;245527;49845;57638.524340187614;58046.7097664509;58855.411445884994;59170.11244831331;57913.13130303049;58055.41944580585;58334.416655833746;58351;58436.707816461494;15473.690526189414;15828.52514424569;15834.366625334858;15843.287052082684;15861.52415427539;9991.500424978722;10261.692149235534;11674.241174323643;12015.098867584966;12023.759524809455;19531.707024394644;20688;20824.687629685566;20870.26954056601;20908.47728806792;6830.711711576678;7053.518761060235;7089.113860767404;7111.96444017787;7195.964020179866;868.6916144768643;919.8344298026419;962;992.3549692699803;1031.3450958641317;26972.865135674198;27392.17823465299;27912.72087279142;28120.29699257535;28125.578116327863;943.3349488610513;979.6767066867917;994.5773046455228;1033.6640591807693;1079.8337795181185;12266.141370104186;12915.806262906064;12925.612231632878;12959.352032398343;12975.156614820195;224396;227389;227508;227843;228140;43493.13013739708;43558.56441435545;43793.78103109528;43805.56194438079;43835.780821095694;1142.611512085878;1185.1585374384283;1259.7984322508355;1284.9357532123356;1390.7844284135974;24194.69936274614;26454.735452645225;27095.458090837677;27310.86344568344;27350.179494615193;38914;39313.213735725694;39374;39397.60602393939;39407.40888886726;200683;201544;201721;202370;203120;30903.536446952865;32209;32264.35471290608;32690.509642354908;32751.508727369586;40795.38806917839;42354.78822605991;42499.575004249564;42562;42949.78525107355;34940.47589286214;35321.293574127856;35412.46881296731;35456.64543354533;35558.644413555536;35008.824955875054;35053.64946350606;35136.12159695926;35260.64739352574;35474;35023.824880875436;35408.82295588506;35602.46596301109;36207;36300.63699362973;31198.064058078293;31382.6826747245;31883.840580796947;31891.36217275688;31904;24341.26976190717;25079.623805643296;25197.874010630563;25374.873125634254;25527.468351898944 23:01:30 INFO - PROCESS | 30306 | |2;jquery.html;338.27102593910126;341.760767462776;356.25364860617015;362.911086783738;366.2418793098288;15526.301316440758;16058.51824445267;16372.918135409336;16864;16890.408835690752;11180.720481987953;11198.38408887513;11199.328040317587;13959.581212563615;16133.919330403332;4561.315802629607;4679.953200467986;4691.624670026406;4699.976500117495;4700.741459219742;3500.2299494111253;4222.97888510557;5945.137954996523;5971.611845230068;5975.581709280352;5909.704514774244;5920.259967504062;5924.0521516557355;5937.524998000171;5942.732577034044;3531.0642679689904;5534.557235421177;5734.913976290359;5747.1666608341975;5883.61756485827;5095.490450954912;5286.286351342596;5294.841154765363;5295.973520132375;5298.602604804655;11758.412079396081;11969.880301196963;12074.215176013531;16935.153242337958;18675.71986420205;1929.4501067195781;1979.7556580403998;2050.4976280811297;2069.0585783468487;2126.1176611706123;9165.404248723811;9202.217811485965;9295.67465138717;9583.856242156373;9671.661491847823;1782.803891571926;1808.7919889212778;1812.0577299804029;1815.7911840138422;1817.164104511926;56126.59683507904;62023.37976620221;63659.36340636627;64829.35170648328;66160.3383966159;9551;9654.131128198496;9670.75823104428;9862.704118876445;10124.291299608956;13385.263810490516;13462.798058029137;13514.594562162954;13514.59456216315;13525.32373381327;6966.293258151785;7092.290770922969;7114.466415018895;7179.820504487429;7195.064641596559;6671.299513551105;6697.263301036882;6743.9325606743305;6773.390394864486;6852.965735171392;4339.349097635317;4343.2182207203;4354.629856462237;4392.363107349416;4416.558344165622;1773.7516747655338;1783.0906237818547;1787.8390944814769;1813.619139980619;1843.0876716025653;852.6291063387446;902.747230775384;906.1799071839995;934.5747684803398;950.3537594435712;15990.8006899483;16292.67414651724;16349.673006539802;16523.586910327096;16546.83453165453;855.5337341149088;860.0367588301143;882.748416701237;900.2707806676613;907.1291560102244;6881.208661003949;9230.307726920508;9332.300077494216;9530.428174309563;9582.425054496753;352459;379525;384585;386226;388313;70252.64873675599;73633.6318318405;73661;73769.26230737731;74954;961.3606951377395;992.7766252593253;996.7308826616772;999.1656966432964;1005.1757558801859;15253.542393728207;15264;15342.846571534588;15600.531984040497;15655.608609784846;34476.82761586176;34577.82711086429;34962.47556286708;35479.64520354763;36305.81847090748;47359.52640473551;48688.2696759556;48689.11614535797;48905.5109448901;49146;7469.626518674153;7522.811929701801;7530.4352173588295;7556.65995030236;7605.6577454013595;10505.842412363667;11771;11801.881981180079;11821.645350639494;12161;9607.615695372107;9954.45250511229;10100.141487973604;10492.422916739348;10525.526351314362;9911;9934.354266972623;10200.0819926207;10281.280310378203;10382.740431489274;10239.692809215736;10499.790004200026;10567.418791966516;10784.946075269887;11234.382108984084;7562.773116806505;7701.537907725555;7708.961455192688;7738;7744.993150890574;9996.700098997042;10759.838602420814;10761.730956726144;11015.063719583924;11015.284006539548 23:01:30 INFO - PROCESS | 30306 | |3;mootools.html;1228.6744012836593;1411.1533080151908;1436.648021234797;1604.2540218798256;1776.3516316544458;7012.193597736262;7183.138023437188;7198.208197098315;7199.928000719998;7204.243554426788;7164.247753985835;7326.560406375621;7331.303526165006;7331.376832969204;7333.486655934087;1882.218879165145;2197.560487902418;2235.3182279404814;2247.3370355745014;2262.479629685173;2239.428945618865;2252.2905284835306;2252.5720113178527;2254.695616091831;2254.763249858766;2130.5419334843004;2180.5529866377356;2181.334692918659;2182.7598964113936;2182.9126834926583;2151.7848215178515;2169.858959167657;2182.967255491169;2202.3723238877005;2203.272919936433;2143.710599069121;2198.4943463003438;2206.7572567017774;2210.8894555272173;2214.136486770161;7179.641017949134;7222.638868056576;7236.529625574373;7241.782746517613;7250.238724933912;4507.729536227836;4659.161350956826;4666.160091183586;4668.719876807369;4670.696404733715;2905.8401787901657;2916.6208392908998;2943.014090279759;2945.7496112830436;3047.162030441624;837.5016864965336;852.8379607874484;940.1068984464786;962.1484985787629;979.774651830076;9986.400815950994;9989.600415983352;9997.550110245056;9999.75000624983;10016.54925528353;4076.2458945095254;4104.0970986382945;4195.643370313496;4207.8316867325575;4222.303319952235;8646.913530864736;8654.48073115615;8658.956705216433;8672;8713.520756358334;3890.8832735017995;4624.121416930772;4660.906781864343;4668.743219122913;4671.369365135731;4076.2255171517318;4163.125743593819;4164.4586203793315;4170.937435938464;4183.91632167355;3481.3907566175817;3525.3301872644115;3550.3254381667402;3602.2795440911923;3614.331348700499;1137.1016896651718;1162.424599823076;1191.9404029798475;1199.688081098903;1202.6933132051445;952.2524818017823;955.6702937486556;957.2533423929347;1020.7090979070929;1221.5113954418125;7059.647017649199;7064.788056358318;7079.858402831915;7107.111611048619;7109.146902371748;453.82754553269547;1113.3041848844473;1129.949152288149;1135.1486385211092;1162.354893034374;5419;5420.214068959979;5430.83707488776;5452.482014208644;5461.098918678374;8463.238308552136;8568.057513673491;8635.525046122399;8649.1350864913;8913.777155571033;8342.082370939192;8398.874016889751;8466.619002144918;8484.703035393732;8501.362397820065;6830.077939478107;6912.447004239649;6929.41100006495;6956.095707557985;6993.650317484207;6835.521513494008;6877.58734475933;6898.6205758681745;6925.826854328682;6937.549059311129;7812.375009999073;8027.75569786684;8068.47554908929;8076.4750291230885;8208;7691.30778229962;7892.0529536456;8066.959665201636;8071.192880712117;8340.708075217339;5715.485606295453;6271.43557079865;6438.645874476949;6493;6588.341165883373;6815.727370905307;6820.3861652451515;6863.347981941708;6868.038474613658;6872.793816185523;6190.41191086846;6335.271443784024;6353.332900045429;6419.101325814297;6434.64609446485;6133.080037994337;6214.25428948529;6233.812985610439;6286.6856657166045;6356.77751278703;6593.868122637425;6613.305602911817;6639.269680335063;6647.6676166192465;6655.933440665532;5825.621334613236;6098.176746139215;6140.201773769381;6142.14010038586;6143.017117261216;6090.908636370369;6121.3572574879;6127.050307202391;6137.662428566293;6140.078988151813 23:01:30 INFO - PROCESS | 30306 | |4;prototype.html;318.2616330114135;319.38677738741615;319.74739955435206;323.291990540716;324.71911796296195;5223.3731952165745;5338.252644629755;5346.064438723218;5350.89298214036;5355.866103347414;5223.843284701465;5312.335958005249;5321.068812957727;5328.706921119337;5337.6797392156495;3897.142628621699;4012.2978478766245;4078.3270760324513;4112.650424713903;4131.938020929689;4081.0613558881473;4097.467329247193;4109.856155034575;4111.444954931091;4112.424260603518;4065.1869626074754;4073.388991651246;4077.9805048737817;4080.224757296119;4080.6123418275365;3907.257621051991;3983.6016398360075;4068.1863627274665;4072.409500622423;4082.795860206978;3556.4309710446464;3557.964420355789;3559.48387483816;3560.394732895388;3567.6075631680496;5048.242763585492;5051;5052.747362631891;5055.216441451581;5060;4653.488116307238;4660.137874493195;4663.463701674317;4664.346991421204;4669.2062349400685;5522.30971128609;5522.779088836442;5527.419620939783;5531.419200983919;5535.418781028015;3865.265599536079;3865.8260378283044;3872.1481274119647;3874.6319099685484;3877.0501227199234;5579.944200557983;5815.680137592431;5816.941830581724;5821.563382746311;5828.6211396259105;3974.721769476109;3987.860424885173;3989.5212574490665;3989.5412027616617;3992.1017771001875;4044.9595504045174;4047.6964227683043;4048.655864251513;4050.1697152083752;4052.068024354356;4641.930371044437;4646.95353046472;4648.790804413809;4651.395318608627;4653.046125544255;5550.16747487872;5558.722063896789;5559.193916882029;5560.165975103686;5565.387807341189;1394.6164804678592;1407.8873690104767;1413.4770135050098;1413.561795843292;1417.5463851567606;929.6188562689265;950.9904900951041;968.8062387522524;969.0793745941243;970.4565443351746;4867.756612169377;4884.804607815719;4888.120138375127;4891.192953162688;4907.87730306738;5697.515711164515;5698;5700.629459085146;5704.600677952587;5705.971470142623;4879.097366987119;4886.413630364379;4888.9755551222015;4889.144399730104;4889.877753056131;3036.4230796148663;3066.2181143808634;3066.31008023193;3068.3403068340413;3069.478188707925;5386.272853164773;5391.272178255964;5392.64947778401;5395.514403703685;5395.838124856261;5650.152477128464;5770.913436298459;5776.942230577724;5781.103928891029;5785.334686511021;5304.602154838402;5323.414424413311;5325.733713314319;5327.254184414108;5330.546903513167;5616.915746263728;5626.7902400983985;5628.802991895264;5633.802816901389;5634.492895639412;5510.476504732044;5511.173324001432;5557.138643510262;5563.554915606823;5571.860703482445;5373.086575282289;5378.623496355218;5379.865503362447;5380.43505431924;5386.434424385383;3852.5954774748247;3963.6432721055244;3979.20415916812;3993.92012159761;3996.720229583901;5498.45015498447;5719.857003574777;5721.05602575587;5732.082866741302;5737.053386191232;5391.81128660495;5500.642458240201;5505.421930697379;5508.586855985737;5521.282233309644;5453.400125986218;5495.972520137374;5497.532709719719;5499.615026948075;5505.614606977473;5397.622166448468;5485.232067510472;5490.203920431595;5492.450754924475;5498.642588231752;5610.046292130266;5613.214150018919;5618.438156184349;5621.100623900156;5623.465770751772;5328.387235467816;5470.370907345706;5470.562355011669;5474.206240095244;5482.698451585201 23:01:30 INFO - PROCESS | 30306 | |5;yui.html;678.674236366544;697.7418355208573;700.2752151523173;703.493721986405;742.5359150530918;11974.161808673385;12160.087993400486;12191.817122743167;12250.877491225096;12281.570145044925;11943.820842687366;12030.578929737461;12086.274823510596;12090.032797376189;12109.697257568543;638.5179189711785;795.3080819686866;804.3484777330352;813.5403497024163;814.7555733280022;817.7015389382892;820.2658620534618;820.958952052398;821.6836517940576;822.4037572759731;865.5888452984844;867.6225841758824;869.7260362985671;870.4690139015196;870.682200996638;677.7898851356096;851.6976473351933;855.9400841941067;864.4553931023446;865.8051938313861;630.136712703599;630.7634637011121;632.3613150717762;632.3802673380113;634.1724050114599;12267.509299628093;12275.263484190977;12323.137380383378;12323.938380308131;12338.074644401706;11800.88199118015;12523.114136355898;12635.43140558677;12639.241645501299;12652.304123273216;9058.864117038249;9224.169824715807;9460.337776355658;9463.621455141785;9487.335886487948;3293.357795229931;3316.585426821647;3318.3529211803707;3349.062262566485;3423.6576342365815;41755.582444175474;41793.79103104465;42107.7894610528;42224.1555168898;42244.36633450501;8883;9556.952215239018;9666.323357364918;9715.07706767856;9718.562664680107;17509.7373539397;17541;17595.56011099707;17795.377161799275;17889.37387191442;6387.552871298964;6464.482841372679;6473.28793832678;6561.770338038241;6666.933330666631;3661.853525858936;3691.686206672463;3718.2749363874327;3854.325493038707;3871.9032024199055;2664.9067282645015;2677.705452400234;2682.597610358423;2692.7980401469968;2697.865106744655;458.82564625442785;491.3710450623208;505.59552358113365;506.25074889164244;510.25757522804975;569.6781318555003;621.6953987654642;635.7584118035116;635.7647670361996;641.1152609398999;7694.461387702919;7784.455088143775;7851.685932562634;7916.604169791487;8106.594670266463;608.6895683201599;609.8780243951228;611.9510439164856;615.5875563372551;642.2838535033404;3635.7454978151277;3641.6540428659237;3714.3499887519574;3722.7021838252876;3733.3839916413485;46980;47163.76418117956;48038.759806201444;50878;55202.17196742052;44238.557614424084;44800.3279950801;44840;45005.77497112559;45814.08371832611;44121.55878441175;44366.77816610961;44422;44743.88140296454;45528.772356138004;7996.280334769898;8101;8126.878096828434;8201.507909525448;8436.156384361515;31001.224969375948;31822.522662159623;31874.362512750078;31908.680913190572;32311.192220194684;34918.65081349255;36709.44935825912;38794.2241155181;38921.610783891796;39180.608193917695;9691.563879625293;9784.902150978683;9936.354136981074;10164.085232329126;10507.527161277609;11006.834897476385;11079;11221.102311815199;11379.601713939972;11897.167198296036;9026.593803278736;10775.245732798629;10863.891361086604;10877.891221087688;11114.388708621103;11153.330800152016;11170.27393219438;11279.15406344511;11291.491882865455;11317;10640.946795265974;10693.9465302673;10740.409277489813;10816.242862999514;10913;9379.577918993798;9479.383840050376;9488.667896623585;9691.466969316756;9799.706008819461;8591.226789588967;8711.433756805787;8971.596278167368;9301.953490232776;9357.157855793012 23:01:30 INFO - PROCESS | 30306 | __end_tp_report 23:01:30 INFO - PROCESS | 30306 | __start_cc_report 23:01:30 INFO - PROCESS | 30306 | _x_x_mozilla_cycle_collect,1033 23:01:30 INFO - PROCESS | 30306 | __end_cc_report 23:01:30 INFO - PROCESS | 30306 | __startTimestamp1459836090888__endTimestamp 23:01:30 INFO - PROCESS | 30306 | 23:01:30 INFO - PROCESS | 30306 | ------- Summary: start ------- 23:01:30 INFO - PROCESS | 30306 | Number of tests: 6 23:01:30 INFO - PROCESS | 30306 | 23:01:30 INFO - PROCESS | 30306 | [#0] dojo.html Cycles:165 Average:4518.33 Median:4657.81 stddev:466.90 (10.0%) stddev-sans-first:442.87 23:01:30 INFO - PROCESS | 30306 | Values: 2579.4 2639.6 2655.8 2663.2 2677.6 4473.7 4534.9 4544.5 4546.2 4558.7 4525.1 4553.8 4580.2 4582.9 4608.2 4173.8 4183.6 4206.8 4235.3 4339.7 4280.0 4298.6 4317.4 4345.0 4352.4 4123.1 4180.7 4198.9 4235.2 4245.7 4130.2 4131.9 4177.1 4177.3 4221.2 4150.5 4159.6 4168.2 4197.4 4201.5 4346.5 4431.3 4440.4 4527.4 4542.3 4863.3 4870.9 4884.3 4951.4 4956.6 4914.9 4924.1 4926.8 4932.6 4984.2 4444.1 4554.6 4591.6 4633.8 4635.6 4967.4 4978.2 4983.0 4988.0 5038.9 4672.8 4809.6 4813.0 4821.8 4870.1 4819.9 4912.3 4918.7 4922.2 4923.9 4829.6 4860.5 4866.9 4869.6 4908.1 4828.9 4843.8 4844.1 4852.5 4900.0 3994.2 4058.8 4086.0 4125.6 4134.4 3539.8 3558.7 3558.9 3591.9 3595.9 4208.2 4209.5 4211.5 4214.0 4241.5 4683.7 4823.3 4826.8 4956.6 4960.9 4275.5 4285.2 4291.3 4295.0 4343.4 4326.4 4327.5 4334.4 4385.5 4393.1 4485.3 4582.2 4613.5 4660.5 4662.1 4889.2 4938.3 4940.5 4943.2 4966.3 4554.2 4683.6 4703.0 4708.4 4749.3 4798.1 4832.1 4835.4 4853.7 4886.0 4891.4 4935.4 4939.7 4939.7 4976.9 4656.1 4730.2 4782.3 4803.7 4849.6 4726.9 4751.0 4778.0 4785.2 4818.5 4657.8 4691.8 4699.8 4701.7 4736.3 4612.6 4682.5 4723.4 4808.4 4809.6 4587.5 4668.5 4672.6 4709.1 4721.0 23:01:30 INFO - PROCESS | 30306 | 23:01:30 INFO - PROCESS | 30306 | [#1] ext.html Cycles:180 Average:39485.87 Median:19471.68 stddev:58396.92 (299.9%) stddev-sans-first:58487.53 23:01:30 INFO - PROCESS | 30306 | Values: 542.1 545.9 558.2 565.1 565.4 27202.3 34430.8 35162.1 35185.6 35232.5 38440.2 38970.2 39002.8 39004.0 39008.8 7586.2 7767.7 7774.3 7776.2 7777.2 7621.4 7748.8 7751.1 7752.3 7930.8 7895.6 7969.8 7973.7 7976.0 7978.4 7870.2 7932.0 7932.7 7935.6 7935.8 7792.1 7997.2 8003.8 8008.1 8015.9 38432.6 39004.2 39013.2 39050.2 39074.2 3262.2 3268.3 3361.7 3416.5 3615.4 29290.3 29782.0 29872.0 30144.8 30801.2 3488.9 3505.8 3534.5 3543.6 3644.3 243071.0 244438.0 244503.0 244559.0 245527.0 49845.0 57638.5 58046.7 58855.4 59170.1 57913.1 58055.4 58334.4 58351.0 58436.7 15473.7 15828.5 15834.4 15843.3 15861.5 9991.5 10261.7 11674.2 12015.1 12023.8 19531.7 20688.0 20824.7 20870.3 20908.5 6830.7 7053.5 7089.1 7112.0 7196.0 868.7 919.8 962.0 992.4 1031.3 26972.9 27392.2 27912.7 28120.3 28125.6 943.3 979.7 994.6 1033.7 1079.8 12266.1 12915.8 12925.6 12959.4 12975.2 224396.0 227389.0 227508.0 227843.0 228140.0 43493.1 43558.6 43793.8 43805.6 43835.8 1142.6 1185.2 1259.8 1284.9 1390.8 24194.7 26454.7 27095.5 27310.9 27350.2 38914.0 39313.2 39374.0 39397.6 39407.4 200683.0 201544.0 201721.0 202370.0 203120.0 30903.5 32209.0 32264.4 32690.5 32751.5 40795.4 42354.8 42499.6 42562.0 42949.8 34940.5 35321.3 35412.5 35456.6 35558.6 35008.8 35053.6 35136.1 35260.6 35474.0 35023.8 35408.8 35602.5 36207.0 36300.6 31198.1 31382.7 31883.8 31891.4 31904.0 24341.3 25079.6 25197.9 25374.9 25527.5 23:01:30 INFO - PROCESS | 30306 | 23:01:30 INFO - PROCESS | 30306 | [#2] jquery.html Cycles:180 Average:23227.11 Median:4620.63 stddev:62366.10 (1349.7%) stddev-sans-first:62517.37 23:01:30 INFO - PROCESS | 30306 | Values: 338.3 341.8 356.3 362.9 366.2 15526.3 16058.5 16372.9 16864.0 16890.4 11180.7 11198.4 11199.3 13959.6 16133.9 4561.3 4680.0 4691.6 4700.0 4700.7 3500.2 4223.0 5945.1 5971.6 5975.6 5909.7 5920.3 5924.1 5937.5 5942.7 3531.1 5534.6 5734.9 5747.2 5883.6 5095.5 5286.3 5294.8 5296.0 5298.6 11758.4 11969.9 12074.2 16935.2 18675.7 1929.5 1979.8 2050.5 2069.1 2126.1 9165.4 9202.2 9295.7 9583.9 9671.7 1782.8 1808.8 1812.1 1815.8 1817.2 56126.6 62023.4 63659.4 64829.4 66160.3 9551.0 9654.1 9670.8 9862.7 10124.3 13385.3 13462.8 13514.6 13514.6 13525.3 6966.3 7092.3 7114.5 7179.8 7195.1 6671.3 6697.3 6743.9 6773.4 6853.0 4339.3 4343.2 4354.6 4392.4 4416.6 1773.8 1783.1 1787.8 1813.6 1843.1 852.6 902.7 906.2 934.6 950.4 15990.8 16292.7 16349.7 16523.6 16546.8 855.5 860.0 882.7 900.3 907.1 6881.2 9230.3 9332.3 9530.4 9582.4 352459.0 379525.0 384585.0 386226.0 388313.0 70252.6 73633.6 73661.0 73769.3 74954.0 961.4 992.8 996.7 999.2 1005.2 15253.5 15264.0 15342.8 15600.5 15655.6 34476.8 34577.8 34962.5 35479.6 36305.8 47359.5 48688.3 48689.1 48905.5 49146.0 7469.6 7522.8 7530.4 7556.7 7605.7 10505.8 11771.0 11801.9 11821.6 12161.0 9607.6 9954.5 10100.1 10492.4 10525.5 9911.0 9934.4 10200.1 10281.3 10382.7 10239.7 10499.8 10567.4 10784.9 11234.4 7562.8 7701.5 7709.0 7738.0 7745.0 9996.7 10759.8 10761.7 11015.1 11015.3 23:01:30 INFO - PROCESS | 30306 | 23:01:30 INFO - PROCESS | 30306 | [#3] mootools.html Cycles:180 Average:5136.57 Median:6202.33 stddev:2615.37 (42.2%) stddev-sans-first:2606.20 23:01:30 INFO - PROCESS | 30306 | Values: 1228.7 1411.2 1436.6 1604.3 1776.4 7012.2 7183.1 7198.2 7199.9 7204.2 7164.2 7326.6 7331.3 7331.4 7333.5 1882.2 2197.6 2235.3 2247.3 2262.5 2239.4 2252.3 2252.6 2254.7 2254.8 2130.5 2180.6 2181.3 2182.8 2182.9 2151.8 2169.9 2183.0 2202.4 2203.3 2143.7 2198.5 2206.8 2210.9 2214.1 7179.6 7222.6 7236.5 7241.8 7250.2 4507.7 4659.2 4666.2 4668.7 4670.7 2905.8 2916.6 2943.0 2945.7 3047.2 837.5 852.8 940.1 962.1 979.8 9986.4 9989.6 9997.6 9999.8 10016.5 4076.2 4104.1 4195.6 4207.8 4222.3 8646.9 8654.5 8659.0 8672.0 8713.5 3890.9 4624.1 4660.9 4668.7 4671.4 4076.2 4163.1 4164.5 4170.9 4183.9 3481.4 3525.3 3550.3 3602.3 3614.3 1137.1 1162.4 1191.9 1199.7 1202.7 952.3 955.7 957.3 1020.7 1221.5 7059.6 7064.8 7079.9 7107.1 7109.1 453.8 1113.3 1129.9 1135.1 1162.4 5419.0 5420.2 5430.8 5452.5 5461.1 8463.2 8568.1 8635.5 8649.1 8913.8 8342.1 8398.9 8466.6 8484.7 8501.4 6830.1 6912.4 6929.4 6956.1 6993.7 6835.5 6877.6 6898.6 6925.8 6937.5 7812.4 8027.8 8068.5 8076.5 8208.0 7691.3 7892.1 8067.0 8071.2 8340.7 5715.5 6271.4 6438.6 6493.0 6588.3 6815.7 6820.4 6863.3 6868.0 6872.8 6190.4 6335.3 6353.3 6419.1 6434.6 6133.1 6214.3 6233.8 6286.7 6356.8 6593.9 6613.3 6639.3 6647.7 6655.9 5825.6 6098.2 6140.2 6142.1 6143.0 6090.9 6121.4 6127.1 6137.7 6140.1 23:01:30 INFO - PROCESS | 30306 | 23:01:30 INFO - PROCESS | 30306 | [#4] prototype.html Cycles:180 Average:4582.19 Median:5324.57 stddev:1337.91 (25.1%) stddev-sans-first:1302.82 23:01:30 INFO - PROCESS | 30306 | Values: 318.3 319.4 319.7 323.3 324.7 5223.4 5338.3 5346.1 5350.9 5355.9 5223.8 5312.3 5321.1 5328.7 5337.7 3897.1 4012.3 4078.3 4112.7 4131.9 4081.1 4097.5 4109.9 4111.4 4112.4 4065.2 4073.4 4078.0 4080.2 4080.6 3907.3 3983.6 4068.2 4072.4 4082.8 3556.4 3558.0 3559.5 3560.4 3567.6 5048.2 5051.0 5052.7 5055.2 5060.0 4653.5 4660.1 4663.5 4664.3 4669.2 5522.3 5522.8 5527.4 5531.4 5535.4 3865.3 3865.8 3872.1 3874.6 3877.1 5579.9 5815.7 5816.9 5821.6 5828.6 3974.7 3987.9 3989.5 3989.5 3992.1 4045.0 4047.7 4048.7 4050.2 4052.1 4641.9 4647.0 4648.8 4651.4 4653.0 5550.2 5558.7 5559.2 5560.2 5565.4 1394.6 1407.9 1413.5 1413.6 1417.5 929.6 951.0 968.8 969.1 970.5 4867.8 4884.8 4888.1 4891.2 4907.9 5697.5 5698.0 5700.6 5704.6 5706.0 4879.1 4886.4 4889.0 4889.1 4889.9 3036.4 3066.2 3066.3 3068.3 3069.5 5386.3 5391.3 5392.6 5395.5 5395.8 5650.2 5770.9 5776.9 5781.1 5785.3 5304.6 5323.4 5325.7 5327.3 5330.5 5616.9 5626.8 5628.8 5633.8 5634.5 5510.5 5511.2 5557.1 5563.6 5571.9 5373.1 5378.6 5379.9 5380.4 5386.4 3852.6 3963.6 3979.2 3993.9 3996.7 5498.5 5719.9 5721.1 5732.1 5737.1 5391.8 5500.6 5505.4 5508.6 5521.3 5453.4 5496.0 5497.5 5499.6 5505.6 5397.6 5485.2 5490.2 5492.5 5498.6 5610.0 5613.2 5618.4 5621.1 5623.5 5328.4 5470.4 5470.6 5474.2 5482.7 23:01:30 INFO - PROCESS | 30306 | 23:01:30 INFO - PROCESS | 30306 | [#5] yui.html Cycles:180 Average:12528.88 Median:23136.45 stddev:14086.59 (60.9%) stddev-sans-first:14097.99 23:01:30 INFO - PROCESS | 30306 | Values: 678.7 697.7 700.3 703.5 742.5 11974.2 12160.1 12191.8 12250.9 12281.6 11943.8 12030.6 12086.3 12090.0 12109.7 638.5 795.3 804.3 813.5 814.8 817.7 820.3 821.0 821.7 822.4 865.6 867.6 869.7 870.5 870.7 677.8 851.7 855.9 864.5 865.8 630.1 630.8 632.4 632.4 634.2 12267.5 12275.3 12323.1 12323.9 12338.1 11800.9 12523.1 12635.4 12639.2 12652.3 9058.9 9224.2 9460.3 9463.6 9487.3 3293.4 3316.6 3318.4 3349.1 3423.7 41755.6 41793.8 42107.8 42224.2 42244.4 8883.0 9557.0 9666.3 9715.1 9718.6 17509.7 17541.0 17595.6 17795.4 17889.4 6387.6 6464.5 6473.3 6561.8 6666.9 3661.9 3691.7 3718.3 3854.3 3871.9 2664.9 2677.7 2682.6 2692.8 2697.9 458.8 491.4 505.6 506.3 510.3 569.7 621.7 635.8 635.8 641.1 7694.5 7784.5 7851.7 7916.6 8106.6 608.7 609.9 612.0 615.6 642.3 3635.7 3641.7 3714.3 3722.7 3733.4 46980.0 47163.8 48038.8 50878.0 55202.2 44238.6 44800.3 44840.0 45005.8 45814.1 44121.6 44366.8 44422.0 44743.9 45528.8 7996.3 8101.0 8126.9 8201.5 8436.2 31001.2 31822.5 31874.4 31908.7 32311.2 34918.7 36709.4 38794.2 38921.6 39180.6 9691.6 9784.9 9936.4 10164.1 10507.5 11006.8 11079.0 11221.1 11379.6 11897.2 9026.6 10775.2 10863.9 10877.9 11114.4 11153.3 11170.3 11279.2 11291.5 11317.0 10640.9 10693.9 10740.4 10816.2 10913.0 9379.6 9479.4 9488.7 9691.5 9799.7 8591.2 8711.4 8971.6 9302.0 9357.2 23:01:30 INFO - PROCESS | 30306 | -------- Summary: end -------- 23:01:30 INFO - PROCESS | 30306 | 23:01:31 INFO - TEST-INFO | 30306: exit 0 23:01:31 INFO - TEST-OK | dromaeo_css | took 1115819ms 23:01:31 INFO - TEST-START | kraken 23:01:31 INFO - operating with platform_type : linux_ 23:01:31 INFO - Initialising browser for kraken test... 23:01:31 INFO - TEST-INFO | started process 30482 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0o6Jl3/profile http://localhost:54729/getInfo.html) 23:01:35 INFO - PROCESS | 30482 | __metrics Screen width/height:1600/1200 23:01:35 INFO - PROCESS | 30482 | colorDepth:24 23:01:35 INFO - PROCESS | 30482 | Browser inner width/height: 1024/697 23:01:35 INFO - PROCESS | 30482 | __metrics 23:01:36 ERROR - PROCESS | 30482 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:01:37 INFO - TEST-INFO | 30482: exit 0 23:01:37 INFO - Browser initialized. 23:01:37 INFO - Running cycle 1/1 for kraken test... 23:01:37 INFO - TEST-INFO | started process 30562 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0o6Jl3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:01:49 INFO - PROCESS | 30562 | RSS: Main: 154382336 23:01:49 INFO - PROCESS | 30562 | 23:01:51 INFO - PROCESS | 30562 | Cycle 1(1): loaded http://localhost:54729/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54729/tests/kraken/driver.html?testName=audio-beat-detection) 23:01:52 INFO - PROCESS | 30562 | RSS: Main: 195067904 23:01:52 INFO - PROCESS | 30562 | 23:01:55 INFO - PROCESS | 30562 | Cycle 1(1): loaded http://localhost:54729/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54729/tests/kraken/driver.html?testName=audio-dft) 23:01:55 INFO - PROCESS | 30562 | RSS: Main: 185241600 23:01:55 INFO - PROCESS | 30562 | 23:01:58 INFO - PROCESS | 30562 | Cycle 1(1): loaded http://localhost:54729/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54729/tests/kraken/driver.html?testName=audio-fft) 23:01:59 INFO - PROCESS | 30562 | RSS: Main: 170012672 23:01:59 INFO - PROCESS | 30562 | 23:02:01 INFO - PROCESS | 30562 | Cycle 1(1): loaded http://localhost:54729/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54729/tests/kraken/driver.html?testName=audio-oscillator) 23:02:02 INFO - PROCESS | 30562 | RSS: Main: 172154880 23:02:02 INFO - PROCESS | 30562 | 23:02:04 INFO - PROCESS | 30562 | Cycle 1(1): loaded http://localhost:54729/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54729/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:02:05 INFO - PROCESS | 30562 | RSS: Main: 173813760 23:02:05 INFO - PROCESS | 30562 | 23:02:08 INFO - PROCESS | 30562 | Cycle 1(1): loaded http://localhost:54729/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54729/tests/kraken/driver.html?testName=imaging-darkroom) 23:02:08 INFO - PROCESS | 30562 | RSS: Main: 174374912 23:02:08 INFO - PROCESS | 30562 | 23:02:12 INFO - PROCESS | 30562 | Cycle 1(1): loaded http://localhost:54729/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54729/tests/kraken/driver.html?testName=imaging-desaturate) 23:02:12 INFO - PROCESS | 30562 | RSS: Main: 174641152 23:02:12 INFO - PROCESS | 30562 | 23:02:15 INFO - PROCESS | 30562 | Cycle 1(1): loaded http://localhost:54729/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54729/tests/kraken/driver.html?testName=json-parse-financial) 23:02:16 INFO - PROCESS | 30562 | RSS: Main: 175214592 23:02:16 INFO - PROCESS | 30562 | 23:02:17 INFO - PROCESS | 30562 | Cycle 1(1): loaded http://localhost:54729/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54729/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:02:18 INFO - PROCESS | 30562 | RSS: Main: 184090624 23:02:18 INFO - PROCESS | 30562 | 23:02:20 INFO - PROCESS | 30562 | Cycle 1(1): loaded http://localhost:54729/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54729/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:02:20 INFO - PROCESS | 30562 | RSS: Main: 181927936 23:02:20 INFO - PROCESS | 30562 | 23:02:23 INFO - PROCESS | 30562 | Cycle 1(1): loaded http://localhost:54729/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54729/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:02:23 INFO - PROCESS | 30562 | RSS: Main: 191995904 23:02:23 INFO - PROCESS | 30562 | 23:02:26 INFO - PROCESS | 30562 | Cycle 1(1): loaded http://localhost:54729/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54729/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:02:26 INFO - PROCESS | 30562 | RSS: Main: 198094848 23:02:26 INFO - PROCESS | 30562 | 23:02:29 INFO - PROCESS | 30562 | Cycle 1(1): loaded http://localhost:54729/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54729/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:02:29 INFO - PROCESS | 30562 | RSS: Main: 198303744 23:02:29 INFO - PROCESS | 30562 | 23:02:31 INFO - PROCESS | 30562 | Cycle 1(1): loaded http://localhost:54729/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54729/tests/kraken/driver.html?testName=ai-astar) 23:02:31 INFO - PROCESS | 30562 | RSS: Main: 260001792 23:02:31 INFO - PROCESS | 30562 | 23:02:31 INFO - PROCESS | 30562 | __start_tp_report 23:02:31 INFO - PROCESS | 30562 | _x_x_mozilla_page_load 23:02:31 INFO - PROCESS | 30562 | _x_x_mozilla_page_load_details 23:02:31 INFO - PROCESS | 30562 | |i|pagename|runs| 23:02:31 INFO - PROCESS | 30562 | |0;ai-astar;110;113;108;111;114;114;104;113;111;111 23:02:31 INFO - PROCESS | 30562 | |1;audio-beat-detection;156;137;155;175;132;152;156;139;182;132 23:02:31 INFO - PROCESS | 30562 | |2;audio-dft;162;161;159;162;160;159;161;162;162;162 23:02:31 INFO - PROCESS | 30562 | |3;audio-fft;73;76;107;95;74;74;73;117;98;74 23:02:31 INFO - PROCESS | 30562 | |4;audio-oscillator;94;95;141;93;94;94;142;94;94;149 23:02:31 INFO - PROCESS | 30562 | |5;imaging-gaussian-blur;117;116;117;116;117;116;117;117;117;117 23:02:31 INFO - PROCESS | 30562 | |6;imaging-darkroom;146;147;146;146;146;146;145;146;146;146 23:02:31 INFO - PROCESS | 30562 | |7;imaging-desaturate;95;95;95;96;95;95;95;96;94;95 23:02:31 INFO - PROCESS | 30562 | |8;json-parse-financial;64;65;67;65;64;65;67;77;63;64 23:02:31 INFO - PROCESS | 30562 | |9;json-stringify-tinderbox;63;63;63;64;64;67;64;64;64;64 23:02:31 INFO - PROCESS | 30562 | |10;stanford-crypto-aes;81;83;81;83;81;89;81;82;80;83 23:02:31 INFO - PROCESS | 30562 | |11;stanford-crypto-ccm;116;119;123;114;115;115;127;117;125;115 23:02:31 INFO - PROCESS | 30562 | |12;stanford-crypto-pbkdf2;142;137;145;142;142;128;130;137;150;149 23:02:31 INFO - PROCESS | 30562 | |13;stanford-crypto-sha256-iterative;69;66;68;67;67;69;67;71;66;68 23:02:31 INFO - PROCESS | 30562 | __end_tp_report 23:02:31 INFO - PROCESS | 30562 | __start_cc_report 23:02:31 INFO - PROCESS | 30562 | _x_x_mozilla_cycle_collect,1174 23:02:31 INFO - PROCESS | 30562 | __end_cc_report 23:02:31 INFO - PROCESS | 30562 | __startTimestamp1459836151876__endTimestamp 23:02:31 INFO - PROCESS | 30562 | 23:02:31 INFO - PROCESS | 30562 | ------- Summary: start ------- 23:02:31 INFO - PROCESS | 30562 | Number of tests: 14 23:02:31 INFO - PROCESS | 30562 | 23:02:31 INFO - PROCESS | 30562 | [#0] ai-astar Cycles:10 Average:110.90 Median:112.00 stddev:3.07 (2.7%) stddev-sans-first:3.24 23:02:31 INFO - PROCESS | 30562 | Values: 110.0 113.0 108.0 111.0 114.0 114.0 104.0 113.0 111.0 111.0 23:02:31 INFO - PROCESS | 30562 | 23:02:31 INFO - PROCESS | 30562 | [#1] audio-beat-detection Cycles:10 Average:151.60 Median:155.50 stddev:17.20 (11.1%) stddev-sans-first:18.17 23:02:31 INFO - PROCESS | 30562 | Values: 156.0 137.0 155.0 175.0 132.0 152.0 156.0 139.0 182.0 132.0 23:02:31 INFO - PROCESS | 30562 | 23:02:31 INFO - PROCESS | 30562 | [#2] audio-dft Cycles:10 Average:161.00 Median:162.00 stddev:1.25 (0.8%) stddev-sans-first:1.27 23:02:31 INFO - PROCESS | 30562 | Values: 162.0 161.0 159.0 162.0 160.0 159.0 161.0 162.0 162.0 162.0 23:02:31 INFO - PROCESS | 30562 | 23:02:31 INFO - PROCESS | 30562 | [#3] audio-fft Cycles:10 Average:86.10 Median:74.00 stddev:16.66 (22.5%) stddev-sans-first:16.98 23:02:31 INFO - PROCESS | 30562 | Values: 73.0 76.0 107.0 95.0 74.0 74.0 73.0 117.0 98.0 74.0 23:02:31 INFO - PROCESS | 30562 | 23:02:31 INFO - PROCESS | 30562 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:94.00 stddev:24.24 (25.8%) stddev-sans-first:25.10 23:02:31 INFO - PROCESS | 30562 | Values: 94.0 95.0 141.0 93.0 94.0 94.0 142.0 94.0 94.0 149.0 23:02:31 INFO - PROCESS | 30562 | 23:02:31 INFO - PROCESS | 30562 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 23:02:31 INFO - PROCESS | 30562 | Values: 117.0 116.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 23:02:31 INFO - PROCESS | 30562 | 23:02:31 INFO - PROCESS | 30562 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 23:02:31 INFO - PROCESS | 30562 | Values: 146.0 147.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 146.0 23:02:31 INFO - PROCESS | 30562 | 23:02:31 INFO - PROCESS | 30562 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 23:02:31 INFO - PROCESS | 30562 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 94.0 95.0 23:02:31 INFO - PROCESS | 30562 | 23:02:31 INFO - PROCESS | 30562 | [#8] json-parse-financial Cycles:10 Average:66.10 Median:65.00 stddev:4.04 (6.2%) stddev-sans-first:4.21 23:02:31 INFO - PROCESS | 30562 | Values: 64.0 65.0 67.0 65.0 64.0 65.0 67.0 77.0 63.0 64.0 23:02:31 INFO - PROCESS | 30562 | 23:02:31 INFO - PROCESS | 30562 | [#9] json-stringify-tinderbox Cycles:10 Average:64.00 Median:64.00 stddev:1.15 (1.8%) stddev-sans-first:1.17 23:02:31 INFO - PROCESS | 30562 | Values: 63.0 63.0 63.0 64.0 64.0 67.0 64.0 64.0 64.0 64.0 23:02:31 INFO - PROCESS | 30562 | 23:02:31 INFO - PROCESS | 30562 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.50 stddev:2.55 (3.1%) stddev-sans-first:2.65 23:02:31 INFO - PROCESS | 30562 | Values: 81.0 83.0 81.0 83.0 81.0 89.0 81.0 82.0 80.0 83.0 23:02:31 INFO - PROCESS | 30562 | 23:02:31 INFO - PROCESS | 30562 | [#11] stanford-crypto-ccm Cycles:10 Average:118.60 Median:118.00 stddev:4.72 (4.0%) stddev-sans-first:4.91 23:02:31 INFO - PROCESS | 30562 | Values: 116.0 119.0 123.0 114.0 115.0 115.0 127.0 117.0 125.0 115.0 23:02:31 INFO - PROCESS | 30562 | 23:02:31 INFO - PROCESS | 30562 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.20 Median:142.00 stddev:7.30 (5.1%) stddev-sans-first:7.71 23:02:31 INFO - PROCESS | 30562 | Values: 142.0 137.0 145.0 142.0 142.0 128.0 130.0 137.0 150.0 149.0 23:02:31 INFO - PROCESS | 30562 | 23:02:31 INFO - PROCESS | 30562 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:1.55 (2.3%) stddev-sans-first:1.58 23:02:31 INFO - PROCESS | 30562 | Values: 69.0 66.0 68.0 67.0 67.0 69.0 67.0 71.0 66.0 68.0 23:02:31 INFO - PROCESS | 30562 | -------- Summary: end -------- 23:02:31 INFO - PROCESS | 30562 | 23:02:32 INFO - TEST-INFO | 30562: exit 0 23:02:32 INFO - TEST-OK | kraken | took 61175ms 23:02:32 INFO - SUITE-END | took 1176s 23:02:33 INFO - Completed test suite (00:19:37) 23:02:33 INFO - javascript benchmark 23:02:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2579.3551612096976, 2639.590863416171, 2655.8273712208693, 2663.2276639774454, 2677.5983602459623, 4473.686841921067, 4534.863954081378, 4544.545545445454, 4546.227141385964, 4558.7492687902195, 4525.072360166167, 4553.772311384426, 4580.152671755719, 4582.908341833169, 4608.21660317746, 4173.833046678137, 4183.560726123759, 4206.831726730927, 4235.322348424253, 4339.652827773771, 4279.957200427987, 4298.570142985692, 4317.417148684935, 4344.97827510862, 4352.39066530686, 4123.092919557693, 4180.749155050677, 4198.91602167958, 4235.216484950263, 4245.681573881956, 4130.235906357333, 4131.876043718693, 4177.143685544456, 4177.310743727281, 4221.197972385267, 4150.460440142792, 4159.584041595846, 4168.187203495319, 4197.412362269285, 4201.516825565038, 4346.456692913386, 4431.26884064129, 4440.444944381952, 4527.4340707411575, 4542.250528662767, 4863.27050942358, 4870.853874383774, 4884.3161957326, 4951.3810773653295, 4956.553910148068, 4914.8771280718265, 4924.138275801756, 4926.827561035347, 4932.605391568666, 4984.227444746034, 4444.133393988173, 4554.567316104932, 4591.632669386441, 4633.814647414133, 4635.58279754817, 4967.379077615298, 4978.2034874419915, 4983.0, 4988.0, 5038.874028149252, 4672.766361681903, 4809.615230781529, 4813.03739252144, 4821.807127714852, 4870.123377791961, 4819.879503012383, 4912.336834527365, 4918.704877707349, 4922.212446008693, 4923.852284431473, 4829.5653391194255, 4860.4896485869185, 4866.902661946812, 4869.586085182728, 4908.11653902301, 4828.855134345975, 4843.782029808667, 4844.0554091951735, 4852.514748525119, 4900.044491324229, 3994.1811928554575, 4058.797060146981, 4086.0193553546933, 4125.64931980779, 4134.37984302351, 3539.752217344813, 3558.6619271169197, 3558.946615800765, 3591.856325746993, 3595.8741444049333, 4208.200441916026, 4209.515905670826, 4211.494620645542, 4214.0, 4241.533431322552, 4683.672142949961, 4823.348847905488, 4826.7827947742435, 4956.578690811321, 4960.875978100504, 4275.508316543637, 4285.1643929434085, 4291.31338985767, 4294.9785251073545, 4343.435353404037, 4326.394304797331, 4327.545607711208, 4334.436523251957, 4385.51759306476, 4393.0994146199955, 4485.25993211123, 4582.198115329737, 4613.538646135359, 4660.4640466345445, 4662.114198302312, 4889.217725163957, 4938.333325001079, 4940.505949405031, 4943.184374578154, 4966.255061740768, 4554.24854898938, 4683.601893839062, 4703.0, 4708.387909571734, 4749.311349854321, 4798.064377446364, 4832.057748738962, 4835.371401717754, 4853.733044682435, 4886.047220792054, 4891.388576427947, 4935.358403407534, 4939.6542242042715, 4939.678920870132, 4976.8755781105765, 4656.115338085753, 4730.172219861579, 4782.330473733749, 4803.711777293373, 4849.587785038311, 4726.85819425404, 4751.0, 4777.95222047789, 4785.234362501983, 4818.518148185153, 4657.813687452464, 4691.812327506861, 4699.765011749467, 4701.694389864648, 4736.313234581035, 4612.584867361954, 4682.461516925461, 4723.433188017322, 4808.35087263229, 4809.591184749335, 4587.472440669366, 4668.463126740468, 4672.602828759457, 4709.105269998689, 4721.00858819638], "unit": "score", "name": "dojo.html", "value": 4489.552998628286}, {"lowerIsBetter": false, "replicates": [542.1325878594248, 545.9153831156169, 558.1739026241163, 565.0563558856709, 565.375260337327, 27202.319942001435, 34430.82784586077, 35162.12094697634, 35185.648143518556, 35232.471512927325, 38440.23119537607, 38970.22059558807, 39002.804985975105, 39004.0, 39008.804955975254, 7586.165521792612, 7767.689292428325, 7774.261445162729, 7776.183500732426, 7777.18339574345, 7621.3521850642765, 7748.845023099535, 7751.069871615414, 7752.302292793647, 7930.801729956739, 7895.644695988694, 7969.760907172794, 7973.681052757912, 7976.042874855026, 7978.441509094366, 7870.173631768667, 7932.048154221501, 7932.722354717557, 7935.64289606969, 7935.801604959922, 7792.1428642849805, 7997.200279971957, 8003.759887203393, 8008.119106898236, 8015.919840801575, 38432.61567384318, 39004.21991560181, 39013.219735605126, 39050.21899562021, 39074.218515629815, 3262.2333751568362, 3268.3299923515624, 3361.7478689098416, 3416.5046068319953, 3615.4396068609144, 29290.267743306376, 29782.02179782026, 29872.0, 30144.84927575348, 30801.229969250722, 3488.8778892738633, 3505.7750550998558, 3534.540509733718, 3543.5747710274672, 3644.344018076745, 243071.0, 244438.0, 244503.0, 244559.0, 245527.0, 49845.0, 57638.524340187614, 58046.7097664509, 58855.411445884994, 59170.11244831331, 57913.13130303049, 58055.41944580585, 58334.416655833746, 58351.0, 58436.707816461494, 15473.690526189414, 15828.52514424569, 15834.366625334858, 15843.287052082684, 15861.52415427539, 9991.500424978722, 10261.692149235534, 11674.241174323643, 12015.098867584966, 12023.759524809455, 19531.707024394644, 20688.0, 20824.687629685566, 20870.26954056601, 20908.47728806792, 6830.711711576678, 7053.518761060235, 7089.113860767404, 7111.96444017787, 7195.964020179866, 868.6916144768643, 919.8344298026419, 962.0, 992.3549692699803, 1031.3450958641317, 26972.865135674198, 27392.17823465299, 27912.72087279142, 28120.29699257535, 28125.578116327863, 943.3349488610513, 979.6767066867917, 994.5773046455228, 1033.6640591807693, 1079.8337795181185, 12266.141370104186, 12915.806262906064, 12925.612231632878, 12959.352032398343, 12975.156614820195, 224396.0, 227389.0, 227508.0, 227843.0, 228140.0, 43493.13013739708, 43558.56441435545, 43793.78103109528, 43805.56194438079, 43835.780821095694, 1142.611512085878, 1185.1585374384283, 1259.7984322508355, 1284.9357532123356, 1390.7844284135974, 24194.69936274614, 26454.735452645225, 27095.458090837677, 27310.86344568344, 27350.179494615193, 38914.0, 39313.213735725694, 39374.0, 39397.60602393939, 39407.40888886726, 200683.0, 201544.0, 201721.0, 202370.0, 203120.0, 30903.536446952865, 32209.0, 32264.35471290608, 32690.509642354908, 32751.508727369586, 40795.38806917839, 42354.78822605991, 42499.575004249564, 42562.0, 42949.78525107355, 34940.47589286214, 35321.293574127856, 35412.46881296731, 35456.64543354533, 35558.644413555536, 35008.824955875054, 35053.64946350606, 35136.12159695926, 35260.64739352574, 35474.0, 35023.824880875436, 35408.82295588506, 35602.46596301109, 36207.0, 36300.63699362973, 31198.064058078293, 31382.6826747245, 31883.840580796947, 31891.36217275688, 31904.0, 24341.26976190717, 25079.623805643296, 25197.874010630563, 25374.873125634254, 25527.468351898944], "unit": "score", "name": "ext.html", "value": 17147.14270264002}, {"lowerIsBetter": false, "replicates": [338.27102593910126, 341.760767462776, 356.25364860617015, 362.911086783738, 366.2418793098288, 15526.301316440758, 16058.51824445267, 16372.918135409336, 16864.0, 16890.408835690752, 11180.720481987953, 11198.38408887513, 11199.328040317587, 13959.581212563615, 16133.919330403332, 4561.315802629607, 4679.953200467986, 4691.624670026406, 4699.976500117495, 4700.741459219742, 3500.2299494111253, 4222.97888510557, 5945.137954996523, 5971.611845230068, 5975.581709280352, 5909.704514774244, 5920.259967504062, 5924.0521516557355, 5937.524998000171, 5942.732577034044, 3531.0642679689904, 5534.557235421177, 5734.913976290359, 5747.1666608341975, 5883.61756485827, 5095.490450954912, 5286.286351342596, 5294.841154765363, 5295.973520132375, 5298.602604804655, 11758.412079396081, 11969.880301196963, 12074.215176013531, 16935.153242337958, 18675.71986420205, 1929.4501067195781, 1979.7556580403998, 2050.4976280811297, 2069.0585783468487, 2126.1176611706123, 9165.404248723811, 9202.217811485965, 9295.67465138717, 9583.856242156373, 9671.661491847823, 1782.803891571926, 1808.7919889212778, 1812.0577299804029, 1815.7911840138422, 1817.164104511926, 56126.59683507904, 62023.37976620221, 63659.36340636627, 64829.35170648328, 66160.3383966159, 9551.0, 9654.131128198496, 9670.75823104428, 9862.704118876445, 10124.291299608956, 13385.263810490516, 13462.798058029137, 13514.594562162954, 13514.59456216315, 13525.32373381327, 6966.293258151785, 7092.290770922969, 7114.466415018895, 7179.820504487429, 7195.064641596559, 6671.299513551105, 6697.263301036882, 6743.9325606743305, 6773.390394864486, 6852.965735171392, 4339.349097635317, 4343.2182207203, 4354.629856462237, 4392.363107349416, 4416.558344165622, 1773.7516747655338, 1783.0906237818547, 1787.8390944814769, 1813.619139980619, 1843.0876716025653, 852.6291063387446, 902.747230775384, 906.1799071839995, 934.5747684803398, 950.3537594435712, 15990.8006899483, 16292.67414651724, 16349.673006539802, 16523.586910327096, 16546.83453165453, 855.5337341149088, 860.0367588301143, 882.748416701237, 900.2707806676613, 907.1291560102244, 6881.208661003949, 9230.307726920508, 9332.300077494216, 9530.428174309563, 9582.425054496753, 352459.0, 379525.0, 384585.0, 386226.0, 388313.0, 70252.64873675599, 73633.6318318405, 73661.0, 73769.26230737731, 74954.0, 961.3606951377395, 992.7766252593253, 996.7308826616772, 999.1656966432964, 1005.1757558801859, 15253.542393728207, 15264.0, 15342.846571534588, 15600.531984040497, 15655.608609784846, 34476.82761586176, 34577.82711086429, 34962.47556286708, 35479.64520354763, 36305.81847090748, 47359.52640473551, 48688.2696759556, 48689.11614535797, 48905.5109448901, 49146.0, 7469.626518674153, 7522.811929701801, 7530.4352173588295, 7556.65995030236, 7605.6577454013595, 10505.842412363667, 11771.0, 11801.881981180079, 11821.645350639494, 12161.0, 9607.615695372107, 9954.45250511229, 10100.141487973604, 10492.422916739348, 10525.526351314362, 9911.0, 9934.354266972623, 10200.0819926207, 10281.280310378203, 10382.740431489274, 10239.692809215736, 10499.790004200026, 10567.418791966516, 10784.946075269887, 11234.382108984084, 7562.773116806505, 7701.537907725555, 7708.961455192688, 7738.0, 7744.993150890574, 9996.700098997042, 10759.838602420814, 10761.730956726144, 11015.063719583924, 11015.284006539548], "unit": "score", "name": "jquery.html", "value": 7980.229968511031}, {"lowerIsBetter": false, "replicates": [1228.6744012836593, 1411.1533080151908, 1436.648021234797, 1604.2540218798256, 1776.3516316544458, 7012.193597736262, 7183.138023437188, 7198.208197098315, 7199.928000719998, 7204.243554426788, 7164.247753985835, 7326.560406375621, 7331.303526165006, 7331.376832969204, 7333.486655934087, 1882.218879165145, 2197.560487902418, 2235.3182279404814, 2247.3370355745014, 2262.479629685173, 2239.428945618865, 2252.2905284835306, 2252.5720113178527, 2254.695616091831, 2254.763249858766, 2130.5419334843004, 2180.5529866377356, 2181.334692918659, 2182.7598964113936, 2182.9126834926583, 2151.7848215178515, 2169.858959167657, 2182.967255491169, 2202.3723238877005, 2203.272919936433, 2143.710599069121, 2198.4943463003438, 2206.7572567017774, 2210.8894555272173, 2214.136486770161, 7179.641017949134, 7222.638868056576, 7236.529625574373, 7241.782746517613, 7250.238724933912, 4507.729536227836, 4659.161350956826, 4666.160091183586, 4668.719876807369, 4670.696404733715, 2905.8401787901657, 2916.6208392908998, 2943.014090279759, 2945.7496112830436, 3047.162030441624, 837.5016864965336, 852.8379607874484, 940.1068984464786, 962.1484985787629, 979.774651830076, 9986.400815950994, 9989.600415983352, 9997.550110245056, 9999.75000624983, 10016.54925528353, 4076.2458945095254, 4104.0970986382945, 4195.643370313496, 4207.8316867325575, 4222.303319952235, 8646.913530864736, 8654.48073115615, 8658.956705216433, 8672.0, 8713.520756358334, 3890.8832735017995, 4624.121416930772, 4660.906781864343, 4668.743219122913, 4671.369365135731, 4076.2255171517318, 4163.125743593819, 4164.4586203793315, 4170.937435938464, 4183.91632167355, 3481.3907566175817, 3525.3301872644115, 3550.3254381667402, 3602.2795440911923, 3614.331348700499, 1137.1016896651718, 1162.424599823076, 1191.9404029798475, 1199.688081098903, 1202.6933132051445, 952.2524818017823, 955.6702937486556, 957.2533423929347, 1020.7090979070929, 1221.5113954418125, 7059.647017649199, 7064.788056358318, 7079.858402831915, 7107.111611048619, 7109.146902371748, 453.82754553269547, 1113.3041848844473, 1129.949152288149, 1135.1486385211092, 1162.354893034374, 5419.0, 5420.214068959979, 5430.83707488776, 5452.482014208644, 5461.098918678374, 8463.238308552136, 8568.057513673491, 8635.525046122399, 8649.1350864913, 8913.777155571033, 8342.082370939192, 8398.874016889751, 8466.619002144918, 8484.703035393732, 8501.362397820065, 6830.077939478107, 6912.447004239649, 6929.41100006495, 6956.095707557985, 6993.650317484207, 6835.521513494008, 6877.58734475933, 6898.6205758681745, 6925.826854328682, 6937.549059311129, 7812.375009999073, 8027.75569786684, 8068.47554908929, 8076.4750291230885, 8208.0, 7691.30778229962, 7892.0529536456, 8066.959665201636, 8071.192880712117, 8340.708075217339, 5715.485606295453, 6271.43557079865, 6438.645874476949, 6493.0, 6588.341165883373, 6815.727370905307, 6820.3861652451515, 6863.347981941708, 6868.038474613658, 6872.793816185523, 6190.41191086846, 6335.271443784024, 6353.332900045429, 6419.101325814297, 6434.64609446485, 6133.080037994337, 6214.25428948529, 6233.812985610439, 6286.6856657166045, 6356.77751278703, 6593.868122637425, 6613.305602911817, 6639.269680335063, 6647.6676166192465, 6655.933440665532, 5825.621334613236, 6098.176746139215, 6140.201773769381, 6142.14010038586, 6143.017117261216, 6090.908636370369, 6121.3572574879, 6127.050307202391, 6137.662428566293, 6140.078988151813], "unit": "score", "name": "mootools.html", "value": 4237.242713322527}, {"lowerIsBetter": false, "replicates": [318.2616330114135, 319.38677738741615, 319.74739955435206, 323.291990540716, 324.71911796296195, 5223.3731952165745, 5338.252644629755, 5346.064438723218, 5350.89298214036, 5355.866103347414, 5223.843284701465, 5312.335958005249, 5321.068812957727, 5328.706921119337, 5337.6797392156495, 3897.142628621699, 4012.2978478766245, 4078.3270760324513, 4112.650424713903, 4131.938020929689, 4081.0613558881473, 4097.467329247193, 4109.856155034575, 4111.444954931091, 4112.424260603518, 4065.1869626074754, 4073.388991651246, 4077.9805048737817, 4080.224757296119, 4080.6123418275365, 3907.257621051991, 3983.6016398360075, 4068.1863627274665, 4072.409500622423, 4082.795860206978, 3556.4309710446464, 3557.964420355789, 3559.48387483816, 3560.394732895388, 3567.6075631680496, 5048.242763585492, 5051.0, 5052.747362631891, 5055.216441451581, 5060.0, 4653.488116307238, 4660.137874493195, 4663.463701674317, 4664.346991421204, 4669.2062349400685, 5522.30971128609, 5522.779088836442, 5527.419620939783, 5531.419200983919, 5535.418781028015, 3865.265599536079, 3865.8260378283044, 3872.1481274119647, 3874.6319099685484, 3877.0501227199234, 5579.944200557983, 5815.680137592431, 5816.941830581724, 5821.563382746311, 5828.6211396259105, 3974.721769476109, 3987.860424885173, 3989.5212574490665, 3989.5412027616617, 3992.1017771001875, 4044.9595504045174, 4047.6964227683043, 4048.655864251513, 4050.1697152083752, 4052.068024354356, 4641.930371044437, 4646.95353046472, 4648.790804413809, 4651.395318608627, 4653.046125544255, 5550.16747487872, 5558.722063896789, 5559.193916882029, 5560.165975103686, 5565.387807341189, 1394.6164804678592, 1407.8873690104767, 1413.4770135050098, 1413.561795843292, 1417.5463851567606, 929.6188562689265, 950.9904900951041, 968.8062387522524, 969.0793745941243, 970.4565443351746, 4867.756612169377, 4884.804607815719, 4888.120138375127, 4891.192953162688, 4907.87730306738, 5697.515711164515, 5698.0, 5700.629459085146, 5704.600677952587, 5705.971470142623, 4879.097366987119, 4886.413630364379, 4888.9755551222015, 4889.144399730104, 4889.877753056131, 3036.4230796148663, 3066.2181143808634, 3066.31008023193, 3068.3403068340413, 3069.478188707925, 5386.272853164773, 5391.272178255964, 5392.64947778401, 5395.514403703685, 5395.838124856261, 5650.152477128464, 5770.913436298459, 5776.942230577724, 5781.103928891029, 5785.334686511021, 5304.602154838402, 5323.414424413311, 5325.733713314319, 5327.254184414108, 5330.546903513167, 5616.915746263728, 5626.7902400983985, 5628.802991895264, 5633.802816901389, 5634.492895639412, 5510.476504732044, 5511.173324001432, 5557.138643510262, 5563.554915606823, 5571.860703482445, 5373.086575282289, 5378.623496355218, 5379.865503362447, 5380.43505431924, 5386.434424385383, 3852.5954774748247, 3963.6432721055244, 3979.20415916812, 3993.92012159761, 3996.720229583901, 5498.45015498447, 5719.857003574777, 5721.05602575587, 5732.082866741302, 5737.053386191232, 5391.81128660495, 5500.642458240201, 5505.421930697379, 5508.586855985737, 5521.282233309644, 5453.400125986218, 5495.972520137374, 5497.532709719719, 5499.615026948075, 5505.614606977473, 5397.622166448468, 5485.232067510472, 5490.203920431595, 5492.450754924475, 5498.642588231752, 5610.046292130266, 5613.214150018919, 5618.438156184349, 5621.100623900156, 5623.465770751772, 5328.387235467816, 5470.370907345706, 5470.562355011669, 5474.206240095244, 5482.698451585201], "unit": "score", "name": "prototype.html", "value": 4157.149918176445}, {"lowerIsBetter": false, "replicates": [678.674236366544, 697.7418355208573, 700.2752151523173, 703.493721986405, 742.5359150530918, 11974.161808673385, 12160.087993400486, 12191.817122743167, 12250.877491225096, 12281.570145044925, 11943.820842687366, 12030.578929737461, 12086.274823510596, 12090.032797376189, 12109.697257568543, 638.5179189711785, 795.3080819686866, 804.3484777330352, 813.5403497024163, 814.7555733280022, 817.7015389382892, 820.2658620534618, 820.958952052398, 821.6836517940576, 822.4037572759731, 865.5888452984844, 867.6225841758824, 869.7260362985671, 870.4690139015196, 870.682200996638, 677.7898851356096, 851.6976473351933, 855.9400841941067, 864.4553931023446, 865.8051938313861, 630.136712703599, 630.7634637011121, 632.3613150717762, 632.3802673380113, 634.1724050114599, 12267.509299628093, 12275.263484190977, 12323.137380383378, 12323.938380308131, 12338.074644401706, 11800.88199118015, 12523.114136355898, 12635.43140558677, 12639.241645501299, 12652.304123273216, 9058.864117038249, 9224.169824715807, 9460.337776355658, 9463.621455141785, 9487.335886487948, 3293.357795229931, 3316.585426821647, 3318.3529211803707, 3349.062262566485, 3423.6576342365815, 41755.582444175474, 41793.79103104465, 42107.7894610528, 42224.1555168898, 42244.36633450501, 8883.0, 9556.952215239018, 9666.323357364918, 9715.07706767856, 9718.562664680107, 17509.7373539397, 17541.0, 17595.56011099707, 17795.377161799275, 17889.37387191442, 6387.552871298964, 6464.482841372679, 6473.28793832678, 6561.770338038241, 6666.933330666631, 3661.853525858936, 3691.686206672463, 3718.2749363874327, 3854.325493038707, 3871.9032024199055, 2664.9067282645015, 2677.705452400234, 2682.597610358423, 2692.7980401469968, 2697.865106744655, 458.82564625442785, 491.3710450623208, 505.59552358113365, 506.25074889164244, 510.25757522804975, 569.6781318555003, 621.6953987654642, 635.7584118035116, 635.7647670361996, 641.1152609398999, 7694.461387702919, 7784.455088143775, 7851.685932562634, 7916.604169791487, 8106.594670266463, 608.6895683201599, 609.8780243951228, 611.9510439164856, 615.5875563372551, 642.2838535033404, 3635.7454978151277, 3641.6540428659237, 3714.3499887519574, 3722.7021838252876, 3733.3839916413485, 46980.0, 47163.76418117956, 48038.759806201444, 50878.0, 55202.17196742052, 44238.557614424084, 44800.3279950801, 44840.0, 45005.77497112559, 45814.08371832611, 44121.55878441175, 44366.77816610961, 44422.0, 44743.88140296454, 45528.772356138004, 7996.280334769898, 8101.0, 8126.878096828434, 8201.507909525448, 8436.156384361515, 31001.224969375948, 31822.522662159623, 31874.362512750078, 31908.680913190572, 32311.192220194684, 34918.65081349255, 36709.44935825912, 38794.2241155181, 38921.610783891796, 39180.608193917695, 9691.563879625293, 9784.902150978683, 9936.354136981074, 10164.085232329126, 10507.527161277609, 11006.834897476385, 11079.0, 11221.102311815199, 11379.601713939972, 11897.167198296036, 9026.593803278736, 10775.245732798629, 10863.891361086604, 10877.891221087688, 11114.388708621103, 11153.330800152016, 11170.27393219438, 11279.15406344511, 11291.491882865455, 11317.0, 10640.946795265974, 10693.9465302673, 10740.409277489813, 10816.242862999514, 10913.0, 9379.577918993798, 9479.383840050376, 9488.667896623585, 9691.466969316756, 9799.706008819461, 8591.226789588967, 8711.433756805787, 8971.596278167368, 9301.953490232776, 9357.157855793012], "unit": "score", "name": "yui.html", "value": 5860.5811113491545}], "name": "dromaeo_css", "value": 6315.084249771612}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 113.0, 108.0, 111.0, 114.0, 114.0, 104.0, 113.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 110.9}, {"lowerIsBetter": true, "replicates": [156.0, 137.0, 155.0, 175.0, 132.0, 152.0, 156.0, 139.0, 182.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 151.6}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 159.0, 162.0, 160.0, 159.0, 161.0, 162.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [73.0, 76.0, 107.0, 95.0, 74.0, 74.0, 73.0, 117.0, 98.0, 74.0], "unit": "score", "name": "audio-fft", "value": 86.1}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 141.0, 93.0, 94.0, 94.0, 142.0, 94.0, 94.0, 149.0], "unit": "score", "name": "audio-oscillator", "value": 109.0}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.7}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.0}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 94.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 67.0, 65.0, 64.0, 65.0, 67.0, 77.0, 63.0, 64.0], "unit": "score", "name": "json-parse-financial", "value": 66.1}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 63.0, 64.0, 64.0, 67.0, 64.0, 64.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.0}, {"lowerIsBetter": true, "replicates": [81.0, 83.0, 81.0, 83.0, 81.0, 89.0, 81.0, 82.0, 80.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.4}, {"lowerIsBetter": true, "replicates": [116.0, 119.0, 123.0, 114.0, 115.0, 115.0, 127.0, 117.0, 125.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.6}, {"lowerIsBetter": true, "replicates": [142.0, 137.0, 145.0, 142.0, 142.0, 128.0, 130.0, 137.0, 150.0, 149.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.2}, {"lowerIsBetter": true, "replicates": [69.0, 66.0, 68.0, 67.0, 67.0, 69.0, 67.0, 71.0, 66.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.8}], "name": "kraken", "value": 1515.5}]} 23:02:33 INFO - Return code: 0 23:02:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:02:33 ERROR - # TBPL SUCCESS # 23:02:33 INFO - Running post-action listener: _resource_record_post_action 23:02:33 INFO - Running post-run listener: _resource_record_post_run 23:02:34 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 282095616; Read time: 12; Write time: 201532 23:02:34 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 6000640; Read time: 0; Write time: 4188 23:02:34 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 276078592; Read time: 12; Write time: 196984 23:02:34 INFO - Running post-run listener: _upload_blobber_files 23:02:34 INFO - Blob upload gear active. 23:02:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:02:34 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:02:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:02:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:02:34 INFO - (blobuploader) - INFO - Open directory for files ... 23:02:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:02:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:02:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:02:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:02:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:02:35 INFO - (blobuploader) - INFO - Done attempting. 23:02:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:02:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:02:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:02:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:02:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:02:36 INFO - (blobuploader) - INFO - Done attempting. 23:02:36 INFO - (blobuploader) - INFO - Iteration through files over. 23:02:36 INFO - Return code: 0 23:02:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:02:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:02:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5c2a49a2a82587f5781d6bf2484107b6d820fd54a6473563265b8885389a49ddaca3dfc2a97aeba9d826b3c42379332e2251be85756cfb375c2f194ad007b9e0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/56bf0eb943a95d698c351b5f952920ac578891dc08ee417bc70665b2dfef019712db9c94299a6006b5093f278493f7c39940cc2bec13c0eb1016d8b7696fff20"} 23:02:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:02:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:02:36 INFO - Contents: 23:02:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5c2a49a2a82587f5781d6bf2484107b6d820fd54a6473563265b8885389a49ddaca3dfc2a97aeba9d826b3c42379332e2251be85756cfb375c2f194ad007b9e0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/56bf0eb943a95d698c351b5f952920ac578891dc08ee417bc70665b2dfef019712db9c94299a6006b5093f278493f7c39940cc2bec13c0eb1016d8b7696fff20"} 23:02:36 INFO - Running post-run listener: copy_logs_to_upload_dir 23:02:36 INFO - Copying logs to upload dir... 23:02:36 INFO - mkdir: /builds/slave/test/build/upload/logs 23:02:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.100034 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-04-04 23:02:35.443368) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-04 23:02:35.446646) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1459834891.720199-1870903635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5c2a49a2a82587f5781d6bf2484107b6d820fd54a6473563265b8885389a49ddaca3dfc2a97aeba9d826b3c42379332e2251be85756cfb375c2f194ad007b9e0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/56bf0eb943a95d698c351b5f952920ac578891dc08ee417bc70665b2dfef019712db9c94299a6006b5093f278493f7c39940cc2bec13c0eb1016d8b7696fff20"} build_url:https://queue.taskcluster.net/v1/task/OGb9A-DNRu-acsFxzkWsCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011139 build_url: 'https://queue.taskcluster.net/v1/task/OGb9A-DNRu-acsFxzkWsCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5c2a49a2a82587f5781d6bf2484107b6d820fd54a6473563265b8885389a49ddaca3dfc2a97aeba9d826b3c42379332e2251be85756cfb375c2f194ad007b9e0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/56bf0eb943a95d698c351b5f952920ac578891dc08ee417bc70665b2dfef019712db9c94299a6006b5093f278493f7c39940cc2bec13c0eb1016d8b7696fff20"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-04 23:02:35.476622) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 23:02:35.476953) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1459834891.720199-1870903635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004607 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 23:02:35.558802) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-04 23:02:35.559582) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-04 23:02:35.560271) ========= ========= Total master_lag: 0.97 =========