builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-009 starttime: 1450700056.75 results: success (0) buildid: 20151221025128 builduid: 3cb7b8613dc5480789afda2206d53db8 revision: 091d6785608297bab2cf36b1b6a2d9a388b82a01 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 04:14:16.751606) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 04:14:16.752261) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 04:14:16.752717) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1450700054.407183-1411039578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006326 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 04:14:16.776414) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 04:14:16.776812) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 04:14:16.791332) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 04:14:16.791894) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1450700054.407183-1411039578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004707 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 04:14:16.840938) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 04:14:16.841267) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 04:14:16.841632) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 04:14:16.842075) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1450700054.407183-1411039578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-21 04:14:17-- 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% 46.7M=0s 2015-12-21 04:14:17 (46.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.177500 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 04:14:17.033271) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 04:14:17.033582) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1450700054.407183-1411039578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014728 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 04:14:17.083057) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 04:14:17.083436) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 091d6785608297bab2cf36b1b6a2d9a388b82a01 --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 091d6785608297bab2cf36b1b6a2d9a388b82a01 --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=a732b360c9c0c9a4a8cfc42c000001d9-1450700054.407183-1411039578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-21 04:14:17,694 truncating revision to first 12 chars 2015-12-21 04:14:17,694 Setting DEBUG logging. 2015-12-21 04:14:17,694 attempt 1/10 2015-12-21 04:14:17,694 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/091d67856082?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-21 04:14:17,936 unpacking tar archive at: mozilla-central-091d67856082/testing/mozharness/ program finished with exit code 0 elapsedTime=0.538347 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 04:14:17.634629) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 04:14:17.634972) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 04:14:17.642445) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 04:14:17.642818) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 04:14:17.643315) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-12-21 04:14:17.643615) ========= /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=a732b360c9c0c9a4a8cfc42c000001d9-1450700054.407183-1411039578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:14:18 INFO - MultiFileLogger online at 20151221 04:14:18 in /builds/slave/test 04:14:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:14:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:14:18 INFO - {'append_to_log': False, 04:14:18 INFO - 'base_work_dir': '/builds/slave/test', 04:14:18 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:14:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:14:18 INFO - 'branch': 'Firefox-Non-PGO', 04:14:18 INFO - 'buildbot_json_path': 'buildprops.json', 04:14:18 INFO - 'config_files': ('talos/linux_config.py',), 04:14:18 INFO - 'default_actions': ('clobber', 04:14:18 INFO - 'read-buildbot-config', 04:14:18 INFO - 'download-and-extract', 04:14:18 INFO - 'populate-webroot', 04:14:18 INFO - 'create-virtualenv', 04:14:18 INFO - 'install', 04:14:18 INFO - 'run-tests'), 04:14:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:14:18 INFO - 'download_minidump_stackwalk': True, 04:14:18 INFO - 'download_symbols': 'ondemand', 04:14:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:14:18 INFO - 'tooltool.py': '/tools/tooltool.py', 04:14:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:14:18 INFO - '/tools/misc-python/virtualenv.py')}, 04:14:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:14:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:14:18 INFO - 'installer_path': 'installer.exe', 04:14:18 INFO - 'log_level': 'info', 04:14:18 INFO - 'log_name': 'talos', 04:14:18 INFO - 'log_to_console': True, 04:14:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:14:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:14:18 INFO - 'opt_config_files': (), 04:14:18 INFO - 'pip_index': False, 04:14:18 INFO - 'sps_profile': False, 04:14:18 INFO - 'sps_profile_interval': 0, 04:14:18 INFO - 'suite': 'dromaeojs', 04:14:18 INFO - 'system_bits': '64', 04:14:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:14:18 INFO - 'title': 'talos-linux64-ix-009', 04:14:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:14:18 INFO - 'use_talos_json': True, 04:14:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:14:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:14:18 INFO - 'work_dir': 'build'} 04:14:18 INFO - ##### 04:14:18 INFO - ##### Running clobber step. 04:14:18 INFO - ##### 04:14:18 INFO - Running pre-action listener: _resource_record_pre_action 04:14:18 INFO - Running main action method: clobber 04:14:18 INFO - rmtree: /builds/slave/test/build 04:14:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:14:18 INFO - Running post-action listener: _resource_record_post_action 04:14:18 INFO - ##### 04:14:18 INFO - ##### Running read-buildbot-config step. 04:14:18 INFO - ##### 04:14:18 INFO - Running pre-action listener: _resource_record_pre_action 04:14:18 INFO - Running main action method: read_buildbot_config 04:14:18 INFO - Using buildbot properties: 04:14:18 INFO - { 04:14:18 INFO - "project": "", 04:14:18 INFO - "product": "firefox", 04:14:18 INFO - "script_repo_revision": "production", 04:14:18 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:14:18 INFO - "repository": "", 04:14:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:14:18 INFO - "buildid": "20151221025128", 04:14:18 INFO - "pgo_build": "False", 04:14:18 INFO - "basedir": "/builds/slave/test", 04:14:18 INFO - "buildnumber": 413, 04:14:18 INFO - "slavename": "talos-linux64-ix-009", 04:14:18 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:14:18 INFO - "platform": "ubuntu64_hw", 04:14:18 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:14:18 INFO - "branch": "mozilla-central", 04:14:18 INFO - "repo_path": "mozilla-central", 04:14:18 INFO - "revision": "091d6785608297bab2cf36b1b6a2d9a388b82a01", 04:14:18 INFO - "stage_platform": "linux64", 04:14:18 INFO - "builduid": "3cb7b8613dc5480789afda2206d53db8", 04:14:18 INFO - "slavebuilddir": "test" 04:14:18 INFO - } 04:14:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:14:18 INFO - Running post-action listener: _resource_record_post_action 04:14:18 INFO - ##### 04:14:18 INFO - ##### Running download-and-extract step. 04:14:18 INFO - ##### 04:14:18 INFO - Running pre-action listener: _resource_record_pre_action 04:14:18 INFO - Running main action method: download_and_extract 04:14:18 INFO - mkdir: /builds/slave/test/build/tests 04:14:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:18 INFO - https://queue.taskcluster.net/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:14:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/test_packages.json 04:14:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/test_packages.json 04:14:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:14:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:14:19 INFO - Downloaded 1302 bytes. 04:14:19 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:14:19 INFO - Using the following test package requirements: 04:14:19 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:14:19 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:19 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:14:19 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:19 INFO - u'jsshell-linux-x86_64.zip'], 04:14:19 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:19 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:14:19 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:14:19 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:19 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:14:19 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:19 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:14:19 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:19 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:14:19 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:14:19 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:19 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:14:19 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:14:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:19 INFO - https://queue.taskcluster.net/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:14:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:14:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:14:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:14:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:14:20 INFO - Downloaded 21871910 bytes. 04:14:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 04:14:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:14:20 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:14:21 INFO - Return code: 0 04:14:21 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:14:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:21 INFO - https://queue.taskcluster.net/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:14:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:14:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:14:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:14:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:14:22 INFO - Downloaded 21871910 bytes. 04:14:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 04:14:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:14:22 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:14:23 INFO - Return code: 0 04:14:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:23 INFO - https://queue.taskcluster.net/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:14:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:14:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:14:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:14:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:14:25 INFO - Downloaded 11132039 bytes. 04:14:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 04:14:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:14:25 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 04:14:25 INFO - Return code: 0 04:14:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:25 INFO - https://queue.taskcluster.net/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:14:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:14:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:14:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:14:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:14:26 INFO - Downloaded 53069162 bytes. 04:14:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:14:26 INFO - mkdir: /builds/slave/test/properties 04:14:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:14:26 INFO - Writing to file /builds/slave/test/properties/build_url 04:14:26 INFO - Contents: 04:14:26 INFO - build_url:https://queue.taskcluster.net/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:14:26 INFO - Running post-action listener: _resource_record_post_action 04:14:26 INFO - Running post-action listener: set_extra_try_arguments 04:14:26 INFO - ##### 04:14:26 INFO - ##### Running populate-webroot step. 04:14:26 INFO - ##### 04:14:26 INFO - Running pre-action listener: _resource_record_pre_action 04:14:26 INFO - Running main action method: populate_webroot 04:14:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:14:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:14:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:14:26 INFO - '--tppagecycles', 04:14:26 INFO - '7'], 04:14:26 INFO - 'tests': ['tsvgm']}}, 04:14:26 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:14:26 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:14:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:14:26 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:14:26 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:14:26 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:14:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:14:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:26 INFO - 'talos_options': ['--e10s'], 04:14:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:14:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:26 INFO - 'tests': ['damp', 'tps']}, 04:14:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:26 INFO - 'talos_options': ['--e10s'], 04:14:26 INFO - 'tests': ['damp', 'tps']}, 04:14:26 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:14:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:14:26 INFO - 'other': {'tests': ['a11yr', 04:14:26 INFO - 'ts_paint', 04:14:26 INFO - 'tpaint', 04:14:26 INFO - 'sessionrestore', 04:14:26 INFO - 'sessionrestore_no_auto_restore']}, 04:14:26 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:14:26 INFO - 'tests': ['a11yr', 04:14:26 INFO - 'ts_paint', 04:14:26 INFO - 'tpaint', 04:14:26 INFO - 'sessionrestore', 04:14:26 INFO - 'sessionrestore_no_auto_restore']}, 04:14:26 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:14:26 INFO - 'tests': ['a11yr', 04:14:26 INFO - 'ts_paint', 04:14:26 INFO - 'tpaint', 04:14:26 INFO - 'sessionrestore', 04:14:26 INFO - 'sessionrestore_no_auto_restore']}, 04:14:26 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:14:26 INFO - 'tests': ['a11yr', 04:14:26 INFO - 'ts_paint', 04:14:26 INFO - 'tpaint', 04:14:26 INFO - 'sessionrestore', 04:14:26 INFO - 'sessionrestore_no_auto_restore']}, 04:14:26 INFO - 'other_l64': {'tests': ['a11yr', 04:14:26 INFO - 'ts_paint', 04:14:26 INFO - 'tpaint', 04:14:26 INFO - 'sessionrestore', 04:14:26 INFO - 'sessionrestore_no_auto_restore']}, 04:14:26 INFO - 'other_nol64': {'tests': ['a11yr', 04:14:26 INFO - 'ts_paint', 04:14:26 INFO - 'tpaint', 04:14:26 INFO - 'sessionrestore', 04:14:26 INFO - 'sessionrestore_no_auto_restore']}, 04:14:26 INFO - 'svgr': {'tests': ['tsvgx', 04:14:26 INFO - 'tsvgr_opacity', 04:14:26 INFO - 'tart', 04:14:26 INFO - 'tscrollx', 04:14:26 INFO - 'cart']}, 04:14:26 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:14:26 INFO - 'tests': ['tsvgx', 04:14:26 INFO - 'tsvgr_opacity', 04:14:26 INFO - 'tart', 04:14:26 INFO - 'tscrollx', 04:14:26 INFO - 'cart']}, 04:14:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:26 INFO - 'tests': ['tp5o']}, 04:14:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:26 INFO - 'talos_options': ['--e10s'], 04:14:26 INFO - 'tests': ['tp5o']}, 04:14:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:26 INFO - 'talos_options': ['--xperf_path', 04:14:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:14:26 INFO - 'tests': ['tp5n']}, 04:14:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:26 INFO - 'talos_options': ['--e10s', 04:14:26 INFO - '--xperf_path', 04:14:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:14:26 INFO - 'tests': ['tp5n']}}, 04:14:26 INFO - 'talos.zip': {'path': '', 04:14:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:14:26 INFO - Running post-action listener: _resource_record_post_action 04:14:26 INFO - ##### 04:14:26 INFO - ##### Running create-virtualenv step. 04:14:26 INFO - ##### 04:14:26 INFO - Running pre-action listener: _resource_record_pre_action 04:14:26 INFO - Running main action method: create_virtualenv 04:14:26 INFO - Creating virtualenv /builds/slave/test/build/venv 04:14:26 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:14:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:14:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:14:26 INFO - Using real prefix '/usr' 04:14:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:14:27 INFO - Installing distribute.............................................................................................................................................................................................done. 04:14:29 INFO - Installing pip.................done. 04:14:29 INFO - Return code: 0 04:14:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:29 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 0x7fb0c353df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2e0b0>, '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 0x2b2efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2f440>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1450700054.407183-1411039578', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:14:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:14:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:14:29 INFO - Using env: {'DISPLAY': ':0', 04:14:29 INFO - 'HOME': '/home/cltbld', 04:14:29 INFO - 'LANG': 'en_US.UTF-8', 04:14:29 INFO - 'LANGUAGE': 'en_US:en', 04:14:29 INFO - 'LOGNAME': 'cltbld', 04:14:29 INFO - 'MAIL': '/var/mail/cltbld', 04:14:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:29 INFO - 'MOZ_NO_REMOTE': '1', 04:14:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:29 INFO - 'NO_EM_RESTART': '1', 04:14:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:29 INFO - 'PWD': '/builds/slave/test', 04:14:29 INFO - 'SHELL': '/bin/bash', 04:14:29 INFO - 'SHLVL': '1', 04:14:29 INFO - 'TERM': 'linux', 04:14:29 INFO - 'TMOUT': '86400', 04:14:29 INFO - 'USER': 'cltbld', 04:14:29 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1450700054.407183-1411039578', 04:14:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:29 INFO - '_': '/tools/buildbot/bin/python'} 04:14:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:29 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:14:29 INFO - Cleaning up... 04:14:29 INFO - Return code: 0 04:14:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:29 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 0x7fb0c353df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2e0b0>, '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 0x2b2efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2f440>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1450700054.407183-1411039578', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:14:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:14:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:14:29 INFO - Using env: {'DISPLAY': ':0', 04:14:29 INFO - 'HOME': '/home/cltbld', 04:14:29 INFO - 'LANG': 'en_US.UTF-8', 04:14:29 INFO - 'LANGUAGE': 'en_US:en', 04:14:29 INFO - 'LOGNAME': 'cltbld', 04:14:29 INFO - 'MAIL': '/var/mail/cltbld', 04:14:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:29 INFO - 'MOZ_NO_REMOTE': '1', 04:14:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:29 INFO - 'NO_EM_RESTART': '1', 04:14:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:29 INFO - 'PWD': '/builds/slave/test', 04:14:29 INFO - 'SHELL': '/bin/bash', 04:14:29 INFO - 'SHLVL': '1', 04:14:29 INFO - 'TERM': 'linux', 04:14:29 INFO - 'TMOUT': '86400', 04:14:29 INFO - 'USER': 'cltbld', 04:14:29 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1450700054.407183-1411039578', 04:14:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:29 INFO - '_': '/tools/buildbot/bin/python'} 04:14:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:29 INFO - Downloading/unpacking psutil>=0.7.1 04:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:31 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:14:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:14:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:14:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:14:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:14:31 INFO - Installing collected packages: psutil 04:14:31 INFO - Running setup.py install for psutil 04:14:31 INFO - building 'psutil._psutil_linux' extension 04:14:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:14:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:14:31 INFO - building 'psutil._psutil_posix' extension 04:14:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:14:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:14:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:14:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:14:32 INFO - Successfully installed psutil 04:14:32 INFO - Cleaning up... 04:14:32 INFO - Return code: 0 04:14:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:14:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:32 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 0x7fb0c353df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2e0b0>, '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 0x2b2efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2f440>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1450700054.407183-1411039578', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:14:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:14:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:14:32 INFO - Using env: {'DISPLAY': ':0', 04:14:32 INFO - 'HOME': '/home/cltbld', 04:14:32 INFO - 'LANG': 'en_US.UTF-8', 04:14:32 INFO - 'LANGUAGE': 'en_US:en', 04:14:32 INFO - 'LOGNAME': 'cltbld', 04:14:32 INFO - 'MAIL': '/var/mail/cltbld', 04:14:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:32 INFO - 'MOZ_NO_REMOTE': '1', 04:14:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:32 INFO - 'NO_EM_RESTART': '1', 04:14:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:32 INFO - 'PWD': '/builds/slave/test', 04:14:32 INFO - 'SHELL': '/bin/bash', 04:14:32 INFO - 'SHLVL': '1', 04:14:32 INFO - 'TERM': 'linux', 04:14:32 INFO - 'TMOUT': '86400', 04:14:32 INFO - 'USER': 'cltbld', 04:14:32 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1450700054.407183-1411039578', 04:14:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:32 INFO - '_': '/tools/buildbot/bin/python'} 04:14:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:14:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:14:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:14:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:14:34 INFO - Installing collected packages: mozsystemmonitor 04:14:34 INFO - Running setup.py install for mozsystemmonitor 04:14:34 INFO - Successfully installed mozsystemmonitor 04:14:34 INFO - Cleaning up... 04:14:34 INFO - Return code: 0 04:14:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:34 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 0x7fb0c353df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2e0b0>, '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 0x2b2efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2f440>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1450700054.407183-1411039578', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:14:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:14:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:14:34 INFO - Using env: {'DISPLAY': ':0', 04:14:34 INFO - 'HOME': '/home/cltbld', 04:14:34 INFO - 'LANG': 'en_US.UTF-8', 04:14:34 INFO - 'LANGUAGE': 'en_US:en', 04:14:34 INFO - 'LOGNAME': 'cltbld', 04:14:34 INFO - 'MAIL': '/var/mail/cltbld', 04:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:34 INFO - 'MOZ_NO_REMOTE': '1', 04:14:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:34 INFO - 'NO_EM_RESTART': '1', 04:14:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:34 INFO - 'PWD': '/builds/slave/test', 04:14:34 INFO - 'SHELL': '/bin/bash', 04:14:34 INFO - 'SHLVL': '1', 04:14:34 INFO - 'TERM': 'linux', 04:14:34 INFO - 'TMOUT': '86400', 04:14:34 INFO - 'USER': 'cltbld', 04:14:34 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1450700054.407183-1411039578', 04:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:34 INFO - '_': '/tools/buildbot/bin/python'} 04:14:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:34 INFO - Downloading/unpacking blobuploader==1.2.4 04:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:36 INFO - Downloading blobuploader-1.2.4.tar.gz 04:14:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:14:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:14:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:14:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:14:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:36 INFO - Downloading docopt-0.6.1.tar.gz 04:14:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:14:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:14:36 INFO - Installing collected packages: blobuploader, requests, docopt 04:14:36 INFO - Running setup.py install for blobuploader 04:14:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:14:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:14:36 INFO - Running setup.py install for requests 04:14:37 INFO - Running setup.py install for docopt 04:14:37 INFO - Successfully installed blobuploader requests docopt 04:14:37 INFO - Cleaning up... 04:14:37 INFO - Return code: 0 04:14:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:37 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 0x7fb0c353df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2e0b0>, '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 0x2b2efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2f440>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1450700054.407183-1411039578', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:14:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:14:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:14:37 INFO - Using env: {'DISPLAY': ':0', 04:14:37 INFO - 'HOME': '/home/cltbld', 04:14:37 INFO - 'LANG': 'en_US.UTF-8', 04:14:37 INFO - 'LANGUAGE': 'en_US:en', 04:14:37 INFO - 'LOGNAME': 'cltbld', 04:14:37 INFO - 'MAIL': '/var/mail/cltbld', 04:14:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:37 INFO - 'MOZ_NO_REMOTE': '1', 04:14:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:37 INFO - 'NO_EM_RESTART': '1', 04:14:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:37 INFO - 'PWD': '/builds/slave/test', 04:14:37 INFO - 'SHELL': '/bin/bash', 04:14:37 INFO - 'SHLVL': '1', 04:14:37 INFO - 'TERM': 'linux', 04:14:37 INFO - 'TMOUT': '86400', 04:14:37 INFO - 'USER': 'cltbld', 04:14:37 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1450700054.407183-1411039578', 04:14:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:37 INFO - '_': '/tools/buildbot/bin/python'} 04:14:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:14:37 INFO - Running setup.py (path:/tmp/pip-eJWF3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:14:37 INFO - Running setup.py (path:/tmp/pip-yafx35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:14:37 INFO - Running setup.py (path:/tmp/pip-O3kWuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:14:37 INFO - Running setup.py (path:/tmp/pip-wUzeFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:14:37 INFO - Running setup.py (path:/tmp/pip-KipM14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:14:37 INFO - Running setup.py (path:/tmp/pip-eJ2A_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:14:38 INFO - Running setup.py (path:/tmp/pip-8lYzKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:14:38 INFO - Running setup.py (path:/tmp/pip-xRq6t8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:14:38 INFO - Running setup.py (path:/tmp/pip-1aq__2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:14:38 INFO - Running setup.py (path:/tmp/pip-6n8_yG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:14:38 INFO - Running setup.py (path:/tmp/pip-aaQ2nh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:14:38 INFO - Running setup.py (path:/tmp/pip-UEb25O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:14:38 INFO - Running setup.py (path:/tmp/pip-vcac4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:14:38 INFO - Running setup.py (path:/tmp/pip-Y7KSSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:38 INFO - Running setup.py (path:/tmp/pip-xMdnAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:14:38 INFO - Running setup.py (path:/tmp/pip-hlkouO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:14:38 INFO - Running setup.py (path:/tmp/pip-Kq_l1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:14:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:14:38 INFO - Running setup.py install for manifestparser 04:14:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:14:38 INFO - Running setup.py install for mozcrash 04:14:39 INFO - Running setup.py install for mozdebug 04:14:39 INFO - Running setup.py install for mozdevice 04:14:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:14:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:14:39 INFO - Running setup.py install for mozfile 04:14:39 INFO - Running setup.py install for mozhttpd 04:14:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:14:39 INFO - Running setup.py install for mozinfo 04:14:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:14:39 INFO - Running setup.py install for mozInstall 04:14:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:14:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:14:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:14:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:14:39 INFO - Running setup.py install for mozleak 04:14:39 INFO - Running setup.py install for mozlog 04:14:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:14:39 INFO - Running setup.py install for moznetwork 04:14:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:14:39 INFO - Running setup.py install for mozprocess 04:14:40 INFO - Running setup.py install for mozprofile 04:14:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:14:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:14:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:14:40 INFO - Running setup.py install for mozrunner 04:14:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:14:40 INFO - Running setup.py install for mozscreenshot 04:14:40 INFO - Running setup.py install for moztest 04:14:40 INFO - Running setup.py install for mozversion 04:14:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:14:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:14:40 INFO - Cleaning up... 04:14:40 INFO - Return code: 0 04:14:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7fb0c353df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2e0b0>, '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 0x2b2efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2f440>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1450700054.407183-1411039578', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:14:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:14:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:14:40 INFO - Using env: {'DISPLAY': ':0', 04:14:40 INFO - 'HOME': '/home/cltbld', 04:14:40 INFO - 'LANG': 'en_US.UTF-8', 04:14:40 INFO - 'LANGUAGE': 'en_US:en', 04:14:40 INFO - 'LOGNAME': 'cltbld', 04:14:40 INFO - 'MAIL': '/var/mail/cltbld', 04:14:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:40 INFO - 'MOZ_NO_REMOTE': '1', 04:14:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:40 INFO - 'NO_EM_RESTART': '1', 04:14:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:40 INFO - 'PWD': '/builds/slave/test', 04:14:40 INFO - 'SHELL': '/bin/bash', 04:14:40 INFO - 'SHLVL': '1', 04:14:40 INFO - 'TERM': 'linux', 04:14:40 INFO - 'TMOUT': '86400', 04:14:40 INFO - 'USER': 'cltbld', 04:14:40 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1450700054.407183-1411039578', 04:14:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:40 INFO - '_': '/tools/buildbot/bin/python'} 04:14:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:14:40 INFO - Running setup.py (path:/tmp/pip-eBverA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:14:40 INFO - Running setup.py (path:/tmp/pip-VnD_hZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:14:40 INFO - Running setup.py (path:/tmp/pip-KHLteK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:14:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:14:41 INFO - Running setup.py (path:/tmp/pip-G_jWnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:14:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:14:41 INFO - Running setup.py (path:/tmp/pip-2ulblw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:14:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:14:41 INFO - Running setup.py (path:/tmp/pip-XL1uwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:14:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:14:41 INFO - Running setup.py (path:/tmp/pip-RLVTJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:14:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:14:41 INFO - Running setup.py (path:/tmp/pip-nnyCeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:14:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:14:41 INFO - Running setup.py (path:/tmp/pip-_y9DCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:14:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:14:41 INFO - Running setup.py (path:/tmp/pip-NB93uQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:14:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:14:41 INFO - Running setup.py (path:/tmp/pip-SnGnRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:14:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:14:41 INFO - Running setup.py (path:/tmp/pip-dyOxt3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:14:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:14:41 INFO - Running setup.py (path:/tmp/pip-p6p0vc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:14:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:14:41 INFO - Running setup.py (path:/tmp/pip-6hnLkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:14:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:41 INFO - Running setup.py (path:/tmp/pip-bOLJQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:14:41 INFO - Running setup.py (path:/tmp/pip-wdmF0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:14:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:14:41 INFO - Running setup.py (path:/tmp/pip-Pfu340-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:14:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:43 INFO - Downloading blessings-1.5.1.tar.gz 04:14:43 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 04:14:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:14:43 INFO - Installing collected packages: blessings 04:14:43 INFO - Running setup.py install for blessings 04:14:43 INFO - Successfully installed blessings 04:14:43 INFO - Cleaning up... 04:14:43 INFO - Return code: 0 04:14:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:14:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:14:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:14:44 INFO - Reading from file tmpfile_stdout 04:14:44 INFO - Current package versions: 04:14:44 INFO - argparse == 1.2.1 04:14:44 INFO - blessings == 1.5.1 04:14:44 INFO - blobuploader == 1.2.4 04:14:44 INFO - docopt == 0.6.1 04:14:44 INFO - manifestparser == 1.1 04:14:44 INFO - mozInstall == 1.12 04:14:44 INFO - mozcrash == 0.16 04:14:44 INFO - mozdebug == 0.1 04:14:44 INFO - mozdevice == 0.47 04:14:44 INFO - mozfile == 1.2 04:14:44 INFO - mozhttpd == 0.7 04:14:44 INFO - mozinfo == 0.9 04:14:44 INFO - mozleak == 0.1 04:14:44 INFO - mozlog == 3.1 04:14:44 INFO - moznetwork == 0.27 04:14:44 INFO - mozprocess == 0.22 04:14:44 INFO - mozprofile == 0.27 04:14:44 INFO - mozrunner == 6.11 04:14:44 INFO - mozscreenshot == 0.1 04:14:44 INFO - mozsystemmonitor == 0.0 04:14:44 INFO - moztest == 0.7 04:14:44 INFO - mozversion == 1.4 04:14:44 INFO - psutil == 3.1.1 04:14:44 INFO - requests == 1.2.3 04:14:44 INFO - wsgiref == 0.1.2 04:14:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7fb0c353df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2e0b0>, '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 0x2b2efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2f440>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1450700054.407183-1411039578', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:14:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:14:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:14:44 INFO - Using env: {'DISPLAY': ':0', 04:14:44 INFO - 'HOME': '/home/cltbld', 04:14:44 INFO - 'LANG': 'en_US.UTF-8', 04:14:44 INFO - 'LANGUAGE': 'en_US:en', 04:14:44 INFO - 'LOGNAME': 'cltbld', 04:14:44 INFO - 'MAIL': '/var/mail/cltbld', 04:14:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:44 INFO - 'MOZ_NO_REMOTE': '1', 04:14:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:44 INFO - 'NO_EM_RESTART': '1', 04:14:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:44 INFO - 'PWD': '/builds/slave/test', 04:14:44 INFO - 'SHELL': '/bin/bash', 04:14:44 INFO - 'SHLVL': '1', 04:14:44 INFO - 'TERM': 'linux', 04:14:44 INFO - 'TMOUT': '86400', 04:14:44 INFO - 'USER': 'cltbld', 04:14:44 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1450700054.407183-1411039578', 04:14:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:44 INFO - '_': '/tools/buildbot/bin/python'} 04:14:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:14:44 INFO - Cleaning up... 04:14:44 INFO - Return code: 0 04:14:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0c353df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2e0b0>, '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 0x2b2efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2f440>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1450700054.407183-1411039578', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:14:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:14:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:14:44 INFO - Using env: {'DISPLAY': ':0', 04:14:44 INFO - 'HOME': '/home/cltbld', 04:14:44 INFO - 'LANG': 'en_US.UTF-8', 04:14:44 INFO - 'LANGUAGE': 'en_US:en', 04:14:44 INFO - 'LOGNAME': 'cltbld', 04:14:44 INFO - 'MAIL': '/var/mail/cltbld', 04:14:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:44 INFO - 'MOZ_NO_REMOTE': '1', 04:14:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:44 INFO - 'NO_EM_RESTART': '1', 04:14:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:44 INFO - 'PWD': '/builds/slave/test', 04:14:44 INFO - 'SHELL': '/bin/bash', 04:14:44 INFO - 'SHLVL': '1', 04:14:44 INFO - 'TERM': 'linux', 04:14:44 INFO - 'TMOUT': '86400', 04:14:44 INFO - 'USER': 'cltbld', 04:14:44 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1450700054.407183-1411039578', 04:14:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:44 INFO - '_': '/tools/buildbot/bin/python'} 04:14:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:44 INFO - Downloading/unpacking jsonschema 04:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:14:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 04:14:46 INFO - Downloading/unpacking functools32 (from jsonschema) 04:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:46 INFO - Downloading functools32-3.2.3-2.tar.gz 04:14:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:14:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:14:46 INFO - warning: no files found matching '*.txt' 04:14:46 INFO - no previously-included directories found matching 'build' 04:14:46 INFO - no previously-included directories found matching 'dist' 04:14:46 INFO - no previously-included directories found matching '.git*' 04:14:46 INFO - Installing collected packages: jsonschema, functools32 04:14:46 INFO - Running setup.py install for functools32 04:14:46 INFO - warning: no files found matching '*.txt' 04:14:46 INFO - no previously-included directories found matching 'build' 04:14:46 INFO - no previously-included directories found matching 'dist' 04:14:46 INFO - no previously-included directories found matching '.git*' 04:14:46 INFO - Successfully installed jsonschema functools32 04:14:46 INFO - Cleaning up... 04:14:46 INFO - Return code: 0 04:14:46 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0c353df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2e0b0>, '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 0x2b2efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2f440>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1450700054.407183-1411039578', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:14:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:14:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:14:46 INFO - Using env: {'DISPLAY': ':0', 04:14:46 INFO - 'HOME': '/home/cltbld', 04:14:46 INFO - 'LANG': 'en_US.UTF-8', 04:14:46 INFO - 'LANGUAGE': 'en_US:en', 04:14:46 INFO - 'LOGNAME': 'cltbld', 04:14:46 INFO - 'MAIL': '/var/mail/cltbld', 04:14:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:46 INFO - 'MOZ_NO_REMOTE': '1', 04:14:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:46 INFO - 'NO_EM_RESTART': '1', 04:14:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:46 INFO - 'PWD': '/builds/slave/test', 04:14:46 INFO - 'SHELL': '/bin/bash', 04:14:46 INFO - 'SHLVL': '1', 04:14:46 INFO - 'TERM': 'linux', 04:14:46 INFO - 'TMOUT': '86400', 04:14:46 INFO - 'USER': 'cltbld', 04:14:46 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1450700054.407183-1411039578', 04:14:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:46 INFO - '_': '/tools/buildbot/bin/python'} 04:14:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:46 INFO - Downloading/unpacking flake8 04:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:14:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 04:14:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:14:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 04:14:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 04:14:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:14:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:14:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:14:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:14:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:14:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:14:49 INFO - no previously-included directories found matching 'docs/_build' 04:14:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:14:49 INFO - Running setup.py install for pep8 04:14:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:14:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:14:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:14:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:14:49 INFO - no previously-included directories found matching 'docs/_build' 04:14:49 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:14:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:14:49 INFO - Cleaning up... 04:14:49 INFO - Return code: 0 04:14:49 INFO - Running post-action listener: _resource_record_post_action 04:14:49 INFO - Running post-action listener: _start_resource_monitoring 04:14:49 INFO - Starting resource monitoring. 04:14:49 INFO - ##### 04:14:49 INFO - ##### Running install step. 04:14:49 INFO - ##### 04:14:49 INFO - Running pre-action listener: _resource_record_pre_action 04:14:49 INFO - Running main action method: install 04:14:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:14:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:14:49 INFO - Reading from file tmpfile_stdout 04:14:49 INFO - Detecting whether we're running mozinstall >=1.0... 04:14:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:14:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:14:49 INFO - Reading from file tmpfile_stdout 04:14:49 INFO - Output received: 04:14:49 INFO - Usage: mozinstall [options] installer 04:14:49 INFO - Options: 04:14:49 INFO - -h, --help show this help message and exit 04:14:49 INFO - -d DEST, --destination=DEST 04:14:49 INFO - Directory to install application into. [default: 04:14:49 INFO - "/builds/slave/test"] 04:14:49 INFO - --app=APP Application being installed. [default: firefox] 04:14:49 INFO - mkdir: /builds/slave/test/build/application 04:14:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:14:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:15:05 INFO - Reading from file tmpfile_stdout 04:15:05 INFO - Output received: 04:15:05 INFO - /builds/slave/test/build/application/firefox/firefox 04:15:05 INFO - Running post-action listener: _resource_record_post_action 04:15:05 INFO - ##### 04:15:05 INFO - ##### Running run-tests step. 04:15:05 INFO - ##### 04:15:05 INFO - Running pre-action listener: _resource_record_pre_action 04:15:05 INFO - Running main action method: run_tests 04:15:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:15:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:15:05 INFO - Python 2.7.3 04:15:05 INFO - Return code: 0 04:15:05 INFO - grabbing minidump binary from tooltool 04:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:05 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 0x2b2e0b0>, '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 0x2b2efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2f440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:15:05 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:15:05 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:15:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:15:05 INFO - Return code: 0 04:15:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:15:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:15:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:15:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:15:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:15:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:15:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:15:06 INFO - Return code: 0 04:15:06 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/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost'] in /builds/slave/test/build 04:15:06 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/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --webServer localhost 04:15:06 INFO - Using env: {'DISPLAY': ':0', 04:15:06 INFO - 'HOME': '/home/cltbld', 04:15:06 INFO - 'LANG': 'en_US.UTF-8', 04:15:06 INFO - 'LANGUAGE': 'en_US:en', 04:15:06 INFO - 'LOGNAME': 'cltbld', 04:15:06 INFO - 'MAIL': '/var/mail/cltbld', 04:15:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:15:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:15:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:06 INFO - 'MOZ_NO_REMOTE': '1', 04:15:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:15:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:15:06 INFO - 'NO_EM_RESTART': '1', 04:15:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:15:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:06 INFO - 'PWD': '/builds/slave/test', 04:15:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:15:06 INFO - 'SHELL': '/bin/bash', 04:15:06 INFO - 'SHLVL': '1', 04:15:06 INFO - 'TERM': 'linux', 04:15:06 INFO - 'TMOUT': '86400', 04:15:06 INFO - 'USER': 'cltbld', 04:15:06 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1450700054.407183-1411039578', 04:15:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:06 INFO - '_': '/tools/buildbot/bin/python'} 04:15:06 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/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost'] with output_timeout 3600 04:15:06 INFO - mozversion INFO | application_buildid: 20151221025128 04:15:06 INFO - mozversion INFO | application_changeset: 091d6785608297bab2cf36b1b6a2d9a388b82a01 04:15:06 INFO - mozversion INFO | application_display_name: Nightly 04:15:06 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:15:06 INFO - mozversion INFO | application_name: Firefox 04:15:06 INFO - mozversion INFO | application_remotingname: firefox 04:15:06 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 04:15:06 INFO - mozversion INFO | application_vendor: Mozilla 04:15:06 INFO - mozversion INFO | application_version: 46.0a1 04:15:06 INFO - mozversion INFO | platform_buildid: 20151221025128 04:15:06 INFO - mozversion INFO | platform_changeset: 091d6785608297bab2cf36b1b6a2d9a388b82a01 04:15:06 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 04:15:06 INFO - mozversion INFO | platform_version: 46.0a1 04:15:06 INFO - 2015-12-21 04:15:06,501 DEBUG : using testdate: 1450700106 04:15:06 INFO - 2015-12-21 04:15:06,501 DEBUG : actual date: 1450700106 04:15:06 INFO - 2015-12-21 04:15:06,509 INFO : starting webserver on 'localhost:51881' 04:15:06 INFO - 2015-12-21 04:15:06,510 INFO : Starting test suite talos-linux64-ix-009 04:15:06 INFO - 2015-12-21 04:15:06,510 INFO : Starting test dromaeo_css 04:15:06 INFO - 2015-12-21 04:15:06,510 DEBUG : operating with platform_type : linux_ 04:15:06 INFO - 2015-12-21 04:15:06,511 INFO : Initialising browser for dromaeo_css test... 04:15:06 INFO - 2015-12-21 04:15:06,527 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmNtulp/profile http://localhost:51881/getInfo.html 04:15:10 INFO - 2015-12-21 04:15:10,611 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 04:15:10 INFO - 2015-12-21 04:15:10,614 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:15:10 INFO - 2015-12-21 04:15:10,614 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:15:10 INFO - 2015-12-21 04:15:10,614 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:15:10 INFO - 2015-12-21 04:15:10,615 DEBUG : BROWSER_OUTPUT: __metrics 04:15:10 INFO - 2015-12-21 04:15:10,736 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:15:10 INFO - 2015-12-21 04:15:10,796 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:15:11 INFO - 2015-12-21 04:15:11,847 INFO : Browser initialized. 04:15:11 INFO - 2015-12-21 04:15:11,847 INFO : Running cycle 1/1 for dromaeo_css test... 04:15:11 INFO - 2015-12-21 04:15:11,847 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmNtulp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:15:23 INFO - 2015-12-21 04:15:23,846 DEBUG : BROWSER_OUTPUT: RSS: Main: 149463040 04:15:23 INFO - 2015-12-21 04:15:23,846 DEBUG : BROWSER_OUTPUT: 04:16:15 INFO - 2015-12-21 04:16:15,015 DEBUG : BROWSER_OUTPUT: 1450700175014 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:18:26 INFO - 2015-12-21 04:18:26,942 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51881/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51881/tests/dromaeo/cssquery-ext.html) 04:18:28 INFO - 2015-12-21 04:18:28,039 DEBUG : BROWSER_OUTPUT: RSS: Main: 249995264 04:18:28 INFO - 2015-12-21 04:18:28,039 DEBUG : BROWSER_OUTPUT: 04:21:30 INFO - 2015-12-21 04:21:30,536 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51881/tests/dromaeo/cssquery-ext.html (next: http://localhost:51881/tests/dromaeo/cssquery-jquery.html) 04:21:31 INFO - 2015-12-21 04:21:31,110 DEBUG : BROWSER_OUTPUT: RSS: Main: 219684864 04:21:31 INFO - 2015-12-21 04:21:31,110 DEBUG : BROWSER_OUTPUT: 04:24:33 INFO - 2015-12-21 04:24:33,218 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51881/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51881/tests/dromaeo/cssquery-mootools.html) 04:24:33 INFO - 2015-12-21 04:24:33,786 DEBUG : BROWSER_OUTPUT: RSS: Main: 228823040 04:24:33 INFO - 2015-12-21 04:24:33,786 DEBUG : BROWSER_OUTPUT: 04:27:35 INFO - 2015-12-21 04:27:35,817 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51881/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51881/tests/dromaeo/cssquery-prototype.html) 04:27:36 INFO - 2015-12-21 04:27:36,399 DEBUG : BROWSER_OUTPUT: RSS: Main: 210890752 04:27:36 INFO - 2015-12-21 04:27:36,399 DEBUG : BROWSER_OUTPUT: 04:30:39 INFO - 2015-12-21 04:30:39,202 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51881/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51881/tests/dromaeo/cssquery-yui.html) 04:30:39 INFO - 2015-12-21 04:30:39,796 DEBUG : BROWSER_OUTPUT: RSS: Main: 214323200 04:30:39 INFO - 2015-12-21 04:30:39,796 DEBUG : BROWSER_OUTPUT: 04:33:42 INFO - 2015-12-21 04:33:42,235 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51881/tests/dromaeo/cssquery-yui.html (next: http://localhost:51881/tests/dromaeo/cssquery-dojo.html) 04:33:42 INFO - 2015-12-21 04:33:42,485 DEBUG : BROWSER_OUTPUT: RSS: Main: 268255232 04:33:42 INFO - 2015-12-21 04:33:42,485 DEBUG : BROWSER_OUTPUT: 04:33:42 INFO - 2015-12-21 04:33:42,486 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:33:42 INFO - 2015-12-21 04:33:42,487 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:33:42 INFO - 2015-12-21 04:33:42,487 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:33:42 INFO - 2015-12-21 04:33:42,487 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:33:42 INFO - 2015-12-21 04:33:42,488 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2544.300317412711;2611.255792099252;2621.0957219759175;2638.841669499829;2639.0895141176297;4245.681573881956;4352.107817897331;4414.713043652165;4435.233366632374;4446.955530444695;4354.608085272325;4379.321205213189;4430.822767089313;4460.375547423363;4492.550744925506;4068.532118806331;4070.71504994649;4110.732802367844;4184.581541845806;4219.303814870558;3954.110325176841;4143.627073563379;4187.497500299953;4203.033302340464;4204.2432362174795;4027.65764909983;4038.7374820636564;4046.5751096134777;4119.773412462313;4150.896227594304;4158.459400277975;4171.040660648037;4182.832686692529;4191;4222.91554168918;4161.334186530141;4164.83340666373;4176.540580536169;4180.728252663597;4213.052063285767;4199.328107502815;4306.655467562588;4326.329418940069;4329.112531930947;4405.691601587891;4734.502877197879;4746.240601503778;4747.287906813971;4752.691075080109;4802.375691160127;4767.070421267854;4767.284907263938;4770.117528257283;4771.33201351811;4808.831690890802;4239.40648309237;4312.676549258756;4353.717008394444;4359.760213188241;4403.295472724349;4882.633802464758;4889.046635905964;4899.4365647950945;4907.2393778964315;4950.232713929347;4700.2244629635725;4714.858554243378;4733.242681170997;4733.786979585927;4763.73799441034;4557.065801510682;4677.906441871211;4679.251319788817;4713.29300604912;4842.322074909515;4796;4797.136515427187;4807.663463557587;4809.470958194595;4852.611791056707;4768.856934291907;4778.187708089633;4778.880527986758;4779.06808172403;4827.058723548875;3836.827342769582;3922.0391004203584;3922.4116382542275;3929.4302326162547;3948.0919388540797;3536.876209332661;3540.7698499597445;3577.749557531;3578.1233597768714;3583.695385892176;4136.689748268892;4149.792510374469;4149.792510374469;4154.044569748975;4185.748855068706;4609.677322587454;4680.765961701969;4720.95279047212;4794.760261986887;4837.298591704183;4054.2904991626347;4083.673306135502;4111.506619205715;4136.8138433770555;4146.813393397304;4279.251131052116;4280.443542339476;4284.293091639907;4316.2446571849805;4322.459692538433;4275.337322714984;4373.278409062596;4550.954490455053;4551.817927282872;4590.747508887043;4694.694844835075;4725.267583524559;4757.833475828329;4779.426468823764;4818.71087734737;4554.635629149594;4568.611668008257;4570.177368073646;4572.1312950539295;4607.861764147081;4478.395416618715;4576.199165146153;4751.548602882721;4757.09615173116;4798.616110711065;4658.440987081436;4676.251799712029;4722;4738.05238952204;4779.617630589475;4596.4024676791805;4597.540245975376;4607.746573938465;4647.930281045719;4661.137689527448;4410.470743510799;4529.139463502056;4605.148047611203;4609.838655647036;4661.230896901973;4452.510223875436;4459.710118842265;4512.706674066307;4520.118576877478;4578.038611891407;4658.161530924466;4660.370849935351;4673.369095172108;4680.4149481314835;4697.906041879211;4298.226319262562;4422.314541246112;4569.2689169732685;4571.245744452128;4609.331646911246 04:33:42 INFO - 2015-12-21 04:33:42,490 DEBUG : BROWSER_OUTPUT: |1;ext.html;548.6735392441498;565.0281515792838;567.6735876870798;569.4078158714935;575.056906673056;27092.593611095825;27619.447611047766;35022.649773502286;35609.2878142437;35621.46567801485;39357.409638855366;39929.600703992954;39947.80026099872;39951.40072898909;40034.799826000904;7037.155541335022;7895.921040789591;8077.515349079044;8079.474834135792;8079.798005049892;7130.786076417689;7234.3489085982255;7239;7239.565626062426;10243.43661098643;10053.145482633985;10152.289339746221;10154.339967902062;10172.18622510201;10178.643747468841;10127.442990635513;10156.746081347952;10181.592736290539;10217.13154381871;10241.948790256076;7211.314925082109;7383.778486645409;7387.7783666490095;7396.852062958765;7399.6670149843385;40143.19713605712;40745.592544074476;40800.18399632021;40802.38796418056;40842;2870.6124673169065;2877.5827505011657;2882.409106133259;2887.927801804951;2891.407261511406;27697.723022769715;27862;27914.860425697945;28156.577651335247;28214.435711285863;3384.245888786334;3432.6567343265724;3511.17487390463;3579.0515513388973;3585.085803120188;214001;214745;214760.99999999843;214914;215013.99999999843;54846.72576637091;55113;55174.724126379915;55213;55305.72347138319;59222.40777592169;59269;59394.703026485455;59454;59578;12967.481300748053;13294.867051329364;13307.334633268298;13308.866911330762;13391.732165356638;9877.654282100091;10052.045055719695;10075.34510256831;10086.344387614781;10112.949435252776;18858.71711924322;18888.71666924997;19169.520761980784;19259;19260.20726994606;7026.894596581055;7166.247544007804;7246.565206087652;7296.658488199513;7352.19125896151;854.1373213054735;892.2014796756866;913.48388160689;983.680303901235;995.3878364805737;26175.214743557724;26180.73819261821;26420.20739377822;26439.603405948925;26561.203163905113;864.9112393569585;933.6265493802533;951.177231694593;969.3214749675255;996.9202463802878;12450.128491005542;12658.556950506689;14009.229492377814;14299.428022878968;14519.92740036293;256453;257880;259041;260643;261855;45233.321500177524;45329.546704532535;45455;45468.3179752304;45469.545304547195;1186.549111337686;1187.192708957917;1190.7975644140517;1193.8925496705338;1198.3528894397102;25079.24762257135;26174.214773556825;26797.598036029085;27006.729932701208;27408.862955685094;37355.43966840554;37944.62055379521;37950;37964;37965.43051854169;169414;169640;169821;169975;170069;24502.63246051275;25055.624165637895;27983.720162798112;28844.42311153723;28959.565606516342;33716.83141584276;34009.31981360408;34049.65950340465;34055.148621283675;34431;29269.560956586094;29814.10557683273;29964.250893727833;30172.698273016988;30580.235494111934;25041.624375634015;29121.563176552794;29422.411551769274;31225.84387078141;32707.836460817543;29937.251568710086;30167.245818854703;30239.546406804355;30391;30441.39117217599;27941;28500.42999139964;28973.855130724212;28994.13017609475;29426.411471770873;22945.31164065081;23687.1709490167;23801.88099059563;23816.285511434686;25329.62005569881 04:33:42 INFO - 2015-12-21 04:33:42,491 DEBUG : BROWSER_OUTPUT: |2;jquery.html;319.5606041692674;325.5296097139634;327.34530938123754;333.76302824994247;336.337415291875;12571.874281257185;13007.674808129801;15624;16002.759958600616;16148;9483.810323793537;9556.661558199095;9583;10516.316439431432;10662.147028237741;4497.595216430513;4633.559811817872;4645.9303110453375;4648.72107673539;4649.39557857478;3530;4600.654950878681;4644.2801365788355;5314.149736042234;5328.813491527797;5264.39459462161;5279.208118782194;5282.339707536558;5289.68261904285;5303.787848486056;5117.232415137722;5270.39390470097;5270.868228294285;5297.7880884764945;5298.284731561248;5137.357830271216;5154.587632989389;5158.329417175781;5164.018836421068;5169.663971841818;13442.798358024638;19315.227390904347;19728.11223494946;19743;19787.50531236716;1784.4468214853307;1865.8600604954547;1905.4950438133906;1908.2271679969635;1928.53715108373;9192.724218273395;9298.349115561914;12154.696132596755;12461.439235234437;12859.42132604035;1758.4109323376556;1761.867859910512;1774.4942691332908;1829.871908966373;1859.302761464451;53670.463295366935;56284.718576407264;56468.435315646726;56610.15084773731;57358.426415735725;9753.65862194834;9869.555869985868;9910.603575857029;9911.900880991241;9964.950175249078;12503.187292825936;12544.184627999151;12544.184627999151;12550;12551.811722824164;6541.967290163519;6602.801915942529;6752.76365327221;6775.864482710318;6790.5925644461495;6063.393660633989;6083.209182806207;6115.205023346936;6143.477804386677;6284.591501552384;4154.750714957112;4211.43145675336;4223.387608796707;4239.97880010598;4246.171996460661;1596.8243493215737;1661.6178278995658;1673.6569003354527;1679.4541773923524;1698.9745153822703;776.8329809091073;800.8558459477233;859.0164261920191;999.7800483893532;1007.4559737741685;12212.694682632828;15168.31742571587;15335.769963450557;16284.67430651404;16376.099314537814;818.4557269415891;825.4387016828614;836.4395854777192;848.5969164646743;890.0298674444886;8744.213020828156;9078.682246121354;9227.215686666708;9353.23777352916;9444.386114902509;510410;513560;515472;539207;539327;72055;72110;73479.63260183665;73534.26465735381;74890.62554687192;1070.8875568065396;1071.6624263357019;1102.2229328323513;1128;1130.8416821644976;14376.05290915339;14512.637184070483;14581.562553123424;14596.854031459974;14680;33712;34070.48894266637;34300.31399372048;34555.65444345625;34978.825105874304;45487.54512454833;45772.7711361441;47390.76304618455;47813.28280075871;48179.518204817505;8781.780455488664;8899.510526921082;8926.25937942095;8942.239909607757;9051.637934482547;10641.414722190353;10709.410982395731;10751.946240268748;10780.676579702622;12815.871841281469;13171.934140329236;13392.732145357233;13416.262105584286;13587.86412135866;13937.90931360304;12820;12882.871171288542;12941.223526588436;13569.86430135686;13617;10857.67426977192;12323.44544495482;12688.365581721062;13796.655083622989;14073.859261407255;8952.462852228888;9074;9174.862377064215;9281.62873485053;9297.581608827755;13810.240436776074;13857;14036.78944815808;14382.496612618508;14461.13233205969 04:33:42 INFO - 2015-12-21 04:33:42,492 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1387.2924808347739;1656.411973749319;1692.8222536633652;1721.7675613792135;1722.664080504302;5878.941210587893;7015.789526314206;7179.138503379589;7182.604956727378;7196.172440169382;7106.822329441767;7271.836506159016;7273.6363181840825;7294.6352682365805;7303.342699157075;1644.1532610705497;1688.3246701319508;2041.1937284772505;2074.0459388681224;2084.7289852319254;2061.7525896892394;2092.801183887528;2095.140992193201;2095.863768855027;2098.150249149097;2081.989590052048;2093.089506064859;2114.1332053857923;2126.2983215538834;2126.8830214338204;2017.1023894367013;2038.7757346691778;2041.4488088216174;2052.2098991888083;2096.968545471819;2075.8546901716886;2081.2195426714984;2095.9476013099643;2097.4966008158085;2098.328534868843;7092.326229008236;7114.288571142896;7150.320719531636;7160.928390716078;7170.175429825533;4134.73124246923;4207.810648520824;4212.873613791591;4215.5362910080175;4235.49174099107;2630.0663264541195;2693.851838148901;2695.17797071893;2696.0833316672424;2712.22701530063;888.3603805260202;893.4594570284949;902.8104098139398;910.1080940678106;911.1753862754218;9569.856452153223;9675.12923836851;9676.75808104796;9686.225101991824;9717.222622190207;3824.349860523718;3834.884953451401;3872.341701910682;3887.2031233597045;3909.550401703784;8445.1977062179;8449.873251901226;8452.915470845335;8463.66145354179;8477.70328038528;4282.143571285693;4290.420793192879;4303.031817840961;4305.246581848164;4317.568243175658;3903.1998440319667;3905.6875449963936;3912.941305880414;3926.5288165420334;3929.980350098231;2910.4761142994466;2926.8536573171255;3408.9829550852583;3461.9653803461642;3541.8406171722336;1107.5071593141136;1124.2074337591978;1131.1685910855515;1132.5752842683994;1137.3289759042204;954.4654993203828;1086.961941373862;1104.6741211342674;1106.2090605217309;1157.0916830288184;6660.234073081658;6676.699548520328;6716.764913228111;6722.495812814059;6742.426893713991;583.9795607153729;720.2941117704679;1093.6445655162104;1115.726646971481;1128.497818470789;5382.1119515280325;5424.62027658068;5427.104527752956;5436.592255580847;5449.373322067933;8271.793205169919;8304.169583041648;8512.574371281411;8514.063453020162;8518.105598912149;8467.195616416431;8477.872831907527;8506.064332923374;8523.445976011539;8530.701425450203;6110.663913484801;6228.595141315709;6800.897986530206;6811.080504131978;6829.214640316427;6660.333966603301;6719.294474080151;6750.459963202834;6755.594664320157;6756;7639.121501027231;7726.690932362642;7848.097468791162;7869.134395216407;7913.643886025027;7901.249381308767;8035.799105022421;8094.554799486084;8120.431569790294;8126.106128325998;6090.786822461193;6366.29970703213;6368.140301059483;6442.903356449563;6461.741530338733;5690.8008219713765;5900.203472531325;6704.7988560343265;6821.386075253251;6823.420009299265;6419.101325814483;6421.967890160519;6517.608943463218;6632.038354438676;6651.833704157435;6291.02489114188;6334.809955701337;6390.90413643805;6421.325760795049;6467.805965821033;6365.840853978688;6396.296407395276;6404.135441715309;6411.71147298382;6411.775587854403;5861.325947515919;5892.469677728854;5897.203877476486;5904.468597826216;5906.26171728534;5949.583529152917;5976.731047102978;6061.7575296987625;6094.939050609437;6098.420650038239 04:33:42 INFO - 2015-12-21 04:33:42,492 DEBUG : BROWSER_OUTPUT: |4;prototype.html;295.44308977577265;300.0697836706211;300.50866832728497;304.108960745017;305.4562878077024;5214.791408343671;5230.2416149658275;5319.760610772515;5390.568754499641;5391.406945236021;5188.221766734991;5290.418054014065;5293.550048245894;5296.523312901838;5301.549368303698;3858.575556688762;4072.490938632671;4079.4492743479695;4082.8979275518054;4084.448599439082;3969.940450893239;3974.105826189113;4043.8786836394956;4046.6155715207155;4052.7365721228175;3987.7806720630356;4005.299072662287;4042.1107356381694;4044.8179831907637;4049.615286547788;3763.849446022156;3869.1681288522823;3934.5081864766903;4034.3948407738926;4049.129437171008;3506.68439840413;3536.0275924120815;3540.415831387818;3548.4677298405186;3550.378683730337;5000.624953128494;5024.497550244982;5025.221090730943;5030.220315851049;5032.270320803463;4629.444466663988;4642.65180111493;4644.210484217691;4650.18621741194;4651.511591282934;5287.101192797234;5489.8471321022635;5499.3675727291475;5506.229127922094;5508.586855985777;3803.6386543278345;3803.7527560708463;3804.90487737806;3806.7715937043868;3810.657040866335;5700.914486282709;5791;5793.246877905845;5793.710314484259;5797.043487824504;3897.7661340319673;3902.941455878164;3905.2384784966657;3906.667933225651;3907.238088572701;3953.2686453006286;3955.1496428267487;3963.2271707016853;3963.2667956428154;3964.1278918637854;4454.420925279693;4602.815887364535;4603.861884143481;4604.033153037833;4604.30935359692;5508.3114610673665;5516.310461192351;5516.862078448071;5518.061929471999;5524.917126243109;1388.3821699343896;1413.039133389305;1413.4275618374575;1414.0172580056762;1414.1091112598997;930.1210356213313;941.0401390581568;942.4345392764286;965.8647789309503;968.9922480620218;4846.8788280292565;4853.4418541867435;4860.270959356125;4861.392325959255;4866.683665561727;5671.773129074873;5688.943110568841;5697.487226149667;5709.400512946081;5713.428657134254;4856.490068542752;4861.392325959255;4862.489438608965;4863.076015557032;4866.31871537985;2820.1116648256143;2905.5932169496286;3040.3919216156414;3074.1546074829603;3074.508078707396;5315.73421328932;5437.293151890229;5440.591955603267;5453.3455985281225;5453.590980676465;5915.792947246826;5920.111983202468;5922.230110085661;5926.733297001645;5927.73325200367;5419.214213939035;5431.755570999315;5437.646552974044;5443.972780136074;5455.0453670607485;5497.697626630574;5642.351129620146;5712.171735098304;5714.628549144292;5725.969325521446;5607.355154157324;5613.635113717595;5614.101743720985;5617.634853734658;5621.184928185308;5423.701696406735;5430;5431.429699881455;5431.456854314695;5441;3926.8232929518813;3965.960340396559;3968.7817170055923;3973.92052158961;3977.3636218206107;5609.831705048855;5729.598928074995;5731.283589551306;5732.16883551891;5733.31200255972;5521.806736764194;5537.778488860562;5540.944590554042;5543.057680194457;5544.861378465409;5526.668399896019;5527.695976721319;5536.557075434036;5541.473560011793;5542.916856247079;5269.71016594091;5406.135018397038;5408.675479471244;5408.972955135199;5413.458654134555;5556.249906262603;5558.305211848519;5566.109422492544;5566.721663916869;5571.66570005801;5209;5285.418603953485;5364.624476286623;5396.379416367011;5423.7830486780085 04:33:42 INFO - 2015-12-21 04:33:42,493 DEBUG : BROWSER_OUTPUT: |5;yui.html;647.4852492268648;668.218184723873;669.8727241824052;772.8686123359029;799.0970203669852;10973.890261097396;11213.66359009231;11303.773924521505;11313;11320.264182828121;11427.942860285708;11526.942365288183;11530;11544.422778861044;13862.584122476343;781.0744268042359;781.3436713160944;781.7029528779055;785.579714852554;785.787837283933;768.9038870141233;770.9421793365492;771.8649236383638;778.3150827272021;790.5375355417087;805.2189376305004;812.0134037144868;813.0203105258149;817.7587611654546;829.3116713128119;805.556943680979;805.5931754464017;806.8668669669556;811.1969150540951;829.2495291760936;601.2904772368603;602.6414283501354;602.9879402411971;611.3153268339488;616.0113018605119;11141.610043648434;11277.32336059839;11281.49233284496;11282.323060616389;11288.040516556102;10215.94892025535;10322.741931451774;10715.892841071567;11029.83455248172;11293.491792869258;8932.240759535447;8988.910110898938;9006.729798106067;9379.5310234488;9646.276529260263;3149.4960806271115;3177.8728850845937;3180.872765089394;3195.440797860365;3200.1679563313705;35176.47235291472;35645;38307.61692383096;39132.60867391318;41136;8813.162749538784;8905.554722263862;8912.955435222782;8924.509151996574;8985.146411090936;15721.921390392974;15728.92135539315;15749.921250393674;15799.36802527886;15813;6111.144439778434;6271.529635277372;6293.1504246927;6436.967815160894;6501.86217411951;3222.4038552867796;3381.6956473916975;3487.4071407860724;3565.4651802229873;3631.7094632429344;2549.5410826051116;2568.987155064213;2576.1241177999195;2583.7416258374014;2583.7416258374387;455.28747510146513;455.44435788338177;458.2621978614428;458.6949678463851;459.7586267209742;487.36885732975884;554.8030449190479;556.716074801854;571.4599703280443;597.7818096394784;7509.211532789088;7606.695732170651;7632.19861914491;7638.694452221849;7721.112072111667;441.0913518152616;539.9578812891158;568.4770011589347;576.6770608459192;581.3111462916457;3610.2418492116426;3648;3690.704743620504;3802.6767724743154;3909.980450097788;45301.773491132335;45540.772296138966;45802;46163;46204.53795462002;41321.96695082647;41824;41902;42051.36922946158;42200.15599687989;34307.14232144217;36654.8167259162;37930;38960.99999999943;39108.217835643125;6331.240251169889;7272.381847543018;7544.547327160388;7814.492058016211;7891.84216315682;27254.318642034108;28577.28556786097;28649.140525783427;28653.14040578786;29306;34024;34103.658963410046;34490.82754586211;34644.653553464144;34656;9216.2626989842;9612.1829644481;9761.804763904824;9952.950235248778;10118.13995810335;10579.471026448493;10581.206409519164;10591.4704264788;10627.36235825853;10666.83999739989;9468.526573671426;9836.311458197857;9934.900650993397;10084.949575252076;10128.34165779222;10297.588096476056;10312.432816195182;10356.689299321033;10371.377717336984;10387.94806025965;8526.957365213382;8843.027267000496;9675.951620241854;9987.800243995225;10044.296899216984;9076.09239076087;9088.454692718458;9213.401128926598;9506;9510.239180865376;8648.394612377073;8881.289496840109;8893.599788009684;8967.282617390463;9035.683751068682 04:33:42 INFO - 2015-12-21 04:33:42,493 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:33:42 INFO - 2015-12-21 04:33:42,494 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:33:42 INFO - 2015-12-21 04:33:42,494 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,906 04:33:42 INFO - 2015-12-21 04:33:42,494 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:33:42 INFO - 2015-12-21 04:33:42,494 DEBUG : BROWSER_OUTPUT: __startTimestamp1450701222485__endTimestamp 04:33:42 INFO - 2015-12-21 04:33:42,494 DEBUG : BROWSER_OUTPUT: 04:33:42 INFO - 2015-12-21 04:33:42,494 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:33:42 INFO - 2015-12-21 04:33:42,494 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:33:42 INFO - 2015-12-21 04:33:42,494 DEBUG : BROWSER_OUTPUT: 04:33:42 INFO - 2015-12-21 04:33:42,494 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4395.10 Median:4492.55 stddev:442.19 (9.8%) stddev-sans-first:419.03 04:33:42 INFO - 2015-12-21 04:33:42,494 DEBUG : BROWSER_OUTPUT: Values: 2544.3 2611.3 2621.1 2638.8 2639.1 4245.7 4352.1 4414.7 4435.2 4447.0 4354.6 4379.3 4430.8 4460.4 4492.6 4068.5 4070.7 4110.7 4184.6 4219.3 3954.1 4143.6 4187.5 4203.0 4204.2 4027.7 4038.7 4046.6 4119.8 4150.9 4158.5 4171.0 4182.8 4191.0 4222.9 4161.3 4164.8 4176.5 4180.7 4213.1 4199.3 4306.7 4326.3 4329.1 4405.7 4734.5 4746.2 4747.3 4752.7 4802.4 4767.1 4767.3 4770.1 4771.3 4808.8 4239.4 4312.7 4353.7 4359.8 4403.3 4882.6 4889.0 4899.4 4907.2 4950.2 4700.2 4714.9 4733.2 4733.8 4763.7 4557.1 4677.9 4679.3 4713.3 4842.3 4796.0 4797.1 4807.7 4809.5 4852.6 4768.9 4778.2 4778.9 4779.1 4827.1 3836.8 3922.0 3922.4 3929.4 3948.1 3536.9 3540.8 3577.7 3578.1 3583.7 4136.7 4149.8 4149.8 4154.0 4185.7 4609.7 4680.8 4721.0 4794.8 4837.3 4054.3 4083.7 4111.5 4136.8 4146.8 4279.3 4280.4 4284.3 4316.2 4322.5 4275.3 4373.3 4551.0 4551.8 4590.7 4694.7 4725.3 4757.8 4779.4 4818.7 4554.6 4568.6 4570.2 4572.1 4607.9 4478.4 4576.2 4751.5 4757.1 4798.6 4658.4 4676.3 4722.0 4738.1 4779.6 4596.4 4597.5 4607.7 4647.9 4661.1 4410.5 4529.1 4605.1 4609.8 4661.2 4452.5 4459.7 4512.7 4520.1 4578.0 4658.2 4660.4 4673.4 4680.4 4697.9 4298.2 4422.3 4569.3 4571.2 4609.3 04:33:42 INFO - 2015-12-21 04:33:42,494 DEBUG : BROWSER_OUTPUT: 04:33:42 INFO - 2015-12-21 04:33:42,494 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:37637.28 Median:29620.26 stddev:56652.31 (191.3%) stddev-sans-first:56742.79 04:33:42 INFO - 2015-12-21 04:33:42,496 DEBUG : BROWSER_OUTPUT: Values: 548.7 565.0 567.7 569.4 575.1 27092.6 27619.4 35022.6 35609.3 35621.5 39357.4 39929.6 39947.8 39951.4 40034.8 7037.2 7895.9 8077.5 8079.5 8079.8 7130.8 7234.3 7239.0 7239.6 10243.4 10053.1 10152.3 10154.3 10172.2 10178.6 10127.4 10156.7 10181.6 10217.1 10241.9 7211.3 7383.8 7387.8 7396.9 7399.7 40143.2 40745.6 40800.2 40802.4 40842.0 2870.6 2877.6 2882.4 2887.9 2891.4 27697.7 27862.0 27914.9 28156.6 28214.4 3384.2 3432.7 3511.2 3579.1 3585.1 214001.0 214745.0 214761.0 214914.0 215014.0 54846.7 55113.0 55174.7 55213.0 55305.7 59222.4 59269.0 59394.7 59454.0 59578.0 12967.5 13294.9 13307.3 13308.9 13391.7 9877.7 10052.0 10075.3 10086.3 10112.9 18858.7 18888.7 19169.5 19259.0 19260.2 7026.9 7166.2 7246.6 7296.7 7352.2 854.1 892.2 913.5 983.7 995.4 26175.2 26180.7 26420.2 26439.6 26561.2 864.9 933.6 951.2 969.3 996.9 12450.1 12658.6 14009.2 14299.4 14519.9 256453.0 257880.0 259041.0 260643.0 261855.0 45233.3 45329.5 45455.0 45468.3 45469.5 1186.5 1187.2 1190.8 1193.9 1198.4 25079.2 26174.2 26797.6 27006.7 27408.9 37355.4 37944.6 37950.0 37964.0 37965.4 169414.0 169640.0 169821.0 169975.0 170069.0 24502.6 25055.6 27983.7 28844.4 28959.6 33716.8 34009.3 34049.7 34055.1 34431.0 29269.6 29814.1 29964.3 30172.7 30580.2 25041.6 29121.6 29422.4 31225.8 32707.8 29937.3 30167.2 30239.5 30391.0 30441.4 27941.0 28500.4 28973.9 28994.1 29426.4 22945.3 23687.2 23801.9 23816.3 25329.6 04:33:42 INFO - 2015-12-21 04:33:42,496 DEBUG : BROWSER_OUTPUT: 04:33:42 INFO - 2015-12-21 04:33:42,496 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27301.66 Median:4243.08 stddev:85578.82 (2016.9%) stddev-sans-first:85794.90 04:33:42 INFO - 2015-12-21 04:33:42,496 DEBUG : BROWSER_OUTPUT: Values: 319.6 325.5 327.3 333.8 336.3 12571.9 13007.7 15624.0 16002.8 16148.0 9483.8 9556.7 9583.0 10516.3 10662.1 4497.6 4633.6 4645.9 4648.7 4649.4 3530.0 4600.7 4644.3 5314.1 5328.8 5264.4 5279.2 5282.3 5289.7 5303.8 5117.2 5270.4 5270.9 5297.8 5298.3 5137.4 5154.6 5158.3 5164.0 5169.7 13442.8 19315.2 19728.1 19743.0 19787.5 1784.4 1865.9 1905.5 1908.2 1928.5 9192.7 9298.3 12154.7 12461.4 12859.4 1758.4 1761.9 1774.5 1829.9 1859.3 53670.5 56284.7 56468.4 56610.2 57358.4 9753.7 9869.6 9910.6 9911.9 9965.0 12503.2 12544.2 12544.2 12550.0 12551.8 6542.0 6602.8 6752.8 6775.9 6790.6 6063.4 6083.2 6115.2 6143.5 6284.6 4154.8 4211.4 4223.4 4240.0 4246.2 1596.8 1661.6 1673.7 1679.5 1699.0 776.8 800.9 859.0 999.8 1007.5 12212.7 15168.3 15335.8 16284.7 16376.1 818.5 825.4 836.4 848.6 890.0 8744.2 9078.7 9227.2 9353.2 9444.4 510410.0 513560.0 515472.0 539207.0 539327.0 72055.0 72110.0 73479.6 73534.3 74890.6 1070.9 1071.7 1102.2 1128.0 1130.8 14376.1 14512.6 14581.6 14596.9 14680.0 33712.0 34070.5 34300.3 34555.7 34978.8 45487.5 45772.8 47390.8 47813.3 48179.5 8781.8 8899.5 8926.3 8942.2 9051.6 10641.4 10709.4 10751.9 10780.7 12815.9 13171.9 13392.7 13416.3 13587.9 13937.9 12820.0 12882.9 12941.2 13569.9 13617.0 10857.7 12323.4 12688.4 13796.7 14073.9 8952.5 9074.0 9174.9 9281.6 9297.6 13810.2 13857.0 14036.8 14382.5 14461.1 04:33:42 INFO - 2015-12-21 04:33:42,496 DEBUG : BROWSER_OUTPUT: 04:33:42 INFO - 2015-12-21 04:33:42,496 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4991.63 Median:6096.68 stddev:2588.59 (42.5%) stddev-sans-first:2581.68 04:33:42 INFO - 2015-12-21 04:33:42,496 DEBUG : BROWSER_OUTPUT: Values: 1387.3 1656.4 1692.8 1721.8 1722.7 5878.9 7015.8 7179.1 7182.6 7196.2 7106.8 7271.8 7273.6 7294.6 7303.3 1644.2 1688.3 2041.2 2074.0 2084.7 2061.8 2092.8 2095.1 2095.9 2098.2 2082.0 2093.1 2114.1 2126.3 2126.9 2017.1 2038.8 2041.4 2052.2 2097.0 2075.9 2081.2 2095.9 2097.5 2098.3 7092.3 7114.3 7150.3 7160.9 7170.2 4134.7 4207.8 4212.9 4215.5 4235.5 2630.1 2693.9 2695.2 2696.1 2712.2 888.4 893.5 902.8 910.1 911.2 9569.9 9675.1 9676.8 9686.2 9717.2 3824.3 3834.9 3872.3 3887.2 3909.6 8445.2 8449.9 8452.9 8463.7 8477.7 4282.1 4290.4 4303.0 4305.2 4317.6 3903.2 3905.7 3912.9 3926.5 3930.0 2910.5 2926.9 3409.0 3462.0 3541.8 1107.5 1124.2 1131.2 1132.6 1137.3 954.5 1087.0 1104.7 1106.2 1157.1 6660.2 6676.7 6716.8 6722.5 6742.4 584.0 720.3 1093.6 1115.7 1128.5 5382.1 5424.6 5427.1 5436.6 5449.4 8271.8 8304.2 8512.6 8514.1 8518.1 8467.2 8477.9 8506.1 8523.4 8530.7 6110.7 6228.6 6800.9 6811.1 6829.2 6660.3 6719.3 6750.5 6755.6 6756.0 7639.1 7726.7 7848.1 7869.1 7913.6 7901.2 8035.8 8094.6 8120.4 8126.1 6090.8 6366.3 6368.1 6442.9 6461.7 5690.8 5900.2 6704.8 6821.4 6823.4 6419.1 6422.0 6517.6 6632.0 6651.8 6291.0 6334.8 6390.9 6421.3 6467.8 6365.8 6396.3 6404.1 6411.7 6411.8 5861.3 5892.5 5897.2 5904.5 5906.3 5949.6 5976.7 6061.8 6094.9 6098.4 04:33:42 INFO - 2015-12-21 04:33:42,496 DEBUG : BROWSER_OUTPUT: 04:33:42 INFO - 2015-12-21 04:33:42,496 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4565.44 Median:5286.26 stddev:1353.61 (25.6%) stddev-sans-first:1318.92 04:33:42 INFO - 2015-12-21 04:33:42,497 DEBUG : BROWSER_OUTPUT: Values: 295.4 300.1 300.5 304.1 305.5 5214.8 5230.2 5319.8 5390.6 5391.4 5188.2 5290.4 5293.6 5296.5 5301.5 3858.6 4072.5 4079.4 4082.9 4084.4 3969.9 3974.1 4043.9 4046.6 4052.7 3987.8 4005.3 4042.1 4044.8 4049.6 3763.8 3869.2 3934.5 4034.4 4049.1 3506.7 3536.0 3540.4 3548.5 3550.4 5000.6 5024.5 5025.2 5030.2 5032.3 4629.4 4642.7 4644.2 4650.2 4651.5 5287.1 5489.8 5499.4 5506.2 5508.6 3803.6 3803.8 3804.9 3806.8 3810.7 5700.9 5791.0 5793.2 5793.7 5797.0 3897.8 3902.9 3905.2 3906.7 3907.2 3953.3 3955.1 3963.2 3963.3 3964.1 4454.4 4602.8 4603.9 4604.0 4604.3 5508.3 5516.3 5516.9 5518.1 5524.9 1388.4 1413.0 1413.4 1414.0 1414.1 930.1 941.0 942.4 965.9 969.0 4846.9 4853.4 4860.3 4861.4 4866.7 5671.8 5688.9 5697.5 5709.4 5713.4 4856.5 4861.4 4862.5 4863.1 4866.3 2820.1 2905.6 3040.4 3074.2 3074.5 5315.7 5437.3 5440.6 5453.3 5453.6 5915.8 5920.1 5922.2 5926.7 5927.7 5419.2 5431.8 5437.6 5444.0 5455.0 5497.7 5642.4 5712.2 5714.6 5726.0 5607.4 5613.6 5614.1 5617.6 5621.2 5423.7 5430.0 5431.4 5431.5 5441.0 3926.8 3966.0 3968.8 3973.9 3977.4 5609.8 5729.6 5731.3 5732.2 5733.3 5521.8 5537.8 5540.9 5543.1 5544.9 5526.7 5527.7 5536.6 5541.5 5542.9 5269.7 5406.1 5408.7 5409.0 5413.5 5556.2 5558.3 5566.1 5566.7 5571.7 5209.0 5285.4 5364.6 5396.4 5423.8 04:33:42 INFO - 2015-12-21 04:33:42,498 DEBUG : BROWSER_OUTPUT: 04:33:42 INFO - 2015-12-21 04:33:42,498 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11480.93 Median:23130.35 stddev:12652.42 (54.7%) stddev-sans-first:12661.75 04:33:42 INFO - 2015-12-21 04:33:42,499 DEBUG : BROWSER_OUTPUT: Values: 647.5 668.2 669.9 772.9 799.1 10973.9 11213.7 11303.8 11313.0 11320.3 11427.9 11526.9 11530.0 11544.4 13862.6 781.1 781.3 781.7 785.6 785.8 768.9 770.9 771.9 778.3 790.5 805.2 812.0 813.0 817.8 829.3 805.6 805.6 806.9 811.2 829.2 601.3 602.6 603.0 611.3 616.0 11141.6 11277.3 11281.5 11282.3 11288.0 10215.9 10322.7 10715.9 11029.8 11293.5 8932.2 8988.9 9006.7 9379.5 9646.3 3149.5 3177.9 3180.9 3195.4 3200.2 35176.5 35645.0 38307.6 39132.6 41136.0 8813.2 8905.6 8913.0 8924.5 8985.1 15721.9 15728.9 15749.9 15799.4 15813.0 6111.1 6271.5 6293.2 6437.0 6501.9 3222.4 3381.7 3487.4 3565.5 3631.7 2549.5 2569.0 2576.1 2583.7 2583.7 455.3 455.4 458.3 458.7 459.8 487.4 554.8 556.7 571.5 597.8 7509.2 7606.7 7632.2 7638.7 7721.1 441.1 540.0 568.5 576.7 581.3 3610.2 3648.0 3690.7 3802.7 3910.0 45301.8 45540.8 45802.0 46163.0 46204.5 41322.0 41824.0 41902.0 42051.4 42200.2 34307.1 36654.8 37930.0 38961.0 39108.2 6331.2 7272.4 7544.5 7814.5 7891.8 27254.3 28577.3 28649.1 28653.1 29306.0 34024.0 34103.7 34490.8 34644.7 34656.0 9216.3 9612.2 9761.8 9953.0 10118.1 10579.5 10581.2 10591.5 10627.4 10666.8 9468.5 9836.3 9934.9 10084.9 10128.3 10297.6 10312.4 10356.7 10371.4 10387.9 8527.0 8843.0 9676.0 9987.8 10044.3 9076.1 9088.5 9213.4 9506.0 9510.2 8648.4 8881.3 8893.6 8967.3 9035.7 04:33:42 INFO - 2015-12-21 04:33:42,499 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:33:42 INFO - 2015-12-21 04:33:42,499 DEBUG : BROWSER_OUTPUT: 04:33:43 INFO - 2015-12-21 04:33:43,221 INFO : Browser exited with error code: 0 04:33:43 INFO - 2015-12-21 04:33:43,239 INFO : Completed test dromaeo_css (00:18:36) 04:33:43 INFO - 2015-12-21 04:33:43,240 INFO : Starting test kraken 04:33:43 INFO - 2015-12-21 04:33:43,240 DEBUG : operating with platform_type : linux_ 04:33:43 INFO - 2015-12-21 04:33:43,240 INFO : Initialising browser for kraken test... 04:33:43 INFO - 2015-12-21 04:33:43,246 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGln8Ej/profile http://localhost:51881/getInfo.html 04:33:47 INFO - 2015-12-21 04:33:47,090 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 04:33:47 INFO - 2015-12-21 04:33:47,110 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:33:47 INFO - 2015-12-21 04:33:47,110 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:33:47 INFO - 2015-12-21 04:33:47,110 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:33:47 INFO - 2015-12-21 04:33:47,110 DEBUG : BROWSER_OUTPUT: __metrics 04:33:47 INFO - 2015-12-21 04:33:47,211 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:33:47 INFO - 2015-12-21 04:33:47,267 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:33:48 INFO - 2015-12-21 04:33:48,258 INFO : Browser initialized. 04:33:48 INFO - 2015-12-21 04:33:48,259 INFO : Running cycle 1/1 for kraken test... 04:33:48 INFO - 2015-12-21 04:33:48,259 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGln8Ej/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:34:00 INFO - 2015-12-21 04:34:00,227 DEBUG : BROWSER_OUTPUT: RSS: Main: 149696512 04:34:00 INFO - 2015-12-21 04:34:00,228 DEBUG : BROWSER_OUTPUT: 04:34:02 INFO - 2015-12-21 04:34:02,802 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51881/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51881/tests/kraken/driver.html?testName=audio-beat-detection) 04:34:03 INFO - 2015-12-21 04:34:03,383 DEBUG : BROWSER_OUTPUT: RSS: Main: 183652352 04:34:03 INFO - 2015-12-21 04:34:03,384 DEBUG : BROWSER_OUTPUT: 04:34:06 INFO - 2015-12-21 04:34:06,126 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51881/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51881/tests/kraken/driver.html?testName=audio-dft) 04:34:06 INFO - 2015-12-21 04:34:06,695 DEBUG : BROWSER_OUTPUT: RSS: Main: 175828992 04:34:06 INFO - 2015-12-21 04:34:06,695 DEBUG : BROWSER_OUTPUT: 04:34:09 INFO - 2015-12-21 04:34:09,695 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51881/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51881/tests/kraken/driver.html?testName=audio-fft) 04:34:10 INFO - 2015-12-21 04:34:10,264 DEBUG : BROWSER_OUTPUT: RSS: Main: 161460224 04:34:10 INFO - 2015-12-21 04:34:10,264 DEBUG : BROWSER_OUTPUT: 04:34:12 INFO - 2015-12-21 04:34:12,297 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51881/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51881/tests/kraken/driver.html?testName=audio-oscillator) 04:34:12 INFO - 2015-12-21 04:34:12,870 DEBUG : BROWSER_OUTPUT: RSS: Main: 162959360 04:34:12 INFO - 2015-12-21 04:34:12,870 DEBUG : BROWSER_OUTPUT: 04:34:15 INFO - 2015-12-21 04:34:15,123 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51881/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51881/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:34:15 INFO - 2015-12-21 04:34:15,685 DEBUG : BROWSER_OUTPUT: RSS: Main: 164716544 04:34:15 INFO - 2015-12-21 04:34:15,685 DEBUG : BROWSER_OUTPUT: 04:34:18 INFO - 2015-12-21 04:34:18,656 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51881/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51881/tests/kraken/driver.html?testName=imaging-darkroom) 04:34:19 INFO - 2015-12-21 04:34:19,242 DEBUG : BROWSER_OUTPUT: RSS: Main: 165150720 04:34:19 INFO - 2015-12-21 04:34:19,243 DEBUG : BROWSER_OUTPUT: 04:34:22 INFO - 2015-12-21 04:34:22,644 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51881/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51881/tests/kraken/driver.html?testName=imaging-desaturate) 04:34:23 INFO - 2015-12-21 04:34:23,225 DEBUG : BROWSER_OUTPUT: RSS: Main: 165830656 04:34:23 INFO - 2015-12-21 04:34:23,225 DEBUG : BROWSER_OUTPUT: 04:34:26 INFO - 2015-12-21 04:34:26,057 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51881/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51881/tests/kraken/driver.html?testName=json-parse-financial) 04:34:26 INFO - 2015-12-21 04:34:26,638 DEBUG : BROWSER_OUTPUT: RSS: Main: 164753408 04:34:26 INFO - 2015-12-21 04:34:26,638 DEBUG : BROWSER_OUTPUT: 04:34:28 INFO - 2015-12-21 04:34:28,407 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51881/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51881/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:34:28 INFO - 2015-12-21 04:34:28,976 DEBUG : BROWSER_OUTPUT: RSS: Main: 175865856 04:34:28 INFO - 2015-12-21 04:34:28,977 DEBUG : BROWSER_OUTPUT: 04:34:30 INFO - 2015-12-21 04:34:30,875 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51881/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51881/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:34:31 INFO - 2015-12-21 04:34:31,477 DEBUG : BROWSER_OUTPUT: RSS: Main: 175067136 04:34:31 INFO - 2015-12-21 04:34:31,477 DEBUG : BROWSER_OUTPUT: 04:34:33 INFO - 2015-12-21 04:34:33,601 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51881/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51881/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:34:34 INFO - 2015-12-21 04:34:34,183 DEBUG : BROWSER_OUTPUT: RSS: Main: 186462208 04:34:34 INFO - 2015-12-21 04:34:34,183 DEBUG : BROWSER_OUTPUT: 04:34:36 INFO - 2015-12-21 04:34:36,698 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51881/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51881/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:34:37 INFO - 2015-12-21 04:34:37,284 DEBUG : BROWSER_OUTPUT: RSS: Main: 193056768 04:34:37 INFO - 2015-12-21 04:34:37,284 DEBUG : BROWSER_OUTPUT: 04:34:39 INFO - 2015-12-21 04:34:39,798 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51881/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51881/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:34:40 INFO - 2015-12-21 04:34:40,371 DEBUG : BROWSER_OUTPUT: RSS: Main: 186998784 04:34:40 INFO - 2015-12-21 04:34:40,372 DEBUG : BROWSER_OUTPUT: 04:34:42 INFO - 2015-12-21 04:34:42,127 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51881/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51881/tests/kraken/driver.html?testName=ai-astar) 04:34:42 INFO - 2015-12-21 04:34:42,386 DEBUG : BROWSER_OUTPUT: RSS: Main: 244449280 04:34:42 INFO - 2015-12-21 04:34:42,386 DEBUG : BROWSER_OUTPUT: 04:34:42 INFO - 2015-12-21 04:34:42,386 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:34:42 INFO - 2015-12-21 04:34:42,386 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:34:42 INFO - 2015-12-21 04:34:42,386 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:34:42 INFO - 2015-12-21 04:34:42,387 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:34:42 INFO - 2015-12-21 04:34:42,387 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;113;107;111;111;112;103;112;112;103 04:34:42 INFO - 2015-12-21 04:34:42,387 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;162;128;152;172;142;151;151;130;167;129 04:34:42 INFO - 2015-12-21 04:34:42,387 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;160;160;161;163;161;161;162;163;161 04:34:42 INFO - 2015-12-21 04:34:42,387 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;88;89;72;72;72;96;90;73 04:34:42 INFO - 2015-12-21 04:34:42,388 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;132;94;95;94;145;94;95;130 04:34:42 INFO - 2015-12-21 04:34:42,388 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;110;110;109;110;109;110;109 04:34:42 INFO - 2015-12-21 04:34:42,388 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;147;147;147;147;145;147;146;146 04:34:42 INFO - 2015-12-21 04:34:42,388 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;96;95;96;95;95;95;95;95 04:34:42 INFO - 2015-12-21 04:34:42,389 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;70;71;71;71;72;71;72;79;69;69 04:34:42 INFO - 2015-12-21 04:34:42,389 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;70;69;69;69;69;69;69;69;68 04:34:42 INFO - 2015-12-21 04:34:42,389 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;91;86;85;87;83;85;84;91;84;82 04:34:42 INFO - 2015-12-21 04:34:42,389 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;124;122;129;122;124;120;120;127;127 04:34:42 INFO - 2015-12-21 04:34:42,389 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;132;133;149;144;143;131;144;144;142;132 04:34:42 INFO - 2015-12-21 04:34:42,390 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;69;68;69;71;70;71;68;68;68 04:34:42 INFO - 2015-12-21 04:34:42,390 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:34:42 INFO - 2015-12-21 04:34:42,390 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:34:42 INFO - 2015-12-21 04:34:42,390 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,982 04:34:42 INFO - 2015-12-21 04:34:42,391 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:34:42 INFO - 2015-12-21 04:34:42,391 DEBUG : BROWSER_OUTPUT: __startTimestamp1450701282380__endTimestamp 04:34:42 INFO - 2015-12-21 04:34:42,391 DEBUG : BROWSER_OUTPUT: 04:34:42 INFO - 2015-12-21 04:34:42,391 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:34:42 INFO - 2015-12-21 04:34:42,392 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:34:42 INFO - 2015-12-21 04:34:42,392 DEBUG : BROWSER_OUTPUT: 04:34:42 INFO - 2015-12-21 04:34:42,392 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.40 Median:111.50 stddev:3.75 (3.4%) stddev-sans-first:3.97 04:34:42 INFO - 2015-12-21 04:34:42,392 DEBUG : BROWSER_OUTPUT: Values: 110.0 113.0 107.0 111.0 111.0 112.0 103.0 112.0 112.0 103.0 04:34:42 INFO - 2015-12-21 04:34:42,392 DEBUG : BROWSER_OUTPUT: 04:34:42 INFO - 2015-12-21 04:34:42,393 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.40 Median:151.50 stddev:15.94 (10.5%) stddev-sans-first:16.13 04:34:42 INFO - 2015-12-21 04:34:42,393 DEBUG : BROWSER_OUTPUT: Values: 162.0 128.0 152.0 172.0 142.0 151.0 151.0 130.0 167.0 129.0 04:34:42 INFO - 2015-12-21 04:34:42,393 DEBUG : BROWSER_OUTPUT: 04:34:42 INFO - 2015-12-21 04:34:42,394 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:1.14 (0.7%) stddev-sans-first:1.12 04:34:42 INFO - 2015-12-21 04:34:42,394 DEBUG : BROWSER_OUTPUT: Values: 160.0 160.0 160.0 161.0 163.0 161.0 161.0 162.0 163.0 161.0 04:34:42 INFO - 2015-12-21 04:34:42,394 DEBUG : BROWSER_OUTPUT: 04:34:42 INFO - 2015-12-21 04:34:42,394 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.80 Median:80.50 stddev:9.66 (12.0%) stddev-sans-first:9.93 04:34:42 INFO - 2015-12-21 04:34:42,394 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 88.0 89.0 72.0 72.0 72.0 96.0 90.0 73.0 04:34:42 INFO - 2015-12-21 04:34:42,395 DEBUG : BROWSER_OUTPUT: 04:34:42 INFO - 2015-12-21 04:34:42,395 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.90 Median:94.50 stddev:20.22 (21.4%) stddev-sans-first:20.99 04:34:42 INFO - 2015-12-21 04:34:42,395 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 132.0 94.0 95.0 94.0 145.0 94.0 95.0 130.0 04:34:42 INFO - 2015-12-21 04:34:42,395 DEBUG : BROWSER_OUTPUT: 04:34:42 INFO - 2015-12-21 04:34:42,395 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 04:34:42 INFO - 2015-12-21 04:34:42,395 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 110.0 110.0 109.0 110.0 109.0 110.0 109.0 04:34:42 INFO - 2015-12-21 04:34:42,395 DEBUG : BROWSER_OUTPUT: 04:34:42 INFO - 2015-12-21 04:34:42,395 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.71 (0.5%) stddev-sans-first:0.73 04:34:42 INFO - 2015-12-21 04:34:42,395 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 147.0 147.0 147.0 147.0 145.0 147.0 146.0 146.0 04:34:42 INFO - 2015-12-21 04:34:42,395 DEBUG : BROWSER_OUTPUT: 04:34:42 INFO - 2015-12-21 04:34:42,395 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:34:42 INFO - 2015-12-21 04:34:42,396 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 04:34:42 INFO - 2015-12-21 04:34:42,396 DEBUG : BROWSER_OUTPUT: 04:34:42 INFO - 2015-12-21 04:34:42,396 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.50 Median:71.00 stddev:2.84 (4.0%) stddev-sans-first:2.96 04:34:42 INFO - 2015-12-21 04:34:42,396 DEBUG : BROWSER_OUTPUT: Values: 70.0 71.0 71.0 71.0 72.0 71.0 72.0 79.0 69.0 69.0 04:34:42 INFO - 2015-12-21 04:34:42,396 DEBUG : BROWSER_OUTPUT: 04:34:42 INFO - 2015-12-21 04:34:42,396 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:69.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 04:34:42 INFO - 2015-12-21 04:34:42,396 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 69.0 69.0 69.0 69.0 69.0 69.0 69.0 68.0 04:34:42 INFO - 2015-12-21 04:34:42,396 DEBUG : BROWSER_OUTPUT: 04:34:42 INFO - 2015-12-21 04:34:42,396 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:85.50 stddev:3.08 (3.6%) stddev-sans-first:2.64 04:34:42 INFO - 2015-12-21 04:34:42,396 DEBUG : BROWSER_OUTPUT: Values: 91.0 86.0 85.0 87.0 83.0 85.0 84.0 91.0 84.0 82.0 04:34:42 INFO - 2015-12-21 04:34:42,397 DEBUG : BROWSER_OUTPUT: 04:34:42 INFO - 2015-12-21 04:34:42,397 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.70 Median:124.00 stddev:3.09 (2.5%) stddev-sans-first:3.22 04:34:42 INFO - 2015-12-21 04:34:42,397 DEBUG : BROWSER_OUTPUT: Values: 122.0 124.0 122.0 129.0 122.0 124.0 120.0 120.0 127.0 127.0 04:34:42 INFO - 2015-12-21 04:34:42,397 DEBUG : BROWSER_OUTPUT: 04:34:42 INFO - 2015-12-21 04:34:42,397 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.40 Median:143.50 stddev:6.64 (4.6%) stddev-sans-first:6.48 04:34:42 INFO - 2015-12-21 04:34:42,397 DEBUG : BROWSER_OUTPUT: Values: 132.0 133.0 149.0 144.0 143.0 131.0 144.0 144.0 142.0 132.0 04:34:42 INFO - 2015-12-21 04:34:42,397 DEBUG : BROWSER_OUTPUT: 04:34:42 INFO - 2015-12-21 04:34:42,397 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:69.50 stddev:1.51 (2.2%) stddev-sans-first:1.27 04:34:42 INFO - 2015-12-21 04:34:42,397 DEBUG : BROWSER_OUTPUT: Values: 72.0 69.0 68.0 69.0 71.0 70.0 71.0 68.0 68.0 68.0 04:34:42 INFO - 2015-12-21 04:34:42,397 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:34:42 INFO - 2015-12-21 04:34:42,397 DEBUG : BROWSER_OUTPUT: 04:34:43 INFO - 2015-12-21 04:34:43,321 INFO : Browser exited with error code: 0 04:34:43 INFO - 2015-12-21 04:34:43,369 INFO : Completed test kraken (00:01:00) 04:34:43 INFO - 2015-12-21 04:34:43,369 INFO : Starting test v8_7 04:34:43 INFO - 2015-12-21 04:34:43,369 DEBUG : operating with platform_type : linux_ 04:34:43 INFO - 2015-12-21 04:34:43,370 INFO : Initialising browser for v8_7 test... 04:34:43 INFO - 2015-12-21 04:34:43,376 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYRAISC/profile http://localhost:51881/getInfo.html 04:34:47 INFO - 2015-12-21 04:34:47,382 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 04:34:47 INFO - 2015-12-21 04:34:47,417 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:34:47 INFO - 2015-12-21 04:34:47,417 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:34:47 INFO - 2015-12-21 04:34:47,417 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:34:47 INFO - 2015-12-21 04:34:47,418 DEBUG : BROWSER_OUTPUT: __metrics 04:34:47 INFO - 2015-12-21 04:34:47,514 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:34:47 INFO - 2015-12-21 04:34:47,562 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:34:47 ERROR - 2015-12-21 04:34:47,577 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 04:34:48 INFO - 2015-12-21 04:34:48,544 INFO : Browser initialized. 04:34:48 INFO - 2015-12-21 04:34:48,545 INFO : Running cycle 1/1 for v8_7 test... 04:34:48 INFO - 2015-12-21 04:34:48,545 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYRAISC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:35:00 INFO - 2015-12-21 04:35:00,449 DEBUG : BROWSER_OUTPUT: RSS: Main: 149831680 04:35:00 INFO - 2015-12-21 04:35:00,449 DEBUG : BROWSER_OUTPUT: 04:35:21 INFO - 2015-12-21 04:35:21,842 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51881/tests/v8_7/run.html (next: http://localhost:51881/tests/v8_7/run.html) 04:35:22 INFO - 2015-12-21 04:35:22,092 DEBUG : BROWSER_OUTPUT: RSS: Main: 451559424 04:35:22 INFO - 2015-12-21 04:35:22,092 DEBUG : BROWSER_OUTPUT: 04:35:22 INFO - 2015-12-21 04:35:22,092 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:35:22 INFO - 2015-12-21 04:35:22,093 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:35:22 INFO - 2015-12-21 04:35:22,093 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:35:22 INFO - 2015-12-21 04:35:22,093 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:35:22 INFO - 2015-12-21 04:35:22,093 DEBUG : BROWSER_OUTPUT: |0;Richards;165.78249336870027 04:35:22 INFO - 2015-12-21 04:35:22,093 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.70649738610905 04:35:22 INFO - 2015-12-21 04:35:22,094 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.00945232137894 04:35:22 INFO - 2015-12-21 04:35:22,094 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5133.333333333333 04:35:22 INFO - 2015-12-21 04:35:22,094 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1992.03187250996 04:35:22 INFO - 2015-12-21 04:35:22,094 DEBUG : BROWSER_OUTPUT: |5;Earley;784.3137254901961 04:35:22 INFO - 2015-12-21 04:35:22,095 DEBUG : BROWSER_OUTPUT: |6;Boyer;12000 04:35:22 INFO - 2015-12-21 04:35:22,095 DEBUG : BROWSER_OUTPUT: |7;RegExp;27648.64864864865 04:35:22 INFO - 2015-12-21 04:35:22,095 DEBUG : BROWSER_OUTPUT: |8;Splay;600.6006006006006 04:35:22 INFO - 2015-12-21 04:35:22,095 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4850.241545893719 04:35:22 INFO - 2015-12-21 04:35:22,097 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:35:22 INFO - 2015-12-21 04:35:22,097 DEBUG : BROWSER_OUTPUT: __startTimestamp1450701322092__endTimestamp 04:35:22 INFO - 2015-12-21 04:35:22,097 DEBUG : BROWSER_OUTPUT: 04:35:22 INFO - 2015-12-21 04:35:22,097 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:35:22 INFO - 2015-12-21 04:35:22,097 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:35:22 INFO - 2015-12-21 04:35:22,097 DEBUG : BROWSER_OUTPUT: 04:35:22 INFO - 2015-12-21 04:35:22,098 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.78 Median:165.78 stddev:0.00 (0.0%) 04:35:22 INFO - 2015-12-21 04:35:22,098 DEBUG : BROWSER_OUTPUT: Values: 165.8 04:35:22 INFO - 2015-12-21 04:35:22,098 DEBUG : BROWSER_OUTPUT: 04:35:22 INFO - 2015-12-21 04:35:22,098 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.71 Median:186.71 stddev:0.00 (0.0%) 04:35:22 INFO - 2015-12-21 04:35:22,098 DEBUG : BROWSER_OUTPUT: Values: 186.7 04:35:22 INFO - 2015-12-21 04:35:22,098 DEBUG : BROWSER_OUTPUT: 04:35:22 INFO - 2015-12-21 04:35:22,098 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.01 Median:278.01 stddev:0.00 (0.0%) 04:35:22 INFO - 2015-12-21 04:35:22,099 DEBUG : BROWSER_OUTPUT: Values: 278.0 04:35:22 INFO - 2015-12-21 04:35:22,099 DEBUG : BROWSER_OUTPUT: 04:35:22 INFO - 2015-12-21 04:35:22,099 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5133.33 Median:5133.33 stddev:0.00 (0.0%) 04:35:22 INFO - 2015-12-21 04:35:22,099 DEBUG : BROWSER_OUTPUT: Values: 5133.3 04:35:22 INFO - 2015-12-21 04:35:22,099 DEBUG : BROWSER_OUTPUT: 04:35:22 INFO - 2015-12-21 04:35:22,099 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1992.03 Median:1992.03 stddev:0.00 (0.0%) 04:35:22 INFO - 2015-12-21 04:35:22,099 DEBUG : BROWSER_OUTPUT: Values: 1992.0 04:35:22 INFO - 2015-12-21 04:35:22,100 DEBUG : BROWSER_OUTPUT: 04:35:22 INFO - 2015-12-21 04:35:22,100 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:784.31 Median:784.31 stddev:0.00 (0.0%) 04:35:22 INFO - 2015-12-21 04:35:22,100 DEBUG : BROWSER_OUTPUT: Values: 784.3 04:35:22 INFO - 2015-12-21 04:35:22,100 DEBUG : BROWSER_OUTPUT: 04:35:22 INFO - 2015-12-21 04:35:22,100 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12000.00 Median:12000.00 stddev:0.00 (0.0%) 04:35:22 INFO - 2015-12-21 04:35:22,100 DEBUG : BROWSER_OUTPUT: Values: 12000.0 04:35:22 INFO - 2015-12-21 04:35:22,100 DEBUG : BROWSER_OUTPUT: 04:35:22 INFO - 2015-12-21 04:35:22,101 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27648.65 Median:27648.65 stddev:0.00 (0.0%) 04:35:22 INFO - 2015-12-21 04:35:22,101 DEBUG : BROWSER_OUTPUT: Values: 27648.6 04:35:22 INFO - 2015-12-21 04:35:22,101 DEBUG : BROWSER_OUTPUT: 04:35:22 INFO - 2015-12-21 04:35:22,101 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:600.60 Median:600.60 stddev:0.00 (0.0%) 04:35:22 INFO - 2015-12-21 04:35:22,101 DEBUG : BROWSER_OUTPUT: Values: 600.6 04:35:22 INFO - 2015-12-21 04:35:22,101 DEBUG : BROWSER_OUTPUT: 04:35:22 INFO - 2015-12-21 04:35:22,101 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 04:35:22 INFO - 2015-12-21 04:35:22,101 DEBUG : BROWSER_OUTPUT: Values: 4850.2 04:35:22 INFO - 2015-12-21 04:35:22,101 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:35:22 INFO - 2015-12-21 04:35:22,101 DEBUG : BROWSER_OUTPUT: 04:35:23 INFO - 2015-12-21 04:35:23,053 INFO : Browser exited with error code: 0 04:35:23 INFO - 2015-12-21 04:35:23,071 INFO : Completed test v8_7 (00:00:39) 04:35:23 INFO - 2015-12-21 04:35:23,132 INFO : Completed test suite (00:20:16) 04:35:23 INFO - 2015-12-21 04:35:23,132 DEBUG : Working with test: dromaeo_css 04:35:23 INFO - 2015-12-21 04:35:23,132 DEBUG : Generating results file: dromaeo_css 04:35:23 INFO - 2015-12-21 04:35:23,133 DEBUG : Working with test: kraken 04:35:23 INFO - 2015-12-21 04:35:23,133 DEBUG : Generating results file: kraken 04:35:23 INFO - 2015-12-21 04:35:23,134 INFO : javascript benchmark 04:35:23 INFO - 2015-12-21 04:35:23,134 DEBUG : Working with test: v8_7 04:35:23 INFO - 2015-12-21 04:35:23,134 DEBUG : Generating results file: v8_7 04:35:23 INFO - 2015-12-21 04:35:23,134 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:35:23 INFO - 2015-12-21 04:35:23,195 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 04:35:23 INFO - 2015-12-21 04:35:23,195 DEBUG : process_Request line: dromaeo_css 6157.15 graph.html#tests=[[72,94,35]] 04:35:23 INFO - 2015-12-21 04:35:23,196 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:35:23 INFO - 2015-12-21 04:35:23,303 DEBUG : process_Request line: kraken 1515.70 graph.html#tests=[[232,94,35]] 04:35:23 INFO - 2015-12-21 04:35:23,303 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:35:23 INFO - 2015-12-21 04:35:23,408 DEBUG : process_Request line: v8_7 19816.75 graph.html#tests=[[230,94,35]] 04:35:23 INFO - 2015-12-21 04:35:23,410 INFO : javascript benchmark 04:35:23 INFO - 2015-12-21 04:35:23,413 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2544.300317412711, 2611.255792099252, 2621.0957219759175, 2638.841669499829, 2639.0895141176297, 4245.681573881956, 4352.107817897331, 4414.713043652165, 4435.233366632374, 4446.955530444695, 4354.608085272325, 4379.321205213189, 4430.822767089313, 4460.375547423363, 4492.550744925506, 4068.532118806331, 4070.71504994649, 4110.732802367844, 4184.581541845806, 4219.303814870558, 3954.110325176841, 4143.627073563379, 4187.497500299953, 4203.033302340464, 4204.2432362174795, 4027.65764909983, 4038.7374820636564, 4046.5751096134777, 4119.773412462313, 4150.896227594304, 4158.459400277975, 4171.040660648037, 4182.832686692529, 4191.0, 4222.91554168918, 4161.334186530141, 4164.83340666373, 4176.540580536169, 4180.728252663597, 4213.052063285767, 4199.328107502815, 4306.655467562588, 4326.329418940069, 4329.112531930947, 4405.691601587891, 4734.502877197879, 4746.240601503778, 4747.287906813971, 4752.691075080109, 4802.375691160127, 4767.070421267854, 4767.284907263938, 4770.117528257283, 4771.33201351811, 4808.831690890802, 4239.40648309237, 4312.676549258756, 4353.717008394444, 4359.760213188241, 4403.295472724349, 4882.633802464758, 4889.046635905964, 4899.4365647950945, 4907.2393778964315, 4950.232713929347, 4700.2244629635725, 4714.858554243378, 4733.242681170997, 4733.786979585927, 4763.73799441034, 4557.065801510682, 4677.906441871211, 4679.251319788817, 4713.29300604912, 4842.322074909515, 4796.0, 4797.136515427187, 4807.663463557587, 4809.470958194595, 4852.611791056707, 4768.856934291907, 4778.187708089633, 4778.880527986758, 4779.06808172403, 4827.058723548875, 3836.827342769582, 3922.0391004203584, 3922.4116382542275, 3929.4302326162547, 3948.0919388540797, 3536.876209332661, 3540.7698499597445, 3577.749557531, 3578.1233597768714, 3583.695385892176, 4136.689748268892, 4149.792510374469, 4149.792510374469, 4154.044569748975, 4185.748855068706, 4609.677322587454, 4680.765961701969, 4720.95279047212, 4794.760261986887, 4837.298591704183, 4054.2904991626347, 4083.673306135502, 4111.506619205715, 4136.8138433770555, 4146.813393397304, 4279.251131052116, 4280.443542339476, 4284.293091639907, 4316.2446571849805, 4322.459692538433, 4275.337322714984, 4373.278409062596, 4550.954490455053, 4551.817927282872, 4590.747508887043, 4694.694844835075, 4725.267583524559, 4757.833475828329, 4779.426468823764, 4818.71087734737, 4554.635629149594, 4568.611668008257, 4570.177368073646, 4572.1312950539295, 4607.861764147081, 4478.395416618715, 4576.199165146153, 4751.548602882721, 4757.09615173116, 4798.616110711065, 4658.440987081436, 4676.251799712029, 4722.0, 4738.05238952204, 4779.617630589475, 4596.4024676791805, 4597.540245975376, 4607.746573938465, 4647.930281045719, 4661.137689527448, 4410.470743510799, 4529.139463502056, 4605.148047611203, 4609.838655647036, 4661.230896901973, 4452.510223875436, 4459.710118842265, 4512.706674066307, 4520.118576877478, 4578.038611891407, 4658.161530924466, 4660.370849935351, 4673.369095172108, 4680.4149481314835, 4697.906041879211, 4298.226319262562, 4422.314541246112, 4569.2689169732685, 4571.245744452128, 4609.331646911246], "unit": "score", "name": "dojo.html", "value": 4368.963769015449}, {"lowerIsBetter": false, "replicates": [548.6735392441498, 565.0281515792838, 567.6735876870798, 569.4078158714935, 575.056906673056, 27092.593611095825, 27619.447611047766, 35022.649773502286, 35609.2878142437, 35621.46567801485, 39357.409638855366, 39929.600703992954, 39947.80026099872, 39951.40072898909, 40034.799826000904, 7037.155541335022, 7895.921040789591, 8077.515349079044, 8079.474834135792, 8079.798005049892, 7130.786076417689, 7234.3489085982255, 7239.0, 7239.565626062426, 10243.43661098643, 10053.145482633985, 10152.289339746221, 10154.339967902062, 10172.18622510201, 10178.643747468841, 10127.442990635513, 10156.746081347952, 10181.592736290539, 10217.13154381871, 10241.948790256076, 7211.314925082109, 7383.778486645409, 7387.7783666490095, 7396.852062958765, 7399.6670149843385, 40143.19713605712, 40745.592544074476, 40800.18399632021, 40802.38796418056, 40842.0, 2870.6124673169065, 2877.5827505011657, 2882.409106133259, 2887.927801804951, 2891.407261511406, 27697.723022769715, 27862.0, 27914.860425697945, 28156.577651335247, 28214.435711285863, 3384.245888786334, 3432.6567343265724, 3511.17487390463, 3579.0515513388973, 3585.085803120188, 214001.0, 214745.0, 214760.99999999843, 214914.0, 215013.99999999843, 54846.72576637091, 55113.0, 55174.724126379915, 55213.0, 55305.72347138319, 59222.40777592169, 59269.0, 59394.703026485455, 59454.0, 59578.0, 12967.481300748053, 13294.867051329364, 13307.334633268298, 13308.866911330762, 13391.732165356638, 9877.654282100091, 10052.045055719695, 10075.34510256831, 10086.344387614781, 10112.949435252776, 18858.71711924322, 18888.71666924997, 19169.520761980784, 19259.0, 19260.20726994606, 7026.894596581055, 7166.247544007804, 7246.565206087652, 7296.658488199513, 7352.19125896151, 854.1373213054735, 892.2014796756866, 913.48388160689, 983.680303901235, 995.3878364805737, 26175.214743557724, 26180.73819261821, 26420.20739377822, 26439.603405948925, 26561.203163905113, 864.9112393569585, 933.6265493802533, 951.177231694593, 969.3214749675255, 996.9202463802878, 12450.128491005542, 12658.556950506689, 14009.229492377814, 14299.428022878968, 14519.92740036293, 256453.0, 257880.0, 259041.0, 260643.0, 261855.0, 45233.321500177524, 45329.546704532535, 45455.0, 45468.3179752304, 45469.545304547195, 1186.549111337686, 1187.192708957917, 1190.7975644140517, 1193.8925496705338, 1198.3528894397102, 25079.24762257135, 26174.214773556825, 26797.598036029085, 27006.729932701208, 27408.862955685094, 37355.43966840554, 37944.62055379521, 37950.0, 37964.0, 37965.43051854169, 169414.0, 169640.0, 169821.0, 169975.0, 170069.0, 24502.63246051275, 25055.624165637895, 27983.720162798112, 28844.42311153723, 28959.565606516342, 33716.83141584276, 34009.31981360408, 34049.65950340465, 34055.148621283675, 34431.0, 29269.560956586094, 29814.10557683273, 29964.250893727833, 30172.698273016988, 30580.235494111934, 25041.624375634015, 29121.563176552794, 29422.411551769274, 31225.84387078141, 32707.836460817543, 29937.251568710086, 30167.245818854703, 30239.546406804355, 30391.0, 30441.39117217599, 27941.0, 28500.42999139964, 28973.855130724212, 28994.13017609475, 29426.411471770873, 22945.31164065081, 23687.1709490167, 23801.88099059563, 23816.285511434686, 25329.62005569881], "unit": "score", "name": "ext.html", "value": 16471.60260786698}, {"lowerIsBetter": false, "replicates": [319.5606041692674, 325.5296097139634, 327.34530938123754, 333.76302824994247, 336.337415291875, 12571.874281257185, 13007.674808129801, 15624.0, 16002.759958600616, 16148.0, 9483.810323793537, 9556.661558199095, 9583.0, 10516.316439431432, 10662.147028237741, 4497.595216430513, 4633.559811817872, 4645.9303110453375, 4648.72107673539, 4649.39557857478, 3530.0, 4600.654950878681, 4644.2801365788355, 5314.149736042234, 5328.813491527797, 5264.39459462161, 5279.208118782194, 5282.339707536558, 5289.68261904285, 5303.787848486056, 5117.232415137722, 5270.39390470097, 5270.868228294285, 5297.7880884764945, 5298.284731561248, 5137.357830271216, 5154.587632989389, 5158.329417175781, 5164.018836421068, 5169.663971841818, 13442.798358024638, 19315.227390904347, 19728.11223494946, 19743.0, 19787.50531236716, 1784.4468214853307, 1865.8600604954547, 1905.4950438133906, 1908.2271679969635, 1928.53715108373, 9192.724218273395, 9298.349115561914, 12154.696132596755, 12461.439235234437, 12859.42132604035, 1758.4109323376556, 1761.867859910512, 1774.4942691332908, 1829.871908966373, 1859.302761464451, 53670.463295366935, 56284.718576407264, 56468.435315646726, 56610.15084773731, 57358.426415735725, 9753.65862194834, 9869.555869985868, 9910.603575857029, 9911.900880991241, 9964.950175249078, 12503.187292825936, 12544.184627999151, 12544.184627999151, 12550.0, 12551.811722824164, 6541.967290163519, 6602.801915942529, 6752.76365327221, 6775.864482710318, 6790.5925644461495, 6063.393660633989, 6083.209182806207, 6115.205023346936, 6143.477804386677, 6284.591501552384, 4154.750714957112, 4211.43145675336, 4223.387608796707, 4239.97880010598, 4246.171996460661, 1596.8243493215737, 1661.6178278995658, 1673.6569003354527, 1679.4541773923524, 1698.9745153822703, 776.8329809091073, 800.8558459477233, 859.0164261920191, 999.7800483893532, 1007.4559737741685, 12212.694682632828, 15168.31742571587, 15335.769963450557, 16284.67430651404, 16376.099314537814, 818.4557269415891, 825.4387016828614, 836.4395854777192, 848.5969164646743, 890.0298674444886, 8744.213020828156, 9078.682246121354, 9227.215686666708, 9353.23777352916, 9444.386114902509, 510410.0, 513560.0, 515472.0, 539207.0, 539327.0, 72055.0, 72110.0, 73479.63260183665, 73534.26465735381, 74890.62554687192, 1070.8875568065396, 1071.6624263357019, 1102.2229328323513, 1128.0, 1130.8416821644976, 14376.05290915339, 14512.637184070483, 14581.562553123424, 14596.854031459974, 14680.0, 33712.0, 34070.48894266637, 34300.31399372048, 34555.65444345625, 34978.825105874304, 45487.54512454833, 45772.7711361441, 47390.76304618455, 47813.28280075871, 48179.518204817505, 8781.780455488664, 8899.510526921082, 8926.25937942095, 8942.239909607757, 9051.637934482547, 10641.414722190353, 10709.410982395731, 10751.946240268748, 10780.676579702622, 12815.871841281469, 13171.934140329236, 13392.732145357233, 13416.262105584286, 13587.86412135866, 13937.90931360304, 12820.0, 12882.871171288542, 12941.223526588436, 13569.86430135686, 13617.0, 10857.67426977192, 12323.44544495482, 12688.365581721062, 13796.655083622989, 14073.859261407255, 8952.462852228888, 9074.0, 9174.862377064215, 9281.62873485053, 9297.581608827755, 13810.240436776074, 13857.0, 14036.78944815808, 14382.496612618508, 14461.13233205969], "unit": "score", "name": "jquery.html", "value": 8145.03845777284}, {"lowerIsBetter": false, "replicates": [1387.2924808347739, 1656.411973749319, 1692.8222536633652, 1721.7675613792135, 1722.664080504302, 5878.941210587893, 7015.789526314206, 7179.138503379589, 7182.604956727378, 7196.172440169382, 7106.822329441767, 7271.836506159016, 7273.6363181840825, 7294.6352682365805, 7303.342699157075, 1644.1532610705497, 1688.3246701319508, 2041.1937284772505, 2074.0459388681224, 2084.7289852319254, 2061.7525896892394, 2092.801183887528, 2095.140992193201, 2095.863768855027, 2098.150249149097, 2081.989590052048, 2093.089506064859, 2114.1332053857923, 2126.2983215538834, 2126.8830214338204, 2017.1023894367013, 2038.7757346691778, 2041.4488088216174, 2052.2098991888083, 2096.968545471819, 2075.8546901716886, 2081.2195426714984, 2095.9476013099643, 2097.4966008158085, 2098.328534868843, 7092.326229008236, 7114.288571142896, 7150.320719531636, 7160.928390716078, 7170.175429825533, 4134.73124246923, 4207.810648520824, 4212.873613791591, 4215.5362910080175, 4235.49174099107, 2630.0663264541195, 2693.851838148901, 2695.17797071893, 2696.0833316672424, 2712.22701530063, 888.3603805260202, 893.4594570284949, 902.8104098139398, 910.1080940678106, 911.1753862754218, 9569.856452153223, 9675.12923836851, 9676.75808104796, 9686.225101991824, 9717.222622190207, 3824.349860523718, 3834.884953451401, 3872.341701910682, 3887.2031233597045, 3909.550401703784, 8445.1977062179, 8449.873251901226, 8452.915470845335, 8463.66145354179, 8477.70328038528, 4282.143571285693, 4290.420793192879, 4303.031817840961, 4305.246581848164, 4317.568243175658, 3903.1998440319667, 3905.6875449963936, 3912.941305880414, 3926.5288165420334, 3929.980350098231, 2910.4761142994466, 2926.8536573171255, 3408.9829550852583, 3461.9653803461642, 3541.8406171722336, 1107.5071593141136, 1124.2074337591978, 1131.1685910855515, 1132.5752842683994, 1137.3289759042204, 954.4654993203828, 1086.961941373862, 1104.6741211342674, 1106.2090605217309, 1157.0916830288184, 6660.234073081658, 6676.699548520328, 6716.764913228111, 6722.495812814059, 6742.426893713991, 583.9795607153729, 720.2941117704679, 1093.6445655162104, 1115.726646971481, 1128.497818470789, 5382.1119515280325, 5424.62027658068, 5427.104527752956, 5436.592255580847, 5449.373322067933, 8271.793205169919, 8304.169583041648, 8512.574371281411, 8514.063453020162, 8518.105598912149, 8467.195616416431, 8477.872831907527, 8506.064332923374, 8523.445976011539, 8530.701425450203, 6110.663913484801, 6228.595141315709, 6800.897986530206, 6811.080504131978, 6829.214640316427, 6660.333966603301, 6719.294474080151, 6750.459963202834, 6755.594664320157, 6756.0, 7639.121501027231, 7726.690932362642, 7848.097468791162, 7869.134395216407, 7913.643886025027, 7901.249381308767, 8035.799105022421, 8094.554799486084, 8120.431569790294, 8126.106128325998, 6090.786822461193, 6366.29970703213, 6368.140301059483, 6442.903356449563, 6461.741530338733, 5690.8008219713765, 5900.203472531325, 6704.7988560343265, 6821.386075253251, 6823.420009299265, 6419.101325814483, 6421.967890160519, 6517.608943463218, 6632.038354438676, 6651.833704157435, 6291.02489114188, 6334.809955701337, 6390.90413643805, 6421.325760795049, 6467.805965821033, 6365.840853978688, 6396.296407395276, 6404.135441715309, 6411.71147298382, 6411.775587854403, 5861.325947515919, 5892.469677728854, 5897.203877476486, 5904.468597826216, 5906.26171728534, 5949.583529152917, 5976.731047102978, 6061.7575296987625, 6094.939050609437, 6098.420650038239], "unit": "score", "name": "mootools.html", "value": 4101.186174922017}, {"lowerIsBetter": false, "replicates": [295.44308977577265, 300.0697836706211, 300.50866832728497, 304.108960745017, 305.4562878077024, 5214.791408343671, 5230.2416149658275, 5319.760610772515, 5390.568754499641, 5391.406945236021, 5188.221766734991, 5290.418054014065, 5293.550048245894, 5296.523312901838, 5301.549368303698, 3858.575556688762, 4072.490938632671, 4079.4492743479695, 4082.8979275518054, 4084.448599439082, 3969.940450893239, 3974.105826189113, 4043.8786836394956, 4046.6155715207155, 4052.7365721228175, 3987.7806720630356, 4005.299072662287, 4042.1107356381694, 4044.8179831907637, 4049.615286547788, 3763.849446022156, 3869.1681288522823, 3934.5081864766903, 4034.3948407738926, 4049.129437171008, 3506.68439840413, 3536.0275924120815, 3540.415831387818, 3548.4677298405186, 3550.378683730337, 5000.624953128494, 5024.497550244982, 5025.221090730943, 5030.220315851049, 5032.270320803463, 4629.444466663988, 4642.65180111493, 4644.210484217691, 4650.18621741194, 4651.511591282934, 5287.101192797234, 5489.8471321022635, 5499.3675727291475, 5506.229127922094, 5508.586855985777, 3803.6386543278345, 3803.7527560708463, 3804.90487737806, 3806.7715937043868, 3810.657040866335, 5700.914486282709, 5791.0, 5793.246877905845, 5793.710314484259, 5797.043487824504, 3897.7661340319673, 3902.941455878164, 3905.2384784966657, 3906.667933225651, 3907.238088572701, 3953.2686453006286, 3955.1496428267487, 3963.2271707016853, 3963.2667956428154, 3964.1278918637854, 4454.420925279693, 4602.815887364535, 4603.861884143481, 4604.033153037833, 4604.30935359692, 5508.3114610673665, 5516.310461192351, 5516.862078448071, 5518.061929471999, 5524.917126243109, 1388.3821699343896, 1413.039133389305, 1413.4275618374575, 1414.0172580056762, 1414.1091112598997, 930.1210356213313, 941.0401390581568, 942.4345392764286, 965.8647789309503, 968.9922480620218, 4846.8788280292565, 4853.4418541867435, 4860.270959356125, 4861.392325959255, 4866.683665561727, 5671.773129074873, 5688.943110568841, 5697.487226149667, 5709.400512946081, 5713.428657134254, 4856.490068542752, 4861.392325959255, 4862.489438608965, 4863.076015557032, 4866.31871537985, 2820.1116648256143, 2905.5932169496286, 3040.3919216156414, 3074.1546074829603, 3074.508078707396, 5315.73421328932, 5437.293151890229, 5440.591955603267, 5453.3455985281225, 5453.590980676465, 5915.792947246826, 5920.111983202468, 5922.230110085661, 5926.733297001645, 5927.73325200367, 5419.214213939035, 5431.755570999315, 5437.646552974044, 5443.972780136074, 5455.0453670607485, 5497.697626630574, 5642.351129620146, 5712.171735098304, 5714.628549144292, 5725.969325521446, 5607.355154157324, 5613.635113717595, 5614.101743720985, 5617.634853734658, 5621.184928185308, 5423.701696406735, 5430.0, 5431.429699881455, 5431.456854314695, 5441.0, 3926.8232929518813, 3965.960340396559, 3968.7817170055923, 3973.92052158961, 3977.3636218206107, 5609.831705048855, 5729.598928074995, 5731.283589551306, 5732.16883551891, 5733.31200255972, 5521.806736764194, 5537.778488860562, 5540.944590554042, 5543.057680194457, 5544.861378465409, 5526.668399896019, 5527.695976721319, 5536.557075434036, 5541.473560011793, 5542.916856247079, 5269.71016594091, 5406.135018397038, 5408.675479471244, 5408.972955135199, 5413.458654134555, 5556.249906262603, 5558.305211848519, 5566.109422492544, 5566.721663916869, 5571.66570005801, 5209.0, 5285.418603953485, 5364.624476286623, 5396.379416367011, 5423.7830486780085], "unit": "score", "name": "prototype.html", "value": 4130.507205394181}, {"lowerIsBetter": false, "replicates": [647.4852492268648, 668.218184723873, 669.8727241824052, 772.8686123359029, 799.0970203669852, 10973.890261097396, 11213.66359009231, 11303.773924521505, 11313.0, 11320.264182828121, 11427.942860285708, 11526.942365288183, 11530.0, 11544.422778861044, 13862.584122476343, 781.0744268042359, 781.3436713160944, 781.7029528779055, 785.579714852554, 785.787837283933, 768.9038870141233, 770.9421793365492, 771.8649236383638, 778.3150827272021, 790.5375355417087, 805.2189376305004, 812.0134037144868, 813.0203105258149, 817.7587611654546, 829.3116713128119, 805.556943680979, 805.5931754464017, 806.8668669669556, 811.1969150540951, 829.2495291760936, 601.2904772368603, 602.6414283501354, 602.9879402411971, 611.3153268339488, 616.0113018605119, 11141.610043648434, 11277.32336059839, 11281.49233284496, 11282.323060616389, 11288.040516556102, 10215.94892025535, 10322.741931451774, 10715.892841071567, 11029.83455248172, 11293.491792869258, 8932.240759535447, 8988.910110898938, 9006.729798106067, 9379.5310234488, 9646.276529260263, 3149.4960806271115, 3177.8728850845937, 3180.872765089394, 3195.440797860365, 3200.1679563313705, 35176.47235291472, 35645.0, 38307.61692383096, 39132.60867391318, 41136.0, 8813.162749538784, 8905.554722263862, 8912.955435222782, 8924.509151996574, 8985.146411090936, 15721.921390392974, 15728.92135539315, 15749.921250393674, 15799.36802527886, 15813.0, 6111.144439778434, 6271.529635277372, 6293.1504246927, 6436.967815160894, 6501.86217411951, 3222.4038552867796, 3381.6956473916975, 3487.4071407860724, 3565.4651802229873, 3631.7094632429344, 2549.5410826051116, 2568.987155064213, 2576.1241177999195, 2583.7416258374014, 2583.7416258374387, 455.28747510146513, 455.44435788338177, 458.2621978614428, 458.6949678463851, 459.7586267209742, 487.36885732975884, 554.8030449190479, 556.716074801854, 571.4599703280443, 597.7818096394784, 7509.211532789088, 7606.695732170651, 7632.19861914491, 7638.694452221849, 7721.112072111667, 441.0913518152616, 539.9578812891158, 568.4770011589347, 576.6770608459192, 581.3111462916457, 3610.2418492116426, 3648.0, 3690.704743620504, 3802.6767724743154, 3909.980450097788, 45301.773491132335, 45540.772296138966, 45802.0, 46163.0, 46204.53795462002, 41321.96695082647, 41824.0, 41902.0, 42051.36922946158, 42200.15599687989, 34307.14232144217, 36654.8167259162, 37930.0, 38960.99999999943, 39108.217835643125, 6331.240251169889, 7272.381847543018, 7544.547327160388, 7814.492058016211, 7891.84216315682, 27254.318642034108, 28577.28556786097, 28649.140525783427, 28653.14040578786, 29306.0, 34024.0, 34103.658963410046, 34490.82754586211, 34644.653553464144, 34656.0, 9216.2626989842, 9612.1829644481, 9761.804763904824, 9952.950235248778, 10118.13995810335, 10579.471026448493, 10581.206409519164, 10591.4704264788, 10627.36235825853, 10666.83999739989, 9468.526573671426, 9836.311458197857, 9934.900650993397, 10084.949575252076, 10128.34165779222, 10297.588096476056, 10312.432816195182, 10356.689299321033, 10371.377717336984, 10387.94806025965, 8526.957365213382, 8843.027267000496, 9675.951620241854, 9987.800243995225, 10044.296899216984, 9076.09239076087, 9088.454692718458, 9213.401128926598, 9506.0, 9510.239180865376, 8648.394612377073, 8881.289496840109, 8893.599788009684, 8967.282617390463, 9035.683751068682], "unit": "score", "name": "yui.html", "value": 5486.682480022094}], "name": "dromaeo_css", "value": 6157.144778438178}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 113.0, 107.0, 111.0, 111.0, 112.0, 103.0, 112.0, 112.0, 103.0], "unit": "score", "name": "ai-astar", "value": 109.4}, {"lowerIsBetter": true, "replicates": [162.0, 128.0, 152.0, 172.0, 142.0, 151.0, 151.0, 130.0, 167.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 148.4}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 160.0, 161.0, 163.0, 161.0, 161.0, 162.0, 163.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 88.0, 89.0, 72.0, 72.0, 72.0, 96.0, 90.0, 73.0], "unit": "score", "name": "audio-fft", "value": 79.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 132.0, 94.0, 95.0, 94.0, 145.0, 94.0, 95.0, 130.0], "unit": "score", "name": "audio-oscillator", "value": 106.9}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 110.0, 110.0, 109.0, 110.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 145.0, 147.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 71.0, 71.0, 72.0, 71.0, 72.0, 79.0, 69.0, 69.0], "unit": "score", "name": "json-parse-financial", "value": 71.5}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.0}, {"lowerIsBetter": true, "replicates": [91.0, 86.0, 85.0, 87.0, 83.0, 85.0, 84.0, 91.0, 84.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.8}, {"lowerIsBetter": true, "replicates": [122.0, 124.0, 122.0, 129.0, 122.0, 124.0, 120.0, 120.0, 127.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.7}, {"lowerIsBetter": true, "replicates": [132.0, 133.0, 149.0, 144.0, 143.0, 131.0, 144.0, 144.0, 142.0, 132.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.4}, {"lowerIsBetter": true, "replicates": [72.0, 69.0, 68.0, 69.0, 71.0, 70.0, 71.0, 68.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.4}], "name": "kraken", "value": 1515.7000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.78249336870027], "unit": "score", "name": "Richards", "value": 212.94166399999992}, {"lowerIsBetter": false, "replicates": [186.70649738610905], "unit": "score", "name": "DeltaBlue", "value": 354.12800799999997}, {"lowerIsBetter": false, "replicates": [278.00945232137894], "unit": "score", "name": "Encrypt", "value": 957.4530570000002}, {"lowerIsBetter": false, "replicates": [5133.333333333333], "unit": "score", "name": "Decrypt", "value": 51.85344155844158}, {"lowerIsBetter": false, "replicates": [1992.03187250996], "unit": "score", "name": "RayTrace", "value": 371.474478}, {"lowerIsBetter": false, "replicates": [784.3137254901961], "unit": "score", "name": "Earley", "value": 849.7403250000002}, {"lowerIsBetter": false, "replicates": [12000.0], "unit": "score", "name": "Boyer", "value": 55.53858333333334}, {"lowerIsBetter": false, "replicates": [27648.64864864865], "unit": "score", "name": "RegExp", "value": 32.94862658846528}, {"lowerIsBetter": false, "replicates": [600.6006006006006], "unit": "score", "name": "Splay", "value": 135.68251500000005}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 19816.754463830923}]} 04:35:23 INFO - RETURN: dromaeo_css: 6157.15 04:35:23 INFO - RETURN: kraken: 1515.70 04:35:23 INFO - RETURN: v8_7: 19816.75 04:35:23 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "19816.75"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1515.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "6157.15"}}} 04:35:23 INFO - Return code: 0 04:35:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:35:23 ERROR - # TBPL SUCCESS # 04:35:23 INFO - Running post-action listener: _resource_record_post_action 04:35:23 INFO - Running post-run listener: _resource_record_post_run 04:35:24 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 0; Write bytes: 551682048; Read time: 0; Write time: 634488 04:35:24 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 230932480; Read time: 0; Write time: 401468 04:35:24 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 0; Write bytes: 319885312; Read time: 0; Write time: 232976 04:35:24 INFO - Running post-run listener: _upload_blobber_files 04:35:24 INFO - Blob upload gear active. 04:35:24 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:35:24 INFO - Copying logs to upload dir... 04:35:24 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1266.436196 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-12-21 04:35:24.099079) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-21 04:35:24.102197) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1450700054.407183-1411039578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009898 build_url: 'https://queue.taskcluster.net/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.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-21 04:35:24.153256) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 04:35:24.153593) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1450700054.407183-1411039578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004582 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 04:35:24.204607) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 04:35:24.204974) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 04:35:24.205342) ========= ========= Total master_lag: 0.23 =========