builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-042 starttime: 1449163377.83 results: success (0) buildid: 20151203080144 builduid: f4b6602647b5467591f41bc8ae86f70f revision: 33d954cc69ff8e0bd22410e3641533e4fac500cf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 09:22:57.833765) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 09:22:57.834266) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 09:22:57.834563) ========= 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=c402a24d74c70935940d60dd000001de-1449163376.491051-1884885895 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006265 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 09:22:57.857866) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 09:22:57.858207) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 09:22:57.874135) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 09:22:57.874543) ========= 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=c402a24d74c70935940d60dd000001de-1449163376.491051-1884885895 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004546 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 09:22:57.924488) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 09:22:57.924832) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 09:22:57.925301) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 09:22:57.925606) ========= 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=c402a24d74c70935940d60dd000001de-1449163376.491051-1884885895 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-03 09:22:58-- 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% 84.5M=0s 2015-12-03 09:22:59 (84.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.196694 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 09:22:58.136080) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 09:22:58.136565) ========= 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=c402a24d74c70935940d60dd000001de-1449163376.491051-1884885895 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014073 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 09:22:58.187132) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 09:22:58.187516) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 33d954cc69ff8e0bd22410e3641533e4fac500cf --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 33d954cc69ff8e0bd22410e3641533e4fac500cf --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=c402a24d74c70935940d60dd000001de-1449163376.491051-1884885895 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-03 09:22:59,166 truncating revision to first 12 chars 2015-12-03 09:22:59,166 Setting DEBUG logging. 2015-12-03 09:22:59,166 attempt 1/10 2015-12-03 09:22:59,166 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/33d954cc69ff?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-03 09:22:59,470 unpacking tar archive at: mozilla-central-33d954cc69ff/testing/mozharness/ program finished with exit code 0 elapsedTime=0.583923 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 09:22:58.784543) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 09:22:58.784884) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 09:22:58.796348) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 09:22:58.796860) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 09:22:58.797549) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-03 09:22:58.797964) ========= /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=c402a24d74c70935940d60dd000001de-1449163376.491051-1884885895 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:22:59 INFO - MultiFileLogger online at 20151203 09:22:59 in /builds/slave/test 09:22:59 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 09:22:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:22:59 INFO - {'append_to_log': False, 09:22:59 INFO - 'base_work_dir': '/builds/slave/test', 09:22:59 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:22:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:22:59 INFO - 'branch': 'Firefox-Non-PGO', 09:22:59 INFO - 'buildbot_json_path': 'buildprops.json', 09:22:59 INFO - 'config_files': ('talos/linux_config.py',), 09:22:59 INFO - 'default_actions': ('clobber', 09:22:59 INFO - 'read-buildbot-config', 09:22:59 INFO - 'download-and-extract', 09:22:59 INFO - 'populate-webroot', 09:22:59 INFO - 'create-virtualenv', 09:22:59 INFO - 'install', 09:22:59 INFO - 'run-tests'), 09:22:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:22:59 INFO - 'download_minidump_stackwalk': True, 09:22:59 INFO - 'download_symbols': 'ondemand', 09:22:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:22:59 INFO - 'tooltool.py': '/tools/tooltool.py', 09:22:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:22:59 INFO - '/tools/misc-python/virtualenv.py')}, 09:22:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:22:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:22:59 INFO - 'installer_path': 'installer.exe', 09:22:59 INFO - 'log_level': 'info', 09:22:59 INFO - 'log_name': 'talos', 09:22:59 INFO - 'log_to_console': True, 09:22:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:22:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:22:59 INFO - 'opt_config_files': (), 09:22:59 INFO - 'pip_index': False, 09:22:59 INFO - 'sps_profile': False, 09:22:59 INFO - 'sps_profile_interval': 0, 09:22:59 INFO - 'suite': 'dromaeojs', 09:22:59 INFO - 'system_bits': '64', 09:22:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:22:59 INFO - 'title': 'talos-linux64-ix-042', 09:22:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:22:59 INFO - 'use_talos_json': True, 09:22:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:22:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:22:59 INFO - 'work_dir': 'build'} 09:22:59 INFO - ##### 09:22:59 INFO - ##### Running clobber step. 09:22:59 INFO - ##### 09:22:59 INFO - Running pre-action listener: _resource_record_pre_action 09:22:59 INFO - Running main action method: clobber 09:22:59 INFO - rmtree: /builds/slave/test/build 09:22:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:23:00 INFO - Running post-action listener: _resource_record_post_action 09:23:00 INFO - ##### 09:23:00 INFO - ##### Running read-buildbot-config step. 09:23:00 INFO - ##### 09:23:00 INFO - Running pre-action listener: _resource_record_pre_action 09:23:00 INFO - Running main action method: read_buildbot_config 09:23:00 INFO - Using buildbot properties: 09:23:00 INFO - { 09:23:00 INFO - "properties": { 09:23:00 INFO - "buildnumber": 393, 09:23:00 INFO - "product": "firefox", 09:23:00 INFO - "script_repo_revision": "production", 09:23:00 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 09:23:00 INFO - "repository": "", 09:23:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 09:23:00 INFO - "buildid": "20151203080144", 09:23:00 INFO - "slavename": "talos-linux64-ix-042", 09:23:00 INFO - "pgo_build": "False", 09:23:00 INFO - "basedir": "/builds/slave/test", 09:23:00 INFO - "project": "", 09:23:00 INFO - "platform": "ubuntu64_hw", 09:23:00 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:23:00 INFO - "slavebuilddir": "test", 09:23:00 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 09:23:00 INFO - "branch": "mozilla-central", 09:23:00 INFO - "repo_path": "mozilla-central", 09:23:00 INFO - "stage_platform": "linux64", 09:23:00 INFO - "builduid": "f4b6602647b5467591f41bc8ae86f70f", 09:23:00 INFO - "revision": "33d954cc69ff8e0bd22410e3641533e4fac500cf" 09:23:00 INFO - }, 09:23:00 INFO - "sourcestamp": { 09:23:00 INFO - "repository": "", 09:23:00 INFO - "hasPatch": false, 09:23:00 INFO - "project": "", 09:23:00 INFO - "branch": "mozilla-central-linux64-talos", 09:23:00 INFO - "changes": [ 09:23:00 INFO - { 09:23:00 INFO - "category": null, 09:23:00 INFO - "files": [ 09:23:00 INFO - { 09:23:00 INFO - "url": null, 09:23:00 INFO - "name": "https://queue.taskcluster.net/v1/task/_EK_P05MQauvEdKksLZgrA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 09:23:00 INFO - } 09:23:00 INFO - ], 09:23:00 INFO - "repository": "", 09:23:00 INFO - "rev": "33d954cc69ff8e0bd22410e3641533e4fac500cf", 09:23:00 INFO - "who": "cbook@mozilla.com", 09:23:00 INFO - "when": 1449162870, 09:23:00 INFO - "number": 6739720, 09:23:00 INFO - "comments": "bug 1227340 - fix script to branch b2g-ota. a=sheriffduty a=NPOTB", 09:23:00 INFO - "project": "", 09:23:00 INFO - "at": "Thu 03 Dec 2015 09:14:30", 09:23:00 INFO - "branch": "mozilla-central-linux64-talos", 09:23:00 INFO - "revlink": "", 09:23:00 INFO - "properties": [ 09:23:00 INFO - [ 09:23:00 INFO - "buildid", 09:23:00 INFO - "20151203080144", 09:23:00 INFO - "Change" 09:23:00 INFO - ], 09:23:00 INFO - [ 09:23:00 INFO - "builduid", 09:23:00 INFO - "f4b6602647b5467591f41bc8ae86f70f", 09:23:00 INFO - "Change" 09:23:00 INFO - ], 09:23:00 INFO - [ 09:23:00 INFO - "pgo_build", 09:23:00 INFO - "False", 09:23:00 INFO - "Change" 09:23:00 INFO - ] 09:23:00 INFO - ], 09:23:00 INFO - "revision": "33d954cc69ff8e0bd22410e3641533e4fac500cf" 09:23:00 INFO - } 09:23:00 INFO - ], 09:23:00 INFO - "revision": "33d954cc69ff8e0bd22410e3641533e4fac500cf" 09:23:00 INFO - } 09:23:00 INFO - } 09:23:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/_EK_P05MQauvEdKksLZgrA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 09:23:00 INFO - Running post-action listener: _resource_record_post_action 09:23:00 INFO - ##### 09:23:00 INFO - ##### Running download-and-extract step. 09:23:00 INFO - ##### 09:23:00 INFO - Running pre-action listener: _resource_record_pre_action 09:23:00 INFO - Running main action method: download_and_extract 09:23:00 INFO - mkdir: /builds/slave/test/build/tests 09:23:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:00 INFO - https://queue.taskcluster.net/v1/task/_EK_P05MQauvEdKksLZgrA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:23:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_EK_P05MQauvEdKksLZgrA/artifacts/public/build/test_packages.json 09:23:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_EK_P05MQauvEdKksLZgrA/artifacts/public/build/test_packages.json 09:23:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_EK_P05MQauvEdKksLZgrA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:23:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_EK_P05MQauvEdKksLZgrA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:23:01 INFO - Downloaded 1302 bytes. 09:23:01 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:23:01 INFO - Using the following test package requirements: 09:23:01 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:23:01 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:23:01 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:23:01 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:23:01 INFO - u'jsshell-linux-x86_64.zip'], 09:23:01 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:23:01 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:23:01 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:23:01 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:23:01 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:23:01 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:23:01 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:23:01 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:23:01 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:23:01 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:23:01 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:23:01 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:23:01 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:01 INFO - https://queue.taskcluster.net/v1/task/_EK_P05MQauvEdKksLZgrA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:23:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_EK_P05MQauvEdKksLZgrA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:23:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_EK_P05MQauvEdKksLZgrA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:23:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_EK_P05MQauvEdKksLZgrA/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 09:23:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_EK_P05MQauvEdKksLZgrA/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 09:23:02 INFO - Downloaded 21793022 bytes. 09:23:02 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 09:23:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:23:02 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 09:23:03 INFO - Return code: 0 09:23:03 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 09:23:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:03 INFO - https://queue.taskcluster.net/v1/task/_EK_P05MQauvEdKksLZgrA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:23:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_EK_P05MQauvEdKksLZgrA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:23:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_EK_P05MQauvEdKksLZgrA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:23:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_EK_P05MQauvEdKksLZgrA/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 09:23:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_EK_P05MQauvEdKksLZgrA/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 09:23:04 INFO - Downloaded 21793022 bytes. 09:23:04 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 09:23:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:23:04 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 09:23:05 INFO - Return code: 0 09:23:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:05 INFO - https://queue.taskcluster.net/v1/task/_EK_P05MQauvEdKksLZgrA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:23:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_EK_P05MQauvEdKksLZgrA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:23:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_EK_P05MQauvEdKksLZgrA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:23:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_EK_P05MQauvEdKksLZgrA/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 09:23:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_EK_P05MQauvEdKksLZgrA/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 09:23:06 INFO - Downloaded 11132001 bytes. 09:23:06 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 09:23:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:23:06 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 09:23:07 INFO - Return code: 0 09:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:07 INFO - https://queue.taskcluster.net/v1/task/_EK_P05MQauvEdKksLZgrA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:23:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_EK_P05MQauvEdKksLZgrA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:23:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_EK_P05MQauvEdKksLZgrA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:23:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_EK_P05MQauvEdKksLZgrA/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 09:23:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_EK_P05MQauvEdKksLZgrA/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 09:23:08 INFO - Downloaded 57676968 bytes. 09:23:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/_EK_P05MQauvEdKksLZgrA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:23:08 INFO - mkdir: /builds/slave/test/properties 09:23:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:23:08 INFO - Writing to file /builds/slave/test/properties/build_url 09:23:08 INFO - Contents: 09:23:08 INFO - build_url:https://queue.taskcluster.net/v1/task/_EK_P05MQauvEdKksLZgrA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:23:08 INFO - Running post-action listener: _resource_record_post_action 09:23:08 INFO - Running post-action listener: set_extra_try_arguments 09:23:08 INFO - ##### 09:23:08 INFO - ##### Running populate-webroot step. 09:23:08 INFO - ##### 09:23:08 INFO - Running pre-action listener: _resource_record_pre_action 09:23:08 INFO - Running main action method: populate_webroot 09:23:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:23:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:23:08 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 09:23:08 INFO - '../fennec_ids.txt'], 09:23:08 INFO - 'tests': ['tcheck2']}, 09:23:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:23:08 INFO - '--tppagecycles', 09:23:08 INFO - '7'], 09:23:08 INFO - 'tests': ['tsvgm']}}, 09:23:08 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:23:08 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:23:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:23:08 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:23:08 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:23:08 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:23:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:23:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:08 INFO - 'talos_options': ['--e10s'], 09:23:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:23:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:08 INFO - 'tests': ['damp', 'tps']}, 09:23:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:08 INFO - 'talos_options': ['--e10s'], 09:23:08 INFO - 'tests': ['damp', 'tps']}, 09:23:08 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:23:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:23:08 INFO - 'other': {'tests': ['a11yr', 09:23:08 INFO - 'ts_paint', 09:23:08 INFO - 'tpaint', 09:23:08 INFO - 'sessionrestore', 09:23:08 INFO - 'sessionrestore_no_auto_restore']}, 09:23:08 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:23:08 INFO - 'tests': ['a11yr', 09:23:08 INFO - 'ts_paint', 09:23:08 INFO - 'tpaint', 09:23:08 INFO - 'sessionrestore', 09:23:08 INFO - 'sessionrestore_no_auto_restore']}, 09:23:08 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:23:08 INFO - 'tests': ['a11yr', 09:23:08 INFO - 'ts_paint', 09:23:08 INFO - 'tpaint', 09:23:08 INFO - 'sessionrestore', 09:23:08 INFO - 'sessionrestore_no_auto_restore']}, 09:23:08 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:23:08 INFO - 'tests': ['a11yr', 09:23:08 INFO - 'ts_paint', 09:23:08 INFO - 'tpaint', 09:23:08 INFO - 'sessionrestore', 09:23:08 INFO - 'sessionrestore_no_auto_restore']}, 09:23:08 INFO - 'other_l64': {'tests': ['a11yr', 09:23:08 INFO - 'ts_paint', 09:23:08 INFO - 'tpaint', 09:23:08 INFO - 'sessionrestore', 09:23:08 INFO - 'sessionrestore_no_auto_restore']}, 09:23:08 INFO - 'other_nol64': {'tests': ['a11yr', 09:23:08 INFO - 'ts_paint', 09:23:08 INFO - 'tpaint', 09:23:08 INFO - 'sessionrestore', 09:23:08 INFO - 'sessionrestore_no_auto_restore']}, 09:23:08 INFO - 'svgr': {'tests': ['tsvgx', 09:23:08 INFO - 'tsvgr_opacity', 09:23:08 INFO - 'tart', 09:23:08 INFO - 'tscrollx', 09:23:08 INFO - 'cart']}, 09:23:08 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:23:08 INFO - 'tests': ['tsvgx', 09:23:08 INFO - 'tsvgr_opacity', 09:23:08 INFO - 'tart', 09:23:08 INFO - 'tscrollx', 09:23:08 INFO - 'cart']}, 09:23:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:08 INFO - 'tests': ['tp5o']}, 09:23:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:08 INFO - 'talos_options': ['--e10s'], 09:23:08 INFO - 'tests': ['tp5o']}, 09:23:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:08 INFO - 'talos_options': ['--xperf_path', 09:23:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:23:08 INFO - 'tests': ['tp5n']}, 09:23:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:08 INFO - 'talos_options': ['--e10s', 09:23:08 INFO - '--xperf_path', 09:23:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:23:08 INFO - 'tests': ['tp5n']}}, 09:23:08 INFO - 'talos.zip': {'path': '', 09:23:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:23:08 INFO - Running post-action listener: _resource_record_post_action 09:23:08 INFO - ##### 09:23:08 INFO - ##### Running create-virtualenv step. 09:23:08 INFO - ##### 09:23:08 INFO - Running pre-action listener: _resource_record_pre_action 09:23:08 INFO - Running main action method: create_virtualenv 09:23:08 INFO - Creating virtualenv /builds/slave/test/build/venv 09:23:08 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 09:23:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:23:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:23:08 INFO - Using real prefix '/usr' 09:23:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:23:09 INFO - Installing distribute.............................................................................................................................................................................................done. 09:23:11 INFO - Installing pip.................done. 09:23:11 INFO - Return code: 0 09:23:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:23:11 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')]} 09:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:11 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')]} 09:23:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:11 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 0x7fc2abc1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a310b0>, '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 0x1a31fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a32440>, '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': 'c402a24d74c70935940d60dd000001de-1449163376.491051-1884885895', '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 09:23:11 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 09:23:11 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 09:23:11 INFO - Using env: {'DISPLAY': ':0', 09:23:11 INFO - 'HOME': '/home/cltbld', 09:23:11 INFO - 'LANG': 'en_US.UTF-8', 09:23:11 INFO - 'LANGUAGE': 'en_US:en', 09:23:11 INFO - 'LOGNAME': 'cltbld', 09:23:11 INFO - 'MAIL': '/var/mail/cltbld', 09:23:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:11 INFO - 'MOZ_NO_REMOTE': '1', 09:23:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:11 INFO - 'NO_EM_RESTART': '1', 09:23:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:11 INFO - 'PWD': '/builds/slave/test', 09:23:11 INFO - 'SHELL': '/bin/bash', 09:23:11 INFO - 'SHLVL': '1', 09:23:11 INFO - 'TERM': 'linux', 09:23:11 INFO - 'TMOUT': '86400', 09:23:11 INFO - 'USER': 'cltbld', 09:23:11 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1449163376.491051-1884885895', 09:23:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:11 INFO - '_': '/tools/buildbot/bin/python'} 09:23:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:11 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 09:23:11 INFO - Cleaning up... 09:23:11 INFO - Return code: 0 09:23:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:23:11 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')]} 09:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:11 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')]} 09:23:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:11 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 0x7fc2abc1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a310b0>, '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 0x1a31fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a32440>, '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': 'c402a24d74c70935940d60dd000001de-1449163376.491051-1884885895', '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 09:23:11 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 09:23:11 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 09:23:11 INFO - Using env: {'DISPLAY': ':0', 09:23:11 INFO - 'HOME': '/home/cltbld', 09:23:11 INFO - 'LANG': 'en_US.UTF-8', 09:23:11 INFO - 'LANGUAGE': 'en_US:en', 09:23:11 INFO - 'LOGNAME': 'cltbld', 09:23:11 INFO - 'MAIL': '/var/mail/cltbld', 09:23:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:11 INFO - 'MOZ_NO_REMOTE': '1', 09:23:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:11 INFO - 'NO_EM_RESTART': '1', 09:23:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:11 INFO - 'PWD': '/builds/slave/test', 09:23:11 INFO - 'SHELL': '/bin/bash', 09:23:11 INFO - 'SHLVL': '1', 09:23:11 INFO - 'TERM': 'linux', 09:23:11 INFO - 'TMOUT': '86400', 09:23:11 INFO - 'USER': 'cltbld', 09:23:11 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1449163376.491051-1884885895', 09:23:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:11 INFO - '_': '/tools/buildbot/bin/python'} 09:23:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:11 INFO - Downloading/unpacking psutil>=0.7.1 09:23:11 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 09:23:11 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 09:23:11 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 09:23:11 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 09:23:11 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 09:23:11 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 09:23:13 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 09:23:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:23:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:23:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:23:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:23:13 INFO - Installing collected packages: psutil 09:23:13 INFO - Running setup.py install for psutil 09:23:13 INFO - building 'psutil._psutil_linux' extension 09:23:13 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 09:23:13 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 09:23:13 INFO - building 'psutil._psutil_posix' extension 09:23:13 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 09:23:13 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 09:23:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:23:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:23:13 INFO - Successfully installed psutil 09:23:13 INFO - Cleaning up... 09:23:13 INFO - Return code: 0 09:23:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:23: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')]} 09:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23: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')]} 09:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:13 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 0x7fc2abc1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a310b0>, '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 0x1a31fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a32440>, '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': 'c402a24d74c70935940d60dd000001de-1449163376.491051-1884885895', '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 09:23:13 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 09:23:13 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 09:23:13 INFO - Using env: {'DISPLAY': ':0', 09:23:13 INFO - 'HOME': '/home/cltbld', 09:23:13 INFO - 'LANG': 'en_US.UTF-8', 09:23:13 INFO - 'LANGUAGE': 'en_US:en', 09:23:13 INFO - 'LOGNAME': 'cltbld', 09:23:13 INFO - 'MAIL': '/var/mail/cltbld', 09:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:13 INFO - 'MOZ_NO_REMOTE': '1', 09:23:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:13 INFO - 'NO_EM_RESTART': '1', 09:23:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:13 INFO - 'PWD': '/builds/slave/test', 09:23:13 INFO - 'SHELL': '/bin/bash', 09:23:13 INFO - 'SHLVL': '1', 09:23:13 INFO - 'TERM': 'linux', 09:23:13 INFO - 'TMOUT': '86400', 09:23:13 INFO - 'USER': 'cltbld', 09:23:13 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1449163376.491051-1884885895', 09:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:13 INFO - '_': '/tools/buildbot/bin/python'} 09:23:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:14 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:23:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:23:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:23:15 INFO - Installing collected packages: mozsystemmonitor 09:23:15 INFO - Running setup.py install for mozsystemmonitor 09:23:15 INFO - Successfully installed mozsystemmonitor 09:23:15 INFO - Cleaning up... 09:23:16 INFO - Return code: 0 09:23:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:23: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')]} 09:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23: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')]} 09:23:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:16 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 0x7fc2abc1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a310b0>, '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 0x1a31fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a32440>, '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': 'c402a24d74c70935940d60dd000001de-1449163376.491051-1884885895', '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 09:23:16 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 09:23:16 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 09:23:16 INFO - Using env: {'DISPLAY': ':0', 09:23:16 INFO - 'HOME': '/home/cltbld', 09:23:16 INFO - 'LANG': 'en_US.UTF-8', 09:23:16 INFO - 'LANGUAGE': 'en_US:en', 09:23:16 INFO - 'LOGNAME': 'cltbld', 09:23:16 INFO - 'MAIL': '/var/mail/cltbld', 09:23:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:16 INFO - 'MOZ_NO_REMOTE': '1', 09:23:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:16 INFO - 'NO_EM_RESTART': '1', 09:23:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:16 INFO - 'PWD': '/builds/slave/test', 09:23:16 INFO - 'SHELL': '/bin/bash', 09:23:16 INFO - 'SHLVL': '1', 09:23:16 INFO - 'TERM': 'linux', 09:23:16 INFO - 'TMOUT': '86400', 09:23:16 INFO - 'USER': 'cltbld', 09:23:16 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1449163376.491051-1884885895', 09:23:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:16 INFO - '_': '/tools/buildbot/bin/python'} 09:23:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:16 INFO - Downloading/unpacking blobuploader==1.2.4 09:23:16 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 09:23:16 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 09:23:16 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 09:23:16 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 09:23:16 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 09:23:16 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 09:23:17 INFO - Downloading blobuploader-1.2.4.tar.gz 09:23:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:23:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:23:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:23:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:23:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:23:18 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 09:23:18 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 09:23:18 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 09:23:18 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 09:23:18 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 09:23:18 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 09:23:18 INFO - Downloading docopt-0.6.1.tar.gz 09:23:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:23:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:23:18 INFO - Installing collected packages: blobuploader, requests, docopt 09:23:18 INFO - Running setup.py install for blobuploader 09:23:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:23:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:23:18 INFO - Running setup.py install for requests 09:23:19 INFO - Running setup.py install for docopt 09:23:19 INFO - Successfully installed blobuploader requests docopt 09:23:19 INFO - Cleaning up... 09:23:19 INFO - Return code: 0 09:23:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:23:19 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')]} 09:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:19 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')]} 09:23:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:19 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 0x7fc2abc1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a310b0>, '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 0x1a31fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a32440>, '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': 'c402a24d74c70935940d60dd000001de-1449163376.491051-1884885895', '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 09:23:19 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 09:23:19 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 09:23:19 INFO - Using env: {'DISPLAY': ':0', 09:23:19 INFO - 'HOME': '/home/cltbld', 09:23:19 INFO - 'LANG': 'en_US.UTF-8', 09:23:19 INFO - 'LANGUAGE': 'en_US:en', 09:23:19 INFO - 'LOGNAME': 'cltbld', 09:23:19 INFO - 'MAIL': '/var/mail/cltbld', 09:23:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:19 INFO - 'MOZ_NO_REMOTE': '1', 09:23:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:19 INFO - 'NO_EM_RESTART': '1', 09:23:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:19 INFO - 'PWD': '/builds/slave/test', 09:23:19 INFO - 'SHELL': '/bin/bash', 09:23:19 INFO - 'SHLVL': '1', 09:23:19 INFO - 'TERM': 'linux', 09:23:19 INFO - 'TMOUT': '86400', 09:23:19 INFO - 'USER': 'cltbld', 09:23:19 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1449163376.491051-1884885895', 09:23:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:19 INFO - '_': '/tools/buildbot/bin/python'} 09:23:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:23:19 INFO - Running setup.py (path:/tmp/pip-Ol2eTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:23:19 INFO - Running setup.py (path:/tmp/pip-VKq6Z_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:23:19 INFO - Running setup.py (path:/tmp/pip-QsreBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:23:19 INFO - Running setup.py (path:/tmp/pip-EKyDlc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:23:19 INFO - Running setup.py (path:/tmp/pip-6Weoh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:23:19 INFO - Running setup.py (path:/tmp/pip-czHf4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:23:19 INFO - Running setup.py (path:/tmp/pip-ka4YWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:23:19 INFO - Running setup.py (path:/tmp/pip-OylH7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:23:20 INFO - Running setup.py (path:/tmp/pip-iNhRjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:23:20 INFO - Running setup.py (path:/tmp/pip-c8BNzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:23:20 INFO - Running setup.py (path:/tmp/pip-KcxSaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:23:20 INFO - Running setup.py (path:/tmp/pip-HPuWHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:23:20 INFO - Running setup.py (path:/tmp/pip-qITed3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:23:20 INFO - Running setup.py (path:/tmp/pip-srMwJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:23:20 INFO - Running setup.py (path:/tmp/pip-DUfGyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:23:20 INFO - Running setup.py (path:/tmp/pip-UT8I6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:23:20 INFO - Running setup.py (path:/tmp/pip-pDYJVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:23:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:23:20 INFO - Running setup.py install for manifestparser 09:23:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:23:20 INFO - Running setup.py install for mozcrash 09:23:20 INFO - Running setup.py install for mozdebug 09:23:20 INFO - Running setup.py install for mozdevice 09:23:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:23:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:23:21 INFO - Running setup.py install for mozfile 09:23:21 INFO - Running setup.py install for mozhttpd 09:23:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:23:21 INFO - Running setup.py install for mozinfo 09:23:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:23:21 INFO - Running setup.py install for mozInstall 09:23:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:23:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:23:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:23:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:23:21 INFO - Running setup.py install for mozleak 09:23:21 INFO - Running setup.py install for mozlog 09:23:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:23:21 INFO - Running setup.py install for moznetwork 09:23:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:23:21 INFO - Running setup.py install for mozprocess 09:23:21 INFO - Running setup.py install for mozprofile 09:23:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:23:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:23:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:23:22 INFO - Running setup.py install for mozrunner 09:23:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:23:22 INFO - Running setup.py install for mozscreenshot 09:23:22 INFO - Running setup.py install for moztest 09:23:22 INFO - Running setup.py install for mozversion 09:23:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:23:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:23:22 INFO - Cleaning up... 09:23:22 INFO - Return code: 0 09:23:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:23:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x7fc2abc1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a310b0>, '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 0x1a31fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a32440>, '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': 'c402a24d74c70935940d60dd000001de-1449163376.491051-1884885895', '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 09:23:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 09:23:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/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 09:23:22 INFO - Using env: {'DISPLAY': ':0', 09:23:22 INFO - 'HOME': '/home/cltbld', 09:23:22 INFO - 'LANG': 'en_US.UTF-8', 09:23:22 INFO - 'LANGUAGE': 'en_US:en', 09:23:22 INFO - 'LOGNAME': 'cltbld', 09:23:22 INFO - 'MAIL': '/var/mail/cltbld', 09:23:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:22 INFO - 'MOZ_NO_REMOTE': '1', 09:23:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:22 INFO - 'NO_EM_RESTART': '1', 09:23:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:22 INFO - 'PWD': '/builds/slave/test', 09:23:22 INFO - 'SHELL': '/bin/bash', 09:23:22 INFO - 'SHLVL': '1', 09:23:22 INFO - 'TERM': 'linux', 09:23:22 INFO - 'TMOUT': '86400', 09:23:22 INFO - 'USER': 'cltbld', 09:23:22 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1449163376.491051-1884885895', 09:23:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:22 INFO - '_': '/tools/buildbot/bin/python'} 09:23:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:23:22 INFO - Running setup.py (path:/tmp/pip-HcqJSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:23:22 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)) 09:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:23:22 INFO - Running setup.py (path:/tmp/pip-SOwbe9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:23:22 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)) 09:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:23:22 INFO - Running setup.py (path:/tmp/pip-qDJziP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:23:22 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)) 09:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:23:22 INFO - Running setup.py (path:/tmp/pip-ZRcmpl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:23:22 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)) 09:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:23:22 INFO - Running setup.py (path:/tmp/pip-Yz5wlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:23:23 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)) 09:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:23:23 INFO - Running setup.py (path:/tmp/pip-p9AB05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:23:23 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)) 09:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:23:23 INFO - Running setup.py (path:/tmp/pip-pdX0KA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:23:23 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)) 09:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:23:23 INFO - Running setup.py (path:/tmp/pip-5JGne8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:23:23 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)) 09:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:23:23 INFO - Running setup.py (path:/tmp/pip-17spf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:23:23 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)) 09:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:23:23 INFO - Running setup.py (path:/tmp/pip-M7n1T9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:23:23 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)) 09:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:23:23 INFO - Running setup.py (path:/tmp/pip-26sxt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:23:23 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)) 09:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:23:23 INFO - Running setup.py (path:/tmp/pip-ozGZ62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:23:23 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)) 09:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:23:23 INFO - Running setup.py (path:/tmp/pip-ffbG0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:23:23 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)) 09:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:23:23 INFO - Running setup.py (path:/tmp/pip-Bt5jM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:23:23 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)) 09:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:23:23 INFO - Running setup.py (path:/tmp/pip-khFJY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:23:23 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)) 09:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:23:23 INFO - Running setup.py (path:/tmp/pip-EdivKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:23:23 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)) 09:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:23:23 INFO - Running setup.py (path:/tmp/pip-XMiDgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:23:23 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)) 09:23:23 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)) 09:23:23 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)) 09:23:23 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)) 09:23:23 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)) 09:23:23 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)) 09:23:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:23:23 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 09:23:23 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 09:23:23 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 09:23:23 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 09:23:23 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 09:23:23 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 09:23:25 INFO - Downloading blessings-1.5.1.tar.gz 09:23:25 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 09:23:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:23:25 INFO - Installing collected packages: blessings 09:23:25 INFO - Running setup.py install for blessings 09:23:25 INFO - Successfully installed blessings 09:23:25 INFO - Cleaning up... 09:23:25 INFO - Return code: 0 09:23:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:23:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:23:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:23:26 INFO - Reading from file tmpfile_stdout 09:23:26 INFO - Current package versions: 09:23:26 INFO - argparse == 1.2.1 09:23:26 INFO - blessings == 1.5.1 09:23:26 INFO - blobuploader == 1.2.4 09:23:26 INFO - docopt == 0.6.1 09:23:26 INFO - manifestparser == 1.1 09:23:26 INFO - mozInstall == 1.12 09:23:26 INFO - mozcrash == 0.16 09:23:26 INFO - mozdebug == 0.1 09:23:26 INFO - mozdevice == 0.47 09:23:26 INFO - mozfile == 1.2 09:23:26 INFO - mozhttpd == 0.7 09:23:26 INFO - mozinfo == 0.9 09:23:26 INFO - mozleak == 0.1 09:23:26 INFO - mozlog == 3.1 09:23:26 INFO - moznetwork == 0.27 09:23:26 INFO - mozprocess == 0.22 09:23:26 INFO - mozprofile == 0.27 09:23:26 INFO - mozrunner == 6.11 09:23:26 INFO - mozscreenshot == 0.1 09:23:26 INFO - mozsystemmonitor == 0.0 09:23:26 INFO - moztest == 0.7 09:23:26 INFO - mozversion == 1.4 09:23:26 INFO - psutil == 3.1.1 09:23:26 INFO - requests == 1.2.3 09:23:26 INFO - wsgiref == 0.1.2 09:23:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:23:26 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')]} 09:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:26 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')]} 09:23:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:26 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 0x7fc2abc1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a310b0>, '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 0x1a31fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a32440>, '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': 'c402a24d74c70935940d60dd000001de-1449163376.491051-1884885895', '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 09:23:26 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 09:23:26 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 09:23:26 INFO - Using env: {'DISPLAY': ':0', 09:23:26 INFO - 'HOME': '/home/cltbld', 09:23:26 INFO - 'LANG': 'en_US.UTF-8', 09:23:26 INFO - 'LANGUAGE': 'en_US:en', 09:23:26 INFO - 'LOGNAME': 'cltbld', 09:23:26 INFO - 'MAIL': '/var/mail/cltbld', 09:23:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:26 INFO - 'MOZ_NO_REMOTE': '1', 09:23:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:26 INFO - 'NO_EM_RESTART': '1', 09:23:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:26 INFO - 'PWD': '/builds/slave/test', 09:23:26 INFO - 'SHELL': '/bin/bash', 09:23:26 INFO - 'SHLVL': '1', 09:23:26 INFO - 'TERM': 'linux', 09:23:26 INFO - 'TMOUT': '86400', 09:23:26 INFO - 'USER': 'cltbld', 09:23:26 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1449163376.491051-1884885895', 09:23:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:26 INFO - '_': '/tools/buildbot/bin/python'} 09:23:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:26 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)) 09:23:26 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)) 09:23:26 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)) 09:23:26 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)) 09:23:26 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)) 09:23:26 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)) 09:23:26 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)) 09:23:26 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)) 09:23:26 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)) 09:23:26 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)) 09:23:26 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)) 09:23:26 INFO - Cleaning up... 09:23:26 INFO - Return code: 0 09:23:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:23:26 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')]} 09:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:26 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')]} 09:23:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:26 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 0x7fc2abc1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a310b0>, '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 0x1a31fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a32440>, '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': 'c402a24d74c70935940d60dd000001de-1449163376.491051-1884885895', '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 09:23:26 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 09:23:26 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 09:23:26 INFO - Using env: {'DISPLAY': ':0', 09:23:26 INFO - 'HOME': '/home/cltbld', 09:23:26 INFO - 'LANG': 'en_US.UTF-8', 09:23:26 INFO - 'LANGUAGE': 'en_US:en', 09:23:26 INFO - 'LOGNAME': 'cltbld', 09:23:26 INFO - 'MAIL': '/var/mail/cltbld', 09:23:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:26 INFO - 'MOZ_NO_REMOTE': '1', 09:23:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:26 INFO - 'NO_EM_RESTART': '1', 09:23:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:26 INFO - 'PWD': '/builds/slave/test', 09:23:26 INFO - 'SHELL': '/bin/bash', 09:23:26 INFO - 'SHLVL': '1', 09:23:26 INFO - 'TERM': 'linux', 09:23:26 INFO - 'TMOUT': '86400', 09:23:26 INFO - 'USER': 'cltbld', 09:23:26 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1449163376.491051-1884885895', 09:23:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:26 INFO - '_': '/tools/buildbot/bin/python'} 09:23:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:26 INFO - Downloading/unpacking jsonschema 09:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:23:28 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 09:23:28 INFO - Downloading/unpacking functools32 (from jsonschema) 09:23:28 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 09:23:28 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 09:23:28 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 09:23:28 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 09:23:28 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 09:23:28 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 09:23:28 INFO - Downloading functools32-3.2.3-2.tar.gz 09:23:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 09:23:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:23:28 INFO - warning: no files found matching '*.txt' 09:23:28 INFO - no previously-included directories found matching 'build' 09:23:28 INFO - no previously-included directories found matching 'dist' 09:23:28 INFO - no previously-included directories found matching '.git*' 09:23:28 INFO - Installing collected packages: jsonschema, functools32 09:23:28 INFO - Running setup.py install for functools32 09:23:28 INFO - warning: no files found matching '*.txt' 09:23:28 INFO - no previously-included directories found matching 'build' 09:23:28 INFO - no previously-included directories found matching 'dist' 09:23:28 INFO - no previously-included directories found matching '.git*' 09:23:28 INFO - Successfully installed jsonschema functools32 09:23:28 INFO - Cleaning up... 09:23:28 INFO - Return code: 0 09:23:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:23:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:28 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 0x7fc2abc1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a310b0>, '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 0x1a31fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a32440>, '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': 'c402a24d74c70935940d60dd000001de-1449163376.491051-1884885895', '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 09:23:28 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 09:23:28 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 09:23:28 INFO - Using env: {'DISPLAY': ':0', 09:23:28 INFO - 'HOME': '/home/cltbld', 09:23:28 INFO - 'LANG': 'en_US.UTF-8', 09:23:28 INFO - 'LANGUAGE': 'en_US:en', 09:23:28 INFO - 'LOGNAME': 'cltbld', 09:23:28 INFO - 'MAIL': '/var/mail/cltbld', 09:23:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:28 INFO - 'MOZ_NO_REMOTE': '1', 09:23:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:28 INFO - 'NO_EM_RESTART': '1', 09:23:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:28 INFO - 'PWD': '/builds/slave/test', 09:23:28 INFO - 'SHELL': '/bin/bash', 09:23:28 INFO - 'SHLVL': '1', 09:23:28 INFO - 'TERM': 'linux', 09:23:28 INFO - 'TMOUT': '86400', 09:23:28 INFO - 'USER': 'cltbld', 09:23:28 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1449163376.491051-1884885895', 09:23:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:28 INFO - '_': '/tools/buildbot/bin/python'} 09:23:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:28 INFO - Downloading/unpacking flake8 09:23:28 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 09:23:28 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 09:23:28 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 09:23:28 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 09:23:28 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 09:23:28 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 09:23:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:23:30 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 09:23:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:23:30 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 09:23:30 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 09:23:30 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 09:23:30 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 09:23:30 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 09:23:30 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 09:23:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:23:30 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 09:23:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:23:30 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 09:23:30 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 09:23:30 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 09:23:30 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 09:23:30 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 09:23:30 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 09:23:30 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 09:23:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:23:30 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 09:23:30 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 09:23:30 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 09:23:30 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 09:23:30 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 09:23:30 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 09:23:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 09:23:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:23:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:23:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:23:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:23:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:23:31 INFO - no previously-included directories found matching 'docs/_build' 09:23:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:23:31 INFO - Running setup.py install for pep8 09:23:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:23:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:23:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:23:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:23:31 INFO - no previously-included directories found matching 'docs/_build' 09:23:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:23:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:23:31 INFO - Cleaning up... 09:23:31 INFO - Return code: 0 09:23:31 INFO - Running post-action listener: _resource_record_post_action 09:23:31 INFO - Running post-action listener: _start_resource_monitoring 09:23:31 INFO - Starting resource monitoring. 09:23:31 INFO - ##### 09:23:31 INFO - ##### Running install step. 09:23:31 INFO - ##### 09:23:31 INFO - Running pre-action listener: _resource_record_pre_action 09:23:31 INFO - Running main action method: install 09:23:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:23:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:23:31 INFO - Reading from file tmpfile_stdout 09:23:31 INFO - Detecting whether we're running mozinstall >=1.0... 09:23:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:23:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:23:31 INFO - Reading from file tmpfile_stdout 09:23:31 INFO - Output received: 09:23:31 INFO - Usage: mozinstall [options] installer 09:23:31 INFO - Options: 09:23:31 INFO - -h, --help show this help message and exit 09:23:31 INFO - -d DEST, --destination=DEST 09:23:31 INFO - Directory to install application into. [default: 09:23:31 INFO - "/builds/slave/test"] 09:23:31 INFO - --app=APP Application being installed. [default: firefox] 09:23:31 INFO - mkdir: /builds/slave/test/build/application 09:23:31 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'] 09:23:31 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 09:23:46 INFO - Reading from file tmpfile_stdout 09:23:46 INFO - Output received: 09:23:46 INFO - /builds/slave/test/build/application/firefox/firefox 09:23:46 INFO - Running post-action listener: _resource_record_post_action 09:23:46 INFO - ##### 09:23:46 INFO - ##### Running run-tests step. 09:23:46 INFO - ##### 09:23:46 INFO - Running pre-action listener: _resource_record_pre_action 09:23:46 INFO - Running main action method: run_tests 09:23:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:23:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:23:46 INFO - Python 2.7.3 09:23:46 INFO - Return code: 0 09:23:46 INFO - grabbing minidump binary from tooltool 09:23: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')]} 09:23:46 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 0x1a310b0>, '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 0x1a31fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a32440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:23:46 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 09:23:46 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 09:23:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:23:46 INFO - Return code: 0 09:23:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:23:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:23:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:23:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:23:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:23:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:23:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:23:47 INFO - Return code: 0 09:23:47 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/_EK_P05MQauvEdKksLZgrA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost'] in /builds/slave/test/build 09:23:47 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/_EK_P05MQauvEdKksLZgrA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --webServer localhost 09:23:47 INFO - Using env: {'DISPLAY': ':0', 09:23:47 INFO - 'HOME': '/home/cltbld', 09:23:47 INFO - 'LANG': 'en_US.UTF-8', 09:23:47 INFO - 'LANGUAGE': 'en_US:en', 09:23:47 INFO - 'LOGNAME': 'cltbld', 09:23:47 INFO - 'MAIL': '/var/mail/cltbld', 09:23:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:23:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:23:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:47 INFO - 'MOZ_NO_REMOTE': '1', 09:23:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:23:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:47 INFO - 'NO_EM_RESTART': '1', 09:23:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:47 INFO - 'PWD': '/builds/slave/test', 09:23:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:23:47 INFO - 'SHELL': '/bin/bash', 09:23:47 INFO - 'SHLVL': '1', 09:23:47 INFO - 'TERM': 'linux', 09:23:47 INFO - 'TMOUT': '86400', 09:23:47 INFO - 'USER': 'cltbld', 09:23:47 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1449163376.491051-1884885895', 09:23:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:47 INFO - '_': '/tools/buildbot/bin/python'} 09:23:47 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/_EK_P05MQauvEdKksLZgrA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost'] with output_timeout 3600 09:23:47 INFO - mozversion INFO | application_buildid: 20151203080144 09:23:47 INFO - mozversion INFO | application_changeset: 33d954cc69ff8e0bd22410e3641533e4fac500cf 09:23:47 INFO - mozversion INFO | application_display_name: Nightly 09:23:47 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:23:47 INFO - mozversion INFO | application_name: Firefox 09:23:47 INFO - mozversion INFO | application_remotingname: firefox 09:23:47 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 09:23:47 INFO - mozversion INFO | application_vendor: Mozilla 09:23:47 INFO - mozversion INFO | application_version: 45.0a1 09:23:47 INFO - mozversion INFO | platform_buildid: 20151203080144 09:23:47 INFO - mozversion INFO | platform_changeset: 33d954cc69ff8e0bd22410e3641533e4fac500cf 09:23:47 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 09:23:47 INFO - mozversion INFO | platform_version: 45.0a1 09:23:47 INFO - 2015-12-03 09:23:47,430 DEBUG : using testdate: 1449163427 09:23:47 INFO - 2015-12-03 09:23:47,430 DEBUG : actual date: 1449163427 09:23:47 INFO - 2015-12-03 09:23:47,439 INFO : starting webserver on 'localhost:58056' 09:23:47 INFO - 2015-12-03 09:23:47,440 INFO : Starting test suite talos-linux64-ix-042 09:23:47 INFO - 2015-12-03 09:23:47,440 INFO : Starting test dromaeo_css 09:23:47 INFO - 2015-12-03 09:23:47,440 DEBUG : operating with platform_type : linux_ 09:23:47 INFO - 2015-12-03 09:23:47,441 INFO : Initialising browser for dromaeo_css test... 09:23:47 INFO - 2015-12-03 09:23:47,457 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS0asFP/profile http://localhost:58056/getInfo.html 09:23:51 INFO - 2015-12-03 09:23:51,795 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:23:51 INFO - 2015-12-03 09:23:51,795 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:23:51 INFO - 2015-12-03 09:23:51,795 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:23:51 INFO - 2015-12-03 09:23:51,795 DEBUG : BROWSER_OUTPUT: __metrics 09:23:51 INFO - 2015-12-03 09:23:51,892 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] 09:23:51 INFO - 2015-12-03 09:23:51,893 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] 09:23:53 INFO - 2015-12-03 09:23:53,379 INFO : Browser initialized. 09:23:53 INFO - 2015-12-03 09:23:53,380 INFO : Running cycle 1/1 for dromaeo_css test... 09:23:53 INFO - 2015-12-03 09:23:53,380 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS0asFP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:24:05 INFO - 2015-12-03 09:24:05,379 DEBUG : BROWSER_OUTPUT: RSS: Main: 142831616 09:24:05 INFO - 2015-12-03 09:24:05,379 DEBUG : BROWSER_OUTPUT: 09:24:56 INFO - 2015-12-03 09:24:56,636 DEBUG : BROWSER_OUTPUT: 1449163496635 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] 09:27:08 INFO - 2015-12-03 09:27:08,697 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58056/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58056/tests/dromaeo/cssquery-ext.html) 09:27:09 INFO - 2015-12-03 09:27:09,746 DEBUG : BROWSER_OUTPUT: RSS: Main: 234926080 09:27:09 INFO - 2015-12-03 09:27:09,746 DEBUG : BROWSER_OUTPUT: 09:30:12 INFO - 2015-12-03 09:30:12,167 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58056/tests/dromaeo/cssquery-ext.html (next: http://localhost:58056/tests/dromaeo/cssquery-jquery.html) 09:30:12 INFO - 2015-12-03 09:30:12,748 DEBUG : BROWSER_OUTPUT: RSS: Main: 218963968 09:30:12 INFO - 2015-12-03 09:30:12,748 DEBUG : BROWSER_OUTPUT: 09:33:14 INFO - 2015-12-03 09:33:14,924 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58056/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58056/tests/dromaeo/cssquery-mootools.html) 09:33:15 INFO - 2015-12-03 09:33:15,506 DEBUG : BROWSER_OUTPUT: RSS: Main: 219099136 09:33:15 INFO - 2015-12-03 09:33:15,506 DEBUG : BROWSER_OUTPUT: 09:36:17 INFO - 2015-12-03 09:36:17,435 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58056/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58056/tests/dromaeo/cssquery-prototype.html) 09:36:18 INFO - 2015-12-03 09:36:18,019 DEBUG : BROWSER_OUTPUT: RSS: Main: 208076800 09:36:18 INFO - 2015-12-03 09:36:18,019 DEBUG : BROWSER_OUTPUT: 09:39:20 INFO - 2015-12-03 09:39:20,722 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58056/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58056/tests/dromaeo/cssquery-yui.html) 09:39:21 INFO - 2015-12-03 09:39:21,327 DEBUG : BROWSER_OUTPUT: RSS: Main: 210817024 09:39:21 INFO - 2015-12-03 09:39:21,327 DEBUG : BROWSER_OUTPUT: 09:42:24 INFO - 2015-12-03 09:42:24,096 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58056/tests/dromaeo/cssquery-yui.html (next: http://localhost:58056/tests/dromaeo/cssquery-dojo.html) 09:42:24 INFO - 2015-12-03 09:42:24,354 DEBUG : BROWSER_OUTPUT: RSS: Main: 229097472 09:42:24 INFO - 2015-12-03 09:42:24,354 DEBUG : BROWSER_OUTPUT: 09:42:24 INFO - 2015-12-03 09:42:24,355 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:42:24 INFO - 2015-12-03 09:42:24,355 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:42:24 INFO - 2015-12-03 09:42:24,355 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:42:24 INFO - 2015-12-03 09:42:24,355 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:42:24 INFO - 2015-12-03 09:42:24,355 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2591.7278685737997;2685.650865387498;2687.0460986349844;2693.5690289553677;2717.021872126035;4424.181526417615;4530.637548996081;4629.097326021423;4640.791164397598;4652.092841895832;4560;4592.311153327003;4666.300054991753;4691.085238378518;4693.788779504922;4246.469191351066;4269.402283680287;4291.613754762071;4362.629176519999;4389.188000219953;4309.547497512747;4364.49808272048;4378.64970802335;4394.296912494002;4439.778011099432;4105.117399759051;4191.224623444642;4192.0777428965575;4224.070704445017;4336.869893903188;4251.149770046003;4289.356596510548;4292.313229883203;4336.804843782037;4368.17004769096;4177.874663760092;4212.831486740557;4213.031002869327;4216.198922204802;4251.128518653669;4479.686421950465;4578.702384345007;4612.1467528507;4613.354130421743;4638.026014536951;4846.733429661367;4933.161362568372;4938.358013458227;4947.802087916479;4972.378452693413;5050.595952323805;5052.292679024939;5076.847694569169;5078.669886457368;5121.718305493197;4704.153252414564;4706.647001474903;4707.152712511781;4712.363830882821;4751.121042607128;4887.902241955212;4981.028699403581;4981.053599816023;5096.413912400121;5255.527002569787;4955.851324460272;4958.7024778513405;4968.080905032581;4978.352814134139;4999.700017998932;5062.594992400673;5065.721385323843;5072.54347108762;5073.086844367976;5076.187809950464;4713.764311784397;4715.4577223619035;4766.285057241372;4904.092742842586;4990.2764099205415;4934;4934.5312195341385;4938.975305123451;4940.555350018443;4980.800767969313;4152.1280531088205;4154.667626589866;4162.646175075092;4165.333546632524;4190.832366705297;3530.064532898784;3556.964430355715;3623.691986181204;3632.891013269606;3669.5779985301497;4263.680223983214;4266.0827921996915;4275.957240427556;4282.079352939133;4292.82828686849;4983.476734942851;4987.426445958761;4992.850214493571;4999.450060493416;5038.672486288379;4133.958660413417;4215.430916826251;4224.598663126998;4229.767362795014;4353.521112677603;4400.163968845973;4400.317950717644;4404.273294906305;4406.27296496081;4426.026274219666;4702.6708130431225;4704.29435584665;4704.482506924235;4705.976470117627;4751.382320298339;4722.5513576210205;4836;4845.5881250094135;4928.433230178575;5057.570106540985;4695.9530404695515;4712.7643617818285;4716.858494245178;4717.056588682209;4754.096721622881;4910.729909854992;4914.238293064581;4914.950850491592;4928.260760885896;4961.900761984813;4798.808047678054;4873.878153046202;4900.485449027943;4901.877453063702;4982.153033984304;4781.258904869751;4820.855374338636;4830.203016502238;4831.95168048315;4879.731614761222;4785.712857228577;4822.807087716593;4825.638077144158;4826.131296366688;4876.4392094909535;4528.230200865795;4621.260598304255;4624.052069325713;4666;4810.855674329776;4846.127697014571;4864.95135048645;4867.975660121819;4873.805047798049;4879.316895634685;4766.1659209638865;4766.66633335677;4767.475577686521;4767.998720268783;4796.472388037383 09:42:24 INFO - 2015-12-03 09:42:24,356 DEBUG : BROWSER_OUTPUT: |1;ext.html;564.0495764636585;565.8330792416236;566.9319681638204;572.997135014325;573;27953.440931181365;28618;36305.636943630554;37440.62559374405;37465.438018429675;39588;40082.398764018566;40097.59902400975;40174.19651606974;40186;6934.167899852025;7639.197884222146;7801.921980780176;7808.648610812499;7814.140444551095;7111.893321600181;10067.546960386764;10402.479876006208;10403.479826008706;10404.791904161912;9737.464439455862;9756.853647195298;9793.608255669764;9803.215742740564;9805.362651427635;7151.785446436563;7384.667689953965;9862.852057219148;9987.950060249688;10121.089101980857;9831.90168098317;9974.900250997469;9980.750481237954;9981.700548983543;9983.600655973753;36588.634113659056;36651;36983.445248321295;37041.444378334345;37131.25737485262;2745;2796.6504186976626;2893.1609833148364;3094.4430002599524;3399.847006884696;27827.304317392227;28151.296217594518;28348.29129271764;28552.714472855212;28885.56671649927;3205.439048166585;3206.88775892845;3211.2935154266024;3258.120307516981;3274.8526316315583;204559;204762;205050;205271;205783;49071.509284907406;50454;52868.20697689538;53265.467345326826;53316.20025699618;55763;56914.715426422605;57168;57250.713746431;57296.71351643299;12702.110852240254;12893.35533223335;12910.870891290966;12972.80540791889;12976.480940762263;9429.622815087458;9481.762955926157;9505.097015783489;9505.762355941157;9512.1439070484;17918.372856949944;18227.54431139232;18265.543361416072;18303;18339.174737136593;6783.796486105425;7013.544119632207;7022.192447868459;7074.575525468488;7154.821129471701;825.628467189767;826.8139668574643;889.9911000890038;896.1173244354305;975.9947254328054;26160.607590886153;26247.219257204793;26482.86758566195;26579.202623921312;26583.33541661435;962.379265373844;979.7991411760572;999.5102399824034;1000.9399436033716;1063.3566692151292;13100.279484628247;13271.933640331736;13314.53399131045;13324;13332.866671333357;361416;366057;366907;367095;367546;42487.36268955968;42674.359884601756;42700.78649606794;42755.14489710188;42846.14307713828;1183.331417748952;1187.714948412392;1205.4936926490896;1221.7861874171983;1225.1913736933582;24504;25434.872825635754;25688.743112568634;25856.870715646302;25909.740902590733;37235.81382093072;37496.2500749978;37571;37589.81205093957;37664.62335376721;208138;227400;227578;230268;331802;27410.5888411678;27492;27591.58612620772;27902.86048569744;27950.58074128849;36585.63414365822;36718.632813671524;36931.63068369282;37080.25839483249;37414.25171496609;30404.990028938002;32662.83668581642;32970.17574560559;33138;33334.66665333413;31926.840365798023;32851.34297314088;32957.34085318328;33059.504107437926;33167.668323317426;31737.365252694355;32167.678323216467;32191.678083218867;32555.674443255266;32801.179970500925;26890.05884794023;27403.31491712723;31693.890713824905;32447.67552324541;32868.67131328656;23116;23432.17987370434;23661.881690591435;23758.40603984845;23767.405814854767 09:42:24 INFO - 2015-12-03 09:42:24,356 DEBUG : BROWSER_OUTPUT: |2;jquery.html;332.33367098966573;333.38324100414235;333.68544716811624;334.8493178069866;339.62810722259115;14675.853241467583;15215.695686086272;15570.377184912619;16143.43497977571;16154.83845161548;10014.949925250363;12458.190217635847;14994.475193368235;14998.400063997455;15022.624434389145;3330.367230226261;4643.071385722852;4783.832565860195;4785.688930219525;4788.640851936101;3421.81180035098;3440.965590344102;3441.2773317603333;3441.896743097711;5184.766685499161;5437.592180586452;5454.91817622736;5457.2359869618285;5477.260569823063;5481.780728770845;5586.190002449643;5995.820125396245;5998.190244317027;6004.639721616717;6005.069214271794;3239.9352012959607;3347.7656564040526;4983.07813054586;5131.486851314876;5138.049460849755;11186.272892261977;11208.21542492026;11215.607453739161;17322;17940.91029544857;1793.7668103146639;1865.2445759467437;1899.848012159024;1904.5429097016754;1931.748872646561;8686.218240358336;8762.342824288204;8816.691415800417;8827.470351778913;11731.296122232608;1786.97319540207;1802.7476153338544;1815.5188874948149;1826.0413283026385;1841.6777064013877;50761;53088;54019;54179.729101354635;54826.45173548214;9686.176674982564;9793.951030244803;9886.026014289026;9918.553665085088;10017.298789084694;12450.190737602208;12465.252084874937;12468.251904885736;12482.063845211464;12485.687857803627;6720.260771315151;6799.864002720017;6825.69284382194;6839.076724642209;6878.484113691493;6614.536982411281;6657.933420665829;6679.532432729662;6680.565763225375;6724.260331363546;4111.09555897702;4112.136451345251;4139.234241665302;4165.312723400665;4172.645325147397;1598.200899550225;1658.96682066358;1675.9413420530223;1687.4009726547145;1688.6285017296175;851.9829603407898;853.5945425922637;887.4808237181321;926.8702381666573;964.0841200859212;14223.28883555818;14417.990740648054;14622.853771462362;14789.778153327708;14809.111453312837;718.2530168624677;725.2493669052611;765.9693612255559;780.1691198873182;849.087231226434;7326.780196594111;7783.532988020737;7791.259830316111;7916.881246781303;8885.155910188521;433966.9874831721;435001;437421;441019;468327;68629;70415;70620.64689676519;71108.28891711017;71874.2812571878;1034.2915103154364;1038.3665963762098;1040.458961340099;1045.6601604478424;1077.4020418667715;13338.733225335633;14479.696632964771;14539.563813085624;14609.707805844037;14695.897807664254;24799.628005580293;26003.60994585045;29538.852305739194;29904.70095299019;30063.549046763877;40362.55105560829;41124.38313425361;42305.78847105868;42793.78603106965;43939.78030109829;8299.95850020746;8490.872636910575;8541.87187192205;8594.140585941606;8637;9782.75543111428;10497.79004419892;15099.924500377429;15286.77069843931;15476.458323958608;12370.505179793068;12801.487940482277;13253.204807711569;13492.325383730578;13662.521811736542;13028.348582571023;13606.795898061338;13632.386542605409;13922;14156.150630962175;10590.576376944837;11685.824712629488;13229.536966206137;13634;14009.789853152415;8285.751427457186;8599.52702601363;8686.131386861263;8693.870001849335;8700.434471759316;13544.187348759106;13712.108712933627;13772.173669579857;13977.930110349384;13999.370028348545 09:42:24 INFO - 2015-12-03 09:42:24,356 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1265.487477571584;1636.0674415583114;1669.323923810857;1707.4280116161094;1715.2110029386479;5856.590038697293;6755.392014718675;7126.8574628507395;7134.429245660348;7137.4646901482465;7026.718931242757;7172.35448809607;7173.85652286954;7177.533460325075;7186.4969452138375;2074.108133502597;2132.360291912428;2132.680097985307;2135.7757435469284;2137.1344605434747;2099.895005249739;2120.8621439606454;2143.6891650710636;2151.257816053459;2162.826973842089;2045.4886278430392;2061.1858315965183;2070.7204527388835;2091.801278878504;2094.319346212487;2073.8859362735043;2096.0986775686447;2097.0458441409123;2097.4651463876767;2097.4861159016064;2035.6946458031266;2072.3161356752234;2103.7791031941733;2106.5470923751313;2108.4518025313378;5921.940780592225;6051.152838602599;7013.193482749498;7080.29197080293;7090.29097090292;3927.1163988102735;4016.176683779818;4025.255327764373;4039.151778126597;4052.797360132011;2663.280914153187;2671.225344650049;2707.1743118348895;2715.0768738628963;2736.849473278969;864.7449002544264;873.218469469821;873.2184694698273;887.2103827593447;887.9156480134377;9476.620935162586;9591.712248632552;9596.23230141587;9607.855882161773;9611.56747946337;3992.84028638857;3995.440638310639;4046.069404037088;4054.655354294859;4076.1236334188293;8318.12659670738;8324.62539185738;8354.164583541597;8354.749357519284;8359;4176.979115104405;4209.473815773028;4215.178040282177;4215.873523794291;4216.135692183095;3794.146317078635;3809.676177524886;3811.923761524754;3816.2939856126704;3824.674902633252;3100.612423447069;3107.8290694011594;3116.626004879384;3144.591203143577;3190.106770104328;1025.1747343388645;1026.2303272545591;1026.6150193677372;1034.8344264917578;1041.5677493840124;853.0445900591253;858.2919091749332;862.6247582301719;863.4948555095214;1076.3864597179688;6455.935440645628;6498.772542960974;6505;6506.186726659168;6513.8697226056165;400.6914675699695;407.9326911059642;424.91501699660193;426.74608607878264;428.5735692985437;4759.214729569582;4805.975970120127;4869.878253043631;4875.366202393737;4877.561019508261;7148.678309476086;8333.125021872616;8412.78968025792;8528.360372972053;8536.445131066585;8328.541930193898;8389.496630202208;8389.916100839035;8433.367497437717;8446.788830279293;6430.77492287777;6610.96694516534;6640.800775976729;6673.933260667428;6678.365555272241;6574.53978221539;6645.302243264581;6654.800355989328;6659.933400666125;6664.166979127609;7284.854302913806;7488.063992001;7574.81062973408;7594.810129746579;7625.8856117157175;7461.888071678821;7609.543427394374;7636.121845987783;7660.961695191489;7689.577073261024;6181.35095814933;6197.876042479215;6278.152449419453;6282.277538082996;6310.52671049664;6880;6883.931160688329;6896.7586134485055;6908.1019467468905;6924.515283930076;6383.9361606383345;6463.612183269019;6525.445337146396;6550.279469258282;6617.569857959217;6050.092486127116;6323.051542268697;6418.967905160444;6503.382178693206;6576.704048317933;6277.3408792078;6325.588836725598;6345.238571371465;6346.7143978522;6347.270063942521;5314.867128321823;5441.319835020622;5791.797287094932;5841.211436456194;5880.206172166874;5847.795327163529;5857.502112320501;5900.173975643327;5902;5909.70451477433 09:42:24 INFO - 2015-12-03 09:42:24,360 DEBUG : BROWSER_OUTPUT: |4;prototype.html;286.46431173705173;293.669621675615;294.57434007858654;303.54013669291015;305.0436880380008;5208.921866172006;5226.007058658857;5232.895342093156;5355.571554275658;5405.324334458192;5083.822066227683;5212.113940630093;5233.842984710455;5247;5262.289590905227;3922.5881282465216;4156.418101465797;4164.500259968808;4166.333386658135;4172.248995180867;3998.540167880702;4032.8588499402526;4052.5542190359038;4053.8581149659767;4056.371262454324;3979.582143874895;4024.7786371749544;4034.1931613677234;4044.716869819114;4055.4525139106286;4064.9390259146135;4065.2072845795083;4065.4918135233097;4075.857344992926;4077.7961101944784;3437.2438063625964;3493.7729047611824;3496.405611046103;3566.251087271676;3611.133328001287;5126.794928202868;5135.768890399903;5139.331886854685;5146.356705411824;5161.483851614846;4683.250679891235;4688.085823264465;4691.225947718623;4693.178693728584;4700.670953033289;5532.723363831833;5546.389897111315;5546.500814926636;5547.77808887644;5550.0564903966015;3794;3905.6094390560716;3905.902352441183;3923.7253392262555;3925.038365600446;5714.057180565202;5809.448102430262;5809.506191973687;5813.738381772788;5815.098659707752;4052.5339585947404;4053.8783836484954;4054.716169868081;4056.3104272273786;4060.878173654795;4118.5057793065025;4122;4122.175564887035;4128.566500517402;4128.690348223835;4582.335561343587;4692.929606055912;4693.155232058262;4694.624430045588;4697.295405689106;5541.695206763667;5545.112781954868;5549.112142057332;5553.333599968029;5554.472325129106;1449.1956963884934;1466.955991320262;1467.882569394446;1468.2365170111482;1469.7868809022846;960.9903900960901;986.4180133721139;987.0820137272262;1000.5747557288123;1008.4856723071287;4868.7078775272885;4876.780544875489;4882.2432522959;4882.926756098661;4883.194272944925;5751.22358481608;5754.74103665336;5755.539556835443;5760.452756988079;5762.049261871744;4842.176829938919;4860.586850117779;4860.95139048605;4870.707757534559;4871.196252618349;3009.232645675339;3069.309405383771;3092.8453577321043;3095.334503081848;3095.59757231563;5254;5350.357957045179;5371.301730775052;5436.891262174813;5491.121420572769;5907.675077870758;5913.733881975321;5929.644221346733;5938.317093534212;5942.435468630473;5453.64551304164;5462.426445223274;5463.754131064112;5467.398586155519;5476.288082549243;5589.015899355671;5709.771609135588;5760.481556659921;5763.452472015152;5811;5703.686297253691;5706.3152421709665;5708.972384970579;5710.37185909558;5712.314522257356;5468.72656367188;5498.092814685532;5501.092319767194;5504.4770746778995;5508.228847961369;3926.528816541919;3980.124372638015;3986.0234242610745;3987.800609969548;4000.9997500624845;5602.13166959122;5770.942290577041;5772.595918285848;5780.797672081457;5785.537157027344;5514.779408823602;5556.777728890961;5558.527525160245;5567.359753628384;5574.470425309752;5561.4716601922755;5565.471280228372;5566.972165139148;5578.358488773681;5581.246531718166;5313.821333253348;5424.159255315432;5428.240046393429;5432.103702888979;5470.8085217017215;5619.129034999582;5619.988402087663;5623.522000629992;5625.521830644441;5630.85922851932;5479.424660410599;5483;5486.945130548644;5489.39616642177;5499.037668408093 09:42:24 INFO - 2015-12-03 09:42:24,361 DEBUG : BROWSER_OUTPUT: |5;yui.html;647.1102234427661;687.4397366146587;729.6169511006723;737.8856277277022;755.4560716284274;10884.23810333277;11283.774324513504;11285.492152853121;11294.717632059192;11300.660980170607;10420.843687344695;10473.371597704125;10473.581056757721;10478.842817357745;10505;763.713607397226;777.793884620576;779.4816447062697;779.5128044971892;779.5478622398995;611.2237458427794;618.5484596244744;771.699037375424;787.5353541410567;788.1527358090048;804.1958041958042;809.6316176139842;810.614957895001;814.604916615444;818.9672413103468;631.36232405271;642.5373730913734;805.0379796143611;806.1575653442167;807.7415227127292;595.1073389915127;605.1346574398608;605.939406059395;606.087837804102;606.4784285514498;11494.597689080925;11639.06887449002;11697.70755731105;11718.296902185895;11738.119641026871;11028.573713782955;11734;11751.177417580773;11776.352300623463;12181.756364872654;8842.248408885253;8853.203211710912;8967.237784788236;8992.640294388217;9007.099290071006;3261.3314270574474;3298.208429976812;3351.145457908218;3351.229217280015;3352.6144493383085;41287.58712412867;41299.1740165198;41465.378019329735;41638.375424368656;41801.95495112616;9030.27757779376;9065.184133428023;9175.44947303164;9214.216791572791;9447.527623618791;16851.57871053209;16863.57841053959;16863.747043794352;16866.66266674684;16895.831041689427;6189.133521307021;6373.362663733682;6468.935310646927;6527.184101987252;6637.701303441357;3606.3328284267495;3638.1450359165574;3639.9818000909827;3677.1174918019483;3711.9620939885517;2720.2519307190287;2738.890444382242;2748.244232835946;2754.3389586499097;2758.7792976561827;460.43366659009604;461.05253703638675;465.3508355843579;472.9929051064237;473.76785375165923;477.2626292378284;512.9948700513022;555.6527170518426;567.2710566921486;585.8798946216016;7322.524035937647;7373.410127189919;7407.592582407911;7468.85062298751;7551.886721699179;375.1933343311901;441.2674959567103;456.1196890002327;487.926810978349;544.6133245395735;3528.9294214115575;3566.4828599852876;3637.7453578249797;3680.1719613086843;3699.926001479955;49242;49971.75014124906;50272.49727502751;50328.24507632388;50329;45618.31572526415;45878.31182532265;46157;46283.30575041377;46685.5331446688;42565.148697025266;42583.36124958128;43127.13745725131;44816;45152.77423612861;7725.92274077252;8185.099639039582;8287.254147126787;8321.459105158145;8428.45215061019;32755.508667370486;32825.50761738623;33070.83464582662;33909.49135763015;34199;38057;40396.596034039285;41878;42141.78929105335;42504.78747606242;9784.755381115529;9918.30571859963;10064.949675251577;10191.643292484727;10197.847032294374;11076.5569377224;11096.278741881752;11158.665240042812;11536.423178841193;11604.071674266208;10302.433366164933;10469.790604188025;11086.671798922316;11260.099192064452;11745.060395168537;10803.513841876977;10925.180611454332;11059.94930481603;11236.101111911192;11272.718182045515;9847.655332063343;9973.800523989334;10061.899381006097;10324.535395907053;10425.322354046963;7094.432445404252;8861.202491775772;9107.089291071105;9173.220276276592;9306.953465232631;8518.103844692587;8719.782005449915;8768.78078048054;8779.604917778588;9127.132922372364 09:42:24 INFO - 2015-12-03 09:42:24,361 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:42:24 INFO - 2015-12-03 09:42:24,361 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:42:24 INFO - 2015-12-03 09:42:24,361 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,886 09:42:24 INFO - 2015-12-03 09:42:24,362 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:42:24 INFO - 2015-12-03 09:42:24,362 DEBUG : BROWSER_OUTPUT: __startTimestamp1449164544347__endTimestamp 09:42:24 INFO - 2015-12-03 09:42:24,362 DEBUG : BROWSER_OUTPUT: 09:42:24 INFO - 2015-12-03 09:42:24,362 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:42:24 INFO - 2015-12-03 09:42:24,363 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:42:24 INFO - 2015-12-03 09:42:24,363 DEBUG : BROWSER_OUTPUT: 09:42:24 INFO - 2015-12-03 09:42:24,363 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4582.42 Median:4712.36 stddev:478.36 (10.2%) stddev-sans-first:453.62 09:42:24 INFO - 2015-12-03 09:42:24,363 DEBUG : BROWSER_OUTPUT: Values: 2591.7 2685.7 2687.0 2693.6 2717.0 4424.2 4530.6 4629.1 4640.8 4652.1 4560.0 4592.3 4666.3 4691.1 4693.8 4246.5 4269.4 4291.6 4362.6 4389.2 4309.5 4364.5 4378.6 4394.3 4439.8 4105.1 4191.2 4192.1 4224.1 4336.9 4251.1 4289.4 4292.3 4336.8 4368.2 4177.9 4212.8 4213.0 4216.2 4251.1 4479.7 4578.7 4612.1 4613.4 4638.0 4846.7 4933.2 4938.4 4947.8 4972.4 5050.6 5052.3 5076.8 5078.7 5121.7 4704.2 4706.6 4707.2 4712.4 4751.1 4887.9 4981.0 4981.1 5096.4 5255.5 4955.9 4958.7 4968.1 4978.4 4999.7 5062.6 5065.7 5072.5 5073.1 5076.2 4713.8 4715.5 4766.3 4904.1 4990.3 4934.0 4934.5 4939.0 4940.6 4980.8 4152.1 4154.7 4162.6 4165.3 4190.8 3530.1 3557.0 3623.7 3632.9 3669.6 4263.7 4266.1 4276.0 4282.1 4292.8 4983.5 4987.4 4992.9 4999.5 5038.7 4134.0 4215.4 4224.6 4229.8 4353.5 4400.2 4400.3 4404.3 4406.3 4426.0 4702.7 4704.3 4704.5 4706.0 4751.4 4722.6 4836.0 4845.6 4928.4 5057.6 4696.0 4712.8 4716.9 4717.1 4754.1 4910.7 4914.2 4915.0 4928.3 4961.9 4798.8 4873.9 4900.5 4901.9 4982.2 4781.3 4820.9 4830.2 4832.0 4879.7 4785.7 4822.8 4825.6 4826.1 4876.4 4528.2 4621.3 4624.1 4666.0 4810.9 4846.1 4865.0 4868.0 4873.8 4879.3 4766.2 4766.7 4767.5 4768.0 4796.5 09:42:24 INFO - 2015-12-03 09:42:24,364 DEBUG : BROWSER_OUTPUT: 09:42:24 INFO - 2015-12-03 09:42:24,364 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42449.12 Median:182484.83 stddev:74077.92 (40.6%) stddev-sans-first:74218.98 09:42:24 INFO - 2015-12-03 09:42:24,365 DEBUG : BROWSER_OUTPUT: Values: 564.0 565.8 566.9 573.0 573.0 27953.4 28618.0 36305.6 37440.6 37465.4 39588.0 40082.4 40097.6 40174.2 40186.0 6934.2 7639.2 7801.9 7808.6 7814.1 7111.9 10067.5 10402.5 10403.5 10404.8 9737.5 9756.9 9793.6 9803.2 9805.4 7151.8 7384.7 9862.9 9988.0 10121.1 9831.9 9974.9 9980.8 9981.7 9983.6 36588.6 36651.0 36983.4 37041.4 37131.3 2745.0 2796.7 2893.2 3094.4 3399.8 27827.3 28151.3 28348.3 28552.7 28885.6 3205.4 3206.9 3211.3 3258.1 3274.9 204559.0 204762.0 205050.0 205271.0 205783.0 49071.5 50454.0 52868.2 53265.5 53316.2 55763.0 56914.7 57168.0 57250.7 57296.7 12702.1 12893.4 12910.9 12972.8 12976.5 9429.6 9481.8 9505.1 9505.8 9512.1 17918.4 18227.5 18265.5 18303.0 18339.2 6783.8 7013.5 7022.2 7074.6 7154.8 825.6 826.8 890.0 896.1 976.0 26160.6 26247.2 26482.9 26579.2 26583.3 962.4 979.8 999.5 1000.9 1063.4 13100.3 13271.9 13314.5 13324.0 13332.9 361416.0 366057.0 366907.0 367095.0 367546.0 42487.4 42674.4 42700.8 42755.1 42846.1 1183.3 1187.7 1205.5 1221.8 1225.2 24504.0 25434.9 25688.7 25856.9 25909.7 37235.8 37496.3 37571.0 37589.8 37664.6 208138.0 227400.0 227578.0 230268.0 331802.0 27410.6 27492.0 27591.6 27902.9 27950.6 36585.6 36718.6 36931.6 37080.3 37414.3 30405.0 32662.8 32970.2 33138.0 33334.7 31926.8 32851.3 32957.3 33059.5 33167.7 31737.4 32167.7 32191.7 32555.7 32801.2 26890.1 27403.3 31693.9 32447.7 32868.7 23116.0 23432.2 23661.9 23758.4 23767.4 09:42:24 INFO - 2015-12-03 09:42:24,365 DEBUG : BROWSER_OUTPUT: 09:42:24 INFO - 2015-12-03 09:42:24,365 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24504.49 Median:3441.12 stddev:72476.18 (2106.2%) stddev-sans-first:72656.76 09:42:24 INFO - 2015-12-03 09:42:24,367 DEBUG : BROWSER_OUTPUT: Values: 332.3 333.4 333.7 334.8 339.6 14675.9 15215.7 15570.4 16143.4 16154.8 10014.9 12458.2 14994.5 14998.4 15022.6 3330.4 4643.1 4783.8 4785.7 4788.6 3421.8 3441.0 3441.3 3441.9 5184.8 5437.6 5454.9 5457.2 5477.3 5481.8 5586.2 5995.8 5998.2 6004.6 6005.1 3239.9 3347.8 4983.1 5131.5 5138.0 11186.3 11208.2 11215.6 17322.0 17940.9 1793.8 1865.2 1899.8 1904.5 1931.7 8686.2 8762.3 8816.7 8827.5 11731.3 1787.0 1802.7 1815.5 1826.0 1841.7 50761.0 53088.0 54019.0 54179.7 54826.5 9686.2 9794.0 9886.0 9918.6 10017.3 12450.2 12465.3 12468.3 12482.1 12485.7 6720.3 6799.9 6825.7 6839.1 6878.5 6614.5 6657.9 6679.5 6680.6 6724.3 4111.1 4112.1 4139.2 4165.3 4172.6 1598.2 1659.0 1675.9 1687.4 1688.6 852.0 853.6 887.5 926.9 964.1 14223.3 14418.0 14622.9 14789.8 14809.1 718.3 725.2 766.0 780.2 849.1 7326.8 7783.5 7791.3 7916.9 8885.2 433967.0 435001.0 437421.0 441019.0 468327.0 68629.0 70415.0 70620.6 71108.3 71874.3 1034.3 1038.4 1040.5 1045.7 1077.4 13338.7 14479.7 14539.6 14609.7 14695.9 24799.6 26003.6 29538.9 29904.7 30063.5 40362.6 41124.4 42305.8 42793.8 43939.8 8300.0 8490.9 8541.9 8594.1 8637.0 9782.8 10497.8 15099.9 15286.8 15476.5 12370.5 12801.5 13253.2 13492.3 13662.5 13028.3 13606.8 13632.4 13922.0 14156.2 10590.6 11685.8 13229.5 13634.0 14009.8 8285.8 8599.5 8686.1 8693.9 8700.4 13544.2 13712.1 13772.2 13977.9 13999.4 09:42:24 INFO - 2015-12-03 09:42:24,367 DEBUG : BROWSER_OUTPUT: 09:42:24 INFO - 2015-12-03 09:42:24,367 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4886.72 Median:6189.61 stddev:2560.53 (41.4%) stddev-sans-first:2553.25 09:42:24 INFO - 2015-12-03 09:42:24,369 DEBUG : BROWSER_OUTPUT: Values: 1265.5 1636.1 1669.3 1707.4 1715.2 5856.6 6755.4 7126.9 7134.4 7137.5 7026.7 7172.4 7173.9 7177.5 7186.5 2074.1 2132.4 2132.7 2135.8 2137.1 2099.9 2120.9 2143.7 2151.3 2162.8 2045.5 2061.2 2070.7 2091.8 2094.3 2073.9 2096.1 2097.0 2097.5 2097.5 2035.7 2072.3 2103.8 2106.5 2108.5 5921.9 6051.2 7013.2 7080.3 7090.3 3927.1 4016.2 4025.3 4039.2 4052.8 2663.3 2671.2 2707.2 2715.1 2736.8 864.7 873.2 873.2 887.2 887.9 9476.6 9591.7 9596.2 9607.9 9611.6 3992.8 3995.4 4046.1 4054.7 4076.1 8318.1 8324.6 8354.2 8354.7 8359.0 4177.0 4209.5 4215.2 4215.9 4216.1 3794.1 3809.7 3811.9 3816.3 3824.7 3100.6 3107.8 3116.6 3144.6 3190.1 1025.2 1026.2 1026.6 1034.8 1041.6 853.0 858.3 862.6 863.5 1076.4 6455.9 6498.8 6505.0 6506.2 6513.9 400.7 407.9 424.9 426.7 428.6 4759.2 4806.0 4869.9 4875.4 4877.6 7148.7 8333.1 8412.8 8528.4 8536.4 8328.5 8389.5 8389.9 8433.4 8446.8 6430.8 6611.0 6640.8 6673.9 6678.4 6574.5 6645.3 6654.8 6659.9 6664.2 7284.9 7488.1 7574.8 7594.8 7625.9 7461.9 7609.5 7636.1 7661.0 7689.6 6181.4 6197.9 6278.2 6282.3 6310.5 6880.0 6883.9 6896.8 6908.1 6924.5 6383.9 6463.6 6525.4 6550.3 6617.6 6050.1 6323.1 6419.0 6503.4 6576.7 6277.3 6325.6 6345.2 6346.7 6347.3 5314.9 5441.3 5791.8 5841.2 5880.2 5847.8 5857.5 5900.2 5902.0 5909.7 09:42:24 INFO - 2015-12-03 09:42:24,369 DEBUG : BROWSER_OUTPUT: 09:42:24 INFO - 2015-12-03 09:42:24,369 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4614.44 Median:5229.45 stddev:1351.88 (25.9%) stddev-sans-first:1316.07 09:42:24 INFO - 2015-12-03 09:42:24,369 DEBUG : BROWSER_OUTPUT: Values: 286.5 293.7 294.6 303.5 305.0 5208.9 5226.0 5232.9 5355.6 5405.3 5083.8 5212.1 5233.8 5247.0 5262.3 3922.6 4156.4 4164.5 4166.3 4172.2 3998.5 4032.9 4052.6 4053.9 4056.4 3979.6 4024.8 4034.2 4044.7 4055.5 4064.9 4065.2 4065.5 4075.9 4077.8 3437.2 3493.8 3496.4 3566.3 3611.1 5126.8 5135.8 5139.3 5146.4 5161.5 4683.3 4688.1 4691.2 4693.2 4700.7 5532.7 5546.4 5546.5 5547.8 5550.1 3794.0 3905.6 3905.9 3923.7 3925.0 5714.1 5809.4 5809.5 5813.7 5815.1 4052.5 4053.9 4054.7 4056.3 4060.9 4118.5 4122.0 4122.2 4128.6 4128.7 4582.3 4692.9 4693.2 4694.6 4697.3 5541.7 5545.1 5549.1 5553.3 5554.5 1449.2 1467.0 1467.9 1468.2 1469.8 961.0 986.4 987.1 1000.6 1008.5 4868.7 4876.8 4882.2 4882.9 4883.2 5751.2 5754.7 5755.5 5760.5 5762.0 4842.2 4860.6 4861.0 4870.7 4871.2 3009.2 3069.3 3092.8 3095.3 3095.6 5254.0 5350.4 5371.3 5436.9 5491.1 5907.7 5913.7 5929.6 5938.3 5942.4 5453.6 5462.4 5463.8 5467.4 5476.3 5589.0 5709.8 5760.5 5763.5 5811.0 5703.7 5706.3 5709.0 5710.4 5712.3 5468.7 5498.1 5501.1 5504.5 5508.2 3926.5 3980.1 3986.0 3987.8 4001.0 5602.1 5770.9 5772.6 5780.8 5785.5 5514.8 5556.8 5558.5 5567.4 5574.5 5561.5 5565.5 5567.0 5578.4 5581.2 5313.8 5424.2 5428.2 5432.1 5470.8 5619.1 5620.0 5623.5 5625.5 5630.9 5479.4 5483.0 5486.9 5489.4 5499.0 09:42:24 INFO - 2015-12-03 09:42:24,370 DEBUG : BROWSER_OUTPUT: 09:42:24 INFO - 2015-12-03 09:42:24,370 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12440.73 Median:23169.37 stddev:14358.44 (62.0%) stddev-sans-first:14371.41 09:42:24 INFO - 2015-12-03 09:42:24,371 DEBUG : BROWSER_OUTPUT: Values: 647.1 687.4 729.6 737.9 755.5 10884.2 11283.8 11285.5 11294.7 11300.7 10420.8 10473.4 10473.6 10478.8 10505.0 763.7 777.8 779.5 779.5 779.5 611.2 618.5 771.7 787.5 788.2 804.2 809.6 810.6 814.6 819.0 631.4 642.5 805.0 806.2 807.7 595.1 605.1 605.9 606.1 606.5 11494.6 11639.1 11697.7 11718.3 11738.1 11028.6 11734.0 11751.2 11776.4 12181.8 8842.2 8853.2 8967.2 8992.6 9007.1 3261.3 3298.2 3351.1 3351.2 3352.6 41287.6 41299.2 41465.4 41638.4 41802.0 9030.3 9065.2 9175.4 9214.2 9447.5 16851.6 16863.6 16863.7 16866.7 16895.8 6189.1 6373.4 6468.9 6527.2 6637.7 3606.3 3638.1 3640.0 3677.1 3712.0 2720.3 2738.9 2748.2 2754.3 2758.8 460.4 461.1 465.4 473.0 473.8 477.3 513.0 555.7 567.3 585.9 7322.5 7373.4 7407.6 7468.9 7551.9 375.2 441.3 456.1 487.9 544.6 3528.9 3566.5 3637.7 3680.2 3699.9 49242.0 49971.8 50272.5 50328.2 50329.0 45618.3 45878.3 46157.0 46283.3 46685.5 42565.1 42583.4 43127.1 44816.0 45152.8 7725.9 8185.1 8287.3 8321.5 8428.5 32755.5 32825.5 33070.8 33909.5 34199.0 38057.0 40396.6 41878.0 42141.8 42504.8 9784.8 9918.3 10064.9 10191.6 10197.8 11076.6 11096.3 11158.7 11536.4 11604.1 10302.4 10469.8 11086.7 11260.1 11745.1 10803.5 10925.2 11059.9 11236.1 11272.7 9847.7 9973.8 10061.9 10324.5 10425.3 7094.4 8861.2 9107.1 9173.2 9307.0 8518.1 8719.8 8768.8 8779.6 9127.1 09:42:24 INFO - 2015-12-03 09:42:24,371 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:42:24 INFO - 2015-12-03 09:42:24,371 DEBUG : BROWSER_OUTPUT: 09:42:25 INFO - 2015-12-03 09:42:25,120 INFO : Browser exited with error code: 0 09:42:25 INFO - 2015-12-03 09:42:25,141 INFO : Completed test dromaeo_css (00:18:37) 09:42:25 INFO - 2015-12-03 09:42:25,141 INFO : Starting test kraken 09:42:25 INFO - 2015-12-03 09:42:25,141 DEBUG : operating with platform_type : linux_ 09:42:25 INFO - 2015-12-03 09:42:25,141 INFO : Initialising browser for kraken test... 09:42:25 INFO - 2015-12-03 09:42:25,147 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUieQ7K/profile http://localhost:58056/getInfo.html 09:42:29 INFO - 2015-12-03 09:42:29,650 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:42:29 INFO - 2015-12-03 09:42:29,650 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:42:29 INFO - 2015-12-03 09:42:29,650 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:42:29 INFO - 2015-12-03 09:42:29,650 DEBUG : BROWSER_OUTPUT: __metrics 09:42:29 INFO - 2015-12-03 09:42:29,738 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] 09:42:29 INFO - 2015-12-03 09:42:29,739 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] 09:42:30 INFO - 2015-12-03 09:42:30,617 INFO : Browser initialized. 09:42:30 INFO - 2015-12-03 09:42:30,617 INFO : Running cycle 1/1 for kraken test... 09:42:30 INFO - 2015-12-03 09:42:30,617 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUieQ7K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:42:42 INFO - 2015-12-03 09:42:42,637 DEBUG : BROWSER_OUTPUT: RSS: Main: 144228352 09:42:42 INFO - 2015-12-03 09:42:42,637 DEBUG : BROWSER_OUTPUT: 09:42:45 INFO - 2015-12-03 09:42:45,233 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58056/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58056/tests/kraken/driver.html?testName=audio-beat-detection) 09:42:45 INFO - 2015-12-03 09:42:45,819 DEBUG : BROWSER_OUTPUT: RSS: Main: 183631872 09:42:45 INFO - 2015-12-03 09:42:45,819 DEBUG : BROWSER_OUTPUT: 09:42:48 INFO - 2015-12-03 09:42:48,516 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58056/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58056/tests/kraken/driver.html?testName=audio-dft) 09:42:49 INFO - 2015-12-03 09:42:49,097 DEBUG : BROWSER_OUTPUT: RSS: Main: 170536960 09:42:49 INFO - 2015-12-03 09:42:49,097 DEBUG : BROWSER_OUTPUT: 09:42:52 INFO - 2015-12-03 09:42:52,082 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58056/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58056/tests/kraken/driver.html?testName=audio-fft) 09:42:52 INFO - 2015-12-03 09:42:52,653 DEBUG : BROWSER_OUTPUT: RSS: Main: 153337856 09:42:52 INFO - 2015-12-03 09:42:52,653 DEBUG : BROWSER_OUTPUT: 09:42:54 INFO - 2015-12-03 09:42:54,690 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58056/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58056/tests/kraken/driver.html?testName=audio-oscillator) 09:42:55 INFO - 2015-12-03 09:42:55,279 DEBUG : BROWSER_OUTPUT: RSS: Main: 155021312 09:42:55 INFO - 2015-12-03 09:42:55,280 DEBUG : BROWSER_OUTPUT: 09:42:57 INFO - 2015-12-03 09:42:57,559 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58056/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58056/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:42:58 INFO - 2015-12-03 09:42:58,120 DEBUG : BROWSER_OUTPUT: RSS: Main: 156827648 09:42:58 INFO - 2015-12-03 09:42:58,120 DEBUG : BROWSER_OUTPUT: 09:43:01 INFO - 2015-12-03 09:43:01,087 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58056/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58056/tests/kraken/driver.html?testName=imaging-darkroom) 09:43:01 INFO - 2015-12-03 09:43:01,668 DEBUG : BROWSER_OUTPUT: RSS: Main: 157990912 09:43:01 INFO - 2015-12-03 09:43:01,668 DEBUG : BROWSER_OUTPUT: 09:43:05 INFO - 2015-12-03 09:43:05,080 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58056/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58056/tests/kraken/driver.html?testName=imaging-desaturate) 09:43:05 INFO - 2015-12-03 09:43:05,662 DEBUG : BROWSER_OUTPUT: RSS: Main: 158298112 09:43:05 INFO - 2015-12-03 09:43:05,662 DEBUG : BROWSER_OUTPUT: 09:43:08 INFO - 2015-12-03 09:43:08,505 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58056/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58056/tests/kraken/driver.html?testName=json-parse-financial) 09:43:09 INFO - 2015-12-03 09:43:09,090 DEBUG : BROWSER_OUTPUT: RSS: Main: 156663808 09:43:09 INFO - 2015-12-03 09:43:09,091 DEBUG : BROWSER_OUTPUT: 09:43:10 INFO - 2015-12-03 09:43:10,865 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58056/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58056/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:43:11 INFO - 2015-12-03 09:43:11,431 DEBUG : BROWSER_OUTPUT: RSS: Main: 166993920 09:43:11 INFO - 2015-12-03 09:43:11,431 DEBUG : BROWSER_OUTPUT: 09:43:13 INFO - 2015-12-03 09:43:13,322 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58056/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58056/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:43:13 INFO - 2015-12-03 09:43:13,923 DEBUG : BROWSER_OUTPUT: RSS: Main: 167124992 09:43:13 INFO - 2015-12-03 09:43:13,923 DEBUG : BROWSER_OUTPUT: 09:43:16 INFO - 2015-12-03 09:43:16,064 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58056/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58056/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:43:16 INFO - 2015-12-03 09:43:16,644 DEBUG : BROWSER_OUTPUT: RSS: Main: 179875840 09:43:16 INFO - 2015-12-03 09:43:16,644 DEBUG : BROWSER_OUTPUT: 09:43:19 INFO - 2015-12-03 09:43:19,144 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58056/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58056/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:43:19 INFO - 2015-12-03 09:43:19,728 DEBUG : BROWSER_OUTPUT: RSS: Main: 183615488 09:43:19 INFO - 2015-12-03 09:43:19,728 DEBUG : BROWSER_OUTPUT: 09:43:22 INFO - 2015-12-03 09:43:22,323 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58056/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58056/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:43:22 INFO - 2015-12-03 09:43:22,904 DEBUG : BROWSER_OUTPUT: RSS: Main: 184139776 09:43:22 INFO - 2015-12-03 09:43:22,904 DEBUG : BROWSER_OUTPUT: 09:43:24 INFO - 2015-12-03 09:43:24,637 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58056/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58056/tests/kraken/driver.html?testName=ai-astar) 09:43:24 INFO - 2015-12-03 09:43:24,887 DEBUG : BROWSER_OUTPUT: RSS: Main: 241537024 09:43:24 INFO - 2015-12-03 09:43:24,887 DEBUG : BROWSER_OUTPUT: 09:43:24 INFO - 2015-12-03 09:43:24,888 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:43:24 INFO - 2015-12-03 09:43:24,888 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:43:24 INFO - 2015-12-03 09:43:24,888 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:43:24 INFO - 2015-12-03 09:43:24,889 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:43:24 INFO - 2015-12-03 09:43:24,890 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;111;105;111;112;114;100;111;111;105 09:43:24 INFO - 2015-12-03 09:43:24,890 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;129;155;165;129;150;147;130;164;139 09:43:24 INFO - 2015-12-03 09:43:24,890 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;160;159;161;160;160;162;162;162;162 09:43:24 INFO - 2015-12-03 09:43:24,890 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;73;88;90;77;72;72;107;91;71 09:43:24 INFO - 2015-12-03 09:43:24,890 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;96;134;93;95;95;129;95;95;146 09:43:24 INFO - 2015-12-03 09:43:24,890 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;109;110;110;109;109;110;110 09:43:24 INFO - 2015-12-03 09:43:24,890 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;148;147;147;146;146;147;147;146;146 09:43:24 INFO - 2015-12-03 09:43:24,891 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;96;95;95;96;95;95;95;96 09:43:24 INFO - 2015-12-03 09:43:24,891 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;73;73;71;72;70;73;80;69;69 09:43:24 INFO - 2015-12-03 09:43:24,891 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;70;68;68;68;69;68;69;69;69 09:43:24 INFO - 2015-12-03 09:43:24,891 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;86;86;87;85;84;84;85;85;84 09:43:24 INFO - 2015-12-03 09:43:24,891 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;119;119;115;119;126;130;126;129;126 09:43:24 INFO - 2015-12-03 09:43:24,891 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;147;151;147;137;149;133;145;143;143;134 09:43:24 INFO - 2015-12-03 09:43:24,891 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;69;71;68;70;68;69;68;70;68 09:43:24 INFO - 2015-12-03 09:43:24,892 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:43:24 INFO - 2015-12-03 09:43:24,892 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:43:24 INFO - 2015-12-03 09:43:24,892 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1006 09:43:24 INFO - 2015-12-03 09:43:24,892 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:43:24 INFO - 2015-12-03 09:43:24,892 DEBUG : BROWSER_OUTPUT: __startTimestamp1449164604887__endTimestamp 09:43:24 INFO - 2015-12-03 09:43:24,892 DEBUG : BROWSER_OUTPUT: 09:43:24 INFO - 2015-12-03 09:43:24,896 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:43:24 INFO - 2015-12-03 09:43:24,896 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:43:24 INFO - 2015-12-03 09:43:24,896 DEBUG : BROWSER_OUTPUT: 09:43:24 INFO - 2015-12-03 09:43:24,896 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.10 Median:111.00 stddev:4.31 (3.9%) stddev-sans-first:4.51 09:43:24 INFO - 2015-12-03 09:43:24,896 DEBUG : BROWSER_OUTPUT: Values: 111.0 111.0 105.0 111.0 112.0 114.0 100.0 111.0 111.0 105.0 09:43:24 INFO - 2015-12-03 09:43:24,896 DEBUG : BROWSER_OUTPUT: 09:43:24 INFO - 2015-12-03 09:43:24,896 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.40 Median:152.50 stddev:14.00 (9.2%) stddev-sans-first:14.41 09:43:24 INFO - 2015-12-03 09:43:24,896 DEBUG : BROWSER_OUTPUT: Values: 156.0 129.0 155.0 165.0 129.0 150.0 147.0 130.0 164.0 139.0 09:43:24 INFO - 2015-12-03 09:43:24,896 DEBUG : BROWSER_OUTPUT: 09:43:24 INFO - 2015-12-03 09:43:24,897 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.80 Median:161.50 stddev:1.14 (0.7%) stddev-sans-first:1.17 09:43:24 INFO - 2015-12-03 09:43:24,897 DEBUG : BROWSER_OUTPUT: Values: 160.0 160.0 159.0 161.0 160.0 160.0 162.0 162.0 162.0 162.0 09:43:24 INFO - 2015-12-03 09:43:24,897 DEBUG : BROWSER_OUTPUT: 09:43:24 INFO - 2015-12-03 09:43:24,897 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.50 Median:75.50 stddev:11.99 (15.9%) stddev-sans-first:12.41 09:43:24 INFO - 2015-12-03 09:43:24,897 DEBUG : BROWSER_OUTPUT: Values: 74.0 73.0 88.0 90.0 77.0 72.0 72.0 107.0 91.0 71.0 09:43:24 INFO - 2015-12-03 09:43:24,897 DEBUG : BROWSER_OUTPUT: 09:43:24 INFO - 2015-12-03 09:43:24,897 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.30 Median:95.00 stddev:20.47 (21.5%) stddev-sans-first:21.22 09:43:24 INFO - 2015-12-03 09:43:24,897 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 134.0 93.0 95.0 95.0 129.0 95.0 95.0 146.0 09:43:24 INFO - 2015-12-03 09:43:24,897 DEBUG : BROWSER_OUTPUT: 09:43:24 INFO - 2015-12-03 09:43:24,897 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 09:43:24 INFO - 2015-12-03 09:43:24,897 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 109.0 110.0 110.0 109.0 109.0 110.0 110.0 09:43:24 INFO - 2015-12-03 09:43:24,897 DEBUG : BROWSER_OUTPUT: 09:43:24 INFO - 2015-12-03 09:43:24,899 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 09:43:24 INFO - 2015-12-03 09:43:24,899 DEBUG : BROWSER_OUTPUT: Values: 147.0 148.0 147.0 147.0 146.0 146.0 147.0 147.0 146.0 146.0 09:43:24 INFO - 2015-12-03 09:43:24,899 DEBUG : BROWSER_OUTPUT: 09:43:24 INFO - 2015-12-03 09:43:24,899 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 09:43:24 INFO - 2015-12-03 09:43:24,899 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 09:43:24 INFO - 2015-12-03 09:43:24,899 DEBUG : BROWSER_OUTPUT: 09:43:24 INFO - 2015-12-03 09:43:24,899 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.20 Median:72.50 stddev:3.16 (4.4%) stddev-sans-first:3.35 09:43:24 INFO - 2015-12-03 09:43:24,899 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 73.0 71.0 72.0 70.0 73.0 80.0 69.0 69.0 09:43:24 INFO - 2015-12-03 09:43:24,899 DEBUG : BROWSER_OUTPUT: 09:43:24 INFO - 2015-12-03 09:43:24,899 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 09:43:24 INFO - 2015-12-03 09:43:24,899 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 68.0 68.0 68.0 69.0 68.0 69.0 69.0 69.0 09:43:24 INFO - 2015-12-03 09:43:24,899 DEBUG : BROWSER_OUTPUT: 09:43:24 INFO - 2015-12-03 09:43:24,899 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:85.00 stddev:0.99 (1.2%) stddev-sans-first:1.05 09:43:24 INFO - 2015-12-03 09:43:24,899 DEBUG : BROWSER_OUTPUT: Values: 85.0 86.0 86.0 87.0 85.0 84.0 84.0 85.0 85.0 84.0 09:43:24 INFO - 2015-12-03 09:43:24,900 DEBUG : BROWSER_OUTPUT: 09:43:24 INFO - 2015-12-03 09:43:24,900 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.10 Median:126.00 stddev:5.00 (4.0%) stddev-sans-first:5.29 09:43:24 INFO - 2015-12-03 09:43:24,900 DEBUG : BROWSER_OUTPUT: Values: 122.0 119.0 119.0 115.0 119.0 126.0 130.0 126.0 129.0 126.0 09:43:24 INFO - 2015-12-03 09:43:24,900 DEBUG : BROWSER_OUTPUT: 09:43:24 INFO - 2015-12-03 09:43:24,900 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.90 Median:146.00 stddev:6.26 (4.3%) stddev-sans-first:6.46 09:43:24 INFO - 2015-12-03 09:43:24,900 DEBUG : BROWSER_OUTPUT: Values: 147.0 151.0 147.0 137.0 149.0 133.0 145.0 143.0 143.0 134.0 09:43:24 INFO - 2015-12-03 09:43:24,900 DEBUG : BROWSER_OUTPUT: 09:43:24 INFO - 2015-12-03 09:43:24,900 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.50 stddev:1.23 (1.8%) stddev-sans-first:1.12 09:43:24 INFO - 2015-12-03 09:43:24,900 DEBUG : BROWSER_OUTPUT: Values: 71.0 69.0 71.0 68.0 70.0 68.0 69.0 68.0 70.0 68.0 09:43:24 INFO - 2015-12-03 09:43:24,900 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:43:24 INFO - 2015-12-03 09:43:24,900 DEBUG : BROWSER_OUTPUT: 09:43:25 INFO - 2015-12-03 09:43:25,812 INFO : Browser exited with error code: 0 09:43:25 INFO - 2015-12-03 09:43:25,861 INFO : Completed test kraken (00:01:00) 09:43:25 INFO - 2015-12-03 09:43:25,861 INFO : Starting test v8_7 09:43:25 INFO - 2015-12-03 09:43:25,861 DEBUG : operating with platform_type : linux_ 09:43:25 INFO - 2015-12-03 09:43:25,861 INFO : Initialising browser for v8_7 test... 09:43:25 INFO - 2015-12-03 09:43:25,867 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7XEGIp/profile http://localhost:58056/getInfo.html 09:43:30 INFO - 2015-12-03 09:43:30,452 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:43:30 INFO - 2015-12-03 09:43:30,452 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:43:30 INFO - 2015-12-03 09:43:30,453 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:43:30 INFO - 2015-12-03 09:43:30,453 DEBUG : BROWSER_OUTPUT: __metrics 09:43:30 INFO - 2015-12-03 09:43:30,575 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] 09:43:30 INFO - 2015-12-03 09:43:30,576 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] 09:43:31 INFO - 2015-12-03 09:43:31,587 INFO : Browser initialized. 09:43:31 INFO - 2015-12-03 09:43:31,587 INFO : Running cycle 1/1 for v8_7 test... 09:43:31 INFO - 2015-12-03 09:43:31,588 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7XEGIp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:43:43 INFO - 2015-12-03 09:43:43,629 DEBUG : BROWSER_OUTPUT: RSS: Main: 143826944 09:43:43 INFO - 2015-12-03 09:43:43,630 DEBUG : BROWSER_OUTPUT: 09:44:05 INFO - 2015-12-03 09:44:05,084 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58056/tests/v8_7/run.html (next: http://localhost:58056/tests/v8_7/run.html) 09:44:05 INFO - 2015-12-03 09:44:05,334 DEBUG : BROWSER_OUTPUT: RSS: Main: 446713856 09:44:05 INFO - 2015-12-03 09:44:05,334 DEBUG : BROWSER_OUTPUT: 09:44:05 INFO - 2015-12-03 09:44:05,334 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:44:05 INFO - 2015-12-03 09:44:05,334 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:44:05 INFO - 2015-12-03 09:44:05,335 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:44:05 INFO - 2015-12-03 09:44:05,335 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:44:05 INFO - 2015-12-03 09:44:05,335 DEBUG : BROWSER_OUTPUT: |0;Richards;167.16817118020728 09:44:05 INFO - 2015-12-03 09:44:05,335 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.87360594795538 09:44:05 INFO - 2015-12-03 09:44:05,335 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.623542476402 09:44:05 INFO - 2015-12-03 09:44:05,335 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5128.205128205128 09:44:05 INFO - 2015-12-03 09:44:05,336 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1970.4724409448818 09:44:05 INFO - 2015-12-03 09:44:05,336 DEBUG : BROWSER_OUTPUT: |5;Earley;795.5449482895783 09:44:05 INFO - 2015-12-03 09:44:05,336 DEBUG : BROWSER_OUTPUT: |6;Boyer;11952.380952380952 09:44:05 INFO - 2015-12-03 09:44:05,336 DEBUG : BROWSER_OUTPUT: |7;RegExp;26868.42105263158 09:44:05 INFO - 2015-12-03 09:44:05,336 DEBUG : BROWSER_OUTPUT: |8;Splay;617.7558569667078 09:44:05 INFO - 2015-12-03 09:44:05,336 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 09:44:05 INFO - 2015-12-03 09:44:05,336 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:44:05 INFO - 2015-12-03 09:44:05,336 DEBUG : BROWSER_OUTPUT: __startTimestamp1449164645332__endTimestamp 09:44:05 INFO - 2015-12-03 09:44:05,336 DEBUG : BROWSER_OUTPUT: 09:44:05 INFO - 2015-12-03 09:44:05,336 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:44:05 INFO - 2015-12-03 09:44:05,336 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:44:05 INFO - 2015-12-03 09:44:05,336 DEBUG : BROWSER_OUTPUT: 09:44:05 INFO - 2015-12-03 09:44:05,337 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.17 Median:167.17 stddev:0.00 (0.0%) 09:44:05 INFO - 2015-12-03 09:44:05,337 DEBUG : BROWSER_OUTPUT: Values: 167.2 09:44:05 INFO - 2015-12-03 09:44:05,337 DEBUG : BROWSER_OUTPUT: 09:44:05 INFO - 2015-12-03 09:44:05,337 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.87 Median:185.87 stddev:0.00 (0.0%) 09:44:05 INFO - 2015-12-03 09:44:05,337 DEBUG : BROWSER_OUTPUT: Values: 185.9 09:44:05 INFO - 2015-12-03 09:44:05,337 DEBUG : BROWSER_OUTPUT: 09:44:05 INFO - 2015-12-03 09:44:05,337 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.62 Median:277.62 stddev:0.00 (0.0%) 09:44:05 INFO - 2015-12-03 09:44:05,337 DEBUG : BROWSER_OUTPUT: Values: 277.6 09:44:05 INFO - 2015-12-03 09:44:05,337 DEBUG : BROWSER_OUTPUT: 09:44:05 INFO - 2015-12-03 09:44:05,337 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5128.21 Median:5128.21 stddev:0.00 (0.0%) 09:44:05 INFO - 2015-12-03 09:44:05,337 DEBUG : BROWSER_OUTPUT: Values: 5128.2 09:44:05 INFO - 2015-12-03 09:44:05,338 DEBUG : BROWSER_OUTPUT: 09:44:05 INFO - 2015-12-03 09:44:05,338 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1970.47 Median:1970.47 stddev:0.00 (0.0%) 09:44:05 INFO - 2015-12-03 09:44:05,338 DEBUG : BROWSER_OUTPUT: Values: 1970.5 09:44:05 INFO - 2015-12-03 09:44:05,338 DEBUG : BROWSER_OUTPUT: 09:44:05 INFO - 2015-12-03 09:44:05,338 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:795.54 Median:795.54 stddev:0.00 (0.0%) 09:44:05 INFO - 2015-12-03 09:44:05,338 DEBUG : BROWSER_OUTPUT: Values: 795.5 09:44:05 INFO - 2015-12-03 09:44:05,338 DEBUG : BROWSER_OUTPUT: 09:44:05 INFO - 2015-12-03 09:44:05,338 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11952.38 Median:11952.38 stddev:0.00 (0.0%) 09:44:05 INFO - 2015-12-03 09:44:05,338 DEBUG : BROWSER_OUTPUT: Values: 11952.4 09:44:05 INFO - 2015-12-03 09:44:05,338 DEBUG : BROWSER_OUTPUT: 09:44:05 INFO - 2015-12-03 09:44:05,338 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26868.42 Median:26868.42 stddev:0.00 (0.0%) 09:44:05 INFO - 2015-12-03 09:44:05,339 DEBUG : BROWSER_OUTPUT: Values: 26868.4 09:44:05 INFO - 2015-12-03 09:44:05,339 DEBUG : BROWSER_OUTPUT: 09:44:05 INFO - 2015-12-03 09:44:05,339 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:617.76 Median:617.76 stddev:0.00 (0.0%) 09:44:05 INFO - 2015-12-03 09:44:05,339 DEBUG : BROWSER_OUTPUT: Values: 617.8 09:44:05 INFO - 2015-12-03 09:44:05,339 DEBUG : BROWSER_OUTPUT: 09:44:05 INFO - 2015-12-03 09:44:05,339 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 09:44:05 INFO - 2015-12-03 09:44:05,340 DEBUG : BROWSER_OUTPUT: Values: 4835.7 09:44:05 INFO - 2015-12-03 09:44:05,340 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:44:05 INFO - 2015-12-03 09:44:05,340 DEBUG : BROWSER_OUTPUT: 09:44:06 INFO - 2015-12-03 09:44:06,316 INFO : Browser exited with error code: 0 09:44:06 INFO - 2015-12-03 09:44:06,328 INFO : Completed test v8_7 (00:00:40) 09:44:06 INFO - 2015-12-03 09:44:06,823 INFO : Completed test suite (00:20:19) 09:44:06 INFO - 2015-12-03 09:44:06,823 DEBUG : Working with test: dromaeo_css 09:44:06 INFO - 2015-12-03 09:44:06,823 DEBUG : Generating results file: dromaeo_css 09:44:06 INFO - 2015-12-03 09:44:06,824 DEBUG : Working with test: kraken 09:44:06 INFO - 2015-12-03 09:44:06,824 DEBUG : Generating results file: kraken 09:44:06 INFO - 2015-12-03 09:44:06,825 INFO : javascript benchmark 09:44:06 INFO - 2015-12-03 09:44:06,825 DEBUG : Working with test: v8_7 09:44:06 INFO - 2015-12-03 09:44:06,825 DEBUG : Generating results file: v8_7 09:44:06 INFO - 2015-12-03 09:44:06,825 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:44:06 INFO - 2015-12-03 09:44:06,901 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 09:44:06 INFO - 2015-12-03 09:44:06,901 DEBUG : process_Request line: dromaeo_css 6190.69 graph.html#tests=[[72,94,35]] 09:44:06 INFO - 2015-12-03 09:44:06,901 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:44:06 INFO - 2015-12-03 09:44:06,940 DEBUG : process_Request line: kraken 1517.90 graph.html#tests=[[232,94,35]] 09:44:06 INFO - 2015-12-03 09:44:06,941 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:44:06 INFO - 2015-12-03 09:44:06,984 DEBUG : process_Request line: v8_7 19820.58 graph.html#tests=[[230,94,35]] 09:44:06 INFO - 2015-12-03 09:44:06,986 INFO : javascript benchmark 09:44:07 INFO - 2015-12-03 09:44:06,989 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2591.7278685737997, 2685.650865387498, 2687.0460986349844, 2693.5690289553677, 2717.021872126035, 4424.181526417615, 4530.637548996081, 4629.097326021423, 4640.791164397598, 4652.092841895832, 4560.0, 4592.311153327003, 4666.300054991753, 4691.085238378518, 4693.788779504922, 4246.469191351066, 4269.402283680287, 4291.613754762071, 4362.629176519999, 4389.188000219953, 4309.547497512747, 4364.49808272048, 4378.64970802335, 4394.296912494002, 4439.778011099432, 4105.117399759051, 4191.224623444642, 4192.0777428965575, 4224.070704445017, 4336.869893903188, 4251.149770046003, 4289.356596510548, 4292.313229883203, 4336.804843782037, 4368.17004769096, 4177.874663760092, 4212.831486740557, 4213.031002869327, 4216.198922204802, 4251.128518653669, 4479.686421950465, 4578.702384345007, 4612.1467528507, 4613.354130421743, 4638.026014536951, 4846.733429661367, 4933.161362568372, 4938.358013458227, 4947.802087916479, 4972.378452693413, 5050.595952323805, 5052.292679024939, 5076.847694569169, 5078.669886457368, 5121.718305493197, 4704.153252414564, 4706.647001474903, 4707.152712511781, 4712.363830882821, 4751.121042607128, 4887.902241955212, 4981.028699403581, 4981.053599816023, 5096.413912400121, 5255.527002569787, 4955.851324460272, 4958.7024778513405, 4968.080905032581, 4978.352814134139, 4999.700017998932, 5062.594992400673, 5065.721385323843, 5072.54347108762, 5073.086844367976, 5076.187809950464, 4713.764311784397, 4715.4577223619035, 4766.285057241372, 4904.092742842586, 4990.2764099205415, 4934.0, 4934.5312195341385, 4938.975305123451, 4940.555350018443, 4980.800767969313, 4152.1280531088205, 4154.667626589866, 4162.646175075092, 4165.333546632524, 4190.832366705297, 3530.064532898784, 3556.964430355715, 3623.691986181204, 3632.891013269606, 3669.5779985301497, 4263.680223983214, 4266.0827921996915, 4275.957240427556, 4282.079352939133, 4292.82828686849, 4983.476734942851, 4987.426445958761, 4992.850214493571, 4999.450060493416, 5038.672486288379, 4133.958660413417, 4215.430916826251, 4224.598663126998, 4229.767362795014, 4353.521112677603, 4400.163968845973, 4400.317950717644, 4404.273294906305, 4406.27296496081, 4426.026274219666, 4702.6708130431225, 4704.29435584665, 4704.482506924235, 4705.976470117627, 4751.382320298339, 4722.5513576210205, 4836.0, 4845.5881250094135, 4928.433230178575, 5057.570106540985, 4695.9530404695515, 4712.7643617818285, 4716.858494245178, 4717.056588682209, 4754.096721622881, 4910.729909854992, 4914.238293064581, 4914.950850491592, 4928.260760885896, 4961.900761984813, 4798.808047678054, 4873.878153046202, 4900.485449027943, 4901.877453063702, 4982.153033984304, 4781.258904869751, 4820.855374338636, 4830.203016502238, 4831.95168048315, 4879.731614761222, 4785.712857228577, 4822.807087716593, 4825.638077144158, 4826.131296366688, 4876.4392094909535, 4528.230200865795, 4621.260598304255, 4624.052069325713, 4666.0, 4810.855674329776, 4846.127697014571, 4864.95135048645, 4867.975660121819, 4873.805047798049, 4879.316895634685, 4766.1659209638865, 4766.66633335677, 4767.475577686521, 4767.998720268783, 4796.472388037383], "unit": "ms", "name": "dojo.html", "value": 4552.745888535097}, {"lowerIsBetter": false, "replicates": [564.0495764636585, 565.8330792416236, 566.9319681638204, 572.997135014325, 573.0, 27953.440931181365, 28618.0, 36305.636943630554, 37440.62559374405, 37465.438018429675, 39588.0, 40082.398764018566, 40097.59902400975, 40174.19651606974, 40186.0, 6934.167899852025, 7639.197884222146, 7801.921980780176, 7808.648610812499, 7814.140444551095, 7111.893321600181, 10067.546960386764, 10402.479876006208, 10403.479826008706, 10404.791904161912, 9737.464439455862, 9756.853647195298, 9793.608255669764, 9803.215742740564, 9805.362651427635, 7151.785446436563, 7384.667689953965, 9862.852057219148, 9987.950060249688, 10121.089101980857, 9831.90168098317, 9974.900250997469, 9980.750481237954, 9981.700548983543, 9983.600655973753, 36588.634113659056, 36651.0, 36983.445248321295, 37041.444378334345, 37131.25737485262, 2745.0, 2796.6504186976626, 2893.1609833148364, 3094.4430002599524, 3399.847006884696, 27827.304317392227, 28151.296217594518, 28348.29129271764, 28552.714472855212, 28885.56671649927, 3205.439048166585, 3206.88775892845, 3211.2935154266024, 3258.120307516981, 3274.8526316315583, 204559.0, 204762.0, 205050.0, 205271.0, 205783.0, 49071.509284907406, 50454.0, 52868.20697689538, 53265.467345326826, 53316.20025699618, 55763.0, 56914.715426422605, 57168.0, 57250.713746431, 57296.71351643299, 12702.110852240254, 12893.35533223335, 12910.870891290966, 12972.80540791889, 12976.480940762263, 9429.622815087458, 9481.762955926157, 9505.097015783489, 9505.762355941157, 9512.1439070484, 17918.372856949944, 18227.54431139232, 18265.543361416072, 18303.0, 18339.174737136593, 6783.796486105425, 7013.544119632207, 7022.192447868459, 7074.575525468488, 7154.821129471701, 825.628467189767, 826.8139668574643, 889.9911000890038, 896.1173244354305, 975.9947254328054, 26160.607590886153, 26247.219257204793, 26482.86758566195, 26579.202623921312, 26583.33541661435, 962.379265373844, 979.7991411760572, 999.5102399824034, 1000.9399436033716, 1063.3566692151292, 13100.279484628247, 13271.933640331736, 13314.53399131045, 13324.0, 13332.866671333357, 361416.0, 366057.0, 366907.0, 367095.0, 367546.0, 42487.36268955968, 42674.359884601756, 42700.78649606794, 42755.14489710188, 42846.14307713828, 1183.331417748952, 1187.714948412392, 1205.4936926490896, 1221.7861874171983, 1225.1913736933582, 24504.0, 25434.872825635754, 25688.743112568634, 25856.870715646302, 25909.740902590733, 37235.81382093072, 37496.2500749978, 37571.0, 37589.81205093957, 37664.62335376721, 208138.0, 227400.0, 227578.0, 230268.0, 331802.0, 27410.5888411678, 27492.0, 27591.58612620772, 27902.86048569744, 27950.58074128849, 36585.63414365822, 36718.632813671524, 36931.63068369282, 37080.25839483249, 37414.25171496609, 30404.990028938002, 32662.83668581642, 32970.17574560559, 33138.0, 33334.66665333413, 31926.840365798023, 32851.34297314088, 32957.34085318328, 33059.504107437926, 33167.668323317426, 31737.365252694355, 32167.678323216467, 32191.678083218867, 32555.674443255266, 32801.179970500925, 26890.05884794023, 27403.31491712723, 31693.890713824905, 32447.67552324541, 32868.67131328656, 23116.0, 23432.17987370434, 23661.881690591435, 23758.40603984845, 23767.405814854767], "unit": "ms", "name": "ext.html", "value": 16897.778321855836}, {"lowerIsBetter": false, "replicates": [332.33367098966573, 333.38324100414235, 333.68544716811624, 334.8493178069866, 339.62810722259115, 14675.853241467583, 15215.695686086272, 15570.377184912619, 16143.43497977571, 16154.83845161548, 10014.949925250363, 12458.190217635847, 14994.475193368235, 14998.400063997455, 15022.624434389145, 3330.367230226261, 4643.071385722852, 4783.832565860195, 4785.688930219525, 4788.640851936101, 3421.81180035098, 3440.965590344102, 3441.2773317603333, 3441.896743097711, 5184.766685499161, 5437.592180586452, 5454.91817622736, 5457.2359869618285, 5477.260569823063, 5481.780728770845, 5586.190002449643, 5995.820125396245, 5998.190244317027, 6004.639721616717, 6005.069214271794, 3239.9352012959607, 3347.7656564040526, 4983.07813054586, 5131.486851314876, 5138.049460849755, 11186.272892261977, 11208.21542492026, 11215.607453739161, 17322.0, 17940.91029544857, 1793.7668103146639, 1865.2445759467437, 1899.848012159024, 1904.5429097016754, 1931.748872646561, 8686.218240358336, 8762.342824288204, 8816.691415800417, 8827.470351778913, 11731.296122232608, 1786.97319540207, 1802.7476153338544, 1815.5188874948149, 1826.0413283026385, 1841.6777064013877, 50761.0, 53088.0, 54019.0, 54179.729101354635, 54826.45173548214, 9686.176674982564, 9793.951030244803, 9886.026014289026, 9918.553665085088, 10017.298789084694, 12450.190737602208, 12465.252084874937, 12468.251904885736, 12482.063845211464, 12485.687857803627, 6720.260771315151, 6799.864002720017, 6825.69284382194, 6839.076724642209, 6878.484113691493, 6614.536982411281, 6657.933420665829, 6679.532432729662, 6680.565763225375, 6724.260331363546, 4111.09555897702, 4112.136451345251, 4139.234241665302, 4165.312723400665, 4172.645325147397, 1598.200899550225, 1658.96682066358, 1675.9413420530223, 1687.4009726547145, 1688.6285017296175, 851.9829603407898, 853.5945425922637, 887.4808237181321, 926.8702381666573, 964.0841200859212, 14223.28883555818, 14417.990740648054, 14622.853771462362, 14789.778153327708, 14809.111453312837, 718.2530168624677, 725.2493669052611, 765.9693612255559, 780.1691198873182, 849.087231226434, 7326.780196594111, 7783.532988020737, 7791.259830316111, 7916.881246781303, 8885.155910188521, 433966.9874831721, 435001.0, 437421.0, 441019.0, 468327.0, 68629.0, 70415.0, 70620.64689676519, 71108.28891711017, 71874.2812571878, 1034.2915103154364, 1038.3665963762098, 1040.458961340099, 1045.6601604478424, 1077.4020418667715, 13338.733225335633, 14479.696632964771, 14539.563813085624, 14609.707805844037, 14695.897807664254, 24799.628005580293, 26003.60994585045, 29538.852305739194, 29904.70095299019, 30063.549046763877, 40362.55105560829, 41124.38313425361, 42305.78847105868, 42793.78603106965, 43939.78030109829, 8299.95850020746, 8490.872636910575, 8541.87187192205, 8594.140585941606, 8637.0, 9782.75543111428, 10497.79004419892, 15099.924500377429, 15286.77069843931, 15476.458323958608, 12370.505179793068, 12801.487940482277, 13253.204807711569, 13492.325383730578, 13662.521811736542, 13028.348582571023, 13606.795898061338, 13632.386542605409, 13922.0, 14156.150630962175, 10590.576376944837, 11685.824712629488, 13229.536966206137, 13634.0, 14009.789853152415, 8285.751427457186, 8599.52702601363, 8686.131386861263, 8693.870001849335, 8700.434471759316, 13544.187348759106, 13712.108712933627, 13772.173669579857, 13977.930110349384, 13999.370028348545], "unit": "ms", "name": "jquery.html", "value": 7897.070505920028}, {"lowerIsBetter": false, "replicates": [1265.487477571584, 1636.0674415583114, 1669.323923810857, 1707.4280116161094, 1715.2110029386479, 5856.590038697293, 6755.392014718675, 7126.8574628507395, 7134.429245660348, 7137.4646901482465, 7026.718931242757, 7172.35448809607, 7173.85652286954, 7177.533460325075, 7186.4969452138375, 2074.108133502597, 2132.360291912428, 2132.680097985307, 2135.7757435469284, 2137.1344605434747, 2099.895005249739, 2120.8621439606454, 2143.6891650710636, 2151.257816053459, 2162.826973842089, 2045.4886278430392, 2061.1858315965183, 2070.7204527388835, 2091.801278878504, 2094.319346212487, 2073.8859362735043, 2096.0986775686447, 2097.0458441409123, 2097.4651463876767, 2097.4861159016064, 2035.6946458031266, 2072.3161356752234, 2103.7791031941733, 2106.5470923751313, 2108.4518025313378, 5921.940780592225, 6051.152838602599, 7013.193482749498, 7080.29197080293, 7090.29097090292, 3927.1163988102735, 4016.176683779818, 4025.255327764373, 4039.151778126597, 4052.797360132011, 2663.280914153187, 2671.225344650049, 2707.1743118348895, 2715.0768738628963, 2736.849473278969, 864.7449002544264, 873.218469469821, 873.2184694698273, 887.2103827593447, 887.9156480134377, 9476.620935162586, 9591.712248632552, 9596.23230141587, 9607.855882161773, 9611.56747946337, 3992.84028638857, 3995.440638310639, 4046.069404037088, 4054.655354294859, 4076.1236334188293, 8318.12659670738, 8324.62539185738, 8354.164583541597, 8354.749357519284, 8359.0, 4176.979115104405, 4209.473815773028, 4215.178040282177, 4215.873523794291, 4216.135692183095, 3794.146317078635, 3809.676177524886, 3811.923761524754, 3816.2939856126704, 3824.674902633252, 3100.612423447069, 3107.8290694011594, 3116.626004879384, 3144.591203143577, 3190.106770104328, 1025.1747343388645, 1026.2303272545591, 1026.6150193677372, 1034.8344264917578, 1041.5677493840124, 853.0445900591253, 858.2919091749332, 862.6247582301719, 863.4948555095214, 1076.3864597179688, 6455.935440645628, 6498.772542960974, 6505.0, 6506.186726659168, 6513.8697226056165, 400.6914675699695, 407.9326911059642, 424.91501699660193, 426.74608607878264, 428.5735692985437, 4759.214729569582, 4805.975970120127, 4869.878253043631, 4875.366202393737, 4877.561019508261, 7148.678309476086, 8333.125021872616, 8412.78968025792, 8528.360372972053, 8536.445131066585, 8328.541930193898, 8389.496630202208, 8389.916100839035, 8433.367497437717, 8446.788830279293, 6430.77492287777, 6610.96694516534, 6640.800775976729, 6673.933260667428, 6678.365555272241, 6574.53978221539, 6645.302243264581, 6654.800355989328, 6659.933400666125, 6664.166979127609, 7284.854302913806, 7488.063992001, 7574.81062973408, 7594.810129746579, 7625.8856117157175, 7461.888071678821, 7609.543427394374, 7636.121845987783, 7660.961695191489, 7689.577073261024, 6181.35095814933, 6197.876042479215, 6278.152449419453, 6282.277538082996, 6310.52671049664, 6880.0, 6883.931160688329, 6896.7586134485055, 6908.1019467468905, 6924.515283930076, 6383.9361606383345, 6463.612183269019, 6525.445337146396, 6550.279469258282, 6617.569857959217, 6050.092486127116, 6323.051542268697, 6418.967905160444, 6503.382178693206, 6576.704048317933, 6277.3408792078, 6325.588836725598, 6345.238571371465, 6346.7143978522, 6347.270063942521, 5314.867128321823, 5441.319835020622, 5791.797287094932, 5841.211436456194, 5880.206172166874, 5847.795327163529, 5857.502112320501, 5900.173975643327, 5902.0, 5909.70451477433], "unit": "ms", "name": "mootools.html", "value": 3933.7759241286267}, {"lowerIsBetter": false, "replicates": [286.46431173705173, 293.669621675615, 294.57434007858654, 303.54013669291015, 305.0436880380008, 5208.921866172006, 5226.007058658857, 5232.895342093156, 5355.571554275658, 5405.324334458192, 5083.822066227683, 5212.113940630093, 5233.842984710455, 5247.0, 5262.289590905227, 3922.5881282465216, 4156.418101465797, 4164.500259968808, 4166.333386658135, 4172.248995180867, 3998.540167880702, 4032.8588499402526, 4052.5542190359038, 4053.8581149659767, 4056.371262454324, 3979.582143874895, 4024.7786371749544, 4034.1931613677234, 4044.716869819114, 4055.4525139106286, 4064.9390259146135, 4065.2072845795083, 4065.4918135233097, 4075.857344992926, 4077.7961101944784, 3437.2438063625964, 3493.7729047611824, 3496.405611046103, 3566.251087271676, 3611.133328001287, 5126.794928202868, 5135.768890399903, 5139.331886854685, 5146.356705411824, 5161.483851614846, 4683.250679891235, 4688.085823264465, 4691.225947718623, 4693.178693728584, 4700.670953033289, 5532.723363831833, 5546.389897111315, 5546.500814926636, 5547.77808887644, 5550.0564903966015, 3794.0, 3905.6094390560716, 3905.902352441183, 3923.7253392262555, 3925.038365600446, 5714.057180565202, 5809.448102430262, 5809.506191973687, 5813.738381772788, 5815.098659707752, 4052.5339585947404, 4053.8783836484954, 4054.716169868081, 4056.3104272273786, 4060.878173654795, 4118.5057793065025, 4122.0, 4122.175564887035, 4128.566500517402, 4128.690348223835, 4582.335561343587, 4692.929606055912, 4693.155232058262, 4694.624430045588, 4697.295405689106, 5541.695206763667, 5545.112781954868, 5549.112142057332, 5553.333599968029, 5554.472325129106, 1449.1956963884934, 1466.955991320262, 1467.882569394446, 1468.2365170111482, 1469.7868809022846, 960.9903900960901, 986.4180133721139, 987.0820137272262, 1000.5747557288123, 1008.4856723071287, 4868.7078775272885, 4876.780544875489, 4882.2432522959, 4882.926756098661, 4883.194272944925, 5751.22358481608, 5754.74103665336, 5755.539556835443, 5760.452756988079, 5762.049261871744, 4842.176829938919, 4860.586850117779, 4860.95139048605, 4870.707757534559, 4871.196252618349, 3009.232645675339, 3069.309405383771, 3092.8453577321043, 3095.334503081848, 3095.59757231563, 5254.0, 5350.357957045179, 5371.301730775052, 5436.891262174813, 5491.121420572769, 5907.675077870758, 5913.733881975321, 5929.644221346733, 5938.317093534212, 5942.435468630473, 5453.64551304164, 5462.426445223274, 5463.754131064112, 5467.398586155519, 5476.288082549243, 5589.015899355671, 5709.771609135588, 5760.481556659921, 5763.452472015152, 5811.0, 5703.686297253691, 5706.3152421709665, 5708.972384970579, 5710.37185909558, 5712.314522257356, 5468.72656367188, 5498.092814685532, 5501.092319767194, 5504.4770746778995, 5508.228847961369, 3926.528816541919, 3980.124372638015, 3986.0234242610745, 3987.800609969548, 4000.9997500624845, 5602.13166959122, 5770.942290577041, 5772.595918285848, 5780.797672081457, 5785.537157027344, 5514.779408823602, 5556.777728890961, 5558.527525160245, 5567.359753628384, 5574.470425309752, 5561.4716601922755, 5565.471280228372, 5566.972165139148, 5578.358488773681, 5581.246531718166, 5313.821333253348, 5424.159255315432, 5428.240046393429, 5432.103702888979, 5470.8085217017215, 5619.129034999582, 5619.988402087663, 5623.522000629992, 5625.521830644441, 5630.85922851932, 5479.424660410599, 5483.0, 5486.945130548644, 5489.39616642177, 5499.037668408093], "unit": "ms", "name": "prototype.html", "value": 4180.164764440132}, {"lowerIsBetter": false, "replicates": [647.1102234427661, 687.4397366146587, 729.6169511006723, 737.8856277277022, 755.4560716284274, 10884.23810333277, 11283.774324513504, 11285.492152853121, 11294.717632059192, 11300.660980170607, 10420.843687344695, 10473.371597704125, 10473.581056757721, 10478.842817357745, 10505.0, 763.713607397226, 777.793884620576, 779.4816447062697, 779.5128044971892, 779.5478622398995, 611.2237458427794, 618.5484596244744, 771.699037375424, 787.5353541410567, 788.1527358090048, 804.1958041958042, 809.6316176139842, 810.614957895001, 814.604916615444, 818.9672413103468, 631.36232405271, 642.5373730913734, 805.0379796143611, 806.1575653442167, 807.7415227127292, 595.1073389915127, 605.1346574398608, 605.939406059395, 606.087837804102, 606.4784285514498, 11494.597689080925, 11639.06887449002, 11697.70755731105, 11718.296902185895, 11738.119641026871, 11028.573713782955, 11734.0, 11751.177417580773, 11776.352300623463, 12181.756364872654, 8842.248408885253, 8853.203211710912, 8967.237784788236, 8992.640294388217, 9007.099290071006, 3261.3314270574474, 3298.208429976812, 3351.145457908218, 3351.229217280015, 3352.6144493383085, 41287.58712412867, 41299.1740165198, 41465.378019329735, 41638.375424368656, 41801.95495112616, 9030.27757779376, 9065.184133428023, 9175.44947303164, 9214.216791572791, 9447.527623618791, 16851.57871053209, 16863.57841053959, 16863.747043794352, 16866.66266674684, 16895.831041689427, 6189.133521307021, 6373.362663733682, 6468.935310646927, 6527.184101987252, 6637.701303441357, 3606.3328284267495, 3638.1450359165574, 3639.9818000909827, 3677.1174918019483, 3711.9620939885517, 2720.2519307190287, 2738.890444382242, 2748.244232835946, 2754.3389586499097, 2758.7792976561827, 460.43366659009604, 461.05253703638675, 465.3508355843579, 472.9929051064237, 473.76785375165923, 477.2626292378284, 512.9948700513022, 555.6527170518426, 567.2710566921486, 585.8798946216016, 7322.524035937647, 7373.410127189919, 7407.592582407911, 7468.85062298751, 7551.886721699179, 375.1933343311901, 441.2674959567103, 456.1196890002327, 487.926810978349, 544.6133245395735, 3528.9294214115575, 3566.4828599852876, 3637.7453578249797, 3680.1719613086843, 3699.926001479955, 49242.0, 49971.75014124906, 50272.49727502751, 50328.24507632388, 50329.0, 45618.31572526415, 45878.31182532265, 46157.0, 46283.30575041377, 46685.5331446688, 42565.148697025266, 42583.36124958128, 43127.13745725131, 44816.0, 45152.77423612861, 7725.92274077252, 8185.099639039582, 8287.254147126787, 8321.459105158145, 8428.45215061019, 32755.508667370486, 32825.50761738623, 33070.83464582662, 33909.49135763015, 34199.0, 38057.0, 40396.596034039285, 41878.0, 42141.78929105335, 42504.78747606242, 9784.755381115529, 9918.30571859963, 10064.949675251577, 10191.643292484727, 10197.847032294374, 11076.5569377224, 11096.278741881752, 11158.665240042812, 11536.423178841193, 11604.071674266208, 10302.433366164933, 10469.790604188025, 11086.671798922316, 11260.099192064452, 11745.060395168537, 10803.513841876977, 10925.180611454332, 11059.94930481603, 11236.101111911192, 11272.718182045515, 9847.655332063343, 9973.800523989334, 10061.899381006097, 10324.535395907053, 10425.322354046963, 7094.432445404252, 8861.202491775772, 9107.089291071105, 9173.220276276592, 9306.953465232631, 8518.103844692587, 8719.782005449915, 8768.78078048054, 8779.604917778588, 9127.132922372364], "unit": "ms", "name": "yui.html", "value": 5633.979617618056}], "name": "dromaeo_css", "value": 6190.688854772016}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 111.0, 105.0, 111.0, 112.0, 114.0, 100.0, 111.0, 111.0, 105.0], "unit": "ms", "name": "ai-astar", "value": 109.1}, {"lowerIsBetter": true, "replicates": [156.0, 129.0, 155.0, 165.0, 129.0, 150.0, 147.0, 130.0, 164.0, 139.0], "unit": "ms", "name": "audio-beat-detection", "value": 146.4}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 159.0, 161.0, 160.0, 160.0, 162.0, 162.0, 162.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 88.0, 90.0, 77.0, 72.0, 72.0, 107.0, 91.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 81.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 134.0, 93.0, 95.0, 95.0, 129.0, 95.0, 95.0, 146.0], "unit": "ms", "name": "audio-oscillator", "value": 107.3}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 73.0, 71.0, 72.0, 70.0, 73.0, 80.0, 69.0, 69.0], "unit": "ms", "name": "json-parse-financial", "value": 72.2}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 68.0, 68.0, 68.0, 69.0, 68.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 86.0, 87.0, 85.0, 84.0, 84.0, 85.0, 85.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.1}, {"lowerIsBetter": true, "replicates": [122.0, 119.0, 119.0, 115.0, 119.0, 126.0, 130.0, 126.0, 129.0, 126.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.1}, {"lowerIsBetter": true, "replicates": [147.0, 151.0, 147.0, 137.0, 149.0, 133.0, 145.0, 143.0, 143.0, 134.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 142.9}, {"lowerIsBetter": true, "replicates": [71.0, 69.0, 71.0, 68.0, 70.0, 68.0, 69.0, 68.0, 70.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.2}], "name": "kraken", "value": 1517.8999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.16817118020728], "unit": "score", "name": "Richards", "value": 211.17656399999993}, {"lowerIsBetter": false, "replicates": [185.87360594795538], "unit": "score", "name": "DeltaBlue", "value": 355.71483999999987}, {"lowerIsBetter": false, "replicates": [277.623542476402], "unit": "score", "name": "Encrypt", "value": 958.7839620000002}, {"lowerIsBetter": false, "replicates": [5128.205128205128], "unit": "score", "name": "Decrypt", "value": 51.90529499999997}, {"lowerIsBetter": false, "replicates": [1970.4724409448818], "unit": "score", "name": "RayTrace", "value": 375.5388731268733}, {"lowerIsBetter": false, "replicates": [795.5449482895783], "unit": "score", "name": "Earley", "value": 837.743991}, {"lowerIsBetter": false, "replicates": [11952.380952380952], "unit": "score", "name": "Boyer", "value": 55.75985258964142}, {"lowerIsBetter": false, "replicates": [26868.42105263158], "unit": "score", "name": "RegExp", "value": 33.90541625857002}, {"lowerIsBetter": false, "replicates": [617.7558569667078], "unit": "score", "name": "Splay", "value": 131.91457285429135}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19820.58185685427}]} 09:44:07 INFO - RETURN: dromaeo_css: 6190.69 09:44:07 INFO - RETURN: kraken: 1517.90 09:44:07 INFO - RETURN: v8_7: 19820.58 09:44:07 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "19820.58"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1517.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "6190.69"}}} 09:44:07 INFO - Return code: 0 09:44:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:44:07 INFO - # TBPL SUCCESS # 09:44:07 INFO - Running post-action listener: _resource_record_post_action 09:44:07 INFO - Running post-run listener: _resource_record_post_run 09:44:08 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 4096; Write bytes: 507588608; Read time: 20; Write time: 662536 09:44:08 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 0; Write bytes: 231378944; Read time: 0; Write time: 455712 09:44:08 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 4096; Write bytes: 276209664; Read time: 20; Write time: 206824 09:44:08 INFO - Running post-run listener: _upload_blobber_files 09:44:08 INFO - Blob upload gear active. 09:44:08 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:44:08 INFO - Copying logs to upload dir... 09:44:08 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1268.520183 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-03 09:44:07.333685) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 09:44:07.337652) ========= 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=c402a24d74c70935940d60dd000001de-1449163376.491051-1884885895 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/_EK_P05MQauvEdKksLZgrA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010143 build_url: 'https://queue.taskcluster.net/v1/task/_EK_P05MQauvEdKksLZgrA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 09:44:07.390872) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 09:44:07.391342) ========= 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=c402a24d74c70935940d60dd000001de-1449163376.491051-1884885895 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004675 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 09:44:07.442891) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 09:44:07.443486) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 09:44:07.444039) ========= ========= Total master_lag: 0.23 =========