builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-062 starttime: 1450228380.44 results: success (0) buildid: 20151215155559 builduid: 6e9a2defd0d44185a6b2d4d404632c2b revision: ed5eee4f80f9e7ec86bafc60bc2de8c5c7d0415f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-15 17:13:00.439086) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-15 17:13:00.439583) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-15 17:13:00.439906) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1450228328.749263-955132104 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006317 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-15 17:13:00.463198) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-15 17:13:00.463547) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-15 17:13:00.477344) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 17:13:00.477729) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1450228328.749263-955132104 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004607 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 17:13:00.527530) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-15 17:13:00.527871) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-15 17:13:00.528323) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 17:13:00.528635) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1450228328.749263-955132104 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-15 17:13:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 71.6M=0s 2015-12-15 17:13:00 (71.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.378806 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 17:13:00.920400) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 17:13:00.920756) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1450228328.749263-955132104 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016712 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 17:13:00.970617) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-15 17:13:00.971009) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ed5eee4f80f9e7ec86bafc60bc2de8c5c7d0415f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev ed5eee4f80f9e7ec86bafc60bc2de8c5c7d0415f --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=bab59de71505bdac5bb1aeb2000001b6-1450228328.749263-955132104 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-15 17:13:01,051 truncating revision to first 12 chars 2015-12-15 17:13:01,051 Setting DEBUG logging. 2015-12-15 17:13:01,051 attempt 1/10 2015-12-15 17:13:01,051 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ed5eee4f80f9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-15 17:13:01,932 unpacking tar archive at: fx-team-ed5eee4f80f9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.156882 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-15 17:13:02.176645) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-15 17:13:02.176988) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-15 17:13:02.195062) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-15 17:13:02.195683) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-15 17:13:02.196243) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-15 17:13:02.196651) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=bab59de71505bdac5bb1aeb2000001b6-1450228328.749263-955132104 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:13:02 INFO - MultiFileLogger online at 20151215 17:13:02 in /builds/slave/test 17:13:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 17:13:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:13:02 INFO - {'append_to_log': False, 17:13:02 INFO - 'base_work_dir': '/builds/slave/test', 17:13:02 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 17:13:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:13:02 INFO - 'branch': 'Fx-Team-Non-PGO', 17:13:02 INFO - 'buildbot_json_path': 'buildprops.json', 17:13:02 INFO - 'config_files': ('talos/linux_config.py',), 17:13:02 INFO - 'default_actions': ('clobber', 17:13:02 INFO - 'read-buildbot-config', 17:13:02 INFO - 'download-and-extract', 17:13:02 INFO - 'populate-webroot', 17:13:02 INFO - 'create-virtualenv', 17:13:02 INFO - 'install', 17:13:02 INFO - 'run-tests'), 17:13:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:13:02 INFO - 'download_minidump_stackwalk': True, 17:13:02 INFO - 'download_symbols': 'ondemand', 17:13:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:13:02 INFO - 'tooltool.py': '/tools/tooltool.py', 17:13:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:13:02 INFO - '/tools/misc-python/virtualenv.py')}, 17:13:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:13:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:13:02 INFO - 'installer_path': 'installer.exe', 17:13:02 INFO - 'log_level': 'info', 17:13:02 INFO - 'log_name': 'talos', 17:13:02 INFO - 'log_to_console': True, 17:13:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:13:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:13:02 INFO - 'opt_config_files': (), 17:13:02 INFO - 'pip_index': False, 17:13:02 INFO - 'sps_profile': False, 17:13:02 INFO - 'sps_profile_interval': 0, 17:13:02 INFO - 'suite': 'dromaeojs-e10s', 17:13:02 INFO - 'system_bits': '64', 17:13:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:13:02 INFO - 'title': 'talos-linux64-ix-062', 17:13:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:13:02 INFO - 'use_talos_json': True, 17:13:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:13:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:13:02 INFO - 'work_dir': 'build'} 17:13:02 INFO - ##### 17:13:02 INFO - ##### Running clobber step. 17:13:02 INFO - ##### 17:13:02 INFO - Running pre-action listener: _resource_record_pre_action 17:13:02 INFO - Running main action method: clobber 17:13:02 INFO - rmtree: /builds/slave/test/build 17:13:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:13:03 INFO - Running post-action listener: _resource_record_post_action 17:13:03 INFO - ##### 17:13:03 INFO - ##### Running read-buildbot-config step. 17:13:03 INFO - ##### 17:13:03 INFO - Running pre-action listener: _resource_record_pre_action 17:13:03 INFO - Running main action method: read_buildbot_config 17:13:03 INFO - Using buildbot properties: 17:13:03 INFO - { 17:13:03 INFO - "properties": { 17:13:03 INFO - "buildnumber": 576, 17:13:03 INFO - "product": "firefox", 17:13:03 INFO - "script_repo_revision": "production", 17:13:03 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:13:03 INFO - "repository": "", 17:13:03 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 17:13:03 INFO - "buildid": "20151215155559", 17:13:03 INFO - "slavename": "talos-linux64-ix-062", 17:13:03 INFO - "pgo_build": "False", 17:13:03 INFO - "basedir": "/builds/slave/test", 17:13:03 INFO - "project": "", 17:13:03 INFO - "platform": "ubuntu64_hw", 17:13:03 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:13:03 INFO - "slavebuilddir": "test", 17:13:03 INFO - "scheduler": "tests-fx-team-linux64-talos", 17:13:03 INFO - "branch": "fx-team", 17:13:03 INFO - "repo_path": "integration/fx-team", 17:13:03 INFO - "stage_platform": "linux64", 17:13:03 INFO - "builduid": "6e9a2defd0d44185a6b2d4d404632c2b", 17:13:03 INFO - "revision": "ed5eee4f80f9e7ec86bafc60bc2de8c5c7d0415f" 17:13:03 INFO - }, 17:13:03 INFO - "sourcestamp": { 17:13:03 INFO - "repository": "", 17:13:03 INFO - "hasPatch": false, 17:13:03 INFO - "project": "", 17:13:03 INFO - "branch": "fx-team-linux64-talos", 17:13:03 INFO - "changes": [ 17:13:03 INFO - { 17:13:03 INFO - "category": null, 17:13:03 INFO - "files": [ 17:13:03 INFO - { 17:13:03 INFO - "url": null, 17:13:03 INFO - "name": "https://queue.taskcluster.net/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2" 17:13:03 INFO - } 17:13:03 INFO - ], 17:13:03 INFO - "repository": "", 17:13:03 INFO - "rev": "ed5eee4f80f9e7ec86bafc60bc2de8c5c7d0415f", 17:13:03 INFO - "who": "kwierso@gmail.com", 17:13:03 INFO - "when": 1450228341, 17:13:03 INFO - "number": 7364233, 17:13:03 INFO - "comments": "Merge m-c to fx-team, a=merge", 17:13:03 INFO - "project": "", 17:13:03 INFO - "at": "Tue 15 Dec 2015 17:12:21", 17:13:03 INFO - "branch": "fx-team-linux64-talos", 17:13:03 INFO - "revlink": "", 17:13:03 INFO - "properties": [ 17:13:03 INFO - [ 17:13:03 INFO - "buildid", 17:13:03 INFO - "20151215155559", 17:13:03 INFO - "Change" 17:13:03 INFO - ], 17:13:03 INFO - [ 17:13:03 INFO - "builduid", 17:13:03 INFO - "6e9a2defd0d44185a6b2d4d404632c2b", 17:13:03 INFO - "Change" 17:13:03 INFO - ], 17:13:03 INFO - [ 17:13:03 INFO - "pgo_build", 17:13:03 INFO - "False", 17:13:03 INFO - "Change" 17:13:03 INFO - ] 17:13:03 INFO - ], 17:13:03 INFO - "revision": "ed5eee4f80f9e7ec86bafc60bc2de8c5c7d0415f" 17:13:03 INFO - } 17:13:03 INFO - ], 17:13:03 INFO - "revision": "ed5eee4f80f9e7ec86bafc60bc2de8c5c7d0415f" 17:13:03 INFO - } 17:13:03 INFO - } 17:13:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 17:13:03 INFO - Running post-action listener: _resource_record_post_action 17:13:03 INFO - ##### 17:13:03 INFO - ##### Running download-and-extract step. 17:13:03 INFO - ##### 17:13:03 INFO - Running pre-action listener: _resource_record_pre_action 17:13:03 INFO - Running main action method: download_and_extract 17:13:03 INFO - mkdir: /builds/slave/test/build/tests 17:13:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:03 INFO - https://queue.taskcluster.net/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:13:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/test_packages.json 17:13:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/test_packages.json 17:13:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 17:13:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 17:13:03 INFO - Downloaded 1302 bytes. 17:13:03 INFO - Reading from file /builds/slave/test/build/test_packages.json 17:13:03 INFO - Using the following test package requirements: 17:13:03 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:13:03 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:13:03 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:13:03 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:13:03 INFO - u'jsshell-linux-x86_64.zip'], 17:13:03 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:13:03 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:13:03 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:13:03 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:13:03 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:13:03 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:13:03 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:13:03 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:13:03 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:13:03 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:13:03 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:13:03 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:13:03 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:13:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:03 INFO - https://queue.taskcluster.net/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:13:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:13:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:13:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/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 17:13:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/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 17:13:04 INFO - Downloaded 21863347 bytes. 17:13:04 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 17:13:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:13:04 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 17:13:06 INFO - Return code: 0 17:13:06 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 17:13:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:06 INFO - https://queue.taskcluster.net/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:13:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:13:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:13:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/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 17:13:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/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 17:13:10 INFO - Downloaded 21863347 bytes. 17:13:10 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 17:13:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:13:10 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 17:13:11 INFO - Return code: 0 17:13:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:11 INFO - https://queue.taskcluster.net/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:13:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:13:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:13:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/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 17:13:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/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 17:13:12 INFO - Downloaded 11132052 bytes. 17:13:12 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 17:13:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:13:12 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 17:13:12 INFO - Return code: 0 17:13:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:12 INFO - https://queue.taskcluster.net/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:13:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:13:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:13:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/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 17:13:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/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 17:13:14 INFO - Downloaded 57747060 bytes. 17:13:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:13:14 INFO - mkdir: /builds/slave/test/properties 17:13:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:13:14 INFO - Writing to file /builds/slave/test/properties/build_url 17:13:14 INFO - Contents: 17:13:14 INFO - build_url:https://queue.taskcluster.net/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:13:14 INFO - Running post-action listener: _resource_record_post_action 17:13:14 INFO - Running post-action listener: set_extra_try_arguments 17:13:14 INFO - ##### 17:13:14 INFO - ##### Running populate-webroot step. 17:13:14 INFO - ##### 17:13:14 INFO - Running pre-action listener: _resource_record_pre_action 17:13:14 INFO - Running main action method: populate_webroot 17:13:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:13:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:13:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:13:14 INFO - '--tppagecycles', 17:13:14 INFO - '7'], 17:13:14 INFO - 'tests': ['tsvgm']}}, 17:13:14 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:13:14 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:13:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:13:14 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:13:14 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:13:14 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:13:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:13:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:14 INFO - 'talos_options': ['--e10s'], 17:13:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:13:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:14 INFO - 'tests': ['damp', 'tps']}, 17:13:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:14 INFO - 'talos_options': ['--e10s'], 17:13:14 INFO - 'tests': ['damp', 'tps']}, 17:13:14 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:13:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:13:14 INFO - 'other': {'tests': ['a11yr', 17:13:14 INFO - 'ts_paint', 17:13:14 INFO - 'tpaint', 17:13:14 INFO - 'sessionrestore', 17:13:14 INFO - 'sessionrestore_no_auto_restore']}, 17:13:14 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:13:14 INFO - 'tests': ['a11yr', 17:13:14 INFO - 'ts_paint', 17:13:14 INFO - 'tpaint', 17:13:14 INFO - 'sessionrestore', 17:13:14 INFO - 'sessionrestore_no_auto_restore']}, 17:13:14 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:13:14 INFO - 'tests': ['a11yr', 17:13:14 INFO - 'ts_paint', 17:13:14 INFO - 'tpaint', 17:13:14 INFO - 'sessionrestore', 17:13:14 INFO - 'sessionrestore_no_auto_restore']}, 17:13:14 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:13:14 INFO - 'tests': ['a11yr', 17:13:14 INFO - 'ts_paint', 17:13:14 INFO - 'tpaint', 17:13:14 INFO - 'sessionrestore', 17:13:14 INFO - 'sessionrestore_no_auto_restore']}, 17:13:14 INFO - 'other_l64': {'tests': ['a11yr', 17:13:14 INFO - 'ts_paint', 17:13:14 INFO - 'tpaint', 17:13:14 INFO - 'sessionrestore', 17:13:14 INFO - 'sessionrestore_no_auto_restore']}, 17:13:14 INFO - 'other_nol64': {'tests': ['a11yr', 17:13:14 INFO - 'ts_paint', 17:13:14 INFO - 'tpaint', 17:13:14 INFO - 'sessionrestore', 17:13:14 INFO - 'sessionrestore_no_auto_restore']}, 17:13:14 INFO - 'svgr': {'tests': ['tsvgx', 17:13:14 INFO - 'tsvgr_opacity', 17:13:14 INFO - 'tart', 17:13:14 INFO - 'tscrollx', 17:13:14 INFO - 'cart']}, 17:13:14 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:13:14 INFO - 'tests': ['tsvgx', 17:13:14 INFO - 'tsvgr_opacity', 17:13:14 INFO - 'tart', 17:13:14 INFO - 'tscrollx', 17:13:14 INFO - 'cart']}, 17:13:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:14 INFO - 'tests': ['tp5o']}, 17:13:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:14 INFO - 'talos_options': ['--e10s'], 17:13:14 INFO - 'tests': ['tp5o']}, 17:13:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:14 INFO - 'talos_options': ['--xperf_path', 17:13:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:13:14 INFO - 'tests': ['tp5n']}, 17:13:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:14 INFO - 'talos_options': ['--e10s', 17:13:14 INFO - '--xperf_path', 17:13:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:13:14 INFO - 'tests': ['tp5n']}}, 17:13:14 INFO - 'talos.zip': {'path': '', 17:13:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:13:14 INFO - Running post-action listener: _resource_record_post_action 17:13:14 INFO - ##### 17:13:14 INFO - ##### Running create-virtualenv step. 17:13:14 INFO - ##### 17:13:14 INFO - Running pre-action listener: _resource_record_pre_action 17:13:14 INFO - Running main action method: create_virtualenv 17:13:14 INFO - Creating virtualenv /builds/slave/test/build/venv 17:13:14 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:13:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:13:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:13:14 INFO - Using real prefix '/usr' 17:13:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:13:14 INFO - Installing distribute.............................................................................................................................................................................................done. 17:13:17 INFO - Installing pip.................done. 17:13:17 INFO - Return code: 0 17:13:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:13:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:17 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 0x7fa8b522ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa8240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10370b0>, '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 0x1037fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038440>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450228328.749263-955132104', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:13:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:13:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:13:17 INFO - Using env: {'DISPLAY': ':0', 17:13:17 INFO - 'HOME': '/home/cltbld', 17:13:17 INFO - 'LANG': 'en_US.UTF-8', 17:13:17 INFO - 'LANGUAGE': 'en_US:en', 17:13:17 INFO - 'LOGNAME': 'cltbld', 17:13:17 INFO - 'MAIL': '/var/mail/cltbld', 17:13:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:17 INFO - 'MOZ_NO_REMOTE': '1', 17:13:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:17 INFO - 'NO_EM_RESTART': '1', 17:13:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:17 INFO - 'PWD': '/builds/slave/test', 17:13:17 INFO - 'SHELL': '/bin/bash', 17:13:17 INFO - 'SHLVL': '1', 17:13:17 INFO - 'TERM': 'linux', 17:13:17 INFO - 'TMOUT': '86400', 17:13:17 INFO - 'USER': 'cltbld', 17:13:17 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450228328.749263-955132104', 17:13:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:17 INFO - '_': '/tools/buildbot/bin/python'} 17:13:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:17 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:13:17 INFO - Cleaning up... 17:13:17 INFO - Return code: 0 17:13:17 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:13:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:17 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 0x7fa8b522ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa8240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10370b0>, '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 0x1037fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038440>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450228328.749263-955132104', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:13:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 17:13:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:13:17 INFO - Using env: {'DISPLAY': ':0', 17:13:17 INFO - 'HOME': '/home/cltbld', 17:13:17 INFO - 'LANG': 'en_US.UTF-8', 17:13:17 INFO - 'LANGUAGE': 'en_US:en', 17:13:17 INFO - 'LOGNAME': 'cltbld', 17:13:17 INFO - 'MAIL': '/var/mail/cltbld', 17:13:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:17 INFO - 'MOZ_NO_REMOTE': '1', 17:13:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:17 INFO - 'NO_EM_RESTART': '1', 17:13:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:17 INFO - 'PWD': '/builds/slave/test', 17:13:17 INFO - 'SHELL': '/bin/bash', 17:13:17 INFO - 'SHLVL': '1', 17:13:17 INFO - 'TERM': 'linux', 17:13:17 INFO - 'TMOUT': '86400', 17:13:17 INFO - 'USER': 'cltbld', 17:13:17 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450228328.749263-955132104', 17:13:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:17 INFO - '_': '/tools/buildbot/bin/python'} 17:13:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:17 INFO - Downloading/unpacking psutil>=0.7.1 17:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:19 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 17:13:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 17:13:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:13:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:13:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:13:19 INFO - Installing collected packages: psutil 17:13:19 INFO - Running setup.py install for psutil 17:13:19 INFO - building 'psutil._psutil_linux' extension 17:13:19 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:13:19 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:13:19 INFO - building 'psutil._psutil_posix' extension 17:13:19 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:13:19 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:13:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:13:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:13:19 INFO - Successfully installed psutil 17:13:19 INFO - Cleaning up... 17:13:19 INFO - Return code: 0 17:13:19 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:13: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')]} 17:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13: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')]} 17:13:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:19 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 0x7fa8b522ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa8240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10370b0>, '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 0x1037fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038440>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450228328.749263-955132104', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:13:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 17:13:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:13:19 INFO - Using env: {'DISPLAY': ':0', 17:13:19 INFO - 'HOME': '/home/cltbld', 17:13:19 INFO - 'LANG': 'en_US.UTF-8', 17:13:19 INFO - 'LANGUAGE': 'en_US:en', 17:13:19 INFO - 'LOGNAME': 'cltbld', 17:13:19 INFO - 'MAIL': '/var/mail/cltbld', 17:13:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:19 INFO - 'MOZ_NO_REMOTE': '1', 17:13:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:19 INFO - 'NO_EM_RESTART': '1', 17:13:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:19 INFO - 'PWD': '/builds/slave/test', 17:13:19 INFO - 'SHELL': '/bin/bash', 17:13:19 INFO - 'SHLVL': '1', 17:13:19 INFO - 'TERM': 'linux', 17:13:19 INFO - 'TMOUT': '86400', 17:13:19 INFO - 'USER': 'cltbld', 17:13:19 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450228328.749263-955132104', 17:13:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:19 INFO - '_': '/tools/buildbot/bin/python'} 17:13:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:20 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:21 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:13:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 17:13:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:13:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:13:21 INFO - Installing collected packages: mozsystemmonitor 17:13:21 INFO - Running setup.py install for mozsystemmonitor 17:13:21 INFO - Successfully installed mozsystemmonitor 17:13:21 INFO - Cleaning up... 17:13:21 INFO - Return code: 0 17:13:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:13: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')]} 17:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13: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')]} 17:13:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:21 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 0x7fa8b522ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa8240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10370b0>, '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 0x1037fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038440>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450228328.749263-955132104', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:13:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:13:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:13:21 INFO - Using env: {'DISPLAY': ':0', 17:13:21 INFO - 'HOME': '/home/cltbld', 17:13:21 INFO - 'LANG': 'en_US.UTF-8', 17:13:21 INFO - 'LANGUAGE': 'en_US:en', 17:13:21 INFO - 'LOGNAME': 'cltbld', 17:13:21 INFO - 'MAIL': '/var/mail/cltbld', 17:13:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:21 INFO - 'MOZ_NO_REMOTE': '1', 17:13:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:21 INFO - 'NO_EM_RESTART': '1', 17:13:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:21 INFO - 'PWD': '/builds/slave/test', 17:13:21 INFO - 'SHELL': '/bin/bash', 17:13:21 INFO - 'SHLVL': '1', 17:13:21 INFO - 'TERM': 'linux', 17:13:21 INFO - 'TMOUT': '86400', 17:13:21 INFO - 'USER': 'cltbld', 17:13:21 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450228328.749263-955132104', 17:13:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:21 INFO - '_': '/tools/buildbot/bin/python'} 17:13:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:22 INFO - Downloading/unpacking blobuploader==1.2.4 17:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:23 INFO - Downloading blobuploader-1.2.4.tar.gz 17:13:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 17:13:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:13:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 17:13:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:13:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:13:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:24 INFO - Downloading docopt-0.6.1.tar.gz 17:13:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 17:13:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:13:24 INFO - Installing collected packages: blobuploader, requests, docopt 17:13:24 INFO - Running setup.py install for blobuploader 17:13:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:13:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:13:24 INFO - Running setup.py install for requests 17:13:25 INFO - Running setup.py install for docopt 17:13:25 INFO - Successfully installed blobuploader requests docopt 17:13:25 INFO - Cleaning up... 17:13:25 INFO - Return code: 0 17:13:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:13: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')]} 17:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13: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')]} 17:13:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:25 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 0x7fa8b522ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa8240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10370b0>, '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 0x1037fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038440>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450228328.749263-955132104', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:13:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:13:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:13:25 INFO - Using env: {'DISPLAY': ':0', 17:13:25 INFO - 'HOME': '/home/cltbld', 17:13:25 INFO - 'LANG': 'en_US.UTF-8', 17:13:25 INFO - 'LANGUAGE': 'en_US:en', 17:13:25 INFO - 'LOGNAME': 'cltbld', 17:13:25 INFO - 'MAIL': '/var/mail/cltbld', 17:13:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:25 INFO - 'MOZ_NO_REMOTE': '1', 17:13:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:25 INFO - 'NO_EM_RESTART': '1', 17:13:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:25 INFO - 'PWD': '/builds/slave/test', 17:13:25 INFO - 'SHELL': '/bin/bash', 17:13:25 INFO - 'SHLVL': '1', 17:13:25 INFO - 'TERM': 'linux', 17:13:25 INFO - 'TMOUT': '86400', 17:13:25 INFO - 'USER': 'cltbld', 17:13:25 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450228328.749263-955132104', 17:13:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:25 INFO - '_': '/tools/buildbot/bin/python'} 17:13:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:13:25 INFO - Running setup.py (path:/tmp/pip-pOpZTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:13:25 INFO - Running setup.py (path:/tmp/pip-R_aRWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:13:25 INFO - Running setup.py (path:/tmp/pip-hlt2B3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:13:25 INFO - Running setup.py (path:/tmp/pip-UR3G0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:13:25 INFO - Running setup.py (path:/tmp/pip-oNm41M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:13:25 INFO - Running setup.py (path:/tmp/pip-9PxbSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:13:25 INFO - Running setup.py (path:/tmp/pip-EbkPv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:13:25 INFO - Running setup.py (path:/tmp/pip-FomuaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:13:25 INFO - Running setup.py (path:/tmp/pip-nUo0Xv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:13:26 INFO - Running setup.py (path:/tmp/pip-52WqFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:13:26 INFO - Running setup.py (path:/tmp/pip-1ALTIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:13:26 INFO - Running setup.py (path:/tmp/pip-JOkwJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:13:26 INFO - Running setup.py (path:/tmp/pip-fOsQrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:13:26 INFO - Running setup.py (path:/tmp/pip-osmXEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:13:26 INFO - Running setup.py (path:/tmp/pip-7SdMoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:13:26 INFO - Running setup.py (path:/tmp/pip-ztMgPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:13:26 INFO - Running setup.py (path:/tmp/pip-dbz87T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:13:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:13:26 INFO - Running setup.py install for manifestparser 17:13:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:13:26 INFO - Running setup.py install for mozcrash 17:13:26 INFO - Running setup.py install for mozdebug 17:13:26 INFO - Running setup.py install for mozdevice 17:13:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:13:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:13:27 INFO - Running setup.py install for mozfile 17:13:27 INFO - Running setup.py install for mozhttpd 17:13:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:13:27 INFO - Running setup.py install for mozinfo 17:13:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:13:27 INFO - Running setup.py install for mozInstall 17:13:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:13:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:13:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:13:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:13:27 INFO - Running setup.py install for mozleak 17:13:27 INFO - Running setup.py install for mozlog 17:13:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:13:27 INFO - Running setup.py install for moznetwork 17:13:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:13:27 INFO - Running setup.py install for mozprocess 17:13:27 INFO - Running setup.py install for mozprofile 17:13:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:13:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:13:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:13:27 INFO - Running setup.py install for mozrunner 17:13:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:13:28 INFO - Running setup.py install for mozscreenshot 17:13:28 INFO - Running setup.py install for moztest 17:13:28 INFO - Running setup.py install for mozversion 17:13:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:13:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:13:28 INFO - Cleaning up... 17:13:28 INFO - Return code: 0 17:13:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:13:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7fa8b522ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa8240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10370b0>, '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 0x1037fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038440>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450228328.749263-955132104', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:13:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:13:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:13:28 INFO - Using env: {'DISPLAY': ':0', 17:13:28 INFO - 'HOME': '/home/cltbld', 17:13:28 INFO - 'LANG': 'en_US.UTF-8', 17:13:28 INFO - 'LANGUAGE': 'en_US:en', 17:13:28 INFO - 'LOGNAME': 'cltbld', 17:13:28 INFO - 'MAIL': '/var/mail/cltbld', 17:13:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:28 INFO - 'MOZ_NO_REMOTE': '1', 17:13:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:28 INFO - 'NO_EM_RESTART': '1', 17:13:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:28 INFO - 'PWD': '/builds/slave/test', 17:13:28 INFO - 'SHELL': '/bin/bash', 17:13:28 INFO - 'SHLVL': '1', 17:13:28 INFO - 'TERM': 'linux', 17:13:28 INFO - 'TMOUT': '86400', 17:13:28 INFO - 'USER': 'cltbld', 17:13:28 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450228328.749263-955132104', 17:13:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:28 INFO - '_': '/tools/buildbot/bin/python'} 17:13:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:13:28 INFO - Running setup.py (path:/tmp/pip-GnZamH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:13:28 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:13:28 INFO - Running setup.py (path:/tmp/pip-GthBxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:13:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:13:28 INFO - Running setup.py (path:/tmp/pip-6yHAHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:13:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:13:28 INFO - Running setup.py (path:/tmp/pip-IILhb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:13:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:13:28 INFO - Running setup.py (path:/tmp/pip-qu2OYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:13:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:13:28 INFO - Running setup.py (path:/tmp/pip-cJbXR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:13:29 INFO - Running setup.py (path:/tmp/pip-KvMD9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:13:29 INFO - Running setup.py (path:/tmp/pip-n_xdFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:13:29 INFO - Running setup.py (path:/tmp/pip-TV0Dr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:13:29 INFO - Running setup.py (path:/tmp/pip-6VQeYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:13:29 INFO - Running setup.py (path:/tmp/pip-qh8mIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:13:29 INFO - Running setup.py (path:/tmp/pip-Pn4s9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:13:29 INFO - Running setup.py (path:/tmp/pip-sDsqNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:13:29 INFO - Running setup.py (path:/tmp/pip-n8pyhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:13:29 INFO - Running setup.py (path:/tmp/pip-cDbgck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:13:29 INFO - Running setup.py (path:/tmp/pip-lHBbQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:13:29 INFO - Running setup.py (path:/tmp/pip-wEqM0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:13:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:13: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 17:13: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 17:13: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 17:13: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 17:13: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 17:13: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 17:13:31 INFO - Downloading blessings-1.5.1.tar.gz 17:13:31 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 17:13:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:13:31 INFO - Installing collected packages: blessings 17:13:31 INFO - Running setup.py install for blessings 17:13:31 INFO - Successfully installed blessings 17:13:31 INFO - Cleaning up... 17:13:31 INFO - Return code: 0 17:13:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:13:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:13:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:13:31 INFO - Reading from file tmpfile_stdout 17:13:31 INFO - Current package versions: 17:13:31 INFO - argparse == 1.2.1 17:13:31 INFO - blessings == 1.5.1 17:13:31 INFO - blobuploader == 1.2.4 17:13:31 INFO - docopt == 0.6.1 17:13:31 INFO - manifestparser == 1.1 17:13:31 INFO - mozInstall == 1.12 17:13:31 INFO - mozcrash == 0.16 17:13:31 INFO - mozdebug == 0.1 17:13:31 INFO - mozdevice == 0.47 17:13:31 INFO - mozfile == 1.2 17:13:31 INFO - mozhttpd == 0.7 17:13:31 INFO - mozinfo == 0.9 17:13:31 INFO - mozleak == 0.1 17:13:31 INFO - mozlog == 3.1 17:13:31 INFO - moznetwork == 0.27 17:13:31 INFO - mozprocess == 0.22 17:13:31 INFO - mozprofile == 0.27 17:13:31 INFO - mozrunner == 6.11 17:13:31 INFO - mozscreenshot == 0.1 17:13:31 INFO - mozsystemmonitor == 0.0 17:13:32 INFO - moztest == 0.7 17:13:32 INFO - mozversion == 1.4 17:13:32 INFO - psutil == 3.1.1 17:13:32 INFO - requests == 1.2.3 17:13:32 INFO - wsgiref == 0.1.2 17:13:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:13: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')]} 17:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13: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')]} 17:13:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13: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', '-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 0x7fa8b522ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa8240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10370b0>, '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 0x1037fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038440>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450228328.749263-955132104', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:13:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:13:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:13:32 INFO - Using env: {'DISPLAY': ':0', 17:13:32 INFO - 'HOME': '/home/cltbld', 17:13:32 INFO - 'LANG': 'en_US.UTF-8', 17:13:32 INFO - 'LANGUAGE': 'en_US:en', 17:13:32 INFO - 'LOGNAME': 'cltbld', 17:13:32 INFO - 'MAIL': '/var/mail/cltbld', 17:13:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:32 INFO - 'MOZ_NO_REMOTE': '1', 17:13:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:32 INFO - 'NO_EM_RESTART': '1', 17:13:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:32 INFO - 'PWD': '/builds/slave/test', 17:13:32 INFO - 'SHELL': '/bin/bash', 17:13:32 INFO - 'SHLVL': '1', 17:13:32 INFO - 'TERM': 'linux', 17:13:32 INFO - 'TMOUT': '86400', 17:13:32 INFO - 'USER': 'cltbld', 17:13:32 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450228328.749263-955132104', 17:13:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:32 INFO - '_': '/tools/buildbot/bin/python'} 17:13:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:13:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:13:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:13:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:13:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:13:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:13:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:13:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:13:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:13:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:13:32 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:13:32 INFO - Cleaning up... 17:13:32 INFO - Return code: 0 17:13:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:13: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')]} 17:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13: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')]} 17:13:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8b522ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa8240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10370b0>, '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 0x1037fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038440>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450228328.749263-955132104', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:13: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', 'jsonschema'] in /builds/slave/test/build 17:13: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 jsonschema 17:13:32 INFO - Using env: {'DISPLAY': ':0', 17:13:32 INFO - 'HOME': '/home/cltbld', 17:13:32 INFO - 'LANG': 'en_US.UTF-8', 17:13:32 INFO - 'LANGUAGE': 'en_US:en', 17:13:32 INFO - 'LOGNAME': 'cltbld', 17:13:32 INFO - 'MAIL': '/var/mail/cltbld', 17:13:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:32 INFO - 'MOZ_NO_REMOTE': '1', 17:13:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:32 INFO - 'NO_EM_RESTART': '1', 17:13:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:32 INFO - 'PWD': '/builds/slave/test', 17:13:32 INFO - 'SHELL': '/bin/bash', 17:13:32 INFO - 'SHLVL': '1', 17:13:32 INFO - 'TERM': 'linux', 17:13:32 INFO - 'TMOUT': '86400', 17:13:32 INFO - 'USER': 'cltbld', 17:13:32 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450228328.749263-955132104', 17:13:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:32 INFO - '_': '/tools/buildbot/bin/python'} 17:13:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:32 INFO - Downloading/unpacking jsonschema 17:13: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 17:13: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 17:13: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 17:13: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 17:13: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 17:13: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 17:13:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:13:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 17:13:34 INFO - Downloading/unpacking functools32 (from jsonschema) 17:13: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 17:13: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 17:13: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 17:13: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 17:13: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 17:13: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 17:13:34 INFO - Downloading functools32-3.2.3-2.tar.gz 17:13:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 17:13:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:13:34 INFO - warning: no files found matching '*.txt' 17:13:34 INFO - no previously-included directories found matching 'build' 17:13:34 INFO - no previously-included directories found matching 'dist' 17:13:34 INFO - no previously-included directories found matching '.git*' 17:13:34 INFO - Installing collected packages: jsonschema, functools32 17:13:34 INFO - Running setup.py install for functools32 17:13:34 INFO - warning: no files found matching '*.txt' 17:13:34 INFO - no previously-included directories found matching 'build' 17:13:34 INFO - no previously-included directories found matching 'dist' 17:13:34 INFO - no previously-included directories found matching '.git*' 17:13:34 INFO - Successfully installed jsonschema functools32 17:13:34 INFO - Cleaning up... 17:13:34 INFO - Return code: 0 17:13:34 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:13: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')]} 17:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13: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')]} 17:13:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8b522ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa8240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10370b0>, '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 0x1037fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038440>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450228328.749263-955132104', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:13: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', 'flake8'] in /builds/slave/test/build 17:13: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 flake8 17:13:34 INFO - Using env: {'DISPLAY': ':0', 17:13:34 INFO - 'HOME': '/home/cltbld', 17:13:34 INFO - 'LANG': 'en_US.UTF-8', 17:13:34 INFO - 'LANGUAGE': 'en_US:en', 17:13:34 INFO - 'LOGNAME': 'cltbld', 17:13:34 INFO - 'MAIL': '/var/mail/cltbld', 17:13:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:34 INFO - 'MOZ_NO_REMOTE': '1', 17:13:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:34 INFO - 'NO_EM_RESTART': '1', 17:13:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:34 INFO - 'PWD': '/builds/slave/test', 17:13:34 INFO - 'SHELL': '/bin/bash', 17:13:34 INFO - 'SHLVL': '1', 17:13:34 INFO - 'TERM': 'linux', 17:13:34 INFO - 'TMOUT': '86400', 17:13:34 INFO - 'USER': 'cltbld', 17:13:34 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450228328.749263-955132104', 17:13:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:34 INFO - '_': '/tools/buildbot/bin/python'} 17:13:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:34 INFO - Downloading/unpacking flake8 17:13: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 17:13: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 17:13: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 17:13: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 17:13: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 17:13: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 17:13:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:13:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 17:13:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:13: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 17:13: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 17:13: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 17:13: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 17:13: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 17:13: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 17:13:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:13:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 17:13:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:13: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 17:13: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 17:13: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 17:13: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 17:13: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 17:13: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 17:13:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 17:13:36 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:13: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 17:13: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 17:13: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 17:13: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 17:13: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 17:13: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 17:13:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 17:13:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:13:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:13:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:13:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:13:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:13:37 INFO - no previously-included directories found matching 'docs/_build' 17:13:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:13:37 INFO - Running setup.py install for pep8 17:13:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:13:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:13:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:13:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:13:37 INFO - no previously-included directories found matching 'docs/_build' 17:13:37 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:13:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:13:37 INFO - Cleaning up... 17:13:37 INFO - Return code: 0 17:13:37 INFO - Running post-action listener: _resource_record_post_action 17:13:37 INFO - Running post-action listener: _start_resource_monitoring 17:13:37 INFO - Starting resource monitoring. 17:13:37 INFO - ##### 17:13:37 INFO - ##### Running install step. 17:13:37 INFO - ##### 17:13:37 INFO - Running pre-action listener: _resource_record_pre_action 17:13:37 INFO - Running main action method: install 17:13:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:13:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:13:37 INFO - Reading from file tmpfile_stdout 17:13:37 INFO - Detecting whether we're running mozinstall >=1.0... 17:13:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:13:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:13:37 INFO - Reading from file tmpfile_stdout 17:13:37 INFO - Output received: 17:13:37 INFO - Usage: mozinstall [options] installer 17:13:37 INFO - Options: 17:13:37 INFO - -h, --help show this help message and exit 17:13:37 INFO - -d DEST, --destination=DEST 17:13:37 INFO - Directory to install application into. [default: 17:13:37 INFO - "/builds/slave/test"] 17:13:37 INFO - --app=APP Application being installed. [default: firefox] 17:13:37 INFO - mkdir: /builds/slave/test/build/application 17:13:37 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'] 17:13:37 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 17:13:52 INFO - Reading from file tmpfile_stdout 17:13:52 INFO - Output received: 17:13:52 INFO - /builds/slave/test/build/application/firefox/firefox 17:13:52 INFO - Running post-action listener: _resource_record_post_action 17:13:52 INFO - ##### 17:13:52 INFO - ##### Running run-tests step. 17:13:52 INFO - ##### 17:13:52 INFO - Running pre-action listener: _resource_record_pre_action 17:13:52 INFO - Running main action method: run_tests 17:13:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:13:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:13:52 INFO - Python 2.7.3 17:13:52 INFO - Return code: 0 17:13:52 INFO - grabbing minidump binary from tooltool 17:13:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:52 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 0x10370b0>, '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 0x1037fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1038440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:13:52 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:13:52 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:13:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:13:52 INFO - Return code: 0 17:13:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:13:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:13:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:13:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:13:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:13:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:13:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:13:53 INFO - Return code: 0 17:13:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost'] in /builds/slave/test/build 17:13:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --webServer localhost 17:13:53 INFO - Using env: {'DISPLAY': ':0', 17:13:53 INFO - 'HOME': '/home/cltbld', 17:13:53 INFO - 'LANG': 'en_US.UTF-8', 17:13:53 INFO - 'LANGUAGE': 'en_US:en', 17:13:53 INFO - 'LOGNAME': 'cltbld', 17:13:53 INFO - 'MAIL': '/var/mail/cltbld', 17:13:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:13:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:13:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:53 INFO - 'MOZ_NO_REMOTE': '1', 17:13:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:13:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:53 INFO - 'NO_EM_RESTART': '1', 17:13:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:53 INFO - 'PWD': '/builds/slave/test', 17:13:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:13:53 INFO - 'SHELL': '/bin/bash', 17:13:53 INFO - 'SHLVL': '1', 17:13:53 INFO - 'TERM': 'linux', 17:13:53 INFO - 'TMOUT': '86400', 17:13:53 INFO - 'USER': 'cltbld', 17:13:53 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450228328.749263-955132104', 17:13:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:53 INFO - '_': '/tools/buildbot/bin/python'} 17:13:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost'] with output_timeout 3600 17:13:53 INFO - mozversion INFO | application_buildid: 20151215155559 17:13:53 INFO - mozversion INFO | application_changeset: ed5eee4f80f9e7ec86bafc60bc2de8c5c7d0415f 17:13:53 INFO - mozversion INFO | application_display_name: Nightly 17:13:53 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:13:53 INFO - mozversion INFO | application_name: Firefox 17:13:53 INFO - mozversion INFO | application_remotingname: firefox 17:13:53 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 17:13:53 INFO - mozversion INFO | application_vendor: Mozilla 17:13:53 INFO - mozversion INFO | application_version: 46.0a1 17:13:53 INFO - mozversion INFO | platform_buildid: 20151215155559 17:13:53 INFO - mozversion INFO | platform_changeset: ed5eee4f80f9e7ec86bafc60bc2de8c5c7d0415f 17:13:53 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 17:13:53 INFO - mozversion INFO | platform_version: 46.0a1 17:13:53 INFO - 2015-12-15 17:13:53,458 DEBUG : using testdate: 1450228433 17:13:53 INFO - 2015-12-15 17:13:53,458 DEBUG : actual date: 1450228433 17:13:53 INFO - 2015-12-15 17:13:53,473 INFO : starting webserver on 'localhost:49453' 17:13:53 INFO - 2015-12-15 17:13:53,474 INFO : Starting test suite talos-linux64-ix-062.e 17:13:53 INFO - 2015-12-15 17:13:53,475 INFO : Starting test dromaeo_css 17:13:53 INFO - 2015-12-15 17:13:53,475 DEBUG : operating with platform_type : linux_ 17:13:53 INFO - 2015-12-15 17:13:53,475 INFO : Initialising browser for dromaeo_css test... 17:13:53 INFO - 2015-12-15 17:13:53,492 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprWoUbh/profile http://localhost:49453/getInfo.html 17:13:58 INFO - 2015-12-15 17:13:58,528 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:13:58 INFO - 2015-12-15 17:13:58,528 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:13:58 INFO - 2015-12-15 17:13:58,529 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:13:58 INFO - 2015-12-15 17:13:58,529 DEBUG : BROWSER_OUTPUT: __metrics 17:13:58 INFO - 2015-12-15 17:13:58,650 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:13:59 INFO - 2015-12-15 17:13:59,574 INFO : Browser initialized. 17:13:59 INFO - 2015-12-15 17:13:59,574 INFO : Running cycle 1/1 for dromaeo_css test... 17:13:59 INFO - 2015-12-15 17:13:59,574 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprWoUbh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:14:11 INFO - 2015-12-15 17:14:11,559 DEBUG : BROWSER_OUTPUT: RSS: Main: 143167488 17:14:11 INFO - 2015-12-15 17:14:11,559 DEBUG : BROWSER_OUTPUT: 17:15:01 INFO - 2015-12-15 17:15:01,183 DEBUG : BROWSER_OUTPUT: 1450228501181 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:17:13 INFO - 2015-12-15 17:17:13,285 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49453/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49453/tests/dromaeo/cssquery-ext.html) 17:17:14 INFO - 2015-12-15 17:17:14,495 DEBUG : BROWSER_OUTPUT: RSS: Main: 146874368 17:17:14 INFO - 2015-12-15 17:17:14,496 DEBUG : BROWSER_OUTPUT: 17:20:16 INFO - 2015-12-15 17:20:16,631 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49453/tests/dromaeo/cssquery-ext.html (next: http://localhost:49453/tests/dromaeo/cssquery-jquery.html) 17:20:17 INFO - 2015-12-15 17:20:17,232 DEBUG : BROWSER_OUTPUT: RSS: Main: 147275776 17:20:17 INFO - 2015-12-15 17:20:17,233 DEBUG : BROWSER_OUTPUT: 17:23:19 INFO - 2015-12-15 17:23:19,111 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49453/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49453/tests/dromaeo/cssquery-mootools.html) 17:23:19 INFO - 2015-12-15 17:23:19,717 DEBUG : BROWSER_OUTPUT: RSS: Main: 145039360 17:23:19 INFO - 2015-12-15 17:23:19,717 DEBUG : BROWSER_OUTPUT: 17:26:21 INFO - 2015-12-15 17:26:21,454 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49453/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49453/tests/dromaeo/cssquery-prototype.html) 17:26:22 INFO - 2015-12-15 17:26:22,060 DEBUG : BROWSER_OUTPUT: RSS: Main: 144384000 17:26:22 INFO - 2015-12-15 17:26:22,060 DEBUG : BROWSER_OUTPUT: 17:29:24 INFO - 2015-12-15 17:29:24,709 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49453/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49453/tests/dromaeo/cssquery-yui.html) 17:29:25 INFO - 2015-12-15 17:29:25,301 DEBUG : BROWSER_OUTPUT: RSS: Main: 144297984 17:29:25 INFO - 2015-12-15 17:29:25,301 DEBUG : BROWSER_OUTPUT: 17:32:27 INFO - 2015-12-15 17:32:27,539 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49453/tests/dromaeo/cssquery-yui.html (next: http://localhost:49453/tests/dromaeo/cssquery-dojo.html) 17:32:27 INFO - 2015-12-15 17:32:27,789 DEBUG : BROWSER_OUTPUT: RSS: Main: 147156992 17:32:27 INFO - 2015-12-15 17:32:27,789 DEBUG : BROWSER_OUTPUT: 17:32:27 INFO - 2015-12-15 17:32:27,789 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:32:27 INFO - 2015-12-15 17:32:27,789 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:32:27 INFO - 2015-12-15 17:32:27,790 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:32:27 INFO - 2015-12-15 17:32:27,790 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:32:27 INFO - 2015-12-15 17:32:27,790 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2663.187727743038;2705.0667519705694;2717.605947137665;2722.047283450792;2729.836209827409;4639.724075879135;4730.124926888524;4769.95230047699;4795.064962332347;4837.443693975194;4688.929666055012;4728.456227533835;4729.668923175371;4735.71585704858;4750.334953106568;4323.675724320673;4433.866983990485;4451.332300154971;4459.88850278744;4467.039586488896;4163.188178305231;4386.276264416368;4440.955590444087;4452.7328360298325;4510.819567217307;4330.415393921811;4460.30865215892;4460.910781784379;4485.416895803557;4491.348754430589;4446.6220371268155;4448.421705178306;4469.597736203757;4490.820367185309;4507.977460112711;4217.557156498585;4289.6997210195295;4306.849260275907;4431.578999994996;4464.821407143743;4655.045715628288;4677.111348843743;4717.410323709536;4738.715677059387;4766.356541866839;5143.897122057575;5146.9485305146845;5154.38147422308;5154.613403994678;5166.276721258989;4958.776855041496;5026.773795179226;5050.621203409759;5058.873528161826;5229.947700522984;4679.74261415622;4690.624750019991;4718.693284936468;4751.097291514601;4768.546988036131;5259;5346.385165705916;5346.8663283417445;5350.170723537858;5398.055340315429;4783.306420569068;4889.119958407521;5096.668716533413;5114.769835357343;5126.2054381570915;5102.489751024942;5120;5170.302009228706;5170.793168273227;5209.0363282792805;5068.290439338495;5068.847934561969;5106.846794596168;5110.974445127825;5126.820561280338;4872.171730805771;4946.332245146931;4949.752512374367;5071.974640126776;5082.517160869711;4247.745135291892;4277.187334406515;4281.036766727524;4309.202797482476;4326.805293761789;3736.6076561961145;3748.7750734955443;3752.493413389212;3793.1275806564095;3797.5442946846;4239.894002649959;4295.162443323585;4315.741055536678;4317.395564620955;4485.708428952108;5000.224965130338;5083.262926875583;5102.953894451629;5105.055564720538;5129.179331306973;4409.470863496337;4419.779011049434;4452.755098469551;4453.1761624099645;4483.30508771141;4323.200207961537;4397.670174736908;4409.206342858316;4540.977295113504;4552.9772351138035;4633.72197668141;4772.49888761675;4883.267509873405;4895.4370247422;4911.950880491292;5113.207452844815;5129.461406552258;5148.6910785353;5150.536451719363;5204.401493828258;4762.809487620595;4873.293372460902;4922.72924989129;4939;4961.82633607822;5013.172826483736;5025.547700706954;5088.0587091388215;5088.567471764942;5126.102931986813;5095.363079615048;5158.787684894122;5159.535641792257;5172.818951336685;5189.273501709688;4814.638902082288;4933.284673722362;4958.925616115834;4986.227134794112;4988.27669987857;4827.203511420576;4893.584045356185;4895.926561101515;4924.926126108183;4980.551750342486;4867.780949857336;4918.6065114791445;4924.384451943507;4938.975305123595;4994.475580064186;4791.089692958327;4944.802207911644;4959.107360674969;5065.696058236517;5113.667611605234;4949.282354058713;4949.604031677385;4967.850964471072;4977.4524802271;5016.673916195582 17:32:27 INFO - 2015-12-15 17:32:27,790 DEBUG : BROWSER_OUTPUT: |1;ext.html;568.074039315915;579.6087640842431;581.5405829394779;581.8719881626046;587.5681374189969;36565;37538.18463615226;37648.43527347092;37657.81171094141;37804;39694.8015259924;40154.59845401545;40165;40331.19337613246;40382.7980860096;7913.920860791376;7990.360771138295;8020.11778704342;8042.195780421969;8045.477043992151;7776.883346749803;7940.40446966477;7942.563159026251;7953.642086106111;7967.282944534991;7927.207279272085;7947.165547617475;8043.839123217532;8061.355091592659;8090.190980901922;7743.767686969371;7974.3221826144845;7974.401919856034;7981.241782030698;8011.639476223584;7778.0666320041955;7901.1703771103785;7906.288434040906;7916.1688022757935;7917.881231781528;36850;37597.62402375969;37831.432528512094;37904;37904.620953790385;3253.7559683023633;3273.492608645664;3367.646397128315;3701.8519259229597;3711.7030637548933;27759;27850.442991140266;28171.859140704164;28187.15438536847;28213.758370910346;3357.842526357763;3372.409828280041;3386.221169131089;3457.2566898116775;3492.441209406483;200151;201937;202653;203239;205736;50773.23840142401;53140.46859531433;53480.19779703308;53622.46377536253;53704.46295536995;45439.091218175454;63688;64632.676836616454;65018;65152;13837.962152838376;13918.51285205013;14007.229602371968;14068.43726250959;14080.647983800487;10310.484475776182;10330.380177189392;10336.17310615149;10372.740681482872;10374;18706.812931870507;18902.621947561245;18964.715529267072;19038.33365832189;19107.331243406414;7148.744848257775;7276.6725497352745;7406.777796666109;7428.591427471433;7474;844.9408541402166;846.4540371460373;870.260278763059;899.3030401438937;1052.8210204265292;23562.42488055397;23856.57876460895;23885.402374572;24101.638475422882;24192.7580724194;932.5430539035959;984.5766320482118;986.3785814936545;1078.396098185019;1131.5417256011328;13622.250776207404;14777.26113694311;15003.32485038176;15195.316210770541;15437.768433473508;252204;255824;256005;257423;257789;45896.3115553267;46159.07681846344;46435.76782116135;46519.76740116345;46545.534544654794;1194.8446701928694;1204.933728644933;1235.9629211123502;1242.45332053896;1348.3393137362818;26656.200313990612;27078.593821092305;27116.32209194786;27177.86411067932;27703.168904932885;39828.40257396199;39933.80033099816;40132;40161;40342.39486407765;239299;240377;241290;241333;241604;27970.860145699142;28533.571996420487;29103.8358465659;29294;29370.706292936797;35833.92498225057;36676.44985325169;36731.63268367282;37151.62848371482;37610.247795044495;31440.68559314469;31474.111553306873;31508.84245578849;32961.83519082389;33183.336333273684;29056.41887162287;29374.853125734233;29494.557581636724;29557;29944.550831737975;29808.403831923675;29846.403071938876;29917.850410747807;30141.095767127023;30180;25415;26707;27094.458110838066;27129.59305610378;27184;23091.422714431603;23379.649305260096;23689.17087901915;25054.248372548125;25113 17:32:27 INFO - 2015-12-15 17:32:27,794 DEBUG : BROWSER_OUTPUT: |2;jquery.html;329.08022078291174;332.91510664780475;333.4897606661807;333.5197315865154;334.73723127345033;14844.40622375105;15417.922910385447;15677.764833527492;15877.603059923507;16462.917685411587;9814.116729494363;10047.447390393525;12795.296258705768;14684.192369419678;14800.629984250372;4473.865784026476;4576.519465456129;4599.816007359718;4713.34013238147;5014.348134742479;4883.413990321149;4925.82759603414;4929.088118698034;4934.383202099738;4954.355933728628;3448.5689288838894;3575.660312270343;4879.512048795127;4893.730844803535;6340.207474065742;6500.642464664442;6540.149780528524;6550.606963582152;6571.967140164268;6585.604863708193;6176.351483094255;6323.177986861724;6335.208098987627;6361.332060133712;6420.0690899819265;19106.617867642708;19256.22975080995;19377;19729.605407891904;19839.404817855488;1953.8827670339824;1990.233760002395;1994.3418671838258;2033.9796602034087;2133.5946170227608;13367.331633418291;13549.661258468519;13809.171449713049;13834.169949803045;14172.50396236137;1789.7225929980873;1812.2026308424252;1826.5707558723689;1860.4697661166638;1867.1971052447443;60127.26665703287;63288;63849;64493.67753161251;64616.179891445136;14825.92587037058;15092.245387730569;15190.316435760416;15227;15227.162506062052;23109;23140.768592314198;23197;23270.301890943298;23315.300540983797;8705.47767133974;8806.955965220133;8826.823463530693;8877.24543413817;8934.86597701035;7407.296306850841;7456.142543607554;7515.436342274351;7542;7584.772456826304;7359.889601655979;7484.738034168887;7501.887471687929;7512.173660897297;7538;2970.5098658721067;3097;3106.2079169811554;3205.6153261608756;3233.2401885556874;346.68798081726146;348.19740498152004;362.9183433727443;368.4123822503103;974.9268804839666;9380.343375963617;15215.695686086216;15247;15760.842391575938;16161.838381616268;821.8068753842842;848.440029580474;851.5401683091061;881.5063564403954;888.2982443869271;8695.304375649934;8754.824903502022;8881.467111973174;9160;9230.215431688248;310383;321569;479672;480261;481143;59399.81200375968;60985.69507152436;63832.36167638357;72995.27004729991;73144.2685573148;1043.89561043895;1075.8171110911164;1076.192855358497;1076.311160857052;1076.3757020927842;14139.929300353844;14239.928800355932;14465.349059292146;14499.432678706175;14670.926645367132;31784.36431271408;32408.35183296368;32480;32553.186170345933;33230.83384583062;38367.65713200025;38527;39736;39945.60054399419;41479;8695.130486951255;8937.865932010895;8979.865302020344;9021;9039.502827344297;14748.926255368655;15613;15952;16111.194440278174;16410.507684769476;11724.237924534878;13282.86717132855;13409.32953352309;13597.912167026812;13646.454141834216;13064.34678266064;13124.934375328063;13392.662044854002;13528.39122239482;13564.253966031964;14230.573082807532;14345.64135896611;14382.784258236345;14464.927675361556;14543;8767.912320876709;8769.473831570127;8770.473771573726;8783.736487905373;8817.559122044;13907.860921390657;13938.233397163254;13942.58172254834;14065.648358791112;14174.220417877115 17:32:27 INFO - 2015-12-15 17:32:27,795 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1489.7169537787813;1627.63378239896;1709.487153853844;1718.87967842251;1725.4392322495185;6117.357677443871;6249.968750156243;6789.42289905358;7178.174509931359;7247.528910620813;6689.431398331136;6881.621510816903;6957.547759395636;6959;6982.1272340957385;2059.042545216474;2082.541840795023;2096.2453516733963;2096.8217701495314;2100.359390385932;2079.272254710854;2090.80137386948;2107.6522373808302;2110.2192188890053;2127.4362293992103;2004.2784597544871;2049.75402951646;2051.7640471345762;2052.1791283486577;2053.9281125160624;2076.470500022492;2084.5726626041624;2104.610647030289;2105.3894370632497;2109.5675386545877;2058.9279375221795;2066.5763518478675;2067.648499755045;2085.697573851798;2086.5931143427038;6891.2764159763;6947.617881016542;6955.304469553055;6967.512274140812;6980.650967451607;4152.795689250114;4233.915321693579;4244.681648876347;4257.318828987347;4259.424977628042;2716.755492005729;2755.4213615140843;2759.075709637274;2761.2130542795207;2778.7360200780895;799.9440039197259;835.5446281776385;841.4656692999928;858.5964596639569;866.1728049712509;9778.462184579845;9937.850932236095;9940.502974851228;9943;9956.352837065568;3889.7082718796205;3898.8245528951265;3951.5060617422823;3957.5250969883223;3975.940360894589;8469.491830490191;8474.237318641352;8499.660013599387;8528;8542.145785421408;4231.661467082626;4242.406063151161;4246.660267178619;4264.104538046983;4277.529471758104;3250.691184337484;3291.391092647868;3789.5831458539537;3840.020794697334;3861.0540417597867;3273.1817045738567;3307.4212012897647;3316.137804170933;3331.4003479373946;3332.9834400507593;1043.5251960358019;1055.5408397347178;1061.9628313009162;1064.0742553977934;1067.2049323254225;1142.657202839145;1157.1899670230873;1157.9363135027654;1176.405915012913;1222.095649219589;6673.799786006428;6695.966520167368;6717.966410167918;6743.494237932076;6763;386.6037311755473;393.3293734183211;393.3686433274553;393.6339204539805;395.01246882793015;5263.947360526422;5340.893182136336;5383.757730902119;5388.622796404214;5409.83770486886;8581.098984606526;8789.736307910645;8810.118988101138;8832.072632373636;8855;8562.529060901586;8657.783555411164;8692.652293908299;8697.304215662733;8720.563971801512;6835.213950395669;6877.346652068046;6888;6914.827129321807;6920.826979325557;6488.416042556004;6561.967190164019;6573.704183311666;6587.308332625005;6624.768133115318;7562.281583249583;7684.807879803049;7781.9610901945125;7806.1803510632835;7808.375329973702;7857.135715071452;7988.161243069394;8054.919450805417;8073.233042860918;8082.717104901535;5097.311862898609;5156.20078887773;6302.684865756785;6392.872142557216;6441.742330306735;6519.967400162969;6710.295418981132;6718.328167183438;6729.2934241903895;6730.629815360202;6197.81406557804;6211.9689401552705;6323.747050117944;6364.554481186273;6446.258680251831;6183.598066125687;6253.937460625336;6269.843253918689;6328.398802113792;6362.3319551448285;6675.732970681119;6722.495812813961;6727.629980351127;6744.190697116377;6750.1562304711915;5957.106434034929;5969.970150149222;5983.910241346471;6005.978983572891;6016.8796624068145;5935.970320148372;5948.553858460719;5970.701464926649;5985.1022346646605;6145.139680444652 17:32:27 INFO - 2015-12-15 17:32:27,796 DEBUG : BROWSER_OUTPUT: |4;prototype.html;293.69162379501546;294.0692707580508;296.89015064426167;301.9894303699371;305.22320693834195;5476.959377718231;5547.972260138704;5591.133374326981;5657;5755.9927012772705;5550.7224638768;5614.214010038598;5625.943740562593;5626.578006649507;5639.295088113986;4196.39152322913;4289.742615443076;4292.549282325358;4292.828286868522;4301.376300436435;4235.08945576701;4248.192843359767;4251.362295655661;4252.532221455637;4272.252355837732;4177.018400675839;4204.810783514749;4208.873733787991;4211.241976444254;4213.052063285767;4151.27352713274;4161.271777438967;4170.249355116078;4189.937150942738;4197.706160568746;3743.644353786386;3754.873537938635;3755.530558680165;3759.51126353575;3760.5863355030924;5254.500822421864;5392.487713667196;5421.213923981;5422.43064478232;5422.864428389283;4917.188663870457;4917.459079501252;4925.655204135712;4927.753612319406;4936.48166942473;5917.14201440793;5929.080992446135;5932.436418540232;5942.8811423771285;5957.374475680078;4055.6147166019477;4055.959440405617;4061.0253539150685;4063.9796801015805;4069.3285607874664;5997.760089596454;6094.451499365034;6221.191245138103;6235.9376406235815;6242.6878656067465;4068.9796551017057;4105.67154627629;4108.609682080198;4112.732672376345;4114.341705327133;4165.10450253191;4165.479315085614;4167.854125105607;4172.561881002512;4173.31140361843;4823.204171311694;4829.7585120744525;4854.975725121351;4857.635677324215;4870.902581948412;5656.971715141481;5857.824265272048;5874.236349274567;5920.407959204132;5939.4357536034;1491.6867457833976;1516.097921736565;1532.3334349557979;1534.232883558221;1535.5777161280737;1025.4718819807806;1036.9325993810378;1044.5717255925035;1051.8842927277992;1056.572088304238;5084.51697088776;5092.599535127795;5101.51535604117;5116.488351164928;5133;6041.305249896231;6062.242219722535;6134.662593557308;6199.969000154971;6214.161088253119;5134.922976155286;5144.742762861917;5164.070467315919;5171.974140129275;5184.8963020739375;3295.9340813183603;3298.142482954449;3337.6829201225846;3342.632310445849;3351.865925362958;5630.183623374588;5753.8561535961935;5756.827295181151;5775.960327141155;5789.739461724233;6290.056491526216;6325.082862984841;6326.145970294044;6330.588511746814;6350.968245158745;5705.885882282248;5755.99270127726;5759.85600359986;5785.103308987113;5794.536437085023;6133.6319820810895;6137.447629713347;6144.262688477412;6145.846353841011;6167.84580385494;5835.328937172279;5981.192539007178;5999.370066142992;6001.2498437695285;6004.0693692477735;5757.0788673811985;5771.68255745938;5771.932192544393;5782.971085144547;5788.21859049023;4078.4494093297026;4086.2849001425225;4106.240345536085;4122.7114102013775;4131.235721391552;6032.426919442646;6104.694765261808;6143;6153.169322141453;6172.783952561639;5846.064629659404;5872.647641141545;5905.409459054232;5926.496247818984;5942.1383899335215;5820.5925585210325;5835.1247312901705;5837.795677151279;5868.149118377897;5893.292804863444;5568.359638641446;5761.971190144022;5783.074708046693;5796.42035796417;5816.76732930678;5941.554383421174;5958.34458209588;5977.462028417463;5980.252468441445;5980.521558275241;5804.65172089676;5820.76716931318;5823.039198532195;5825.126231065374;5830.4461076197695 17:32:27 INFO - 2015-12-15 17:32:27,798 DEBUG : BROWSER_OUTPUT: |5;yui.html;776.7320274505294;781.8514482248372;787.5235482533063;789.4552758596571;813.2680587471275;10528.631497897575;10610.893891061107;10624.415657138863;10635.52140153693;10684.732881677963;11656.941715291432;11850.525978960854;11850.881491185086;11949;11982.281063136217;774.0556521044317;780.8906753054576;786.0645831460544;786.5084322298563;792.4413288631501;777.8055486128468;782.1435528096725;782.5969625642798;787.6731156570045;789.0649580247425;816.5386556595535;826.5701835045772;828.7555171224473;830.4519017448486;837.0875745437472;827.4290739389802;827.6441130313963;828.4904783558129;829.722043115554;831.629924683516;609.1958614628692;612.3478495402383;615.6213928434025;616.4944745308849;617.4658920034138;10111.19110471168;10119.241056920686;10216.182705383551;10232.64185753495;10241.385516868937;9695.224382049419;10202.285839991204;11154.386508742016;11188.888111118866;11243.100551955824;9545.809083818354;9574.521273936345;9586.137247647745;9787.412755234638;9831.655892043744;3247.1395080303737;3251.4472539668077;3262.9184270393193;3290.161008942728;3335.7498187635783;36835.63164368349;37303.88088357353;38340.424893626616;38343.616563834286;41514.58485415138;8948.507832069168;8991.010988791228;9362.34463587556;9481.288903332277;9835.901640983499;16156.596085097966;16398.426055088254;16471.505854824376;16506;16512.09183494895;6200.286966998763;6247.500199983991;6250.4374606285655;6270.090836828635;6300.747970081237;3609.4946707460977;3637.836297366625;3643;3671.4492826076303;3722.2927643747603;2613.372790530259;2641.0228215560364;2641.4981153581143;2651.3239124023253;2660.547706889795;484.6123101518841;487.75124686409475;489.18062245738247;490.6663468841151;493.8592501137231;532.5952276270062;619.0664556961954;644.0596728775946;650.9641969691618;651.46905272203;7567.129780075252;8002.159773223844;8241.629126689313;8247.422680412434;8427.95786021066;629.9149614802035;650.7624716978269;663.0882536512296;670.3865962644223;675.3044364304774;3765.3975363941636;3816.656500914931;3887.319719049155;3921.705872059607;4016.7188296819527;50428.24357634639;50785.74607126941;51024.74487627538;51122.233166502534;51775;41667.583324166975;43475.56524434715;43860;46743.5325646746;47011.5298847014;38446.42330365047;41544.37683434751;43237;45305.77347113309;45750.77124614356;8135;8283.792905177419;8450.267695122362;8556.486610803371;8731.345149113715;31860.203494912814;31999.36001279915;32068.67931320657;33399.49900751442;33679;38466.42300365441;38668.22663546657;40374.39438408485;41053.768386947246;41251.38122928098;9470.715878523655;9757.80484390294;9944.204463642747;10001.699949001542;10234;11087;11184.891685249962;11190.104791616488;11235.697598541336;11278.718032048937;10856.077233434931;10859.511321990687;10899.618513351994;11179.552817887194;11411.60059397917;10728;10917.890821092005;10988.615398461016;11017.11863050938;11022.779544408906;10406.271560990657;10627.840582391425;10777.784444311226;10830.241883068109;10830.67507974762;9435.622575097193;9437.858432123387;9699.951500242736;9717.6598819041;9721;8913.777155570902;9327.253819694544;9362.719118426457;9415.011423800403;9454.101860323259 17:32:27 INFO - 2015-12-15 17:32:27,798 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:32:27 INFO - 2015-12-15 17:32:27,798 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:32:27 INFO - 2015-12-15 17:32:27,798 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,331 17:32:27 INFO - 2015-12-15 17:32:27,798 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:32:27 INFO - 2015-12-15 17:32:27,799 DEBUG : BROWSER_OUTPUT: __startTimestamp1450229547787__endTimestamp 17:32:27 INFO - 2015-12-15 17:32:27,799 DEBUG : BROWSER_OUTPUT: 17:32:27 INFO - 2015-12-15 17:32:27,799 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:32:27 INFO - 2015-12-15 17:32:27,799 DEBUG : BROWSER_OUTPUT: Number of tests: 6 17:32:27 INFO - 2015-12-15 17:32:27,799 DEBUG : BROWSER_OUTPUT: 17:32:27 INFO - 2015-12-15 17:32:27,799 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4716.78 Median:4867.78 stddev:498.54 (10.2%) stddev-sans-first:473.32 17:32:27 INFO - 2015-12-15 17:32:27,800 DEBUG : BROWSER_OUTPUT: Values: 2663.2 2705.1 2717.6 2722.0 2729.8 4639.7 4730.1 4770.0 4795.1 4837.4 4688.9 4728.5 4729.7 4735.7 4750.3 4323.7 4433.9 4451.3 4459.9 4467.0 4163.2 4386.3 4441.0 4452.7 4510.8 4330.4 4460.3 4460.9 4485.4 4491.3 4446.6 4448.4 4469.6 4490.8 4508.0 4217.6 4289.7 4306.8 4431.6 4464.8 4655.0 4677.1 4717.4 4738.7 4766.4 5143.9 5146.9 5154.4 5154.6 5166.3 4958.8 5026.8 5050.6 5058.9 5229.9 4679.7 4690.6 4718.7 4751.1 4768.5 5259.0 5346.4 5346.9 5350.2 5398.1 4783.3 4889.1 5096.7 5114.8 5126.2 5102.5 5120.0 5170.3 5170.8 5209.0 5068.3 5068.8 5106.8 5111.0 5126.8 4872.2 4946.3 4949.8 5072.0 5082.5 4247.7 4277.2 4281.0 4309.2 4326.8 3736.6 3748.8 3752.5 3793.1 3797.5 4239.9 4295.2 4315.7 4317.4 4485.7 5000.2 5083.3 5103.0 5105.1 5129.2 4409.5 4419.8 4452.8 4453.2 4483.3 4323.2 4397.7 4409.2 4541.0 4553.0 4633.7 4772.5 4883.3 4895.4 4912.0 5113.2 5129.5 5148.7 5150.5 5204.4 4762.8 4873.3 4922.7 4939.0 4961.8 5013.2 5025.5 5088.1 5088.6 5126.1 5095.4 5158.8 5159.5 5172.8 5189.3 4814.6 4933.3 4958.9 4986.2 4988.3 4827.2 4893.6 4895.9 4924.9 4980.6 4867.8 4918.6 4924.4 4939.0 4994.5 4791.1 4944.8 4959.1 5065.7 5113.7 4949.3 4949.6 4967.9 4977.5 5016.7 17:32:27 INFO - 2015-12-15 17:32:27,801 DEBUG : BROWSER_OUTPUT: 17:32:27 INFO - 2015-12-15 17:32:27,801 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39378.10 Median:3362.74 stddev:60978.46 (1813.4%) stddev-sans-first:61079.89 17:32:27 INFO - 2015-12-15 17:32:27,801 DEBUG : BROWSER_OUTPUT: Values: 568.1 579.6 581.5 581.9 587.6 36565.0 37538.2 37648.4 37657.8 37804.0 39694.8 40154.6 40165.0 40331.2 40382.8 7913.9 7990.4 8020.1 8042.2 8045.5 7776.9 7940.4 7942.6 7953.6 7967.3 7927.2 7947.2 8043.8 8061.4 8090.2 7743.8 7974.3 7974.4 7981.2 8011.6 7778.1 7901.2 7906.3 7916.2 7917.9 36850.0 37597.6 37831.4 37904.0 37904.6 3253.8 3273.5 3367.6 3701.9 3711.7 27759.0 27850.4 28171.9 28187.2 28213.8 3357.8 3372.4 3386.2 3457.3 3492.4 200151.0 201937.0 202653.0 203239.0 205736.0 50773.2 53140.5 53480.2 53622.5 53704.5 45439.1 63688.0 64632.7 65018.0 65152.0 13838.0 13918.5 14007.2 14068.4 14080.6 10310.5 10330.4 10336.2 10372.7 10374.0 18706.8 18902.6 18964.7 19038.3 19107.3 7148.7 7276.7 7406.8 7428.6 7474.0 844.9 846.5 870.3 899.3 1052.8 23562.4 23856.6 23885.4 24101.6 24192.8 932.5 984.6 986.4 1078.4 1131.5 13622.3 14777.3 15003.3 15195.3 15437.8 252204.0 255824.0 256005.0 257423.0 257789.0 45896.3 46159.1 46435.8 46519.8 46545.5 1194.8 1204.9 1236.0 1242.5 1348.3 26656.2 27078.6 27116.3 27177.9 27703.2 39828.4 39933.8 40132.0 40161.0 40342.4 239299.0 240377.0 241290.0 241333.0 241604.0 27970.9 28533.6 29103.8 29294.0 29370.7 35833.9 36676.4 36731.6 37151.6 37610.2 31440.7 31474.1 31508.8 32961.8 33183.3 29056.4 29374.9 29494.6 29557.0 29944.6 29808.4 29846.4 29917.9 30141.1 30180.0 25415.0 26707.0 27094.5 27129.6 27184.0 23091.4 23379.6 23689.2 25054.2 25113.0 17:32:27 INFO - 2015-12-15 17:32:27,801 DEBUG : BROWSER_OUTPUT: 17:32:27 INFO - 2015-12-15 17:32:27,801 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25065.13 Median:16781.87 stddev:69025.87 (411.3%) stddev-sans-first:69194.51 17:32:27 INFO - 2015-12-15 17:32:27,802 DEBUG : BROWSER_OUTPUT: Values: 329.1 332.9 333.5 333.5 334.7 14844.4 15417.9 15677.8 15877.6 16462.9 9814.1 10047.4 12795.3 14684.2 14800.6 4473.9 4576.5 4599.8 4713.3 5014.3 4883.4 4925.8 4929.1 4934.4 4954.4 3448.6 3575.7 4879.5 4893.7 6340.2 6500.6 6540.1 6550.6 6572.0 6585.6 6176.4 6323.2 6335.2 6361.3 6420.1 19106.6 19256.2 19377.0 19729.6 19839.4 1953.9 1990.2 1994.3 2034.0 2133.6 13367.3 13549.7 13809.2 13834.2 14172.5 1789.7 1812.2 1826.6 1860.5 1867.2 60127.3 63288.0 63849.0 64493.7 64616.2 14825.9 15092.2 15190.3 15227.0 15227.2 23109.0 23140.8 23197.0 23270.3 23315.3 8705.5 8807.0 8826.8 8877.2 8934.9 7407.3 7456.1 7515.4 7542.0 7584.8 7359.9 7484.7 7501.9 7512.2 7538.0 2970.5 3097.0 3106.2 3205.6 3233.2 346.7 348.2 362.9 368.4 974.9 9380.3 15215.7 15247.0 15760.8 16161.8 821.8 848.4 851.5 881.5 888.3 8695.3 8754.8 8881.5 9160.0 9230.2 310383.0 321569.0 479672.0 480261.0 481143.0 59399.8 60985.7 63832.4 72995.3 73144.3 1043.9 1075.8 1076.2 1076.3 1076.4 14139.9 14239.9 14465.3 14499.4 14670.9 31784.4 32408.4 32480.0 32553.2 33230.8 38367.7 38527.0 39736.0 39945.6 41479.0 8695.1 8937.9 8979.9 9021.0 9039.5 14748.9 15613.0 15952.0 16111.2 16410.5 11724.2 13282.9 13409.3 13597.9 13646.5 13064.3 13124.9 13392.7 13528.4 13564.3 14230.6 14345.6 14382.8 14464.9 14543.0 8767.9 8769.5 8770.5 8783.7 8817.6 13907.9 13938.2 13942.6 14065.6 14174.2 17:32:27 INFO - 2015-12-15 17:32:27,802 DEBUG : BROWSER_OUTPUT: 17:32:27 INFO - 2015-12-15 17:32:27,803 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4976.33 Median:6067.12 stddev:2628.35 (43.3%) stddev-sans-first:2622.66 17:32:27 INFO - 2015-12-15 17:32:27,803 DEBUG : BROWSER_OUTPUT: Values: 1489.7 1627.6 1709.5 1718.9 1725.4 6117.4 6250.0 6789.4 7178.2 7247.5 6689.4 6881.6 6957.5 6959.0 6982.1 2059.0 2082.5 2096.2 2096.8 2100.4 2079.3 2090.8 2107.7 2110.2 2127.4 2004.3 2049.8 2051.8 2052.2 2053.9 2076.5 2084.6 2104.6 2105.4 2109.6 2058.9 2066.6 2067.6 2085.7 2086.6 6891.3 6947.6 6955.3 6967.5 6980.7 4152.8 4233.9 4244.7 4257.3 4259.4 2716.8 2755.4 2759.1 2761.2 2778.7 799.9 835.5 841.5 858.6 866.2 9778.5 9937.9 9940.5 9943.0 9956.4 3889.7 3898.8 3951.5 3957.5 3975.9 8469.5 8474.2 8499.7 8528.0 8542.1 4231.7 4242.4 4246.7 4264.1 4277.5 3250.7 3291.4 3789.6 3840.0 3861.1 3273.2 3307.4 3316.1 3331.4 3333.0 1043.5 1055.5 1062.0 1064.1 1067.2 1142.7 1157.2 1157.9 1176.4 1222.1 6673.8 6696.0 6718.0 6743.5 6763.0 386.6 393.3 393.4 393.6 395.0 5263.9 5340.9 5383.8 5388.6 5409.8 8581.1 8789.7 8810.1 8832.1 8855.0 8562.5 8657.8 8692.7 8697.3 8720.6 6835.2 6877.3 6888.0 6914.8 6920.8 6488.4 6562.0 6573.7 6587.3 6624.8 7562.3 7684.8 7782.0 7806.2 7808.4 7857.1 7988.2 8054.9 8073.2 8082.7 5097.3 5156.2 6302.7 6392.9 6441.7 6520.0 6710.3 6718.3 6729.3 6730.6 6197.8 6212.0 6323.7 6364.6 6446.3 6183.6 6253.9 6269.8 6328.4 6362.3 6675.7 6722.5 6727.6 6744.2 6750.2 5957.1 5970.0 5983.9 6006.0 6016.9 5936.0 5948.6 5970.7 5985.1 6145.1 17:32:27 INFO - 2015-12-15 17:32:27,803 DEBUG : BROWSER_OUTPUT: 17:32:27 INFO - 2015-12-15 17:32:27,803 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4864.21 Median:5512.47 stddev:1447.87 (26.3%) stddev-sans-first:1410.70 17:32:27 INFO - 2015-12-15 17:32:27,803 DEBUG : BROWSER_OUTPUT: Values: 293.7 294.1 296.9 302.0 305.2 5477.0 5548.0 5591.1 5657.0 5756.0 5550.7 5614.2 5625.9 5626.6 5639.3 4196.4 4289.7 4292.5 4292.8 4301.4 4235.1 4248.2 4251.4 4252.5 4272.3 4177.0 4204.8 4208.9 4211.2 4213.1 4151.3 4161.3 4170.2 4189.9 4197.7 3743.6 3754.9 3755.5 3759.5 3760.6 5254.5 5392.5 5421.2 5422.4 5422.9 4917.2 4917.5 4925.7 4927.8 4936.5 5917.1 5929.1 5932.4 5942.9 5957.4 4055.6 4056.0 4061.0 4064.0 4069.3 5997.8 6094.5 6221.2 6235.9 6242.7 4069.0 4105.7 4108.6 4112.7 4114.3 4165.1 4165.5 4167.9 4172.6 4173.3 4823.2 4829.8 4855.0 4857.6 4870.9 5657.0 5857.8 5874.2 5920.4 5939.4 1491.7 1516.1 1532.3 1534.2 1535.6 1025.5 1036.9 1044.6 1051.9 1056.6 5084.5 5092.6 5101.5 5116.5 5133.0 6041.3 6062.2 6134.7 6200.0 6214.2 5134.9 5144.7 5164.1 5172.0 5184.9 3295.9 3298.1 3337.7 3342.6 3351.9 5630.2 5753.9 5756.8 5776.0 5789.7 6290.1 6325.1 6326.1 6330.6 6351.0 5705.9 5756.0 5759.9 5785.1 5794.5 6133.6 6137.4 6144.3 6145.8 6167.8 5835.3 5981.2 5999.4 6001.2 6004.1 5757.1 5771.7 5771.9 5783.0 5788.2 4078.4 4086.3 4106.2 4122.7 4131.2 6032.4 6104.7 6143.0 6153.2 6172.8 5846.1 5872.6 5905.4 5926.5 5942.1 5820.6 5835.1 5837.8 5868.1 5893.3 5568.4 5762.0 5783.1 5796.4 5816.8 5941.6 5958.3 5977.5 5980.3 5980.5 5804.7 5820.8 5823.0 5825.1 5830.4 17:32:27 INFO - 2015-12-15 17:32:27,803 DEBUG : BROWSER_OUTPUT: 17:32:27 INFO - 2015-12-15 17:32:27,803 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12319.47 Median:23748.07 stddev:14006.60 (59.0%) stddev-sans-first:14019.07 17:32:27 INFO - 2015-12-15 17:32:27,804 DEBUG : BROWSER_OUTPUT: Values: 776.7 781.9 787.5 789.5 813.3 10528.6 10610.9 10624.4 10635.5 10684.7 11656.9 11850.5 11850.9 11949.0 11982.3 774.1 780.9 786.1 786.5 792.4 777.8 782.1 782.6 787.7 789.1 816.5 826.6 828.8 830.5 837.1 827.4 827.6 828.5 829.7 831.6 609.2 612.3 615.6 616.5 617.5 10111.2 10119.2 10216.2 10232.6 10241.4 9695.2 10202.3 11154.4 11188.9 11243.1 9545.8 9574.5 9586.1 9787.4 9831.7 3247.1 3251.4 3262.9 3290.2 3335.7 36835.6 37303.9 38340.4 38343.6 41514.6 8948.5 8991.0 9362.3 9481.3 9835.9 16156.6 16398.4 16471.5 16506.0 16512.1 6200.3 6247.5 6250.4 6270.1 6300.7 3609.5 3637.8 3643.0 3671.4 3722.3 2613.4 2641.0 2641.5 2651.3 2660.5 484.6 487.8 489.2 490.7 493.9 532.6 619.1 644.1 651.0 651.5 7567.1 8002.2 8241.6 8247.4 8428.0 629.9 650.8 663.1 670.4 675.3 3765.4 3816.7 3887.3 3921.7 4016.7 50428.2 50785.7 51024.7 51122.2 51775.0 41667.6 43475.6 43860.0 46743.5 47011.5 38446.4 41544.4 43237.0 45305.8 45750.8 8135.0 8283.8 8450.3 8556.5 8731.3 31860.2 31999.4 32068.7 33399.5 33679.0 38466.4 38668.2 40374.4 41053.8 41251.4 9470.7 9757.8 9944.2 10001.7 10234.0 11087.0 11184.9 11190.1 11235.7 11278.7 10856.1 10859.5 10899.6 11179.6 11411.6 10728.0 10917.9 10988.6 11017.1 11022.8 10406.3 10627.8 10777.8 10830.2 10830.7 9435.6 9437.9 9700.0 9717.7 9721.0 8913.8 9327.3 9362.7 9415.0 9454.1 17:32:27 INFO - 2015-12-15 17:32:27,805 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:32:27 INFO - 2015-12-15 17:32:27,805 DEBUG : BROWSER_OUTPUT: 17:32:28 INFO - 2015-12-15 17:32:28,466 INFO : Browser exited with error code: 0 17:32:28 INFO - 2015-12-15 17:32:28,487 INFO : Completed test dromaeo_css (00:18:35) 17:32:28 INFO - 2015-12-15 17:32:28,487 INFO : Starting test kraken 17:32:28 INFO - 2015-12-15 17:32:28,487 DEBUG : operating with platform_type : linux_ 17:32:28 INFO - 2015-12-15 17:32:28,487 INFO : Initialising browser for kraken test... 17:32:28 INFO - 2015-12-15 17:32:28,493 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPCVTh4/profile http://localhost:49453/getInfo.html 17:32:33 INFO - 2015-12-15 17:32:33,121 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:32:33 INFO - 2015-12-15 17:32:33,121 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:32:33 INFO - 2015-12-15 17:32:33,121 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:32:33 INFO - 2015-12-15 17:32:33,121 DEBUG : BROWSER_OUTPUT: __metrics 17:32:33 INFO - 2015-12-15 17:32:33,230 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:32:34 INFO - 2015-12-15 17:32:34,142 INFO : Browser initialized. 17:32:34 INFO - 2015-12-15 17:32:34,142 INFO : Running cycle 1/1 for kraken test... 17:32:34 INFO - 2015-12-15 17:32:34,143 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPCVTh4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:32:46 INFO - 2015-12-15 17:32:46,286 DEBUG : BROWSER_OUTPUT: RSS: Main: 143282176 17:32:46 INFO - 2015-12-15 17:32:46,286 DEBUG : BROWSER_OUTPUT: 17:32:48 INFO - 2015-12-15 17:32:48,883 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49453/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49453/tests/kraken/driver.html?testName=audio-beat-detection) 17:32:49 INFO - 2015-12-15 17:32:49,488 DEBUG : BROWSER_OUTPUT: RSS: Main: 142217216 17:32:49 INFO - 2015-12-15 17:32:49,489 DEBUG : BROWSER_OUTPUT: 17:32:52 INFO - 2015-12-15 17:32:52,238 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49453/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49453/tests/kraken/driver.html?testName=audio-dft) 17:32:52 INFO - 2015-12-15 17:32:52,832 DEBUG : BROWSER_OUTPUT: RSS: Main: 142921728 17:32:52 INFO - 2015-12-15 17:32:52,832 DEBUG : BROWSER_OUTPUT: 17:32:55 INFO - 2015-12-15 17:32:55,777 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49453/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49453/tests/kraken/driver.html?testName=audio-fft) 17:32:56 INFO - 2015-12-15 17:32:56,367 DEBUG : BROWSER_OUTPUT: RSS: Main: 137428992 17:32:56 INFO - 2015-12-15 17:32:56,367 DEBUG : BROWSER_OUTPUT: 17:32:58 INFO - 2015-12-15 17:32:58,473 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49453/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49453/tests/kraken/driver.html?testName=audio-oscillator) 17:32:59 INFO - 2015-12-15 17:32:59,059 DEBUG : BROWSER_OUTPUT: RSS: Main: 138743808 17:32:59 INFO - 2015-12-15 17:32:59,059 DEBUG : BROWSER_OUTPUT: 17:33:01 INFO - 2015-12-15 17:33:01,336 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49453/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49453/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:33:01 INFO - 2015-12-15 17:33:01,931 DEBUG : BROWSER_OUTPUT: RSS: Main: 139833344 17:33:01 INFO - 2015-12-15 17:33:01,931 DEBUG : BROWSER_OUTPUT: 17:33:04 INFO - 2015-12-15 17:33:04,953 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49453/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49453/tests/kraken/driver.html?testName=imaging-darkroom) 17:33:05 INFO - 2015-12-15 17:33:05,560 DEBUG : BROWSER_OUTPUT: RSS: Main: 141099008 17:33:05 INFO - 2015-12-15 17:33:05,560 DEBUG : BROWSER_OUTPUT: 17:33:09 INFO - 2015-12-15 17:33:09,003 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49453/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49453/tests/kraken/driver.html?testName=imaging-desaturate) 17:33:09 INFO - 2015-12-15 17:33:09,589 DEBUG : BROWSER_OUTPUT: RSS: Main: 141479936 17:33:09 INFO - 2015-12-15 17:33:09,589 DEBUG : BROWSER_OUTPUT: 17:33:12 INFO - 2015-12-15 17:33:12,509 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49453/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49453/tests/kraken/driver.html?testName=json-parse-financial) 17:33:13 INFO - 2015-12-15 17:33:13,096 DEBUG : BROWSER_OUTPUT: RSS: Main: 141578240 17:33:13 INFO - 2015-12-15 17:33:13,096 DEBUG : BROWSER_OUTPUT: 17:33:14 INFO - 2015-12-15 17:33:14,866 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49453/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49453/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:33:15 INFO - 2015-12-15 17:33:15,447 DEBUG : BROWSER_OUTPUT: RSS: Main: 141393920 17:33:15 INFO - 2015-12-15 17:33:15,448 DEBUG : BROWSER_OUTPUT: 17:33:17 INFO - 2015-12-15 17:33:17,351 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49453/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49453/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:33:17 INFO - 2015-12-15 17:33:17,957 DEBUG : BROWSER_OUTPUT: RSS: Main: 140283904 17:33:17 INFO - 2015-12-15 17:33:17,958 DEBUG : BROWSER_OUTPUT: 17:33:20 INFO - 2015-12-15 17:33:20,091 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49453/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49453/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:33:20 INFO - 2015-12-15 17:33:20,678 DEBUG : BROWSER_OUTPUT: RSS: Main: 140660736 17:33:20 INFO - 2015-12-15 17:33:20,678 DEBUG : BROWSER_OUTPUT: 17:33:23 INFO - 2015-12-15 17:33:23,279 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49453/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49453/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:33:23 INFO - 2015-12-15 17:33:23,881 DEBUG : BROWSER_OUTPUT: RSS: Main: 140447744 17:33:23 INFO - 2015-12-15 17:33:23,882 DEBUG : BROWSER_OUTPUT: 17:33:26 INFO - 2015-12-15 17:33:26,503 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49453/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49453/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:33:27 INFO - 2015-12-15 17:33:27,104 DEBUG : BROWSER_OUTPUT: RSS: Main: 140427264 17:33:27 INFO - 2015-12-15 17:33:27,104 DEBUG : BROWSER_OUTPUT: 17:33:28 INFO - 2015-12-15 17:33:28,880 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49453/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49453/tests/kraken/driver.html?testName=ai-astar) 17:33:29 INFO - 2015-12-15 17:33:29,138 DEBUG : BROWSER_OUTPUT: RSS: Main: 140505088 17:33:29 INFO - 2015-12-15 17:33:29,139 DEBUG : BROWSER_OUTPUT: 17:33:29 INFO - 2015-12-15 17:33:29,139 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:33:29 INFO - 2015-12-15 17:33:29,139 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:33:29 INFO - 2015-12-15 17:33:29,139 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:33:29 INFO - 2015-12-15 17:33:29,139 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:33:29 INFO - 2015-12-15 17:33:29,139 DEBUG : BROWSER_OUTPUT: |0;ai-astar;116;109;114;115;113;125;113;113;121;113 17:33:29 INFO - 2015-12-15 17:33:29,139 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;133;155;166;133;158;156;136;171;130 17:33:29 INFO - 2015-12-15 17:33:29,140 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;164;165;165;166;172;162;163;167;165 17:33:29 INFO - 2015-12-15 17:33:29,140 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;74;75;157;74;73;72;73;151 17:33:29 INFO - 2015-12-15 17:33:29,140 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;96;137;95;96;94;139;96;95;128 17:33:29 INFO - 2015-12-15 17:33:29,140 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;111;111;112;110;113;111;110;110;112 17:33:29 INFO - 2015-12-15 17:33:29,140 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;148;149;149;149;147;149;148;149;149 17:33:29 INFO - 2015-12-15 17:33:29,140 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;99;97;98;96;97;98;98;97 17:33:29 INFO - 2015-12-15 17:33:29,140 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;75;73;74;78;72;72;73;78;71;70 17:33:29 INFO - 2015-12-15 17:33:29,141 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;69;68;70;68;69;69;69;69 17:33:29 INFO - 2015-12-15 17:33:29,141 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;92;86;84;85;85;85;84;84;87;84 17:33:29 INFO - 2015-12-15 17:33:29,141 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;124;121;127;125;134;129;128;137;127;126 17:33:29 INFO - 2015-12-15 17:33:29,141 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;151;147;148;152;140;159;158;139;144 17:33:29 INFO - 2015-12-15 17:33:29,141 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;70;74;72;70;71;69;70;71;69 17:33:29 INFO - 2015-12-15 17:33:29,141 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:33:29 INFO - 2015-12-15 17:33:29,141 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:33:29 INFO - 2015-12-15 17:33:29,141 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,778 17:33:29 INFO - 2015-12-15 17:33:29,141 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:33:29 INFO - 2015-12-15 17:33:29,141 DEBUG : BROWSER_OUTPUT: __startTimestamp1450229609133__endTimestamp 17:33:29 INFO - 2015-12-15 17:33:29,142 DEBUG : BROWSER_OUTPUT: 17:33:29 INFO - 2015-12-15 17:33:29,143 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:33:29 INFO - 2015-12-15 17:33:29,143 DEBUG : BROWSER_OUTPUT: Number of tests: 14 17:33:29 INFO - 2015-12-15 17:33:29,143 DEBUG : BROWSER_OUTPUT: 17:33:29 INFO - 2015-12-15 17:33:29,143 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:115.20 Median:114.50 stddev:4.59 (4.0%) stddev-sans-first:4.86 17:33:29 INFO - 2015-12-15 17:33:29,143 DEBUG : BROWSER_OUTPUT: Values: 116.0 109.0 114.0 115.0 113.0 125.0 113.0 113.0 121.0 113.0 17:33:29 INFO - 2015-12-15 17:33:29,143 DEBUG : BROWSER_OUTPUT: 17:33:29 INFO - 2015-12-15 17:33:29,143 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.10 Median:155.50 stddev:14.90 (9.6%) stddev-sans-first:15.73 17:33:29 INFO - 2015-12-15 17:33:29,143 DEBUG : BROWSER_OUTPUT: Values: 153.0 133.0 155.0 166.0 133.0 158.0 156.0 136.0 171.0 130.0 17:33:29 INFO - 2015-12-15 17:33:29,143 DEBUG : BROWSER_OUTPUT: 17:33:29 INFO - 2015-12-15 17:33:29,143 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:165.20 Median:165.00 stddev:2.82 (1.7%) stddev-sans-first:2.88 17:33:29 INFO - 2015-12-15 17:33:29,143 DEBUG : BROWSER_OUTPUT: Values: 163.0 164.0 165.0 165.0 166.0 172.0 162.0 163.0 167.0 165.0 17:33:29 INFO - 2015-12-15 17:33:29,143 DEBUG : BROWSER_OUTPUT: 17:33:29 INFO - 2015-12-15 17:33:29,144 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:89.50 Median:73.00 stddev:34.03 (46.6%) stddev-sans-first:35.57 17:33:29 INFO - 2015-12-15 17:33:29,144 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 74.0 75.0 157.0 74.0 73.0 72.0 73.0 151.0 17:33:29 INFO - 2015-12-15 17:33:29,144 DEBUG : BROWSER_OUTPUT: 17:33:29 INFO - 2015-12-15 17:33:29,144 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.00 Median:95.00 stddev:19.30 (20.3%) stddev-sans-first:19.89 17:33:29 INFO - 2015-12-15 17:33:29,144 DEBUG : BROWSER_OUTPUT: Values: 94.0 96.0 137.0 95.0 96.0 94.0 139.0 96.0 95.0 128.0 17:33:29 INFO - 2015-12-15 17:33:29,144 DEBUG : BROWSER_OUTPUT: 17:33:29 INFO - 2015-12-15 17:33:29,144 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:111.00 Median:111.00 stddev:1.05 (0.9%) stddev-sans-first:1.05 17:33:29 INFO - 2015-12-15 17:33:29,144 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 111.0 112.0 110.0 113.0 111.0 110.0 110.0 112.0 17:33:29 INFO - 2015-12-15 17:33:29,144 DEBUG : BROWSER_OUTPUT: 17:33:29 INFO - 2015-12-15 17:33:29,144 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.60 Median:149.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 17:33:29 INFO - 2015-12-15 17:33:29,144 DEBUG : BROWSER_OUTPUT: Values: 149.0 148.0 149.0 149.0 149.0 147.0 149.0 148.0 149.0 149.0 17:33:29 INFO - 2015-12-15 17:33:29,144 DEBUG : BROWSER_OUTPUT: 17:33:29 INFO - 2015-12-15 17:33:29,145 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:97.30 Median:97.50 stddev:0.95 (1.0%) stddev-sans-first:0.88 17:33:29 INFO - 2015-12-15 17:33:29,145 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 99.0 97.0 98.0 96.0 97.0 98.0 98.0 97.0 17:33:29 INFO - 2015-12-15 17:33:29,145 DEBUG : BROWSER_OUTPUT: 17:33:29 INFO - 2015-12-15 17:33:29,145 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.60 Median:73.50 stddev:2.72 (3.7%) stddev-sans-first:2.83 17:33:29 INFO - 2015-12-15 17:33:29,145 DEBUG : BROWSER_OUTPUT: Values: 75.0 73.0 74.0 78.0 72.0 72.0 73.0 78.0 71.0 70.0 17:33:29 INFO - 2015-12-15 17:33:29,145 DEBUG : BROWSER_OUTPUT: 17:33:29 INFO - 2015-12-15 17:33:29,145 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 17:33:29 INFO - 2015-12-15 17:33:29,145 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 68.0 70.0 68.0 69.0 69.0 69.0 69.0 17:33:29 INFO - 2015-12-15 17:33:29,145 DEBUG : BROWSER_OUTPUT: 17:33:29 INFO - 2015-12-15 17:33:29,145 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:85.00 stddev:2.46 (2.9%) stddev-sans-first:1.05 17:33:29 INFO - 2015-12-15 17:33:29,145 DEBUG : BROWSER_OUTPUT: Values: 92.0 86.0 84.0 85.0 85.0 85.0 84.0 84.0 87.0 84.0 17:33:29 INFO - 2015-12-15 17:33:29,145 DEBUG : BROWSER_OUTPUT: 17:33:29 INFO - 2015-12-15 17:33:29,145 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.80 Median:127.50 stddev:4.69 (3.7%) stddev-sans-first:4.76 17:33:29 INFO - 2015-12-15 17:33:29,145 DEBUG : BROWSER_OUTPUT: Values: 124.0 121.0 127.0 125.0 134.0 129.0 128.0 137.0 127.0 126.0 17:33:29 INFO - 2015-12-15 17:33:29,145 DEBUG : BROWSER_OUTPUT: 17:33:29 INFO - 2015-12-15 17:33:29,146 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.70 Median:149.50 stddev:7.36 (4.9%) stddev-sans-first:7.11 17:33:29 INFO - 2015-12-15 17:33:29,146 DEBUG : BROWSER_OUTPUT: Values: 139.0 151.0 147.0 148.0 152.0 140.0 159.0 158.0 139.0 144.0 17:33:29 INFO - 2015-12-15 17:33:29,146 DEBUG : BROWSER_OUTPUT: 17:33:29 INFO - 2015-12-15 17:33:29,146 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:71.00 stddev:1.55 (2.2%) stddev-sans-first:1.58 17:33:29 INFO - 2015-12-15 17:33:29,146 DEBUG : BROWSER_OUTPUT: Values: 72.0 70.0 74.0 72.0 70.0 71.0 69.0 70.0 71.0 69.0 17:33:29 INFO - 2015-12-15 17:33:29,146 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:33:29 INFO - 2015-12-15 17:33:29,146 DEBUG : BROWSER_OUTPUT: 17:33:30 INFO - 2015-12-15 17:33:30,070 INFO : Browser exited with error code: 0 17:33:30 INFO - 2015-12-15 17:33:30,119 INFO : Completed test kraken (00:01:01) 17:33:30 INFO - 2015-12-15 17:33:30,119 INFO : Starting test v8_7 17:33:30 INFO - 2015-12-15 17:33:30,119 DEBUG : operating with platform_type : linux_ 17:33:30 INFO - 2015-12-15 17:33:30,119 INFO : Initialising browser for v8_7 test... 17:33:30 INFO - 2015-12-15 17:33:30,125 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSVe9LE/profile http://localhost:49453/getInfo.html 17:33:34 INFO - 2015-12-15 17:33:34,874 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:33:34 INFO - 2015-12-15 17:33:34,874 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:33:34 INFO - 2015-12-15 17:33:34,874 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:33:34 INFO - 2015-12-15 17:33:34,874 DEBUG : BROWSER_OUTPUT: __metrics 17:33:34 INFO - 2015-12-15 17:33:34,970 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:33:35 INFO - 2015-12-15 17:33:35,870 INFO : Browser initialized. 17:33:35 INFO - 2015-12-15 17:33:35,870 INFO : Running cycle 1/1 for v8_7 test... 17:33:35 INFO - 2015-12-15 17:33:35,870 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSVe9LE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:33:47 INFO - 2015-12-15 17:33:47,976 DEBUG : BROWSER_OUTPUT: RSS: Main: 143163392 17:33:47 INFO - 2015-12-15 17:33:47,977 DEBUG : BROWSER_OUTPUT: 17:34:09 INFO - 2015-12-15 17:34:09,436 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49453/tests/v8_7/run.html (next: http://localhost:49453/tests/v8_7/run.html) 17:34:09 INFO - 2015-12-15 17:34:09,694 DEBUG : BROWSER_OUTPUT: RSS: Main: 138366976 17:34:09 INFO - 2015-12-15 17:34:09,694 DEBUG : BROWSER_OUTPUT: 17:34:09 INFO - 2015-12-15 17:34:09,694 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:34:09 INFO - 2015-12-15 17:34:09,694 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:34:09 INFO - 2015-12-15 17:34:09,695 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:34:09 INFO - 2015-12-15 17:34:09,695 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:34:09 INFO - 2015-12-15 17:34:09,695 DEBUG : BROWSER_OUTPUT: |0;Richards;167.36401673640168 17:34:09 INFO - 2015-12-15 17:34:09,695 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.63207722294413 17:34:09 INFO - 2015-12-15 17:34:09,695 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.70680044593087 17:34:09 INFO - 2015-12-15 17:34:09,695 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5164.948453608247 17:34:09 INFO - 2015-12-15 17:34:09,695 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1071.8113612004288 17:34:09 INFO - 2015-12-15 17:34:09,695 DEBUG : BROWSER_OUTPUT: |5;Earley;716.3323782234957 17:34:09 INFO - 2015-12-15 17:34:09,696 DEBUG : BROWSER_OUTPUT: |6;Boyer;12219.512195121952 17:34:09 INFO - 2015-12-15 17:34:09,696 DEBUG : BROWSER_OUTPUT: |7;RegExp;26342.105263157893 17:34:09 INFO - 2015-12-15 17:34:09,696 DEBUG : BROWSER_OUTPUT: |8;Splay;592.7682276229995 17:34:09 INFO - 2015-12-15 17:34:09,696 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 17:34:09 INFO - 2015-12-15 17:34:09,696 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:34:09 INFO - 2015-12-15 17:34:09,696 DEBUG : BROWSER_OUTPUT: __startTimestamp1450229649688__endTimestamp 17:34:09 INFO - 2015-12-15 17:34:09,696 DEBUG : BROWSER_OUTPUT: 17:34:09 INFO - 2015-12-15 17:34:09,697 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:34:09 INFO - 2015-12-15 17:34:09,697 DEBUG : BROWSER_OUTPUT: Number of tests: 10 17:34:09 INFO - 2015-12-15 17:34:09,697 DEBUG : BROWSER_OUTPUT: 17:34:09 INFO - 2015-12-15 17:34:09,697 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.36 Median:167.36 stddev:0.00 (0.0%) 17:34:09 INFO - 2015-12-15 17:34:09,697 DEBUG : BROWSER_OUTPUT: Values: 167.4 17:34:09 INFO - 2015-12-15 17:34:09,697 DEBUG : BROWSER_OUTPUT: 17:34:09 INFO - 2015-12-15 17:34:09,697 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.63 Median:185.63 stddev:0.00 (0.0%) 17:34:09 INFO - 2015-12-15 17:34:09,698 DEBUG : BROWSER_OUTPUT: Values: 185.6 17:34:09 INFO - 2015-12-15 17:34:09,698 DEBUG : BROWSER_OUTPUT: 17:34:09 INFO - 2015-12-15 17:34:09,698 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.71 Median:278.71 stddev:0.00 (0.0%) 17:34:09 INFO - 2015-12-15 17:34:09,698 DEBUG : BROWSER_OUTPUT: Values: 278.7 17:34:09 INFO - 2015-12-15 17:34:09,698 DEBUG : BROWSER_OUTPUT: 17:34:09 INFO - 2015-12-15 17:34:09,698 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5164.95 Median:5164.95 stddev:0.00 (0.0%) 17:34:09 INFO - 2015-12-15 17:34:09,698 DEBUG : BROWSER_OUTPUT: Values: 5164.9 17:34:09 INFO - 2015-12-15 17:34:09,699 DEBUG : BROWSER_OUTPUT: 17:34:09 INFO - 2015-12-15 17:34:09,699 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1071.81 Median:1071.81 stddev:0.00 (0.0%) 17:34:09 INFO - 2015-12-15 17:34:09,699 DEBUG : BROWSER_OUTPUT: Values: 1071.8 17:34:09 INFO - 2015-12-15 17:34:09,699 DEBUG : BROWSER_OUTPUT: 17:34:09 INFO - 2015-12-15 17:34:09,699 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:716.33 Median:716.33 stddev:0.00 (0.0%) 17:34:09 INFO - 2015-12-15 17:34:09,699 DEBUG : BROWSER_OUTPUT: Values: 716.3 17:34:09 INFO - 2015-12-15 17:34:09,699 DEBUG : BROWSER_OUTPUT: 17:34:09 INFO - 2015-12-15 17:34:09,699 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12219.51 Median:12219.51 stddev:0.00 (0.0%) 17:34:09 INFO - 2015-12-15 17:34:09,700 DEBUG : BROWSER_OUTPUT: Values: 12219.5 17:34:09 INFO - 2015-12-15 17:34:09,700 DEBUG : BROWSER_OUTPUT: 17:34:09 INFO - 2015-12-15 17:34:09,700 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26342.11 Median:26342.11 stddev:0.00 (0.0%) 17:34:09 INFO - 2015-12-15 17:34:09,700 DEBUG : BROWSER_OUTPUT: Values: 26342.1 17:34:09 INFO - 2015-12-15 17:34:09,700 DEBUG : BROWSER_OUTPUT: 17:34:09 INFO - 2015-12-15 17:34:09,700 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:592.77 Median:592.77 stddev:0.00 (0.0%) 17:34:09 INFO - 2015-12-15 17:34:09,700 DEBUG : BROWSER_OUTPUT: Values: 592.8 17:34:09 INFO - 2015-12-15 17:34:09,701 DEBUG : BROWSER_OUTPUT: 17:34:09 INFO - 2015-12-15 17:34:09,701 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 17:34:09 INFO - 2015-12-15 17:34:09,701 DEBUG : BROWSER_OUTPUT: Values: 4845.4 17:34:09 INFO - 2015-12-15 17:34:09,701 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:34:09 INFO - 2015-12-15 17:34:09,701 DEBUG : BROWSER_OUTPUT: 17:34:10 INFO - 2015-12-15 17:34:10,634 INFO : Browser exited with error code: 0 17:34:10 INFO - 2015-12-15 17:34:10,652 INFO : Completed test v8_7 (00:00:40) 17:34:10 INFO - 2015-12-15 17:34:10,722 INFO : Completed test suite (00:20:17) 17:34:10 INFO - 2015-12-15 17:34:10,722 DEBUG : Working with test: dromaeo_css 17:34:10 INFO - 2015-12-15 17:34:10,722 DEBUG : Generating results file: dromaeo_css 17:34:10 INFO - 2015-12-15 17:34:10,723 DEBUG : Working with test: kraken 17:34:10 INFO - 2015-12-15 17:34:10,724 DEBUG : Generating results file: kraken 17:34:10 INFO - 2015-12-15 17:34:10,724 INFO : javascript benchmark 17:34:10 INFO - 2015-12-15 17:34:10,724 DEBUG : Working with test: v8_7 17:34:10 INFO - 2015-12-15 17:34:10,724 DEBUG : Generating results file: v8_7 17:34:10 INFO - 2015-12-15 17:34:10,724 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:34:10 INFO - 2015-12-15 17:34:10,777 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 17:34:10 INFO - 2015-12-15 17:34:10,777 DEBUG : process_Request line: dromaeo_css 6428.44 graph.html#tests=[[72,132,43]] 17:34:10 INFO - 2015-12-15 17:34:10,777 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:34:10 INFO - 2015-12-15 17:34:10,806 DEBUG : process_Request line: kraken 1557.30 graph.html#tests=[[232,132,43]] 17:34:10 INFO - 2015-12-15 17:34:10,806 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:34:10 INFO - 2015-12-15 17:34:10,836 DEBUG : process_Request line: v8_7 21346.80 graph.html#tests=[[230,132,43]] 17:34:10 INFO - 2015-12-15 17:34:10,837 INFO : javascript benchmark 17:34:10 INFO - 2015-12-15 17:34:10,841 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2663.187727743038, 2705.0667519705694, 2717.605947137665, 2722.047283450792, 2729.836209827409, 4639.724075879135, 4730.124926888524, 4769.95230047699, 4795.064962332347, 4837.443693975194, 4688.929666055012, 4728.456227533835, 4729.668923175371, 4735.71585704858, 4750.334953106568, 4323.675724320673, 4433.866983990485, 4451.332300154971, 4459.88850278744, 4467.039586488896, 4163.188178305231, 4386.276264416368, 4440.955590444087, 4452.7328360298325, 4510.819567217307, 4330.415393921811, 4460.30865215892, 4460.910781784379, 4485.416895803557, 4491.348754430589, 4446.6220371268155, 4448.421705178306, 4469.597736203757, 4490.820367185309, 4507.977460112711, 4217.557156498585, 4289.6997210195295, 4306.849260275907, 4431.578999994996, 4464.821407143743, 4655.045715628288, 4677.111348843743, 4717.410323709536, 4738.715677059387, 4766.356541866839, 5143.897122057575, 5146.9485305146845, 5154.38147422308, 5154.613403994678, 5166.276721258989, 4958.776855041496, 5026.773795179226, 5050.621203409759, 5058.873528161826, 5229.947700522984, 4679.74261415622, 4690.624750019991, 4718.693284936468, 4751.097291514601, 4768.546988036131, 5259.0, 5346.385165705916, 5346.8663283417445, 5350.170723537858, 5398.055340315429, 4783.306420569068, 4889.119958407521, 5096.668716533413, 5114.769835357343, 5126.2054381570915, 5102.489751024942, 5120.0, 5170.302009228706, 5170.793168273227, 5209.0363282792805, 5068.290439338495, 5068.847934561969, 5106.846794596168, 5110.974445127825, 5126.820561280338, 4872.171730805771, 4946.332245146931, 4949.752512374367, 5071.974640126776, 5082.517160869711, 4247.745135291892, 4277.187334406515, 4281.036766727524, 4309.202797482476, 4326.805293761789, 3736.6076561961145, 3748.7750734955443, 3752.493413389212, 3793.1275806564095, 3797.5442946846, 4239.894002649959, 4295.162443323585, 4315.741055536678, 4317.395564620955, 4485.708428952108, 5000.224965130338, 5083.262926875583, 5102.953894451629, 5105.055564720538, 5129.179331306973, 4409.470863496337, 4419.779011049434, 4452.755098469551, 4453.1761624099645, 4483.30508771141, 4323.200207961537, 4397.670174736908, 4409.206342858316, 4540.977295113504, 4552.9772351138035, 4633.72197668141, 4772.49888761675, 4883.267509873405, 4895.4370247422, 4911.950880491292, 5113.207452844815, 5129.461406552258, 5148.6910785353, 5150.536451719363, 5204.401493828258, 4762.809487620595, 4873.293372460902, 4922.72924989129, 4939.0, 4961.82633607822, 5013.172826483736, 5025.547700706954, 5088.0587091388215, 5088.567471764942, 5126.102931986813, 5095.363079615048, 5158.787684894122, 5159.535641792257, 5172.818951336685, 5189.273501709688, 4814.638902082288, 4933.284673722362, 4958.925616115834, 4986.227134794112, 4988.27669987857, 4827.203511420576, 4893.584045356185, 4895.926561101515, 4924.926126108183, 4980.551750342486, 4867.780949857336, 4918.6065114791445, 4924.384451943507, 4938.975305123595, 4994.475580064186, 4791.089692958327, 4944.802207911644, 4959.107360674969, 5065.696058236517, 5113.667611605234, 4949.282354058713, 4949.604031677385, 4967.850964471072, 4977.4524802271, 5016.673916195582], "unit": "score", "name": "dojo.html", "value": 4685.408888572669}, {"lowerIsBetter": false, "replicates": [568.074039315915, 579.6087640842431, 581.5405829394779, 581.8719881626046, 587.5681374189969, 36565.0, 37538.18463615226, 37648.43527347092, 37657.81171094141, 37804.0, 39694.8015259924, 40154.59845401545, 40165.0, 40331.19337613246, 40382.7980860096, 7913.920860791376, 7990.360771138295, 8020.11778704342, 8042.195780421969, 8045.477043992151, 7776.883346749803, 7940.40446966477, 7942.563159026251, 7953.642086106111, 7967.282944534991, 7927.207279272085, 7947.165547617475, 8043.839123217532, 8061.355091592659, 8090.190980901922, 7743.767686969371, 7974.3221826144845, 7974.401919856034, 7981.241782030698, 8011.639476223584, 7778.0666320041955, 7901.1703771103785, 7906.288434040906, 7916.1688022757935, 7917.881231781528, 36850.0, 37597.62402375969, 37831.432528512094, 37904.0, 37904.620953790385, 3253.7559683023633, 3273.492608645664, 3367.646397128315, 3701.8519259229597, 3711.7030637548933, 27759.0, 27850.442991140266, 28171.859140704164, 28187.15438536847, 28213.758370910346, 3357.842526357763, 3372.409828280041, 3386.221169131089, 3457.2566898116775, 3492.441209406483, 200151.0, 201937.0, 202653.0, 203239.0, 205736.0, 50773.23840142401, 53140.46859531433, 53480.19779703308, 53622.46377536253, 53704.46295536995, 45439.091218175454, 63688.0, 64632.676836616454, 65018.0, 65152.0, 13837.962152838376, 13918.51285205013, 14007.229602371968, 14068.43726250959, 14080.647983800487, 10310.484475776182, 10330.380177189392, 10336.17310615149, 10372.740681482872, 10374.0, 18706.812931870507, 18902.621947561245, 18964.715529267072, 19038.33365832189, 19107.331243406414, 7148.744848257775, 7276.6725497352745, 7406.777796666109, 7428.591427471433, 7474.0, 844.9408541402166, 846.4540371460373, 870.260278763059, 899.3030401438937, 1052.8210204265292, 23562.42488055397, 23856.57876460895, 23885.402374572, 24101.638475422882, 24192.7580724194, 932.5430539035959, 984.5766320482118, 986.3785814936545, 1078.396098185019, 1131.5417256011328, 13622.250776207404, 14777.26113694311, 15003.32485038176, 15195.316210770541, 15437.768433473508, 252204.0, 255824.0, 256005.0, 257423.0, 257789.0, 45896.3115553267, 46159.07681846344, 46435.76782116135, 46519.76740116345, 46545.534544654794, 1194.8446701928694, 1204.933728644933, 1235.9629211123502, 1242.45332053896, 1348.3393137362818, 26656.200313990612, 27078.593821092305, 27116.32209194786, 27177.86411067932, 27703.168904932885, 39828.40257396199, 39933.80033099816, 40132.0, 40161.0, 40342.39486407765, 239299.0, 240377.0, 241290.0, 241333.0, 241604.0, 27970.860145699142, 28533.571996420487, 29103.8358465659, 29294.0, 29370.706292936797, 35833.92498225057, 36676.44985325169, 36731.63268367282, 37151.62848371482, 37610.247795044495, 31440.68559314469, 31474.111553306873, 31508.84245578849, 32961.83519082389, 33183.336333273684, 29056.41887162287, 29374.853125734233, 29494.557581636724, 29557.0, 29944.550831737975, 29808.403831923675, 29846.403071938876, 29917.850410747807, 30141.095767127023, 30180.0, 25415.0, 26707.0, 27094.458110838066, 27129.59305610378, 27184.0, 23091.422714431603, 23379.649305260096, 23689.17087901915, 25054.248372548125, 25113.0], "unit": "score", "name": "ext.html", "value": 16731.419200875844}, {"lowerIsBetter": false, "replicates": [329.08022078291174, 332.91510664780475, 333.4897606661807, 333.5197315865154, 334.73723127345033, 14844.40622375105, 15417.922910385447, 15677.764833527492, 15877.603059923507, 16462.917685411587, 9814.116729494363, 10047.447390393525, 12795.296258705768, 14684.192369419678, 14800.629984250372, 4473.865784026476, 4576.519465456129, 4599.816007359718, 4713.34013238147, 5014.348134742479, 4883.413990321149, 4925.82759603414, 4929.088118698034, 4934.383202099738, 4954.355933728628, 3448.5689288838894, 3575.660312270343, 4879.512048795127, 4893.730844803535, 6340.207474065742, 6500.642464664442, 6540.149780528524, 6550.606963582152, 6571.967140164268, 6585.604863708193, 6176.351483094255, 6323.177986861724, 6335.208098987627, 6361.332060133712, 6420.0690899819265, 19106.617867642708, 19256.22975080995, 19377.0, 19729.605407891904, 19839.404817855488, 1953.8827670339824, 1990.233760002395, 1994.3418671838258, 2033.9796602034087, 2133.5946170227608, 13367.331633418291, 13549.661258468519, 13809.171449713049, 13834.169949803045, 14172.50396236137, 1789.7225929980873, 1812.2026308424252, 1826.5707558723689, 1860.4697661166638, 1867.1971052447443, 60127.26665703287, 63288.0, 63849.0, 64493.67753161251, 64616.179891445136, 14825.92587037058, 15092.245387730569, 15190.316435760416, 15227.0, 15227.162506062052, 23109.0, 23140.768592314198, 23197.0, 23270.301890943298, 23315.300540983797, 8705.47767133974, 8806.955965220133, 8826.823463530693, 8877.24543413817, 8934.86597701035, 7407.296306850841, 7456.142543607554, 7515.436342274351, 7542.0, 7584.772456826304, 7359.889601655979, 7484.738034168887, 7501.887471687929, 7512.173660897297, 7538.0, 2970.5098658721067, 3097.0, 3106.2079169811554, 3205.6153261608756, 3233.2401885556874, 346.68798081726146, 348.19740498152004, 362.9183433727443, 368.4123822503103, 974.9268804839666, 9380.343375963617, 15215.695686086216, 15247.0, 15760.842391575938, 16161.838381616268, 821.8068753842842, 848.440029580474, 851.5401683091061, 881.5063564403954, 888.2982443869271, 8695.304375649934, 8754.824903502022, 8881.467111973174, 9160.0, 9230.215431688248, 310383.0, 321569.0, 479672.0, 480261.0, 481143.0, 59399.81200375968, 60985.69507152436, 63832.36167638357, 72995.27004729991, 73144.2685573148, 1043.89561043895, 1075.8171110911164, 1076.192855358497, 1076.311160857052, 1076.3757020927842, 14139.929300353844, 14239.928800355932, 14465.349059292146, 14499.432678706175, 14670.926645367132, 31784.36431271408, 32408.35183296368, 32480.0, 32553.186170345933, 33230.83384583062, 38367.65713200025, 38527.0, 39736.0, 39945.60054399419, 41479.0, 8695.130486951255, 8937.865932010895, 8979.865302020344, 9021.0, 9039.502827344297, 14748.926255368655, 15613.0, 15952.0, 16111.194440278174, 16410.507684769476, 11724.237924534878, 13282.86717132855, 13409.32953352309, 13597.912167026812, 13646.454141834216, 13064.34678266064, 13124.934375328063, 13392.662044854002, 13528.39122239482, 13564.253966031964, 14230.573082807532, 14345.64135896611, 14382.784258236345, 14464.927675361556, 14543.0, 8767.912320876709, 8769.473831570127, 8770.473771573726, 8783.736487905373, 8817.559122044, 13907.860921390657, 13938.233397163254, 13942.58172254834, 14065.648358791112, 14174.220417877115], "unit": "score", "name": "jquery.html", "value": 8849.58730736399}, {"lowerIsBetter": false, "replicates": [1489.7169537787813, 1627.63378239896, 1709.487153853844, 1718.87967842251, 1725.4392322495185, 6117.357677443871, 6249.968750156243, 6789.42289905358, 7178.174509931359, 7247.528910620813, 6689.431398331136, 6881.621510816903, 6957.547759395636, 6959.0, 6982.1272340957385, 2059.042545216474, 2082.541840795023, 2096.2453516733963, 2096.8217701495314, 2100.359390385932, 2079.272254710854, 2090.80137386948, 2107.6522373808302, 2110.2192188890053, 2127.4362293992103, 2004.2784597544871, 2049.75402951646, 2051.7640471345762, 2052.1791283486577, 2053.9281125160624, 2076.470500022492, 2084.5726626041624, 2104.610647030289, 2105.3894370632497, 2109.5675386545877, 2058.9279375221795, 2066.5763518478675, 2067.648499755045, 2085.697573851798, 2086.5931143427038, 6891.2764159763, 6947.617881016542, 6955.304469553055, 6967.512274140812, 6980.650967451607, 4152.795689250114, 4233.915321693579, 4244.681648876347, 4257.318828987347, 4259.424977628042, 2716.755492005729, 2755.4213615140843, 2759.075709637274, 2761.2130542795207, 2778.7360200780895, 799.9440039197259, 835.5446281776385, 841.4656692999928, 858.5964596639569, 866.1728049712509, 9778.462184579845, 9937.850932236095, 9940.502974851228, 9943.0, 9956.352837065568, 3889.7082718796205, 3898.8245528951265, 3951.5060617422823, 3957.5250969883223, 3975.940360894589, 8469.491830490191, 8474.237318641352, 8499.660013599387, 8528.0, 8542.145785421408, 4231.661467082626, 4242.406063151161, 4246.660267178619, 4264.104538046983, 4277.529471758104, 3250.691184337484, 3291.391092647868, 3789.5831458539537, 3840.020794697334, 3861.0540417597867, 3273.1817045738567, 3307.4212012897647, 3316.137804170933, 3331.4003479373946, 3332.9834400507593, 1043.5251960358019, 1055.5408397347178, 1061.9628313009162, 1064.0742553977934, 1067.2049323254225, 1142.657202839145, 1157.1899670230873, 1157.9363135027654, 1176.405915012913, 1222.095649219589, 6673.799786006428, 6695.966520167368, 6717.966410167918, 6743.494237932076, 6763.0, 386.6037311755473, 393.3293734183211, 393.3686433274553, 393.6339204539805, 395.01246882793015, 5263.947360526422, 5340.893182136336, 5383.757730902119, 5388.622796404214, 5409.83770486886, 8581.098984606526, 8789.736307910645, 8810.118988101138, 8832.072632373636, 8855.0, 8562.529060901586, 8657.783555411164, 8692.652293908299, 8697.304215662733, 8720.563971801512, 6835.213950395669, 6877.346652068046, 6888.0, 6914.827129321807, 6920.826979325557, 6488.416042556004, 6561.967190164019, 6573.704183311666, 6587.308332625005, 6624.768133115318, 7562.281583249583, 7684.807879803049, 7781.9610901945125, 7806.1803510632835, 7808.375329973702, 7857.135715071452, 7988.161243069394, 8054.919450805417, 8073.233042860918, 8082.717104901535, 5097.311862898609, 5156.20078887773, 6302.684865756785, 6392.872142557216, 6441.742330306735, 6519.967400162969, 6710.295418981132, 6718.328167183438, 6729.2934241903895, 6730.629815360202, 6197.81406557804, 6211.9689401552705, 6323.747050117944, 6364.554481186273, 6446.258680251831, 6183.598066125687, 6253.937460625336, 6269.843253918689, 6328.398802113792, 6362.3319551448285, 6675.732970681119, 6722.495812813961, 6727.629980351127, 6744.190697116377, 6750.1562304711915, 5957.106434034929, 5969.970150149222, 5983.910241346471, 6005.978983572891, 6016.8796624068145, 5935.970320148372, 5948.553858460719, 5970.701464926649, 5985.1022346646605, 6145.139680444652], "unit": "score", "name": "mootools.html", "value": 4001.9938669623466}, {"lowerIsBetter": false, "replicates": [293.69162379501546, 294.0692707580508, 296.89015064426167, 301.9894303699371, 305.22320693834195, 5476.959377718231, 5547.972260138704, 5591.133374326981, 5657.0, 5755.9927012772705, 5550.7224638768, 5614.214010038598, 5625.943740562593, 5626.578006649507, 5639.295088113986, 4196.39152322913, 4289.742615443076, 4292.549282325358, 4292.828286868522, 4301.376300436435, 4235.08945576701, 4248.192843359767, 4251.362295655661, 4252.532221455637, 4272.252355837732, 4177.018400675839, 4204.810783514749, 4208.873733787991, 4211.241976444254, 4213.052063285767, 4151.27352713274, 4161.271777438967, 4170.249355116078, 4189.937150942738, 4197.706160568746, 3743.644353786386, 3754.873537938635, 3755.530558680165, 3759.51126353575, 3760.5863355030924, 5254.500822421864, 5392.487713667196, 5421.213923981, 5422.43064478232, 5422.864428389283, 4917.188663870457, 4917.459079501252, 4925.655204135712, 4927.753612319406, 4936.48166942473, 5917.14201440793, 5929.080992446135, 5932.436418540232, 5942.8811423771285, 5957.374475680078, 4055.6147166019477, 4055.959440405617, 4061.0253539150685, 4063.9796801015805, 4069.3285607874664, 5997.760089596454, 6094.451499365034, 6221.191245138103, 6235.9376406235815, 6242.6878656067465, 4068.9796551017057, 4105.67154627629, 4108.609682080198, 4112.732672376345, 4114.341705327133, 4165.10450253191, 4165.479315085614, 4167.854125105607, 4172.561881002512, 4173.31140361843, 4823.204171311694, 4829.7585120744525, 4854.975725121351, 4857.635677324215, 4870.902581948412, 5656.971715141481, 5857.824265272048, 5874.236349274567, 5920.407959204132, 5939.4357536034, 1491.6867457833976, 1516.097921736565, 1532.3334349557979, 1534.232883558221, 1535.5777161280737, 1025.4718819807806, 1036.9325993810378, 1044.5717255925035, 1051.8842927277992, 1056.572088304238, 5084.51697088776, 5092.599535127795, 5101.51535604117, 5116.488351164928, 5133.0, 6041.305249896231, 6062.242219722535, 6134.662593557308, 6199.969000154971, 6214.161088253119, 5134.922976155286, 5144.742762861917, 5164.070467315919, 5171.974140129275, 5184.8963020739375, 3295.9340813183603, 3298.142482954449, 3337.6829201225846, 3342.632310445849, 3351.865925362958, 5630.183623374588, 5753.8561535961935, 5756.827295181151, 5775.960327141155, 5789.739461724233, 6290.056491526216, 6325.082862984841, 6326.145970294044, 6330.588511746814, 6350.968245158745, 5705.885882282248, 5755.99270127726, 5759.85600359986, 5785.103308987113, 5794.536437085023, 6133.6319820810895, 6137.447629713347, 6144.262688477412, 6145.846353841011, 6167.84580385494, 5835.328937172279, 5981.192539007178, 5999.370066142992, 6001.2498437695285, 6004.0693692477735, 5757.0788673811985, 5771.68255745938, 5771.932192544393, 5782.971085144547, 5788.21859049023, 4078.4494093297026, 4086.2849001425225, 4106.240345536085, 4122.7114102013775, 4131.235721391552, 6032.426919442646, 6104.694765261808, 6143.0, 6153.169322141453, 6172.783952561639, 5846.064629659404, 5872.647641141545, 5905.409459054232, 5926.496247818984, 5942.1383899335215, 5820.5925585210325, 5835.1247312901705, 5837.795677151279, 5868.149118377897, 5893.292804863444, 5568.359638641446, 5761.971190144022, 5783.074708046693, 5796.42035796417, 5816.76732930678, 5941.554383421174, 5958.34458209588, 5977.462028417463, 5980.252468441445, 5980.521558275241, 5804.65172089676, 5820.76716931318, 5823.039198532195, 5825.126231065374, 5830.4461076197695], "unit": "score", "name": "prototype.html", "value": 4395.371550931441}, {"lowerIsBetter": false, "replicates": [776.7320274505294, 781.8514482248372, 787.5235482533063, 789.4552758596571, 813.2680587471275, 10528.631497897575, 10610.893891061107, 10624.415657138863, 10635.52140153693, 10684.732881677963, 11656.941715291432, 11850.525978960854, 11850.881491185086, 11949.0, 11982.281063136217, 774.0556521044317, 780.8906753054576, 786.0645831460544, 786.5084322298563, 792.4413288631501, 777.8055486128468, 782.1435528096725, 782.5969625642798, 787.6731156570045, 789.0649580247425, 816.5386556595535, 826.5701835045772, 828.7555171224473, 830.4519017448486, 837.0875745437472, 827.4290739389802, 827.6441130313963, 828.4904783558129, 829.722043115554, 831.629924683516, 609.1958614628692, 612.3478495402383, 615.6213928434025, 616.4944745308849, 617.4658920034138, 10111.19110471168, 10119.241056920686, 10216.182705383551, 10232.64185753495, 10241.385516868937, 9695.224382049419, 10202.285839991204, 11154.386508742016, 11188.888111118866, 11243.100551955824, 9545.809083818354, 9574.521273936345, 9586.137247647745, 9787.412755234638, 9831.655892043744, 3247.1395080303737, 3251.4472539668077, 3262.9184270393193, 3290.161008942728, 3335.7498187635783, 36835.63164368349, 37303.88088357353, 38340.424893626616, 38343.616563834286, 41514.58485415138, 8948.507832069168, 8991.010988791228, 9362.34463587556, 9481.288903332277, 9835.901640983499, 16156.596085097966, 16398.426055088254, 16471.505854824376, 16506.0, 16512.09183494895, 6200.286966998763, 6247.500199983991, 6250.4374606285655, 6270.090836828635, 6300.747970081237, 3609.4946707460977, 3637.836297366625, 3643.0, 3671.4492826076303, 3722.2927643747603, 2613.372790530259, 2641.0228215560364, 2641.4981153581143, 2651.3239124023253, 2660.547706889795, 484.6123101518841, 487.75124686409475, 489.18062245738247, 490.6663468841151, 493.8592501137231, 532.5952276270062, 619.0664556961954, 644.0596728775946, 650.9641969691618, 651.46905272203, 7567.129780075252, 8002.159773223844, 8241.629126689313, 8247.422680412434, 8427.95786021066, 629.9149614802035, 650.7624716978269, 663.0882536512296, 670.3865962644223, 675.3044364304774, 3765.3975363941636, 3816.656500914931, 3887.319719049155, 3921.705872059607, 4016.7188296819527, 50428.24357634639, 50785.74607126941, 51024.74487627538, 51122.233166502534, 51775.0, 41667.583324166975, 43475.56524434715, 43860.0, 46743.5325646746, 47011.5298847014, 38446.42330365047, 41544.37683434751, 43237.0, 45305.77347113309, 45750.77124614356, 8135.0, 8283.792905177419, 8450.267695122362, 8556.486610803371, 8731.345149113715, 31860.203494912814, 31999.36001279915, 32068.67931320657, 33399.49900751442, 33679.0, 38466.42300365441, 38668.22663546657, 40374.39438408485, 41053.768386947246, 41251.38122928098, 9470.715878523655, 9757.80484390294, 9944.204463642747, 10001.699949001542, 10234.0, 11087.0, 11184.891685249962, 11190.104791616488, 11235.697598541336, 11278.718032048937, 10856.077233434931, 10859.511321990687, 10899.618513351994, 11179.552817887194, 11411.60059397917, 10728.0, 10917.890821092005, 10988.615398461016, 11017.11863050938, 11022.779544408906, 10406.271560990657, 10627.840582391425, 10777.784444311226, 10830.241883068109, 10830.67507974762, 9435.622575097193, 9437.858432123387, 9699.951500242736, 9717.6598819041, 9721.0, 8913.777155570902, 9327.253819694544, 9362.719118426457, 9415.011423800403, 9454.101860323259], "unit": "score", "name": "yui.html", "value": 5782.46353724127}], "name": "dromaeo_css", "value": 6428.438602797677}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 109.0, 114.0, 115.0, 113.0, 125.0, 113.0, 113.0, 121.0, 113.0], "unit": "score", "name": "ai-astar", "value": 115.2}, {"lowerIsBetter": true, "replicates": [153.0, 133.0, 155.0, 166.0, 133.0, 158.0, 156.0, 136.0, 171.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 149.1}, {"lowerIsBetter": true, "replicates": [163.0, 164.0, 165.0, 165.0, 166.0, 172.0, 162.0, 163.0, 167.0, 165.0], "unit": "score", "name": "audio-dft", "value": 165.2}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 74.0, 75.0, 157.0, 74.0, 73.0, 72.0, 73.0, 151.0], "unit": "score", "name": "audio-fft", "value": 89.5}, {"lowerIsBetter": true, "replicates": [94.0, 96.0, 137.0, 95.0, 96.0, 94.0, 139.0, 96.0, 95.0, 128.0], "unit": "score", "name": "audio-oscillator", "value": 107.0}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 111.0, 112.0, 110.0, 113.0, 111.0, 110.0, 110.0, 112.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 111.0}, {"lowerIsBetter": true, "replicates": [149.0, 148.0, 149.0, 149.0, 149.0, 147.0, 149.0, 148.0, 149.0, 149.0], "unit": "score", "name": "imaging-darkroom", "value": 148.6}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 99.0, 97.0, 98.0, 96.0, 97.0, 98.0, 98.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 97.3}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 74.0, 78.0, 72.0, 72.0, 73.0, 78.0, 71.0, 70.0], "unit": "score", "name": "json-parse-financial", "value": 73.6}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 68.0, 70.0, 68.0, 69.0, 69.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [92.0, 86.0, 84.0, 85.0, 85.0, 85.0, 84.0, 84.0, 87.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.6}, {"lowerIsBetter": true, "replicates": [124.0, 121.0, 127.0, 125.0, 134.0, 129.0, 128.0, 137.0, 127.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.8}, {"lowerIsBetter": true, "replicates": [139.0, 151.0, 147.0, 148.0, 152.0, 140.0, 159.0, 158.0, 139.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.7}, {"lowerIsBetter": true, "replicates": [72.0, 70.0, 74.0, 72.0, 70.0, 71.0, 69.0, 70.0, 71.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.8}], "name": "kraken", "value": 1557.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.36401673640168], "unit": "score", "name": "Richards", "value": 210.92945000000006}, {"lowerIsBetter": false, "replicates": [185.63207722294413], "unit": "score", "name": "DeltaBlue", "value": 356.1776659999999}, {"lowerIsBetter": false, "replicates": [278.70680044593087], "unit": "score", "name": "Encrypt", "value": 955.0574279999998}, {"lowerIsBetter": false, "replicates": [5164.948453608247], "unit": "score", "name": "Decrypt", "value": 51.53604191616765}, {"lowerIsBetter": false, "replicates": [1071.8113612004288], "unit": "score", "name": "RayTrace", "value": 690.4097369999998}, {"lowerIsBetter": false, "replicates": [716.3323782234957], "unit": "score", "name": "Earley", "value": 930.3823479999999}, {"lowerIsBetter": false, "replicates": [12219.512195121952], "unit": "score", "name": "Boyer", "value": 54.540884231536886}, {"lowerIsBetter": false, "replicates": [26342.105263157893], "unit": "score", "name": "RegExp", "value": 34.58284715284714}, {"lowerIsBetter": false, "replicates": [592.7682276229995], "unit": "score", "name": "Splay", "value": 137.47531699999993}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 21346.801399144773}]} 17:34:10 INFO - RETURN: dromaeo_css: 6428.44 17:34:10 INFO - RETURN: kraken: 1557.30 17:34:10 INFO - RETURN: v8_7: 21346.80 17:34:10 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21346.80"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1557.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6428.44"}}} 17:34:10 INFO - Return code: 0 17:34:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:34:10 INFO - # TBPL SUCCESS # 17:34:10 INFO - Running post-action listener: _resource_record_post_action 17:34:10 INFO - Running post-run listener: _resource_record_post_run 17:34:12 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 8192; Write bytes: 508354560; Read time: 68; Write time: 373108 17:34:12 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 231145472; Read time: 0; Write time: 212312 17:34:12 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 8192; Write bytes: 276795392; Read time: 68; Write time: 160740 17:34:12 INFO - Running post-run listener: _upload_blobber_files 17:34:12 INFO - Blob upload gear active. 17:34:12 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 17:34:12 INFO - Copying logs to upload dir... 17:34:12 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1269.877471 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-15 17:34:12.090358) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-15 17:34:12.093834) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1450228328.749263-955132104 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009927 build_url: 'https://queue.taskcluster.net/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/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-15 17:34:12.145850) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 17:34:12.146229) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1450228328.749263-955132104 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 17:34:12.196736) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-15 17:34:12.197107) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-15 17:34:12.197466) ========= ========= Total master_lag: 0.26 =========