builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-014 starttime: 1449191317.64 results: success (0) buildid: 20151203155442 builduid: e79a20b297cf4f3bae8998cd37533bcb revision: 9d8af47837101c8f4ce67930e5094a59ed9942a6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 17:08:37.639255) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 17:08:37.640017) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 17:08:37.640310) ========= 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=01deea79d00cc2c334834894000001d2-1449190031.695872-1875200976 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006441 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 17:08:37.663353) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 17:08:37.663645) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 17:08:37.677393) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 17:08:37.677687) ========= 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=01deea79d00cc2c334834894000001d2-1449190031.695872-1875200976 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004682 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 17:08:37.726499) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 17:08:37.726774) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 17:08:37.727113) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 17:08:37.727389) ========= 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=01deea79d00cc2c334834894000001d2-1449190031.695872-1875200976 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-03 17:08:38-- 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% 43.3M=0s 2015-12-03 17:08:38 (43.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101441 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 17:08:37.842026) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 17:08:37.842319) ========= 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=01deea79d00cc2c334834894000001d2-1449190031.695872-1875200976 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021577 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 17:08:37.891899) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 17:08:37.892263) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9d8af47837101c8f4ce67930e5094a59ed9942a6 --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 9d8af47837101c8f4ce67930e5094a59ed9942a6 --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=01deea79d00cc2c334834894000001d2-1449190031.695872-1875200976 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-03 17:08:38,394 truncating revision to first 12 chars 2015-12-03 17:08:38,394 Setting DEBUG logging. 2015-12-03 17:08:38,394 attempt 1/10 2015-12-03 17:08:38,394 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9d8af4783710?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-03 17:08:38,672 unpacking tar archive at: mozilla-central-9d8af4783710/testing/mozharness/ program finished with exit code 0 elapsedTime=0.567911 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 17:08:38.473069) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 17:08:38.473370) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 17:08:38.482530) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 17:08:38.482848) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 17:08:38.483275) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2015-12-03 17:08:38.483556) ========= /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=01deea79d00cc2c334834894000001d2-1449190031.695872-1875200976 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:08:39 INFO - MultiFileLogger online at 20151203 17:08:39 in /builds/slave/test 17:08:39 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 17:08:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:08:39 INFO - {'append_to_log': False, 17:08:39 INFO - 'base_work_dir': '/builds/slave/test', 17:08:39 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:08:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:08:39 INFO - 'branch': 'Firefox-Non-PGO', 17:08:39 INFO - 'buildbot_json_path': 'buildprops.json', 17:08:39 INFO - 'config_files': ('talos/linux_config.py',), 17:08:39 INFO - 'default_actions': ('clobber', 17:08:39 INFO - 'read-buildbot-config', 17:08:39 INFO - 'download-and-extract', 17:08:39 INFO - 'populate-webroot', 17:08:39 INFO - 'create-virtualenv', 17:08:39 INFO - 'install', 17:08:39 INFO - 'run-tests'), 17:08:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:08:39 INFO - 'download_minidump_stackwalk': True, 17:08:39 INFO - 'download_symbols': 'ondemand', 17:08:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:08:39 INFO - 'tooltool.py': '/tools/tooltool.py', 17:08:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:08:39 INFO - '/tools/misc-python/virtualenv.py')}, 17:08:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:08:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:08:39 INFO - 'installer_path': 'installer.exe', 17:08:39 INFO - 'log_level': 'info', 17:08:39 INFO - 'log_name': 'talos', 17:08:39 INFO - 'log_to_console': True, 17:08:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:08:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:08:39 INFO - 'opt_config_files': (), 17:08:39 INFO - 'pip_index': False, 17:08:39 INFO - 'sps_profile': False, 17:08:39 INFO - 'sps_profile_interval': 0, 17:08:39 INFO - 'suite': 'dromaeojs', 17:08:39 INFO - 'system_bits': '64', 17:08:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:08:39 INFO - 'title': 'talos-linux64-ix-014', 17:08:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:08:39 INFO - 'use_talos_json': True, 17:08:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:08:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:08:39 INFO - 'work_dir': 'build'} 17:08:39 INFO - ##### 17:08:39 INFO - ##### Running clobber step. 17:08:39 INFO - ##### 17:08:39 INFO - Running pre-action listener: _resource_record_pre_action 17:08:39 INFO - Running main action method: clobber 17:08:39 INFO - rmtree: /builds/slave/test/build 17:08:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:08:39 INFO - Running post-action listener: _resource_record_post_action 17:08:39 INFO - ##### 17:08:39 INFO - ##### Running read-buildbot-config step. 17:08:39 INFO - ##### 17:08:39 INFO - Running pre-action listener: _resource_record_pre_action 17:08:39 INFO - Running main action method: read_buildbot_config 17:08:39 INFO - Using buildbot properties: 17:08:39 INFO - { 17:08:39 INFO - "properties": { 17:08:39 INFO - "buildnumber": 395, 17:08:39 INFO - "product": "firefox", 17:08:39 INFO - "script_repo_revision": "production", 17:08:39 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 17:08:39 INFO - "repository": "", 17:08:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 17:08:39 INFO - "buildid": "20151203155442", 17:08:39 INFO - "slavename": "talos-linux64-ix-014", 17:08:39 INFO - "pgo_build": "False", 17:08:39 INFO - "basedir": "/builds/slave/test", 17:08:39 INFO - "project": "", 17:08:39 INFO - "platform": "ubuntu64_hw", 17:08:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:08:39 INFO - "slavebuilddir": "test", 17:08:39 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 17:08:39 INFO - "branch": "mozilla-central", 17:08:39 INFO - "repo_path": "mozilla-central", 17:08:39 INFO - "stage_platform": "linux64", 17:08:39 INFO - "builduid": "e79a20b297cf4f3bae8998cd37533bcb", 17:08:39 INFO - "revision": "9d8af47837101c8f4ce67930e5094a59ed9942a6" 17:08:39 INFO - }, 17:08:39 INFO - "sourcestamp": { 17:08:39 INFO - "repository": "", 17:08:39 INFO - "hasPatch": false, 17:08:39 INFO - "project": "", 17:08:39 INFO - "branch": "mozilla-central-linux64-talos", 17:08:39 INFO - "changes": [ 17:08:39 INFO - { 17:08:39 INFO - "category": null, 17:08:39 INFO - "files": [ 17:08:39 INFO - { 17:08:39 INFO - "url": null, 17:08:39 INFO - "name": "https://queue.taskcluster.net/v1/task/0Om73bYtRJKD7mm_xwWGnQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 17:08:39 INFO - } 17:08:39 INFO - ], 17:08:39 INFO - "repository": "", 17:08:39 INFO - "rev": "9d8af47837101c8f4ce67930e5094a59ed9942a6", 17:08:39 INFO - "who": "kwierso@gmail.com", 17:08:39 INFO - "when": 1449191275, 17:08:39 INFO - "number": 6741841, 17:08:39 INFO - "comments": "Merge inbound to central, a=merge", 17:08:39 INFO - "project": "", 17:08:39 INFO - "at": "Thu 03 Dec 2015 17:07:55", 17:08:39 INFO - "branch": "mozilla-central-linux64-talos", 17:08:39 INFO - "revlink": "", 17:08:39 INFO - "properties": [ 17:08:39 INFO - [ 17:08:39 INFO - "buildid", 17:08:39 INFO - "20151203155442", 17:08:39 INFO - "Change" 17:08:39 INFO - ], 17:08:39 INFO - [ 17:08:39 INFO - "builduid", 17:08:39 INFO - "e79a20b297cf4f3bae8998cd37533bcb", 17:08:39 INFO - "Change" 17:08:39 INFO - ], 17:08:39 INFO - [ 17:08:39 INFO - "pgo_build", 17:08:39 INFO - "False", 17:08:39 INFO - "Change" 17:08:39 INFO - ] 17:08:39 INFO - ], 17:08:39 INFO - "revision": "9d8af47837101c8f4ce67930e5094a59ed9942a6" 17:08:39 INFO - } 17:08:39 INFO - ], 17:08:39 INFO - "revision": "9d8af47837101c8f4ce67930e5094a59ed9942a6" 17:08:39 INFO - } 17:08:39 INFO - } 17:08:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/0Om73bYtRJKD7mm_xwWGnQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 17:08:39 INFO - Running post-action listener: _resource_record_post_action 17:08:39 INFO - ##### 17:08:39 INFO - ##### Running download-and-extract step. 17:08:39 INFO - ##### 17:08:39 INFO - Running pre-action listener: _resource_record_pre_action 17:08:39 INFO - Running main action method: download_and_extract 17:08:39 INFO - mkdir: /builds/slave/test/build/tests 17:08:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:39 INFO - https://queue.taskcluster.net/v1/task/0Om73bYtRJKD7mm_xwWGnQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:08:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Om73bYtRJKD7mm_xwWGnQ/artifacts/public/build/test_packages.json 17:08:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Om73bYtRJKD7mm_xwWGnQ/artifacts/public/build/test_packages.json 17:08:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Om73bYtRJKD7mm_xwWGnQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 17:08:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Om73bYtRJKD7mm_xwWGnQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 17:08:41 INFO - Downloaded 1302 bytes. 17:08:41 INFO - Reading from file /builds/slave/test/build/test_packages.json 17:08:41 INFO - Using the following test package requirements: 17:08:41 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 17:08:41 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:08:41 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:41 INFO - u'jsshell-linux-x86_64.zip'], 17:08:41 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:08:41 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 17:08:41 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:08:41 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:08:41 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:08:41 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 17:08:41 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:08:41 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:08:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:41 INFO - https://queue.taskcluster.net/v1/task/0Om73bYtRJKD7mm_xwWGnQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:08:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Om73bYtRJKD7mm_xwWGnQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:08:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Om73bYtRJKD7mm_xwWGnQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:08:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Om73bYtRJKD7mm_xwWGnQ/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 17:08:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Om73bYtRJKD7mm_xwWGnQ/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 17:08:44 INFO - Downloaded 21795068 bytes. 17:08:44 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 17:08:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:08:44 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 17:08:45 INFO - Return code: 0 17:08:45 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 17:08:45 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')]} 17:08:45 INFO - https://queue.taskcluster.net/v1/task/0Om73bYtRJKD7mm_xwWGnQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:08:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Om73bYtRJKD7mm_xwWGnQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:08:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Om73bYtRJKD7mm_xwWGnQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:08:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Om73bYtRJKD7mm_xwWGnQ/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 17:08:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Om73bYtRJKD7mm_xwWGnQ/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 17:08:47 INFO - Downloaded 21795068 bytes. 17:08:47 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 17:08:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:08:47 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 17:08:48 INFO - Return code: 0 17:08:48 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')]} 17:08:48 INFO - https://queue.taskcluster.net/v1/task/0Om73bYtRJKD7mm_xwWGnQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:08:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Om73bYtRJKD7mm_xwWGnQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 17:08:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Om73bYtRJKD7mm_xwWGnQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 17:08:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Om73bYtRJKD7mm_xwWGnQ/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 17:08:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Om73bYtRJKD7mm_xwWGnQ/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 17:08:52 INFO - Downloaded 11132001 bytes. 17:08:52 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 17:08:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 17:08:52 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 17:08:52 INFO - Return code: 0 17:08:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:52 INFO - https://queue.taskcluster.net/v1/task/0Om73bYtRJKD7mm_xwWGnQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:08:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Om73bYtRJKD7mm_xwWGnQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 17:08:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Om73bYtRJKD7mm_xwWGnQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 17:08:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Om73bYtRJKD7mm_xwWGnQ/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 17:08:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0Om73bYtRJKD7mm_xwWGnQ/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 17:08:54 INFO - Downloaded 57679806 bytes. 17:08:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/0Om73bYtRJKD7mm_xwWGnQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 17:08:54 INFO - mkdir: /builds/slave/test/properties 17:08:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:08:54 INFO - Writing to file /builds/slave/test/properties/build_url 17:08:54 INFO - Contents: 17:08:54 INFO - build_url:https://queue.taskcluster.net/v1/task/0Om73bYtRJKD7mm_xwWGnQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 17:08:54 INFO - Running post-action listener: _resource_record_post_action 17:08:54 INFO - Running post-action listener: set_extra_try_arguments 17:08:54 INFO - ##### 17:08:54 INFO - ##### Running populate-webroot step. 17:08:54 INFO - ##### 17:08:54 INFO - Running pre-action listener: _resource_record_pre_action 17:08:54 INFO - Running main action method: populate_webroot 17:08:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:08:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:08:54 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 17:08:54 INFO - '../fennec_ids.txt'], 17:08:54 INFO - 'tests': ['tcheck2']}, 17:08:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:08:54 INFO - '--tppagecycles', 17:08:54 INFO - '7'], 17:08:54 INFO - 'tests': ['tsvgm']}}, 17:08:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:08:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:08:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:08:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:08:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:08:54 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:08:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:08:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:54 INFO - 'talos_options': ['--e10s'], 17:08:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:08:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:54 INFO - 'tests': ['damp', 'tps']}, 17:08:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:54 INFO - 'talos_options': ['--e10s'], 17:08:54 INFO - 'tests': ['damp', 'tps']}, 17:08:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:08:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:08:54 INFO - 'other': {'tests': ['a11yr', 17:08:54 INFO - 'ts_paint', 17:08:54 INFO - 'tpaint', 17:08:54 INFO - 'sessionrestore', 17:08:54 INFO - 'sessionrestore_no_auto_restore']}, 17:08:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:08:54 INFO - 'tests': ['a11yr', 17:08:54 INFO - 'ts_paint', 17:08:54 INFO - 'tpaint', 17:08:54 INFO - 'sessionrestore', 17:08:54 INFO - 'sessionrestore_no_auto_restore']}, 17:08:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:08:54 INFO - 'tests': ['a11yr', 17:08:54 INFO - 'ts_paint', 17:08:54 INFO - 'tpaint', 17:08:54 INFO - 'sessionrestore', 17:08:54 INFO - 'sessionrestore_no_auto_restore']}, 17:08:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:08:54 INFO - 'tests': ['a11yr', 17:08:54 INFO - 'ts_paint', 17:08:54 INFO - 'tpaint', 17:08:54 INFO - 'sessionrestore', 17:08:54 INFO - 'sessionrestore_no_auto_restore']}, 17:08:54 INFO - 'other_l64': {'tests': ['a11yr', 17:08:54 INFO - 'ts_paint', 17:08:54 INFO - 'tpaint', 17:08:54 INFO - 'sessionrestore', 17:08:54 INFO - 'sessionrestore_no_auto_restore']}, 17:08:54 INFO - 'other_nol64': {'tests': ['a11yr', 17:08:54 INFO - 'ts_paint', 17:08:54 INFO - 'tpaint', 17:08:54 INFO - 'sessionrestore', 17:08:54 INFO - 'sessionrestore_no_auto_restore']}, 17:08:54 INFO - 'svgr': {'tests': ['tsvgx', 17:08:54 INFO - 'tsvgr_opacity', 17:08:54 INFO - 'tart', 17:08:54 INFO - 'tscrollx', 17:08:54 INFO - 'cart']}, 17:08:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:08:54 INFO - 'tests': ['tsvgx', 17:08:54 INFO - 'tsvgr_opacity', 17:08:54 INFO - 'tart', 17:08:54 INFO - 'tscrollx', 17:08:54 INFO - 'cart']}, 17:08:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:54 INFO - 'tests': ['tp5o']}, 17:08:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:54 INFO - 'talos_options': ['--e10s'], 17:08:54 INFO - 'tests': ['tp5o']}, 17:08:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:54 INFO - 'talos_options': ['--xperf_path', 17:08:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:08:54 INFO - 'tests': ['tp5n']}, 17:08:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:54 INFO - 'talos_options': ['--e10s', 17:08:54 INFO - '--xperf_path', 17:08:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:08:54 INFO - 'tests': ['tp5n']}}, 17:08:54 INFO - 'talos.zip': {'path': '', 17:08:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:08:54 INFO - Running post-action listener: _resource_record_post_action 17:08:54 INFO - ##### 17:08:54 INFO - ##### Running create-virtualenv step. 17:08:54 INFO - ##### 17:08:54 INFO - Running pre-action listener: _resource_record_pre_action 17:08:54 INFO - Running main action method: create_virtualenv 17:08:54 INFO - Creating virtualenv /builds/slave/test/build/venv 17:08:54 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 17:08:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:08:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:08:54 INFO - Using real prefix '/usr' 17:08:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:08:54 INFO - Installing distribute.............................................................................................................................................................................................done. 17:08:56 INFO - Installing pip.................done. 17:08:56 INFO - Return code: 0 17:08:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:08:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f29e400ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201c0b0>, '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 0x201cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201d440>, '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': '01deea79d00cc2c334834894000001d2-1449190031.695872-1875200976', '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 17:08:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:08:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:08:56 INFO - Using env: {'DISPLAY': ':0', 17:08:56 INFO - 'HOME': '/home/cltbld', 17:08:56 INFO - 'LANG': 'en_US.UTF-8', 17:08:56 INFO - 'LANGUAGE': 'en_US:en', 17:08:56 INFO - 'LOGNAME': 'cltbld', 17:08:56 INFO - 'MAIL': '/var/mail/cltbld', 17:08:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:56 INFO - 'MOZ_NO_REMOTE': '1', 17:08:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:56 INFO - 'NO_EM_RESTART': '1', 17:08:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:56 INFO - 'PWD': '/builds/slave/test', 17:08:56 INFO - 'SHELL': '/bin/bash', 17:08:56 INFO - 'SHLVL': '1', 17:08:56 INFO - 'TERM': 'linux', 17:08:56 INFO - 'TMOUT': '86400', 17:08:56 INFO - 'USER': 'cltbld', 17:08:56 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1449190031.695872-1875200976', 17:08:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:56 INFO - '_': '/tools/buildbot/bin/python'} 17:08:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:08:56 INFO - Cleaning up... 17:08:56 INFO - Return code: 0 17:08:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:08:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f29e400ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201c0b0>, '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 0x201cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201d440>, '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': '01deea79d00cc2c334834894000001d2-1449190031.695872-1875200976', '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 17:08:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 17:08:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:08:56 INFO - Using env: {'DISPLAY': ':0', 17:08:56 INFO - 'HOME': '/home/cltbld', 17:08:56 INFO - 'LANG': 'en_US.UTF-8', 17:08:56 INFO - 'LANGUAGE': 'en_US:en', 17:08:56 INFO - 'LOGNAME': 'cltbld', 17:08:56 INFO - 'MAIL': '/var/mail/cltbld', 17:08:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:56 INFO - 'MOZ_NO_REMOTE': '1', 17:08:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:56 INFO - 'NO_EM_RESTART': '1', 17:08:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:56 INFO - 'PWD': '/builds/slave/test', 17:08:56 INFO - 'SHELL': '/bin/bash', 17:08:56 INFO - 'SHLVL': '1', 17:08:56 INFO - 'TERM': 'linux', 17:08:56 INFO - 'TMOUT': '86400', 17:08:56 INFO - 'USER': 'cltbld', 17:08:56 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1449190031.695872-1875200976', 17:08:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:56 INFO - '_': '/tools/buildbot/bin/python'} 17:08:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:57 INFO - Downloading/unpacking psutil>=0.7.1 17:08:57 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 17:08:57 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 17:08:57 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 17:08:57 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 17:08:57 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 17:08:57 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 17:08:58 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 17:08:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 17:08:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:08:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:08:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:08:58 INFO - Installing collected packages: psutil 17:08:58 INFO - Running setup.py install for psutil 17:08:58 INFO - building 'psutil._psutil_linux' extension 17:08:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:08:59 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 17:08:59 INFO - building 'psutil._psutil_posix' extension 17:08:59 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 17:08:59 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 17:08:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:08:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:08:59 INFO - Successfully installed psutil 17:08:59 INFO - Cleaning up... 17:08:59 INFO - Return code: 0 17:08:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:08:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:59 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 0x7f29e400ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201c0b0>, '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 0x201cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201d440>, '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': '01deea79d00cc2c334834894000001d2-1449190031.695872-1875200976', '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 17:08:59 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 17:08:59 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 17:08:59 INFO - Using env: {'DISPLAY': ':0', 17:08:59 INFO - 'HOME': '/home/cltbld', 17:08:59 INFO - 'LANG': 'en_US.UTF-8', 17:08:59 INFO - 'LANGUAGE': 'en_US:en', 17:08:59 INFO - 'LOGNAME': 'cltbld', 17:08:59 INFO - 'MAIL': '/var/mail/cltbld', 17:08:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:59 INFO - 'MOZ_NO_REMOTE': '1', 17:08:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:59 INFO - 'NO_EM_RESTART': '1', 17:08:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:59 INFO - 'PWD': '/builds/slave/test', 17:08:59 INFO - 'SHELL': '/bin/bash', 17:08:59 INFO - 'SHLVL': '1', 17:08:59 INFO - 'TERM': 'linux', 17:08:59 INFO - 'TMOUT': '86400', 17:08:59 INFO - 'USER': 'cltbld', 17:08:59 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1449190031.695872-1875200976', 17:08:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:59 INFO - '_': '/tools/buildbot/bin/python'} 17:08:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:09:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 17:09:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:09:01 INFO - Installing collected packages: mozsystemmonitor 17:09:01 INFO - Running setup.py install for mozsystemmonitor 17:09:01 INFO - Successfully installed mozsystemmonitor 17:09:01 INFO - Cleaning up... 17:09:01 INFO - Return code: 0 17:09:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:09: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')]} 17:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09: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')]} 17:09:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:01 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 0x7f29e400ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201c0b0>, '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 0x201cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201d440>, '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': '01deea79d00cc2c334834894000001d2-1449190031.695872-1875200976', '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 17:09:01 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 17:09:01 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 17:09:01 INFO - Using env: {'DISPLAY': ':0', 17:09:01 INFO - 'HOME': '/home/cltbld', 17:09:01 INFO - 'LANG': 'en_US.UTF-8', 17:09:01 INFO - 'LANGUAGE': 'en_US:en', 17:09:01 INFO - 'LOGNAME': 'cltbld', 17:09:01 INFO - 'MAIL': '/var/mail/cltbld', 17:09:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:01 INFO - 'MOZ_NO_REMOTE': '1', 17:09:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:01 INFO - 'NO_EM_RESTART': '1', 17:09:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:01 INFO - 'PWD': '/builds/slave/test', 17:09:01 INFO - 'SHELL': '/bin/bash', 17:09:01 INFO - 'SHLVL': '1', 17:09:01 INFO - 'TERM': 'linux', 17:09:01 INFO - 'TMOUT': '86400', 17:09:01 INFO - 'USER': 'cltbld', 17:09:01 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1449190031.695872-1875200976', 17:09:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:01 INFO - '_': '/tools/buildbot/bin/python'} 17:09:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:01 INFO - Downloading/unpacking blobuploader==1.2.4 17:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:03 INFO - Downloading blobuploader-1.2.4.tar.gz 17:09:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 17:09:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:09:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 17:09:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:09:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:04 INFO - Downloading docopt-0.6.1.tar.gz 17:09:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 17:09:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:09:04 INFO - Installing collected packages: blobuploader, requests, docopt 17:09:04 INFO - Running setup.py install for blobuploader 17:09:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:09:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:09:04 INFO - Running setup.py install for requests 17:09:04 INFO - Running setup.py install for docopt 17:09:04 INFO - Successfully installed blobuploader requests docopt 17:09:04 INFO - Cleaning up... 17:09:04 INFO - Return code: 0 17:09:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:09:04 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')]} 17:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:04 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')]} 17:09:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:04 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 0x7f29e400ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201c0b0>, '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 0x201cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201d440>, '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': '01deea79d00cc2c334834894000001d2-1449190031.695872-1875200976', '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 17:09:04 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 17:09:04 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 17:09:04 INFO - Using env: {'DISPLAY': ':0', 17:09:04 INFO - 'HOME': '/home/cltbld', 17:09:04 INFO - 'LANG': 'en_US.UTF-8', 17:09:04 INFO - 'LANGUAGE': 'en_US:en', 17:09:04 INFO - 'LOGNAME': 'cltbld', 17:09:04 INFO - 'MAIL': '/var/mail/cltbld', 17:09:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:04 INFO - 'MOZ_NO_REMOTE': '1', 17:09:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:04 INFO - 'NO_EM_RESTART': '1', 17:09:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:04 INFO - 'PWD': '/builds/slave/test', 17:09:04 INFO - 'SHELL': '/bin/bash', 17:09:04 INFO - 'SHLVL': '1', 17:09:04 INFO - 'TERM': 'linux', 17:09:04 INFO - 'TMOUT': '86400', 17:09:04 INFO - 'USER': 'cltbld', 17:09:04 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1449190031.695872-1875200976', 17:09:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:04 INFO - '_': '/tools/buildbot/bin/python'} 17:09:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:09:05 INFO - Running setup.py (path:/tmp/pip-7RqNCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:09:05 INFO - Running setup.py (path:/tmp/pip-GFPiN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:09:05 INFO - Running setup.py (path:/tmp/pip-uLltbQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:09:05 INFO - Running setup.py (path:/tmp/pip-a8d_4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:09:05 INFO - Running setup.py (path:/tmp/pip-M5zEtq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:09:05 INFO - Running setup.py (path:/tmp/pip-Va5YI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:09:05 INFO - Running setup.py (path:/tmp/pip-ObgrMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:09:05 INFO - Running setup.py (path:/tmp/pip-FMK9MY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:09:05 INFO - Running setup.py (path:/tmp/pip-z_Y8GZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:09:05 INFO - Running setup.py (path:/tmp/pip-rnK2a7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:09:05 INFO - Running setup.py (path:/tmp/pip-xtfAx9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:09:05 INFO - Running setup.py (path:/tmp/pip-0yCiA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:09:05 INFO - Running setup.py (path:/tmp/pip-ThwsnY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:09:05 INFO - Running setup.py (path:/tmp/pip-HQ7g4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:09:06 INFO - Running setup.py (path:/tmp/pip-YBtq4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:09:06 INFO - Running setup.py (path:/tmp/pip-A3kpXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:09:06 INFO - Running setup.py (path:/tmp/pip-iFicfw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:09:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:09:06 INFO - Running setup.py install for manifestparser 17:09:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:09:06 INFO - Running setup.py install for mozcrash 17:09:06 INFO - Running setup.py install for mozdebug 17:09:06 INFO - Running setup.py install for mozdevice 17:09:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:09:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:09:06 INFO - Running setup.py install for mozfile 17:09:06 INFO - Running setup.py install for mozhttpd 17:09:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:09:06 INFO - Running setup.py install for mozinfo 17:09:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:09:06 INFO - Running setup.py install for mozInstall 17:09:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:09:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:09:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:09:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:09:07 INFO - Running setup.py install for mozleak 17:09:07 INFO - Running setup.py install for mozlog 17:09:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:09:07 INFO - Running setup.py install for moznetwork 17:09:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:09:07 INFO - Running setup.py install for mozprocess 17:09:07 INFO - Running setup.py install for mozprofile 17:09:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:09:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:09:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:09:07 INFO - Running setup.py install for mozrunner 17:09:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:09:07 INFO - Running setup.py install for mozscreenshot 17:09:07 INFO - Running setup.py install for moztest 17:09:07 INFO - Running setup.py install for mozversion 17:09:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:09:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:09:08 INFO - Cleaning up... 17:09:08 INFO - Return code: 0 17:09:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:09:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:08 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 0x7f29e400ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201c0b0>, '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 0x201cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201d440>, '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': '01deea79d00cc2c334834894000001d2-1449190031.695872-1875200976', '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 17:09:08 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 17:09:08 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 17:09:08 INFO - Using env: {'DISPLAY': ':0', 17:09:08 INFO - 'HOME': '/home/cltbld', 17:09:08 INFO - 'LANG': 'en_US.UTF-8', 17:09:08 INFO - 'LANGUAGE': 'en_US:en', 17:09:08 INFO - 'LOGNAME': 'cltbld', 17:09:08 INFO - 'MAIL': '/var/mail/cltbld', 17:09:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:08 INFO - 'MOZ_NO_REMOTE': '1', 17:09:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:08 INFO - 'NO_EM_RESTART': '1', 17:09:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:08 INFO - 'PWD': '/builds/slave/test', 17:09:08 INFO - 'SHELL': '/bin/bash', 17:09:08 INFO - 'SHLVL': '1', 17:09:08 INFO - 'TERM': 'linux', 17:09:08 INFO - 'TMOUT': '86400', 17:09:08 INFO - 'USER': 'cltbld', 17:09:08 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1449190031.695872-1875200976', 17:09:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:08 INFO - '_': '/tools/buildbot/bin/python'} 17:09:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:09:08 INFO - Running setup.py (path:/tmp/pip-Gi34uk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:09:08 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:09:08 INFO - Running setup.py (path:/tmp/pip-QCyxqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:09:08 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)) 17:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:09:08 INFO - Running setup.py (path:/tmp/pip-5eFQKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:09:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:09:08 INFO - Running setup.py (path:/tmp/pip-xJtSVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:09:08 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)) 17:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:09:08 INFO - Running setup.py (path:/tmp/pip-jVcsWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:09:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:09:08 INFO - Running setup.py (path:/tmp/pip-blVP7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:09:08 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)) 17:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:09:08 INFO - Running setup.py (path:/tmp/pip-p9Tan7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:09:08 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)) 17:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:09:08 INFO - Running setup.py (path:/tmp/pip-Tprb3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:09:08 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)) 17:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:09:08 INFO - Running setup.py (path:/tmp/pip-zP19i0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:09:08 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)) 17:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:09:08 INFO - Running setup.py (path:/tmp/pip-lwAJlC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:09:08 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)) 17:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:09:08 INFO - Running setup.py (path:/tmp/pip-XBG01k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:09:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:09:09 INFO - Running setup.py (path:/tmp/pip-vdcTyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:09:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:09:09 INFO - Running setup.py (path:/tmp/pip-NJC5Qa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:09:09 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)) 17:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:09:09 INFO - Running setup.py (path:/tmp/pip-JR7Voh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:09:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:09:09 INFO - Running setup.py (path:/tmp/pip-BO67MH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:09:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:09:09 INFO - Running setup.py (path:/tmp/pip-xvq3gE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:09:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:09:09 INFO - Running setup.py (path:/tmp/pip-Dw7RHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:09:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:09:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:09:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:09:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:09:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:09:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:09:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:11 INFO - Downloading blessings-1.5.1.tar.gz 17:09:11 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 17:09:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:09:11 INFO - Installing collected packages: blessings 17:09:11 INFO - Running setup.py install for blessings 17:09:11 INFO - Successfully installed blessings 17:09:11 INFO - Cleaning up... 17:09:11 INFO - Return code: 0 17:09:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:09:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:09:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:09:11 INFO - Reading from file tmpfile_stdout 17:09:11 INFO - Current package versions: 17:09:11 INFO - argparse == 1.2.1 17:09:11 INFO - blessings == 1.5.1 17:09:11 INFO - blobuploader == 1.2.4 17:09:11 INFO - docopt == 0.6.1 17:09:11 INFO - manifestparser == 1.1 17:09:11 INFO - mozInstall == 1.12 17:09:11 INFO - mozcrash == 0.16 17:09:11 INFO - mozdebug == 0.1 17:09:11 INFO - mozdevice == 0.47 17:09:11 INFO - mozfile == 1.2 17:09:11 INFO - mozhttpd == 0.7 17:09:11 INFO - mozinfo == 0.9 17:09:11 INFO - mozleak == 0.1 17:09:11 INFO - mozlog == 3.1 17:09:11 INFO - moznetwork == 0.27 17:09:11 INFO - mozprocess == 0.22 17:09:11 INFO - mozprofile == 0.27 17:09:11 INFO - mozrunner == 6.11 17:09:11 INFO - mozscreenshot == 0.1 17:09:11 INFO - mozsystemmonitor == 0.0 17:09:11 INFO - moztest == 0.7 17:09:11 INFO - mozversion == 1.4 17:09:11 INFO - psutil == 3.1.1 17:09:11 INFO - requests == 1.2.3 17:09:11 INFO - wsgiref == 0.1.2 17:09:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:09: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')]} 17:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09: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')]} 17:09:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09: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', '-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 0x7f29e400ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201c0b0>, '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 0x201cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201d440>, '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': '01deea79d00cc2c334834894000001d2-1449190031.695872-1875200976', '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 17:09:11 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 17:09:11 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 17:09:11 INFO - Using env: {'DISPLAY': ':0', 17:09:11 INFO - 'HOME': '/home/cltbld', 17:09:11 INFO - 'LANG': 'en_US.UTF-8', 17:09:11 INFO - 'LANGUAGE': 'en_US:en', 17:09:11 INFO - 'LOGNAME': 'cltbld', 17:09:11 INFO - 'MAIL': '/var/mail/cltbld', 17:09:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:11 INFO - 'MOZ_NO_REMOTE': '1', 17:09:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:11 INFO - 'NO_EM_RESTART': '1', 17:09:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:11 INFO - 'PWD': '/builds/slave/test', 17:09:11 INFO - 'SHELL': '/bin/bash', 17:09:11 INFO - 'SHLVL': '1', 17:09:11 INFO - 'TERM': 'linux', 17:09:11 INFO - 'TMOUT': '86400', 17:09:11 INFO - 'USER': 'cltbld', 17:09:11 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1449190031.695872-1875200976', 17:09:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:11 INFO - '_': '/tools/buildbot/bin/python'} 17:09:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:11 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)) 17:09:11 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)) 17:09:11 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)) 17:09:11 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)) 17:09:11 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)) 17:09:11 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)) 17:09:11 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)) 17:09:11 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)) 17:09:11 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)) 17:09:11 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)) 17:09:11 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)) 17:09:11 INFO - Cleaning up... 17:09:11 INFO - Return code: 0 17:09:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:09: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')]} 17:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09: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')]} 17:09:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f29e400ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201c0b0>, '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 0x201cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201d440>, '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': '01deea79d00cc2c334834894000001d2-1449190031.695872-1875200976', '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 17:09: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', 'jsonschema'] in /builds/slave/test/build 17:09: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 jsonschema 17:09:11 INFO - Using env: {'DISPLAY': ':0', 17:09:11 INFO - 'HOME': '/home/cltbld', 17:09:11 INFO - 'LANG': 'en_US.UTF-8', 17:09:11 INFO - 'LANGUAGE': 'en_US:en', 17:09:11 INFO - 'LOGNAME': 'cltbld', 17:09:11 INFO - 'MAIL': '/var/mail/cltbld', 17:09:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:11 INFO - 'MOZ_NO_REMOTE': '1', 17:09:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:11 INFO - 'NO_EM_RESTART': '1', 17:09:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:11 INFO - 'PWD': '/builds/slave/test', 17:09:11 INFO - 'SHELL': '/bin/bash', 17:09:11 INFO - 'SHLVL': '1', 17:09:11 INFO - 'TERM': 'linux', 17:09:11 INFO - 'TMOUT': '86400', 17:09:11 INFO - 'USER': 'cltbld', 17:09:11 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1449190031.695872-1875200976', 17:09:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:11 INFO - '_': '/tools/buildbot/bin/python'} 17:09:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:12 INFO - Downloading/unpacking jsonschema 17:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:09:13 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 17:09:13 INFO - Downloading/unpacking functools32 (from jsonschema) 17:09:13 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 17:09:13 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 17:09:13 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 17:09:13 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 17:09:13 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 17:09:13 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 17:09:13 INFO - Downloading functools32-3.2.3-2.tar.gz 17:09:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 17:09:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:09:13 INFO - warning: no files found matching '*.txt' 17:09:13 INFO - no previously-included directories found matching 'build' 17:09:13 INFO - no previously-included directories found matching 'dist' 17:09:13 INFO - no previously-included directories found matching '.git*' 17:09:13 INFO - Installing collected packages: jsonschema, functools32 17:09:14 INFO - Running setup.py install for functools32 17:09:14 INFO - warning: no files found matching '*.txt' 17:09:14 INFO - no previously-included directories found matching 'build' 17:09:14 INFO - no previously-included directories found matching 'dist' 17:09:14 INFO - no previously-included directories found matching '.git*' 17:09:14 INFO - Successfully installed jsonschema functools32 17:09:14 INFO - Cleaning up... 17:09:14 INFO - Return code: 0 17:09:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:09:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:14 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 0x7f29e400ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201c0b0>, '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 0x201cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201d440>, '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': '01deea79d00cc2c334834894000001d2-1449190031.695872-1875200976', '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 17:09:14 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 17:09:14 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 17:09:14 INFO - Using env: {'DISPLAY': ':0', 17:09:14 INFO - 'HOME': '/home/cltbld', 17:09:14 INFO - 'LANG': 'en_US.UTF-8', 17:09:14 INFO - 'LANGUAGE': 'en_US:en', 17:09:14 INFO - 'LOGNAME': 'cltbld', 17:09:14 INFO - 'MAIL': '/var/mail/cltbld', 17:09:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:14 INFO - 'MOZ_NO_REMOTE': '1', 17:09:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:14 INFO - 'NO_EM_RESTART': '1', 17:09:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:14 INFO - 'PWD': '/builds/slave/test', 17:09:14 INFO - 'SHELL': '/bin/bash', 17:09:14 INFO - 'SHLVL': '1', 17:09:14 INFO - 'TERM': 'linux', 17:09:14 INFO - 'TMOUT': '86400', 17:09:14 INFO - 'USER': 'cltbld', 17:09:14 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1449190031.695872-1875200976', 17:09:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:14 INFO - '_': '/tools/buildbot/bin/python'} 17:09:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:14 INFO - Downloading/unpacking flake8 17:09: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 17:09: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 17:09: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 17:09: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 17:09: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 17:09: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 17:09:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:09:16 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 17:09:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:09: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 17:09: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 17:09: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 17:09: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 17:09: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 17:09: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 17:09:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:09:16 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 17:09:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:09: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 17:09: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 17:09: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 17:09: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 17:09: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 17:09: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 17:09:16 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 17:09:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:09: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 17:09: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 17:09: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 17:09: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 17:09: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 17:09: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 17:09:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 17:09:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:09:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:09:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:09:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:09:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:09:16 INFO - no previously-included directories found matching 'docs/_build' 17:09:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:09:16 INFO - Running setup.py install for pep8 17:09:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:09:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:09:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:09:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:09:16 INFO - no previously-included directories found matching 'docs/_build' 17:09:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:09:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:09:16 INFO - Cleaning up... 17:09:16 INFO - Return code: 0 17:09:17 INFO - Running post-action listener: _resource_record_post_action 17:09:17 INFO - Running post-action listener: _start_resource_monitoring 17:09:17 INFO - Starting resource monitoring. 17:09:17 INFO - ##### 17:09:17 INFO - ##### Running install step. 17:09:17 INFO - ##### 17:09:17 INFO - Running pre-action listener: _resource_record_pre_action 17:09:17 INFO - Running main action method: install 17:09:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:09:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:09:17 INFO - Reading from file tmpfile_stdout 17:09:17 INFO - Detecting whether we're running mozinstall >=1.0... 17:09:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:09:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:09:17 INFO - Reading from file tmpfile_stdout 17:09:17 INFO - Output received: 17:09:17 INFO - Usage: mozinstall [options] installer 17:09:17 INFO - Options: 17:09:17 INFO - -h, --help show this help message and exit 17:09:17 INFO - -d DEST, --destination=DEST 17:09:17 INFO - Directory to install application into. [default: 17:09:17 INFO - "/builds/slave/test"] 17:09:17 INFO - --app=APP Application being installed. [default: firefox] 17:09:17 INFO - mkdir: /builds/slave/test/build/application 17:09:17 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'] 17:09:17 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 17:09:31 INFO - Reading from file tmpfile_stdout 17:09:31 INFO - Output received: 17:09:31 INFO - /builds/slave/test/build/application/firefox/firefox 17:09:31 INFO - Running post-action listener: _resource_record_post_action 17:09:31 INFO - ##### 17:09:31 INFO - ##### Running run-tests step. 17:09:31 INFO - ##### 17:09:31 INFO - Running pre-action listener: _resource_record_pre_action 17:09:31 INFO - Running main action method: run_tests 17:09:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:09:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:09:31 INFO - Python 2.7.3 17:09:31 INFO - Return code: 0 17:09:31 INFO - grabbing minidump binary from tooltool 17:09:31 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')]} 17:09:31 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 0x201c0b0>, '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 0x201cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201d440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:09:31 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 17:09:31 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 17:09:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:09:31 INFO - Return code: 0 17:09:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:09:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:09:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:09:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:09:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:09:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:09:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:09:32 INFO - Return code: 0 17:09:32 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/0Om73bYtRJKD7mm_xwWGnQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost'] in /builds/slave/test/build 17:09:32 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/0Om73bYtRJKD7mm_xwWGnQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost 17:09:32 INFO - Using env: {'DISPLAY': ':0', 17:09:32 INFO - 'HOME': '/home/cltbld', 17:09:32 INFO - 'LANG': 'en_US.UTF-8', 17:09:32 INFO - 'LANGUAGE': 'en_US:en', 17:09:32 INFO - 'LOGNAME': 'cltbld', 17:09:32 INFO - 'MAIL': '/var/mail/cltbld', 17:09:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:09:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:09:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:32 INFO - 'MOZ_NO_REMOTE': '1', 17:09:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:09:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:32 INFO - 'NO_EM_RESTART': '1', 17:09:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:32 INFO - 'PWD': '/builds/slave/test', 17:09:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:09:32 INFO - 'SHELL': '/bin/bash', 17:09:32 INFO - 'SHLVL': '1', 17:09:32 INFO - 'TERM': 'linux', 17:09:32 INFO - 'TMOUT': '86400', 17:09:32 INFO - 'USER': 'cltbld', 17:09:32 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1449190031.695872-1875200976', 17:09:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:32 INFO - '_': '/tools/buildbot/bin/python'} 17:09:32 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/0Om73bYtRJKD7mm_xwWGnQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost'] with output_timeout 3600 17:09:33 INFO - mozversion INFO | application_buildid: 20151203155442 17:09:33 INFO - mozversion INFO | application_changeset: 9d8af47837101c8f4ce67930e5094a59ed9942a6 17:09:33 INFO - mozversion INFO | application_display_name: Nightly 17:09:33 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:09:33 INFO - mozversion INFO | application_name: Firefox 17:09:33 INFO - mozversion INFO | application_remotingname: firefox 17:09:33 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 17:09:33 INFO - mozversion INFO | application_vendor: Mozilla 17:09:33 INFO - mozversion INFO | application_version: 45.0a1 17:09:33 INFO - mozversion INFO | platform_buildid: 20151203155442 17:09:33 INFO - mozversion INFO | platform_changeset: 9d8af47837101c8f4ce67930e5094a59ed9942a6 17:09:33 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 17:09:33 INFO - mozversion INFO | platform_version: 45.0a1 17:09:33 INFO - 2015-12-03 17:09:33,024 DEBUG : using testdate: 1449191373 17:09:33 INFO - 2015-12-03 17:09:33,024 DEBUG : actual date: 1449191373 17:09:33 INFO - 2015-12-03 17:09:33,036 INFO : starting webserver on 'localhost:58096' 17:09:33 INFO - 2015-12-03 17:09:33,037 INFO : Starting test suite talos-linux64-ix-014 17:09:33 INFO - 2015-12-03 17:09:33,038 INFO : Starting test dromaeo_css 17:09:33 INFO - 2015-12-03 17:09:33,038 DEBUG : operating with platform_type : linux_ 17:09:33 INFO - 2015-12-03 17:09:33,038 INFO : Initialising browser for dromaeo_css test... 17:09:33 INFO - 2015-12-03 17:09:33,051 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp83_6Va/profile http://localhost:58096/getInfo.html 17:09:37 INFO - 2015-12-03 17:09:37,406 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:09:37 INFO - 2015-12-03 17:09:37,407 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:09:37 INFO - 2015-12-03 17:09:37,407 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:09:37 INFO - 2015-12-03 17:09:37,407 DEBUG : BROWSER_OUTPUT: __metrics 17:09:37 INFO - 2015-12-03 17:09:37,556 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] 17:09:37 INFO - 2015-12-03 17:09:37,556 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] 17:09:38 INFO - 2015-12-03 17:09:38,721 INFO : Browser initialized. 17:09:38 INFO - 2015-12-03 17:09:38,721 INFO : Running cycle 1/1 for dromaeo_css test... 17:09:38 INFO - 2015-12-03 17:09:38,722 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp83_6Va/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:09:50 INFO - 2015-12-03 17:09:50,763 DEBUG : BROWSER_OUTPUT: RSS: Main: 143798272 17:09:50 INFO - 2015-12-03 17:09:50,764 DEBUG : BROWSER_OUTPUT: 17:10:41 INFO - 2015-12-03 17:10:41,934 DEBUG : BROWSER_OUTPUT: 1449191441933 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] 17:12:54 INFO - 2015-12-03 17:12:54,014 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58096/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58096/tests/dromaeo/cssquery-ext.html) 17:12:55 INFO - 2015-12-03 17:12:55,107 DEBUG : BROWSER_OUTPUT: RSS: Main: 248369152 17:12:55 INFO - 2015-12-03 17:12:55,107 DEBUG : BROWSER_OUTPUT: 17:15:57 INFO - 2015-12-03 17:15:57,713 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58096/tests/dromaeo/cssquery-ext.html (next: http://localhost:58096/tests/dromaeo/cssquery-jquery.html) 17:15:58 INFO - 2015-12-03 17:15:58,299 DEBUG : BROWSER_OUTPUT: RSS: Main: 226656256 17:15:58 INFO - 2015-12-03 17:15:58,300 DEBUG : BROWSER_OUTPUT: 17:19:00 INFO - 2015-12-03 17:19:00,357 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58096/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58096/tests/dromaeo/cssquery-mootools.html) 17:19:00 INFO - 2015-12-03 17:19:00,923 DEBUG : BROWSER_OUTPUT: RSS: Main: 215478272 17:19:00 INFO - 2015-12-03 17:19:00,923 DEBUG : BROWSER_OUTPUT: 17:22:02 INFO - 2015-12-03 17:22:02,833 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58096/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58096/tests/dromaeo/cssquery-prototype.html) 17:22:03 INFO - 2015-12-03 17:22:03,419 DEBUG : BROWSER_OUTPUT: RSS: Main: 207265792 17:22:03 INFO - 2015-12-03 17:22:03,419 DEBUG : BROWSER_OUTPUT: 17:25:06 INFO - 2015-12-03 17:25:06,096 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58096/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58096/tests/dromaeo/cssquery-yui.html) 17:25:06 INFO - 2015-12-03 17:25:06,705 DEBUG : BROWSER_OUTPUT: RSS: Main: 208916480 17:25:06 INFO - 2015-12-03 17:25:06,705 DEBUG : BROWSER_OUTPUT: 17:28:09 INFO - 2015-12-03 17:28:09,430 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58096/tests/dromaeo/cssquery-yui.html (next: http://localhost:58096/tests/dromaeo/cssquery-dojo.html) 17:28:09 INFO - 2015-12-03 17:28:09,680 DEBUG : BROWSER_OUTPUT: RSS: Main: 256090112 17:28:09 INFO - 2015-12-03 17:28:09,681 DEBUG : BROWSER_OUTPUT: 17:28:09 INFO - 2015-12-03 17:28:09,681 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:28:09 INFO - 2015-12-03 17:28:09,681 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:28:09 INFO - 2015-12-03 17:28:09,681 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:28:09 INFO - 2015-12-03 17:28:09,681 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:28:09 INFO - 2015-12-03 17:28:09,682 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2600.271923861319;2709.972900270998;2711.9322016949586;2716.4838680650664;2726.8363898166103;4479.574440428162;4607.101615185032;4685.062987402516;4725.173094708425;4735.19501684714;4600.447946246455;4656.208444564424;4676.696014759038;4682.953170468303;4684.250519916814;4283.421738065368;4307.073979094502;4332.65338772899;4482.282834746441;4495.910081798362;4109.979450102745;4410.4266445362055;4414.918345005478;4464.6651501137385;4490.50604433512;4273.230818452677;4296.699231053827;4331.480222373335;4338.436003319548;4372.978135109304;4371.759553224571;4373.803178856959;4374.321980093091;4390.100029493978;4414.227510185737;4138.255114079495;4231.70378073535;4345.044090300129;4371.0820727646915;4407;4500.932486012713;4606;4690.577847993697;4745.857624271277;4756.07256584966;5063.0380227756605;5065.772040258161;5068.214426763858;5075.492450754895;5099.286099945974;4837.854864354075;5086.41506226785;5092.465291144414;5097.592192624581;5102.209157580581;4549.499555048975;4565.61192298655;4641.489436162019;4702.506236845151;4739.478657347689;5130.692158470503;5145.536901678867;5146.150885103991;5146.716930568855;5149.382074151126;4745.311929770233;4935.876603084952;4936.3829521309835;4936.407631084293;4982.725950072709;4944.48082951285;4955.380577427822;4982.128127577659;5053.5957123430035;5055.9241611375855;5008.348914641073;5011.373578302712;5023.120953833065;5065.341505604321;5068.265101560253;5028.673136246132;5034.496550344937;5037.370328708911;5037.823676171316;5074.086664400444;3975.960240397617;4121.773302468393;4123.690723195772;4135.710500265012;4272.423222864935;3663;3683.318586061587;3699.260147970363;3711.5175027246287;3714.3685573452576;4314;4314.525402205755;4315.546867578922;4353.10761293934;4353.303471444554;4780.235162374003;4892.143874821892;4896.020795840846;4931.975340123348;5019.573336266459;4313.61177494027;4324.437823082979;4334.219840428753;4374.759388233678;4376.978115109404;4461.486929003207;4516.322551617283;4550.590446859798;4555.06621142665;4591.081783643218;4559.840405585788;4695.741734204515;4700;4844.249141383091;4864.513548645178;4985.900281994413;5046.7224302662235;5068.189089745771;5070.290159377616;5117.462666420121;4756.833510827105;4797.232442809134;4797.712137271775;4799.712017278975;4844.878878028077;4750.5249475052215;4835.564799168092;4852.19938710123;4993;5043.67216130965;4966.478519755374;5019.874503137451;5039.647224694383;5044.47033061538;5084.51697088776;4883.487233840396;4893.412790465167;4899.583535399388;4901.338319326987;4940.333055037524;4696.131215724965;4835.032993401263;4842.249451335048;4878.365812444502;4887.242477416006;4724.976375118103;4773.403324584427;4779.498152693917;4780.282957556395;4834.057358814997;4954.380702412199;4964.776585053609;4971.627127965345;4972.204447288416;4986.1772807487805;4673.7429441381055;4790.688605240648;4795.712257264575;4838.443578988321;4891.315215869852 17:28:09 INFO - 2015-12-03 17:28:09,686 DEBUG : BROWSER_OUTPUT: |1;ext.html;558.1989844573038;566.798786430817;568.7525926222094;571.362930332679;571.8341680912536;28546.143615691537;29040.709592904066;29137.417251654955;37422;37797.244055118885;40703.59296407035;41164.58835411645;41169.38245926306;41195.17609647813;41461.792691036506;7740.342070923978;7895.171007044264;7906;7906.841863162734;7933.682652693914;7131.465140114512;7300.233475485077;10115.645952391667;10367.637132700356;10382.117520010808;10063.34588251765;10173.033561811653;10173.796524069514;10178.134858537032;10182.439965801877;7167.641617919136;7345.008423862817;10093.94953025234;10207.030332118436;10210.183185345191;7040.401565866908;7149.714011439536;10092.343997640204;10340.586376544928;10346;37633.62366376328;38163.23673526542;38179.23641527154;38186.80906595477;38212.808935955145;2726.4547090581764;2789.888404463819;2933.31067199208;2966;3506.6493350664987;28226;28382.716172838213;28469.57295640567;28812.423751524853;28932.855335723187;3375.8143302118374;3482.5298584690995;3497.667721566447;3559.626239244868;3576.5529308836394;216326;217155;218149.91276003304;218176;218505;47057.529424706;47866;53182.46817531853;53900.73049634727;54158.18762718562;57632;57687.42312576905;58362.708186458796;58482.122768158515;58540.414595854345;12263;12391.070669699808;12396.442160102817;12402.875971240172;12416.255024698547;9142.268618510503;9145.81708365829;9229.123233292827;9233;9236.815263694689;17498.82501174972;18153.364632237808;18182.36361727333;18232.908835456004;18337.358192463198;7030.437564994788;7162.104736907887;7215.422766178693;7345.118585769635;7375.44684148691;753.6344872736719;846.8814365988767;885.7032893980588;978.9706308810747;1007.044324906402;26339.209823705318;26374.691487554857;26403.735962640127;26501.204963851116;26642.20073397801;969.5879251318162;977.0669011094387;993.7068564773409;1052.957881684724;1059.6820953713855;13887;13909.095908765898;14027.85972140286;14426.711465770626;14651.560453186421;205577;208348;208992;209242;209517;42742.358864617054;42749.57250427518;42784.786076069424;42826.57173428288;43085;1181.4860535667012;1188.423614546944;1200.8351898658461;1218.3786269002871;1220.383706228349;25719.742802572484;26097;27059.458810824068;27406.314842129108;27471.31321716973;36233.81883090568;37065.62934370622;39095.80452097721;43275.567244327154;43626.56373436225;181792;182277;182637;183132;183268;24214.87892560526;26259.080932167282;26674.466510670067;26675.599866001638;26715.465690685687;28499.145025649264;38168.427473588476;38670.419943700304;38729;38763.41854872123;30861.8396712228;32709.888618307432;33511.66488335085;33594.49608255829;33679.66320336765;32569.208693521137;33067.17332066718;33478.83260583682;33831.3233735319;34367;30652;31215.531767023058;31216.843915780275;31242.21894452657;31462.370752584364;26975.865120674272;28055.29861753391;28883.711162888943;30186;30299.545506816976;23377.309759575648;23475.76524234736;23638.52722945566;23879.28362149069;23891.283261502183 17:28:09 INFO - 2015-12-03 17:28:09,686 DEBUG : BROWSER_OUTPUT: |2;jquery.html;324.4623934279108;328.4400097833194;331.68986997157657;332.3220629914974;332.7720511449656;12601.495940162382;12981.415836287366;14912.254387280633;15331;16509.091999940014;12313.138080334358;13709.177449353047;13922.51271205508;13954.720905581882;14242.430302787901;3891.824867880938;4367.3448982652535;5044.369453818273;5089.872753181182;5105.05556472052;5067.6452648314635;5100.770465329069;5111.7699703513435;5112.948870511303;5116.360454943132;4922.532359425849;5048.9495105048845;5075.3909530856345;5081.491850814926;5081.949180508184;4950.55445009949;4974.801007959713;4986.326845875797;4988.251762235657;4991.450940396553;4408.625266852321;4414.779261036935;4431.446069241345;4432.822687092513;4434.334849772527;11008.504617292241;11332.980031797095;11364;11386.202965792398;14362.210078445682;1879.6146789908037;1896.2225487550177;1898.221729091066;1899.9525011874675;1927.778305494872;9193.126652967958;11190.261228458323;12181.573644922473;12269.815952760715;12616.936915315364;1720.1657196259805;1736.2187015842921;1802.4953013156205;1814.1564172659776;1822.6719190545696;55704.593971692964;55748.44251557514;56377;56847.71576142093;56860;9398.154166124945;9429.48137852411;9523.761905952268;9535.856962145574;9539.189168920719;10468.63359782404;10757.085647719874;11683.707907302216;11941.104417168746;11944.104192185447;6365.713542890581;6557.180352455943;6669.533132680665;6675.23234828001;6765.458763298924;6102.298235702862;6141.6007959482495;6142.385761423822;6150.477209437158;6183.876322473615;3996.2207369562657;4024.4969378827645;4041.6362527372676;4154.296738337267;4180.937285940713;1648.5384092454133;1654.3630702179507;1663.4760050584027;1669.7912760904887;1679.5885008173075;350.67737681333233;350.8403676327265;371.485492592761;825.669732107162;857.0829212742306;9507.619695212252;10064.74838129038;10268.948655256676;10371.688849334532;10416.114630256361;382.6001828089653;384.05713972198186;388.1131614261399;390.52941205846884;411.00946718408494;4483.618892394118;5429.294191755125;5435.402105768362;5530.557555395559;5675;470039;474646;476845;477007;487463;51563.74218128961;68186.65906670435;70747.29252707407;72323.6383818088;73692;394.54233089615906;400.2395448647593;403.1956247286682;414.9896252593649;418.9560096189856;9299.256059515088;9566.186874115778;9605.759856003655;9621.27840411958;9625.32622716403;29086.7091329084;29953.550696740003;30427.695723042485;30438.39123217479;30927.381452371275;38904.416433754086;39860.80069599633;40627.59372406356;40762.59237407588;41449;8622.61198246068;8858;8899.955500222717;8904.154105359981;8925.73222803291;15646.608834779221;15674.216289185268;16026;16098.436554720529;16175.757363639319;12892.871071289166;13176.60470185896;13297.66755831112;13631.727365452834;13738.725225495235;12106.152569320064;12196.146269761031;13167.2757998311;13512.662183445493;13515.256660883746;12896.355182240663;12926.901213396966;13057.412416441093;13302.135361201492;13353.66615834573;8849.911500885166;8888.73333799987;8905.955470222867;8982.86525702102;8989.640414383352;9505.477198754135;9569.043095690375;10809.891901080888;13511.121777084458;13799.86200138026 17:28:09 INFO - 2015-12-03 17:28:09,690 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1189.381521608764;1678.320280286484;1683.772690686757;1704.1734758642056;1750.6936286149923;5788.47903688668;7029.437644988401;7215.747448839292;7241.674124664396;7258.818529536764;6818.897716534244;6954.96522517388;6965.059716938212;6972.4422046236305;6976.755813546527;2027.858049936505;2046.6725323948172;2066.1838573763353;2067.286786058815;2069.968950465744;2103.484646261668;2114.862533935297;2120.6500927347047;2151.3868547463976;2157.967630485544;2072.730545029144;2086.843486738493;2109.504266497372;2113.0280071167203;2113.2075471698113;2070.234013415031;2088.791120887899;2092.9162833486644;2093.665013597825;2094.3612198279593;2071.109422948132;2081.7814129516487;2127.808497235241;2132.5734853029303;2133.5839511295303;5820.679862607555;5945;7109.182444018952;7191.748288809867;7202.423806095552;4006.419069234945;4072.328065869128;4087.8773636790943;4113.115680128757;4130.277201489727;2726.236653736937;2764.060219525371;2811.1144989328295;2811.367442325481;2821;869.2263885142229;881.8589025755913;883.9625358799385;897.3135551303258;905.2350763604743;9622.711318660451;9687.41875487473;9688.176504997084;9690.75773105671;9705;3959.2675355059405;3967.3652215645357;4000.439938408625;4013.0368711509614;4046.716729828943;8355.373346999;8423.368247381472;8428.115047920002;8461.11158328379;8462.957685211535;4224.809883555247;4238.6397156242065;4253.298205796071;4256.638185754184;4263.275243208662;3832.329342365075;3832.7125465590193;3833.9041523961564;3834.4631751554803;3834.482344883405;3293.176705823544;3339.44899091652;3340.7661463697796;3363.058343663778;3366.074329559342;1036.1555332404216;1047.1518070363031;1049.8897615750236;1058.1587637827945;1058.3544038136731;897.708244820436;902.2240872849344;915.56053094515;915.9587818548048;938.3666025432806;6584.934150658528;6637.568558043712;6638.4689224861895;6641.468682505388;6643.601383916884;415.64670030474457;427.8545294599789;428.25911173669726;430.03671775223273;433.05593805503673;4712.976435117871;5027.773750181251;5057.0644430779685;5068.062408454448;5083.61872859537;7132.215456299803;8374.246317831303;8566.828663426697;8567.100454452317;8575.056743758181;8392.370572207108;8539.829203415897;8620.094890036582;8636.784080397914;8638.352123590756;6421.3578642136345;6461;6469.870602587922;6511.479081673455;6529.085927970088;6540.476761859135;6553.049807777941;6575.704093315717;6603.174603174603;6623.138991931018;7319.158296795937;7431.888521672287;7439.367653749492;7565.243475652391;7565.4325925556905;7506;7621.618919053914;7778.649960751893;7807.141214466517;7813.609319534115;6093.573449858467;6296.212973378328;6332.335104813928;6350.4919606432295;6396.200474940632;6853.143357080365;6884.51808373409;6899.827504312432;6909.723611055702;6968.825779355557;6430.035494675836;6513.381228783258;6530.8367290818105;6586.473082153512;6593.274739778524;6443.967780161257;6449.129367535323;6461.0954466373805;6468.062130990886;6509.218893732783;6502.154719886574;6524.249711283263;6544.051112588743;6544.6727663617585;6547.770828020996;5946.43508866657;6031.517478601613;6085.361037091042;6108.083787431743;6122.173506576555;6169.2288463942;6187.288461826947;6191.690415479298;6204.689765511616;6217.316095229431 17:28:09 INFO - 2015-12-03 17:28:09,691 DEBUG : BROWSER_OUTPUT: |4;prototype.html;283.62844673477747;287.04843443983196;289.67266988303214;291.4666160925507;294.3597675056754;5370.167624018279;5390.434004429537;5405.459454054592;5439.891202175959;5452.454754524546;5323.653962492435;5333.653312534682;5343.118385466393;5347.839564813062;5351.785928562863;4074.9388759168637;4125.154343359604;4128.710990230685;4130.401091841696;4140.4824396950235;3922.627350401707;4004.2191772604356;4008.1983603279314;4098.7540747555095;4108.650764685005;4048.0487085534874;4058.0463591056077;4060.37584966013;4068.105016896278;4074.327735923569;3850.1337199130253;3981.422693709396;4036.656884164835;4059.0664147246002;4063.553009168989;3397.69420752131;3482.5298584690995;3482.9477557836653;3488.1628409181612;3493.580770307554;5154.793808247666;5158.793648254065;5163.483651634844;5170.767315470775;5179.689218646893;4607.9308810367875;4618.5381461853885;4622.768861556909;4625.8149674013;4629.560191781776;5481.040817856899;5595.916061259084;5611.382747897728;5616.691081990489;5624.521915637176;3772.8113594320175;3781.6596506314563;3782.905427364338;3784.526934133233;3785.9053523661855;5930.169776231331;5934.525237980951;5942.64344139353;5945.464908158243;5948.553858460589;3837.4819399381286;3875.8255878485534;3883.0292426893275;3886.6696330811633;3888.4556162137324;3916.138449541096;3936.173403585279;3941.290567697842;3942.3100957332354;3942.9211415772097;4468.530804265505;4582.564656357641;4583.449986001635;4587.816487340469;4593.885152871138;5603.8879222416135;5626.409227031103;5639.689817060101;5648.096304591246;5658.547316214693;1381.171297221659;1401.2853444743255;1401.2923473645947;1401.4044031286867;1402.5021117503343;928.4522131942186;930.3534043839467;932.9860052099224;972.3533849989819;980.843065109579;4942.5057494251005;4945.431275403303;4950.529699678525;4960.082384758759;4967.254911763264;5897.675627840425;5902.321233058254;5903.734331955073;5904.439078287556;5909.054551271776;4945.9258111128365;4947.529984651453;4952.4304704959395;4953.752312384367;4962.057209130254;3053.2824786175674;3113.3150706844913;3149.1969547765175;3182.8567714452906;3192.1062102611304;5469.316335458067;5512.531434828004;5595.188697638901;5604.075327570987;5634;6078.209832721718;6080.513558915276;6115.296740874767;6119.724612392364;6120.204373431426;5522.91715624266;5549.944500555023;5570.470805273492;5580.665160090408;5598.804041858515;5806.274215723035;5919.230500034968;5945.881082378241;5949.434803693643;5951.16683664296;5803;5805.216295800182;5816.82549523515;5818.330891947311;5821.126830975219;5602.411746766531;5606.551475881838;5608.439156084359;5610.186522954067;5619.072852979376;3913.6086391360636;3995.1610161866333;4000.0599859032523;4013.69897257701;4015.257177422186;5920.319163296103;5921.851953701192;5934.258217722785;5936.257967754031;5936.643801371932;5657.15142728594;5703.515201207778;5708.4862362387585;5710.371859095413;5711.914321285101;5669.262995810518;5701.315842098975;5701.7149142541875;5703.8859222816145;5718.313802343745;5410.134378499579;5565.38780734127;5609.49514543693;5614.494695477427;5619.297587801525;5765.423457654201;5769.711514424346;5772;5773.566982476415;5775.220345253337;5624.859378515406;5630.971845140748;5632.85917852057;5636.126400407943;5639.689817059937 17:28:09 INFO - 2015-12-03 17:28:09,692 DEBUG : BROWSER_OUTPUT: |5;yui.html;689.4484412470023;690.6443181761393;697.8953157026447;731.4623751542618;778.4939789137061;12177.33024683643;12338;12488.12583119182;12521;14422.639434014154;12978.74042519149;13083.345832708374;13086.672833179175;13100.672483187926;13117.081804273705;631.8167731357901;639.8816218999476;640.0942666127447;801.8717005279171;816.967321307147;791.133708589094;793.0721056364039;807.2855522862251;807.8303556253164;808.1958451340925;837.4305472278847;847.7075408983891;848.0163010907348;848.7835601921502;848.8981322241309;655.655780715126;662.1557514169449;819.3199644295221;838.4508147163588;839.47532792005;621.0963048764038;621.7388696747377;622.2999125983268;622.3838399983983;622.5019984012772;10499.580016799318;10593.364398136137;10683.14534837211;10691.625793097204;10712.946435267851;10706.785864282749;11232.438378081146;11254.15593830466;11337.489812958354;11486.368249746261;9173.266138708954;9393.953030234874;9398.34211605188;9674.837567918232;9712.125908668184;3136.466800643896;3210.4381733196597;3217.3082787200865;3242.157039169809;3271.263965607719;40398.79800600978;40879.591204087876;40895.38656920119;41242.587574124176;41451.1709765806;9121.726348209564;9513.476758778334;9686.660966866126;9761.316707830525;9785.902140978642;16276.348946042026;16493.092879891483;16609.501714948572;16616.750748738777;16681;6232.563720539519;6265.8746825063245;6313.05304204373;6321.146645202931;6398.936010639927;3517.243792584555;3553.3071051145293;3584.2652256287397;3601.8019008954757;3629.0927268182954;2730.9349353752054;2761.5719563467696;2766.6265054217824;2772.196063141707;2775.153578158681;489.52271535253556;490.6884128578307;494.695762106302;501.98494045178705;502.1664037697405;489.51782494243145;535.1483865824291;553.9336776704827;556.4991507643153;597.7369957218809;7362.335267126905;7455.569573726269;7592.696292148363;7599.848003040019;7626.428017898569;461.335676625658;467.6959976015617;513.2557791202771;531.861715953847;550.0978395431496;3403.1662242750685;3406.3698215829654;3444.844981975817;3511.034465521951;3578.8568457261417;47457.28814067792;48048.27927581089;48207.75896120497;48209.5179048212;48694.75652621714;44768.55231447709;45056.3241551377;46683.29975050377;47166;47517.52482475131;42014.78992605017;42060.15879682389;42505.36241956373;42669;42721.78639106784;7271.381932535794;7410.333070023508;7458.589777562286;7849.215078492333;7908.881366779618;31561.210969725023;32246.19384515406;33197;33418.83290583531;33524.83237583796;40108.1978360437;43018.13963720771;43525.56474435215;43723.34414983841;44134.33798493089;10686.358818470917;10697.946510267398;10763.408012559385;10931.672049838518;11212.66362009141;10106.44380254444;10328.431936243578;10402.843957340494;11561.19071665009;11922.986546143675;10336.741581460523;10754.032137107697;11114.05530529914;11126.165537584875;11164.832527511931;10439.425831579336;10479.842802357818;10795.19036072282;10871.29336593119;10925.890741092488;10388.42863642507;10399.168066554808;10405.970835686969;10642.255042146975;10664.360138391721;8470.49177049379;8494.490330580185;8620.698275560577;9101.499417532099;9164.495952722398;8910.777230569029;8955.507447090473;9098.619939528762;9121.498317592595;9377.953110234404 17:28:09 INFO - 2015-12-03 17:28:09,692 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:28:09 INFO - 2015-12-03 17:28:09,692 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:28:09 INFO - 2015-12-03 17:28:09,692 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,927 17:28:09 INFO - 2015-12-03 17:28:09,693 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:28:09 INFO - 2015-12-03 17:28:09,693 DEBUG : BROWSER_OUTPUT: __startTimestamp1449192489679__endTimestamp 17:28:09 INFO - 2015-12-03 17:28:09,693 DEBUG : BROWSER_OUTPUT: 17:28:09 INFO - 2015-12-03 17:28:09,693 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:28:09 INFO - 2015-12-03 17:28:09,693 DEBUG : BROWSER_OUTPUT: Number of tests: 6 17:28:09 INFO - 2015-12-03 17:28:09,693 DEBUG : BROWSER_OUTPUT: 17:28:09 INFO - 2015-12-03 17:28:09,693 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4637.45 Median:4756.07 stddev:480.83 (10.1%) stddev-sans-first:454.97 17:28:09 INFO - 2015-12-03 17:28:09,694 DEBUG : BROWSER_OUTPUT: Values: 2600.3 2710.0 2711.9 2716.5 2726.8 4479.6 4607.1 4685.1 4725.2 4735.2 4600.4 4656.2 4676.7 4683.0 4684.3 4283.4 4307.1 4332.7 4482.3 4495.9 4110.0 4410.4 4414.9 4464.7 4490.5 4273.2 4296.7 4331.5 4338.4 4373.0 4371.8 4373.8 4374.3 4390.1 4414.2 4138.3 4231.7 4345.0 4371.1 4407.0 4500.9 4606.0 4690.6 4745.9 4756.1 5063.0 5065.8 5068.2 5075.5 5099.3 4837.9 5086.4 5092.5 5097.6 5102.2 4549.5 4565.6 4641.5 4702.5 4739.5 5130.7 5145.5 5146.2 5146.7 5149.4 4745.3 4935.9 4936.4 4936.4 4982.7 4944.5 4955.4 4982.1 5053.6 5055.9 5008.3 5011.4 5023.1 5065.3 5068.3 5028.7 5034.5 5037.4 5037.8 5074.1 3976.0 4121.8 4123.7 4135.7 4272.4 3663.0 3683.3 3699.3 3711.5 3714.4 4314.0 4314.5 4315.5 4353.1 4353.3 4780.2 4892.1 4896.0 4932.0 5019.6 4313.6 4324.4 4334.2 4374.8 4377.0 4461.5 4516.3 4550.6 4555.1 4591.1 4559.8 4695.7 4700.0 4844.2 4864.5 4985.9 5046.7 5068.2 5070.3 5117.5 4756.8 4797.2 4797.7 4799.7 4844.9 4750.5 4835.6 4852.2 4993.0 5043.7 4966.5 5019.9 5039.6 5044.5 5084.5 4883.5 4893.4 4899.6 4901.3 4940.3 4696.1 4835.0 4842.2 4878.4 4887.2 4725.0 4773.4 4779.5 4780.3 4834.1 4954.4 4964.8 4971.6 4972.2 4986.2 4673.7 4790.7 4795.7 4838.4 4891.3 17:28:09 INFO - 2015-12-03 17:28:09,694 DEBUG : BROWSER_OUTPUT: 17:28:09 INFO - 2015-12-03 17:28:09,694 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:36751.75 Median:30756.92 stddev:52656.10 (171.2%) stddev-sans-first:52733.68 17:28:09 INFO - 2015-12-03 17:28:09,694 DEBUG : BROWSER_OUTPUT: Values: 558.2 566.8 568.8 571.4 571.8 28546.1 29040.7 29137.4 37422.0 37797.2 40703.6 41164.6 41169.4 41195.2 41461.8 7740.3 7895.2 7906.0 7906.8 7933.7 7131.5 7300.2 10115.6 10367.6 10382.1 10063.3 10173.0 10173.8 10178.1 10182.4 7167.6 7345.0 10093.9 10207.0 10210.2 7040.4 7149.7 10092.3 10340.6 10346.0 37633.6 38163.2 38179.2 38186.8 38212.8 2726.5 2789.9 2933.3 2966.0 3506.6 28226.0 28382.7 28469.6 28812.4 28932.9 3375.8 3482.5 3497.7 3559.6 3576.6 216326.0 217155.0 218149.9 218176.0 218505.0 47057.5 47866.0 53182.5 53900.7 54158.2 57632.0 57687.4 58362.7 58482.1 58540.4 12263.0 12391.1 12396.4 12402.9 12416.3 9142.3 9145.8 9229.1 9233.0 9236.8 17498.8 18153.4 18182.4 18232.9 18337.4 7030.4 7162.1 7215.4 7345.1 7375.4 753.6 846.9 885.7 979.0 1007.0 26339.2 26374.7 26403.7 26501.2 26642.2 969.6 977.1 993.7 1053.0 1059.7 13887.0 13909.1 14027.9 14426.7 14651.6 205577.0 208348.0 208992.0 209242.0 209517.0 42742.4 42749.6 42784.8 42826.6 43085.0 1181.5 1188.4 1200.8 1218.4 1220.4 25719.7 26097.0 27059.5 27406.3 27471.3 36233.8 37065.6 39095.8 43275.6 43626.6 181792.0 182277.0 182637.0 183132.0 183268.0 24214.9 26259.1 26674.5 26675.6 26715.5 28499.1 38168.4 38670.4 38729.0 38763.4 30861.8 32709.9 33511.7 33594.5 33679.7 32569.2 33067.2 33478.8 33831.3 34367.0 30652.0 31215.5 31216.8 31242.2 31462.4 26975.9 28055.3 28883.7 30186.0 30299.5 23377.3 23475.8 23638.5 23879.3 23891.3 17:28:09 INFO - 2015-12-03 17:28:09,694 DEBUG : BROWSER_OUTPUT: 17:28:09 INFO - 2015-12-03 17:28:09,695 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25032.77 Median:2222.42 stddev:78016.80 (3510.4%) stddev-sans-first:78213.59 17:28:09 INFO - 2015-12-03 17:28:09,695 DEBUG : BROWSER_OUTPUT: Values: 324.5 328.4 331.7 332.3 332.8 12601.5 12981.4 14912.3 15331.0 16509.1 12313.1 13709.2 13922.5 13954.7 14242.4 3891.8 4367.3 5044.4 5089.9 5105.1 5067.6 5100.8 5111.8 5112.9 5116.4 4922.5 5048.9 5075.4 5081.5 5081.9 4950.6 4974.8 4986.3 4988.3 4991.5 4408.6 4414.8 4431.4 4432.8 4434.3 11008.5 11333.0 11364.0 11386.2 14362.2 1879.6 1896.2 1898.2 1900.0 1927.8 9193.1 11190.3 12181.6 12269.8 12616.9 1720.2 1736.2 1802.5 1814.2 1822.7 55704.6 55748.4 56377.0 56847.7 56860.0 9398.2 9429.5 9523.8 9535.9 9539.2 10468.6 10757.1 11683.7 11941.1 11944.1 6365.7 6557.2 6669.5 6675.2 6765.5 6102.3 6141.6 6142.4 6150.5 6183.9 3996.2 4024.5 4041.6 4154.3 4180.9 1648.5 1654.4 1663.5 1669.8 1679.6 350.7 350.8 371.5 825.7 857.1 9507.6 10064.7 10268.9 10371.7 10416.1 382.6 384.1 388.1 390.5 411.0 4483.6 5429.3 5435.4 5530.6 5675.0 470039.0 474646.0 476845.0 477007.0 487463.0 51563.7 68186.7 70747.3 72323.6 73692.0 394.5 400.2 403.2 415.0 419.0 9299.3 9566.2 9605.8 9621.3 9625.3 29086.7 29953.6 30427.7 30438.4 30927.4 38904.4 39860.8 40627.6 40762.6 41449.0 8622.6 8858.0 8900.0 8904.2 8925.7 15646.6 15674.2 16026.0 16098.4 16175.8 12892.9 13176.6 13297.7 13631.7 13738.7 12106.2 12196.1 13167.3 13512.7 13515.3 12896.4 12926.9 13057.4 13302.1 13353.7 8849.9 8888.7 8906.0 8982.9 8989.6 9505.5 9569.0 10809.9 13511.1 13799.9 17:28:09 INFO - 2015-12-03 17:28:09,695 DEBUG : BROWSER_OUTPUT: 17:28:09 INFO - 2015-12-03 17:28:09,695 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4941.29 Median:6341.41 stddev:2582.16 (40.7%) stddev-sans-first:2574.00 17:28:09 INFO - 2015-12-03 17:28:09,696 DEBUG : BROWSER_OUTPUT: Values: 1189.4 1678.3 1683.8 1704.2 1750.7 5788.5 7029.4 7215.7 7241.7 7258.8 6818.9 6955.0 6965.1 6972.4 6976.8 2027.9 2046.7 2066.2 2067.3 2070.0 2103.5 2114.9 2120.7 2151.4 2158.0 2072.7 2086.8 2109.5 2113.0 2113.2 2070.2 2088.8 2092.9 2093.7 2094.4 2071.1 2081.8 2127.8 2132.6 2133.6 5820.7 5945.0 7109.2 7191.7 7202.4 4006.4 4072.3 4087.9 4113.1 4130.3 2726.2 2764.1 2811.1 2811.4 2821.0 869.2 881.9 884.0 897.3 905.2 9622.7 9687.4 9688.2 9690.8 9705.0 3959.3 3967.4 4000.4 4013.0 4046.7 8355.4 8423.4 8428.1 8461.1 8463.0 4224.8 4238.6 4253.3 4256.6 4263.3 3832.3 3832.7 3833.9 3834.5 3834.5 3293.2 3339.4 3340.8 3363.1 3366.1 1036.2 1047.2 1049.9 1058.2 1058.4 897.7 902.2 915.6 916.0 938.4 6584.9 6637.6 6638.5 6641.5 6643.6 415.6 427.9 428.3 430.0 433.1 4713.0 5027.8 5057.1 5068.1 5083.6 7132.2 8374.2 8566.8 8567.1 8575.1 8392.4 8539.8 8620.1 8636.8 8638.4 6421.4 6461.0 6469.9 6511.5 6529.1 6540.5 6553.0 6575.7 6603.2 6623.1 7319.2 7431.9 7439.4 7565.2 7565.4 7506.0 7621.6 7778.6 7807.1 7813.6 6093.6 6296.2 6332.3 6350.5 6396.2 6853.1 6884.5 6899.8 6909.7 6968.8 6430.0 6513.4 6530.8 6586.5 6593.3 6444.0 6449.1 6461.1 6468.1 6509.2 6502.2 6524.2 6544.1 6544.7 6547.8 5946.4 6031.5 6085.4 6108.1 6122.2 6169.2 6187.3 6191.7 6204.7 6217.3 17:28:09 INFO - 2015-12-03 17:28:09,696 DEBUG : BROWSER_OUTPUT: 17:28:09 INFO - 2015-12-03 17:28:09,696 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4665.67 Median:5380.30 stddev:1417.08 (26.3%) stddev-sans-first:1382.36 17:28:09 INFO - 2015-12-03 17:28:09,696 DEBUG : BROWSER_OUTPUT: Values: 283.6 287.0 289.7 291.5 294.4 5370.2 5390.4 5405.5 5439.9 5452.5 5323.7 5333.7 5343.1 5347.8 5351.8 4074.9 4125.2 4128.7 4130.4 4140.5 3922.6 4004.2 4008.2 4098.8 4108.7 4048.0 4058.0 4060.4 4068.1 4074.3 3850.1 3981.4 4036.7 4059.1 4063.6 3397.7 3482.5 3482.9 3488.2 3493.6 5154.8 5158.8 5163.5 5170.8 5179.7 4607.9 4618.5 4622.8 4625.8 4629.6 5481.0 5595.9 5611.4 5616.7 5624.5 3772.8 3781.7 3782.9 3784.5 3785.9 5930.2 5934.5 5942.6 5945.5 5948.6 3837.5 3875.8 3883.0 3886.7 3888.5 3916.1 3936.2 3941.3 3942.3 3942.9 4468.5 4582.6 4583.4 4587.8 4593.9 5603.9 5626.4 5639.7 5648.1 5658.5 1381.2 1401.3 1401.3 1401.4 1402.5 928.5 930.4 933.0 972.4 980.8 4942.5 4945.4 4950.5 4960.1 4967.3 5897.7 5902.3 5903.7 5904.4 5909.1 4945.9 4947.5 4952.4 4953.8 4962.1 3053.3 3113.3 3149.2 3182.9 3192.1 5469.3 5512.5 5595.2 5604.1 5634.0 6078.2 6080.5 6115.3 6119.7 6120.2 5522.9 5549.9 5570.5 5580.7 5598.8 5806.3 5919.2 5945.9 5949.4 5951.2 5803.0 5805.2 5816.8 5818.3 5821.1 5602.4 5606.6 5608.4 5610.2 5619.1 3913.6 3995.2 4000.1 4013.7 4015.3 5920.3 5921.9 5934.3 5936.3 5936.6 5657.2 5703.5 5708.5 5710.4 5711.9 5669.3 5701.3 5701.7 5703.9 5718.3 5410.1 5565.4 5609.5 5614.5 5619.3 5765.4 5769.7 5772.0 5773.6 5775.2 5624.9 5631.0 5632.9 5636.1 5639.7 17:28:09 INFO - 2015-12-03 17:28:09,696 DEBUG : BROWSER_OUTPUT: 17:28:09 INFO - 2015-12-03 17:28:09,696 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12467.51 Median:44912.44 stddev:14205.05 (31.6%) stddev-sans-first:14217.36 17:28:09 INFO - 2015-12-03 17:28:09,696 DEBUG : BROWSER_OUTPUT: Values: 689.4 690.6 697.9 731.5 778.5 12177.3 12338.0 12488.1 12521.0 14422.6 12978.7 13083.3 13086.7 13100.7 13117.1 631.8 639.9 640.1 801.9 817.0 791.1 793.1 807.3 807.8 808.2 837.4 847.7 848.0 848.8 848.9 655.7 662.2 819.3 838.5 839.5 621.1 621.7 622.3 622.4 622.5 10499.6 10593.4 10683.1 10691.6 10712.9 10706.8 11232.4 11254.2 11337.5 11486.4 9173.3 9394.0 9398.3 9674.8 9712.1 3136.5 3210.4 3217.3 3242.2 3271.3 40398.8 40879.6 40895.4 41242.6 41451.2 9121.7 9513.5 9686.7 9761.3 9785.9 16276.3 16493.1 16609.5 16616.8 16681.0 6232.6 6265.9 6313.1 6321.1 6398.9 3517.2 3553.3 3584.3 3601.8 3629.1 2730.9 2761.6 2766.6 2772.2 2775.2 489.5 490.7 494.7 502.0 502.2 489.5 535.1 553.9 556.5 597.7 7362.3 7455.6 7592.7 7599.8 7626.4 461.3 467.7 513.3 531.9 550.1 3403.2 3406.4 3444.8 3511.0 3578.9 47457.3 48048.3 48207.8 48209.5 48694.8 44768.6 45056.3 46683.3 47166.0 47517.5 42014.8 42060.2 42505.4 42669.0 42721.8 7271.4 7410.3 7458.6 7849.2 7908.9 31561.2 32246.2 33197.0 33418.8 33524.8 40108.2 43018.1 43525.6 43723.3 44134.3 10686.4 10697.9 10763.4 10931.7 11212.7 10106.4 10328.4 10402.8 11561.2 11923.0 10336.7 10754.0 11114.1 11126.2 11164.8 10439.4 10479.8 10795.2 10871.3 10925.9 10388.4 10399.2 10406.0 10642.3 10664.4 8470.5 8494.5 8620.7 9101.5 9164.5 8910.8 8955.5 9098.6 9121.5 9378.0 17:28:09 INFO - 2015-12-03 17:28:09,696 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:28:09 INFO - 2015-12-03 17:28:09,696 DEBUG : BROWSER_OUTPUT: 17:28:10 INFO - 2015-12-03 17:28:10,460 INFO : Browser exited with error code: 0 17:28:10 INFO - 2015-12-03 17:28:10,479 INFO : Completed test dromaeo_css (00:18:37) 17:28:10 INFO - 2015-12-03 17:28:10,479 INFO : Starting test kraken 17:28:10 INFO - 2015-12-03 17:28:10,479 DEBUG : operating with platform_type : linux_ 17:28:10 INFO - 2015-12-03 17:28:10,479 INFO : Initialising browser for kraken test... 17:28:10 INFO - 2015-12-03 17:28:10,485 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQaZt60/profile http://localhost:58096/getInfo.html 17:28:15 INFO - 2015-12-03 17:28:15,332 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:28:15 INFO - 2015-12-03 17:28:15,332 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:28:15 INFO - 2015-12-03 17:28:15,332 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:28:15 INFO - 2015-12-03 17:28:15,332 DEBUG : BROWSER_OUTPUT: __metrics 17:28:15 INFO - 2015-12-03 17:28:15,433 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] 17:28:15 INFO - 2015-12-03 17:28:15,433 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] 17:28:15 ERROR - 2015-12-03 17:28:15,509 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 17:28:16 INFO - 2015-12-03 17:28:16,406 INFO : Browser initialized. 17:28:16 INFO - 2015-12-03 17:28:16,406 INFO : Running cycle 1/1 for kraken test... 17:28:16 INFO - 2015-12-03 17:28:16,407 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQaZt60/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:28:28 INFO - 2015-12-03 17:28:28,391 DEBUG : BROWSER_OUTPUT: RSS: Main: 143364096 17:28:28 INFO - 2015-12-03 17:28:28,391 DEBUG : BROWSER_OUTPUT: 17:28:31 INFO - 2015-12-03 17:28:31,015 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58096/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58096/tests/kraken/driver.html?testName=audio-beat-detection) 17:28:31 INFO - 2015-12-03 17:28:31,608 DEBUG : BROWSER_OUTPUT: RSS: Main: 183525376 17:28:31 INFO - 2015-12-03 17:28:31,608 DEBUG : BROWSER_OUTPUT: 17:28:34 INFO - 2015-12-03 17:28:34,358 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58096/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58096/tests/kraken/driver.html?testName=audio-dft) 17:28:34 INFO - 2015-12-03 17:28:34,940 DEBUG : BROWSER_OUTPUT: RSS: Main: 171372544 17:28:34 INFO - 2015-12-03 17:28:34,941 DEBUG : BROWSER_OUTPUT: 17:28:37 INFO - 2015-12-03 17:28:37,980 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58096/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58096/tests/kraken/driver.html?testName=audio-fft) 17:28:38 INFO - 2015-12-03 17:28:38,547 DEBUG : BROWSER_OUTPUT: RSS: Main: 154017792 17:28:38 INFO - 2015-12-03 17:28:38,547 DEBUG : BROWSER_OUTPUT: 17:28:40 INFO - 2015-12-03 17:28:40,579 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58096/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58096/tests/kraken/driver.html?testName=audio-oscillator) 17:28:41 INFO - 2015-12-03 17:28:41,148 DEBUG : BROWSER_OUTPUT: RSS: Main: 156545024 17:28:41 INFO - 2015-12-03 17:28:41,149 DEBUG : BROWSER_OUTPUT: 17:28:43 INFO - 2015-12-03 17:28:43,402 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58096/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58096/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:28:43 INFO - 2015-12-03 17:28:43,984 DEBUG : BROWSER_OUTPUT: RSS: Main: 158138368 17:28:43 INFO - 2015-12-03 17:28:43,984 DEBUG : BROWSER_OUTPUT: 17:28:47 INFO - 2015-12-03 17:28:47,023 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58096/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58096/tests/kraken/driver.html?testName=imaging-darkroom) 17:28:47 INFO - 2015-12-03 17:28:47,592 DEBUG : BROWSER_OUTPUT: RSS: Main: 157077504 17:28:47 INFO - 2015-12-03 17:28:47,593 DEBUG : BROWSER_OUTPUT: 17:28:51 INFO - 2015-12-03 17:28:51,013 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58096/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58096/tests/kraken/driver.html?testName=imaging-desaturate) 17:28:51 INFO - 2015-12-03 17:28:51,595 DEBUG : BROWSER_OUTPUT: RSS: Main: 157581312 17:28:51 INFO - 2015-12-03 17:28:51,595 DEBUG : BROWSER_OUTPUT: 17:28:54 INFO - 2015-12-03 17:28:54,453 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58096/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58096/tests/kraken/driver.html?testName=json-parse-financial) 17:28:55 INFO - 2015-12-03 17:28:55,026 DEBUG : BROWSER_OUTPUT: RSS: Main: 158994432 17:28:55 INFO - 2015-12-03 17:28:55,026 DEBUG : BROWSER_OUTPUT: 17:28:56 INFO - 2015-12-03 17:28:56,783 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58096/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58096/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:28:57 INFO - 2015-12-03 17:28:57,364 DEBUG : BROWSER_OUTPUT: RSS: Main: 168955904 17:28:57 INFO - 2015-12-03 17:28:57,365 DEBUG : BROWSER_OUTPUT: 17:28:59 INFO - 2015-12-03 17:28:59,263 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58096/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58096/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:28:59 INFO - 2015-12-03 17:28:59,870 DEBUG : BROWSER_OUTPUT: RSS: Main: 169177088 17:28:59 INFO - 2015-12-03 17:28:59,870 DEBUG : BROWSER_OUTPUT: 17:29:02 INFO - 2015-12-03 17:29:02,034 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58096/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58096/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:29:02 INFO - 2015-12-03 17:29:02,615 DEBUG : BROWSER_OUTPUT: RSS: Main: 181088256 17:29:02 INFO - 2015-12-03 17:29:02,615 DEBUG : BROWSER_OUTPUT: 17:29:05 INFO - 2015-12-03 17:29:05,130 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58096/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58096/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:29:05 INFO - 2015-12-03 17:29:05,716 DEBUG : BROWSER_OUTPUT: RSS: Main: 187215872 17:29:05 INFO - 2015-12-03 17:29:05,716 DEBUG : BROWSER_OUTPUT: 17:29:08 INFO - 2015-12-03 17:29:08,280 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58096/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58096/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:29:08 INFO - 2015-12-03 17:29:08,861 DEBUG : BROWSER_OUTPUT: RSS: Main: 185827328 17:29:08 INFO - 2015-12-03 17:29:08,862 DEBUG : BROWSER_OUTPUT: 17:29:10 INFO - 2015-12-03 17:29:10,631 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58096/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58096/tests/kraken/driver.html?testName=ai-astar) 17:29:10 INFO - 2015-12-03 17:29:10,881 DEBUG : BROWSER_OUTPUT: RSS: Main: 243326976 17:29:10 INFO - 2015-12-03 17:29:10,882 DEBUG : BROWSER_OUTPUT: 17:29:10 INFO - 2015-12-03 17:29:10,882 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:29:10 INFO - 2015-12-03 17:29:10,882 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:29:10 INFO - 2015-12-03 17:29:10,882 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:29:10 INFO - 2015-12-03 17:29:10,882 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:29:10 INFO - 2015-12-03 17:29:10,882 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;114;105;112;111;110;100;112;111;105 17:29:10 INFO - 2015-12-03 17:29:10,882 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;159;129;157;178;131;147;164;136;166;132 17:29:10 INFO - 2015-12-03 17:29:10,882 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;160;161;163;161;160;161;161;162;162 17:29:10 INFO - 2015-12-03 17:29:10,883 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;86;93;72;72;72;102;89;72 17:29:10 INFO - 2015-12-03 17:29:10,883 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;94;131;95;95;95;138;94;95;130 17:29:10 INFO - 2015-12-03 17:29:10,883 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;108;110;110;109;109;109;109 17:29:10 INFO - 2015-12-03 17:29:10,883 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;147;146;146;146;147;147;146;148 17:29:10 INFO - 2015-12-03 17:29:10,883 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 17:29:10 INFO - 2015-12-03 17:29:10,883 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;73;71;70;70;71;72;79;69;71 17:29:10 INFO - 2015-12-03 17:29:10,883 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;67;67;68;68;68;68;70;68 17:29:10 INFO - 2015-12-03 17:29:10,884 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;85;85;93;86;84;85;84;85;86 17:29:10 INFO - 2015-12-03 17:29:10,884 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;124;121;119;118;119;123;127;127;128;128 17:29:10 INFO - 2015-12-03 17:29:10,884 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;154;135;136;149;153;143;137;146;136;135 17:29:10 INFO - 2015-12-03 17:29:10,884 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;68;70;70;70;68;70;73;69;67 17:29:10 INFO - 2015-12-03 17:29:10,884 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:29:10 INFO - 2015-12-03 17:29:10,884 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:29:10 INFO - 2015-12-03 17:29:10,884 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1023 17:29:10 INFO - 2015-12-03 17:29:10,885 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:29:10 INFO - 2015-12-03 17:29:10,885 DEBUG : BROWSER_OUTPUT: __startTimestamp1449192550880__endTimestamp 17:29:10 INFO - 2015-12-03 17:29:10,885 DEBUG : BROWSER_OUTPUT: 17:29:10 INFO - 2015-12-03 17:29:10,892 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:29:10 INFO - 2015-12-03 17:29:10,892 DEBUG : BROWSER_OUTPUT: Number of tests: 14 17:29:10 INFO - 2015-12-03 17:29:10,892 DEBUG : BROWSER_OUTPUT: 17:29:10 INFO - 2015-12-03 17:29:10,892 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.10 Median:111.00 stddev:4.33 (3.9%) stddev-sans-first:4.54 17:29:10 INFO - 2015-12-03 17:29:10,893 DEBUG : BROWSER_OUTPUT: Values: 111.0 114.0 105.0 112.0 111.0 110.0 100.0 112.0 111.0 105.0 17:29:10 INFO - 2015-12-03 17:29:10,893 DEBUG : BROWSER_OUTPUT: 17:29:10 INFO - 2015-12-03 17:29:10,893 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.90 Median:158.00 stddev:17.31 (11.0%) stddev-sans-first:18.04 17:29:10 INFO - 2015-12-03 17:29:10,893 DEBUG : BROWSER_OUTPUT: Values: 159.0 129.0 157.0 178.0 131.0 147.0 164.0 136.0 166.0 132.0 17:29:10 INFO - 2015-12-03 17:29:10,893 DEBUG : BROWSER_OUTPUT: 17:29:10 INFO - 2015-12-03 17:29:10,893 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.95 (0.6%) stddev-sans-first:0.97 17:29:10 INFO - 2015-12-03 17:29:10,893 DEBUG : BROWSER_OUTPUT: Values: 162.0 160.0 161.0 163.0 161.0 160.0 161.0 161.0 162.0 162.0 17:29:10 INFO - 2015-12-03 17:29:10,893 DEBUG : BROWSER_OUTPUT: 17:29:10 INFO - 2015-12-03 17:29:10,893 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.40 Median:73.00 stddev:11.17 (15.3%) stddev-sans-first:11.52 17:29:10 INFO - 2015-12-03 17:29:10,893 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 86.0 93.0 72.0 72.0 72.0 102.0 89.0 72.0 17:29:10 INFO - 2015-12-03 17:29:10,893 DEBUG : BROWSER_OUTPUT: 17:29:10 INFO - 2015-12-03 17:29:10,893 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.20 Median:95.00 stddev:18.61 (19.6%) stddev-sans-first:19.29 17:29:10 INFO - 2015-12-03 17:29:10,893 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 131.0 95.0 95.0 95.0 138.0 94.0 95.0 130.0 17:29:10 INFO - 2015-12-03 17:29:10,893 DEBUG : BROWSER_OUTPUT: 17:29:10 INFO - 2015-12-03 17:29:10,893 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.50 stddev:0.67 (0.6%) stddev-sans-first:0.67 17:29:10 INFO - 2015-12-03 17:29:10,894 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 108.0 110.0 110.0 109.0 109.0 109.0 109.0 17:29:10 INFO - 2015-12-03 17:29:10,894 DEBUG : BROWSER_OUTPUT: 17:29:10 INFO - 2015-12-03 17:29:10,894 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 17:29:10 INFO - 2015-12-03 17:29:10,894 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 147.0 146.0 146.0 146.0 147.0 147.0 146.0 148.0 17:29:10 INFO - 2015-12-03 17:29:10,894 DEBUG : BROWSER_OUTPUT: 17:29:10 INFO - 2015-12-03 17:29:10,894 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 17:29:10 INFO - 2015-12-03 17:29:10,894 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 17:29:10 INFO - 2015-12-03 17:29:10,894 DEBUG : BROWSER_OUTPUT: 17:29:10 INFO - 2015-12-03 17:29:10,894 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.90 Median:71.50 stddev:2.81 (3.9%) stddev-sans-first:2.95 17:29:10 INFO - 2015-12-03 17:29:10,894 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 71.0 70.0 70.0 71.0 72.0 79.0 69.0 71.0 17:29:10 INFO - 2015-12-03 17:29:10,894 DEBUG : BROWSER_OUTPUT: 17:29:10 INFO - 2015-12-03 17:29:10,894 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 17:29:10 INFO - 2015-12-03 17:29:10,894 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 67.0 67.0 68.0 68.0 68.0 68.0 70.0 68.0 17:29:10 INFO - 2015-12-03 17:29:10,894 DEBUG : BROWSER_OUTPUT: 17:29:10 INFO - 2015-12-03 17:29:10,894 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:85.00 stddev:2.67 (3.1%) stddev-sans-first:2.76 17:29:10 INFO - 2015-12-03 17:29:10,894 DEBUG : BROWSER_OUTPUT: Values: 84.0 85.0 85.0 93.0 86.0 84.0 85.0 84.0 85.0 86.0 17:29:10 INFO - 2015-12-03 17:29:10,895 DEBUG : BROWSER_OUTPUT: 17:29:10 INFO - 2015-12-03 17:29:10,895 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.40 Median:125.50 stddev:3.98 (3.2%) stddev-sans-first:4.21 17:29:10 INFO - 2015-12-03 17:29:10,895 DEBUG : BROWSER_OUTPUT: Values: 124.0 121.0 119.0 118.0 119.0 123.0 127.0 127.0 128.0 128.0 17:29:10 INFO - 2015-12-03 17:29:10,895 DEBUG : BROWSER_OUTPUT: 17:29:10 INFO - 2015-12-03 17:29:10,895 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.40 Median:144.50 stddev:7.63 (5.3%) stddev-sans-first:6.85 17:29:10 INFO - 2015-12-03 17:29:10,895 DEBUG : BROWSER_OUTPUT: Values: 154.0 135.0 136.0 149.0 153.0 143.0 137.0 146.0 136.0 135.0 17:29:10 INFO - 2015-12-03 17:29:10,895 DEBUG : BROWSER_OUTPUT: 17:29:10 INFO - 2015-12-03 17:29:10,895 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:70.00 stddev:1.71 (2.4%) stddev-sans-first:1.74 17:29:10 INFO - 2015-12-03 17:29:10,895 DEBUG : BROWSER_OUTPUT: Values: 71.0 68.0 70.0 70.0 70.0 68.0 70.0 73.0 69.0 67.0 17:29:10 INFO - 2015-12-03 17:29:10,895 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:29:10 INFO - 2015-12-03 17:29:10,895 DEBUG : BROWSER_OUTPUT: 17:29:11 INFO - 2015-12-03 17:29:11,808 INFO : Browser exited with error code: 0 17:29:11 INFO - 2015-12-03 17:29:11,858 INFO : Completed test kraken (00:01:01) 17:29:11 INFO - 2015-12-03 17:29:11,858 INFO : Starting test v8_7 17:29:11 INFO - 2015-12-03 17:29:11,858 DEBUG : operating with platform_type : linux_ 17:29:11 INFO - 2015-12-03 17:29:11,858 INFO : Initialising browser for v8_7 test... 17:29:11 INFO - 2015-12-03 17:29:11,864 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpATQ8yH/profile http://localhost:58096/getInfo.html 17:29:16 INFO - 2015-12-03 17:29:16,672 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:29:16 INFO - 2015-12-03 17:29:16,673 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:29:16 INFO - 2015-12-03 17:29:16,673 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:29:16 INFO - 2015-12-03 17:29:16,673 DEBUG : BROWSER_OUTPUT: __metrics 17:29:16 INFO - 2015-12-03 17:29:16,749 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] 17:29:16 INFO - 2015-12-03 17:29:16,750 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] 17:29:16 ERROR - 2015-12-03 17:29:16,832 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 17:29:17 INFO - 2015-12-03 17:29:17,684 INFO : Browser initialized. 17:29:17 INFO - 2015-12-03 17:29:17,685 INFO : Running cycle 1/1 for v8_7 test... 17:29:17 INFO - 2015-12-03 17:29:17,685 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpATQ8yH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:29:29 INFO - 2015-12-03 17:29:29,783 DEBUG : BROWSER_OUTPUT: RSS: Main: 143429632 17:29:29 INFO - 2015-12-03 17:29:29,783 DEBUG : BROWSER_OUTPUT: 17:29:51 INFO - 2015-12-03 17:29:51,197 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58096/tests/v8_7/run.html (next: http://localhost:58096/tests/v8_7/run.html) 17:29:51 INFO - 2015-12-03 17:29:51,441 DEBUG : BROWSER_OUTPUT: RSS: Main: 462655488 17:29:51 INFO - 2015-12-03 17:29:51,441 DEBUG : BROWSER_OUTPUT: 17:29:51 INFO - 2015-12-03 17:29:51,442 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:29:51 INFO - 2015-12-03 17:29:51,443 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:29:51 INFO - 2015-12-03 17:29:51,443 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:29:51 INFO - 2015-12-03 17:29:51,443 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:29:51 INFO - 2015-12-03 17:29:51,443 DEBUG : BROWSER_OUTPUT: |0;Richards;165.50810989738497 17:29:51 INFO - 2015-12-03 17:29:51,443 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.46084625694044 17:29:51 INFO - 2015-12-03 17:29:51,443 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.8622420524261 17:29:51 INFO - 2015-12-03 17:29:51,443 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5191.709844559586 17:29:51 INFO - 2015-12-03 17:29:51,444 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1966.6011787819255 17:29:51 INFO - 2015-12-03 17:29:51,444 DEBUG : BROWSER_OUTPUT: |5;Earley;795.5449482895783 17:29:51 INFO - 2015-12-03 17:29:51,444 DEBUG : BROWSER_OUTPUT: |6;Boyer;12132.530120481928 17:29:51 INFO - 2015-12-03 17:29:51,444 DEBUG : BROWSER_OUTPUT: |7;RegExp;26368.42105263158 17:29:51 INFO - 2015-12-03 17:29:51,444 DEBUG : BROWSER_OUTPUT: |8;Splay;635.7279084551811 17:29:51 INFO - 2015-12-03 17:29:51,444 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 17:29:51 INFO - 2015-12-03 17:29:51,444 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:29:51 INFO - 2015-12-03 17:29:51,445 DEBUG : BROWSER_OUTPUT: __startTimestamp1449192591442__endTimestamp 17:29:51 INFO - 2015-12-03 17:29:51,445 DEBUG : BROWSER_OUTPUT: 17:29:51 INFO - 2015-12-03 17:29:51,445 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:29:51 INFO - 2015-12-03 17:29:51,446 DEBUG : BROWSER_OUTPUT: Number of tests: 10 17:29:51 INFO - 2015-12-03 17:29:51,446 DEBUG : BROWSER_OUTPUT: 17:29:51 INFO - 2015-12-03 17:29:51,446 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.51 Median:165.51 stddev:0.00 (0.0%) 17:29:51 INFO - 2015-12-03 17:29:51,447 DEBUG : BROWSER_OUTPUT: Values: 165.5 17:29:51 INFO - 2015-12-03 17:29:51,447 DEBUG : BROWSER_OUTPUT: 17:29:51 INFO - 2015-12-03 17:29:51,447 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.46 Median:191.46 stddev:0.00 (0.0%) 17:29:51 INFO - 2015-12-03 17:29:51,447 DEBUG : BROWSER_OUTPUT: Values: 191.5 17:29:51 INFO - 2015-12-03 17:29:51,447 DEBUG : BROWSER_OUTPUT: 17:29:51 INFO - 2015-12-03 17:29:51,447 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.86 Median:278.86 stddev:0.00 (0.0%) 17:29:51 INFO - 2015-12-03 17:29:51,447 DEBUG : BROWSER_OUTPUT: Values: 278.9 17:29:51 INFO - 2015-12-03 17:29:51,448 DEBUG : BROWSER_OUTPUT: 17:29:51 INFO - 2015-12-03 17:29:51,448 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5191.71 Median:5191.71 stddev:0.00 (0.0%) 17:29:51 INFO - 2015-12-03 17:29:51,448 DEBUG : BROWSER_OUTPUT: Values: 5191.7 17:29:51 INFO - 2015-12-03 17:29:51,448 DEBUG : BROWSER_OUTPUT: 17:29:51 INFO - 2015-12-03 17:29:51,448 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1966.60 Median:1966.60 stddev:0.00 (0.0%) 17:29:51 INFO - 2015-12-03 17:29:51,448 DEBUG : BROWSER_OUTPUT: Values: 1966.6 17:29:51 INFO - 2015-12-03 17:29:51,448 DEBUG : BROWSER_OUTPUT: 17:29:51 INFO - 2015-12-03 17:29:51,448 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:795.54 Median:795.54 stddev:0.00 (0.0%) 17:29:51 INFO - 2015-12-03 17:29:51,449 DEBUG : BROWSER_OUTPUT: Values: 795.5 17:29:51 INFO - 2015-12-03 17:29:51,449 DEBUG : BROWSER_OUTPUT: 17:29:51 INFO - 2015-12-03 17:29:51,449 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12132.53 Median:12132.53 stddev:0.00 (0.0%) 17:29:51 INFO - 2015-12-03 17:29:51,449 DEBUG : BROWSER_OUTPUT: Values: 12132.5 17:29:51 INFO - 2015-12-03 17:29:51,449 DEBUG : BROWSER_OUTPUT: 17:29:51 INFO - 2015-12-03 17:29:51,449 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26368.42 Median:26368.42 stddev:0.00 (0.0%) 17:29:51 INFO - 2015-12-03 17:29:51,449 DEBUG : BROWSER_OUTPUT: Values: 26368.4 17:29:51 INFO - 2015-12-03 17:29:51,450 DEBUG : BROWSER_OUTPUT: 17:29:51 INFO - 2015-12-03 17:29:51,450 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:635.73 Median:635.73 stddev:0.00 (0.0%) 17:29:51 INFO - 2015-12-03 17:29:51,450 DEBUG : BROWSER_OUTPUT: Values: 635.7 17:29:51 INFO - 2015-12-03 17:29:51,450 DEBUG : BROWSER_OUTPUT: 17:29:51 INFO - 2015-12-03 17:29:51,450 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 17:29:51 INFO - 2015-12-03 17:29:51,450 DEBUG : BROWSER_OUTPUT: Values: 4830.9 17:29:51 INFO - 2015-12-03 17:29:51,450 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:29:51 INFO - 2015-12-03 17:29:51,451 DEBUG : BROWSER_OUTPUT: 17:29:52 INFO - 2015-12-03 17:29:52,336 INFO : Browser exited with error code: 0 17:29:52 INFO - 2015-12-03 17:29:52,353 INFO : Completed test v8_7 (00:00:40) 17:29:52 INFO - 2015-12-03 17:29:52,454 INFO : Completed test suite (00:20:19) 17:29:52 INFO - 2015-12-03 17:29:52,454 DEBUG : Working with test: dromaeo_css 17:29:52 INFO - 2015-12-03 17:29:52,454 DEBUG : Generating results file: dromaeo_css 17:29:52 INFO - 2015-12-03 17:29:52,455 DEBUG : Working with test: kraken 17:29:52 INFO - 2015-12-03 17:29:52,455 DEBUG : Generating results file: kraken 17:29:52 INFO - 2015-12-03 17:29:52,456 INFO : javascript benchmark 17:29:52 INFO - 2015-12-03 17:29:52,456 DEBUG : Working with test: v8_7 17:29:52 INFO - 2015-12-03 17:29:52,456 DEBUG : Generating results file: v8_7 17:29:52 INFO - 2015-12-03 17:29:52,456 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:29:52 INFO - 2015-12-03 17:29:52,517 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 17:29:52 INFO - 2015-12-03 17:29:52,517 DEBUG : process_Request line: dromaeo_css 6119.25 graph.html#tests=[[72,94,35]] 17:29:52 INFO - 2015-12-03 17:29:52,517 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:29:52 INFO - 2015-12-03 17:29:52,544 DEBUG : process_Request line: kraken 1519.00 graph.html#tests=[[232,94,35]] 17:29:52 INFO - 2015-12-03 17:29:52,545 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:29:52 INFO - 2015-12-03 17:29:52,579 DEBUG : process_Request line: v8_7 19705.25 graph.html#tests=[[230,94,35]] 17:29:52 INFO - 2015-12-03 17:29:52,581 INFO : javascript benchmark 17:29:52 INFO - 2015-12-03 17:29:52,584 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2600.271923861319, 2709.972900270998, 2711.9322016949586, 2716.4838680650664, 2726.8363898166103, 4479.574440428162, 4607.101615185032, 4685.062987402516, 4725.173094708425, 4735.19501684714, 4600.447946246455, 4656.208444564424, 4676.696014759038, 4682.953170468303, 4684.250519916814, 4283.421738065368, 4307.073979094502, 4332.65338772899, 4482.282834746441, 4495.910081798362, 4109.979450102745, 4410.4266445362055, 4414.918345005478, 4464.6651501137385, 4490.50604433512, 4273.230818452677, 4296.699231053827, 4331.480222373335, 4338.436003319548, 4372.978135109304, 4371.759553224571, 4373.803178856959, 4374.321980093091, 4390.100029493978, 4414.227510185737, 4138.255114079495, 4231.70378073535, 4345.044090300129, 4371.0820727646915, 4407.0, 4500.932486012713, 4606.0, 4690.577847993697, 4745.857624271277, 4756.07256584966, 5063.0380227756605, 5065.772040258161, 5068.214426763858, 5075.492450754895, 5099.286099945974, 4837.854864354075, 5086.41506226785, 5092.465291144414, 5097.592192624581, 5102.209157580581, 4549.499555048975, 4565.61192298655, 4641.489436162019, 4702.506236845151, 4739.478657347689, 5130.692158470503, 5145.536901678867, 5146.150885103991, 5146.716930568855, 5149.382074151126, 4745.311929770233, 4935.876603084952, 4936.3829521309835, 4936.407631084293, 4982.725950072709, 4944.48082951285, 4955.380577427822, 4982.128127577659, 5053.5957123430035, 5055.9241611375855, 5008.348914641073, 5011.373578302712, 5023.120953833065, 5065.341505604321, 5068.265101560253, 5028.673136246132, 5034.496550344937, 5037.370328708911, 5037.823676171316, 5074.086664400444, 3975.960240397617, 4121.773302468393, 4123.690723195772, 4135.710500265012, 4272.423222864935, 3663.0, 3683.318586061587, 3699.260147970363, 3711.5175027246287, 3714.3685573452576, 4314.0, 4314.525402205755, 4315.546867578922, 4353.10761293934, 4353.303471444554, 4780.235162374003, 4892.143874821892, 4896.020795840846, 4931.975340123348, 5019.573336266459, 4313.61177494027, 4324.437823082979, 4334.219840428753, 4374.759388233678, 4376.978115109404, 4461.486929003207, 4516.322551617283, 4550.590446859798, 4555.06621142665, 4591.081783643218, 4559.840405585788, 4695.741734204515, 4700.0, 4844.249141383091, 4864.513548645178, 4985.900281994413, 5046.7224302662235, 5068.189089745771, 5070.290159377616, 5117.462666420121, 4756.833510827105, 4797.232442809134, 4797.712137271775, 4799.712017278975, 4844.878878028077, 4750.5249475052215, 4835.564799168092, 4852.19938710123, 4993.0, 5043.67216130965, 4966.478519755374, 5019.874503137451, 5039.647224694383, 5044.47033061538, 5084.51697088776, 4883.487233840396, 4893.412790465167, 4899.583535399388, 4901.338319326987, 4940.333055037524, 4696.131215724965, 4835.032993401263, 4842.249451335048, 4878.365812444502, 4887.242477416006, 4724.976375118103, 4773.403324584427, 4779.498152693917, 4780.282957556395, 4834.057358814997, 4954.380702412199, 4964.776585053609, 4971.627127965345, 4972.204447288416, 4986.1772807487805, 4673.7429441381055, 4790.688605240648, 4795.712257264575, 4838.443578988321, 4891.315215869852], "unit": "ms", "name": "dojo.html", "value": 4607.84572605002}, {"lowerIsBetter": false, "replicates": [558.1989844573038, 566.798786430817, 568.7525926222094, 571.362930332679, 571.8341680912536, 28546.143615691537, 29040.709592904066, 29137.417251654955, 37422.0, 37797.244055118885, 40703.59296407035, 41164.58835411645, 41169.38245926306, 41195.17609647813, 41461.792691036506, 7740.342070923978, 7895.171007044264, 7906.0, 7906.841863162734, 7933.682652693914, 7131.465140114512, 7300.233475485077, 10115.645952391667, 10367.637132700356, 10382.117520010808, 10063.34588251765, 10173.033561811653, 10173.796524069514, 10178.134858537032, 10182.439965801877, 7167.641617919136, 7345.008423862817, 10093.94953025234, 10207.030332118436, 10210.183185345191, 7040.401565866908, 7149.714011439536, 10092.343997640204, 10340.586376544928, 10346.0, 37633.62366376328, 38163.23673526542, 38179.23641527154, 38186.80906595477, 38212.808935955145, 2726.4547090581764, 2789.888404463819, 2933.31067199208, 2966.0, 3506.6493350664987, 28226.0, 28382.716172838213, 28469.57295640567, 28812.423751524853, 28932.855335723187, 3375.8143302118374, 3482.5298584690995, 3497.667721566447, 3559.626239244868, 3576.5529308836394, 216326.0, 217155.0, 218149.91276003304, 218176.0, 218505.0, 47057.529424706, 47866.0, 53182.46817531853, 53900.73049634727, 54158.18762718562, 57632.0, 57687.42312576905, 58362.708186458796, 58482.122768158515, 58540.414595854345, 12263.0, 12391.070669699808, 12396.442160102817, 12402.875971240172, 12416.255024698547, 9142.268618510503, 9145.81708365829, 9229.123233292827, 9233.0, 9236.815263694689, 17498.82501174972, 18153.364632237808, 18182.36361727333, 18232.908835456004, 18337.358192463198, 7030.437564994788, 7162.104736907887, 7215.422766178693, 7345.118585769635, 7375.44684148691, 753.6344872736719, 846.8814365988767, 885.7032893980588, 978.9706308810747, 1007.044324906402, 26339.209823705318, 26374.691487554857, 26403.735962640127, 26501.204963851116, 26642.20073397801, 969.5879251318162, 977.0669011094387, 993.7068564773409, 1052.957881684724, 1059.6820953713855, 13887.0, 13909.095908765898, 14027.85972140286, 14426.711465770626, 14651.560453186421, 205577.0, 208348.0, 208992.0, 209242.0, 209517.0, 42742.358864617054, 42749.57250427518, 42784.786076069424, 42826.57173428288, 43085.0, 1181.4860535667012, 1188.423614546944, 1200.8351898658461, 1218.3786269002871, 1220.383706228349, 25719.742802572484, 26097.0, 27059.458810824068, 27406.314842129108, 27471.31321716973, 36233.81883090568, 37065.62934370622, 39095.80452097721, 43275.567244327154, 43626.56373436225, 181792.0, 182277.0, 182637.0, 183132.0, 183268.0, 24214.87892560526, 26259.080932167282, 26674.466510670067, 26675.599866001638, 26715.465690685687, 28499.145025649264, 38168.427473588476, 38670.419943700304, 38729.0, 38763.41854872123, 30861.8396712228, 32709.888618307432, 33511.66488335085, 33594.49608255829, 33679.66320336765, 32569.208693521137, 33067.17332066718, 33478.83260583682, 33831.3233735319, 34367.0, 30652.0, 31215.531767023058, 31216.843915780275, 31242.21894452657, 31462.370752584364, 26975.865120674272, 28055.29861753391, 28883.711162888943, 30186.0, 30299.545506816976, 23377.309759575648, 23475.76524234736, 23638.52722945566, 23879.28362149069, 23891.283261502183], "unit": "ms", "name": "ext.html", "value": 16561.709146292786}, {"lowerIsBetter": false, "replicates": [324.4623934279108, 328.4400097833194, 331.68986997157657, 332.3220629914974, 332.7720511449656, 12601.495940162382, 12981.415836287366, 14912.254387280633, 15331.0, 16509.091999940014, 12313.138080334358, 13709.177449353047, 13922.51271205508, 13954.720905581882, 14242.430302787901, 3891.824867880938, 4367.3448982652535, 5044.369453818273, 5089.872753181182, 5105.05556472052, 5067.6452648314635, 5100.770465329069, 5111.7699703513435, 5112.948870511303, 5116.360454943132, 4922.532359425849, 5048.9495105048845, 5075.3909530856345, 5081.491850814926, 5081.949180508184, 4950.55445009949, 4974.801007959713, 4986.326845875797, 4988.251762235657, 4991.450940396553, 4408.625266852321, 4414.779261036935, 4431.446069241345, 4432.822687092513, 4434.334849772527, 11008.504617292241, 11332.980031797095, 11364.0, 11386.202965792398, 14362.210078445682, 1879.6146789908037, 1896.2225487550177, 1898.221729091066, 1899.9525011874675, 1927.778305494872, 9193.126652967958, 11190.261228458323, 12181.573644922473, 12269.815952760715, 12616.936915315364, 1720.1657196259805, 1736.2187015842921, 1802.4953013156205, 1814.1564172659776, 1822.6719190545696, 55704.593971692964, 55748.44251557514, 56377.0, 56847.71576142093, 56860.0, 9398.154166124945, 9429.48137852411, 9523.761905952268, 9535.856962145574, 9539.189168920719, 10468.63359782404, 10757.085647719874, 11683.707907302216, 11941.104417168746, 11944.104192185447, 6365.713542890581, 6557.180352455943, 6669.533132680665, 6675.23234828001, 6765.458763298924, 6102.298235702862, 6141.6007959482495, 6142.385761423822, 6150.477209437158, 6183.876322473615, 3996.2207369562657, 4024.4969378827645, 4041.6362527372676, 4154.296738337267, 4180.937285940713, 1648.5384092454133, 1654.3630702179507, 1663.4760050584027, 1669.7912760904887, 1679.5885008173075, 350.67737681333233, 350.8403676327265, 371.485492592761, 825.669732107162, 857.0829212742306, 9507.619695212252, 10064.74838129038, 10268.948655256676, 10371.688849334532, 10416.114630256361, 382.6001828089653, 384.05713972198186, 388.1131614261399, 390.52941205846884, 411.00946718408494, 4483.618892394118, 5429.294191755125, 5435.402105768362, 5530.557555395559, 5675.0, 470039.0, 474646.0, 476845.0, 477007.0, 487463.0, 51563.74218128961, 68186.65906670435, 70747.29252707407, 72323.6383818088, 73692.0, 394.54233089615906, 400.2395448647593, 403.1956247286682, 414.9896252593649, 418.9560096189856, 9299.256059515088, 9566.186874115778, 9605.759856003655, 9621.27840411958, 9625.32622716403, 29086.7091329084, 29953.550696740003, 30427.695723042485, 30438.39123217479, 30927.381452371275, 38904.416433754086, 39860.80069599633, 40627.59372406356, 40762.59237407588, 41449.0, 8622.61198246068, 8858.0, 8899.955500222717, 8904.154105359981, 8925.73222803291, 15646.608834779221, 15674.216289185268, 16026.0, 16098.436554720529, 16175.757363639319, 12892.871071289166, 13176.60470185896, 13297.66755831112, 13631.727365452834, 13738.725225495235, 12106.152569320064, 12196.146269761031, 13167.2757998311, 13512.662183445493, 13515.256660883746, 12896.355182240663, 12926.901213396966, 13057.412416441093, 13302.135361201492, 13353.66615834573, 8849.911500885166, 8888.73333799987, 8905.955470222867, 8982.86525702102, 8989.640414383352, 9505.477198754135, 9569.043095690375, 10809.891901080888, 13511.121777084458, 13799.86200138026], "unit": "ms", "name": "jquery.html", "value": 7210.21614789682}, {"lowerIsBetter": false, "replicates": [1189.381521608764, 1678.320280286484, 1683.772690686757, 1704.1734758642056, 1750.6936286149923, 5788.47903688668, 7029.437644988401, 7215.747448839292, 7241.674124664396, 7258.818529536764, 6818.897716534244, 6954.96522517388, 6965.059716938212, 6972.4422046236305, 6976.755813546527, 2027.858049936505, 2046.6725323948172, 2066.1838573763353, 2067.286786058815, 2069.968950465744, 2103.484646261668, 2114.862533935297, 2120.6500927347047, 2151.3868547463976, 2157.967630485544, 2072.730545029144, 2086.843486738493, 2109.504266497372, 2113.0280071167203, 2113.2075471698113, 2070.234013415031, 2088.791120887899, 2092.9162833486644, 2093.665013597825, 2094.3612198279593, 2071.109422948132, 2081.7814129516487, 2127.808497235241, 2132.5734853029303, 2133.5839511295303, 5820.679862607555, 5945.0, 7109.182444018952, 7191.748288809867, 7202.423806095552, 4006.419069234945, 4072.328065869128, 4087.8773636790943, 4113.115680128757, 4130.277201489727, 2726.236653736937, 2764.060219525371, 2811.1144989328295, 2811.367442325481, 2821.0, 869.2263885142229, 881.8589025755913, 883.9625358799385, 897.3135551303258, 905.2350763604743, 9622.711318660451, 9687.41875487473, 9688.176504997084, 9690.75773105671, 9705.0, 3959.2675355059405, 3967.3652215645357, 4000.439938408625, 4013.0368711509614, 4046.716729828943, 8355.373346999, 8423.368247381472, 8428.115047920002, 8461.11158328379, 8462.957685211535, 4224.809883555247, 4238.6397156242065, 4253.298205796071, 4256.638185754184, 4263.275243208662, 3832.329342365075, 3832.7125465590193, 3833.9041523961564, 3834.4631751554803, 3834.482344883405, 3293.176705823544, 3339.44899091652, 3340.7661463697796, 3363.058343663778, 3366.074329559342, 1036.1555332404216, 1047.1518070363031, 1049.8897615750236, 1058.1587637827945, 1058.3544038136731, 897.708244820436, 902.2240872849344, 915.56053094515, 915.9587818548048, 938.3666025432806, 6584.934150658528, 6637.568558043712, 6638.4689224861895, 6641.468682505388, 6643.601383916884, 415.64670030474457, 427.8545294599789, 428.25911173669726, 430.03671775223273, 433.05593805503673, 4712.976435117871, 5027.773750181251, 5057.0644430779685, 5068.062408454448, 5083.61872859537, 7132.215456299803, 8374.246317831303, 8566.828663426697, 8567.100454452317, 8575.056743758181, 8392.370572207108, 8539.829203415897, 8620.094890036582, 8636.784080397914, 8638.352123590756, 6421.3578642136345, 6461.0, 6469.870602587922, 6511.479081673455, 6529.085927970088, 6540.476761859135, 6553.049807777941, 6575.704093315717, 6603.174603174603, 6623.138991931018, 7319.158296795937, 7431.888521672287, 7439.367653749492, 7565.243475652391, 7565.4325925556905, 7506.0, 7621.618919053914, 7778.649960751893, 7807.141214466517, 7813.609319534115, 6093.573449858467, 6296.212973378328, 6332.335104813928, 6350.4919606432295, 6396.200474940632, 6853.143357080365, 6884.51808373409, 6899.827504312432, 6909.723611055702, 6968.825779355557, 6430.035494675836, 6513.381228783258, 6530.8367290818105, 6586.473082153512, 6593.274739778524, 6443.967780161257, 6449.129367535323, 6461.0954466373805, 6468.062130990886, 6509.218893732783, 6502.154719886574, 6524.249711283263, 6544.051112588743, 6544.6727663617585, 6547.770828020996, 5946.43508866657, 6031.517478601613, 6085.361037091042, 6108.083787431743, 6122.173506576555, 6169.2288463942, 6187.288461826947, 6191.690415479298, 6204.689765511616, 6217.316095229431], "unit": "ms", "name": "mootools.html", "value": 3979.3352460461606}, {"lowerIsBetter": false, "replicates": [283.62844673477747, 287.04843443983196, 289.67266988303214, 291.4666160925507, 294.3597675056754, 5370.167624018279, 5390.434004429537, 5405.459454054592, 5439.891202175959, 5452.454754524546, 5323.653962492435, 5333.653312534682, 5343.118385466393, 5347.839564813062, 5351.785928562863, 4074.9388759168637, 4125.154343359604, 4128.710990230685, 4130.401091841696, 4140.4824396950235, 3922.627350401707, 4004.2191772604356, 4008.1983603279314, 4098.7540747555095, 4108.650764685005, 4048.0487085534874, 4058.0463591056077, 4060.37584966013, 4068.105016896278, 4074.327735923569, 3850.1337199130253, 3981.422693709396, 4036.656884164835, 4059.0664147246002, 4063.553009168989, 3397.69420752131, 3482.5298584690995, 3482.9477557836653, 3488.1628409181612, 3493.580770307554, 5154.793808247666, 5158.793648254065, 5163.483651634844, 5170.767315470775, 5179.689218646893, 4607.9308810367875, 4618.5381461853885, 4622.768861556909, 4625.8149674013, 4629.560191781776, 5481.040817856899, 5595.916061259084, 5611.382747897728, 5616.691081990489, 5624.521915637176, 3772.8113594320175, 3781.6596506314563, 3782.905427364338, 3784.526934133233, 3785.9053523661855, 5930.169776231331, 5934.525237980951, 5942.64344139353, 5945.464908158243, 5948.553858460589, 3837.4819399381286, 3875.8255878485534, 3883.0292426893275, 3886.6696330811633, 3888.4556162137324, 3916.138449541096, 3936.173403585279, 3941.290567697842, 3942.3100957332354, 3942.9211415772097, 4468.530804265505, 4582.564656357641, 4583.449986001635, 4587.816487340469, 4593.885152871138, 5603.8879222416135, 5626.409227031103, 5639.689817060101, 5648.096304591246, 5658.547316214693, 1381.171297221659, 1401.2853444743255, 1401.2923473645947, 1401.4044031286867, 1402.5021117503343, 928.4522131942186, 930.3534043839467, 932.9860052099224, 972.3533849989819, 980.843065109579, 4942.5057494251005, 4945.431275403303, 4950.529699678525, 4960.082384758759, 4967.254911763264, 5897.675627840425, 5902.321233058254, 5903.734331955073, 5904.439078287556, 5909.054551271776, 4945.9258111128365, 4947.529984651453, 4952.4304704959395, 4953.752312384367, 4962.057209130254, 3053.2824786175674, 3113.3150706844913, 3149.1969547765175, 3182.8567714452906, 3192.1062102611304, 5469.316335458067, 5512.531434828004, 5595.188697638901, 5604.075327570987, 5634.0, 6078.209832721718, 6080.513558915276, 6115.296740874767, 6119.724612392364, 6120.204373431426, 5522.91715624266, 5549.944500555023, 5570.470805273492, 5580.665160090408, 5598.804041858515, 5806.274215723035, 5919.230500034968, 5945.881082378241, 5949.434803693643, 5951.16683664296, 5803.0, 5805.216295800182, 5816.82549523515, 5818.330891947311, 5821.126830975219, 5602.411746766531, 5606.551475881838, 5608.439156084359, 5610.186522954067, 5619.072852979376, 3913.6086391360636, 3995.1610161866333, 4000.0599859032523, 4013.69897257701, 4015.257177422186, 5920.319163296103, 5921.851953701192, 5934.258217722785, 5936.257967754031, 5936.643801371932, 5657.15142728594, 5703.515201207778, 5708.4862362387585, 5710.371859095413, 5711.914321285101, 5669.262995810518, 5701.315842098975, 5701.7149142541875, 5703.8859222816145, 5718.313802343745, 5410.134378499579, 5565.38780734127, 5609.49514543693, 5614.494695477427, 5619.297587801525, 5765.423457654201, 5769.711514424346, 5772.0, 5773.566982476415, 5775.220345253337, 5624.859378515406, 5630.971845140748, 5632.85917852057, 5636.126400407943, 5639.689817059937], "unit": "ms", "name": "prototype.html", "value": 4203.099606043492}, {"lowerIsBetter": false, "replicates": [689.4484412470023, 690.6443181761393, 697.8953157026447, 731.4623751542618, 778.4939789137061, 12177.33024683643, 12338.0, 12488.12583119182, 12521.0, 14422.639434014154, 12978.74042519149, 13083.345832708374, 13086.672833179175, 13100.672483187926, 13117.081804273705, 631.8167731357901, 639.8816218999476, 640.0942666127447, 801.8717005279171, 816.967321307147, 791.133708589094, 793.0721056364039, 807.2855522862251, 807.8303556253164, 808.1958451340925, 837.4305472278847, 847.7075408983891, 848.0163010907348, 848.7835601921502, 848.8981322241309, 655.655780715126, 662.1557514169449, 819.3199644295221, 838.4508147163588, 839.47532792005, 621.0963048764038, 621.7388696747377, 622.2999125983268, 622.3838399983983, 622.5019984012772, 10499.580016799318, 10593.364398136137, 10683.14534837211, 10691.625793097204, 10712.946435267851, 10706.785864282749, 11232.438378081146, 11254.15593830466, 11337.489812958354, 11486.368249746261, 9173.266138708954, 9393.953030234874, 9398.34211605188, 9674.837567918232, 9712.125908668184, 3136.466800643896, 3210.4381733196597, 3217.3082787200865, 3242.157039169809, 3271.263965607719, 40398.79800600978, 40879.591204087876, 40895.38656920119, 41242.587574124176, 41451.1709765806, 9121.726348209564, 9513.476758778334, 9686.660966866126, 9761.316707830525, 9785.902140978642, 16276.348946042026, 16493.092879891483, 16609.501714948572, 16616.750748738777, 16681.0, 6232.563720539519, 6265.8746825063245, 6313.05304204373, 6321.146645202931, 6398.936010639927, 3517.243792584555, 3553.3071051145293, 3584.2652256287397, 3601.8019008954757, 3629.0927268182954, 2730.9349353752054, 2761.5719563467696, 2766.6265054217824, 2772.196063141707, 2775.153578158681, 489.52271535253556, 490.6884128578307, 494.695762106302, 501.98494045178705, 502.1664037697405, 489.51782494243145, 535.1483865824291, 553.9336776704827, 556.4991507643153, 597.7369957218809, 7362.335267126905, 7455.569573726269, 7592.696292148363, 7599.848003040019, 7626.428017898569, 461.335676625658, 467.6959976015617, 513.2557791202771, 531.861715953847, 550.0978395431496, 3403.1662242750685, 3406.3698215829654, 3444.844981975817, 3511.034465521951, 3578.8568457261417, 47457.28814067792, 48048.27927581089, 48207.75896120497, 48209.5179048212, 48694.75652621714, 44768.55231447709, 45056.3241551377, 46683.29975050377, 47166.0, 47517.52482475131, 42014.78992605017, 42060.15879682389, 42505.36241956373, 42669.0, 42721.78639106784, 7271.381932535794, 7410.333070023508, 7458.589777562286, 7849.215078492333, 7908.881366779618, 31561.210969725023, 32246.19384515406, 33197.0, 33418.83290583531, 33524.83237583796, 40108.1978360437, 43018.13963720771, 43525.56474435215, 43723.34414983841, 44134.33798493089, 10686.358818470917, 10697.946510267398, 10763.408012559385, 10931.672049838518, 11212.66362009141, 10106.44380254444, 10328.431936243578, 10402.843957340494, 11561.19071665009, 11922.986546143675, 10336.741581460523, 10754.032137107697, 11114.05530529914, 11126.165537584875, 11164.832527511931, 10439.425831579336, 10479.842802357818, 10795.19036072282, 10871.29336593119, 10925.890741092488, 10388.42863642507, 10399.168066554808, 10405.970835686969, 10642.255042146975, 10664.360138391721, 8470.49177049379, 8494.490330580185, 8620.698275560577, 9101.499417532099, 9164.495952722398, 8910.777230569029, 8955.507447090473, 9098.619939528762, 9121.498317592595, 9377.953110234404], "unit": "ms", "name": "yui.html", "value": 5704.406423777295}], "name": "dromaeo_css", "value": 6119.241357491952}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 114.0, 105.0, 112.0, 111.0, 110.0, 100.0, 112.0, 111.0, 105.0], "unit": "ms", "name": "ai-astar", "value": 109.1}, {"lowerIsBetter": true, "replicates": [159.0, 129.0, 157.0, 178.0, 131.0, 147.0, 164.0, 136.0, 166.0, 132.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.9}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 161.0, 163.0, 161.0, 160.0, 161.0, 161.0, 162.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 86.0, 93.0, 72.0, 72.0, 72.0, 102.0, 89.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 80.4}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 131.0, 95.0, 95.0, 95.0, 138.0, 94.0, 95.0, 130.0], "unit": "ms", "name": "audio-oscillator", "value": 106.2}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 108.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 147.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.0}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 71.0, 70.0, 70.0, 71.0, 72.0, 79.0, 69.0, 71.0], "unit": "ms", "name": "json-parse-financial", "value": 71.9}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 67.0, 68.0, 68.0, 68.0, 68.0, 70.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 85.0, 93.0, 86.0, 84.0, 85.0, 84.0, 85.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.7}, {"lowerIsBetter": true, "replicates": [124.0, 121.0, 119.0, 118.0, 119.0, 123.0, 127.0, 127.0, 128.0, 128.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.4}, {"lowerIsBetter": true, "replicates": [154.0, 135.0, 136.0, 149.0, 153.0, 143.0, 137.0, 146.0, 136.0, 135.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 142.4}, {"lowerIsBetter": true, "replicates": [71.0, 68.0, 70.0, 70.0, 70.0, 68.0, 70.0, 73.0, 69.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.6}], "name": "kraken", "value": 1519.0000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.50810989738497], "unit": "score", "name": "Richards", "value": 213.294684}, {"lowerIsBetter": false, "replicates": [191.46084625694044], "unit": "score", "name": "DeltaBlue", "value": 345.33431399999995}, {"lowerIsBetter": false, "replicates": [278.8622420524261], "unit": "score", "name": "Encrypt", "value": 954.525066}, {"lowerIsBetter": false, "replicates": [5191.709844559586], "unit": "score", "name": "Decrypt", "value": 51.270392215568904}, {"lowerIsBetter": false, "replicates": [1966.6011787819255], "unit": "score", "name": "RayTrace", "value": 376.2781228771229}, {"lowerIsBetter": false, "replicates": [795.5449482895783], "unit": "score", "name": "Earley", "value": 837.743991}, {"lowerIsBetter": false, "replicates": [12132.530120481928], "unit": "score", "name": "Boyer", "value": 54.93190566037737}, {"lowerIsBetter": false, "replicates": [26368.42105263158], "unit": "score", "name": "RegExp", "value": 34.54833333333334}, {"lowerIsBetter": false, "replicates": [635.7279084551811], "unit": "score", "name": "Splay", "value": 128.18534299999996}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19705.251581524622}]} 17:29:52 INFO - RETURN: dromaeo_css: 6119.25 17:29:52 INFO - RETURN: kraken: 1519.00 17:29:52 INFO - RETURN: v8_7: 19705.25 17:29:52 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "19705.25"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1519.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "6119.25"}}} 17:29:52 INFO - Return code: 0 17:29:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:29:52 ERROR - # TBPL SUCCESS # 17:29:52 INFO - Running post-action listener: _resource_record_post_action 17:29:52 INFO - Running post-run listener: _resource_record_post_run 17:29:53 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 4096; Write bytes: 517410816; Read time: 240; Write time: 670520 17:29:53 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 243195904; Read time: 0; Write time: 459412 17:29:53 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 4096; Write bytes: 274214912; Read time: 240; Write time: 211108 17:29:53 INFO - Running post-run listener: _upload_blobber_files 17:29:53 INFO - Blob upload gear active. 17:29:53 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 17:29:53 INFO - Copying logs to upload dir... 17:29:53 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1274.906774 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2015-12-03 17:29:53.410597) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 17:29:53.414537) ========= 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=01deea79d00cc2c334834894000001d2-1449190031.695872-1875200976 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/0Om73bYtRJKD7mm_xwWGnQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009891 build_url: 'https://queue.taskcluster.net/v1/task/0Om73bYtRJKD7mm_xwWGnQ/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 17:29:53.467752) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 17:29:53.468096) ========= 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=01deea79d00cc2c334834894000001d2-1449190031.695872-1875200976 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004558 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 17:29:53.518087) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 17:29:53.518422) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 17:29:53.518731) ========= ========= Total master_lag: 0.22 =========