builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-037 starttime: 1449751990.96 results: success (0) buildid: 20151210030842 builduid: d39c74da16b843a88728fca669a9c4ca revision: 412e4d7ce98ca4dbc37de133d0f26d7e1a59946f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-10 04:53:10.960948) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-10 04:53:10.961617) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-10 04:53:10.961895) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1449751990.97621-57362914 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006318 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-10 04:53:11.019376) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-10 04:53:11.019641) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-10 04:53:11.068811) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 04:53:11.069079) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1449751990.97621-57362914 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004617 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 04:53:11.117663) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-10 04:53:11.117923) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-10 04:53:11.118252) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 04:53:11.118534) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1449751990.97621-57362914 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-10 04:53:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2015-12-10 04:53:11 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.186642 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 04:53:11.324611) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 04:53:11.324928) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1449751990.97621-57362914 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017679 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 04:53:11.380453) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 04:53:11.380810) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 412e4d7ce98ca4dbc37de133d0f26d7e1a59946f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 412e4d7ce98ca4dbc37de133d0f26d7e1a59946f --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=6ea65ccfe4e6b94e0d4f826f000001d8-1449751990.97621-57362914 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-10 04:53:11,683 truncating revision to first 12 chars 2015-12-10 04:53:11,683 Setting DEBUG logging. 2015-12-10 04:53:11,683 attempt 1/10 2015-12-10 04:53:11,683 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/412e4d7ce98c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-10 04:53:12,299 unpacking tar archive at: mozilla-central-412e4d7ce98c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.882251 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 04:53:12.275800) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-10 04:53:12.276122) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-10 04:53:12.285552) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-10 04:53:12.285853) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-10 04:53:12.286267) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2015-12-10 04:53:12.286815) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6ea65ccfe4e6b94e0d4f826f000001d8-1449751990.97621-57362914 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:53:12 INFO - MultiFileLogger online at 20151210 04:53:12 in /builds/slave/test 04:53:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:53:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:53:12 INFO - {'append_to_log': False, 04:53:12 INFO - 'base_work_dir': '/builds/slave/test', 04:53:12 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:53:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:53:12 INFO - 'branch': 'Firefox-Non-PGO', 04:53:12 INFO - 'buildbot_json_path': 'buildprops.json', 04:53:12 INFO - 'config_files': ('talos/linux_config.py',), 04:53:12 INFO - 'default_actions': ('clobber', 04:53:12 INFO - 'read-buildbot-config', 04:53:12 INFO - 'download-and-extract', 04:53:12 INFO - 'populate-webroot', 04:53:12 INFO - 'create-virtualenv', 04:53:12 INFO - 'install', 04:53:12 INFO - 'run-tests'), 04:53:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:53:12 INFO - 'download_minidump_stackwalk': True, 04:53:12 INFO - 'download_symbols': 'ondemand', 04:53:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:53:12 INFO - 'tooltool.py': '/tools/tooltool.py', 04:53:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:53:12 INFO - '/tools/misc-python/virtualenv.py')}, 04:53:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:53:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:53:12 INFO - 'installer_path': 'installer.exe', 04:53:12 INFO - 'log_level': 'info', 04:53:12 INFO - 'log_name': 'talos', 04:53:12 INFO - 'log_to_console': True, 04:53:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:53:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:53:12 INFO - 'opt_config_files': (), 04:53:12 INFO - 'pip_index': False, 04:53:12 INFO - 'sps_profile': False, 04:53:12 INFO - 'sps_profile_interval': 0, 04:53:12 INFO - 'suite': 'dromaeojs', 04:53:12 INFO - 'system_bits': '64', 04:53:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:53:12 INFO - 'title': 'talos-linux64-ix-037', 04:53:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:53:12 INFO - 'use_talos_json': True, 04:53:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:53:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:53:12 INFO - 'work_dir': 'build'} 04:53:12 INFO - ##### 04:53:12 INFO - ##### Running clobber step. 04:53:12 INFO - ##### 04:53:12 INFO - Running pre-action listener: _resource_record_pre_action 04:53:12 INFO - Running main action method: clobber 04:53:12 INFO - rmtree: /builds/slave/test/build 04:53:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:53:13 INFO - Running post-action listener: _resource_record_post_action 04:53:13 INFO - ##### 04:53:13 INFO - ##### Running read-buildbot-config step. 04:53:13 INFO - ##### 04:53:13 INFO - Running pre-action listener: _resource_record_pre_action 04:53:13 INFO - Running main action method: read_buildbot_config 04:53:13 INFO - Using buildbot properties: 04:53:13 INFO - { 04:53:13 INFO - "properties": { 04:53:13 INFO - "buildnumber": 342, 04:53:13 INFO - "product": "firefox", 04:53:13 INFO - "script_repo_revision": "production", 04:53:13 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:53:13 INFO - "repository": "", 04:53:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:53:13 INFO - "buildid": "20151210030842", 04:53:13 INFO - "slavename": "talos-linux64-ix-037", 04:53:13 INFO - "pgo_build": "False", 04:53:13 INFO - "basedir": "/builds/slave/test", 04:53:13 INFO - "project": "", 04:53:13 INFO - "platform": "ubuntu64_hw", 04:53:13 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:53:13 INFO - "slavebuilddir": "test", 04:53:13 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:53:13 INFO - "branch": "mozilla-central", 04:53:13 INFO - "repo_path": "mozilla-central", 04:53:13 INFO - "stage_platform": "linux64", 04:53:13 INFO - "builduid": "d39c74da16b843a88728fca669a9c4ca", 04:53:13 INFO - "revision": "412e4d7ce98ca4dbc37de133d0f26d7e1a59946f" 04:53:13 INFO - }, 04:53:13 INFO - "sourcestamp": { 04:53:13 INFO - "repository": "", 04:53:13 INFO - "hasPatch": false, 04:53:13 INFO - "project": "", 04:53:13 INFO - "branch": "mozilla-central-linux64-talos", 04:53:13 INFO - "changes": [ 04:53:13 INFO - { 04:53:13 INFO - "category": null, 04:53:13 INFO - "files": [ 04:53:13 INFO - { 04:53:13 INFO - "url": null, 04:53:13 INFO - "name": "https://queue.taskcluster.net/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 04:53:13 INFO - } 04:53:13 INFO - ], 04:53:13 INFO - "repository": "", 04:53:13 INFO - "rev": "412e4d7ce98ca4dbc37de133d0f26d7e1a59946f", 04:53:13 INFO - "who": "cbook@mozilla.com", 04:53:13 INFO - "when": 1449751914, 04:53:13 INFO - "number": 7238589, 04:53:13 INFO - "comments": "merge mozilla-inbound to mozilla-central a=merge", 04:53:13 INFO - "project": "", 04:53:13 INFO - "at": "Thu 10 Dec 2015 04:51:54", 04:53:13 INFO - "branch": "mozilla-central-linux64-talos", 04:53:13 INFO - "revlink": "", 04:53:13 INFO - "properties": [ 04:53:13 INFO - [ 04:53:13 INFO - "buildid", 04:53:13 INFO - "20151210030842", 04:53:13 INFO - "Change" 04:53:13 INFO - ], 04:53:13 INFO - [ 04:53:13 INFO - "builduid", 04:53:13 INFO - "d39c74da16b843a88728fca669a9c4ca", 04:53:13 INFO - "Change" 04:53:13 INFO - ], 04:53:13 INFO - [ 04:53:13 INFO - "pgo_build", 04:53:13 INFO - "False", 04:53:13 INFO - "Change" 04:53:13 INFO - ] 04:53:13 INFO - ], 04:53:13 INFO - "revision": "412e4d7ce98ca4dbc37de133d0f26d7e1a59946f" 04:53:13 INFO - } 04:53:13 INFO - ], 04:53:13 INFO - "revision": "412e4d7ce98ca4dbc37de133d0f26d7e1a59946f" 04:53:13 INFO - } 04:53:13 INFO - } 04:53:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 04:53:13 INFO - Running post-action listener: _resource_record_post_action 04:53:13 INFO - ##### 04:53:13 INFO - ##### Running download-and-extract step. 04:53:13 INFO - ##### 04:53:13 INFO - Running pre-action listener: _resource_record_pre_action 04:53:13 INFO - Running main action method: download_and_extract 04:53:13 INFO - mkdir: /builds/slave/test/build/tests 04:53:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:13 INFO - https://queue.taskcluster.net/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:53:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/test_packages.json 04:53:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/test_packages.json 04:53:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:53:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:53:21 INFO - Downloaded 1302 bytes. 04:53:21 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:53:21 INFO - Using the following test package requirements: 04:53:21 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:53:21 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:53:21 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:53:21 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:53:21 INFO - u'jsshell-linux-x86_64.zip'], 04:53:21 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:53:21 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:53:21 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:53:21 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:53:21 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:53:21 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:53:21 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:53:21 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:53:21 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:53:21 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:53:21 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:53:21 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:53:21 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:53:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:21 INFO - https://queue.taskcluster.net/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:53:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:53:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:53:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHY71w4zTdq0sy57y7INIw/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 04:53:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHY71w4zTdq0sy57y7INIw/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 04:53:32 INFO - Downloaded 21866764 bytes. 04:53:32 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 04:53:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:53:32 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 04:53:33 INFO - Return code: 0 04:53:33 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 04:53:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:33 INFO - https://queue.taskcluster.net/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:53:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:53:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:53:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHY71w4zTdq0sy57y7INIw/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 04:53:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHY71w4zTdq0sy57y7INIw/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 04:53:34 INFO - Downloaded 21866764 bytes. 04:53:34 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 04:53:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:53:34 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 04:53:36 INFO - Return code: 0 04:53:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:36 INFO - https://queue.taskcluster.net/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:53:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:53:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:53:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHY71w4zTdq0sy57y7INIw/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 04:53:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHY71w4zTdq0sy57y7INIw/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 04:53:36 INFO - Downloaded 11132038 bytes. 04:53:36 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 04:53:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:53:36 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 04:53:37 INFO - Return code: 0 04:53:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:37 INFO - https://queue.taskcluster.net/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:53:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:53:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:53:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHY71w4zTdq0sy57y7INIw/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 04:53:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fHY71w4zTdq0sy57y7INIw/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 04:53:38 INFO - Downloaded 57726826 bytes. 04:53:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:53:38 INFO - mkdir: /builds/slave/test/properties 04:53:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:53:38 INFO - Writing to file /builds/slave/test/properties/build_url 04:53:38 INFO - Contents: 04:53:38 INFO - build_url:https://queue.taskcluster.net/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:53:38 INFO - Running post-action listener: _resource_record_post_action 04:53:38 INFO - Running post-action listener: set_extra_try_arguments 04:53:38 INFO - ##### 04:53:38 INFO - ##### Running populate-webroot step. 04:53:38 INFO - ##### 04:53:38 INFO - Running pre-action listener: _resource_record_pre_action 04:53:38 INFO - Running main action method: populate_webroot 04:53:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:53:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:53:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:53:38 INFO - '--tppagecycles', 04:53:38 INFO - '7'], 04:53:38 INFO - 'tests': ['tsvgm']}}, 04:53:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:53:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:53:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:53:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:53:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:53:38 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:53:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:53:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:38 INFO - 'talos_options': ['--e10s'], 04:53:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:53:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:38 INFO - 'tests': ['damp', 'tps']}, 04:53:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:38 INFO - 'talos_options': ['--e10s'], 04:53:38 INFO - 'tests': ['damp', 'tps']}, 04:53:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:53:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:53:38 INFO - 'other': {'tests': ['a11yr', 04:53:38 INFO - 'ts_paint', 04:53:38 INFO - 'tpaint', 04:53:38 INFO - 'sessionrestore', 04:53:38 INFO - 'sessionrestore_no_auto_restore']}, 04:53:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:53:38 INFO - 'tests': ['a11yr', 04:53:38 INFO - 'ts_paint', 04:53:38 INFO - 'tpaint', 04:53:38 INFO - 'sessionrestore', 04:53:38 INFO - 'sessionrestore_no_auto_restore']}, 04:53:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:53:38 INFO - 'tests': ['a11yr', 04:53:38 INFO - 'ts_paint', 04:53:38 INFO - 'tpaint', 04:53:38 INFO - 'sessionrestore', 04:53:38 INFO - 'sessionrestore_no_auto_restore']}, 04:53:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:53:38 INFO - 'tests': ['a11yr', 04:53:38 INFO - 'ts_paint', 04:53:38 INFO - 'tpaint', 04:53:38 INFO - 'sessionrestore', 04:53:38 INFO - 'sessionrestore_no_auto_restore']}, 04:53:38 INFO - 'other_l64': {'tests': ['a11yr', 04:53:38 INFO - 'ts_paint', 04:53:38 INFO - 'tpaint', 04:53:38 INFO - 'sessionrestore', 04:53:38 INFO - 'sessionrestore_no_auto_restore']}, 04:53:38 INFO - 'other_nol64': {'tests': ['a11yr', 04:53:38 INFO - 'ts_paint', 04:53:38 INFO - 'tpaint', 04:53:38 INFO - 'sessionrestore', 04:53:38 INFO - 'sessionrestore_no_auto_restore']}, 04:53:38 INFO - 'svgr': {'tests': ['tsvgx', 04:53:38 INFO - 'tsvgr_opacity', 04:53:38 INFO - 'tart', 04:53:38 INFO - 'tscrollx', 04:53:38 INFO - 'cart']}, 04:53:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:53:38 INFO - 'tests': ['tsvgx', 04:53:38 INFO - 'tsvgr_opacity', 04:53:38 INFO - 'tart', 04:53:38 INFO - 'tscrollx', 04:53:38 INFO - 'cart']}, 04:53:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:38 INFO - 'tests': ['tp5o']}, 04:53:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:38 INFO - 'talos_options': ['--e10s'], 04:53:38 INFO - 'tests': ['tp5o']}, 04:53:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:38 INFO - 'talos_options': ['--xperf_path', 04:53:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:53:38 INFO - 'tests': ['tp5n']}, 04:53:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:38 INFO - 'talos_options': ['--e10s', 04:53:38 INFO - '--xperf_path', 04:53:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:53:38 INFO - 'tests': ['tp5n']}}, 04:53:38 INFO - 'talos.zip': {'path': '', 04:53:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:53:38 INFO - Running post-action listener: _resource_record_post_action 04:53:38 INFO - ##### 04:53:38 INFO - ##### Running create-virtualenv step. 04:53:38 INFO - ##### 04:53:38 INFO - Running pre-action listener: _resource_record_pre_action 04:53:38 INFO - Running main action method: create_virtualenv 04:53:38 INFO - Creating virtualenv /builds/slave/test/build/venv 04:53:38 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:53:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:53:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:53:38 INFO - Using real prefix '/usr' 04:53:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:53:38 INFO - Installing distribute.............................................................................................................................................................................................done. 04:53:40 INFO - Installing pip.................done. 04:53:40 INFO - Return code: 0 04:53:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:53:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:40 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 0x7f640b60af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2795240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28240b0>, '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 0x2824fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2825440>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1449751990.97621-57362914', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:53:40 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 04:53:40 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 04:53:40 INFO - Using env: {'DISPLAY': ':0', 04:53:40 INFO - 'HOME': '/home/cltbld', 04:53:40 INFO - 'LANG': 'en_US.UTF-8', 04:53:40 INFO - 'LANGUAGE': 'en_US:en', 04:53:40 INFO - 'LOGNAME': 'cltbld', 04:53:40 INFO - 'MAIL': '/var/mail/cltbld', 04:53:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:40 INFO - 'MOZ_NO_REMOTE': '1', 04:53:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:40 INFO - 'NO_EM_RESTART': '1', 04:53:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:40 INFO - 'PWD': '/builds/slave/test', 04:53:40 INFO - 'SHELL': '/bin/bash', 04:53:40 INFO - 'SHLVL': '1', 04:53:40 INFO - 'TERM': 'linux', 04:53:40 INFO - 'TMOUT': '86400', 04:53:40 INFO - 'USER': 'cltbld', 04:53:40 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1449751990.97621-57362914', 04:53:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:40 INFO - '_': '/tools/buildbot/bin/python'} 04:53:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:53:41 INFO - Cleaning up... 04:53:41 INFO - Return code: 0 04:53:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:53:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:41 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 0x7f640b60af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2795240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28240b0>, '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 0x2824fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2825440>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1449751990.97621-57362914', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:53:41 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 04:53:41 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 04:53:41 INFO - Using env: {'DISPLAY': ':0', 04:53:41 INFO - 'HOME': '/home/cltbld', 04:53:41 INFO - 'LANG': 'en_US.UTF-8', 04:53:41 INFO - 'LANGUAGE': 'en_US:en', 04:53:41 INFO - 'LOGNAME': 'cltbld', 04:53:41 INFO - 'MAIL': '/var/mail/cltbld', 04:53:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:41 INFO - 'MOZ_NO_REMOTE': '1', 04:53:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:41 INFO - 'NO_EM_RESTART': '1', 04:53:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:41 INFO - 'PWD': '/builds/slave/test', 04:53:41 INFO - 'SHELL': '/bin/bash', 04:53:41 INFO - 'SHLVL': '1', 04:53:41 INFO - 'TERM': 'linux', 04:53:41 INFO - 'TMOUT': '86400', 04:53:41 INFO - 'USER': 'cltbld', 04:53:41 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1449751990.97621-57362914', 04:53:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:41 INFO - '_': '/tools/buildbot/bin/python'} 04:53:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:41 INFO - Downloading/unpacking psutil>=0.7.1 04:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:43 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:53:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:53:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:53:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:53:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:53:43 INFO - Installing collected packages: psutil 04:53:43 INFO - Running setup.py install for psutil 04:53:43 INFO - building 'psutil._psutil_linux' extension 04:53:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:53:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:53:43 INFO - building 'psutil._psutil_posix' extension 04:53:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:53:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:53:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:53:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:53:44 INFO - Successfully installed psutil 04:53:44 INFO - Cleaning up... 04:53:44 INFO - Return code: 0 04:53:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:44 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 0x7f640b60af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2795240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28240b0>, '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 0x2824fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2825440>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1449751990.97621-57362914', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:53:44 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 04:53:44 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 04:53:44 INFO - Using env: {'DISPLAY': ':0', 04:53:44 INFO - 'HOME': '/home/cltbld', 04:53:44 INFO - 'LANG': 'en_US.UTF-8', 04:53:44 INFO - 'LANGUAGE': 'en_US:en', 04:53:44 INFO - 'LOGNAME': 'cltbld', 04:53:44 INFO - 'MAIL': '/var/mail/cltbld', 04:53:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:44 INFO - 'MOZ_NO_REMOTE': '1', 04:53:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:44 INFO - 'NO_EM_RESTART': '1', 04:53:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:44 INFO - 'PWD': '/builds/slave/test', 04:53:44 INFO - 'SHELL': '/bin/bash', 04:53:44 INFO - 'SHLVL': '1', 04:53:44 INFO - 'TERM': 'linux', 04:53:44 INFO - 'TMOUT': '86400', 04:53:44 INFO - 'USER': 'cltbld', 04:53:44 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1449751990.97621-57362914', 04:53:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:44 INFO - '_': '/tools/buildbot/bin/python'} 04:53:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:53:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:53:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:53:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:53:46 INFO - Installing collected packages: mozsystemmonitor 04:53:46 INFO - Running setup.py install for mozsystemmonitor 04:53:46 INFO - Successfully installed mozsystemmonitor 04:53:46 INFO - Cleaning up... 04:53:46 INFO - Return code: 0 04:53:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:53:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:46 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 0x7f640b60af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2795240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28240b0>, '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 0x2824fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2825440>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1449751990.97621-57362914', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:53:46 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 04:53:46 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 04:53:46 INFO - Using env: {'DISPLAY': ':0', 04:53:46 INFO - 'HOME': '/home/cltbld', 04:53:46 INFO - 'LANG': 'en_US.UTF-8', 04:53:46 INFO - 'LANGUAGE': 'en_US:en', 04:53:46 INFO - 'LOGNAME': 'cltbld', 04:53:46 INFO - 'MAIL': '/var/mail/cltbld', 04:53:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:46 INFO - 'MOZ_NO_REMOTE': '1', 04:53:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:46 INFO - 'NO_EM_RESTART': '1', 04:53:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:46 INFO - 'PWD': '/builds/slave/test', 04:53:46 INFO - 'SHELL': '/bin/bash', 04:53:46 INFO - 'SHLVL': '1', 04:53:46 INFO - 'TERM': 'linux', 04:53:46 INFO - 'TMOUT': '86400', 04:53:46 INFO - 'USER': 'cltbld', 04:53:46 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1449751990.97621-57362914', 04:53:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:46 INFO - '_': '/tools/buildbot/bin/python'} 04:53:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:46 INFO - Downloading/unpacking blobuploader==1.2.4 04:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:48 INFO - Downloading blobuploader-1.2.4.tar.gz 04:53:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:53:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:53:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:53:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:53:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:48 INFO - Downloading docopt-0.6.1.tar.gz 04:53:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:53:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:53:48 INFO - Installing collected packages: blobuploader, requests, docopt 04:53:48 INFO - Running setup.py install for blobuploader 04:53:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:53:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:53:48 INFO - Running setup.py install for requests 04:53:49 INFO - Running setup.py install for docopt 04:53:49 INFO - Successfully installed blobuploader requests docopt 04:53:49 INFO - Cleaning up... 04:53:49 INFO - Return code: 0 04:53:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:49 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 0x7f640b60af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2795240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28240b0>, '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 0x2824fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2825440>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1449751990.97621-57362914', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:53:49 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 04:53:49 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 04:53:49 INFO - Using env: {'DISPLAY': ':0', 04:53:49 INFO - 'HOME': '/home/cltbld', 04:53:49 INFO - 'LANG': 'en_US.UTF-8', 04:53:49 INFO - 'LANGUAGE': 'en_US:en', 04:53:49 INFO - 'LOGNAME': 'cltbld', 04:53:49 INFO - 'MAIL': '/var/mail/cltbld', 04:53:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:49 INFO - 'MOZ_NO_REMOTE': '1', 04:53:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:49 INFO - 'NO_EM_RESTART': '1', 04:53:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:49 INFO - 'PWD': '/builds/slave/test', 04:53:49 INFO - 'SHELL': '/bin/bash', 04:53:49 INFO - 'SHLVL': '1', 04:53:49 INFO - 'TERM': 'linux', 04:53:49 INFO - 'TMOUT': '86400', 04:53:49 INFO - 'USER': 'cltbld', 04:53:49 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1449751990.97621-57362914', 04:53:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:49 INFO - '_': '/tools/buildbot/bin/python'} 04:53:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:53:49 INFO - Running setup.py (path:/tmp/pip-GKdy1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:53:49 INFO - Running setup.py (path:/tmp/pip-HNZT8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:53:49 INFO - Running setup.py (path:/tmp/pip-2HYvUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:53:49 INFO - Running setup.py (path:/tmp/pip-6QPmFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:53:49 INFO - Running setup.py (path:/tmp/pip-dmqvvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:53:50 INFO - Running setup.py (path:/tmp/pip-RJ_Uhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:53:50 INFO - Running setup.py (path:/tmp/pip-xXZdIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:53:50 INFO - Running setup.py (path:/tmp/pip-A8bSA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:53:50 INFO - Running setup.py (path:/tmp/pip-Q08gvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:53:50 INFO - Running setup.py (path:/tmp/pip-RbUxHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:53:50 INFO - Running setup.py (path:/tmp/pip-mWQd7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:53:50 INFO - Running setup.py (path:/tmp/pip-W3H2K4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:53:50 INFO - Running setup.py (path:/tmp/pip-3TLBFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:53:50 INFO - Running setup.py (path:/tmp/pip-Mstpy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:50 INFO - Running setup.py (path:/tmp/pip-plQQ2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:53:50 INFO - Running setup.py (path:/tmp/pip-7W5qiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:53:50 INFO - Running setup.py (path:/tmp/pip-Hmks_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:53:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:53:50 INFO - Running setup.py install for manifestparser 04:53:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:53:50 INFO - Running setup.py install for mozcrash 04:53:51 INFO - Running setup.py install for mozdebug 04:53:51 INFO - Running setup.py install for mozdevice 04:53:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:53:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:53:51 INFO - Running setup.py install for mozfile 04:53:51 INFO - Running setup.py install for mozhttpd 04:53:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:53:51 INFO - Running setup.py install for mozinfo 04:53:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:53:51 INFO - Running setup.py install for mozInstall 04:53:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:53:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:53:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:53:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:53:51 INFO - Running setup.py install for mozleak 04:53:51 INFO - Running setup.py install for mozlog 04:53:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:53:51 INFO - Running setup.py install for moznetwork 04:53:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:53:51 INFO - Running setup.py install for mozprocess 04:53:52 INFO - Running setup.py install for mozprofile 04:53:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:53:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:53:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:53:52 INFO - Running setup.py install for mozrunner 04:53:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:53:52 INFO - Running setup.py install for mozscreenshot 04:53:52 INFO - Running setup.py install for moztest 04:53:52 INFO - Running setup.py install for mozversion 04:53:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:53:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:53:52 INFO - Cleaning up... 04:53:52 INFO - Return code: 0 04:53:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:52 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 0x7f640b60af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2795240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28240b0>, '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 0x2824fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2825440>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1449751990.97621-57362914', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:53:52 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 04:53:52 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 04:53:52 INFO - Using env: {'DISPLAY': ':0', 04:53:52 INFO - 'HOME': '/home/cltbld', 04:53:52 INFO - 'LANG': 'en_US.UTF-8', 04:53:52 INFO - 'LANGUAGE': 'en_US:en', 04:53:52 INFO - 'LOGNAME': 'cltbld', 04:53:52 INFO - 'MAIL': '/var/mail/cltbld', 04:53:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:52 INFO - 'MOZ_NO_REMOTE': '1', 04:53:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:52 INFO - 'NO_EM_RESTART': '1', 04:53:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:52 INFO - 'PWD': '/builds/slave/test', 04:53:52 INFO - 'SHELL': '/bin/bash', 04:53:52 INFO - 'SHLVL': '1', 04:53:52 INFO - 'TERM': 'linux', 04:53:52 INFO - 'TMOUT': '86400', 04:53:52 INFO - 'USER': 'cltbld', 04:53:52 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1449751990.97621-57362914', 04:53:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:52 INFO - '_': '/tools/buildbot/bin/python'} 04:53:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:53:52 INFO - Running setup.py (path:/tmp/pip-a0ox2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:53:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:53:52 INFO - Running setup.py (path:/tmp/pip-TFxEM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:53:53 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)) 04:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:53:53 INFO - Running setup.py (path:/tmp/pip-zchaJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:53:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:53:53 INFO - Running setup.py (path:/tmp/pip-aL0qZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:53:53 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)) 04:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:53:53 INFO - Running setup.py (path:/tmp/pip-BGsoXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:53:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:53:53 INFO - Running setup.py (path:/tmp/pip-PNMrEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:53:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:53:53 INFO - Running setup.py (path:/tmp/pip-Ci87Ro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:53:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:53:53 INFO - Running setup.py (path:/tmp/pip-LMkh9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:53:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:53:53 INFO - Running setup.py (path:/tmp/pip-SCaVQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:53:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:53:53 INFO - Running setup.py (path:/tmp/pip-PaCWWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:53:53 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)) 04:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:53:53 INFO - Running setup.py (path:/tmp/pip-DrdNjB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:53:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:53:53 INFO - Running setup.py (path:/tmp/pip-wXt7QC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:53:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:53:53 INFO - Running setup.py (path:/tmp/pip-3NYYtu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:53:53 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)) 04:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:53:53 INFO - Running setup.py (path:/tmp/pip-ibeBv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:53:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:53 INFO - Running setup.py (path:/tmp/pip-5tUVSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:53:53 INFO - Running setup.py (path:/tmp/pip-Oot0wM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:53:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:53:54 INFO - Running setup.py (path:/tmp/pip-OWEfn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:53:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:53:54 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)) 04:53:54 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)) 04:53:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:53:54 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)) 04:53:54 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)) 04:53:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:53:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:55 INFO - Downloading blessings-1.5.1.tar.gz 04:53:55 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 04:53:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:53:55 INFO - Installing collected packages: blessings 04:53:55 INFO - Running setup.py install for blessings 04:53:55 INFO - Successfully installed blessings 04:53:55 INFO - Cleaning up... 04:53:56 INFO - Return code: 0 04:53:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:53:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:53:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:53:56 INFO - Reading from file tmpfile_stdout 04:53:56 INFO - Current package versions: 04:53:56 INFO - argparse == 1.2.1 04:53:56 INFO - blessings == 1.5.1 04:53:56 INFO - blobuploader == 1.2.4 04:53:56 INFO - docopt == 0.6.1 04:53:56 INFO - manifestparser == 1.1 04:53:56 INFO - mozInstall == 1.12 04:53:56 INFO - mozcrash == 0.16 04:53:56 INFO - mozdebug == 0.1 04:53:56 INFO - mozdevice == 0.47 04:53:56 INFO - mozfile == 1.2 04:53:56 INFO - mozhttpd == 0.7 04:53:56 INFO - mozinfo == 0.9 04:53:56 INFO - mozleak == 0.1 04:53:56 INFO - mozlog == 3.1 04:53:56 INFO - moznetwork == 0.27 04:53:56 INFO - mozprocess == 0.22 04:53:56 INFO - mozprofile == 0.27 04:53:56 INFO - mozrunner == 6.11 04:53:56 INFO - mozscreenshot == 0.1 04:53:56 INFO - mozsystemmonitor == 0.0 04:53:56 INFO - moztest == 0.7 04:53:56 INFO - mozversion == 1.4 04:53:56 INFO - psutil == 3.1.1 04:53:56 INFO - requests == 1.2.3 04:53:56 INFO - wsgiref == 0.1.2 04:53:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53: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')]} 04:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53: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')]} 04:53:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:56 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 0x7f640b60af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2795240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28240b0>, '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 0x2824fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2825440>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1449751990.97621-57362914', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:53:56 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 04:53:56 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 04:53:56 INFO - Using env: {'DISPLAY': ':0', 04:53:56 INFO - 'HOME': '/home/cltbld', 04:53:56 INFO - 'LANG': 'en_US.UTF-8', 04:53:56 INFO - 'LANGUAGE': 'en_US:en', 04:53:56 INFO - 'LOGNAME': 'cltbld', 04:53:56 INFO - 'MAIL': '/var/mail/cltbld', 04:53:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:56 INFO - 'MOZ_NO_REMOTE': '1', 04:53:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:56 INFO - 'NO_EM_RESTART': '1', 04:53:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:56 INFO - 'PWD': '/builds/slave/test', 04:53:56 INFO - 'SHELL': '/bin/bash', 04:53:56 INFO - 'SHLVL': '1', 04:53:56 INFO - 'TERM': 'linux', 04:53:56 INFO - 'TMOUT': '86400', 04:53:56 INFO - 'USER': 'cltbld', 04:53:56 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1449751990.97621-57362914', 04:53:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:56 INFO - '_': '/tools/buildbot/bin/python'} 04:53:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:56 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)) 04:53:56 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)) 04:53:56 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)) 04:53:56 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)) 04:53:56 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)) 04:53:56 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)) 04:53:56 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)) 04:53:56 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)) 04:53:56 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)) 04:53:56 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)) 04:53:56 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)) 04:53:56 INFO - Cleaning up... 04:53:56 INFO - Return code: 0 04:53:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:53: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')]} 04:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53: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')]} 04:53:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:56 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 0x7f640b60af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2795240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28240b0>, '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 0x2824fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2825440>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1449751990.97621-57362914', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:53:56 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 04:53:56 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 04:53:56 INFO - Using env: {'DISPLAY': ':0', 04:53:56 INFO - 'HOME': '/home/cltbld', 04:53:56 INFO - 'LANG': 'en_US.UTF-8', 04:53:56 INFO - 'LANGUAGE': 'en_US:en', 04:53:56 INFO - 'LOGNAME': 'cltbld', 04:53:56 INFO - 'MAIL': '/var/mail/cltbld', 04:53:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:56 INFO - 'MOZ_NO_REMOTE': '1', 04:53:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:56 INFO - 'NO_EM_RESTART': '1', 04:53:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:56 INFO - 'PWD': '/builds/slave/test', 04:53:56 INFO - 'SHELL': '/bin/bash', 04:53:56 INFO - 'SHLVL': '1', 04:53:56 INFO - 'TERM': 'linux', 04:53:56 INFO - 'TMOUT': '86400', 04:53:56 INFO - 'USER': 'cltbld', 04:53:56 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1449751990.97621-57362914', 04:53:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:56 INFO - '_': '/tools/buildbot/bin/python'} 04:53:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:56 INFO - Downloading/unpacking jsonschema 04:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:53:58 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 04:53:58 INFO - Downloading/unpacking functools32 (from jsonschema) 04:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:58 INFO - Downloading functools32-3.2.3-2.tar.gz 04:53:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:53:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:53:58 INFO - warning: no files found matching '*.txt' 04:53:58 INFO - no previously-included directories found matching 'build' 04:53:58 INFO - no previously-included directories found matching 'dist' 04:53:58 INFO - no previously-included directories found matching '.git*' 04:53:58 INFO - Installing collected packages: jsonschema, functools32 04:53:58 INFO - Running setup.py install for functools32 04:53:58 INFO - warning: no files found matching '*.txt' 04:53:58 INFO - no previously-included directories found matching 'build' 04:53:58 INFO - no previously-included directories found matching 'dist' 04:53:58 INFO - no previously-included directories found matching '.git*' 04:53:58 INFO - Successfully installed jsonschema functools32 04:53:58 INFO - Cleaning up... 04:53:58 INFO - Return code: 0 04:53:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:53: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')]} 04:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53: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')]} 04:53:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:58 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 0x7f640b60af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2795240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28240b0>, '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 0x2824fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2825440>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1449751990.97621-57362914', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:53:58 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 04:53:58 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 04:53:58 INFO - Using env: {'DISPLAY': ':0', 04:53:58 INFO - 'HOME': '/home/cltbld', 04:53:58 INFO - 'LANG': 'en_US.UTF-8', 04:53:58 INFO - 'LANGUAGE': 'en_US:en', 04:53:58 INFO - 'LOGNAME': 'cltbld', 04:53:58 INFO - 'MAIL': '/var/mail/cltbld', 04:53:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:58 INFO - 'MOZ_NO_REMOTE': '1', 04:53:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:58 INFO - 'NO_EM_RESTART': '1', 04:53:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:58 INFO - 'PWD': '/builds/slave/test', 04:53:58 INFO - 'SHELL': '/bin/bash', 04:53:58 INFO - 'SHLVL': '1', 04:53:58 INFO - 'TERM': 'linux', 04:53:58 INFO - 'TMOUT': '86400', 04:53:58 INFO - 'USER': 'cltbld', 04:53:58 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1449751990.97621-57362914', 04:53:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:58 INFO - '_': '/tools/buildbot/bin/python'} 04:53:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:58 INFO - Downloading/unpacking flake8 04:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:54:00 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 04:54:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:54:00 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 04:54:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:01 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 04:54:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:54:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:54:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:54:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:54:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:54:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:54:01 INFO - no previously-included directories found matching 'docs/_build' 04:54:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:54:01 INFO - Running setup.py install for pep8 04:54:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:54:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:54:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:54:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:54:01 INFO - no previously-included directories found matching 'docs/_build' 04:54:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:54:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:54:01 INFO - Cleaning up... 04:54:01 INFO - Return code: 0 04:54:01 INFO - Running post-action listener: _resource_record_post_action 04:54:01 INFO - Running post-action listener: _start_resource_monitoring 04:54:01 INFO - Starting resource monitoring. 04:54:01 INFO - ##### 04:54:01 INFO - ##### Running install step. 04:54:01 INFO - ##### 04:54:01 INFO - Running pre-action listener: _resource_record_pre_action 04:54:01 INFO - Running main action method: install 04:54:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:54:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:54:01 INFO - Reading from file tmpfile_stdout 04:54:01 INFO - Detecting whether we're running mozinstall >=1.0... 04:54:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:54:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:54:01 INFO - Reading from file tmpfile_stdout 04:54:01 INFO - Output received: 04:54:01 INFO - Usage: mozinstall [options] installer 04:54:01 INFO - Options: 04:54:01 INFO - -h, --help show this help message and exit 04:54:01 INFO - -d DEST, --destination=DEST 04:54:01 INFO - Directory to install application into. [default: 04:54:01 INFO - "/builds/slave/test"] 04:54:01 INFO - --app=APP Application being installed. [default: firefox] 04:54:01 INFO - mkdir: /builds/slave/test/build/application 04:54:01 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'] 04:54:01 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 04:54:16 INFO - Reading from file tmpfile_stdout 04:54:16 INFO - Output received: 04:54:16 INFO - /builds/slave/test/build/application/firefox/firefox 04:54:16 INFO - Running post-action listener: _resource_record_post_action 04:54:16 INFO - ##### 04:54:16 INFO - ##### Running run-tests step. 04:54:16 INFO - ##### 04:54:16 INFO - Running pre-action listener: _resource_record_pre_action 04:54:16 INFO - Running main action method: run_tests 04:54:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:54:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:54:16 INFO - Python 2.7.3 04:54:16 INFO - Return code: 0 04:54:16 INFO - grabbing minidump binary from tooltool 04:54:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:16 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 0x28240b0>, '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 0x2824fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2825440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:54:16 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:54:16 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:54:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:54:16 INFO - Return code: 0 04:54:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:54:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:54:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:54:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:54:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:54:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:54:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:54:17 INFO - Return code: 0 04:54:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost'] in /builds/slave/test/build 04:54:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --webServer localhost 04:54:17 INFO - Using env: {'DISPLAY': ':0', 04:54:17 INFO - 'HOME': '/home/cltbld', 04:54:17 INFO - 'LANG': 'en_US.UTF-8', 04:54:17 INFO - 'LANGUAGE': 'en_US:en', 04:54:17 INFO - 'LOGNAME': 'cltbld', 04:54:17 INFO - 'MAIL': '/var/mail/cltbld', 04:54:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:54:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:54:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:17 INFO - 'MOZ_NO_REMOTE': '1', 04:54:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:54:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:17 INFO - 'NO_EM_RESTART': '1', 04:54:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:17 INFO - 'PWD': '/builds/slave/test', 04:54:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:54:17 INFO - 'SHELL': '/bin/bash', 04:54:17 INFO - 'SHLVL': '1', 04:54:17 INFO - 'TERM': 'linux', 04:54:17 INFO - 'TMOUT': '86400', 04:54:17 INFO - 'USER': 'cltbld', 04:54:17 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1449751990.97621-57362914', 04:54:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:17 INFO - '_': '/tools/buildbot/bin/python'} 04:54:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost'] with output_timeout 3600 04:54:17 INFO - mozversion INFO | application_buildid: 20151210030842 04:54:17 INFO - mozversion INFO | application_changeset: 412e4d7ce98ca4dbc37de133d0f26d7e1a59946f 04:54:17 INFO - mozversion INFO | application_display_name: Nightly 04:54:17 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:54:17 INFO - mozversion INFO | application_name: Firefox 04:54:17 INFO - mozversion INFO | application_remotingname: firefox 04:54:17 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 04:54:17 INFO - mozversion INFO | application_vendor: Mozilla 04:54:17 INFO - mozversion INFO | application_version: 45.0a1 04:54:17 INFO - mozversion INFO | platform_buildid: 20151210030842 04:54:17 INFO - mozversion INFO | platform_changeset: 412e4d7ce98ca4dbc37de133d0f26d7e1a59946f 04:54:17 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 04:54:17 INFO - mozversion INFO | platform_version: 45.0a1 04:54:17 INFO - 2015-12-10 04:54:17,587 DEBUG : using testdate: 1449752057 04:54:17 INFO - 2015-12-10 04:54:17,587 DEBUG : actual date: 1449752057 04:54:17 INFO - 2015-12-10 04:54:17,602 INFO : starting webserver on 'localhost:47693' 04:54:17 INFO - 2015-12-10 04:54:17,603 INFO : Starting test suite talos-linux64-ix-037 04:54:17 INFO - 2015-12-10 04:54:17,603 INFO : Starting test dromaeo_css 04:54:17 INFO - 2015-12-10 04:54:17,603 DEBUG : operating with platform_type : linux_ 04:54:17 INFO - 2015-12-10 04:54:17,604 INFO : Initialising browser for dromaeo_css test... 04:54:17 INFO - 2015-12-10 04:54:17,620 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiPoM2a/profile http://localhost:47693/getInfo.html 04:54:22 INFO - 2015-12-10 04:54:22,343 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:54:22 INFO - 2015-12-10 04:54:22,343 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:54:22 INFO - 2015-12-10 04:54:22,343 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:54:22 INFO - 2015-12-10 04:54:22,343 DEBUG : BROWSER_OUTPUT: __metrics 04:54:22 INFO - 2015-12-10 04:54:22,432 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] 04:54:22 INFO - 2015-12-10 04:54:22,528 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] 04:54:23 INFO - 2015-12-10 04:54:23,740 INFO : Browser initialized. 04:54:23 INFO - 2015-12-10 04:54:23,740 INFO : Running cycle 1/1 for dromaeo_css test... 04:54:23 INFO - 2015-12-10 04:54:23,741 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiPoM2a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:54:35 INFO - 2015-12-10 04:54:35,722 DEBUG : BROWSER_OUTPUT: RSS: Main: 142860288 04:54:35 INFO - 2015-12-10 04:54:35,722 DEBUG : BROWSER_OUTPUT: 04:55:26 INFO - 2015-12-10 04:55:26,945 DEBUG : BROWSER_OUTPUT: 1449752126937 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:57:39 INFO - 2015-12-10 04:57:39,042 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47693/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47693/tests/dromaeo/cssquery-ext.html) 04:57:40 INFO - 2015-12-10 04:57:40,111 DEBUG : BROWSER_OUTPUT: RSS: Main: 250765312 04:57:40 INFO - 2015-12-10 04:57:40,111 DEBUG : BROWSER_OUTPUT: 05:00:42 INFO - 2015-12-10 05:00:42,722 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47693/tests/dromaeo/cssquery-ext.html (next: http://localhost:47693/tests/dromaeo/cssquery-jquery.html) 05:00:43 INFO - 2015-12-10 05:00:43,308 DEBUG : BROWSER_OUTPUT: RSS: Main: 224780288 05:00:43 INFO - 2015-12-10 05:00:43,308 DEBUG : BROWSER_OUTPUT: 05:03:45 INFO - 2015-12-10 05:03:45,397 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47693/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47693/tests/dromaeo/cssquery-mootools.html) 05:03:45 INFO - 2015-12-10 05:03:45,966 DEBUG : BROWSER_OUTPUT: RSS: Main: 221044736 05:03:45 INFO - 2015-12-10 05:03:45,966 DEBUG : BROWSER_OUTPUT: 05:06:47 INFO - 2015-12-10 05:06:47,863 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47693/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47693/tests/dromaeo/cssquery-prototype.html) 05:06:48 INFO - 2015-12-10 05:06:48,464 DEBUG : BROWSER_OUTPUT: RSS: Main: 209297408 05:06:48 INFO - 2015-12-10 05:06:48,464 DEBUG : BROWSER_OUTPUT: 05:09:51 INFO - 2015-12-10 05:09:51,214 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47693/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47693/tests/dromaeo/cssquery-yui.html) 05:09:51 INFO - 2015-12-10 05:09:51,796 DEBUG : BROWSER_OUTPUT: RSS: Main: 209309696 05:09:51 INFO - 2015-12-10 05:09:51,796 DEBUG : BROWSER_OUTPUT: 05:12:54 INFO - 2015-12-10 05:12:54,306 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47693/tests/dromaeo/cssquery-yui.html (next: http://localhost:47693/tests/dromaeo/cssquery-dojo.html) 05:12:54 INFO - 2015-12-10 05:12:54,556 DEBUG : BROWSER_OUTPUT: RSS: Main: 250843136 05:12:54 INFO - 2015-12-10 05:12:54,556 DEBUG : BROWSER_OUTPUT: 05:12:54 INFO - 2015-12-10 05:12:54,556 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:12:54 INFO - 2015-12-10 05:12:54,556 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:12:54 INFO - 2015-12-10 05:12:54,556 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:12:54 INFO - 2015-12-10 05:12:54,557 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:12:54 INFO - 2015-12-10 05:12:54,558 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2609.895604175833;2689.193242027391;2693.138195777352;2704.0941284669634;2722.3330284080403;4429.51275359711;4578.198815207334;4618.445786505616;4694.999999999995;4707.082118986799;4548.408706868111;4611.12388646157;4700;4704.529547045294;4707.62339012879;4277.059047009669;4310.439642846425;4316.935245971313;4326.156399502099;4384.539623339551;4108.4453598764085;4348.956510434887;4362.956370436303;4404.14119246747;4416.97791511042;4146.170765846812;4229.70392072555;4245.957540424618;4247.8300867965245;4250.872473825791;4332.1119170569955;4335.349697545394;4338.761368124752;4347.891302717426;4373.475182978063;4335.436393268887;4338.544452832439;4346.804393802255;4360.040791025969;4390.868273951786;4353.760543170124;4476.61948734358;4482;4500.684952053358;4608.308753686941;4932.8520144395725;4958.2562615607585;4960.131976904027;4962.131626965267;4962.6526143169995;4880.487548807359;4920.827771027997;4934.555889969884;4993.251012348177;5023.849284521433;4641.953580464152;4642.535746425364;4649.907001859944;4651.744154071558;4691;4916.901661966741;5111.565516931102;5114.15616423286;5115.104856650071;5115.38615366151;4767.833125840648;4817.879553011203;4826.927596086061;4830.975845120822;4833.492483289274;4989.501049895054;5039.571636410873;5040.47075057121;5059.8988020239385;5085.542301192911;4974.850754477371;4997.85006449807;4997.900041999213;4999.325091112653;5019.372578427697;4729.95270047302;4884.242942343943;4962.528559786814;4983.8504844854715;5018.473060328686;4045.3122969095325;4100.384942258685;4121.196366708523;4123.278426275389;4162.042730172077;3630.528031355907;3632.800195989193;3646.0520264731363;3647.635236476331;3677.043968568138;4114.485689288839;4221.430106935586;4334.7399156050105;4342.218400687843;4378.408914796461;4879.219324907997;4928.211486162197;4954.157793175169;4976.751162441936;4987;4283.87148385549;4311.267084595626;4313.547077556874;4319.67602429819;4341;4414.448193975753;4416.492103408085;4421.624161946206;4457.732536047847;4458;4617.722936623813;4720.4807471177455;4765;4768.189407800752;4824.035192961352;4967.329410529533;4970.577500912318;4975.353204083446;4976.8755781105765;4999.800007999639;4758.04839032188;4762.119007983534;4765.618750500021;4768.928466073081;4802.927956080592;4680.3213534036695;4770.737609431515;4817.0125124350125;4856.4415092263425;4897.8285759998225;4902.85291441243;4973.602111830973;4991.301217829579;4994.1759609663995;5024.447310795883;4808.951910480991;4862.756862156949;4870.878228044327;4871.098846713369;4913.65604407688;4668.696534725232;4802.039592081528;4803.351547541177;4864.221724524059;4907.2393778964315;4658.976705116453;4725.763711814464;4736.4316282046375;4740.19416699155;4781.258904869751;4863.173260545645;4865.343178670976;4866.610671146371;4888.5111488850835;4907.828226012072;4547.840825571089;4650.232711602548;4654.813807447799;4747.098051370229;4803.615710743202 05:12:54 INFO - 2015-12-10 05:12:54,559 DEBUG : BROWSER_OUTPUT: |1;ext.html;553.1785298831237;563.6618029182489;574.752856271803;575.2665351676612;580.5645765675744;26419.867900660494;27164.185074447774;35141.99999999997;35968.280634387294;35991.460128098035;39693.60306396935;40190.39714404279;40270.798646006726;40298.395524067164;40339.19321613566;7088.291170882896;7975.641096150687;8065.758027259162;8133.10535841057;8133.75598732039;7266.636668166597;9751.366161199534;9890.258230632695;9938.055884690979;9987.201023918069;9661.37201081931;9768.462734549597;9779.21766258701;9781.951090244538;9795.755106122333;7341.972123902658;7530.77407677765;9681.564329605184;9788.804223915517;9978.201743860474;9791.216702663769;9955.452450115241;9982.800343993153;9988.952264785701;9991.950040249825;37031.62968370336;37528.62471375278;37543.24913501742;37666.24667506662;37706.05734856623;2609.0085767408455;2650.403659176689;2696.5685490321453;2957.54158105494;3013.789034767567;24548.509029819303;24857;24904.875475622506;24945.501089978097;25073.62389564158;3359.227377703142;3380.3408335374365;3382.9830850845588;3430.9656903430896;3496.772709773882;216148;216474;216650.91674541685;216789;217481;53904.46095538994;54074.45925540773;54200.18699719507;54259;54280.185797213075;48343.51656483461;49419.258711119364;57183.428165718644;57477.97654164252;57585.13622295669;13680.863191368158;14366.784498232535;14390.784138237936;14414.711705765825;14431.855681443261;8917.821643567222;8931.285497160212;8939.553022348857;8942.105789421006;8968.103189681111;18324.450266492026;18409.631807363778;18479.260829566934;18485.7227141593;18548.44354669362;6932.722691092401;7150.856982860418;7159.964200178966;7217.314355136254;7294.416446684252;848.4909054567211;853.8335024670254;858.1632907914733;873.5937788928179;1002.8295189817749;22227.444313892283;24449.633255501183;24482.38794030128;24517.50964980726;24559.263222103367;906.4833045164193;926.5552534783342;936.4334577580602;988.367444835306;1051.4795176387738;11510.456165395266;12906.612801615967;12931.870681293067;12950.611481655566;12965.416556254992;244256;246935;247451;248645;248722;37305;37687.81156094202;42956;43675.56324436778;43710.56289437129;1128.9040431563244;1170.7014711248748;1179.7817403780327;1182.2729021651794;1194.2297218294325;23788;23791.286261412184;25518.362040949123;25585.23244302674;25722.35694107662;33030.834845825615;36163.63836361708;36625;41012.58987410088;41946;195320;195844;197902;198624;199031;27196.864015680585;27597.172084837486;27600.585991209748;27604.723952761018;27611.723882760914;36476.63523364732;36749.26501470009;36896.26207475889;37465.25069498649;37626.2474750498;32379.51430728588;32593.185170369983;33141;33482.49776253407;33533;32591.674083258862;32888.50667239945;32904.67095329016;33031.83484082564;33134.33731325408;32260.19349516281;32606.673933260365;32910.17724556905;33070.83464582662;33074.66925330812;28100.71899280981;29399.11802645924;30002.83439664632;30055.248618784706;30279.243018924702;22866.740649651005;23284.41788955222;24761.504769904863;25050.74949250484;25541 05:12:54 INFO - 2015-12-10 05:12:54,560 DEBUG : BROWSER_OUTPUT: |2;jquery.html;340.82277215847745;342.7326685185556;343.2054793153849;345.2887052671496;345.6439866937056;12611.243325400483;13006.154599950996;15395.307211175495;15496.767548486767;16002.439914602977;13067.411966461508;15678.294476748546;16436.424725134624;16622.75065874013;16638.168091595402;4902.8774280643;5002.124628190052;5027.321311622939;5031.6729412588065;5034.521720436553;3762.6613604775566;3867.7099217558657;4950.455449900508;4981.850544483671;4982.800687972477;5519.337679478468;5661.264035675356;5712.428757124296;5714;5715.057015592443;5533.059379905426;5674.035413979634;5680.147977803321;5683.54531637468;5688.63023903445;5040.16837221858;5057.671251368649;5084.847454576332;5088.338515992934;5094.312267843868;19384.607693653554;19954.70067948982;20293.086811093537;20536.07587658544;20551.79448205514;1832.5235438785878;1839.7700287464068;1894.1287007976348;1901.1824915286422;2027.290448343083;12792.737129531739;12965.546205882843;13086.411111500005;13103.737925241441;13417.865821341758;1770.3184274054581;1777.79555351135;1799.7930238022534;1830.6338732253469;1878.7181922711702;54399;55864.16203756988;56410;57171.42828571744;57746;9544.95227523858;9680;9705.854412183822;9776.902230977741;9863.80272394548;12318.938405308096;12421.565245216374;12434;12437.689057773629;12440.564580239648;6590.406863382319;6931.2375638679705;6965.930340696629;6968.930310696828;7066.692661857573;6238.719257633417;6291.591046581958;6298.559100862987;6305.747770089145;6332.620042797447;5702.45826646468;5805.390434004453;5810.94189058104;5830.300363956268;5861.384554621789;1564.5853848730096;1661.1860188507544;1688.7044767165942;1729.9048552329743;1742.5643589102724;857.5797859049021;868.6568805321863;961.8653388525612;980.0787259975742;1008.8436292374694;13518;16165.757513637305;16309.673806523802;16605.169741513117;16865.662686746196;729.6570611812546;773.3001633521559;789.5183937797939;840.0255703384167;875.4834647557972;8264.586770661443;9024.142706442877;9187.63249470027;9300.793860677679;9327;470514;483411;484208;487005;492726;72448;73709;73853.26146738572;74229.62885185647;75234.62382688052;1026.897310268982;1047.314009323894;1049.8582691336571;1062.2882668612049;1067.0556557446716;14154;14483.928580312559;14537.41850325975;14653.413863445343;14825.25873706332;33868.83065584656;33932;33954.15114622154;35016.299674006885;35027.47458788171;40757.388639171026;41362.79318603388;43198;43409.34885976776;43463;8431.873521897054;8609.268212201783;8624.827503449771;8664.826703466022;8699.347548933729;11270.605528806453;16026.198690065683;16030.519084427486;16271;16279;13476.056676032584;13495.932520337336;13545.86454135446;13645.317734113452;13923.930380348034;13801.447942082204;14029.649258768612;14151.43394264218;14272.286385680882;14644.780328295297;14006.579802605938;14226.644333891321;14577.85422145765;14579.271036448346;14934.327955242257;8987.640494380152;9124.087591240823;9276.07239276067;9319.534023298944;9394.06059394055;9876.555555000186;9997.150242229201;10594.735131621772;13901;13940.860591393955 05:12:54 INFO - 2015-12-10 05:12:54,561 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1413.1026797983277;1638.2136574444266;1696.787901512311;1726.6460375622992;1727.0414919719558;5824.4175582441785;6771.492138089645;6853.177618685752;6859.588424694522;6867.278935711754;6804;6885.7245710171655;6952.2352541220425;6990.231074581792;7032.4374050076;1928.6142771445732;1964.4499540128786;1965.272849045855;1967.2721093195537;1967.6753335699593;2047.1504325704814;2069.1826728442256;2079.1475495047034;2091.456221382444;2096.350131459245;2037.5822956293923;2058.7220725202055;2086.5618220173783;2089.185217765073;2089.2269860151764;2074.771775104745;2106.8096525463066;2107.051826678001;2107.71545841311;2123.437289118385;2013.224908410258;2026.4832467720785;2026.9594608107902;2029.6143732690741;2075.4707549574764;6993.47548933832;7061.540999834994;7074.787756367317;7078.292170782932;7078.575285482888;4092.3656833190903;4163.479565054368;4170.270202714543;4171.728837625545;4174.582541745832;2575.8712064396705;2598.649182360376;2615.777658898996;2617.450335429562;2631.5526360518566;794.964226609804;795.8925545051402;798.9600519973978;799.5762246009624;851.2296371783546;9530.237580993504;9538.761530961781;9553.904460955371;9556.856647150298;9563.282753793494;3720.4605332227216;3724.944125838115;3770.170562476251;3781.5840257571645;3783;8010.959945200237;8037.156098609678;8048.5975701215875;8060.435769496079;8105.189481051848;4151.8546850860075;4174.478190226222;4185.6232939035635;4205.074883525619;4205.558416366299;3228.2090887732656;3313.784604000732;3663.725220608465;3808.5620153682125;3852.5954774748807;3359.983200083984;3418.265073009315;3426.7258619310396;3446.276281980762;3469.7397695172963;1071.2929466552039;1071.3625392891217;1075.6289080267295;1080.6325849211305;1083.030687534652;794.5034353529045;852.7313896122702;857.6740838481337;936.9156775890066;1067.754416484213;6704.865902682017;6776.288489708608;6793.082933803873;6796.35434633709;6799.762008329685;1022.1822541966397;1029.4183786160795;1037.3101887245048;1045.268312181476;1058.7776566921034;5083.440821509631;5141.485851414828;5141.614378921521;5153.3558305211845;5159.974200128975;8242.29940455056;8328.6668533258;8496;8520.488770673779;8529.616167272363;8321.375896807764;8415.789605259917;8429.831403371898;8434.198751118634;8440.915590844013;6536.313687062885;6608.702608382634;6621.337866213436;6662.966685166543;6671.966640166768;6205.968970155121;6234.064890266496;6259;6284.183056202664;6284.497240220863;7390.7413240536325;7521.435892308208;7608.695652174072;7642.121156066901;7722.034745656793;7741.535507869546;7874.13384527713;7882.408819338458;7929.881051784112;8074.434789564909;6066.787662431793;6099.4815440688035;6117.571769976059;6118.326984031842;6133.877322453615;6813.965930170318;6833.829154271183;6837.62393068386;6926.905842962251;6950;6214.471769899609;6236.781712640036;6269.028300613412;6291.02489114188;6328.114064030948;5530.391656917655;5773.16289138081;6260.843478912881;6262.906056409249;6403.807885763435;6450.225972883284;6478.5141114415665;6497.155369801895;6505.577137486048;6511.055896895018;5734.827955161351;5774.42255774436;5778.017736984639;5779.826605201851;5782.595218334676;5968.283805943314;5987.910181347196;6000.189974353581;6003.489703375262;6013.639181649115 05:12:54 INFO - 2015-12-10 05:12:54,562 DEBUG : BROWSER_OUTPUT: |4;prototype.html;310.38388798235496;316.52837272464035;320.8139279218053;320.82194382117916;322.51622566150775;5111.361079865017;5282.392524859642;5292.364916210051;5309.814156504528;5322.175062865253;5146.150885103953;5213.218017297408;5238.816641417541;5239.161734122541;5245.8950820983555;3840.923181536368;3907.5310962684375;3925.1757131002523;4053.088055187589;4074.633283004536;3992.2614316351423;4027.899302517446;4032.1532478179615;4048.4534587830562;4054.108096218827;4004.1190937993597;4004.299247631667;4005.3591425371947;4007.9599204008023;4010.8596199133035;3799.4490798834154;3876.089119057019;3928.823202955874;3966.365381538969;4008.318585840414;3489.2846966372085;3497.178163131662;3500.474928760681;3506.1234691327168;3511.859525618998;4887.14474966883;4910.631702622282;4910.680805747651;4917.041176970492;4924.089043526959;4574.268117101281;4581.198290299184;4583.770811459413;4584.106099310636;4588.770561471946;5226.764795584208;5376.91934620981;5383.67697938125;5436.565074794007;5440.564754819645;3819.9045023874623;3821.1593449441357;3822.120912190184;3823.3118038753014;3825.387937929918;5644.57665675076;5710.514606258473;5713.314402271712;5726.3700992890745;5728.341240757324;3933.6263055009726;3939.153082087365;3942.172143849766;3942.290387730236;3946.3291240489184;3906.511686039245;3989.4813674222746;3998.420229066769;4010.3382941814857;4013.618706222904;4571.26859702446;4579.862604121881;4587.518310577408;4590.173768721662;4590.311453281967;5413.512783849473;5415.404305526389;5433.538149257357;5442.319710036246;5446.509814116748;1380.5306195893445;1403.2843249942603;1404.3259235566984;1415.1367665723901;1415.7097794952217;942.2462030375672;943.7451887990342;951.5194826612517;969.8690676758547;971.0871780526282;4811.08589368019;4823.517648235148;4829.73436460998;4830.082284365959;4830.203016502308;5613.298337707786;5616.775328986876;5617;5622.128570071645;5628.127640215773;4788.353572267699;4819.49395313487;4827.637927155477;4832.63755218353;4836.153673107192;2804.467151241258;2912.577676236976;2981.5229563269772;3005.3838963012968;3033.8634761435787;5342.412334643186;5420.674759514442;5436.429174936575;5440.129579267377;5441.347038355423;5810.970945145247;5818.883622327529;5819.476247137778;5821.79623713168;5832.075415113002;5429.049916264638;5431.945680543144;5436.103042997861;5437.374701909331;5437.8368648940595;5516.834494965157;5656.773729050792;5659.801906933238;5660.405657406078;5668.149777533238;5534.142207957773;5548.167774833807;5549.361823390362;5551.9722401387735;5552.500274975271;5394.32570928634;5425.050616142238;5432.9185062223305;5433.293671822637;5436;3950.3284441645565;3950.767816183847;3950.861719839907;3951.6641085508054;3952.9407058894717;5507.366652834975;5656.43435656431;5660.971695141498;5662.348829884616;5664.631798933056;5446.101393270066;5447.101228297287;5456.399796022513;5456.48163424474;5456.972715136399;5441;5449.073657478159;5456.290682211287;5457.918131227955;5460.453954604666;5204.453532379046;5344.812931547377;5347;5352.732363381738;5352.759125839269;5480.753366098455;5491.368492623399;5494.2582751329655;5498.5876059296515;5506.311711036121;5122.847359344118;5212.218167274939;5296.470352964827;5357.142857142839;5366.6243362964215 05:12:54 INFO - 2015-12-10 05:12:54,563 DEBUG : BROWSER_OUTPUT: |5;yui.html;707.7133760826866;727.6980053277887;745.7613563659631;755.2221212151483;796.80079980005;11618;11675.065994720424;11681.532738690463;11704.707382315446;11709.063274938006;11206.551737930493;11858.881411185885;11966.222195557304;11970.760584788299;11982.340971246578;643.8358218654237;652.448680864671;807.2169995104754;810.1979040749675;820.1634332980386;810.8378324335127;816.873384625381;822.7655118291289;824.4929368438397;825.7110011495959;861.5261606116642;870.843248215321;871.5511511571545;871.7646235516406;872.2498651159997;661.216458496683;671.8186089755764;838.1450920061503;854.1287886355944;857.3312816003527;629.3894921925724;630.2405601250482;632.1434456311723;634.6160572853404;634.8127302445789;11404.885951140466;11422.71443213918;11440.370779607118;11469.770604587862;11490.597829076025;10690.66366704162;11471.541138354456;11584.884151158549;11661.416929153509;11663.59177428786;9096.090390960917;9151.725448236564;9175.403598766126;9280.35037547372;9326;3129.4836352001894;3145.056483055097;3167.984160079208;3172.159377764894;3173.3177366866003;36594.26811463756;37138.257234855155;37175.25649487022;37213.25573488515;37269.25461490782;9140.54297285133;9197.954010229905;9228.5847136879;9550.952245238868;9566.61733530665;15672.294746736196;15747.921260393625;15776.447824326093;15800.841991580168;15805.68388632221;6215.098810672517;6406.2953075161695;6413.390727880844;6550.115734375799;6575.605463672195;3552.0942159749616;3646.033801042726;3647.872324468684;3650.178709790276;3656.2321912398693;2551.1708694674303;2596.7533084356955;2597.8830952607177;2603.127952136018;2604.1666666666865;462.3503976912443;465.3438651501367;465.4205514134924;472.5817651378555;475.2064053031377;386.4222986634999;415.8523724077969;427.3952357414286;438.8683394981493;459.39360044740624;7064.788056358318;7228.96385518069;7283.672234749449;7297.452691048193;7368.852622947511;393.0723492557562;442.3850847322225;473.6707987948343;484.056090623286;516.628027819969;3273.1489812648883;3435.1927297085167;3459;3546.095745584911;3555.4311310190246;49232.507674922796;49298.26052609214;49360;49430;49457.50542494601;38279;38443.42334864979;43021.56978430238;43346;43384;39688.80155599204;39794.20411591752;40192.59807401947;41019.9999999994;41046;7331.816704582428;7669.5398276103615;7763.340116090196;7892.84214315699;7949.562774047483;29735.70264297416;30242.54636180503;30674.07977760671;31042.844785775927;31077.844610776803;38440.80779596196;38446.423303649906;38509.614903850605;38652;38877;9612.66355677548;9770.267229957924;9893.466438203028;10098.747531311776;10467.738306542398;10224.64213752515;10347.741306467398;10394.376337419477;10728.463576820972;10942.56229750833;10639.521221544894;10781.676549703521;10902.78194436091;11069.391183484986;11158.776824463628;10147.391156530632;10227.59089636436;10253.692389228336;10322.845157322496;10344.896551034695;8293.637716328669;9680.661176858775;10033.899661003588;10238.18094552449;10822.729431764268;8299.460535065202;8325.014278973853;8411.074781774123;8493.193146651058;8525.87211191845;8562.657493700432;8727.694530691395;8905.910940890508;8968.327375446737;9259.583318750538 05:12:54 INFO - 2015-12-10 05:12:54,563 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:12:54 INFO - 2015-12-10 05:12:54,563 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:12:54 INFO - 2015-12-10 05:12:54,563 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,900 05:12:54 INFO - 2015-12-10 05:12:54,563 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:12:54 INFO - 2015-12-10 05:12:54,563 DEBUG : BROWSER_OUTPUT: __startTimestamp1449753174555__endTimestamp 05:12:54 INFO - 2015-12-10 05:12:54,564 DEBUG : BROWSER_OUTPUT: 05:12:54 INFO - 2015-12-10 05:12:54,564 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:12:54 INFO - 2015-12-10 05:12:54,564 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:12:54 INFO - 2015-12-10 05:12:54,564 DEBUG : BROWSER_OUTPUT: 05:12:54 INFO - 2015-12-10 05:12:54,564 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4587.02 Median:4720.48 stddev:470.21 (10.0%) stddev-sans-first:445.33 05:12:54 INFO - 2015-12-10 05:12:54,564 DEBUG : BROWSER_OUTPUT: Values: 2609.9 2689.2 2693.1 2704.1 2722.3 4429.5 4578.2 4618.4 4695.0 4707.1 4548.4 4611.1 4700.0 4704.5 4707.6 4277.1 4310.4 4316.9 4326.2 4384.5 4108.4 4349.0 4363.0 4404.1 4417.0 4146.2 4229.7 4246.0 4247.8 4250.9 4332.1 4335.3 4338.8 4347.9 4373.5 4335.4 4338.5 4346.8 4360.0 4390.9 4353.8 4476.6 4482.0 4500.7 4608.3 4932.9 4958.3 4960.1 4962.1 4962.7 4880.5 4920.8 4934.6 4993.3 5023.8 4642.0 4642.5 4649.9 4651.7 4691.0 4916.9 5111.6 5114.2 5115.1 5115.4 4767.8 4817.9 4826.9 4831.0 4833.5 4989.5 5039.6 5040.5 5059.9 5085.5 4974.9 4997.9 4997.9 4999.3 5019.4 4730.0 4884.2 4962.5 4983.9 5018.5 4045.3 4100.4 4121.2 4123.3 4162.0 3630.5 3632.8 3646.1 3647.6 3677.0 4114.5 4221.4 4334.7 4342.2 4378.4 4879.2 4928.2 4954.2 4976.8 4987.0 4283.9 4311.3 4313.5 4319.7 4341.0 4414.4 4416.5 4421.6 4457.7 4458.0 4617.7 4720.5 4765.0 4768.2 4824.0 4967.3 4970.6 4975.4 4976.9 4999.8 4758.0 4762.1 4765.6 4768.9 4802.9 4680.3 4770.7 4817.0 4856.4 4897.8 4902.9 4973.6 4991.3 4994.2 5024.4 4809.0 4862.8 4870.9 4871.1 4913.7 4668.7 4802.0 4803.4 4864.2 4907.2 4659.0 4725.8 4736.4 4740.2 4781.3 4863.2 4865.3 4866.6 4888.5 4907.8 4547.8 4650.2 4654.8 4747.1 4803.6 05:12:54 INFO - 2015-12-10 05:12:54,564 DEBUG : BROWSER_OUTPUT: 05:12:54 INFO - 2015-12-10 05:12:54,564 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:37944.64 Median:3369.78 stddev:57460.64 (1705.2%) stddev-sans-first:57553.24 05:12:54 INFO - 2015-12-10 05:12:54,566 DEBUG : BROWSER_OUTPUT: Values: 553.2 563.7 574.8 575.3 580.6 26419.9 27164.2 35142.0 35968.3 35991.5 39693.6 40190.4 40270.8 40298.4 40339.2 7088.3 7975.6 8065.8 8133.1 8133.8 7266.6 9751.4 9890.3 9938.1 9987.2 9661.4 9768.5 9779.2 9782.0 9795.8 7342.0 7530.8 9681.6 9788.8 9978.2 9791.2 9955.5 9982.8 9989.0 9992.0 37031.6 37528.6 37543.2 37666.2 37706.1 2609.0 2650.4 2696.6 2957.5 3013.8 24548.5 24857.0 24904.9 24945.5 25073.6 3359.2 3380.3 3383.0 3431.0 3496.8 216148.0 216474.0 216650.9 216789.0 217481.0 53904.5 54074.5 54200.2 54259.0 54280.2 48343.5 49419.3 57183.4 57478.0 57585.1 13680.9 14366.8 14390.8 14414.7 14431.9 8917.8 8931.3 8939.6 8942.1 8968.1 18324.5 18409.6 18479.3 18485.7 18548.4 6932.7 7150.9 7160.0 7217.3 7294.4 848.5 853.8 858.2 873.6 1002.8 22227.4 24449.6 24482.4 24517.5 24559.3 906.5 926.6 936.4 988.4 1051.5 11510.5 12906.6 12931.9 12950.6 12965.4 244256.0 246935.0 247451.0 248645.0 248722.0 37305.0 37687.8 42956.0 43675.6 43710.6 1128.9 1170.7 1179.8 1182.3 1194.2 23788.0 23791.3 25518.4 25585.2 25722.4 33030.8 36163.6 36625.0 41012.6 41946.0 195320.0 195844.0 197902.0 198624.0 199031.0 27196.9 27597.2 27600.6 27604.7 27611.7 36476.6 36749.3 36896.3 37465.3 37626.2 32379.5 32593.2 33141.0 33482.5 33533.0 32591.7 32888.5 32904.7 33031.8 33134.3 32260.2 32606.7 32910.2 33070.8 33074.7 28100.7 29399.1 30002.8 30055.2 30279.2 22866.7 23284.4 24761.5 25050.7 25541.0 05:12:54 INFO - 2015-12-10 05:12:54,566 DEBUG : BROWSER_OUTPUT: 05:12:54 INFO - 2015-12-10 05:12:54,566 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26552.91 Median:22312.55 stddev:78988.24 (354.0%) stddev-sans-first:79185.30 05:12:54 INFO - 2015-12-10 05:12:54,566 DEBUG : BROWSER_OUTPUT: Values: 340.8 342.7 343.2 345.3 345.6 12611.2 13006.2 15395.3 15496.8 16002.4 13067.4 15678.3 16436.4 16622.8 16638.2 4902.9 5002.1 5027.3 5031.7 5034.5 3762.7 3867.7 4950.5 4981.9 4982.8 5519.3 5661.3 5712.4 5714.0 5715.1 5533.1 5674.0 5680.1 5683.5 5688.6 5040.2 5057.7 5084.8 5088.3 5094.3 19384.6 19954.7 20293.1 20536.1 20551.8 1832.5 1839.8 1894.1 1901.2 2027.3 12792.7 12965.5 13086.4 13103.7 13417.9 1770.3 1777.8 1799.8 1830.6 1878.7 54399.0 55864.2 56410.0 57171.4 57746.0 9545.0 9680.0 9705.9 9776.9 9863.8 12318.9 12421.6 12434.0 12437.7 12440.6 6590.4 6931.2 6965.9 6968.9 7066.7 6238.7 6291.6 6298.6 6305.7 6332.6 5702.5 5805.4 5810.9 5830.3 5861.4 1564.6 1661.2 1688.7 1729.9 1742.6 857.6 868.7 961.9 980.1 1008.8 13518.0 16165.8 16309.7 16605.2 16865.7 729.7 773.3 789.5 840.0 875.5 8264.6 9024.1 9187.6 9300.8 9327.0 470514.0 483411.0 484208.0 487005.0 492726.0 72448.0 73709.0 73853.3 74229.6 75234.6 1026.9 1047.3 1049.9 1062.3 1067.1 14154.0 14483.9 14537.4 14653.4 14825.3 33868.8 33932.0 33954.2 35016.3 35027.5 40757.4 41362.8 43198.0 43409.3 43463.0 8431.9 8609.3 8624.8 8664.8 8699.3 11270.6 16026.2 16030.5 16271.0 16279.0 13476.1 13495.9 13545.9 13645.3 13923.9 13801.4 14029.6 14151.4 14272.3 14644.8 14006.6 14226.6 14577.9 14579.3 14934.3 8987.6 9124.1 9276.1 9319.5 9394.1 9876.6 9997.2 10594.7 13901.0 13940.9 05:12:54 INFO - 2015-12-10 05:12:54,566 DEBUG : BROWSER_OUTPUT: 05:12:54 INFO - 2015-12-10 05:12:54,566 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4896.62 Median:6108.53 stddev:2540.96 (41.6%) stddev-sans-first:2534.60 05:12:54 INFO - 2015-12-10 05:12:54,568 DEBUG : BROWSER_OUTPUT: Values: 1413.1 1638.2 1696.8 1726.6 1727.0 5824.4 6771.5 6853.2 6859.6 6867.3 6804.0 6885.7 6952.2 6990.2 7032.4 1928.6 1964.4 1965.3 1967.3 1967.7 2047.2 2069.2 2079.1 2091.5 2096.4 2037.6 2058.7 2086.6 2089.2 2089.2 2074.8 2106.8 2107.1 2107.7 2123.4 2013.2 2026.5 2027.0 2029.6 2075.5 6993.5 7061.5 7074.8 7078.3 7078.6 4092.4 4163.5 4170.3 4171.7 4174.6 2575.9 2598.6 2615.8 2617.5 2631.6 795.0 795.9 799.0 799.6 851.2 9530.2 9538.8 9553.9 9556.9 9563.3 3720.5 3724.9 3770.2 3781.6 3783.0 8011.0 8037.2 8048.6 8060.4 8105.2 4151.9 4174.5 4185.6 4205.1 4205.6 3228.2 3313.8 3663.7 3808.6 3852.6 3360.0 3418.3 3426.7 3446.3 3469.7 1071.3 1071.4 1075.6 1080.6 1083.0 794.5 852.7 857.7 936.9 1067.8 6704.9 6776.3 6793.1 6796.4 6799.8 1022.2 1029.4 1037.3 1045.3 1058.8 5083.4 5141.5 5141.6 5153.4 5160.0 8242.3 8328.7 8496.0 8520.5 8529.6 8321.4 8415.8 8429.8 8434.2 8440.9 6536.3 6608.7 6621.3 6663.0 6672.0 6206.0 6234.1 6259.0 6284.2 6284.5 7390.7 7521.4 7608.7 7642.1 7722.0 7741.5 7874.1 7882.4 7929.9 8074.4 6066.8 6099.5 6117.6 6118.3 6133.9 6814.0 6833.8 6837.6 6926.9 6950.0 6214.5 6236.8 6269.0 6291.0 6328.1 5530.4 5773.2 6260.8 6262.9 6403.8 6450.2 6478.5 6497.2 6505.6 6511.1 5734.8 5774.4 5778.0 5779.8 5782.6 5968.3 5987.9 6000.2 6003.5 6013.6 05:12:54 INFO - 2015-12-10 05:12:54,568 DEBUG : BROWSER_OUTPUT: 05:12:54 INFO - 2015-12-10 05:12:54,568 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4526.78 Median:5219.99 stddev:1330.46 (25.5%) stddev-sans-first:1296.01 05:12:54 INFO - 2015-12-10 05:12:54,568 DEBUG : BROWSER_OUTPUT: Values: 310.4 316.5 320.8 320.8 322.5 5111.4 5282.4 5292.4 5309.8 5322.2 5146.2 5213.2 5238.8 5239.2 5245.9 3840.9 3907.5 3925.2 4053.1 4074.6 3992.3 4027.9 4032.2 4048.5 4054.1 4004.1 4004.3 4005.4 4008.0 4010.9 3799.4 3876.1 3928.8 3966.4 4008.3 3489.3 3497.2 3500.5 3506.1 3511.9 4887.1 4910.6 4910.7 4917.0 4924.1 4574.3 4581.2 4583.8 4584.1 4588.8 5226.8 5376.9 5383.7 5436.6 5440.6 3819.9 3821.2 3822.1 3823.3 3825.4 5644.6 5710.5 5713.3 5726.4 5728.3 3933.6 3939.2 3942.2 3942.3 3946.3 3906.5 3989.5 3998.4 4010.3 4013.6 4571.3 4579.9 4587.5 4590.2 4590.3 5413.5 5415.4 5433.5 5442.3 5446.5 1380.5 1403.3 1404.3 1415.1 1415.7 942.2 943.7 951.5 969.9 971.1 4811.1 4823.5 4829.7 4830.1 4830.2 5613.3 5616.8 5617.0 5622.1 5628.1 4788.4 4819.5 4827.6 4832.6 4836.2 2804.5 2912.6 2981.5 3005.4 3033.9 5342.4 5420.7 5436.4 5440.1 5441.3 5811.0 5818.9 5819.5 5821.8 5832.1 5429.0 5431.9 5436.1 5437.4 5437.8 5516.8 5656.8 5659.8 5660.4 5668.1 5534.1 5548.2 5549.4 5552.0 5552.5 5394.3 5425.1 5432.9 5433.3 5436.0 3950.3 3950.8 3950.9 3951.7 3952.9 5507.4 5656.4 5661.0 5662.3 5664.6 5446.1 5447.1 5456.4 5456.5 5457.0 5441.0 5449.1 5456.3 5457.9 5460.5 5204.5 5344.8 5347.0 5352.7 5352.8 5480.8 5491.4 5494.3 5498.6 5506.3 5122.8 5212.2 5296.5 5357.1 5366.6 05:12:54 INFO - 2015-12-10 05:12:54,568 DEBUG : BROWSER_OUTPUT: 05:12:54 INFO - 2015-12-10 05:12:54,568 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11855.91 Median:21724.48 stddev:13319.34 (61.3%) stddev-sans-first:13330.39 05:12:54 INFO - 2015-12-10 05:12:54,570 DEBUG : BROWSER_OUTPUT: Values: 707.7 727.7 745.8 755.2 796.8 11618.0 11675.1 11681.5 11704.7 11709.1 11206.6 11858.9 11966.2 11970.8 11982.3 643.8 652.4 807.2 810.2 820.2 810.8 816.9 822.8 824.5 825.7 861.5 870.8 871.6 871.8 872.2 661.2 671.8 838.1 854.1 857.3 629.4 630.2 632.1 634.6 634.8 11404.9 11422.7 11440.4 11469.8 11490.6 10690.7 11471.5 11584.9 11661.4 11663.6 9096.1 9151.7 9175.4 9280.4 9326.0 3129.5 3145.1 3168.0 3172.2 3173.3 36594.3 37138.3 37175.3 37213.3 37269.3 9140.5 9198.0 9228.6 9551.0 9566.6 15672.3 15747.9 15776.4 15800.8 15805.7 6215.1 6406.3 6413.4 6550.1 6575.6 3552.1 3646.0 3647.9 3650.2 3656.2 2551.2 2596.8 2597.9 2603.1 2604.2 462.4 465.3 465.4 472.6 475.2 386.4 415.9 427.4 438.9 459.4 7064.8 7229.0 7283.7 7297.5 7368.9 393.1 442.4 473.7 484.1 516.6 3273.1 3435.2 3459.0 3546.1 3555.4 49232.5 49298.3 49360.0 49430.0 49457.5 38279.0 38443.4 43021.6 43346.0 43384.0 39688.8 39794.2 40192.6 41020.0 41046.0 7331.8 7669.5 7763.3 7892.8 7949.6 29735.7 30242.5 30674.1 31042.8 31077.8 38440.8 38446.4 38509.6 38652.0 38877.0 9612.7 9770.3 9893.5 10098.7 10467.7 10224.6 10347.7 10394.4 10728.5 10942.6 10639.5 10781.7 10902.8 11069.4 11158.8 10147.4 10227.6 10253.7 10322.8 10344.9 8293.6 9680.7 10033.9 10238.2 10822.7 8299.5 8325.0 8411.1 8493.2 8525.9 8562.7 8727.7 8905.9 8968.3 9259.6 05:12:54 INFO - 2015-12-10 05:12:54,570 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:12:54 INFO - 2015-12-10 05:12:54,570 DEBUG : BROWSER_OUTPUT: 05:12:55 INFO - 2015-12-10 05:12:55,274 INFO : Browser exited with error code: 0 05:12:55 INFO - 2015-12-10 05:12:55,295 INFO : Completed test dromaeo_css (00:18:37) 05:12:55 INFO - 2015-12-10 05:12:55,295 INFO : Starting test kraken 05:12:55 INFO - 2015-12-10 05:12:55,295 DEBUG : operating with platform_type : linux_ 05:12:55 INFO - 2015-12-10 05:12:55,295 INFO : Initialising browser for kraken test... 05:12:55 INFO - 2015-12-10 05:12:55,301 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjkoK6J/profile http://localhost:47693/getInfo.html 05:12:59 INFO - 2015-12-10 05:12:59,844 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:12:59 INFO - 2015-12-10 05:12:59,845 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:12:59 INFO - 2015-12-10 05:12:59,845 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:12:59 INFO - 2015-12-10 05:12:59,845 DEBUG : BROWSER_OUTPUT: __metrics 05:12:59 INFO - 2015-12-10 05:12:59,947 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] 05:13:00 INFO - 2015-12-10 05:13:00,023 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] 05:13:00 ERROR - 2015-12-10 05:13:00,038 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 05:13:00 INFO - 2015-12-10 05:13:00,871 INFO : Browser initialized. 05:13:00 INFO - 2015-12-10 05:13:00,871 INFO : Running cycle 1/1 for kraken test... 05:13:00 INFO - 2015-12-10 05:13:00,872 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjkoK6J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:13:12 INFO - 2015-12-10 05:13:12,857 DEBUG : BROWSER_OUTPUT: RSS: Main: 143495168 05:13:12 INFO - 2015-12-10 05:13:12,857 DEBUG : BROWSER_OUTPUT: 05:13:15 INFO - 2015-12-10 05:13:15,484 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47693/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47693/tests/kraken/driver.html?testName=audio-beat-detection) 05:13:16 INFO - 2015-12-10 05:13:16,065 DEBUG : BROWSER_OUTPUT: RSS: Main: 175869952 05:13:16 INFO - 2015-12-10 05:13:16,065 DEBUG : BROWSER_OUTPUT: 05:13:18 INFO - 2015-12-10 05:13:18,754 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47693/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47693/tests/kraken/driver.html?testName=audio-dft) 05:13:19 INFO - 2015-12-10 05:13:19,335 DEBUG : BROWSER_OUTPUT: RSS: Main: 165838848 05:13:19 INFO - 2015-12-10 05:13:19,335 DEBUG : BROWSER_OUTPUT: 05:13:22 INFO - 2015-12-10 05:13:22,377 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47693/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47693/tests/kraken/driver.html?testName=audio-fft) 05:13:22 INFO - 2015-12-10 05:13:22,938 DEBUG : BROWSER_OUTPUT: RSS: Main: 153116672 05:13:22 INFO - 2015-12-10 05:13:22,939 DEBUG : BROWSER_OUTPUT: 05:13:24 INFO - 2015-12-10 05:13:24,982 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47693/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47693/tests/kraken/driver.html?testName=audio-oscillator) 05:13:25 INFO - 2015-12-10 05:13:25,556 DEBUG : BROWSER_OUTPUT: RSS: Main: 155238400 05:13:25 INFO - 2015-12-10 05:13:25,557 DEBUG : BROWSER_OUTPUT: 05:13:27 INFO - 2015-12-10 05:13:27,835 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47693/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47693/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:13:28 INFO - 2015-12-10 05:13:28,401 DEBUG : BROWSER_OUTPUT: RSS: Main: 158158848 05:13:28 INFO - 2015-12-10 05:13:28,401 DEBUG : BROWSER_OUTPUT: 05:13:31 INFO - 2015-12-10 05:13:31,380 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47693/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47693/tests/kraken/driver.html?testName=imaging-darkroom) 05:13:31 INFO - 2015-12-10 05:13:31,961 DEBUG : BROWSER_OUTPUT: RSS: Main: 156200960 05:13:31 INFO - 2015-12-10 05:13:31,961 DEBUG : BROWSER_OUTPUT: 05:13:35 INFO - 2015-12-10 05:13:35,369 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47693/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47693/tests/kraken/driver.html?testName=imaging-desaturate) 05:13:35 INFO - 2015-12-10 05:13:35,950 DEBUG : BROWSER_OUTPUT: RSS: Main: 158597120 05:13:35 INFO - 2015-12-10 05:13:35,950 DEBUG : BROWSER_OUTPUT: 05:13:38 INFO - 2015-12-10 05:13:38,800 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47693/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47693/tests/kraken/driver.html?testName=json-parse-financial) 05:13:39 INFO - 2015-12-10 05:13:39,382 DEBUG : BROWSER_OUTPUT: RSS: Main: 158134272 05:13:39 INFO - 2015-12-10 05:13:39,382 DEBUG : BROWSER_OUTPUT: 05:13:41 INFO - 2015-12-10 05:13:41,179 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47693/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47693/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:13:41 INFO - 2015-12-10 05:13:41,746 DEBUG : BROWSER_OUTPUT: RSS: Main: 166985728 05:13:41 INFO - 2015-12-10 05:13:41,746 DEBUG : BROWSER_OUTPUT: 05:13:43 INFO - 2015-12-10 05:13:43,636 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47693/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47693/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:13:44 INFO - 2015-12-10 05:13:44,229 DEBUG : BROWSER_OUTPUT: RSS: Main: 166318080 05:13:44 INFO - 2015-12-10 05:13:44,230 DEBUG : BROWSER_OUTPUT: 05:13:46 INFO - 2015-12-10 05:13:46,361 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47693/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47693/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:13:46 INFO - 2015-12-10 05:13:46,943 DEBUG : BROWSER_OUTPUT: RSS: Main: 180723712 05:13:46 INFO - 2015-12-10 05:13:46,943 DEBUG : BROWSER_OUTPUT: 05:13:49 INFO - 2015-12-10 05:13:49,429 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47693/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47693/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:13:50 INFO - 2015-12-10 05:13:50,016 DEBUG : BROWSER_OUTPUT: RSS: Main: 188022784 05:13:50 INFO - 2015-12-10 05:13:50,016 DEBUG : BROWSER_OUTPUT: 05:13:52 INFO - 2015-12-10 05:13:52,631 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47693/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47693/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:13:53 INFO - 2015-12-10 05:13:53,213 DEBUG : BROWSER_OUTPUT: RSS: Main: 185503744 05:13:53 INFO - 2015-12-10 05:13:53,213 DEBUG : BROWSER_OUTPUT: 05:13:54 INFO - 2015-12-10 05:13:54,983 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47693/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47693/tests/kraken/driver.html?testName=ai-astar) 05:13:55 INFO - 2015-12-10 05:13:55,229 DEBUG : BROWSER_OUTPUT: RSS: Main: 243859456 05:13:55 INFO - 2015-12-10 05:13:55,229 DEBUG : BROWSER_OUTPUT: 05:13:55 INFO - 2015-12-10 05:13:55,230 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:13:55 INFO - 2015-12-10 05:13:55,231 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:13:55 INFO - 2015-12-10 05:13:55,231 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:13:55 INFO - 2015-12-10 05:13:55,231 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:13:55 INFO - 2015-12-10 05:13:55,232 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;112;105;112;113;114;100;113;112;103 05:13:55 INFO - 2015-12-10 05:13:55,233 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;160;127;150;168;130;156;153;129;168;135 05:13:55 INFO - 2015-12-10 05:13:55,233 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;160;162;162;161;162;164;164;163 05:13:55 INFO - 2015-12-10 05:13:55,233 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;86;92;72;72;72;103;89;72 05:13:55 INFO - 2015-12-10 05:13:55,233 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;96;131;94;94;95;146;96;94;131 05:13:55 INFO - 2015-12-10 05:13:55,233 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;109;110;109;110;109;110;109 05:13:55 INFO - 2015-12-10 05:13:55,233 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;145;146;146;146;147;146;146;146;146 05:13:55 INFO - 2015-12-10 05:13:55,233 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;95;95;95;95;95;96;95 05:13:55 INFO - 2015-12-10 05:13:55,234 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;73;72;72;73;72;72;86;69;70 05:13:55 INFO - 2015-12-10 05:13:55,234 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;67;67;68;67;68;68;67;67;68 05:13:55 INFO - 2015-12-10 05:13:55,234 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;83;83;85;84;84;82;85;83;84 05:13:55 INFO - 2015-12-10 05:13:55,234 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;118;125;120;122;118;119;121;125;119 05:13:55 INFO - 2015-12-10 05:13:55,234 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;145;147;156;141;139;154;149;147;135 05:13:55 INFO - 2015-12-10 05:13:55,234 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;70;69;71;70;68;70;67;69;68 05:13:55 INFO - 2015-12-10 05:13:55,234 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:13:55 INFO - 2015-12-10 05:13:55,235 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:13:55 INFO - 2015-12-10 05:13:55,235 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,966 05:13:55 INFO - 2015-12-10 05:13:55,235 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:13:55 INFO - 2015-12-10 05:13:55,235 DEBUG : BROWSER_OUTPUT: __startTimestamp1449753235230__endTimestamp 05:13:55 INFO - 2015-12-10 05:13:55,235 DEBUG : BROWSER_OUTPUT: 05:13:55 INFO - 2015-12-10 05:13:55,243 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:13:55 INFO - 2015-12-10 05:13:55,243 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:13:55 INFO - 2015-12-10 05:13:55,243 DEBUG : BROWSER_OUTPUT: 05:13:55 INFO - 2015-12-10 05:13:55,243 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.40 Median:112.00 stddev:4.90 (4.4%) stddev-sans-first:5.20 05:13:55 INFO - 2015-12-10 05:13:55,243 DEBUG : BROWSER_OUTPUT: Values: 110.0 112.0 105.0 112.0 113.0 114.0 100.0 113.0 112.0 103.0 05:13:55 INFO - 2015-12-10 05:13:55,243 DEBUG : BROWSER_OUTPUT: 05:13:55 INFO - 2015-12-10 05:13:55,243 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.60 Median:154.50 stddev:16.09 (10.4%) stddev-sans-first:16.43 05:13:55 INFO - 2015-12-10 05:13:55,243 DEBUG : BROWSER_OUTPUT: Values: 160.0 127.0 150.0 168.0 130.0 156.0 153.0 129.0 168.0 135.0 05:13:55 INFO - 2015-12-10 05:13:55,243 DEBUG : BROWSER_OUTPUT: 05:13:55 INFO - 2015-12-10 05:13:55,243 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:1.23 (0.8%) stddev-sans-first:1.30 05:13:55 INFO - 2015-12-10 05:13:55,243 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 160.0 162.0 162.0 161.0 162.0 164.0 164.0 163.0 05:13:55 INFO - 2015-12-10 05:13:55,243 DEBUG : BROWSER_OUTPUT: 05:13:55 INFO - 2015-12-10 05:13:55,243 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.30 Median:72.50 stddev:11.34 (15.6%) stddev-sans-first:11.63 05:13:55 INFO - 2015-12-10 05:13:55,243 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 86.0 92.0 72.0 72.0 72.0 103.0 89.0 72.0 05:13:55 INFO - 2015-12-10 05:13:55,243 DEBUG : BROWSER_OUTPUT: 05:13:55 INFO - 2015-12-10 05:13:55,244 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.10 Median:94.00 stddev:20.37 (21.7%) stddev-sans-first:21.05 05:13:55 INFO - 2015-12-10 05:13:55,244 DEBUG : BROWSER_OUTPUT: Values: 94.0 96.0 131.0 94.0 94.0 95.0 146.0 96.0 94.0 131.0 05:13:55 INFO - 2015-12-10 05:13:55,244 DEBUG : BROWSER_OUTPUT: 05:13:55 INFO - 2015-12-10 05:13:55,244 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:13:55 INFO - 2015-12-10 05:13:55,244 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 109.0 110.0 109.0 110.0 109.0 110.0 109.0 05:13:55 INFO - 2015-12-10 05:13:55,244 DEBUG : BROWSER_OUTPUT: 05:13:55 INFO - 2015-12-10 05:13:55,244 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 05:13:55 INFO - 2015-12-10 05:13:55,244 DEBUG : BROWSER_OUTPUT: Values: 146.0 145.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 05:13:55 INFO - 2015-12-10 05:13:55,245 DEBUG : BROWSER_OUTPUT: 05:13:55 INFO - 2015-12-10 05:13:55,245 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 05:13:55 INFO - 2015-12-10 05:13:55,245 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 05:13:55 INFO - 2015-12-10 05:13:55,245 DEBUG : BROWSER_OUTPUT: 05:13:55 INFO - 2015-12-10 05:13:55,245 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.00 Median:72.00 stddev:4.74 (6.6%) stddev-sans-first:4.97 05:13:55 INFO - 2015-12-10 05:13:55,245 DEBUG : BROWSER_OUTPUT: Values: 71.0 73.0 72.0 72.0 73.0 72.0 72.0 86.0 69.0 70.0 05:13:55 INFO - 2015-12-10 05:13:55,245 DEBUG : BROWSER_OUTPUT: 05:13:55 INFO - 2015-12-10 05:13:55,245 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:68.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 05:13:55 INFO - 2015-12-10 05:13:55,245 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 67.0 68.0 67.0 68.0 68.0 67.0 67.0 68.0 05:13:55 INFO - 2015-12-10 05:13:55,246 DEBUG : BROWSER_OUTPUT: 05:13:55 INFO - 2015-12-10 05:13:55,246 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:84.00 stddev:1.08 (1.3%) stddev-sans-first:1.00 05:13:55 INFO - 2015-12-10 05:13:55,246 DEBUG : BROWSER_OUTPUT: Values: 82.0 83.0 83.0 85.0 84.0 84.0 82.0 85.0 83.0 84.0 05:13:55 INFO - 2015-12-10 05:13:55,246 DEBUG : BROWSER_OUTPUT: 05:13:55 INFO - 2015-12-10 05:13:55,246 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.60 Median:120.50 stddev:2.63 (2.2%) stddev-sans-first:2.73 05:13:55 INFO - 2015-12-10 05:13:55,246 DEBUG : BROWSER_OUTPUT: Values: 119.0 118.0 125.0 120.0 122.0 118.0 119.0 121.0 125.0 119.0 05:13:55 INFO - 2015-12-10 05:13:55,246 DEBUG : BROWSER_OUTPUT: 05:13:55 INFO - 2015-12-10 05:13:55,246 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.00 Median:147.00 stddev:7.01 (4.8%) stddev-sans-first:6.81 05:13:55 INFO - 2015-12-10 05:13:55,246 DEBUG : BROWSER_OUTPUT: Values: 137.0 145.0 147.0 156.0 141.0 139.0 154.0 149.0 147.0 135.0 05:13:55 INFO - 2015-12-10 05:13:55,246 DEBUG : BROWSER_OUTPUT: 05:13:55 INFO - 2015-12-10 05:13:55,246 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:70.00 stddev:1.34 (1.9%) stddev-sans-first:1.27 05:13:55 INFO - 2015-12-10 05:13:55,246 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 69.0 71.0 70.0 68.0 70.0 67.0 69.0 68.0 05:13:55 INFO - 2015-12-10 05:13:55,246 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:13:55 INFO - 2015-12-10 05:13:55,246 DEBUG : BROWSER_OUTPUT: 05:13:56 INFO - 2015-12-10 05:13:56,146 INFO : Browser exited with error code: 0 05:13:56 INFO - 2015-12-10 05:13:56,195 INFO : Completed test kraken (00:01:00) 05:13:56 INFO - 2015-12-10 05:13:56,195 INFO : Starting test v8_7 05:13:56 INFO - 2015-12-10 05:13:56,195 DEBUG : operating with platform_type : linux_ 05:13:56 INFO - 2015-12-10 05:13:56,195 INFO : Initialising browser for v8_7 test... 05:13:56 INFO - 2015-12-10 05:13:56,201 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpByw1Ux/profile http://localhost:47693/getInfo.html 05:14:00 INFO - 2015-12-10 05:14:00,540 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:14:00 INFO - 2015-12-10 05:14:00,541 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:14:00 INFO - 2015-12-10 05:14:00,541 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:14:00 INFO - 2015-12-10 05:14:00,541 DEBUG : BROWSER_OUTPUT: __metrics 05:14:00 INFO - 2015-12-10 05:14:00,622 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] 05:14:00 INFO - 2015-12-10 05:14:00,682 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] 05:14:01 INFO - 2015-12-10 05:14:01,922 INFO : Browser initialized. 05:14:01 INFO - 2015-12-10 05:14:01,923 INFO : Running cycle 1/1 for v8_7 test... 05:14:01 INFO - 2015-12-10 05:14:01,923 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpByw1Ux/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:14:13 INFO - 2015-12-10 05:14:13,899 DEBUG : BROWSER_OUTPUT: RSS: Main: 143884288 05:14:13 INFO - 2015-12-10 05:14:13,899 DEBUG : BROWSER_OUTPUT: 05:14:35 INFO - 2015-12-10 05:14:35,259 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47693/tests/v8_7/run.html (next: http://localhost:47693/tests/v8_7/run.html) 05:14:35 INFO - 2015-12-10 05:14:35,517 DEBUG : BROWSER_OUTPUT: RSS: Main: 445181952 05:14:35 INFO - 2015-12-10 05:14:35,517 DEBUG : BROWSER_OUTPUT: 05:14:35 INFO - 2015-12-10 05:14:35,517 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:14:35 INFO - 2015-12-10 05:14:35,517 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:14:35 INFO - 2015-12-10 05:14:35,517 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:14:35 INFO - 2015-12-10 05:14:35,517 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:14:35 INFO - 2015-12-10 05:14:35,517 DEBUG : BROWSER_OUTPUT: |0;Richards;168.86187098953056 05:14:35 INFO - 2015-12-10 05:14:35,518 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.9427296392711 05:14:35 INFO - 2015-12-10 05:14:35,518 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.08676307007784 05:14:35 INFO - 2015-12-10 05:14:35,518 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5427.027027027027 05:14:35 INFO - 2015-12-10 05:14:35,518 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2010.0401606425703 05:14:35 INFO - 2015-12-10 05:14:35,518 DEBUG : BROWSER_OUTPUT: |5;Earley;789.2659826361484 05:14:35 INFO - 2015-12-10 05:14:35,518 DEBUG : BROWSER_OUTPUT: |6;Boyer;12144.578313253012 05:14:35 INFO - 2015-12-10 05:14:35,518 DEBUG : BROWSER_OUTPUT: |7;RegExp;27243.243243243243 05:14:35 INFO - 2015-12-10 05:14:35,518 DEBUG : BROWSER_OUTPUT: |8;Splay;609.3845216331505 05:14:35 INFO - 2015-12-10 05:14:35,518 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 05:14:35 INFO - 2015-12-10 05:14:35,518 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:14:35 INFO - 2015-12-10 05:14:35,518 DEBUG : BROWSER_OUTPUT: __startTimestamp1449753275511__endTimestamp 05:14:35 INFO - 2015-12-10 05:14:35,518 DEBUG : BROWSER_OUTPUT: 05:14:35 INFO - 2015-12-10 05:14:35,518 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:14:35 INFO - 2015-12-10 05:14:35,518 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:14:35 INFO - 2015-12-10 05:14:35,519 DEBUG : BROWSER_OUTPUT: 05:14:35 INFO - 2015-12-10 05:14:35,519 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.86 Median:168.86 stddev:0.00 (0.0%) 05:14:35 INFO - 2015-12-10 05:14:35,519 DEBUG : BROWSER_OUTPUT: Values: 168.9 05:14:35 INFO - 2015-12-10 05:14:35,519 DEBUG : BROWSER_OUTPUT: 05:14:35 INFO - 2015-12-10 05:14:35,519 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.94 Median:185.94 stddev:0.00 (0.0%) 05:14:35 INFO - 2015-12-10 05:14:35,519 DEBUG : BROWSER_OUTPUT: Values: 185.9 05:14:35 INFO - 2015-12-10 05:14:35,519 DEBUG : BROWSER_OUTPUT: 05:14:35 INFO - 2015-12-10 05:14:35,519 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.09 Median:278.09 stddev:0.00 (0.0%) 05:14:35 INFO - 2015-12-10 05:14:35,519 DEBUG : BROWSER_OUTPUT: Values: 278.1 05:14:35 INFO - 2015-12-10 05:14:35,519 DEBUG : BROWSER_OUTPUT: 05:14:35 INFO - 2015-12-10 05:14:35,519 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5427.03 Median:5427.03 stddev:0.00 (0.0%) 05:14:35 INFO - 2015-12-10 05:14:35,519 DEBUG : BROWSER_OUTPUT: Values: 5427.0 05:14:35 INFO - 2015-12-10 05:14:35,519 DEBUG : BROWSER_OUTPUT: 05:14:35 INFO - 2015-12-10 05:14:35,519 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2010.04 Median:2010.04 stddev:0.00 (0.0%) 05:14:35 INFO - 2015-12-10 05:14:35,519 DEBUG : BROWSER_OUTPUT: Values: 2010.0 05:14:35 INFO - 2015-12-10 05:14:35,519 DEBUG : BROWSER_OUTPUT: 05:14:35 INFO - 2015-12-10 05:14:35,520 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:789.27 Median:789.27 stddev:0.00 (0.0%) 05:14:35 INFO - 2015-12-10 05:14:35,520 DEBUG : BROWSER_OUTPUT: Values: 789.3 05:14:35 INFO - 2015-12-10 05:14:35,520 DEBUG : BROWSER_OUTPUT: 05:14:35 INFO - 2015-12-10 05:14:35,520 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12144.58 Median:12144.58 stddev:0.00 (0.0%) 05:14:35 INFO - 2015-12-10 05:14:35,520 DEBUG : BROWSER_OUTPUT: Values: 12144.6 05:14:35 INFO - 2015-12-10 05:14:35,520 DEBUG : BROWSER_OUTPUT: 05:14:35 INFO - 2015-12-10 05:14:35,520 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27243.24 Median:27243.24 stddev:0.00 (0.0%) 05:14:35 INFO - 2015-12-10 05:14:35,520 DEBUG : BROWSER_OUTPUT: Values: 27243.2 05:14:35 INFO - 2015-12-10 05:14:35,520 DEBUG : BROWSER_OUTPUT: 05:14:35 INFO - 2015-12-10 05:14:35,520 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:609.38 Median:609.38 stddev:0.00 (0.0%) 05:14:35 INFO - 2015-12-10 05:14:35,520 DEBUG : BROWSER_OUTPUT: Values: 609.4 05:14:35 INFO - 2015-12-10 05:14:35,520 DEBUG : BROWSER_OUTPUT: 05:14:35 INFO - 2015-12-10 05:14:35,520 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 05:14:35 INFO - 2015-12-10 05:14:35,520 DEBUG : BROWSER_OUTPUT: Values: 4840.6 05:14:35 INFO - 2015-12-10 05:14:35,520 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:14:35 INFO - 2015-12-10 05:14:35,520 DEBUG : BROWSER_OUTPUT: 05:14:36 INFO - 2015-12-10 05:14:36,390 INFO : Browser exited with error code: 0 05:14:36 INFO - 2015-12-10 05:14:36,404 INFO : Completed test v8_7 (00:00:40) 05:14:36 INFO - 2015-12-10 05:14:36,590 INFO : Completed test suite (00:20:18) 05:14:36 INFO - 2015-12-10 05:14:36,590 DEBUG : Working with test: dromaeo_css 05:14:36 INFO - 2015-12-10 05:14:36,590 DEBUG : Generating results file: dromaeo_css 05:14:36 INFO - 2015-12-10 05:14:36,591 DEBUG : Working with test: kraken 05:14:36 INFO - 2015-12-10 05:14:36,591 DEBUG : Generating results file: kraken 05:14:36 INFO - 2015-12-10 05:14:36,592 INFO : javascript benchmark 05:14:36 INFO - 2015-12-10 05:14:36,592 DEBUG : Working with test: v8_7 05:14:36 INFO - 2015-12-10 05:14:36,592 DEBUG : Generating results file: v8_7 05:14:36 INFO - 2015-12-10 05:14:36,592 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:14:36 INFO - 2015-12-10 05:14:36,640 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 05:14:36 INFO - 2015-12-10 05:14:36,640 DEBUG : process_Request line: dromaeo_css 6220.47 graph.html#tests=[[72,94,35]] 05:14:36 INFO - 2015-12-10 05:14:36,640 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:14:36 INFO - 2015-12-10 05:14:36,668 DEBUG : process_Request line: kraken 1516.30 graph.html#tests=[[232,94,35]] 05:14:36 INFO - 2015-12-10 05:14:36,668 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:14:36 INFO - 2015-12-10 05:14:36,698 DEBUG : process_Request line: v8_7 19630.07 graph.html#tests=[[230,94,35]] 05:14:36 INFO - 2015-12-10 05:14:36,699 INFO : javascript benchmark 05:14:36 INFO - 2015-12-10 05:14:36,703 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2609.895604175833, 2689.193242027391, 2693.138195777352, 2704.0941284669634, 2722.3330284080403, 4429.51275359711, 4578.198815207334, 4618.445786505616, 4694.999999999995, 4707.082118986799, 4548.408706868111, 4611.12388646157, 4700.0, 4704.529547045294, 4707.62339012879, 4277.059047009669, 4310.439642846425, 4316.935245971313, 4326.156399502099, 4384.539623339551, 4108.4453598764085, 4348.956510434887, 4362.956370436303, 4404.14119246747, 4416.97791511042, 4146.170765846812, 4229.70392072555, 4245.957540424618, 4247.8300867965245, 4250.872473825791, 4332.1119170569955, 4335.349697545394, 4338.761368124752, 4347.891302717426, 4373.475182978063, 4335.436393268887, 4338.544452832439, 4346.804393802255, 4360.040791025969, 4390.868273951786, 4353.760543170124, 4476.61948734358, 4482.0, 4500.684952053358, 4608.308753686941, 4932.8520144395725, 4958.2562615607585, 4960.131976904027, 4962.131626965267, 4962.6526143169995, 4880.487548807359, 4920.827771027997, 4934.555889969884, 4993.251012348177, 5023.849284521433, 4641.953580464152, 4642.535746425364, 4649.907001859944, 4651.744154071558, 4691.0, 4916.901661966741, 5111.565516931102, 5114.15616423286, 5115.104856650071, 5115.38615366151, 4767.833125840648, 4817.879553011203, 4826.927596086061, 4830.975845120822, 4833.492483289274, 4989.501049895054, 5039.571636410873, 5040.47075057121, 5059.8988020239385, 5085.542301192911, 4974.850754477371, 4997.85006449807, 4997.900041999213, 4999.325091112653, 5019.372578427697, 4729.95270047302, 4884.242942343943, 4962.528559786814, 4983.8504844854715, 5018.473060328686, 4045.3122969095325, 4100.384942258685, 4121.196366708523, 4123.278426275389, 4162.042730172077, 3630.528031355907, 3632.800195989193, 3646.0520264731363, 3647.635236476331, 3677.043968568138, 4114.485689288839, 4221.430106935586, 4334.7399156050105, 4342.218400687843, 4378.408914796461, 4879.219324907997, 4928.211486162197, 4954.157793175169, 4976.751162441936, 4987.0, 4283.87148385549, 4311.267084595626, 4313.547077556874, 4319.67602429819, 4341.0, 4414.448193975753, 4416.492103408085, 4421.624161946206, 4457.732536047847, 4458.0, 4617.722936623813, 4720.4807471177455, 4765.0, 4768.189407800752, 4824.035192961352, 4967.329410529533, 4970.577500912318, 4975.353204083446, 4976.8755781105765, 4999.800007999639, 4758.04839032188, 4762.119007983534, 4765.618750500021, 4768.928466073081, 4802.927956080592, 4680.3213534036695, 4770.737609431515, 4817.0125124350125, 4856.4415092263425, 4897.8285759998225, 4902.85291441243, 4973.602111830973, 4991.301217829579, 4994.1759609663995, 5024.447310795883, 4808.951910480991, 4862.756862156949, 4870.878228044327, 4871.098846713369, 4913.65604407688, 4668.696534725232, 4802.039592081528, 4803.351547541177, 4864.221724524059, 4907.2393778964315, 4658.976705116453, 4725.763711814464, 4736.4316282046375, 4740.19416699155, 4781.258904869751, 4863.173260545645, 4865.343178670976, 4866.610671146371, 4888.5111488850835, 4907.828226012072, 4547.840825571089, 4650.232711602548, 4654.813807447799, 4747.098051370229, 4803.615710743202], "unit": "ms", "name": "dojo.html", "value": 4558.333645120059}, {"lowerIsBetter": false, "replicates": [553.1785298831237, 563.6618029182489, 574.752856271803, 575.2665351676612, 580.5645765675744, 26419.867900660494, 27164.185074447774, 35141.99999999997, 35968.280634387294, 35991.460128098035, 39693.60306396935, 40190.39714404279, 40270.798646006726, 40298.395524067164, 40339.19321613566, 7088.291170882896, 7975.641096150687, 8065.758027259162, 8133.10535841057, 8133.75598732039, 7266.636668166597, 9751.366161199534, 9890.258230632695, 9938.055884690979, 9987.201023918069, 9661.37201081931, 9768.462734549597, 9779.21766258701, 9781.951090244538, 9795.755106122333, 7341.972123902658, 7530.77407677765, 9681.564329605184, 9788.804223915517, 9978.201743860474, 9791.216702663769, 9955.452450115241, 9982.800343993153, 9988.952264785701, 9991.950040249825, 37031.62968370336, 37528.62471375278, 37543.24913501742, 37666.24667506662, 37706.05734856623, 2609.0085767408455, 2650.403659176689, 2696.5685490321453, 2957.54158105494, 3013.789034767567, 24548.509029819303, 24857.0, 24904.875475622506, 24945.501089978097, 25073.62389564158, 3359.227377703142, 3380.3408335374365, 3382.9830850845588, 3430.9656903430896, 3496.772709773882, 216148.0, 216474.0, 216650.91674541685, 216789.0, 217481.0, 53904.46095538994, 54074.45925540773, 54200.18699719507, 54259.0, 54280.185797213075, 48343.51656483461, 49419.258711119364, 57183.428165718644, 57477.97654164252, 57585.13622295669, 13680.863191368158, 14366.784498232535, 14390.784138237936, 14414.711705765825, 14431.855681443261, 8917.821643567222, 8931.285497160212, 8939.553022348857, 8942.105789421006, 8968.103189681111, 18324.450266492026, 18409.631807363778, 18479.260829566934, 18485.7227141593, 18548.44354669362, 6932.722691092401, 7150.856982860418, 7159.964200178966, 7217.314355136254, 7294.416446684252, 848.4909054567211, 853.8335024670254, 858.1632907914733, 873.5937788928179, 1002.8295189817749, 22227.444313892283, 24449.633255501183, 24482.38794030128, 24517.50964980726, 24559.263222103367, 906.4833045164193, 926.5552534783342, 936.4334577580602, 988.367444835306, 1051.4795176387738, 11510.456165395266, 12906.612801615967, 12931.870681293067, 12950.611481655566, 12965.416556254992, 244256.0, 246935.0, 247451.0, 248645.0, 248722.0, 37305.0, 37687.81156094202, 42956.0, 43675.56324436778, 43710.56289437129, 1128.9040431563244, 1170.7014711248748, 1179.7817403780327, 1182.2729021651794, 1194.2297218294325, 23788.0, 23791.286261412184, 25518.362040949123, 25585.23244302674, 25722.35694107662, 33030.834845825615, 36163.63836361708, 36625.0, 41012.58987410088, 41946.0, 195320.0, 195844.0, 197902.0, 198624.0, 199031.0, 27196.864015680585, 27597.172084837486, 27600.585991209748, 27604.723952761018, 27611.723882760914, 36476.63523364732, 36749.26501470009, 36896.26207475889, 37465.25069498649, 37626.2474750498, 32379.51430728588, 32593.185170369983, 33141.0, 33482.49776253407, 33533.0, 32591.674083258862, 32888.50667239945, 32904.67095329016, 33031.83484082564, 33134.33731325408, 32260.19349516281, 32606.673933260365, 32910.17724556905, 33070.83464582662, 33074.66925330812, 28100.71899280981, 29399.11802645924, 30002.83439664632, 30055.248618784706, 30279.243018924702, 22866.740649651005, 23284.41788955222, 24761.504769904863, 25050.74949250484, 25541.0], "unit": "ms", "name": "ext.html", "value": 16490.113285614363}, {"lowerIsBetter": false, "replicates": [340.82277215847745, 342.7326685185556, 343.2054793153849, 345.2887052671496, 345.6439866937056, 12611.243325400483, 13006.154599950996, 15395.307211175495, 15496.767548486767, 16002.439914602977, 13067.411966461508, 15678.294476748546, 16436.424725134624, 16622.75065874013, 16638.168091595402, 4902.8774280643, 5002.124628190052, 5027.321311622939, 5031.6729412588065, 5034.521720436553, 3762.6613604775566, 3867.7099217558657, 4950.455449900508, 4981.850544483671, 4982.800687972477, 5519.337679478468, 5661.264035675356, 5712.428757124296, 5714.0, 5715.057015592443, 5533.059379905426, 5674.035413979634, 5680.147977803321, 5683.54531637468, 5688.63023903445, 5040.16837221858, 5057.671251368649, 5084.847454576332, 5088.338515992934, 5094.312267843868, 19384.607693653554, 19954.70067948982, 20293.086811093537, 20536.07587658544, 20551.79448205514, 1832.5235438785878, 1839.7700287464068, 1894.1287007976348, 1901.1824915286422, 2027.290448343083, 12792.737129531739, 12965.546205882843, 13086.411111500005, 13103.737925241441, 13417.865821341758, 1770.3184274054581, 1777.79555351135, 1799.7930238022534, 1830.6338732253469, 1878.7181922711702, 54399.0, 55864.16203756988, 56410.0, 57171.42828571744, 57746.0, 9544.95227523858, 9680.0, 9705.854412183822, 9776.902230977741, 9863.80272394548, 12318.938405308096, 12421.565245216374, 12434.0, 12437.689057773629, 12440.564580239648, 6590.406863382319, 6931.2375638679705, 6965.930340696629, 6968.930310696828, 7066.692661857573, 6238.719257633417, 6291.591046581958, 6298.559100862987, 6305.747770089145, 6332.620042797447, 5702.45826646468, 5805.390434004453, 5810.94189058104, 5830.300363956268, 5861.384554621789, 1564.5853848730096, 1661.1860188507544, 1688.7044767165942, 1729.9048552329743, 1742.5643589102724, 857.5797859049021, 868.6568805321863, 961.8653388525612, 980.0787259975742, 1008.8436292374694, 13518.0, 16165.757513637305, 16309.673806523802, 16605.169741513117, 16865.662686746196, 729.6570611812546, 773.3001633521559, 789.5183937797939, 840.0255703384167, 875.4834647557972, 8264.586770661443, 9024.142706442877, 9187.63249470027, 9300.793860677679, 9327.0, 470514.0, 483411.0, 484208.0, 487005.0, 492726.0, 72448.0, 73709.0, 73853.26146738572, 74229.62885185647, 75234.62382688052, 1026.897310268982, 1047.314009323894, 1049.8582691336571, 1062.2882668612049, 1067.0556557446716, 14154.0, 14483.928580312559, 14537.41850325975, 14653.413863445343, 14825.25873706332, 33868.83065584656, 33932.0, 33954.15114622154, 35016.299674006885, 35027.47458788171, 40757.388639171026, 41362.79318603388, 43198.0, 43409.34885976776, 43463.0, 8431.873521897054, 8609.268212201783, 8624.827503449771, 8664.826703466022, 8699.347548933729, 11270.605528806453, 16026.198690065683, 16030.519084427486, 16271.0, 16279.0, 13476.056676032584, 13495.932520337336, 13545.86454135446, 13645.317734113452, 13923.930380348034, 13801.447942082204, 14029.649258768612, 14151.43394264218, 14272.286385680882, 14644.780328295297, 14006.579802605938, 14226.644333891321, 14577.85422145765, 14579.271036448346, 14934.327955242257, 8987.640494380152, 9124.087591240823, 9276.07239276067, 9319.534023298944, 9394.06059394055, 9876.555555000186, 9997.150242229201, 10594.735131621772, 13901.0, 13940.860591393955], "unit": "ms", "name": "jquery.html", "value": 8468.052629417196}, {"lowerIsBetter": false, "replicates": [1413.1026797983277, 1638.2136574444266, 1696.787901512311, 1726.6460375622992, 1727.0414919719558, 5824.4175582441785, 6771.492138089645, 6853.177618685752, 6859.588424694522, 6867.278935711754, 6804.0, 6885.7245710171655, 6952.2352541220425, 6990.231074581792, 7032.4374050076, 1928.6142771445732, 1964.4499540128786, 1965.272849045855, 1967.2721093195537, 1967.6753335699593, 2047.1504325704814, 2069.1826728442256, 2079.1475495047034, 2091.456221382444, 2096.350131459245, 2037.5822956293923, 2058.7220725202055, 2086.5618220173783, 2089.185217765073, 2089.2269860151764, 2074.771775104745, 2106.8096525463066, 2107.051826678001, 2107.71545841311, 2123.437289118385, 2013.224908410258, 2026.4832467720785, 2026.9594608107902, 2029.6143732690741, 2075.4707549574764, 6993.47548933832, 7061.540999834994, 7074.787756367317, 7078.292170782932, 7078.575285482888, 4092.3656833190903, 4163.479565054368, 4170.270202714543, 4171.728837625545, 4174.582541745832, 2575.8712064396705, 2598.649182360376, 2615.777658898996, 2617.450335429562, 2631.5526360518566, 794.964226609804, 795.8925545051402, 798.9600519973978, 799.5762246009624, 851.2296371783546, 9530.237580993504, 9538.761530961781, 9553.904460955371, 9556.856647150298, 9563.282753793494, 3720.4605332227216, 3724.944125838115, 3770.170562476251, 3781.5840257571645, 3783.0, 8010.959945200237, 8037.156098609678, 8048.5975701215875, 8060.435769496079, 8105.189481051848, 4151.8546850860075, 4174.478190226222, 4185.6232939035635, 4205.074883525619, 4205.558416366299, 3228.2090887732656, 3313.784604000732, 3663.725220608465, 3808.5620153682125, 3852.5954774748807, 3359.983200083984, 3418.265073009315, 3426.7258619310396, 3446.276281980762, 3469.7397695172963, 1071.2929466552039, 1071.3625392891217, 1075.6289080267295, 1080.6325849211305, 1083.030687534652, 794.5034353529045, 852.7313896122702, 857.6740838481337, 936.9156775890066, 1067.754416484213, 6704.865902682017, 6776.288489708608, 6793.082933803873, 6796.35434633709, 6799.762008329685, 1022.1822541966397, 1029.4183786160795, 1037.3101887245048, 1045.268312181476, 1058.7776566921034, 5083.440821509631, 5141.485851414828, 5141.614378921521, 5153.3558305211845, 5159.974200128975, 8242.29940455056, 8328.6668533258, 8496.0, 8520.488770673779, 8529.616167272363, 8321.375896807764, 8415.789605259917, 8429.831403371898, 8434.198751118634, 8440.915590844013, 6536.313687062885, 6608.702608382634, 6621.337866213436, 6662.966685166543, 6671.966640166768, 6205.968970155121, 6234.064890266496, 6259.0, 6284.183056202664, 6284.497240220863, 7390.7413240536325, 7521.435892308208, 7608.695652174072, 7642.121156066901, 7722.034745656793, 7741.535507869546, 7874.13384527713, 7882.408819338458, 7929.881051784112, 8074.434789564909, 6066.787662431793, 6099.4815440688035, 6117.571769976059, 6118.326984031842, 6133.877322453615, 6813.965930170318, 6833.829154271183, 6837.62393068386, 6926.905842962251, 6950.0, 6214.471769899609, 6236.781712640036, 6269.028300613412, 6291.02489114188, 6328.114064030948, 5530.391656917655, 5773.16289138081, 6260.843478912881, 6262.906056409249, 6403.807885763435, 6450.225972883284, 6478.5141114415665, 6497.155369801895, 6505.577137486048, 6511.055896895018, 5734.827955161351, 5774.42255774436, 5778.017736984639, 5779.826605201851, 5782.595218334676, 5968.283805943314, 5987.910181347196, 6000.189974353581, 6003.489703375262, 6013.639181649115], "unit": "ms", "name": "mootools.html", "value": 4016.644034875592}, {"lowerIsBetter": false, "replicates": [310.38388798235496, 316.52837272464035, 320.8139279218053, 320.82194382117916, 322.51622566150775, 5111.361079865017, 5282.392524859642, 5292.364916210051, 5309.814156504528, 5322.175062865253, 5146.150885103953, 5213.218017297408, 5238.816641417541, 5239.161734122541, 5245.8950820983555, 3840.923181536368, 3907.5310962684375, 3925.1757131002523, 4053.088055187589, 4074.633283004536, 3992.2614316351423, 4027.899302517446, 4032.1532478179615, 4048.4534587830562, 4054.108096218827, 4004.1190937993597, 4004.299247631667, 4005.3591425371947, 4007.9599204008023, 4010.8596199133035, 3799.4490798834154, 3876.089119057019, 3928.823202955874, 3966.365381538969, 4008.318585840414, 3489.2846966372085, 3497.178163131662, 3500.474928760681, 3506.1234691327168, 3511.859525618998, 4887.14474966883, 4910.631702622282, 4910.680805747651, 4917.041176970492, 4924.089043526959, 4574.268117101281, 4581.198290299184, 4583.770811459413, 4584.106099310636, 4588.770561471946, 5226.764795584208, 5376.91934620981, 5383.67697938125, 5436.565074794007, 5440.564754819645, 3819.9045023874623, 3821.1593449441357, 3822.120912190184, 3823.3118038753014, 3825.387937929918, 5644.57665675076, 5710.514606258473, 5713.314402271712, 5726.3700992890745, 5728.341240757324, 3933.6263055009726, 3939.153082087365, 3942.172143849766, 3942.290387730236, 3946.3291240489184, 3906.511686039245, 3989.4813674222746, 3998.420229066769, 4010.3382941814857, 4013.618706222904, 4571.26859702446, 4579.862604121881, 4587.518310577408, 4590.173768721662, 4590.311453281967, 5413.512783849473, 5415.404305526389, 5433.538149257357, 5442.319710036246, 5446.509814116748, 1380.5306195893445, 1403.2843249942603, 1404.3259235566984, 1415.1367665723901, 1415.7097794952217, 942.2462030375672, 943.7451887990342, 951.5194826612517, 969.8690676758547, 971.0871780526282, 4811.08589368019, 4823.517648235148, 4829.73436460998, 4830.082284365959, 4830.203016502308, 5613.298337707786, 5616.775328986876, 5617.0, 5622.128570071645, 5628.127640215773, 4788.353572267699, 4819.49395313487, 4827.637927155477, 4832.63755218353, 4836.153673107192, 2804.467151241258, 2912.577676236976, 2981.5229563269772, 3005.3838963012968, 3033.8634761435787, 5342.412334643186, 5420.674759514442, 5436.429174936575, 5440.129579267377, 5441.347038355423, 5810.970945145247, 5818.883622327529, 5819.476247137778, 5821.79623713168, 5832.075415113002, 5429.049916264638, 5431.945680543144, 5436.103042997861, 5437.374701909331, 5437.8368648940595, 5516.834494965157, 5656.773729050792, 5659.801906933238, 5660.405657406078, 5668.149777533238, 5534.142207957773, 5548.167774833807, 5549.361823390362, 5551.9722401387735, 5552.500274975271, 5394.32570928634, 5425.050616142238, 5432.9185062223305, 5433.293671822637, 5436.0, 3950.3284441645565, 3950.767816183847, 3950.861719839907, 3951.6641085508054, 3952.9407058894717, 5507.366652834975, 5656.43435656431, 5660.971695141498, 5662.348829884616, 5664.631798933056, 5446.101393270066, 5447.101228297287, 5456.399796022513, 5456.48163424474, 5456.972715136399, 5441.0, 5449.073657478159, 5456.290682211287, 5457.918131227955, 5460.453954604666, 5204.453532379046, 5344.812931547377, 5347.0, 5352.732363381738, 5352.759125839269, 5480.753366098455, 5491.368492623399, 5494.2582751329655, 5498.5876059296515, 5506.311711036121, 5122.847359344118, 5212.218167274939, 5296.470352964827, 5357.142857142839, 5366.6243362964215], "unit": "ms", "name": "prototype.html", "value": 4106.005370823472}, {"lowerIsBetter": false, "replicates": [707.7133760826866, 727.6980053277887, 745.7613563659631, 755.2221212151483, 796.80079980005, 11618.0, 11675.065994720424, 11681.532738690463, 11704.707382315446, 11709.063274938006, 11206.551737930493, 11858.881411185885, 11966.222195557304, 11970.760584788299, 11982.340971246578, 643.8358218654237, 652.448680864671, 807.2169995104754, 810.1979040749675, 820.1634332980386, 810.8378324335127, 816.873384625381, 822.7655118291289, 824.4929368438397, 825.7110011495959, 861.5261606116642, 870.843248215321, 871.5511511571545, 871.7646235516406, 872.2498651159997, 661.216458496683, 671.8186089755764, 838.1450920061503, 854.1287886355944, 857.3312816003527, 629.3894921925724, 630.2405601250482, 632.1434456311723, 634.6160572853404, 634.8127302445789, 11404.885951140466, 11422.71443213918, 11440.370779607118, 11469.770604587862, 11490.597829076025, 10690.66366704162, 11471.541138354456, 11584.884151158549, 11661.416929153509, 11663.59177428786, 9096.090390960917, 9151.725448236564, 9175.403598766126, 9280.35037547372, 9326.0, 3129.4836352001894, 3145.056483055097, 3167.984160079208, 3172.159377764894, 3173.3177366866003, 36594.26811463756, 37138.257234855155, 37175.25649487022, 37213.25573488515, 37269.25461490782, 9140.54297285133, 9197.954010229905, 9228.5847136879, 9550.952245238868, 9566.61733530665, 15672.294746736196, 15747.921260393625, 15776.447824326093, 15800.841991580168, 15805.68388632221, 6215.098810672517, 6406.2953075161695, 6413.390727880844, 6550.115734375799, 6575.605463672195, 3552.0942159749616, 3646.033801042726, 3647.872324468684, 3650.178709790276, 3656.2321912398693, 2551.1708694674303, 2596.7533084356955, 2597.8830952607177, 2603.127952136018, 2604.1666666666865, 462.3503976912443, 465.3438651501367, 465.4205514134924, 472.5817651378555, 475.2064053031377, 386.4222986634999, 415.8523724077969, 427.3952357414286, 438.8683394981493, 459.39360044740624, 7064.788056358318, 7228.96385518069, 7283.672234749449, 7297.452691048193, 7368.852622947511, 393.0723492557562, 442.3850847322225, 473.6707987948343, 484.056090623286, 516.628027819969, 3273.1489812648883, 3435.1927297085167, 3459.0, 3546.095745584911, 3555.4311310190246, 49232.507674922796, 49298.26052609214, 49360.0, 49430.0, 49457.50542494601, 38279.0, 38443.42334864979, 43021.56978430238, 43346.0, 43384.0, 39688.80155599204, 39794.20411591752, 40192.59807401947, 41019.9999999994, 41046.0, 7331.816704582428, 7669.5398276103615, 7763.340116090196, 7892.84214315699, 7949.562774047483, 29735.70264297416, 30242.54636180503, 30674.07977760671, 31042.844785775927, 31077.844610776803, 38440.80779596196, 38446.423303649906, 38509.614903850605, 38652.0, 38877.0, 9612.66355677548, 9770.267229957924, 9893.466438203028, 10098.747531311776, 10467.738306542398, 10224.64213752515, 10347.741306467398, 10394.376337419477, 10728.463576820972, 10942.56229750833, 10639.521221544894, 10781.676549703521, 10902.78194436091, 11069.391183484986, 11158.776824463628, 10147.391156530632, 10227.59089636436, 10253.692389228336, 10322.845157322496, 10344.896551034695, 8293.637716328669, 9680.661176858775, 10033.899661003588, 10238.18094552449, 10822.729431764268, 8299.460535065202, 8325.014278973853, 8411.074781774123, 8493.193146651058, 8525.87211191845, 8562.657493700432, 8727.694530691395, 8905.910940890508, 8968.327375446737, 9259.583318750538], "unit": "ms", "name": "yui.html", "value": 5518.210791930822}], "name": "dromaeo_css", "value": 6220.474347231137}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 105.0, 112.0, 113.0, 114.0, 100.0, 113.0, 112.0, 103.0], "unit": "ms", "name": "ai-astar", "value": 109.4}, {"lowerIsBetter": true, "replicates": [160.0, 127.0, 150.0, 168.0, 130.0, 156.0, 153.0, 129.0, 168.0, 135.0], "unit": "ms", "name": "audio-beat-detection", "value": 147.6}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 160.0, 162.0, 162.0, 161.0, 162.0, 164.0, 164.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 162.2}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 86.0, 92.0, 72.0, 72.0, 72.0, 103.0, 89.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 80.3}, {"lowerIsBetter": true, "replicates": [94.0, 96.0, 131.0, 94.0, 94.0, 95.0, 146.0, 96.0, 94.0, 131.0], "unit": "ms", "name": "audio-oscillator", "value": 107.1}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 109.0, 110.0, 109.0, 110.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.0}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 72.0, 72.0, 73.0, 72.0, 72.0, 86.0, 69.0, 70.0], "unit": "ms", "name": "json-parse-financial", "value": 73.0}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 67.0, 68.0, 67.0, 68.0, 68.0, 67.0, 67.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 67.5}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 83.0, 85.0, 84.0, 84.0, 82.0, 85.0, 83.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.5}, {"lowerIsBetter": true, "replicates": [119.0, 118.0, 125.0, 120.0, 122.0, 118.0, 119.0, 121.0, 125.0, 119.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 120.6}, {"lowerIsBetter": true, "replicates": [137.0, 145.0, 147.0, 156.0, 141.0, 139.0, 154.0, 149.0, 147.0, 135.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.0}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 69.0, 71.0, 70.0, 68.0, 70.0, 67.0, 69.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.3}], "name": "kraken", "value": 1516.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.86187098953056], "unit": "score", "name": "Richards", "value": 209.058444}, {"lowerIsBetter": false, "replicates": [185.9427296392711], "unit": "score", "name": "DeltaBlue", "value": 355.5826040000001}, {"lowerIsBetter": false, "replicates": [278.08676307007784], "unit": "score", "name": "Encrypt", "value": 957.1868759999999}, {"lowerIsBetter": false, "replicates": [5427.027027027027], "unit": "score", "name": "Decrypt", "value": 49.04729581673304}, {"lowerIsBetter": false, "replicates": [2010.0401606425703], "unit": "score", "name": "RayTrace", "value": 368.1463756243757}, {"lowerIsBetter": false, "replicates": [789.2659826361484], "unit": "score", "name": "Earley", "value": 844.4086210000003}, {"lowerIsBetter": false, "replicates": [12144.578313253012], "unit": "score", "name": "Boyer", "value": 54.87740972222223}, {"lowerIsBetter": false, "replicates": [27243.243243243243], "unit": "score", "name": "RegExp", "value": 33.43893353174606}, {"lowerIsBetter": false, "replicates": [609.3845216331505], "unit": "score", "name": "Splay", "value": 133.72673099999997}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19630.0731997656}]} 05:14:36 INFO - RETURN: dromaeo_css: 6220.47 05:14:36 INFO - RETURN: kraken: 1516.30 05:14:36 INFO - RETURN: v8_7: 19630.07 05:14:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "19630.07"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1516.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "6220.47"}}} 05:14:36 INFO - Return code: 0 05:14:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:14:36 ERROR - # TBPL SUCCESS # 05:14:36 INFO - Running post-action listener: _resource_record_post_action 05:14:36 INFO - Running post-run listener: _resource_record_post_run 05:14:37 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 8192; Write bytes: 508235776; Read time: 24; Write time: 534032 05:14:37 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 232337408; Read time: 0; Write time: 384240 05:14:37 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 8192; Write bytes: 275898368; Read time: 24; Write time: 149792 05:14:37 INFO - Running post-run listener: _upload_blobber_files 05:14:37 INFO - Blob upload gear active. 05:14:37 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:14:37 INFO - Copying logs to upload dir... 05:14:37 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1285.401552 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2015-12-10 05:14:37.717798) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-10 05:14:37.721913) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1449751990.97621-57362914 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/fHY71w4zTdq0sy57y7INIw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009964 build_url: 'https://queue.taskcluster.net/v1/task/fHY71w4zTdq0sy57y7INIw/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-10 05:14:37.774130) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 05:14:37.774559) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1449751990.97621-57362914 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004473 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 05:14:37.824673) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-10 05:14:37.825021) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-10 05:14:37.825374) ========= ========= Total master_lag: 0.28 =========