builder: elm_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-066 starttime: 1449196913.27 results: success (0) buildid: 20151203171816 builduid: fd5a2ca61d924f73b0f82ed5d1955bfb revision: 843db0ee142ba91ef4c89da07e43b299ad07e9eb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 18:41:53.266587) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 18:41:53.267035) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 18:41:53.267326) ========= 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=004b26eee9c3b360c8654f40000001e1-1449196913.67122-1665846561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006387 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 18:41:53.289914) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 18:41:53.290188) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 18:41:53.303797) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 18:41:53.304114) ========= 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=004b26eee9c3b360c8654f40000001e1-1449196913.67122-1665846561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004565 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 18:41:53.353295) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 18:41:53.353603) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 18:41:53.354011) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 18:41:53.354334) ========= 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=004b26eee9c3b360c8654f40000001e1-1449196913.67122-1665846561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-03 18:41:54-- 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% 47.0M=0s 2015-12-03 18:41:54 (47.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.206945 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 18:41:53.573643) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 18:41:53.573958) ========= 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=004b26eee9c3b360c8654f40000001e1-1449196913.67122-1665846561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013524 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 18:41:53.623240) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 18:41:53.623600) ========= bash -c 'python archiver_client.py mozharness --repo projects/elm --rev 843db0ee142ba91ef4c89da07e43b299ad07e9eb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/elm --rev 843db0ee142ba91ef4c89da07e43b299ad07e9eb --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=004b26eee9c3b360c8654f40000001e1-1449196913.67122-1665846561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-03 18:41:54,904 truncating revision to first 12 chars 2015-12-03 18:41:54,904 Setting DEBUG logging. 2015-12-03 18:41:54,904 attempt 1/10 2015-12-03 18:41:54,904 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/elm/843db0ee142b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-03 18:41:55,163 unpacking tar archive at: elm-843db0ee142b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.572118 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 18:41:54.209641) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 18:41:54.210161) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 18:41:54.377156) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 18:41:54.377626) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 18:41:54.378059) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-03 18:41:54.378346) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Elm --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Elm 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', 'Elm', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Elm'] 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=004b26eee9c3b360c8654f40000001e1-1449196913.67122-1665846561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:41:55 INFO - MultiFileLogger online at 20151203 18:41:55 in /builds/slave/test 18:41:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Elm --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Elm 18:41:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:41:55 INFO - {'append_to_log': False, 18:41:55 INFO - 'base_work_dir': '/builds/slave/test', 18:41:55 INFO - 'blob_upload_branch': 'Elm', 18:41:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:41:55 INFO - 'branch': 'Elm', 18:41:55 INFO - 'buildbot_json_path': 'buildprops.json', 18:41:55 INFO - 'config_files': ('talos/linux_config.py',), 18:41:55 INFO - 'default_actions': ('clobber', 18:41:55 INFO - 'read-buildbot-config', 18:41:55 INFO - 'download-and-extract', 18:41:55 INFO - 'populate-webroot', 18:41:55 INFO - 'create-virtualenv', 18:41:55 INFO - 'install', 18:41:55 INFO - 'run-tests'), 18:41:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:41:55 INFO - 'download_minidump_stackwalk': True, 18:41:55 INFO - 'download_symbols': 'ondemand', 18:41:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:41:55 INFO - 'tooltool.py': '/tools/tooltool.py', 18:41:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:41:55 INFO - '/tools/misc-python/virtualenv.py')}, 18:41:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:41:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:41:55 INFO - 'installer_path': 'installer.exe', 18:41:55 INFO - 'log_level': 'info', 18:41:55 INFO - 'log_name': 'talos', 18:41:55 INFO - 'log_to_console': True, 18:41:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:41:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:41:55 INFO - 'opt_config_files': (), 18:41:55 INFO - 'pip_index': False, 18:41:55 INFO - 'sps_profile': False, 18:41:55 INFO - 'sps_profile_interval': 0, 18:41:55 INFO - 'suite': 'dromaeojs', 18:41:55 INFO - 'system_bits': '64', 18:41:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:41:55 INFO - 'title': 'talos-linux64-ix-066', 18:41:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:41:55 INFO - 'use_talos_json': True, 18:41:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:41:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:41:55 INFO - 'work_dir': 'build'} 18:41:55 INFO - ##### 18:41:55 INFO - ##### Running clobber step. 18:41:55 INFO - ##### 18:41:55 INFO - Running pre-action listener: _resource_record_pre_action 18:41:55 INFO - Running main action method: clobber 18:41:55 INFO - rmtree: /builds/slave/test/build 18:41:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:41:56 INFO - Running post-action listener: _resource_record_post_action 18:41:56 INFO - ##### 18:41:56 INFO - ##### Running read-buildbot-config step. 18:41:56 INFO - ##### 18:41:56 INFO - Running pre-action listener: _resource_record_pre_action 18:41:56 INFO - Running main action method: read_buildbot_config 18:41:56 INFO - Using buildbot properties: 18:41:56 INFO - { 18:41:56 INFO - "properties": { 18:41:56 INFO - "buildnumber": 1, 18:41:56 INFO - "product": "firefox", 18:41:56 INFO - "script_repo_revision": "production", 18:41:56 INFO - "builddir": "elm_ubuntu64_hw_test-dromaeojs", 18:41:56 INFO - "repository": "", 18:41:56 INFO - "buildername": "Ubuntu HW 12.04 x64 elm talos dromaeojs", 18:41:56 INFO - "buildid": "20151203171816", 18:41:56 INFO - "slavename": "talos-linux64-ix-066", 18:41:56 INFO - "pgo_build": "False", 18:41:56 INFO - "basedir": "/builds/slave/test", 18:41:56 INFO - "project": "", 18:41:56 INFO - "platform": "ubuntu64_hw", 18:41:56 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:41:56 INFO - "slavebuilddir": "test", 18:41:56 INFO - "scheduler": "tests-elm-linux64-talos", 18:41:56 INFO - "branch": "elm", 18:41:56 INFO - "repo_path": "projects/elm", 18:41:56 INFO - "stage_platform": "linux64", 18:41:56 INFO - "builduid": "fd5a2ca61d924f73b0f82ed5d1955bfb", 18:41:56 INFO - "revision": "843db0ee142ba91ef4c89da07e43b299ad07e9eb" 18:41:56 INFO - }, 18:41:56 INFO - "sourcestamp": { 18:41:56 INFO - "repository": "", 18:41:56 INFO - "hasPatch": false, 18:41:56 INFO - "project": "", 18:41:56 INFO - "branch": "elm-linux64-talos", 18:41:56 INFO - "changes": [ 18:41:56 INFO - { 18:41:56 INFO - "category": null, 18:41:56 INFO - "files": [ 18:41:56 INFO - { 18:41:56 INFO - "url": null, 18:41:56 INFO - "name": "https://queue.taskcluster.net/v1/task/sEo2UBSBTzCvRcBqtRCpCw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 18:41:56 INFO - } 18:41:56 INFO - ], 18:41:56 INFO - "repository": "", 18:41:56 INFO - "rev": "843db0ee142ba91ef4c89da07e43b299ad07e9eb", 18:41:56 INFO - "who": "mh@glandium.org", 18:41:56 INFO - "when": 1449196856, 18:41:56 INFO - "number": 6742349, 18:41:56 INFO - "comments": "Merge m-c to elm. a=me", 18:41:56 INFO - "project": "", 18:41:56 INFO - "at": "Thu 03 Dec 2015 18:40:56", 18:41:56 INFO - "branch": "elm-linux64-talos", 18:41:56 INFO - "revlink": "", 18:41:56 INFO - "properties": [ 18:41:56 INFO - [ 18:41:56 INFO - "buildid", 18:41:56 INFO - "20151203171816", 18:41:56 INFO - "Change" 18:41:56 INFO - ], 18:41:56 INFO - [ 18:41:56 INFO - "builduid", 18:41:56 INFO - "fd5a2ca61d924f73b0f82ed5d1955bfb", 18:41:56 INFO - "Change" 18:41:56 INFO - ], 18:41:56 INFO - [ 18:41:56 INFO - "pgo_build", 18:41:56 INFO - "False", 18:41:56 INFO - "Change" 18:41:56 INFO - ] 18:41:56 INFO - ], 18:41:56 INFO - "revision": "843db0ee142ba91ef4c89da07e43b299ad07e9eb" 18:41:56 INFO - } 18:41:56 INFO - ], 18:41:56 INFO - "revision": "843db0ee142ba91ef4c89da07e43b299ad07e9eb" 18:41:56 INFO - } 18:41:56 INFO - } 18:41:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/sEo2UBSBTzCvRcBqtRCpCw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 18:41:56 INFO - Running post-action listener: _resource_record_post_action 18:41:56 INFO - ##### 18:41:56 INFO - ##### Running download-and-extract step. 18:41:56 INFO - ##### 18:41:56 INFO - Running pre-action listener: _resource_record_pre_action 18:41:56 INFO - Running main action method: download_and_extract 18:41:56 INFO - mkdir: /builds/slave/test/build/tests 18:41:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:41:56 INFO - https://queue.taskcluster.net/v1/task/sEo2UBSBTzCvRcBqtRCpCw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:41:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sEo2UBSBTzCvRcBqtRCpCw/artifacts/public/build/test_packages.json 18:41:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sEo2UBSBTzCvRcBqtRCpCw/artifacts/public/build/test_packages.json 18:41:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sEo2UBSBTzCvRcBqtRCpCw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:41:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sEo2UBSBTzCvRcBqtRCpCw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:41:56 INFO - Downloaded 1302 bytes. 18:41:56 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:41:56 INFO - Using the following test package requirements: 18:41:56 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:41:56 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:41:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:41:56 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:41:56 INFO - u'jsshell-linux-x86_64.zip'], 18:41:56 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:41:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:41:56 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:41:56 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:41:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:41:56 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:41:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:41:56 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:41:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:41:56 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:41:56 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:41:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:41:56 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:41:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:41:56 INFO - https://queue.taskcluster.net/v1/task/sEo2UBSBTzCvRcBqtRCpCw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:41:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sEo2UBSBTzCvRcBqtRCpCw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:41:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sEo2UBSBTzCvRcBqtRCpCw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:41:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sEo2UBSBTzCvRcBqtRCpCw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:41:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sEo2UBSBTzCvRcBqtRCpCw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:41:57 INFO - Downloaded 21793287 bytes. 18:41:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 18:41:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:41:57 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 18:41:58 INFO - Return code: 0 18:41:58 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:41:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:41:58 INFO - https://queue.taskcluster.net/v1/task/sEo2UBSBTzCvRcBqtRCpCw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:41:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sEo2UBSBTzCvRcBqtRCpCw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:41:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sEo2UBSBTzCvRcBqtRCpCw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:41:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sEo2UBSBTzCvRcBqtRCpCw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:41:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sEo2UBSBTzCvRcBqtRCpCw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:41:59 INFO - Downloaded 21793287 bytes. 18:41:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 18:41:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:41:59 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 18:42:01 INFO - Return code: 0 18:42:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:42:01 INFO - https://queue.taskcluster.net/v1/task/sEo2UBSBTzCvRcBqtRCpCw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:42:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sEo2UBSBTzCvRcBqtRCpCw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:42:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sEo2UBSBTzCvRcBqtRCpCw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:42:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sEo2UBSBTzCvRcBqtRCpCw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:42:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sEo2UBSBTzCvRcBqtRCpCw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:42:03 INFO - Downloaded 11132001 bytes. 18:42:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 18:42:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:42:03 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 18:42:03 INFO - Return code: 0 18:42:03 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')]} 18:42:03 INFO - https://queue.taskcluster.net/v1/task/sEo2UBSBTzCvRcBqtRCpCw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:42:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sEo2UBSBTzCvRcBqtRCpCw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:42:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sEo2UBSBTzCvRcBqtRCpCw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:42:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sEo2UBSBTzCvRcBqtRCpCw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:42:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sEo2UBSBTzCvRcBqtRCpCw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:42:04 INFO - Downloaded 57680163 bytes. 18:42:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/sEo2UBSBTzCvRcBqtRCpCw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:42:04 INFO - mkdir: /builds/slave/test/properties 18:42:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:42:04 INFO - Writing to file /builds/slave/test/properties/build_url 18:42:04 INFO - Contents: 18:42:04 INFO - build_url:https://queue.taskcluster.net/v1/task/sEo2UBSBTzCvRcBqtRCpCw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:42:04 INFO - Running post-action listener: _resource_record_post_action 18:42:04 INFO - Running post-action listener: set_extra_try_arguments 18:42:04 INFO - ##### 18:42:04 INFO - ##### Running populate-webroot step. 18:42:04 INFO - ##### 18:42:04 INFO - Running pre-action listener: _resource_record_pre_action 18:42:04 INFO - Running main action method: populate_webroot 18:42:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:42:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:42:04 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 18:42:04 INFO - '../fennec_ids.txt'], 18:42:04 INFO - 'tests': ['tcheck2']}, 18:42:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:42:04 INFO - '--tppagecycles', 18:42:04 INFO - '7'], 18:42:04 INFO - 'tests': ['tsvgm']}}, 18:42:04 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:42:04 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:42:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:42:04 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:42:04 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:42:04 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:42:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:42:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:42:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:42:04 INFO - 'talos_options': ['--e10s'], 18:42:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:42:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:42:04 INFO - 'tests': ['damp', 'tps']}, 18:42:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:42:04 INFO - 'talos_options': ['--e10s'], 18:42:04 INFO - 'tests': ['damp', 'tps']}, 18:42:04 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:42:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:42:04 INFO - 'other': {'tests': ['a11yr', 18:42:04 INFO - 'ts_paint', 18:42:04 INFO - 'tpaint', 18:42:04 INFO - 'sessionrestore', 18:42:04 INFO - 'sessionrestore_no_auto_restore']}, 18:42:04 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:42:04 INFO - 'tests': ['a11yr', 18:42:04 INFO - 'ts_paint', 18:42:04 INFO - 'tpaint', 18:42:04 INFO - 'sessionrestore', 18:42:04 INFO - 'sessionrestore_no_auto_restore']}, 18:42:04 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:42:04 INFO - 'tests': ['a11yr', 18:42:04 INFO - 'ts_paint', 18:42:04 INFO - 'tpaint', 18:42:04 INFO - 'sessionrestore', 18:42:04 INFO - 'sessionrestore_no_auto_restore']}, 18:42:04 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:42:04 INFO - 'tests': ['a11yr', 18:42:04 INFO - 'ts_paint', 18:42:04 INFO - 'tpaint', 18:42:04 INFO - 'sessionrestore', 18:42:04 INFO - 'sessionrestore_no_auto_restore']}, 18:42:04 INFO - 'other_l64': {'tests': ['a11yr', 18:42:04 INFO - 'ts_paint', 18:42:04 INFO - 'tpaint', 18:42:04 INFO - 'sessionrestore', 18:42:04 INFO - 'sessionrestore_no_auto_restore']}, 18:42:04 INFO - 'other_nol64': {'tests': ['a11yr', 18:42:04 INFO - 'ts_paint', 18:42:04 INFO - 'tpaint', 18:42:04 INFO - 'sessionrestore', 18:42:04 INFO - 'sessionrestore_no_auto_restore']}, 18:42:04 INFO - 'svgr': {'tests': ['tsvgx', 18:42:04 INFO - 'tsvgr_opacity', 18:42:04 INFO - 'tart', 18:42:04 INFO - 'tscrollx', 18:42:04 INFO - 'cart']}, 18:42:04 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:42:04 INFO - 'tests': ['tsvgx', 18:42:04 INFO - 'tsvgr_opacity', 18:42:04 INFO - 'tart', 18:42:04 INFO - 'tscrollx', 18:42:04 INFO - 'cart']}, 18:42:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:42:04 INFO - 'tests': ['tp5o']}, 18:42:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:42:04 INFO - 'talos_options': ['--e10s'], 18:42:04 INFO - 'tests': ['tp5o']}, 18:42:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:42:04 INFO - 'talos_options': ['--xperf_path', 18:42:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:42:04 INFO - 'tests': ['tp5n']}, 18:42:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:42:04 INFO - 'talos_options': ['--e10s', 18:42:04 INFO - '--xperf_path', 18:42:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:42:04 INFO - 'tests': ['tp5n']}}, 18:42:04 INFO - 'talos.zip': {'path': '', 18:42:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:42:04 INFO - Running post-action listener: _resource_record_post_action 18:42:04 INFO - ##### 18:42:04 INFO - ##### Running create-virtualenv step. 18:42:04 INFO - ##### 18:42:04 INFO - Running pre-action listener: _resource_record_pre_action 18:42:04 INFO - Running main action method: create_virtualenv 18:42:04 INFO - Creating virtualenv /builds/slave/test/build/venv 18:42:04 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 18:42:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:42:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:42:04 INFO - Using real prefix '/usr' 18:42:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:42:05 INFO - Installing distribute.............................................................................................................................................................................................done. 18:42:07 INFO - Installing pip.................done. 18:42:07 INFO - Return code: 0 18:42:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:42:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:42:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:42:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7ff8dbd58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a75240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b040b0>, '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 0x1b04fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b05440>, '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': '004b26eee9c3b360c8654f40000001e1-1449196913.67122-1665846561', '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 18:42:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 18:42:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 18:42:07 INFO - Using env: {'DISPLAY': ':0', 18:42:07 INFO - 'HOME': '/home/cltbld', 18:42:07 INFO - 'LANG': 'en_US.UTF-8', 18:42:07 INFO - 'LANGUAGE': 'en_US:en', 18:42:07 INFO - 'LOGNAME': 'cltbld', 18:42:07 INFO - 'MAIL': '/var/mail/cltbld', 18:42:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:07 INFO - 'MOZ_NO_REMOTE': '1', 18:42:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:07 INFO - 'NO_EM_RESTART': '1', 18:42:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:07 INFO - 'PWD': '/builds/slave/test', 18:42:07 INFO - 'SHELL': '/bin/bash', 18:42:07 INFO - 'SHLVL': '1', 18:42:07 INFO - 'TERM': 'linux', 18:42:07 INFO - 'TMOUT': '86400', 18:42:07 INFO - 'USER': 'cltbld', 18:42:07 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1449196913.67122-1665846561', 18:42:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:07 INFO - '_': '/tools/buildbot/bin/python'} 18:42:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:07 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 18:42:07 INFO - Cleaning up... 18:42:07 INFO - Return code: 0 18:42:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:42:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:42:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:42:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7ff8dbd58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a75240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b040b0>, '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 0x1b04fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b05440>, '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': '004b26eee9c3b360c8654f40000001e1-1449196913.67122-1665846561', '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 18:42:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 18:42:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 18:42:07 INFO - Using env: {'DISPLAY': ':0', 18:42:07 INFO - 'HOME': '/home/cltbld', 18:42:07 INFO - 'LANG': 'en_US.UTF-8', 18:42:07 INFO - 'LANGUAGE': 'en_US:en', 18:42:07 INFO - 'LOGNAME': 'cltbld', 18:42:07 INFO - 'MAIL': '/var/mail/cltbld', 18:42:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:07 INFO - 'MOZ_NO_REMOTE': '1', 18:42:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:07 INFO - 'NO_EM_RESTART': '1', 18:42:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:07 INFO - 'PWD': '/builds/slave/test', 18:42:07 INFO - 'SHELL': '/bin/bash', 18:42:07 INFO - 'SHLVL': '1', 18:42:07 INFO - 'TERM': 'linux', 18:42:07 INFO - 'TMOUT': '86400', 18:42:07 INFO - 'USER': 'cltbld', 18:42:07 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1449196913.67122-1665846561', 18:42:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:07 INFO - '_': '/tools/buildbot/bin/python'} 18:42:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:07 INFO - Downloading/unpacking psutil>=0.7.1 18:42:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:42:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:42:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:42:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:42:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:09 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 18:42:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:42:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:42:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:42:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:42:09 INFO - Installing collected packages: psutil 18:42:09 INFO - Running setup.py install for psutil 18:42:09 INFO - building 'psutil._psutil_linux' extension 18:42:09 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 18:42:09 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 18:42:09 INFO - building 'psutil._psutil_posix' extension 18:42:09 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 18:42:09 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 18:42:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:42:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:42:10 INFO - Successfully installed psutil 18:42:10 INFO - Cleaning up... 18:42:10 INFO - Return code: 0 18:42:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:42:10 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')]} 18:42:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:10 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')]} 18:42:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7ff8dbd58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a75240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b040b0>, '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 0x1b04fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b05440>, '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': '004b26eee9c3b360c8654f40000001e1-1449196913.67122-1665846561', '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 18:42:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 18:42:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 18:42:10 INFO - Using env: {'DISPLAY': ':0', 18:42:10 INFO - 'HOME': '/home/cltbld', 18:42:10 INFO - 'LANG': 'en_US.UTF-8', 18:42:10 INFO - 'LANGUAGE': 'en_US:en', 18:42:10 INFO - 'LOGNAME': 'cltbld', 18:42:10 INFO - 'MAIL': '/var/mail/cltbld', 18:42:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:10 INFO - 'MOZ_NO_REMOTE': '1', 18:42:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:10 INFO - 'NO_EM_RESTART': '1', 18:42:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:10 INFO - 'PWD': '/builds/slave/test', 18:42:10 INFO - 'SHELL': '/bin/bash', 18:42:10 INFO - 'SHLVL': '1', 18:42:10 INFO - 'TERM': 'linux', 18:42:10 INFO - 'TMOUT': '86400', 18:42:10 INFO - 'USER': 'cltbld', 18:42:10 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1449196913.67122-1665846561', 18:42:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:10 INFO - '_': '/tools/buildbot/bin/python'} 18:42:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:42:10 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 18:42:10 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 18:42:10 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 18:42:10 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 18:42:10 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 18:42:10 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 18:42:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:42:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:42:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:42:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:42:12 INFO - Installing collected packages: mozsystemmonitor 18:42:12 INFO - Running setup.py install for mozsystemmonitor 18:42:12 INFO - Successfully installed mozsystemmonitor 18:42:12 INFO - Cleaning up... 18:42:12 INFO - Return code: 0 18:42:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:42:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:42:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7ff8dbd58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a75240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b040b0>, '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 0x1b04fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b05440>, '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': '004b26eee9c3b360c8654f40000001e1-1449196913.67122-1665846561', '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 18:42:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 18:42:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 18:42:12 INFO - Using env: {'DISPLAY': ':0', 18:42:12 INFO - 'HOME': '/home/cltbld', 18:42:12 INFO - 'LANG': 'en_US.UTF-8', 18:42:12 INFO - 'LANGUAGE': 'en_US:en', 18:42:12 INFO - 'LOGNAME': 'cltbld', 18:42:12 INFO - 'MAIL': '/var/mail/cltbld', 18:42:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:12 INFO - 'MOZ_NO_REMOTE': '1', 18:42:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:12 INFO - 'NO_EM_RESTART': '1', 18:42:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:12 INFO - 'PWD': '/builds/slave/test', 18:42:12 INFO - 'SHELL': '/bin/bash', 18:42:12 INFO - 'SHLVL': '1', 18:42:12 INFO - 'TERM': 'linux', 18:42:12 INFO - 'TMOUT': '86400', 18:42:12 INFO - 'USER': 'cltbld', 18:42:12 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1449196913.67122-1665846561', 18:42:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:12 INFO - '_': '/tools/buildbot/bin/python'} 18:42:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:12 INFO - Downloading/unpacking blobuploader==1.2.4 18:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:42:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:42:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:42:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:14 INFO - Downloading blobuploader-1.2.4.tar.gz 18:42:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:42:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:42:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18: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 18: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 18: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 18: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 18: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 18: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 18:42:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:42:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:42:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18: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 18: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 18: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 18: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 18: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 18: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 18:42:14 INFO - Downloading docopt-0.6.1.tar.gz 18:42:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:42:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:42:14 INFO - Installing collected packages: blobuploader, requests, docopt 18:42:14 INFO - Running setup.py install for blobuploader 18:42:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:42:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:42:14 INFO - Running setup.py install for requests 18:42:15 INFO - Running setup.py install for docopt 18:42:15 INFO - Successfully installed blobuploader requests docopt 18:42:15 INFO - Cleaning up... 18:42:15 INFO - Return code: 0 18:42:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:42:15 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')]} 18:42:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:15 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')]} 18:42:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7ff8dbd58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a75240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b040b0>, '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 0x1b04fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b05440>, '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': '004b26eee9c3b360c8654f40000001e1-1449196913.67122-1665846561', '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 18:42:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 18:42:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --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 18:42:15 INFO - Using env: {'DISPLAY': ':0', 18:42:15 INFO - 'HOME': '/home/cltbld', 18:42:15 INFO - 'LANG': 'en_US.UTF-8', 18:42:15 INFO - 'LANGUAGE': 'en_US:en', 18:42:15 INFO - 'LOGNAME': 'cltbld', 18:42:15 INFO - 'MAIL': '/var/mail/cltbld', 18:42:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:15 INFO - 'MOZ_NO_REMOTE': '1', 18:42:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:15 INFO - 'NO_EM_RESTART': '1', 18:42:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:15 INFO - 'PWD': '/builds/slave/test', 18:42:15 INFO - 'SHELL': '/bin/bash', 18:42:15 INFO - 'SHLVL': '1', 18:42:15 INFO - 'TERM': 'linux', 18:42:15 INFO - 'TMOUT': '86400', 18:42:15 INFO - 'USER': 'cltbld', 18:42:15 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1449196913.67122-1665846561', 18:42:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:15 INFO - '_': '/tools/buildbot/bin/python'} 18:42:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:42:15 INFO - Running setup.py (path:/tmp/pip-W8fwnZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:42:15 INFO - Running setup.py (path:/tmp/pip-zR8u6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:42:15 INFO - Running setup.py (path:/tmp/pip-I731ls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:42:15 INFO - Running setup.py (path:/tmp/pip-n5MA0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:42:15 INFO - Running setup.py (path:/tmp/pip-v8WO0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:42:16 INFO - Running setup.py (path:/tmp/pip-WhTSn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:42:16 INFO - Running setup.py (path:/tmp/pip-XGpDzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:42:16 INFO - Running setup.py (path:/tmp/pip-wZqUmh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:42:16 INFO - Running setup.py (path:/tmp/pip-AqSKVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:42:16 INFO - Running setup.py (path:/tmp/pip-cUAtK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:42:16 INFO - Running setup.py (path:/tmp/pip-RxNUdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:42:16 INFO - Running setup.py (path:/tmp/pip-qWA6oG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:42:16 INFO - Running setup.py (path:/tmp/pip-pzYtYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:42:16 INFO - Running setup.py (path:/tmp/pip-deK4bp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:42:16 INFO - Running setup.py (path:/tmp/pip-Qa4QXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:42:16 INFO - Running setup.py (path:/tmp/pip-dJipjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:42:16 INFO - Running setup.py (path:/tmp/pip-yiLyQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:42:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:42:16 INFO - Running setup.py install for manifestparser 18:42:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:42:17 INFO - Running setup.py install for mozcrash 18:42:17 INFO - Running setup.py install for mozdebug 18:42:17 INFO - Running setup.py install for mozdevice 18:42:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:42:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:42:17 INFO - Running setup.py install for mozfile 18:42:17 INFO - Running setup.py install for mozhttpd 18:42:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:42:17 INFO - Running setup.py install for mozinfo 18:42:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:42:17 INFO - Running setup.py install for mozInstall 18:42:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:42:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:42:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:42:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:42:17 INFO - Running setup.py install for mozleak 18:42:17 INFO - Running setup.py install for mozlog 18:42:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:42:17 INFO - Running setup.py install for moznetwork 18:42:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:42:18 INFO - Running setup.py install for mozprocess 18:42:18 INFO - Running setup.py install for mozprofile 18:42:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:42:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:42:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:42:18 INFO - Running setup.py install for mozrunner 18:42:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:42:18 INFO - Running setup.py install for mozscreenshot 18:42:18 INFO - Running setup.py install for moztest 18:42:18 INFO - Running setup.py install for mozversion 18:42:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:42:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:42:18 INFO - Cleaning up... 18:42:18 INFO - Return code: 0 18:42:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:42:18 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')]} 18:42:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:18 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')]} 18:42:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7ff8dbd58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a75240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b040b0>, '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 0x1b04fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b05440>, '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': '004b26eee9c3b360c8654f40000001e1-1449196913.67122-1665846561', '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 18:42:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 18:42:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 18:42:18 INFO - Using env: {'DISPLAY': ':0', 18:42:18 INFO - 'HOME': '/home/cltbld', 18:42:18 INFO - 'LANG': 'en_US.UTF-8', 18:42:18 INFO - 'LANGUAGE': 'en_US:en', 18:42:18 INFO - 'LOGNAME': 'cltbld', 18:42:18 INFO - 'MAIL': '/var/mail/cltbld', 18:42:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:18 INFO - 'MOZ_NO_REMOTE': '1', 18:42:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:18 INFO - 'NO_EM_RESTART': '1', 18:42:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:18 INFO - 'PWD': '/builds/slave/test', 18:42:18 INFO - 'SHELL': '/bin/bash', 18:42:18 INFO - 'SHLVL': '1', 18:42:18 INFO - 'TERM': 'linux', 18:42:18 INFO - 'TMOUT': '86400', 18:42:18 INFO - 'USER': 'cltbld', 18:42:18 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1449196913.67122-1665846561', 18:42:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:18 INFO - '_': '/tools/buildbot/bin/python'} 18:42:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:42:18 INFO - Running setup.py (path:/tmp/pip-rOVB0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:42:18 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)) 18:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:42:18 INFO - Running setup.py (path:/tmp/pip-xkADU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:42:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 18:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:42:19 INFO - Running setup.py (path:/tmp/pip-wUpt1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:42:19 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)) 18:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:42:19 INFO - Running setup.py (path:/tmp/pip-HBj2qG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:42:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 18:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:42:19 INFO - Running setup.py (path:/tmp/pip-6mSERE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:42:19 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)) 18:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:42:19 INFO - Running setup.py (path:/tmp/pip-aC8BHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:42:19 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)) 18:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:42:19 INFO - Running setup.py (path:/tmp/pip-9eh_Dd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:42:19 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)) 18:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:42:19 INFO - Running setup.py (path:/tmp/pip-dgRId_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:42:19 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)) 18:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:42:19 INFO - Running setup.py (path:/tmp/pip-IXAiz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:42:19 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)) 18:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:42:19 INFO - Running setup.py (path:/tmp/pip-nqHYxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:42:19 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)) 18:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:42:19 INFO - Running setup.py (path:/tmp/pip-4yoiQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:42:19 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)) 18:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:42:19 INFO - Running setup.py (path:/tmp/pip-yXnodi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:42:19 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)) 18:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:42:19 INFO - Running setup.py (path:/tmp/pip-wccwSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:42:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 18:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:42:19 INFO - Running setup.py (path:/tmp/pip-J8Raj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:42:19 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)) 18:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:42:19 INFO - Running setup.py (path:/tmp/pip-4Stgol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:42:20 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)) 18:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:42:20 INFO - Running setup.py (path:/tmp/pip-turzis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:42:20 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)) 18:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:42:20 INFO - Running setup.py (path:/tmp/pip-qPVx3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:42:20 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)) 18:42:20 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:42:20 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:42:20 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)) 18:42:20 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:42:20 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:42:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:42:20 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 18:42:20 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 18:42:20 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 18:42:20 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 18:42:20 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 18:42:20 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 18:42:21 INFO - Downloading blessings-1.5.1.tar.gz 18:42:21 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 18:42:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:42:21 INFO - Installing collected packages: blessings 18:42:21 INFO - Running setup.py install for blessings 18:42:22 INFO - Successfully installed blessings 18:42:22 INFO - Cleaning up... 18:42:22 INFO - Return code: 0 18:42:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:42:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:42:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:42:22 INFO - Reading from file tmpfile_stdout 18:42:22 INFO - Current package versions: 18:42:22 INFO - argparse == 1.2.1 18:42:22 INFO - blessings == 1.5.1 18:42:22 INFO - blobuploader == 1.2.4 18:42:22 INFO - docopt == 0.6.1 18:42:22 INFO - manifestparser == 1.1 18:42:22 INFO - mozInstall == 1.12 18:42:22 INFO - mozcrash == 0.16 18:42:22 INFO - mozdebug == 0.1 18:42:22 INFO - mozdevice == 0.47 18:42:22 INFO - mozfile == 1.2 18:42:22 INFO - mozhttpd == 0.7 18:42:22 INFO - mozinfo == 0.9 18:42:22 INFO - mozleak == 0.1 18:42:22 INFO - mozlog == 3.1 18:42:22 INFO - moznetwork == 0.27 18:42:22 INFO - mozprocess == 0.22 18:42:22 INFO - mozprofile == 0.27 18:42:22 INFO - mozrunner == 6.11 18:42:22 INFO - mozscreenshot == 0.1 18:42:22 INFO - mozsystemmonitor == 0.0 18:42:22 INFO - moztest == 0.7 18:42:22 INFO - mozversion == 1.4 18:42:22 INFO - psutil == 3.1.1 18:42:22 INFO - requests == 1.2.3 18:42:22 INFO - wsgiref == 0.1.2 18:42:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:42:22 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')]} 18:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:22 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')]} 18:42:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7ff8dbd58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a75240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b040b0>, '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 0x1b04fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b05440>, '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': '004b26eee9c3b360c8654f40000001e1-1449196913.67122-1665846561', '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 18:42:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 18:42:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 18:42:22 INFO - Using env: {'DISPLAY': ':0', 18:42:22 INFO - 'HOME': '/home/cltbld', 18:42:22 INFO - 'LANG': 'en_US.UTF-8', 18:42:22 INFO - 'LANGUAGE': 'en_US:en', 18:42:22 INFO - 'LOGNAME': 'cltbld', 18:42:22 INFO - 'MAIL': '/var/mail/cltbld', 18:42:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:22 INFO - 'MOZ_NO_REMOTE': '1', 18:42:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:22 INFO - 'NO_EM_RESTART': '1', 18:42:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:22 INFO - 'PWD': '/builds/slave/test', 18:42:22 INFO - 'SHELL': '/bin/bash', 18:42:22 INFO - 'SHLVL': '1', 18:42:22 INFO - 'TERM': 'linux', 18:42:22 INFO - 'TMOUT': '86400', 18:42:22 INFO - 'USER': 'cltbld', 18:42:22 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1449196913.67122-1665846561', 18:42:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:22 INFO - '_': '/tools/buildbot/bin/python'} 18:42:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:22 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 1)) 18:42:22 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 2)) 18:42:22 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 3)) 18:42:22 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 4)) 18:42:22 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 5)) 18:42:22 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 6)) 18:42:22 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 7)) 18:42:22 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 8)) 18:42:22 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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:42:22 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 3)) 18:42:22 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.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:42:22 INFO - Cleaning up... 18:42:22 INFO - Return code: 0 18:42:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:42:22 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')]} 18:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:22 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')]} 18:42:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7ff8dbd58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a75240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b040b0>, '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 0x1b04fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b05440>, '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': '004b26eee9c3b360c8654f40000001e1-1449196913.67122-1665846561', '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 18:42:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 18:42:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 18:42:22 INFO - Using env: {'DISPLAY': ':0', 18:42:22 INFO - 'HOME': '/home/cltbld', 18:42:22 INFO - 'LANG': 'en_US.UTF-8', 18:42:22 INFO - 'LANGUAGE': 'en_US:en', 18:42:22 INFO - 'LOGNAME': 'cltbld', 18:42:22 INFO - 'MAIL': '/var/mail/cltbld', 18:42:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:22 INFO - 'MOZ_NO_REMOTE': '1', 18:42:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:22 INFO - 'NO_EM_RESTART': '1', 18:42:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:22 INFO - 'PWD': '/builds/slave/test', 18:42:22 INFO - 'SHELL': '/bin/bash', 18:42:22 INFO - 'SHLVL': '1', 18:42:22 INFO - 'TERM': 'linux', 18:42:22 INFO - 'TMOUT': '86400', 18:42:22 INFO - 'USER': 'cltbld', 18:42:22 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1449196913.67122-1665846561', 18:42:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:22 INFO - '_': '/tools/buildbot/bin/python'} 18:42:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:22 INFO - Downloading/unpacking jsonschema 18:42:22 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 18:42:22 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 18:42:22 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 18:42:22 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 18:42:22 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 18:42:22 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 18:42:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:42:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 18:42:24 INFO - Downloading/unpacking functools32 (from jsonschema) 18:42:24 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 18:42:24 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 18:42:24 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 18:42:24 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 18:42:24 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 18:42:24 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 18:42:24 INFO - Downloading functools32-3.2.3-2.tar.gz 18:42:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 18:42:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:42:24 INFO - warning: no files found matching '*.txt' 18:42:24 INFO - no previously-included directories found matching 'build' 18:42:24 INFO - no previously-included directories found matching 'dist' 18:42:24 INFO - no previously-included directories found matching '.git*' 18:42:24 INFO - Installing collected packages: jsonschema, functools32 18:42:24 INFO - Running setup.py install for functools32 18:42:24 INFO - warning: no files found matching '*.txt' 18:42:24 INFO - no previously-included directories found matching 'build' 18:42:24 INFO - no previously-included directories found matching 'dist' 18:42:24 INFO - no previously-included directories found matching '.git*' 18:42:24 INFO - Successfully installed jsonschema functools32 18:42:24 INFO - Cleaning up... 18:42:24 INFO - Return code: 0 18:42:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:42:24 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')]} 18:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:24 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')]} 18:42:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7ff8dbd58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a75240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b040b0>, '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 0x1b04fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b05440>, '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': '004b26eee9c3b360c8654f40000001e1-1449196913.67122-1665846561', '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 18:42:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 18:42:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 18:42:24 INFO - Using env: {'DISPLAY': ':0', 18:42:24 INFO - 'HOME': '/home/cltbld', 18:42:24 INFO - 'LANG': 'en_US.UTF-8', 18:42:24 INFO - 'LANGUAGE': 'en_US:en', 18:42:24 INFO - 'LOGNAME': 'cltbld', 18:42:24 INFO - 'MAIL': '/var/mail/cltbld', 18:42:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:24 INFO - 'MOZ_NO_REMOTE': '1', 18:42:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:24 INFO - 'NO_EM_RESTART': '1', 18:42:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:24 INFO - 'PWD': '/builds/slave/test', 18:42:24 INFO - 'SHELL': '/bin/bash', 18:42:24 INFO - 'SHLVL': '1', 18:42:24 INFO - 'TERM': 'linux', 18:42:24 INFO - 'TMOUT': '86400', 18:42:24 INFO - 'USER': 'cltbld', 18:42:24 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1449196913.67122-1665846561', 18:42:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:24 INFO - '_': '/tools/buildbot/bin/python'} 18:42:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:25 INFO - Downloading/unpacking flake8 18:42:25 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 18:42:25 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 18:42:25 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 18:42:25 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 18:42:25 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 18:42:25 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 18:42:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:42:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 18:42:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:42:26 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 18:42:26 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 18:42:26 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 18:42:26 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 18:42:26 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 18:42:26 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 18:42:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:42:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 18:42:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:42:26 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 18:42:26 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 18:42:26 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 18:42:26 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 18:42:26 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 18:42:26 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 18:42:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 18:42:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:42:27 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 18:42:27 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 18:42:27 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 18:42:27 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 18:42:27 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 18:42:27 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 18:42:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 18:42:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:42:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:42:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:42:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:42:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:42:27 INFO - no previously-included directories found matching 'docs/_build' 18:42:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:42:27 INFO - Running setup.py install for pep8 18:42:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:42:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:42:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:42:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:42:27 INFO - no previously-included directories found matching 'docs/_build' 18:42:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:42:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:42:27 INFO - Cleaning up... 18:42:27 INFO - Return code: 0 18:42:27 INFO - Running post-action listener: _resource_record_post_action 18:42:27 INFO - Running post-action listener: _start_resource_monitoring 18:42:27 INFO - Starting resource monitoring. 18:42:27 INFO - ##### 18:42:27 INFO - ##### Running install step. 18:42:27 INFO - ##### 18:42:27 INFO - Running pre-action listener: _resource_record_pre_action 18:42:27 INFO - Running main action method: install 18:42:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:42:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:42:27 INFO - Reading from file tmpfile_stdout 18:42:27 INFO - Detecting whether we're running mozinstall >=1.0... 18:42:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:42:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:42:27 INFO - Reading from file tmpfile_stdout 18:42:27 INFO - Output received: 18:42:27 INFO - Usage: mozinstall [options] installer 18:42:27 INFO - Options: 18:42:27 INFO - -h, --help show this help message and exit 18:42:27 INFO - -d DEST, --destination=DEST 18:42:27 INFO - Directory to install application into. [default: 18:42:27 INFO - "/builds/slave/test"] 18:42:27 INFO - --app=APP Application being installed. [default: firefox] 18:42:27 INFO - mkdir: /builds/slave/test/build/application 18:42:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:42:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:42:42 INFO - Reading from file tmpfile_stdout 18:42:42 INFO - Output received: 18:42:42 INFO - /builds/slave/test/build/application/firefox/firefox 18:42:42 INFO - Running post-action listener: _resource_record_post_action 18:42:42 INFO - ##### 18:42:42 INFO - ##### Running run-tests step. 18:42:42 INFO - ##### 18:42:42 INFO - Running pre-action listener: _resource_record_pre_action 18:42:42 INFO - Running main action method: run_tests 18:42:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:42:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:42:42 INFO - Python 2.7.3 18:42:42 INFO - Return code: 0 18:42:42 INFO - grabbing minidump binary from tooltool 18:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:42:42 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 0x1b040b0>, '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 0x1b04fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b05440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:42:42 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 18:42:42 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 18:42:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:42:42 INFO - Return code: 0 18:42:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:42:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:42:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:42:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:42:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:42:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:42:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:42:43 INFO - Return code: 0 18:42:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Elm', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/sEo2UBSBTzCvRcBqtRCpCw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost'] in /builds/slave/test/build 18:42:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Elm --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/sEo2UBSBTzCvRcBqtRCpCw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --webServer localhost 18:42:43 INFO - Using env: {'DISPLAY': ':0', 18:42:43 INFO - 'HOME': '/home/cltbld', 18:42:43 INFO - 'LANG': 'en_US.UTF-8', 18:42:43 INFO - 'LANGUAGE': 'en_US:en', 18:42:43 INFO - 'LOGNAME': 'cltbld', 18:42:43 INFO - 'MAIL': '/var/mail/cltbld', 18:42:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:42:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:42:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:43 INFO - 'MOZ_NO_REMOTE': '1', 18:42:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:42:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:43 INFO - 'NO_EM_RESTART': '1', 18:42:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:43 INFO - 'PWD': '/builds/slave/test', 18:42:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:42:43 INFO - 'SHELL': '/bin/bash', 18:42:43 INFO - 'SHLVL': '1', 18:42:43 INFO - 'TERM': 'linux', 18:42:43 INFO - 'TMOUT': '86400', 18:42:43 INFO - 'USER': 'cltbld', 18:42:43 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1449196913.67122-1665846561', 18:42:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:43 INFO - '_': '/tools/buildbot/bin/python'} 18:42:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Elm', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/sEo2UBSBTzCvRcBqtRCpCw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost'] with output_timeout 3600 18:42:43 INFO - mozversion INFO | application_buildid: 20151203171816 18:42:43 INFO - mozversion INFO | application_changeset: 843db0ee142ba91ef4c89da07e43b299ad07e9eb 18:42:43 INFO - mozversion INFO | application_display_name: Nightly 18:42:43 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:42:43 INFO - mozversion INFO | application_name: Firefox 18:42:43 INFO - mozversion INFO | application_remotingname: firefox 18:42:43 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/projects/elm 18:42:43 INFO - mozversion INFO | application_vendor: Mozilla 18:42:43 INFO - mozversion INFO | application_version: 45.0a1 18:42:43 INFO - mozversion INFO | platform_buildid: 20151203171816 18:42:43 INFO - mozversion INFO | platform_changeset: 843db0ee142ba91ef4c89da07e43b299ad07e9eb 18:42:43 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/projects/elm 18:42:43 INFO - mozversion INFO | platform_version: 45.0a1 18:42:43 INFO - 2015-12-03 18:42:43,632 DEBUG : using testdate: 1449196963 18:42:43 INFO - 2015-12-03 18:42:43,632 DEBUG : actual date: 1449196963 18:42:43 INFO - 2015-12-03 18:42:43,643 INFO : starting webserver on 'localhost:46527' 18:42:43 INFO - 2015-12-03 18:42:43,644 INFO : Starting test suite talos-linux64-ix-066 18:42:43 INFO - 2015-12-03 18:42:43,644 INFO : Starting test dromaeo_css 18:42:43 INFO - 2015-12-03 18:42:43,644 DEBUG : operating with platform_type : linux_ 18:42:43 INFO - 2015-12-03 18:42:43,645 INFO : Initialising browser for dromaeo_css test... 18:42:43 INFO - 2015-12-03 18:42:43,661 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmIhEyh/profile http://localhost:46527/getInfo.html 18:42:47 INFO - 2015-12-03 18:42:47,905 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:42:47 INFO - 2015-12-03 18:42:47,905 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:42:47 INFO - 2015-12-03 18:42:47,905 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:42:47 INFO - 2015-12-03 18:42:47,905 DEBUG : BROWSER_OUTPUT: __metrics 18:42:48 INFO - 2015-12-03 18:42:48,022 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:42:48 INFO - 2015-12-03 18:42:48,022 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:42:49 INFO - 2015-12-03 18:42:49,430 INFO : Browser initialized. 18:42:49 INFO - 2015-12-03 18:42:49,431 INFO : Running cycle 1/1 for dromaeo_css test... 18:42:49 INFO - 2015-12-03 18:42:49,431 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmIhEyh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:43:01 INFO - 2015-12-03 18:43:01,353 DEBUG : BROWSER_OUTPUT: RSS: Main: 141115392 18:43:01 INFO - 2015-12-03 18:43:01,353 DEBUG : BROWSER_OUTPUT: 18:43:53 INFO - 2015-12-03 18:43:53,050 DEBUG : BROWSER_OUTPUT: 1449197033046 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] 18:46:05 INFO - 2015-12-03 18:46:05,294 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46527/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46527/tests/dromaeo/cssquery-ext.html) 18:46:06 INFO - 2015-12-03 18:46:06,419 DEBUG : BROWSER_OUTPUT: RSS: Main: 226512896 18:46:06 INFO - 2015-12-03 18:46:06,420 DEBUG : BROWSER_OUTPUT: 18:49:09 INFO - 2015-12-03 18:49:09,015 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46527/tests/dromaeo/cssquery-ext.html (next: http://localhost:46527/tests/dromaeo/cssquery-jquery.html) 18:49:09 INFO - 2015-12-03 18:49:09,585 DEBUG : BROWSER_OUTPUT: RSS: Main: 220274688 18:49:09 INFO - 2015-12-03 18:49:09,585 DEBUG : BROWSER_OUTPUT: 18:52:11 INFO - 2015-12-03 18:52:11,685 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46527/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46527/tests/dromaeo/cssquery-mootools.html) 18:52:12 INFO - 2015-12-03 18:52:12,266 DEBUG : BROWSER_OUTPUT: RSS: Main: 209903616 18:52:12 INFO - 2015-12-03 18:52:12,266 DEBUG : BROWSER_OUTPUT: 18:55:14 INFO - 2015-12-03 18:55:14,205 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46527/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46527/tests/dromaeo/cssquery-prototype.html) 18:55:14 INFO - 2015-12-03 18:55:14,786 DEBUG : BROWSER_OUTPUT: RSS: Main: 202711040 18:55:14 INFO - 2015-12-03 18:55:14,786 DEBUG : BROWSER_OUTPUT: 18:58:17 INFO - 2015-12-03 18:58:17,581 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46527/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46527/tests/dromaeo/cssquery-yui.html) 18:58:18 INFO - 2015-12-03 18:58:18,162 DEBUG : BROWSER_OUTPUT: RSS: Main: 209432576 18:58:18 INFO - 2015-12-03 18:58:18,163 DEBUG : BROWSER_OUTPUT: 19:01:20 INFO - 2015-12-03 19:01:20,455 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46527/tests/dromaeo/cssquery-yui.html (next: http://localhost:46527/tests/dromaeo/cssquery-dojo.html) 19:01:20 INFO - 2015-12-03 19:01:20,721 DEBUG : BROWSER_OUTPUT: RSS: Main: 253415424 19:01:20 INFO - 2015-12-03 19:01:20,721 DEBUG : BROWSER_OUTPUT: 19:01:20 INFO - 2015-12-03 19:01:20,721 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:01:20 INFO - 2015-12-03 19:01:20,721 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:01:20 INFO - 2015-12-03 19:01:20,721 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:01:20 INFO - 2015-12-03 19:01:20,721 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:01:20 INFO - 2015-12-03 19:01:20,721 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2614.7254538273482;2712.755851973322;2723.0605441122807;2735.124760076776;2751.6010178524116;4414.801333939972;4523.615492683126;4636.142313671969;4696.718196908184;4721.527847215281;4567.954320456794;4588.334691469735;4650.4186976627925;4676.719396836193;4726.810927562902;4332.133573285348;4343.153085148398;4346.478422589294;4357.847475338363;4399.604035636792;4125.174965006996;4389.012472193763;4396.340548917672;4447.9555204448025;4459.910801783963;4206.49522057352;4284.742915425053;4310.396544483775;4314.288142456491;4331.003869110123;4334.609885110355;4336.653067754603;4349.478062632505;4353.064091220403;4388.27593447084;4277.700560960734;4303.289957157065;4314.935275970863;4317.136572685476;4371;4375.518692943773;4464.374987501752;4467.285234362519;4483.215437298492;4590.380298659672;5050.9494905051215;5071.644984851062;5074.644774865761;5082.1106306396605;5124.692518448867;5091.79632814687;5096.923546146811;5102.438731739506;5105.081085404626;5146.305248791403;4510.188166130095;4615.538446155358;4628.375169352162;4633.374494443275;4736.8105275788585;5109.131447653907;5118.513741194581;5120.359955005624;5124.641275110706;5136.8202112925865;4896.290037944549;4930.605551555867;4930.605551555938;4930.950690493121;4961.479044700254;4827.879303017382;4899.510048995072;4926.753662316942;4929.112759703216;4932.679375840559;4942.901141977212;4971.801127954914;4976.178930476503;4978.850634480971;4982.476839931827;4959.2561115832195;4964.925526117111;4966.155753521838;4966.503349665005;5006.123928312531;3978.085040440657;4048.9190216196102;4084.6732261419015;4165.4584903962295;4198.727082739612;3545.5213546170935;3600.0819790953665;3640.12636967126;3642.635736426389;3671.339158951361;4336.804843782037;4339.175556644227;4369.737815731066;4372.606465418127;4374.993751437188;4790.976045119752;4922.950770492249;4929.309896614477;5030.673006254582;5044.243363495431;4223.809928553223;4297.226499230106;4303.419038429772;4322.654187664979;4335.28467802809;4452.933206001912;4456.799444025027;4471.5528447155675;4479.193745125908;4514.367988481616;4586.587207151372;4688.109259240733;4692;4799.1841386965;4815.15734746411;4866.7079975201605;4966.255061740768;5064.468230835857;5080.237964305384;5084.3898732152375;4810.2063159579675;4852.078105160008;4852.880622708573;4855.878603034952;4892.730899800403;5015.473375295687;5024.723640199824;5028.321176641107;5034.521720436553;5067.721275329893;4826.6621336506105;4909.042736666316;4959.380077490314;4962.751862406793;4963.801447942042;4813.446453657734;4882.438519570295;4883.658143930033;4901.975490122527;4926.137925863031;4896.583790377857;4912;4915.7498955577385;4918.680285781413;4958.950410495849;4601.378813860086;4727.503612120678;4800.4479484859685;4848.127337079219;4851.1753001990455;4756.548127927841;4775.689580177277;4811.639127065414;4826.95173048265;4865.610751139971;4664.370310008241;4737.38414006177;4749.833755818529;4756.8097276108565;4798.088363210979 19:01:20 INFO - 2015-12-03 19:01:20,723 DEBUG : BROWSER_OUTPUT: |1;ext.html;574.0929331655984;581.9621724587902;583.0117950074623;588.4321629627409;590.0411830774989;27865.58201626977;37408.25183496332;37411.81294093533;37637.81181094098;37720.622793772054;40910.18179636406;41339.966500837494;41437.58562414375;41492;41536.16927661445;6943.930560694379;7055.682494287769;7889.250521200491;8058.35533157346;8060.798480037987;10088.495575221246;10261.486925653724;10345;10352.17182625392;10366.067053965142;10056.245781566375;10162.9491852541;10181.490925453734;10187.490625468734;10187.796244075114;7077.3984211342095;7243.311885370934;7250.274972502708;7254.600996945166;9968.202543796515;6909.654517274166;9712;9851.704448866545;9915.454649994248;9915.801683966352;34660.48009279863;34988.125296867525;35092.649073509194;35130.64869351325;35142;2851.8431486268246;3072.5391191321255;3518.9619062376405;3579.391503444395;3622.456631505269;30872.8456357719;31183.844080779676;31252.687473125206;31527.84236078805;31932.36135277305;3222.4038552867796;3275.164832967602;3281.1140991932284;3389.915252118692;3396.5075064115563;218478;220270.89864550735;220307;220606;220696;51407.22889156666;56011.43988560144;56447;56462;56494;47665.76167119142;61846.38153618406;62143;62341;62348.688256558424;13501.527446539323;13779.793303100461;13780.517681881087;13794.724105517833;13840.653983650489;9828.901710982942;9899.60401583943;9918.652847150315;9924.603015879284;9929.950350248202;18624.813751862577;19198.520036998907;19205.423837284903;19207.423777286425;19274.132664030152;7416.44376671741;7685.42359323053;7724.6137693115115;7768.844623107506;7844.764657060297;885.8936927568733;903.6340282185726;955.8518429643416;978.4178413843752;1037.6160820496464;26617.201483955512;26625.600615990777;26708.332291692474;26853.462930741276;26922;957.1816097236763;979.9804003919882;998.1066945084254;1003.7892042670975;1083.6803143072812;13885.444582216598;13927.512537061357;13978.720425591431;14130.15219086858;14241.50154744579;257961;261421;262192;263281.98821111966;264205;38949.6105038946;46392.768036160276;46864.5313546867;47025.529744702115;47062.29406558904;1077.1221454514546;1113.4265853085667;1211.2732360583755;1221.4015132585148;1236.023541402282;26497.735022649525;26931.596026059233;29574.556381653863;30839.537406938463;31050;37005;37400;42592.78703606462;43582.78208608937;44217.33673994957;189100;190025;190725;191803;192662;38408;38878.41682374823;39097;39206.80396597999;39234.607653924235;42060.15879682328;42373.57626423697;42859.571404286806;43145.568544315414;43253.56746432495;35508;36030.63969360378;36304;36535.634643653226;36904;35571.50999430015;36128.4580731284;36815;36946.815265924575;37145.25709485849;35821.46267805933;38924;39408.80295598504;39520.2095958085;39588.40617390799;28293.29266768265;31076.446177691476;31335;31417.37165256728;31511.321537669555;23831.880840595684;23916.613334523507;23963.400914977265;24133.93187430589;24135.15526956548 19:01:20 INFO - 2015-12-03 19:01:20,723 DEBUG : BROWSER_OUTPUT: |2;jquery.html;335.19051490650077;335.8597561279456;336.7407096535667;337.46006389776363;339.4687314353039;12334.629961101182;12733.108682392212;14798.852011479881;15187.620309492268;15552.533423997284;8904.91095089049;9138.634454621808;9395.436273823558;13702.862971370283;16226.269817858225;4420.049689316805;4536.092781443708;4536.886577835564;4539.0921815637;4539.841105561306;3383.8477268522975;3496.7552271341015;3497.318022985519;3501.124718820295;4427.690061695683;5102.872428189288;5305.602079844008;5307.416184219733;5319.680819150844;5320.654157479771;4663.48701642819;4831.541003604652;4833.057553777015;5346.545543628797;5381.246625472457;4540.137373898981;4664.976675116636;4667.766611669437;4678.064387122555;4678.485366609671;9980.700578982569;10232.386056836614;10240.231982601335;10261.640842570474;10269;1855.2115350975782;1875.7373967644542;1881.924723011078;1886.1041005522404;1922.2503223742751;8481;8568.057513673491;8603.440776349516;8677.6983452482;9292;1671.3899426709163;1727.5076603168036;1732.601501654614;1759.6920538905767;1772.8936263824212;53339.46660533384;55371.723141384035;55523.44476555223;55554.16668749932;55778.721106394616;8811.823763524693;8931.106889311146;9068.22920051803;9070.591823367964;9145.588448519833;11448.370339631234;11533.942330288462;11537.423128843524;11554.191206615624;11558;6777.762778302736;6786.078200235732;6875.48433867462;6916.446684265246;6937.7571784987285;6841;6855.07456493377;6901.275366086589;6905.447564194852;6941.236463988957;3670.8531658733887;3714.591394946554;3715.628437156263;3732.1789206374556;3740.139767853409;1498.0936533397137;1516.1282262698771;1516.6360073582262;1552.813662360524;1558.7194305024977;836.6067948064522;886.778305423644;897.8787863638456;941.8257622339889;989.6635144051057;11892.821607675893;15088.773668394982;15626.025476566856;15978.201089945456;15988.200589970455;839.5634270179472;847.326375531454;867.5618812499647;899.487292243415;933.8972713001565;8803.823923521493;9318.064541737773;9343.34596578233;9364.859527107099;9842.458664773507;451330;471011;473225;478237;480892;69985.3001469989;71400;71675.64162179155;72787;73837.63081184559;1065.1372388365603;1067.7704293576762;1078.5524007536785;1101.251149218523;1111.2554588425612;14129.717405652034;14584.635384115481;14612.561623151323;14755.409783608535;14959.476418325306;33147.50278745773;33621.327573448885;33709.325813483105;34332.485012724326;34564.65435345614;39393.40909886411;39523.20953580855;40297.59702402938;41291.58708412998;41324.1735165289;8715.08491608372;9003.279737621106;9016;9122.224610908148;9282.62869485213;15951.521454356387;16203.837961620233;16403.83596164023;16693.83306166923;16749.74875376895;13922.860771392561;13948.02363834522;14107.858921411065;14132.78800818009;14226.71546569042;13326;13480.191188528719;13536;13777.931110344383;13915.860841391457;11956;13347.733045339233;13564.389602467716;13604.183748975092;13944.093633913762;8008.479448835807;8097.878531822145;8104.79738006531;8310.127436619068;8378.24595786382;10826;13263.403146858222;13435.865641343853;13582.25297608641;13691.589252322447 19:01:20 INFO - 2015-12-03 19:01:20,724 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1236.3385588710041;1597.337105101383;1666.4750603559874;1668.6579251253486;1710.6664200480902;5976.910346344808;7016.543924644894;7132.144142702877;7148.74979375722;7163.140423149216;6993.055937448443;7104.85790284194;7108.289171082889;7117.039199708051;7134.5719256844495;1711.0503670462888;1737.4353335166059;1964.872283301588;1992.8704634198803;2035.6946458031339;2037.3378651938106;2040.1941233212872;2045.3659365596714;2046.4270004398793;2047.3550831488108;1981.6135853508572;2005.7994200579972;2017.9899100504551;2022.9696554551695;2041.3467690339098;1988.9502762430911;2011.4870707969521;2012.778594354627;2038.1236068490543;2038.9694154587694;2067.4934641012896;2086.405374468284;2086.5305306306113;2089.770125286217;2091.1217288738767;7047.753328633473;7067.328603782633;7156.105486814148;7160.785176444663;7174.246704096047;4237.8304867805255;4333.501647310568;4335.9566404335865;4338.370936214231;4343.413639158736;2259.661050842387;2574.292069680834;2690.8923643054254;2699.5410780167417;2734.644496215479;832.4381042796149;840.8355742624416;854.662408348705;919.7010971434311;923.6305477808863;9558.091981261769;9591.712248632552;9592.472414017226;9617.663381781604;9623.470709110927;4033.6773058155277;4057.33054046085;4153.314703073959;4162.729422587522;4167.374893765898;8341.040780310343;8350.206730360605;8369.079401265855;8371.832563348698;8373.623186956602;4368.890777730582;4418.646508279394;4441.955580444154;4444.244478438609;4446.26636604963;3966.801659916993;3987.641112299907;3998.4402183694306;3998.9200215995515;4001.8799436016966;2993.0571869860923;3044.0411270449736;3114.859831307597;3156.889508867179;3349.531065650811;1095.956161753521;1101.8457415961773;1106.551846502168;1107.7729065541705;1113.4154568851256;870.3341943413294;870.8780770692108;952.8713623660856;1020.994895025535;1062.7661914378825;6487.059376390397;6493;6496.090547323379;6526.314736952647;6526.608403495806;1108.467935391017;1117.3240189685123;1144.3019757947645;1145.5017067575632;1151.8790526994544;4945.653804233741;4970.428400733889;4975.228839529878;4983.302337672729;4986.127427700138;8388.664453421794;8408.2432581068;8428.536430496259;8691.304695624334;8697.434666746642;8520.105388934073;8566.14338566151;8575.356848236408;8603.397762156714;8614.095519970439;6579.440747536417;6644.302348253461;6685.09751183584;6751.831204219934;6752.5948443093575;6193.071039344134;6193.473554747897;6226.719797609027;6228.252609686867;6236.812895612958;7330.64252209014;7441.888371674538;7456.813579660335;7466.066741657293;7559.962200188964;7692.269234422721;7856;7862.488938218998;7895.1315355309725;7943.205679432011;5876.764929402947;5940.287165540163;5945.672987985702;5950.583459157818;5953;6567.737290508326;6671.5997040177745;6747.932520674731;6779.661016949034;6798.422134118655;6331.2085989251345;6378.202724659418;6413.679316034087;6420.3258657842125;6508.284088750328;6241.78153764616;6256.749730010749;6273.027680709497;6299.527535434769;6442.09810626522;6330.082138090043;6532.673366331569;6533.477321814338;6545.934540654533;6547.410733034049;6035.879282414239;6069.544784141295;6078.665673388006;6078.939210607838;6089.117078023751;5720.914186287126;5737.254156959735;5747.971260143672;5810.535157187331;5861.1501332307425 19:01:20 INFO - 2015-12-03 19:01:20,725 DEBUG : BROWSER_OUTPUT: |4;prototype.html;304.65421746317924;316.14325178765534;317.4143704864526;320.9406259841931;321.91952011997;5218.921716174255;5371.113766228567;5382.865428364288;5409.756560954756;5412.592725891267;5287.973560132194;5367.221752845835;5370.301860758106;5373.435789242132;5385.973070134643;3927.175293188434;4020.798960051986;4043.9595604043875;4162.687798415123;4173.1445053764055;4106.630403263705;4109.342505199169;4113.362428823537;4118.949667834698;4155.168966206756;4091.161311931062;4099.795010249491;4100.261952848486;4104;4108.404281379198;3884.9417258741;3979.9801000994953;3988.441618173458;4033.9394909076386;4067.51189857219;3555.484454754072;3560.768550044239;3578.3022310649435;3601.4237721964623;3601.963980360189;5103.438621751604;5137.486251374833;5154.278401023859;5159.071367153911;5165.276861239429;4701.623870090384;4710.670253082286;4711.905761884743;4712.670113092085;4718.504557021532;5453.23654688344;5593.552515798767;5607.158926161068;5613.07384281593;5624.465675760796;3896.980515097435;3900.941485877714;3903.4925459690057;3904.4338570907057;3907.081835768592;5828;5907.763689452417;5929.377415371367;5933.792317268875;5938.25771778532;4015.558288588253;4044.2315959967514;4049.9797501012895;4051.2707712611423;4053.4527838741983;3949.526056873136;4105.0763578195265;4107.219628270619;4111.60939710727;4124.05146816234;4698.671093023524;4705.035467729176;4707.270373092176;4709.529047095331;4710.740909249956;5628.127640215773;5644.943550564524;5651.378348381675;5653.152027195872;5654.236678048493;1429.8856091512655;1451.7459444597152;1454.6363409147714;1454.9490767823074;1455.89080818939;975.8953840148364;979.4172467381896;985.8521221816785;988.461288597716;998.1615443027746;4936.259561065797;4970.3538539990295;4972.676776009548;4973.726445045557;4979.45226025137;5808.564357673192;5834.358220595731;5843.620164689281;5844.707764611752;5846;4940.382452193476;4953.108440480748;4955.529224723718;4957.652964292465;4962.354893863775;2903.3177203357195;3023.818570885754;3101.2246938265434;3112.097491727419;3154.8264845433264;5511.669299841942;5569.415211402826;5572.3870374258795;5572.414896435897;5578.609497335147;6014.368491308437;6034.607750496204;6047.334793172748;6053.909191362045;6054.212952316171;5556.111022236423;5566.137248726535;5566.4990150886615;5566.55467562594;5569.359523654832;5755.942440575541;5874.706264686834;5876.324222714272;5879.059350503899;5880.882382352414;5738.1679656450415;5738.856528586819;5740.196372507936;5742.368339482737;5746.13807928814;5513.917291240715;5545.140503222007;5548.0845660465575;5553.250311207935;5563.58273129525;3985.063510075072;4016.4176194451056;4039.4344791728595;4067.9593204067583;4075.8777236682945;5878.500327472213;5883.823485295448;5885.764569417347;5886.411358864079;5891.7643294269465;5667.036603777286;5667.263255776723;5671.0359238930305;5671.602987790815;5673.120666296731;5654.038813401814;5658.943410566007;5661.094224923992;5663.263775709132;5666.744996475086;5346.198070289488;5496.422875598005;5507.063799154073;5509.090999984957;5511.063119269654;5701.458361455655;5706.115552089433;5708.229389032427;5710.65736055838;5711.343195532567;5279.841604751864;5411.2965314508865;5463.07127788269;5557.3331200256225;5568.248286481273 19:01:20 INFO - 2015-12-03 19:01:20,725 DEBUG : BROWSER_OUTPUT: |5;yui.html;692.5636848785265;692.9467209841044;700.9719611215552;701.7438634898264;722.859042486715;11533.538658453663;11903.561282720812;12000.459979300942;12045.036397088234;12047.457864396101;11823.645290641272;11919.702007449818;11926.522939082426;11941.641750747469;11943.223690460114;624.6189824207253;790.5059337913804;813.446856137826;814.7067055859885;816.5508970066469;626.7712285015959;795.9442839001272;807.2492581898832;811.7889348769304;812.3460614205562;827.3546633625782;846.2383854530941;846.4540371460404;846.6063280574563;847.7414388611471;646.1115965547373;655.2366493035607;819.4141189049858;839.5886015852219;839.6767244610808;615.6706162203244;617.9505639548826;618.2951435363689;618.3414663383483;619.3218425823716;11521.193516453852;11721.120915931338;11771.529138834436;11779.411029448493;11787.528498860036;10551.36691798487;10645.946770266099;10647.201459890539;10988.279036475167;11167.776644467147;8873.423227490257;8924.955375223148;8976.640934362618;8993.235574976135;9023.052579479127;3104.736097431721;3162.98418507906;3173.1432513221303;3181.459151944175;3205.695458931421;39712.20575588472;39858.99999999971;40016;40061.59938400608;40098;8024.79938001543;8371.288440482505;8415.368847336475;8621.180987806149;8797.12028797128;16171.676566468605;16245.67508649844;16265.51203463898;16398.344066237216;16456.506304810875;6366.076918846834;6419.775307864203;6444.903326450107;6480.882045357218;6553.705083271264;3660.670539651444;3662.359087159736;3717.9256414872093;3734.477173195755;3761.1161377076364;2698.3793727442408;2731.9726802732116;2736.781057515394;2738.7812423471364;2739.5479745842113;489.4224814718595;490.19852541095565;492.4878126748213;492.69206745783885;495.95784358329223;455.92933095370273;513.6301862658879;528.6167528541853;532.7229840482927;538.6095081066196;7084.964575177091;7497.962510187414;7593.886091708629;7664.425168112302;7681.884771728429;519.8076711616726;546.6310240587587;551.4860863829567;560.4759549820931;568.7895478672834;3324.2852786650988;3456.809875456874;3468.2543253200683;3500.5974312954336;3528.7177025837873;53751.46248537464;54212.72893635585;54602.18096728552;54640.45359546433;54660.453395466335;48102.759486203046;48782.75608622005;48902.13174419093;48909.266361004615;49004;41384.58615413868;42694;42886.142277154286;44363.778181108886;44534.55465445369;6964.756233531802;7052.788416347517;7087.433005359662;7114.893276600958;7294;31856.5221521682;31940;32722.345553089282;32752.181195470304;32772.83613581917;39730.60269397269;40355.394669079404;40782.79608601938;41369.79315103405;41478.792606036775;8556.144385561644;8591.484510929364;8682.392232543662;8749.91250087491;8810.427322224035;9083.18251357381;9096.681616143404;9211.539423028687;9234.676786312446;9597.616095356108;8757.562121893752;8823.29413646894;8868.512231827053;8910.955445222733;8956.507392093497;8691.782705432162;8698.173673501007;8731.170538798804;8736;8747;8711.041785403473;8717.953845538575;8863.379563430499;8876.778080548038;8881.289496840109;7326.890096648448;7386.778396648109;7447.255274472726;7675.270849269311;7706.576138312446;7152.749653762094;7535.284148005931;7813.843723125392;8021.438499305226;8523.95738021306 19:01:20 INFO - 2015-12-03 19:01:20,726 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:01:20 INFO - 2015-12-03 19:01:20,726 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:01:20 INFO - 2015-12-03 19:01:20,726 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,923 19:01:20 INFO - 2015-12-03 19:01:20,727 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:01:20 INFO - 2015-12-03 19:01:20,727 DEBUG : BROWSER_OUTPUT: __startTimestamp1449198080719__endTimestamp 19:01:20 INFO - 2015-12-03 19:01:20,727 DEBUG : BROWSER_OUTPUT: 19:01:20 INFO - 2015-12-03 19:01:20,727 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:01:20 INFO - 2015-12-03 19:01:20,727 DEBUG : BROWSER_OUTPUT: Number of tests: 6 19:01:20 INFO - 2015-12-03 19:01:20,727 DEBUG : BROWSER_OUTPUT: 19:01:20 INFO - 2015-12-03 19:01:20,727 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4613.93 Median:4749.83 stddev:481.36 (10.1%) stddev-sans-first:456.58 19:01:20 INFO - 2015-12-03 19:01:20,729 DEBUG : BROWSER_OUTPUT: Values: 2614.7 2712.8 2723.1 2735.1 2751.6 4414.8 4523.6 4636.1 4696.7 4721.5 4568.0 4588.3 4650.4 4676.7 4726.8 4332.1 4343.2 4346.5 4357.8 4399.6 4125.2 4389.0 4396.3 4448.0 4459.9 4206.5 4284.7 4310.4 4314.3 4331.0 4334.6 4336.7 4349.5 4353.1 4388.3 4277.7 4303.3 4314.9 4317.1 4371.0 4375.5 4464.4 4467.3 4483.2 4590.4 5050.9 5071.6 5074.6 5082.1 5124.7 5091.8 5096.9 5102.4 5105.1 5146.3 4510.2 4615.5 4628.4 4633.4 4736.8 5109.1 5118.5 5120.4 5124.6 5136.8 4896.3 4930.6 4930.6 4931.0 4961.5 4827.9 4899.5 4926.8 4929.1 4932.7 4942.9 4971.8 4976.2 4978.9 4982.5 4959.3 4964.9 4966.2 4966.5 5006.1 3978.1 4048.9 4084.7 4165.5 4198.7 3545.5 3600.1 3640.1 3642.6 3671.3 4336.8 4339.2 4369.7 4372.6 4375.0 4791.0 4923.0 4929.3 5030.7 5044.2 4223.8 4297.2 4303.4 4322.7 4335.3 4452.9 4456.8 4471.6 4479.2 4514.4 4586.6 4688.1 4692.0 4799.2 4815.2 4866.7 4966.3 5064.5 5080.2 5084.4 4810.2 4852.1 4852.9 4855.9 4892.7 5015.5 5024.7 5028.3 5034.5 5067.7 4826.7 4909.0 4959.4 4962.8 4963.8 4813.4 4882.4 4883.7 4902.0 4926.1 4896.6 4912.0 4915.7 4918.7 4959.0 4601.4 4727.5 4800.4 4848.1 4851.2 4756.5 4775.7 4811.6 4827.0 4865.6 4664.4 4737.4 4749.8 4756.8 4798.1 19:01:20 INFO - 2015-12-03 19:01:20,729 DEBUG : BROWSER_OUTPUT: 19:01:20 INFO - 2015-12-03 19:01:20,729 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40010.11 Median:35926.05 stddev:58678.45 (163.3%) stddev-sans-first:58768.35 19:01:20 INFO - 2015-12-03 19:01:20,729 DEBUG : BROWSER_OUTPUT: Values: 574.1 582.0 583.0 588.4 590.0 27865.6 37408.3 37411.8 37637.8 37720.6 40910.2 41340.0 41437.6 41492.0 41536.2 6943.9 7055.7 7889.3 8058.4 8060.8 10088.5 10261.5 10345.0 10352.2 10366.1 10056.2 10162.9 10181.5 10187.5 10187.8 7077.4 7243.3 7250.3 7254.6 9968.2 6909.7 9712.0 9851.7 9915.5 9915.8 34660.5 34988.1 35092.6 35130.6 35142.0 2851.8 3072.5 3519.0 3579.4 3622.5 30872.8 31183.8 31252.7 31527.8 31932.4 3222.4 3275.2 3281.1 3389.9 3396.5 218478.0 220270.9 220307.0 220606.0 220696.0 51407.2 56011.4 56447.0 56462.0 56494.0 47665.8 61846.4 62143.0 62341.0 62348.7 13501.5 13779.8 13780.5 13794.7 13840.7 9828.9 9899.6 9918.7 9924.6 9930.0 18624.8 19198.5 19205.4 19207.4 19274.1 7416.4 7685.4 7724.6 7768.8 7844.8 885.9 903.6 955.9 978.4 1037.6 26617.2 26625.6 26708.3 26853.5 26922.0 957.2 980.0 998.1 1003.8 1083.7 13885.4 13927.5 13978.7 14130.2 14241.5 257961.0 261421.0 262192.0 263282.0 264205.0 38949.6 46392.8 46864.5 47025.5 47062.3 1077.1 1113.4 1211.3 1221.4 1236.0 26497.7 26931.6 29574.6 30839.5 31050.0 37005.0 37400.0 42592.8 43582.8 44217.3 189100.0 190025.0 190725.0 191803.0 192662.0 38408.0 38878.4 39097.0 39206.8 39234.6 42060.2 42373.6 42859.6 43145.6 43253.6 35508.0 36030.6 36304.0 36535.6 36904.0 35571.5 36128.5 36815.0 36946.8 37145.3 35821.5 38924.0 39408.8 39520.2 39588.4 28293.3 31076.4 31335.0 31417.4 31511.3 23831.9 23916.6 23963.4 24133.9 24135.2 19:01:20 INFO - 2015-12-03 19:01:20,729 DEBUG : BROWSER_OUTPUT: 19:01:20 INFO - 2015-12-03 19:01:20,729 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25349.56 Median:39458.31 stddev:77023.50 (195.2%) stddev-sans-first:77216.67 19:01:20 INFO - 2015-12-03 19:01:20,729 DEBUG : BROWSER_OUTPUT: Values: 335.2 335.9 336.7 337.5 339.5 12334.6 12733.1 14798.9 15187.6 15552.5 8904.9 9138.6 9395.4 13702.9 16226.3 4420.0 4536.1 4536.9 4539.1 4539.8 3383.8 3496.8 3497.3 3501.1 4427.7 5102.9 5305.6 5307.4 5319.7 5320.7 4663.5 4831.5 4833.1 5346.5 5381.2 4540.1 4665.0 4667.8 4678.1 4678.5 9980.7 10232.4 10240.2 10261.6 10269.0 1855.2 1875.7 1881.9 1886.1 1922.3 8481.0 8568.1 8603.4 8677.7 9292.0 1671.4 1727.5 1732.6 1759.7 1772.9 53339.5 55371.7 55523.4 55554.2 55778.7 8811.8 8931.1 9068.2 9070.6 9145.6 11448.4 11533.9 11537.4 11554.2 11558.0 6777.8 6786.1 6875.5 6916.4 6937.8 6841.0 6855.1 6901.3 6905.4 6941.2 3670.9 3714.6 3715.6 3732.2 3740.1 1498.1 1516.1 1516.6 1552.8 1558.7 836.6 886.8 897.9 941.8 989.7 11892.8 15088.8 15626.0 15978.2 15988.2 839.6 847.3 867.6 899.5 933.9 8803.8 9318.1 9343.3 9364.9 9842.5 451330.0 471011.0 473225.0 478237.0 480892.0 69985.3 71400.0 71675.6 72787.0 73837.6 1065.1 1067.8 1078.6 1101.3 1111.3 14129.7 14584.6 14612.6 14755.4 14959.5 33147.5 33621.3 33709.3 34332.5 34564.7 39393.4 39523.2 40297.6 41291.6 41324.2 8715.1 9003.3 9016.0 9122.2 9282.6 15951.5 16203.8 16403.8 16693.8 16749.7 13922.9 13948.0 14107.9 14132.8 14226.7 13326.0 13480.2 13536.0 13777.9 13915.9 11956.0 13347.7 13564.4 13604.2 13944.1 8008.5 8097.9 8104.8 8310.1 8378.2 10826.0 13263.4 13435.9 13582.3 13691.6 19:01:20 INFO - 2015-12-03 19:01:20,729 DEBUG : BROWSER_OUTPUT: 19:01:20 INFO - 2015-12-03 19:01:20,729 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4938.90 Median:6078.80 stddev:2558.55 (42.1%) stddev-sans-first:2550.59 19:01:20 INFO - 2015-12-03 19:01:20,730 DEBUG : BROWSER_OUTPUT: Values: 1236.3 1597.3 1666.5 1668.7 1710.7 5976.9 7016.5 7132.1 7148.7 7163.1 6993.1 7104.9 7108.3 7117.0 7134.6 1711.1 1737.4 1964.9 1992.9 2035.7 2037.3 2040.2 2045.4 2046.4 2047.4 1981.6 2005.8 2018.0 2023.0 2041.3 1989.0 2011.5 2012.8 2038.1 2039.0 2067.5 2086.4 2086.5 2089.8 2091.1 7047.8 7067.3 7156.1 7160.8 7174.2 4237.8 4333.5 4336.0 4338.4 4343.4 2259.7 2574.3 2690.9 2699.5 2734.6 832.4 840.8 854.7 919.7 923.6 9558.1 9591.7 9592.5 9617.7 9623.5 4033.7 4057.3 4153.3 4162.7 4167.4 8341.0 8350.2 8369.1 8371.8 8373.6 4368.9 4418.6 4442.0 4444.2 4446.3 3966.8 3987.6 3998.4 3998.9 4001.9 2993.1 3044.0 3114.9 3156.9 3349.5 1096.0 1101.8 1106.6 1107.8 1113.4 870.3 870.9 952.9 1021.0 1062.8 6487.1 6493.0 6496.1 6526.3 6526.6 1108.5 1117.3 1144.3 1145.5 1151.9 4945.7 4970.4 4975.2 4983.3 4986.1 8388.7 8408.2 8428.5 8691.3 8697.4 8520.1 8566.1 8575.4 8603.4 8614.1 6579.4 6644.3 6685.1 6751.8 6752.6 6193.1 6193.5 6226.7 6228.3 6236.8 7330.6 7441.9 7456.8 7466.1 7560.0 7692.3 7856.0 7862.5 7895.1 7943.2 5876.8 5940.3 5945.7 5950.6 5953.0 6567.7 6671.6 6747.9 6779.7 6798.4 6331.2 6378.2 6413.7 6420.3 6508.3 6241.8 6256.7 6273.0 6299.5 6442.1 6330.1 6532.7 6533.5 6545.9 6547.4 6035.9 6069.5 6078.7 6078.9 6089.1 5720.9 5737.3 5748.0 5810.5 5861.2 19:01:20 INFO - 2015-12-03 19:01:20,731 DEBUG : BROWSER_OUTPUT: 19:01:20 INFO - 2015-12-03 19:01:20,731 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4668.18 Median:5370.71 stddev:1383.52 (25.8%) stddev-sans-first:1348.08 19:01:20 INFO - 2015-12-03 19:01:20,731 DEBUG : BROWSER_OUTPUT: Values: 304.7 316.1 317.4 320.9 321.9 5218.9 5371.1 5382.9 5409.8 5412.6 5288.0 5367.2 5370.3 5373.4 5386.0 3927.2 4020.8 4044.0 4162.7 4173.1 4106.6 4109.3 4113.4 4118.9 4155.2 4091.2 4099.8 4100.3 4104.0 4108.4 3884.9 3980.0 3988.4 4033.9 4067.5 3555.5 3560.8 3578.3 3601.4 3602.0 5103.4 5137.5 5154.3 5159.1 5165.3 4701.6 4710.7 4711.9 4712.7 4718.5 5453.2 5593.6 5607.2 5613.1 5624.5 3897.0 3900.9 3903.5 3904.4 3907.1 5828.0 5907.8 5929.4 5933.8 5938.3 4015.6 4044.2 4050.0 4051.3 4053.5 3949.5 4105.1 4107.2 4111.6 4124.1 4698.7 4705.0 4707.3 4709.5 4710.7 5628.1 5644.9 5651.4 5653.2 5654.2 1429.9 1451.7 1454.6 1454.9 1455.9 975.9 979.4 985.9 988.5 998.2 4936.3 4970.4 4972.7 4973.7 4979.5 5808.6 5834.4 5843.6 5844.7 5846.0 4940.4 4953.1 4955.5 4957.7 4962.4 2903.3 3023.8 3101.2 3112.1 3154.8 5511.7 5569.4 5572.4 5572.4 5578.6 6014.4 6034.6 6047.3 6053.9 6054.2 5556.1 5566.1 5566.5 5566.6 5569.4 5755.9 5874.7 5876.3 5879.1 5880.9 5738.2 5738.9 5740.2 5742.4 5746.1 5513.9 5545.1 5548.1 5553.3 5563.6 3985.1 4016.4 4039.4 4068.0 4075.9 5878.5 5883.8 5885.8 5886.4 5891.8 5667.0 5667.3 5671.0 5671.6 5673.1 5654.0 5658.9 5661.1 5663.3 5666.7 5346.2 5496.4 5507.1 5509.1 5511.1 5701.5 5706.1 5708.2 5710.7 5711.3 5279.8 5411.3 5463.1 5557.3 5568.2 19:01:20 INFO - 2015-12-03 19:01:20,731 DEBUG : BROWSER_OUTPUT: 19:01:20 INFO - 2015-12-03 19:01:20,731 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12200.21 Median:616.81 stddev:14768.01 (2394.3%) stddev-sans-first:14784.15 19:01:20 INFO - 2015-12-03 19:01:20,731 DEBUG : BROWSER_OUTPUT: Values: 692.6 692.9 701.0 701.7 722.9 11533.5 11903.6 12000.5 12045.0 12047.5 11823.6 11919.7 11926.5 11941.6 11943.2 624.6 790.5 813.4 814.7 816.6 626.8 795.9 807.2 811.8 812.3 827.4 846.2 846.5 846.6 847.7 646.1 655.2 819.4 839.6 839.7 615.7 618.0 618.3 618.3 619.3 11521.2 11721.1 11771.5 11779.4 11787.5 10551.4 10645.9 10647.2 10988.3 11167.8 8873.4 8925.0 8976.6 8993.2 9023.1 3104.7 3163.0 3173.1 3181.5 3205.7 39712.2 39859.0 40016.0 40061.6 40098.0 8024.8 8371.3 8415.4 8621.2 8797.1 16171.7 16245.7 16265.5 16398.3 16456.5 6366.1 6419.8 6444.9 6480.9 6553.7 3660.7 3662.4 3717.9 3734.5 3761.1 2698.4 2732.0 2736.8 2738.8 2739.5 489.4 490.2 492.5 492.7 496.0 455.9 513.6 528.6 532.7 538.6 7085.0 7498.0 7593.9 7664.4 7681.9 519.8 546.6 551.5 560.5 568.8 3324.3 3456.8 3468.3 3500.6 3528.7 53751.5 54212.7 54602.2 54640.5 54660.5 48102.8 48782.8 48902.1 48909.3 49004.0 41384.6 42694.0 42886.1 44363.8 44534.6 6964.8 7052.8 7087.4 7114.9 7294.0 31856.5 31940.0 32722.3 32752.2 32772.8 39730.6 40355.4 40782.8 41369.8 41478.8 8556.1 8591.5 8682.4 8749.9 8810.4 9083.2 9096.7 9211.5 9234.7 9597.6 8757.6 8823.3 8868.5 8911.0 8956.5 8691.8 8698.2 8731.2 8736.0 8747.0 8711.0 8718.0 8863.4 8876.8 8881.3 7326.9 7386.8 7447.3 7675.3 7706.6 7152.7 7535.3 7813.8 8021.4 8524.0 19:01:20 INFO - 2015-12-03 19:01:20,731 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:01:20 INFO - 2015-12-03 19:01:20,731 DEBUG : BROWSER_OUTPUT: 19:01:21 INFO - 2015-12-03 19:01:21,410 INFO : Browser exited with error code: 0 19:01:21 INFO - 2015-12-03 19:01:21,431 INFO : Completed test dromaeo_css (00:18:37) 19:01:21 INFO - 2015-12-03 19:01:21,431 INFO : Starting test kraken 19:01:21 INFO - 2015-12-03 19:01:21,431 DEBUG : operating with platform_type : linux_ 19:01:21 INFO - 2015-12-03 19:01:21,431 INFO : Initialising browser for kraken test... 19:01:21 INFO - 2015-12-03 19:01:21,438 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3mBy0l/profile http://localhost:46527/getInfo.html 19:01:25 INFO - 2015-12-03 19:01:25,577 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:01:25 INFO - 2015-12-03 19:01:25,578 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:01:25 INFO - 2015-12-03 19:01:25,578 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:01:25 INFO - 2015-12-03 19:01:25,578 DEBUG : BROWSER_OUTPUT: __metrics 19:01:25 INFO - 2015-12-03 19:01:25,674 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:01:25 INFO - 2015-12-03 19:01:25,674 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:01:27 INFO - 2015-12-03 19:01:27,010 INFO : Browser initialized. 19:01:27 INFO - 2015-12-03 19:01:27,010 INFO : Running cycle 1/1 for kraken test... 19:01:27 INFO - 2015-12-03 19:01:27,011 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3mBy0l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:01:38 INFO - 2015-12-03 19:01:38,950 DEBUG : BROWSER_OUTPUT: RSS: Main: 141684736 19:01:38 INFO - 2015-12-03 19:01:38,950 DEBUG : BROWSER_OUTPUT: 19:01:41 INFO - 2015-12-03 19:01:41,546 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46527/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46527/tests/kraken/driver.html?testName=audio-beat-detection) 19:01:42 INFO - 2015-12-03 19:01:42,127 DEBUG : BROWSER_OUTPUT: RSS: Main: 181747712 19:01:42 INFO - 2015-12-03 19:01:42,127 DEBUG : BROWSER_OUTPUT: 19:01:44 INFO - 2015-12-03 19:01:44,886 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46527/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46527/tests/kraken/driver.html?testName=audio-dft) 19:01:45 INFO - 2015-12-03 19:01:45,459 DEBUG : BROWSER_OUTPUT: RSS: Main: 169021440 19:01:45 INFO - 2015-12-03 19:01:45,459 DEBUG : BROWSER_OUTPUT: 19:01:48 INFO - 2015-12-03 19:01:48,479 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46527/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46527/tests/kraken/driver.html?testName=audio-fft) 19:01:49 INFO - 2015-12-03 19:01:49,059 DEBUG : BROWSER_OUTPUT: RSS: Main: 151760896 19:01:49 INFO - 2015-12-03 19:01:49,060 DEBUG : BROWSER_OUTPUT: 19:01:51 INFO - 2015-12-03 19:01:51,139 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46527/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46527/tests/kraken/driver.html?testName=audio-oscillator) 19:01:51 INFO - 2015-12-03 19:01:51,712 DEBUG : BROWSER_OUTPUT: RSS: Main: 154939392 19:01:51 INFO - 2015-12-03 19:01:51,712 DEBUG : BROWSER_OUTPUT: 19:01:53 INFO - 2015-12-03 19:01:53,986 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46527/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46527/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:01:54 INFO - 2015-12-03 19:01:54,552 DEBUG : BROWSER_OUTPUT: RSS: Main: 156184576 19:01:54 INFO - 2015-12-03 19:01:54,552 DEBUG : BROWSER_OUTPUT: 19:01:57 INFO - 2015-12-03 19:01:57,611 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46527/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46527/tests/kraken/driver.html?testName=imaging-darkroom) 19:01:58 INFO - 2015-12-03 19:01:58,193 DEBUG : BROWSER_OUTPUT: RSS: Main: 154808320 19:01:58 INFO - 2015-12-03 19:01:58,193 DEBUG : BROWSER_OUTPUT: 19:02:01 INFO - 2015-12-03 19:02:01,607 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46527/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46527/tests/kraken/driver.html?testName=imaging-desaturate) 19:02:02 INFO - 2015-12-03 19:02:02,189 DEBUG : BROWSER_OUTPUT: RSS: Main: 155660288 19:02:02 INFO - 2015-12-03 19:02:02,189 DEBUG : BROWSER_OUTPUT: 19:02:05 INFO - 2015-12-03 19:02:05,090 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46527/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46527/tests/kraken/driver.html?testName=json-parse-financial) 19:02:05 INFO - 2015-12-03 19:02:05,663 DEBUG : BROWSER_OUTPUT: RSS: Main: 157081600 19:02:05 INFO - 2015-12-03 19:02:05,663 DEBUG : BROWSER_OUTPUT: 19:02:07 INFO - 2015-12-03 19:02:07,473 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46527/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46527/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:02:08 INFO - 2015-12-03 19:02:08,039 DEBUG : BROWSER_OUTPUT: RSS: Main: 168976384 19:02:08 INFO - 2015-12-03 19:02:08,039 DEBUG : BROWSER_OUTPUT: 19:02:09 INFO - 2015-12-03 19:02:09,949 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46527/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46527/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:02:10 INFO - 2015-12-03 19:02:10,550 DEBUG : BROWSER_OUTPUT: RSS: Main: 166932480 19:02:10 INFO - 2015-12-03 19:02:10,550 DEBUG : BROWSER_OUTPUT: 19:02:12 INFO - 2015-12-03 19:02:12,715 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46527/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46527/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:02:13 INFO - 2015-12-03 19:02:13,301 DEBUG : BROWSER_OUTPUT: RSS: Main: 179126272 19:02:13 INFO - 2015-12-03 19:02:13,301 DEBUG : BROWSER_OUTPUT: 19:02:15 INFO - 2015-12-03 19:02:15,803 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46527/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46527/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:02:16 INFO - 2015-12-03 19:02:16,389 DEBUG : BROWSER_OUTPUT: RSS: Main: 184483840 19:02:16 INFO - 2015-12-03 19:02:16,390 DEBUG : BROWSER_OUTPUT: 19:02:18 INFO - 2015-12-03 19:02:18,977 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46527/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46527/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:02:19 INFO - 2015-12-03 19:02:19,558 DEBUG : BROWSER_OUTPUT: RSS: Main: 183222272 19:02:19 INFO - 2015-12-03 19:02:19,558 DEBUG : BROWSER_OUTPUT: 19:02:21 INFO - 2015-12-03 19:02:21,333 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46527/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46527/tests/kraken/driver.html?testName=ai-astar) 19:02:21 INFO - 2015-12-03 19:02:21,583 DEBUG : BROWSER_OUTPUT: RSS: Main: 239927296 19:02:21 INFO - 2015-12-03 19:02:21,583 DEBUG : BROWSER_OUTPUT: 19:02:21 INFO - 2015-12-03 19:02:21,586 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:02:21 INFO - 2015-12-03 19:02:21,587 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:02:21 INFO - 2015-12-03 19:02:21,587 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:02:21 INFO - 2015-12-03 19:02:21,587 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:02:21 INFO - 2015-12-03 19:02:21,587 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;112;106;113;114;112;100;112;111;105 19:02:21 INFO - 2015-12-03 19:02:21,587 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;159;132;153;161;136;154;154;139;166;131 19:02:21 INFO - 2015-12-03 19:02:21,587 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;160;161;160;160;162;161;162;162 19:02:21 INFO - 2015-12-03 19:02:21,587 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;84;89;72;74;74;97;88;72 19:02:21 INFO - 2015-12-03 19:02:21,587 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;95;135;95;95;95;126;95;94;131 19:02:21 INFO - 2015-12-03 19:02:21,588 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;113;109;109;109;109;109;109;109 19:02:21 INFO - 2015-12-03 19:02:21,588 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;146;147;147;147;147;147;146;146 19:02:21 INFO - 2015-12-03 19:02:21,588 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;98;95;95;95;95;95;95;95 19:02:21 INFO - 2015-12-03 19:02:21,588 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;71;71;70;70;70;70;82;68;71 19:02:21 INFO - 2015-12-03 19:02:21,588 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;78;68;69;69;69;69;69;68;68 19:02:21 INFO - 2015-12-03 19:02:21,588 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;88;93;84;85;84;86;84;83;86;85 19:02:21 INFO - 2015-12-03 19:02:21,588 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;126;125;125;118;117;117;127;118;126;127 19:02:21 INFO - 2015-12-03 19:02:21,589 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;157;134;146;147;146;134;145;146;152;132 19:02:21 INFO - 2015-12-03 19:02:21,589 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;68;69;68;68;72;70;70;68;69 19:02:21 INFO - 2015-12-03 19:02:21,589 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:02:21 INFO - 2015-12-03 19:02:21,589 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:02:21 INFO - 2015-12-03 19:02:21,589 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1010 19:02:21 INFO - 2015-12-03 19:02:21,589 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:02:21 INFO - 2015-12-03 19:02:21,589 DEBUG : BROWSER_OUTPUT: __startTimestamp1449198141584__endTimestamp 19:02:21 INFO - 2015-12-03 19:02:21,590 DEBUG : BROWSER_OUTPUT: 19:02:21 INFO - 2015-12-03 19:02:21,593 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:02:21 INFO - 2015-12-03 19:02:21,593 DEBUG : BROWSER_OUTPUT: Number of tests: 14 19:02:21 INFO - 2015-12-03 19:02:21,593 DEBUG : BROWSER_OUTPUT: 19:02:21 INFO - 2015-12-03 19:02:21,593 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.60 Median:112.00 stddev:4.45 (4.0%) stddev-sans-first:4.69 19:02:21 INFO - 2015-12-03 19:02:21,593 DEBUG : BROWSER_OUTPUT: Values: 111.0 112.0 106.0 113.0 114.0 112.0 100.0 112.0 111.0 105.0 19:02:21 INFO - 2015-12-03 19:02:21,594 DEBUG : BROWSER_OUTPUT: 19:02:21 INFO - 2015-12-03 19:02:21,594 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.50 Median:154.00 stddev:12.82 (8.3%) stddev-sans-first:13.02 19:02:21 INFO - 2015-12-03 19:02:21,594 DEBUG : BROWSER_OUTPUT: Values: 159.0 132.0 153.0 161.0 136.0 154.0 154.0 139.0 166.0 131.0 19:02:21 INFO - 2015-12-03 19:02:21,594 DEBUG : BROWSER_OUTPUT: 19:02:21 INFO - 2015-12-03 19:02:21,594 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 19:02:21 INFO - 2015-12-03 19:02:21,594 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 160.0 161.0 160.0 160.0 162.0 161.0 162.0 162.0 19:02:21 INFO - 2015-12-03 19:02:21,594 DEBUG : BROWSER_OUTPUT: 19:02:21 INFO - 2015-12-03 19:02:21,595 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.50 Median:79.00 stddev:9.19 (11.6%) stddev-sans-first:9.34 19:02:21 INFO - 2015-12-03 19:02:21,595 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 84.0 89.0 72.0 74.0 74.0 97.0 88.0 72.0 19:02:21 INFO - 2015-12-03 19:02:21,595 DEBUG : BROWSER_OUTPUT: 19:02:21 INFO - 2015-12-03 19:02:21,595 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.50 Median:95.00 stddev:17.50 (18.4%) stddev-sans-first:18.06 19:02:21 INFO - 2015-12-03 19:02:21,595 DEBUG : BROWSER_OUTPUT: Values: 94.0 95.0 135.0 95.0 95.0 95.0 126.0 95.0 94.0 131.0 19:02:21 INFO - 2015-12-03 19:02:21,595 DEBUG : BROWSER_OUTPUT: 19:02:21 INFO - 2015-12-03 19:02:21,596 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.00 stddev:1.26 (1.2%) stddev-sans-first:1.33 19:02:21 INFO - 2015-12-03 19:02:21,596 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 113.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 19:02:21 INFO - 2015-12-03 19:02:21,596 DEBUG : BROWSER_OUTPUT: 19:02:21 INFO - 2015-12-03 19:02:21,596 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 19:02:21 INFO - 2015-12-03 19:02:21,596 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 146.0 147.0 147.0 147.0 147.0 147.0 146.0 146.0 19:02:21 INFO - 2015-12-03 19:02:21,596 DEBUG : BROWSER_OUTPUT: 19:02:21 INFO - 2015-12-03 19:02:21,596 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.95 (1.0%) stddev-sans-first:1.00 19:02:21 INFO - 2015-12-03 19:02:21,596 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 98.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 19:02:21 INFO - 2015-12-03 19:02:21,596 DEBUG : BROWSER_OUTPUT: 19:02:21 INFO - 2015-12-03 19:02:21,596 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.50 Median:71.00 stddev:3.84 (5.4%) stddev-sans-first:4.07 19:02:21 INFO - 2015-12-03 19:02:21,596 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 71.0 70.0 70.0 70.0 70.0 82.0 68.0 71.0 19:02:21 INFO - 2015-12-03 19:02:21,596 DEBUG : BROWSER_OUTPUT: 19:02:21 INFO - 2015-12-03 19:02:21,596 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:69.00 stddev:3.10 (4.5%) stddev-sans-first:3.16 19:02:21 INFO - 2015-12-03 19:02:21,596 DEBUG : BROWSER_OUTPUT: Values: 67.0 78.0 68.0 69.0 69.0 69.0 69.0 69.0 68.0 68.0 19:02:21 INFO - 2015-12-03 19:02:21,596 DEBUG : BROWSER_OUTPUT: 19:02:21 INFO - 2015-12-03 19:02:21,596 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:85.50 stddev:2.90 (3.4%) stddev-sans-first:2.96 19:02:21 INFO - 2015-12-03 19:02:21,597 DEBUG : BROWSER_OUTPUT: Values: 88.0 93.0 84.0 85.0 84.0 86.0 84.0 83.0 86.0 85.0 19:02:21 INFO - 2015-12-03 19:02:21,597 DEBUG : BROWSER_OUTPUT: 19:02:21 INFO - 2015-12-03 19:02:21,597 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.60 Median:125.50 stddev:4.45 (3.5%) stddev-sans-first:4.55 19:02:21 INFO - 2015-12-03 19:02:21,597 DEBUG : BROWSER_OUTPUT: Values: 126.0 125.0 125.0 118.0 117.0 117.0 127.0 118.0 126.0 127.0 19:02:21 INFO - 2015-12-03 19:02:21,597 DEBUG : BROWSER_OUTPUT: 19:02:21 INFO - 2015-12-03 19:02:21,597 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.90 Median:146.00 stddev:8.16 (5.6%) stddev-sans-first:7.14 19:02:21 INFO - 2015-12-03 19:02:21,597 DEBUG : BROWSER_OUTPUT: Values: 157.0 134.0 146.0 147.0 146.0 134.0 145.0 146.0 152.0 132.0 19:02:21 INFO - 2015-12-03 19:02:21,597 DEBUG : BROWSER_OUTPUT: 19:02:21 INFO - 2015-12-03 19:02:21,597 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.50 stddev:1.32 (1.9%) stddev-sans-first:1.36 19:02:21 INFO - 2015-12-03 19:02:21,597 DEBUG : BROWSER_OUTPUT: Values: 70.0 68.0 69.0 68.0 68.0 72.0 70.0 70.0 68.0 69.0 19:02:21 INFO - 2015-12-03 19:02:21,597 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:02:21 INFO - 2015-12-03 19:02:21,597 DEBUG : BROWSER_OUTPUT: 19:02:22 INFO - 2015-12-03 19:02:22,438 INFO : Browser exited with error code: 0 19:02:22 INFO - 2015-12-03 19:02:22,494 INFO : Completed test kraken (00:01:01) 19:02:22 INFO - 2015-12-03 19:02:22,494 INFO : Starting test v8_7 19:02:22 INFO - 2015-12-03 19:02:22,494 DEBUG : operating with platform_type : linux_ 19:02:22 INFO - 2015-12-03 19:02:22,495 INFO : Initialising browser for v8_7 test... 19:02:22 INFO - 2015-12-03 19:02:22,501 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFrM8tO/profile http://localhost:46527/getInfo.html 19:02:27 INFO - 2015-12-03 19:02:27,041 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:02:27 INFO - 2015-12-03 19:02:27,041 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:02:27 INFO - 2015-12-03 19:02:27,041 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:02:27 INFO - 2015-12-03 19:02:27,041 DEBUG : BROWSER_OUTPUT: __metrics 19:02:27 INFO - 2015-12-03 19:02:27,143 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:02:27 INFO - 2015-12-03 19:02:27,144 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:02:27 ERROR - 2015-12-03 19:02:27,220 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 19:02:28 INFO - 2015-12-03 19:02:28,274 INFO : Browser initialized. 19:02:28 INFO - 2015-12-03 19:02:28,274 INFO : Running cycle 1/1 for v8_7 test... 19:02:28 INFO - 2015-12-03 19:02:28,274 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFrM8tO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:02:40 INFO - 2015-12-03 19:02:40,326 DEBUG : BROWSER_OUTPUT: RSS: Main: 141221888 19:02:40 INFO - 2015-12-03 19:02:40,326 DEBUG : BROWSER_OUTPUT: 19:03:01 INFO - 2015-12-03 19:03:01,759 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46527/tests/v8_7/run.html (next: http://localhost:46527/tests/v8_7/run.html) 19:03:02 INFO - 2015-12-03 19:03:02,005 DEBUG : BROWSER_OUTPUT: RSS: Main: 445816832 19:03:02 INFO - 2015-12-03 19:03:02,005 DEBUG : BROWSER_OUTPUT: 19:03:02 INFO - 2015-12-03 19:03:02,007 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:03:02 INFO - 2015-12-03 19:03:02,007 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:03:02 INFO - 2015-12-03 19:03:02,007 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:03:02 INFO - 2015-12-03 19:03:02,007 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:03:02 INFO - 2015-12-03 19:03:02,007 DEBUG : BROWSER_OUTPUT: |0;Richards;165.45334215751157 19:03:02 INFO - 2015-12-03 19:03:02,007 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.49434242255612 19:03:02 INFO - 2015-12-03 19:03:02,008 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.2415136338342 19:03:02 INFO - 2015-12-03 19:03:02,008 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5208.333333333333 19:03:02 INFO - 2015-12-03 19:03:02,008 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1976.2845849802372 19:03:02 INFO - 2015-12-03 19:03:02,008 DEBUG : BROWSER_OUTPUT: |5;Earley;795.5449482895783 19:03:02 INFO - 2015-12-03 19:03:02,008 DEBUG : BROWSER_OUTPUT: |6;Boyer;11976.190476190477 19:03:02 INFO - 2015-12-03 19:03:02,009 DEBUG : BROWSER_OUTPUT: |7;RegExp;26526.315789473683 19:03:02 INFO - 2015-12-03 19:03:02,009 DEBUG : BROWSER_OUTPUT: |8;Splay;611.9585112873704 19:03:02 INFO - 2015-12-03 19:03:02,009 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 19:03:02 INFO - 2015-12-03 19:03:02,009 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:03:02 INFO - 2015-12-03 19:03:02,009 DEBUG : BROWSER_OUTPUT: __startTimestamp1449198182005__endTimestamp 19:03:02 INFO - 2015-12-03 19:03:02,009 DEBUG : BROWSER_OUTPUT: 19:03:02 INFO - 2015-12-03 19:03:02,009 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:03:02 INFO - 2015-12-03 19:03:02,010 DEBUG : BROWSER_OUTPUT: Number of tests: 10 19:03:02 INFO - 2015-12-03 19:03:02,010 DEBUG : BROWSER_OUTPUT: 19:03:02 INFO - 2015-12-03 19:03:02,010 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.45 Median:165.45 stddev:0.00 (0.0%) 19:03:02 INFO - 2015-12-03 19:03:02,010 DEBUG : BROWSER_OUTPUT: Values: 165.5 19:03:02 INFO - 2015-12-03 19:03:02,010 DEBUG : BROWSER_OUTPUT: 19:03:02 INFO - 2015-12-03 19:03:02,010 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.49 Median:185.49 stddev:0.00 (0.0%) 19:03:02 INFO - 2015-12-03 19:03:02,010 DEBUG : BROWSER_OUTPUT: Values: 185.5 19:03:02 INFO - 2015-12-03 19:03:02,010 DEBUG : BROWSER_OUTPUT: 19:03:02 INFO - 2015-12-03 19:03:02,010 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.24 Median:278.24 stddev:0.00 (0.0%) 19:03:02 INFO - 2015-12-03 19:03:02,010 DEBUG : BROWSER_OUTPUT: Values: 278.2 19:03:02 INFO - 2015-12-03 19:03:02,010 DEBUG : BROWSER_OUTPUT: 19:03:02 INFO - 2015-12-03 19:03:02,010 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 19:03:02 INFO - 2015-12-03 19:03:02,011 DEBUG : BROWSER_OUTPUT: Values: 5208.3 19:03:02 INFO - 2015-12-03 19:03:02,012 DEBUG : BROWSER_OUTPUT: 19:03:02 INFO - 2015-12-03 19:03:02,012 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1976.28 Median:1976.28 stddev:0.00 (0.0%) 19:03:02 INFO - 2015-12-03 19:03:02,012 DEBUG : BROWSER_OUTPUT: Values: 1976.3 19:03:02 INFO - 2015-12-03 19:03:02,012 DEBUG : BROWSER_OUTPUT: 19:03:02 INFO - 2015-12-03 19:03:02,012 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:795.54 Median:795.54 stddev:0.00 (0.0%) 19:03:02 INFO - 2015-12-03 19:03:02,012 DEBUG : BROWSER_OUTPUT: Values: 795.5 19:03:02 INFO - 2015-12-03 19:03:02,012 DEBUG : BROWSER_OUTPUT: 19:03:02 INFO - 2015-12-03 19:03:02,012 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11976.19 Median:11976.19 stddev:0.00 (0.0%) 19:03:02 INFO - 2015-12-03 19:03:02,012 DEBUG : BROWSER_OUTPUT: Values: 11976.2 19:03:02 INFO - 2015-12-03 19:03:02,012 DEBUG : BROWSER_OUTPUT: 19:03:02 INFO - 2015-12-03 19:03:02,012 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26526.32 Median:26526.32 stddev:0.00 (0.0%) 19:03:02 INFO - 2015-12-03 19:03:02,013 DEBUG : BROWSER_OUTPUT: Values: 26526.3 19:03:02 INFO - 2015-12-03 19:03:02,013 DEBUG : BROWSER_OUTPUT: 19:03:02 INFO - 2015-12-03 19:03:02,013 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:611.96 Median:611.96 stddev:0.00 (0.0%) 19:03:02 INFO - 2015-12-03 19:03:02,013 DEBUG : BROWSER_OUTPUT: Values: 612.0 19:03:02 INFO - 2015-12-03 19:03:02,013 DEBUG : BROWSER_OUTPUT: 19:03:02 INFO - 2015-12-03 19:03:02,013 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 19:03:02 INFO - 2015-12-03 19:03:02,013 DEBUG : BROWSER_OUTPUT: Values: 4835.7 19:03:02 INFO - 2015-12-03 19:03:02,013 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:03:02 INFO - 2015-12-03 19:03:02,013 DEBUG : BROWSER_OUTPUT: 19:03:02 INFO - 2015-12-03 19:03:02,946 INFO : Browser exited with error code: 0 19:03:02 INFO - 2015-12-03 19:03:02,960 INFO : Completed test v8_7 (00:00:40) 19:03:03 INFO - 2015-12-03 19:03:03,009 INFO : Completed test suite (00:20:19) 19:03:03 INFO - 2015-12-03 19:03:03,009 DEBUG : Working with test: dromaeo_css 19:03:03 INFO - 2015-12-03 19:03:03,010 DEBUG : Generating results file: dromaeo_css 19:03:03 INFO - 2015-12-03 19:03:03,011 DEBUG : Working with test: kraken 19:03:03 INFO - 2015-12-03 19:03:03,011 DEBUG : Generating results file: kraken 19:03:03 INFO - 2015-12-03 19:03:03,011 INFO : javascript benchmark 19:03:03 INFO - 2015-12-03 19:03:03,011 DEBUG : Working with test: v8_7 19:03:03 INFO - 2015-12-03 19:03:03,011 DEBUG : Generating results file: v8_7 19:03:03 INFO - 2015-12-03 19:03:03,012 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:03:03 INFO - 2015-12-03 19:03:03,073 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,141,35]] 19:03:03 INFO - 2015-12-03 19:03:03,073 DEBUG : process_Request line: dromaeo_css 6244.54 graph.html#tests=[[72,141,35]] 19:03:03 INFO - 2015-12-03 19:03:03,073 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:03:03 INFO - 2015-12-03 19:03:03,106 DEBUG : process_Request line: kraken 1517.80 graph.html#tests=[[232,141,35]] 19:03:03 INFO - 2015-12-03 19:03:03,106 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:03:03 INFO - 2015-12-03 19:03:03,140 DEBUG : process_Request line: v8_7 19844.07 graph.html#tests=[[230,141,35]] 19:03:03 INFO - 2015-12-03 19:03:03,142 INFO : javascript benchmark 19:03:03 INFO - 2015-12-03 19:03:03,145 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2614.7254538273482, 2712.755851973322, 2723.0605441122807, 2735.124760076776, 2751.6010178524116, 4414.801333939972, 4523.615492683126, 4636.142313671969, 4696.718196908184, 4721.527847215281, 4567.954320456794, 4588.334691469735, 4650.4186976627925, 4676.719396836193, 4726.810927562902, 4332.133573285348, 4343.153085148398, 4346.478422589294, 4357.847475338363, 4399.604035636792, 4125.174965006996, 4389.012472193763, 4396.340548917672, 4447.9555204448025, 4459.910801783963, 4206.49522057352, 4284.742915425053, 4310.396544483775, 4314.288142456491, 4331.003869110123, 4334.609885110355, 4336.653067754603, 4349.478062632505, 4353.064091220403, 4388.27593447084, 4277.700560960734, 4303.289957157065, 4314.935275970863, 4317.136572685476, 4371.0, 4375.518692943773, 4464.374987501752, 4467.285234362519, 4483.215437298492, 4590.380298659672, 5050.9494905051215, 5071.644984851062, 5074.644774865761, 5082.1106306396605, 5124.692518448867, 5091.79632814687, 5096.923546146811, 5102.438731739506, 5105.081085404626, 5146.305248791403, 4510.188166130095, 4615.538446155358, 4628.375169352162, 4633.374494443275, 4736.8105275788585, 5109.131447653907, 5118.513741194581, 5120.359955005624, 5124.641275110706, 5136.8202112925865, 4896.290037944549, 4930.605551555867, 4930.605551555938, 4930.950690493121, 4961.479044700254, 4827.879303017382, 4899.510048995072, 4926.753662316942, 4929.112759703216, 4932.679375840559, 4942.901141977212, 4971.801127954914, 4976.178930476503, 4978.850634480971, 4982.476839931827, 4959.2561115832195, 4964.925526117111, 4966.155753521838, 4966.503349665005, 5006.123928312531, 3978.085040440657, 4048.9190216196102, 4084.6732261419015, 4165.4584903962295, 4198.727082739612, 3545.5213546170935, 3600.0819790953665, 3640.12636967126, 3642.635736426389, 3671.339158951361, 4336.804843782037, 4339.175556644227, 4369.737815731066, 4372.606465418127, 4374.993751437188, 4790.976045119752, 4922.950770492249, 4929.309896614477, 5030.673006254582, 5044.243363495431, 4223.809928553223, 4297.226499230106, 4303.419038429772, 4322.654187664979, 4335.28467802809, 4452.933206001912, 4456.799444025027, 4471.5528447155675, 4479.193745125908, 4514.367988481616, 4586.587207151372, 4688.109259240733, 4692.0, 4799.1841386965, 4815.15734746411, 4866.7079975201605, 4966.255061740768, 5064.468230835857, 5080.237964305384, 5084.3898732152375, 4810.2063159579675, 4852.078105160008, 4852.880622708573, 4855.878603034952, 4892.730899800403, 5015.473375295687, 5024.723640199824, 5028.321176641107, 5034.521720436553, 5067.721275329893, 4826.6621336506105, 4909.042736666316, 4959.380077490314, 4962.751862406793, 4963.801447942042, 4813.446453657734, 4882.438519570295, 4883.658143930033, 4901.975490122527, 4926.137925863031, 4896.583790377857, 4912.0, 4915.7498955577385, 4918.680285781413, 4958.950410495849, 4601.378813860086, 4727.503612120678, 4800.4479484859685, 4848.127337079219, 4851.1753001990455, 4756.548127927841, 4775.689580177277, 4811.639127065414, 4826.95173048265, 4865.610751139971, 4664.370310008241, 4737.38414006177, 4749.833755818529, 4756.8097276108565, 4798.088363210979], "unit": "ms", "name": "dojo.html", "value": 4584.218066603462}, {"lowerIsBetter": false, "replicates": [574.0929331655984, 581.9621724587902, 583.0117950074623, 588.4321629627409, 590.0411830774989, 27865.58201626977, 37408.25183496332, 37411.81294093533, 37637.81181094098, 37720.622793772054, 40910.18179636406, 41339.966500837494, 41437.58562414375, 41492.0, 41536.16927661445, 6943.930560694379, 7055.682494287769, 7889.250521200491, 8058.35533157346, 8060.798480037987, 10088.495575221246, 10261.486925653724, 10345.0, 10352.17182625392, 10366.067053965142, 10056.245781566375, 10162.9491852541, 10181.490925453734, 10187.490625468734, 10187.796244075114, 7077.3984211342095, 7243.311885370934, 7250.274972502708, 7254.600996945166, 9968.202543796515, 6909.654517274166, 9712.0, 9851.704448866545, 9915.454649994248, 9915.801683966352, 34660.48009279863, 34988.125296867525, 35092.649073509194, 35130.64869351325, 35142.0, 2851.8431486268246, 3072.5391191321255, 3518.9619062376405, 3579.391503444395, 3622.456631505269, 30872.8456357719, 31183.844080779676, 31252.687473125206, 31527.84236078805, 31932.36135277305, 3222.4038552867796, 3275.164832967602, 3281.1140991932284, 3389.915252118692, 3396.5075064115563, 218478.0, 220270.89864550735, 220307.0, 220606.0, 220696.0, 51407.22889156666, 56011.43988560144, 56447.0, 56462.0, 56494.0, 47665.76167119142, 61846.38153618406, 62143.0, 62341.0, 62348.688256558424, 13501.527446539323, 13779.793303100461, 13780.517681881087, 13794.724105517833, 13840.653983650489, 9828.901710982942, 9899.60401583943, 9918.652847150315, 9924.603015879284, 9929.950350248202, 18624.813751862577, 19198.520036998907, 19205.423837284903, 19207.423777286425, 19274.132664030152, 7416.44376671741, 7685.42359323053, 7724.6137693115115, 7768.844623107506, 7844.764657060297, 885.8936927568733, 903.6340282185726, 955.8518429643416, 978.4178413843752, 1037.6160820496464, 26617.201483955512, 26625.600615990777, 26708.332291692474, 26853.462930741276, 26922.0, 957.1816097236763, 979.9804003919882, 998.1066945084254, 1003.7892042670975, 1083.6803143072812, 13885.444582216598, 13927.512537061357, 13978.720425591431, 14130.15219086858, 14241.50154744579, 257961.0, 261421.0, 262192.0, 263281.98821111966, 264205.0, 38949.6105038946, 46392.768036160276, 46864.5313546867, 47025.529744702115, 47062.29406558904, 1077.1221454514546, 1113.4265853085667, 1211.2732360583755, 1221.4015132585148, 1236.023541402282, 26497.735022649525, 26931.596026059233, 29574.556381653863, 30839.537406938463, 31050.0, 37005.0, 37400.0, 42592.78703606462, 43582.78208608937, 44217.33673994957, 189100.0, 190025.0, 190725.0, 191803.0, 192662.0, 38408.0, 38878.41682374823, 39097.0, 39206.80396597999, 39234.607653924235, 42060.15879682328, 42373.57626423697, 42859.571404286806, 43145.568544315414, 43253.56746432495, 35508.0, 36030.63969360378, 36304.0, 36535.634643653226, 36904.0, 35571.50999430015, 36128.4580731284, 36815.0, 36946.815265924575, 37145.25709485849, 35821.46267805933, 38924.0, 39408.80295598504, 39520.2095958085, 39588.40617390799, 28293.29266768265, 31076.446177691476, 31335.0, 31417.37165256728, 31511.321537669555, 23831.880840595684, 23916.613334523507, 23963.400914977265, 24133.93187430589, 24135.15526956548], "unit": "ms", "name": "ext.html", "value": 17540.317342323036}, {"lowerIsBetter": false, "replicates": [335.19051490650077, 335.8597561279456, 336.7407096535667, 337.46006389776363, 339.4687314353039, 12334.629961101182, 12733.108682392212, 14798.852011479881, 15187.620309492268, 15552.533423997284, 8904.91095089049, 9138.634454621808, 9395.436273823558, 13702.862971370283, 16226.269817858225, 4420.049689316805, 4536.092781443708, 4536.886577835564, 4539.0921815637, 4539.841105561306, 3383.8477268522975, 3496.7552271341015, 3497.318022985519, 3501.124718820295, 4427.690061695683, 5102.872428189288, 5305.602079844008, 5307.416184219733, 5319.680819150844, 5320.654157479771, 4663.48701642819, 4831.541003604652, 4833.057553777015, 5346.545543628797, 5381.246625472457, 4540.137373898981, 4664.976675116636, 4667.766611669437, 4678.064387122555, 4678.485366609671, 9980.700578982569, 10232.386056836614, 10240.231982601335, 10261.640842570474, 10269.0, 1855.2115350975782, 1875.7373967644542, 1881.924723011078, 1886.1041005522404, 1922.2503223742751, 8481.0, 8568.057513673491, 8603.440776349516, 8677.6983452482, 9292.0, 1671.3899426709163, 1727.5076603168036, 1732.601501654614, 1759.6920538905767, 1772.8936263824212, 53339.46660533384, 55371.723141384035, 55523.44476555223, 55554.16668749932, 55778.721106394616, 8811.823763524693, 8931.106889311146, 9068.22920051803, 9070.591823367964, 9145.588448519833, 11448.370339631234, 11533.942330288462, 11537.423128843524, 11554.191206615624, 11558.0, 6777.762778302736, 6786.078200235732, 6875.48433867462, 6916.446684265246, 6937.7571784987285, 6841.0, 6855.07456493377, 6901.275366086589, 6905.447564194852, 6941.236463988957, 3670.8531658733887, 3714.591394946554, 3715.628437156263, 3732.1789206374556, 3740.139767853409, 1498.0936533397137, 1516.1282262698771, 1516.6360073582262, 1552.813662360524, 1558.7194305024977, 836.6067948064522, 886.778305423644, 897.8787863638456, 941.8257622339889, 989.6635144051057, 11892.821607675893, 15088.773668394982, 15626.025476566856, 15978.201089945456, 15988.200589970455, 839.5634270179472, 847.326375531454, 867.5618812499647, 899.487292243415, 933.8972713001565, 8803.823923521493, 9318.064541737773, 9343.34596578233, 9364.859527107099, 9842.458664773507, 451330.0, 471011.0, 473225.0, 478237.0, 480892.0, 69985.3001469989, 71400.0, 71675.64162179155, 72787.0, 73837.63081184559, 1065.1372388365603, 1067.7704293576762, 1078.5524007536785, 1101.251149218523, 1111.2554588425612, 14129.717405652034, 14584.635384115481, 14612.561623151323, 14755.409783608535, 14959.476418325306, 33147.50278745773, 33621.327573448885, 33709.325813483105, 34332.485012724326, 34564.65435345614, 39393.40909886411, 39523.20953580855, 40297.59702402938, 41291.58708412998, 41324.1735165289, 8715.08491608372, 9003.279737621106, 9016.0, 9122.224610908148, 9282.62869485213, 15951.521454356387, 16203.837961620233, 16403.83596164023, 16693.83306166923, 16749.74875376895, 13922.860771392561, 13948.02363834522, 14107.858921411065, 14132.78800818009, 14226.71546569042, 13326.0, 13480.191188528719, 13536.0, 13777.931110344383, 13915.860841391457, 11956.0, 13347.733045339233, 13564.389602467716, 13604.183748975092, 13944.093633913762, 8008.479448835807, 8097.878531822145, 8104.79738006531, 8310.127436619068, 8378.24595786382, 10826.0, 13263.403146858222, 13435.865641343853, 13582.25297608641, 13691.589252322447], "unit": "ms", "name": "jquery.html", "value": 7847.010002197191}, {"lowerIsBetter": false, "replicates": [1236.3385588710041, 1597.337105101383, 1666.4750603559874, 1668.6579251253486, 1710.6664200480902, 5976.910346344808, 7016.543924644894, 7132.144142702877, 7148.74979375722, 7163.140423149216, 6993.055937448443, 7104.85790284194, 7108.289171082889, 7117.039199708051, 7134.5719256844495, 1711.0503670462888, 1737.4353335166059, 1964.872283301588, 1992.8704634198803, 2035.6946458031339, 2037.3378651938106, 2040.1941233212872, 2045.3659365596714, 2046.4270004398793, 2047.3550831488108, 1981.6135853508572, 2005.7994200579972, 2017.9899100504551, 2022.9696554551695, 2041.3467690339098, 1988.9502762430911, 2011.4870707969521, 2012.778594354627, 2038.1236068490543, 2038.9694154587694, 2067.4934641012896, 2086.405374468284, 2086.5305306306113, 2089.770125286217, 2091.1217288738767, 7047.753328633473, 7067.328603782633, 7156.105486814148, 7160.785176444663, 7174.246704096047, 4237.8304867805255, 4333.501647310568, 4335.9566404335865, 4338.370936214231, 4343.413639158736, 2259.661050842387, 2574.292069680834, 2690.8923643054254, 2699.5410780167417, 2734.644496215479, 832.4381042796149, 840.8355742624416, 854.662408348705, 919.7010971434311, 923.6305477808863, 9558.091981261769, 9591.712248632552, 9592.472414017226, 9617.663381781604, 9623.470709110927, 4033.6773058155277, 4057.33054046085, 4153.314703073959, 4162.729422587522, 4167.374893765898, 8341.040780310343, 8350.206730360605, 8369.079401265855, 8371.832563348698, 8373.623186956602, 4368.890777730582, 4418.646508279394, 4441.955580444154, 4444.244478438609, 4446.26636604963, 3966.801659916993, 3987.641112299907, 3998.4402183694306, 3998.9200215995515, 4001.8799436016966, 2993.0571869860923, 3044.0411270449736, 3114.859831307597, 3156.889508867179, 3349.531065650811, 1095.956161753521, 1101.8457415961773, 1106.551846502168, 1107.7729065541705, 1113.4154568851256, 870.3341943413294, 870.8780770692108, 952.8713623660856, 1020.994895025535, 1062.7661914378825, 6487.059376390397, 6493.0, 6496.090547323379, 6526.314736952647, 6526.608403495806, 1108.467935391017, 1117.3240189685123, 1144.3019757947645, 1145.5017067575632, 1151.8790526994544, 4945.653804233741, 4970.428400733889, 4975.228839529878, 4983.302337672729, 4986.127427700138, 8388.664453421794, 8408.2432581068, 8428.536430496259, 8691.304695624334, 8697.434666746642, 8520.105388934073, 8566.14338566151, 8575.356848236408, 8603.397762156714, 8614.095519970439, 6579.440747536417, 6644.302348253461, 6685.09751183584, 6751.831204219934, 6752.5948443093575, 6193.071039344134, 6193.473554747897, 6226.719797609027, 6228.252609686867, 6236.812895612958, 7330.64252209014, 7441.888371674538, 7456.813579660335, 7466.066741657293, 7559.962200188964, 7692.269234422721, 7856.0, 7862.488938218998, 7895.1315355309725, 7943.205679432011, 5876.764929402947, 5940.287165540163, 5945.672987985702, 5950.583459157818, 5953.0, 6567.737290508326, 6671.5997040177745, 6747.932520674731, 6779.661016949034, 6798.422134118655, 6331.2085989251345, 6378.202724659418, 6413.679316034087, 6420.3258657842125, 6508.284088750328, 6241.78153764616, 6256.749730010749, 6273.027680709497, 6299.527535434769, 6442.09810626522, 6330.082138090043, 6532.673366331569, 6533.477321814338, 6545.934540654533, 6547.410733034049, 6035.879282414239, 6069.544784141295, 6078.665673388006, 6078.939210607838, 6089.117078023751, 5720.914186287126, 5737.254156959735, 5747.971260143672, 5810.535157187331, 5861.1501332307425], "unit": "ms", "name": "mootools.html", "value": 4060.2464039418796}, {"lowerIsBetter": false, "replicates": [304.65421746317924, 316.14325178765534, 317.4143704864526, 320.9406259841931, 321.91952011997, 5218.921716174255, 5371.113766228567, 5382.865428364288, 5409.756560954756, 5412.592725891267, 5287.973560132194, 5367.221752845835, 5370.301860758106, 5373.435789242132, 5385.973070134643, 3927.175293188434, 4020.798960051986, 4043.9595604043875, 4162.687798415123, 4173.1445053764055, 4106.630403263705, 4109.342505199169, 4113.362428823537, 4118.949667834698, 4155.168966206756, 4091.161311931062, 4099.795010249491, 4100.261952848486, 4104.0, 4108.404281379198, 3884.9417258741, 3979.9801000994953, 3988.441618173458, 4033.9394909076386, 4067.51189857219, 3555.484454754072, 3560.768550044239, 3578.3022310649435, 3601.4237721964623, 3601.963980360189, 5103.438621751604, 5137.486251374833, 5154.278401023859, 5159.071367153911, 5165.276861239429, 4701.623870090384, 4710.670253082286, 4711.905761884743, 4712.670113092085, 4718.504557021532, 5453.23654688344, 5593.552515798767, 5607.158926161068, 5613.07384281593, 5624.465675760796, 3896.980515097435, 3900.941485877714, 3903.4925459690057, 3904.4338570907057, 3907.081835768592, 5828.0, 5907.763689452417, 5929.377415371367, 5933.792317268875, 5938.25771778532, 4015.558288588253, 4044.2315959967514, 4049.9797501012895, 4051.2707712611423, 4053.4527838741983, 3949.526056873136, 4105.0763578195265, 4107.219628270619, 4111.60939710727, 4124.05146816234, 4698.671093023524, 4705.035467729176, 4707.270373092176, 4709.529047095331, 4710.740909249956, 5628.127640215773, 5644.943550564524, 5651.378348381675, 5653.152027195872, 5654.236678048493, 1429.8856091512655, 1451.7459444597152, 1454.6363409147714, 1454.9490767823074, 1455.89080818939, 975.8953840148364, 979.4172467381896, 985.8521221816785, 988.461288597716, 998.1615443027746, 4936.259561065797, 4970.3538539990295, 4972.676776009548, 4973.726445045557, 4979.45226025137, 5808.564357673192, 5834.358220595731, 5843.620164689281, 5844.707764611752, 5846.0, 4940.382452193476, 4953.108440480748, 4955.529224723718, 4957.652964292465, 4962.354893863775, 2903.3177203357195, 3023.818570885754, 3101.2246938265434, 3112.097491727419, 3154.8264845433264, 5511.669299841942, 5569.415211402826, 5572.3870374258795, 5572.414896435897, 5578.609497335147, 6014.368491308437, 6034.607750496204, 6047.334793172748, 6053.909191362045, 6054.212952316171, 5556.111022236423, 5566.137248726535, 5566.4990150886615, 5566.55467562594, 5569.359523654832, 5755.942440575541, 5874.706264686834, 5876.324222714272, 5879.059350503899, 5880.882382352414, 5738.1679656450415, 5738.856528586819, 5740.196372507936, 5742.368339482737, 5746.13807928814, 5513.917291240715, 5545.140503222007, 5548.0845660465575, 5553.250311207935, 5563.58273129525, 3985.063510075072, 4016.4176194451056, 4039.4344791728595, 4067.9593204067583, 4075.8777236682945, 5878.500327472213, 5883.823485295448, 5885.764569417347, 5886.411358864079, 5891.7643294269465, 5667.036603777286, 5667.263255776723, 5671.0359238930305, 5671.602987790815, 5673.120666296731, 5654.038813401814, 5658.943410566007, 5661.094224923992, 5663.263775709132, 5666.744996475086, 5346.198070289488, 5496.422875598005, 5507.063799154073, 5509.090999984957, 5511.063119269654, 5701.458361455655, 5706.115552089433, 5708.229389032427, 5710.65736055838, 5711.343195532567, 5279.841604751864, 5411.2965314508865, 5463.07127788269, 5557.3331200256225, 5568.248286481273], "unit": "ms", "name": "prototype.html", "value": 4227.782209743157}, {"lowerIsBetter": false, "replicates": [692.5636848785265, 692.9467209841044, 700.9719611215552, 701.7438634898264, 722.859042486715, 11533.538658453663, 11903.561282720812, 12000.459979300942, 12045.036397088234, 12047.457864396101, 11823.645290641272, 11919.702007449818, 11926.522939082426, 11941.641750747469, 11943.223690460114, 624.6189824207253, 790.5059337913804, 813.446856137826, 814.7067055859885, 816.5508970066469, 626.7712285015959, 795.9442839001272, 807.2492581898832, 811.7889348769304, 812.3460614205562, 827.3546633625782, 846.2383854530941, 846.4540371460404, 846.6063280574563, 847.7414388611471, 646.1115965547373, 655.2366493035607, 819.4141189049858, 839.5886015852219, 839.6767244610808, 615.6706162203244, 617.9505639548826, 618.2951435363689, 618.3414663383483, 619.3218425823716, 11521.193516453852, 11721.120915931338, 11771.529138834436, 11779.411029448493, 11787.528498860036, 10551.36691798487, 10645.946770266099, 10647.201459890539, 10988.279036475167, 11167.776644467147, 8873.423227490257, 8924.955375223148, 8976.640934362618, 8993.235574976135, 9023.052579479127, 3104.736097431721, 3162.98418507906, 3173.1432513221303, 3181.459151944175, 3205.695458931421, 39712.20575588472, 39858.99999999971, 40016.0, 40061.59938400608, 40098.0, 8024.79938001543, 8371.288440482505, 8415.368847336475, 8621.180987806149, 8797.12028797128, 16171.676566468605, 16245.67508649844, 16265.51203463898, 16398.344066237216, 16456.506304810875, 6366.076918846834, 6419.775307864203, 6444.903326450107, 6480.882045357218, 6553.705083271264, 3660.670539651444, 3662.359087159736, 3717.9256414872093, 3734.477173195755, 3761.1161377076364, 2698.3793727442408, 2731.9726802732116, 2736.781057515394, 2738.7812423471364, 2739.5479745842113, 489.4224814718595, 490.19852541095565, 492.4878126748213, 492.69206745783885, 495.95784358329223, 455.92933095370273, 513.6301862658879, 528.6167528541853, 532.7229840482927, 538.6095081066196, 7084.964575177091, 7497.962510187414, 7593.886091708629, 7664.425168112302, 7681.884771728429, 519.8076711616726, 546.6310240587587, 551.4860863829567, 560.4759549820931, 568.7895478672834, 3324.2852786650988, 3456.809875456874, 3468.2543253200683, 3500.5974312954336, 3528.7177025837873, 53751.46248537464, 54212.72893635585, 54602.18096728552, 54640.45359546433, 54660.453395466335, 48102.759486203046, 48782.75608622005, 48902.13174419093, 48909.266361004615, 49004.0, 41384.58615413868, 42694.0, 42886.142277154286, 44363.778181108886, 44534.55465445369, 6964.756233531802, 7052.788416347517, 7087.433005359662, 7114.893276600958, 7294.0, 31856.5221521682, 31940.0, 32722.345553089282, 32752.181195470304, 32772.83613581917, 39730.60269397269, 40355.394669079404, 40782.79608601938, 41369.79315103405, 41478.792606036775, 8556.144385561644, 8591.484510929364, 8682.392232543662, 8749.91250087491, 8810.427322224035, 9083.18251357381, 9096.681616143404, 9211.539423028687, 9234.676786312446, 9597.616095356108, 8757.562121893752, 8823.29413646894, 8868.512231827053, 8910.955445222733, 8956.507392093497, 8691.782705432162, 8698.173673501007, 8731.170538798804, 8736.0, 8747.0, 8711.041785403473, 8717.953845538575, 8863.379563430499, 8876.778080548038, 8881.289496840109, 7326.890096648448, 7386.778396648109, 7447.255274472726, 7675.270849269311, 7706.576138312446, 7152.749653762094, 7535.284148005931, 7813.843723125392, 8021.438499305226, 8523.95738021306], "unit": "ms", "name": "yui.html", "value": 5473.720333222083}], "name": "dromaeo_css", "value": 6244.536118874924}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 106.0, 113.0, 114.0, 112.0, 100.0, 112.0, 111.0, 105.0], "unit": "ms", "name": "ai-astar", "value": 109.6}, {"lowerIsBetter": true, "replicates": [159.0, 132.0, 153.0, 161.0, 136.0, 154.0, 154.0, 139.0, 166.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.5}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 160.0, 161.0, 160.0, 160.0, 162.0, 161.0, 162.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 160.9}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 84.0, 89.0, 72.0, 74.0, 74.0, 97.0, 88.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 79.5}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 135.0, 95.0, 95.0, 95.0, 126.0, 95.0, 94.0, 131.0], "unit": "ms", "name": "audio-oscillator", "value": 105.5}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 113.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 98.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 71.0, 70.0, 70.0, 70.0, 70.0, 82.0, 68.0, 71.0], "unit": "ms", "name": "json-parse-financial", "value": 71.5}, {"lowerIsBetter": true, "replicates": [67.0, 78.0, 68.0, 69.0, 69.0, 69.0, 69.0, 69.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.4}, {"lowerIsBetter": true, "replicates": [88.0, 93.0, 84.0, 85.0, 84.0, 86.0, 84.0, 83.0, 86.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.8}, {"lowerIsBetter": true, "replicates": [126.0, 125.0, 125.0, 118.0, 117.0, 117.0, 127.0, 118.0, 126.0, 127.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 122.6}, {"lowerIsBetter": true, "replicates": [157.0, 134.0, 146.0, 147.0, 146.0, 134.0, 145.0, 146.0, 152.0, 132.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.9}, {"lowerIsBetter": true, "replicates": [70.0, 68.0, 69.0, 68.0, 68.0, 72.0, 70.0, 70.0, 68.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.2}], "name": "kraken", "value": 1517.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.45334215751157], "unit": "score", "name": "Richards", "value": 213.36528799999996}, {"lowerIsBetter": false, "replicates": [185.49434242255612], "unit": "score", "name": "DeltaBlue", "value": 356.44213800000017}, {"lowerIsBetter": false, "replicates": [278.2415136338342], "unit": "score", "name": "Encrypt", "value": 956.654514}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [1976.2845849802372], "unit": "score", "name": "RayTrace", "value": 374.434434}, {"lowerIsBetter": false, "replicates": [795.5449482895783], "unit": "score", "name": "Earley", "value": 837.743991}, {"lowerIsBetter": false, "replicates": [11976.190476190477], "unit": "score", "name": "Boyer", "value": 55.648998011928406}, {"lowerIsBetter": false, "replicates": [26526.315789473683], "unit": "score", "name": "RegExp", "value": 34.34268849206351}, {"lowerIsBetter": false, "replicates": [611.9585112873704], "unit": "score", "name": "Splay", "value": 133.16425623130613}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19844.071834215523}]} 19:03:03 INFO - RETURN: dromaeo_css: 6244.54 19:03:03 INFO - RETURN: kraken: 1517.80 19:03:03 INFO - RETURN: v8_7: 19844.07 19:03:03 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,141,35]]", "result": "19844.07"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,141,35]]", "result": "1517.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,141,35]]", "result": "6244.54"}}} 19:03:03 INFO - Return code: 0 19:03:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:03:03 ERROR - # TBPL SUCCESS # 19:03:03 INFO - Running post-action listener: _resource_record_post_action 19:03:03 INFO - Running post-run listener: _resource_record_post_run 19:03:04 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 4096; Write bytes: 510595072; Read time: 256; Write time: 676228 19:03:04 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 235671552; Read time: 0; Write time: 431640 19:03:04 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 4096; Write bytes: 274923520; Read time: 256; Write time: 244588 19:03:04 INFO - Running post-run listener: _upload_blobber_files 19:03:04 INFO - Blob upload gear active. 19:03:04 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 19:03:04 INFO - Copying logs to upload dir... 19:03:04 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1268.792104 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-03 19:03:03.165533) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 19:03:03.168948) ========= 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=004b26eee9c3b360c8654f40000001e1-1449196913.67122-1665846561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/sEo2UBSBTzCvRcBqtRCpCw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010054 build_url: 'https://queue.taskcluster.net/v1/task/sEo2UBSBTzCvRcBqtRCpCw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 19:03:03.220327) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 19:03:03.220657) ========= 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=004b26eee9c3b360c8654f40000001e1-1449196913.67122-1665846561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004548 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 19:03:03.270269) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 19:03:03.270588) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 19:03:03.270861) ========= ========= Total master_lag: 0.20 =========