builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-034 starttime: 1450285464.28 results: success (0) buildid: 20151216083053 builduid: 4eb9a8d6ee1d4ae89a63ebfce4d49e5d revision: b13cc636c9c8573f8c5d39ac2fbdefbff70f51df ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 09:04:24.279872) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 09:04:24.280797) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 09:04:24.281093) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1450284880.663872-775345031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006505 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 09:04:24.336856) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 09:04:24.337143) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 09:04:24.445662) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 09:04:24.445933) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1450284880.663872-775345031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004031 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 09:04:24.504059) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 09:04:24.504327) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 09:04:24.504683) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 09:04:24.504963) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1450284880.663872-775345031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-16 09:04:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2015-12-16 09:04:25 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.130222 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 09:04:24.651150) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 09:04:24.651429) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1450284880.663872-775345031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020693 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 09:04:24.702100) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 09:04:24.702406) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b13cc636c9c8573f8c5d39ac2fbdefbff70f51df --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 b13cc636c9c8573f8c5d39ac2fbdefbff70f51df --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=d16fe3a243cfe9e60ec7df77000001e0-1450284880.663872-775345031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-16 09:04:25,232 truncating revision to first 12 chars 2015-12-16 09:04:25,232 Setting DEBUG logging. 2015-12-16 09:04:25,232 attempt 1/10 2015-12-16 09:04:25,232 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b13cc636c9c8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-16 09:04:25,461 unpacking tar archive at: fx-team-b13cc636c9c8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.479685 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 09:04:25.195965) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 09:04:25.196272) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 09:04:25.214490) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 09:04:25.214771) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 09:04:25.215144) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2015-12-16 09:04:25.215486) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=d16fe3a243cfe9e60ec7df77000001e0-1450284880.663872-775345031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:04:25 INFO - MultiFileLogger online at 20151216 09:04:25 in /builds/slave/test 09:04:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 09:04:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:04:25 INFO - {'append_to_log': False, 09:04:25 INFO - 'base_work_dir': '/builds/slave/test', 09:04:25 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:04:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:04:25 INFO - 'branch': 'Fx-Team-Non-PGO', 09:04:25 INFO - 'buildbot_json_path': 'buildprops.json', 09:04:25 INFO - 'config_files': ('talos/linux_config.py',), 09:04:25 INFO - 'default_actions': ('clobber', 09:04:25 INFO - 'read-buildbot-config', 09:04:25 INFO - 'download-and-extract', 09:04:25 INFO - 'populate-webroot', 09:04:25 INFO - 'create-virtualenv', 09:04:25 INFO - 'install', 09:04:25 INFO - 'run-tests'), 09:04:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:04:25 INFO - 'download_minidump_stackwalk': True, 09:04:25 INFO - 'download_symbols': 'ondemand', 09:04:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:04:25 INFO - 'tooltool.py': '/tools/tooltool.py', 09:04:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:04:25 INFO - '/tools/misc-python/virtualenv.py')}, 09:04:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:04:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:04:25 INFO - 'installer_path': 'installer.exe', 09:04:25 INFO - 'log_level': 'info', 09:04:25 INFO - 'log_name': 'talos', 09:04:25 INFO - 'log_to_console': True, 09:04:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:04:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:04:25 INFO - 'opt_config_files': (), 09:04:25 INFO - 'pip_index': False, 09:04:25 INFO - 'sps_profile': False, 09:04:25 INFO - 'sps_profile_interval': 0, 09:04:25 INFO - 'suite': 'dromaeojs', 09:04:25 INFO - 'system_bits': '64', 09:04:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:04:25 INFO - 'title': 'talos-linux64-ix-034', 09:04:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:04:25 INFO - 'use_talos_json': True, 09:04:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:04:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:04:25 INFO - 'work_dir': 'build'} 09:04:25 INFO - ##### 09:04:25 INFO - ##### Running clobber step. 09:04:25 INFO - ##### 09:04:25 INFO - Running pre-action listener: _resource_record_pre_action 09:04:25 INFO - Running main action method: clobber 09:04:25 INFO - rmtree: /builds/slave/test/build 09:04:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:04:26 INFO - Running post-action listener: _resource_record_post_action 09:04:26 INFO - ##### 09:04:26 INFO - ##### Running read-buildbot-config step. 09:04:26 INFO - ##### 09:04:26 INFO - Running pre-action listener: _resource_record_pre_action 09:04:26 INFO - Running main action method: read_buildbot_config 09:04:26 INFO - Using buildbot properties: 09:04:26 INFO - { 09:04:26 INFO - "properties": { 09:04:26 INFO - "buildnumber": 1200, 09:04:26 INFO - "product": "firefox", 09:04:26 INFO - "script_repo_revision": "production", 09:04:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:04:26 INFO - "repository": "", 09:04:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 09:04:26 INFO - "buildid": "20151216083053", 09:04:26 INFO - "slavename": "talos-linux64-ix-034", 09:04:26 INFO - "pgo_build": "False", 09:04:26 INFO - "basedir": "/builds/slave/test", 09:04:26 INFO - "project": "", 09:04:26 INFO - "platform": "ubuntu64_hw", 09:04:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:04:26 INFO - "slavebuilddir": "test", 09:04:26 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:04:26 INFO - "branch": "fx-team", 09:04:26 INFO - "repo_path": "integration/fx-team", 09:04:26 INFO - "stage_platform": "linux64", 09:04:26 INFO - "builduid": "4eb9a8d6ee1d4ae89a63ebfce4d49e5d", 09:04:26 INFO - "revision": "b13cc636c9c8573f8c5d39ac2fbdefbff70f51df" 09:04:26 INFO - }, 09:04:26 INFO - "sourcestamp": { 09:04:26 INFO - "repository": "", 09:04:26 INFO - "hasPatch": false, 09:04:26 INFO - "project": "", 09:04:26 INFO - "branch": "fx-team-linux64-talos", 09:04:26 INFO - "changes": [ 09:04:26 INFO - { 09:04:26 INFO - "category": null, 09:04:26 INFO - "files": [ 09:04:26 INFO - { 09:04:26 INFO - "url": null, 09:04:26 INFO - "name": "https://queue.taskcluster.net/v1/task/f6SkOJErTwqV-kuaojpO4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2" 09:04:26 INFO - } 09:04:26 INFO - ], 09:04:26 INFO - "repository": "", 09:04:26 INFO - "rev": "b13cc636c9c8573f8c5d39ac2fbdefbff70f51df", 09:04:26 INFO - "who": "gijskruitbosch@gmail.com", 09:04:26 INFO - "when": 1450285358, 09:04:26 INFO - "number": 7367130, 09:04:26 INFO - "comments": "Bug 1226145 - actually check whether the on-screen keyboard is up rather than relying on internal state, r=masayuki", 09:04:26 INFO - "project": "", 09:04:26 INFO - "at": "Wed 16 Dec 2015 09:02:38", 09:04:26 INFO - "branch": "fx-team-linux64-talos", 09:04:26 INFO - "revlink": "", 09:04:26 INFO - "properties": [ 09:04:26 INFO - [ 09:04:26 INFO - "buildid", 09:04:26 INFO - "20151216083053", 09:04:26 INFO - "Change" 09:04:26 INFO - ], 09:04:26 INFO - [ 09:04:26 INFO - "builduid", 09:04:26 INFO - "4eb9a8d6ee1d4ae89a63ebfce4d49e5d", 09:04:26 INFO - "Change" 09:04:26 INFO - ], 09:04:26 INFO - [ 09:04:26 INFO - "pgo_build", 09:04:26 INFO - "False", 09:04:26 INFO - "Change" 09:04:26 INFO - ] 09:04:26 INFO - ], 09:04:26 INFO - "revision": "b13cc636c9c8573f8c5d39ac2fbdefbff70f51df" 09:04:26 INFO - } 09:04:26 INFO - ], 09:04:26 INFO - "revision": "b13cc636c9c8573f8c5d39ac2fbdefbff70f51df" 09:04:26 INFO - } 09:04:26 INFO - } 09:04:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/f6SkOJErTwqV-kuaojpO4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 09:04:26 INFO - Running post-action listener: _resource_record_post_action 09:04:26 INFO - ##### 09:04:26 INFO - ##### Running download-and-extract step. 09:04:26 INFO - ##### 09:04:26 INFO - Running pre-action listener: _resource_record_pre_action 09:04:26 INFO - Running main action method: download_and_extract 09:04:26 INFO - mkdir: /builds/slave/test/build/tests 09:04:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:26 INFO - https://queue.taskcluster.net/v1/task/f6SkOJErTwqV-kuaojpO4Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:04:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6SkOJErTwqV-kuaojpO4Q/artifacts/public/build/test_packages.json 09:04:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6SkOJErTwqV-kuaojpO4Q/artifacts/public/build/test_packages.json 09:04:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6SkOJErTwqV-kuaojpO4Q/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:04:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6SkOJErTwqV-kuaojpO4Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:04:37 INFO - Downloaded 1302 bytes. 09:04:37 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:04:37 INFO - Using the following test package requirements: 09:04:37 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 09:04:37 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:04:37 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:37 INFO - u'jsshell-linux-x86_64.zip'], 09:04:37 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:04:37 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 09:04:37 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:04:37 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:04:37 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:04:37 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 09:04:37 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:04:37 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:04:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:37 INFO - https://queue.taskcluster.net/v1/task/f6SkOJErTwqV-kuaojpO4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:04:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6SkOJErTwqV-kuaojpO4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:04:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6SkOJErTwqV-kuaojpO4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:04:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6SkOJErTwqV-kuaojpO4Q/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 09:04:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6SkOJErTwqV-kuaojpO4Q/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 09:04:48 INFO - Downloaded 21870297 bytes. 09:04:48 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 09:04:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:04:48 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 09:04:49 INFO - Return code: 0 09:04:49 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 09:04:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:49 INFO - https://queue.taskcluster.net/v1/task/f6SkOJErTwqV-kuaojpO4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:04:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6SkOJErTwqV-kuaojpO4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:04:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6SkOJErTwqV-kuaojpO4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:04:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6SkOJErTwqV-kuaojpO4Q/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 09:04:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6SkOJErTwqV-kuaojpO4Q/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 09:04:50 INFO - Downloaded 21870297 bytes. 09:04:50 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 09:04:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:04:50 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 09:04:51 INFO - Return code: 0 09:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:51 INFO - https://queue.taskcluster.net/v1/task/f6SkOJErTwqV-kuaojpO4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:04:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6SkOJErTwqV-kuaojpO4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 09:04:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6SkOJErTwqV-kuaojpO4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 09:04:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6SkOJErTwqV-kuaojpO4Q/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 09:04:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6SkOJErTwqV-kuaojpO4Q/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 09:04:52 INFO - Downloaded 11132052 bytes. 09:04:52 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 09:04:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 09:04:52 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 09:04:52 INFO - Return code: 0 09:04: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')]} 09:04:52 INFO - https://queue.taskcluster.net/v1/task/f6SkOJErTwqV-kuaojpO4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:04:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6SkOJErTwqV-kuaojpO4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:04:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6SkOJErTwqV-kuaojpO4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:04:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6SkOJErTwqV-kuaojpO4Q/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 09:04:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6SkOJErTwqV-kuaojpO4Q/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 09:04:53 INFO - Downloaded 57746908 bytes. 09:04:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f6SkOJErTwqV-kuaojpO4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:04:53 INFO - mkdir: /builds/slave/test/properties 09:04:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:04:53 INFO - Writing to file /builds/slave/test/properties/build_url 09:04:53 INFO - Contents: 09:04:53 INFO - build_url:https://queue.taskcluster.net/v1/task/f6SkOJErTwqV-kuaojpO4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:04:53 INFO - Running post-action listener: _resource_record_post_action 09:04:53 INFO - Running post-action listener: set_extra_try_arguments 09:04:53 INFO - ##### 09:04:53 INFO - ##### Running populate-webroot step. 09:04:53 INFO - ##### 09:04:53 INFO - Running pre-action listener: _resource_record_pre_action 09:04:53 INFO - Running main action method: populate_webroot 09:04:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:04:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:04:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:04:53 INFO - '--tppagecycles', 09:04:53 INFO - '7'], 09:04:53 INFO - 'tests': ['tsvgm']}}, 09:04:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:04:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:04:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:04:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:04:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:04:53 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:04:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:04:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:53 INFO - 'talos_options': ['--e10s'], 09:04:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:04:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:53 INFO - 'tests': ['damp', 'tps']}, 09:04:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:53 INFO - 'talos_options': ['--e10s'], 09:04:53 INFO - 'tests': ['damp', 'tps']}, 09:04:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:04:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:04:53 INFO - 'other': {'tests': ['a11yr', 09:04:53 INFO - 'ts_paint', 09:04:53 INFO - 'tpaint', 09:04:53 INFO - 'sessionrestore', 09:04:53 INFO - 'sessionrestore_no_auto_restore']}, 09:04:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:04:53 INFO - 'tests': ['a11yr', 09:04:53 INFO - 'ts_paint', 09:04:53 INFO - 'tpaint', 09:04:53 INFO - 'sessionrestore', 09:04:53 INFO - 'sessionrestore_no_auto_restore']}, 09:04:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:04:53 INFO - 'tests': ['a11yr', 09:04:53 INFO - 'ts_paint', 09:04:53 INFO - 'tpaint', 09:04:53 INFO - 'sessionrestore', 09:04:53 INFO - 'sessionrestore_no_auto_restore']}, 09:04:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:04:53 INFO - 'tests': ['a11yr', 09:04:53 INFO - 'ts_paint', 09:04:53 INFO - 'tpaint', 09:04:53 INFO - 'sessionrestore', 09:04:53 INFO - 'sessionrestore_no_auto_restore']}, 09:04:53 INFO - 'other_l64': {'tests': ['a11yr', 09:04:53 INFO - 'ts_paint', 09:04:53 INFO - 'tpaint', 09:04:53 INFO - 'sessionrestore', 09:04:53 INFO - 'sessionrestore_no_auto_restore']}, 09:04:53 INFO - 'other_nol64': {'tests': ['a11yr', 09:04:53 INFO - 'ts_paint', 09:04:53 INFO - 'tpaint', 09:04:53 INFO - 'sessionrestore', 09:04:53 INFO - 'sessionrestore_no_auto_restore']}, 09:04:53 INFO - 'svgr': {'tests': ['tsvgx', 09:04:53 INFO - 'tsvgr_opacity', 09:04:53 INFO - 'tart', 09:04:53 INFO - 'tscrollx', 09:04:53 INFO - 'cart']}, 09:04:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:04:53 INFO - 'tests': ['tsvgx', 09:04:53 INFO - 'tsvgr_opacity', 09:04:53 INFO - 'tart', 09:04:53 INFO - 'tscrollx', 09:04:53 INFO - 'cart']}, 09:04:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:53 INFO - 'tests': ['tp5o']}, 09:04:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:53 INFO - 'talos_options': ['--e10s'], 09:04:53 INFO - 'tests': ['tp5o']}, 09:04:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:53 INFO - 'talos_options': ['--xperf_path', 09:04:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:04:53 INFO - 'tests': ['tp5n']}, 09:04:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:53 INFO - 'talos_options': ['--e10s', 09:04:53 INFO - '--xperf_path', 09:04:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:04:53 INFO - 'tests': ['tp5n']}}, 09:04:53 INFO - 'talos.zip': {'path': '', 09:04:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:04:53 INFO - Running post-action listener: _resource_record_post_action 09:04:53 INFO - ##### 09:04:53 INFO - ##### Running create-virtualenv step. 09:04:53 INFO - ##### 09:04:53 INFO - Running pre-action listener: _resource_record_pre_action 09:04:53 INFO - Running main action method: create_virtualenv 09:04:53 INFO - Creating virtualenv /builds/slave/test/build/venv 09:04:53 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:04:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:04:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:04:54 INFO - Using real prefix '/usr' 09:04:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:04:54 INFO - Installing distribute.............................................................................................................................................................................................done. 09:04:56 INFO - Installing pip.................done. 09:04:56 INFO - Return code: 0 09:04:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:04:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6011934f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd05240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd940b0>, '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 0xd94fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd95440>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1450284880.663872-775345031', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:04:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:04:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:04:56 INFO - Using env: {'DISPLAY': ':0', 09:04:56 INFO - 'HOME': '/home/cltbld', 09:04:56 INFO - 'LANG': 'en_US.UTF-8', 09:04:56 INFO - 'LANGUAGE': 'en_US:en', 09:04:56 INFO - 'LOGNAME': 'cltbld', 09:04:56 INFO - 'MAIL': '/var/mail/cltbld', 09:04:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:56 INFO - 'MOZ_NO_REMOTE': '1', 09:04:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:56 INFO - 'NO_EM_RESTART': '1', 09:04:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:56 INFO - 'PWD': '/builds/slave/test', 09:04:56 INFO - 'SHELL': '/bin/bash', 09:04:56 INFO - 'SHLVL': '1', 09:04:56 INFO - 'TERM': 'linux', 09:04:56 INFO - 'TMOUT': '86400', 09:04:56 INFO - 'USER': 'cltbld', 09:04:56 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1450284880.663872-775345031', 09:04:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:56 INFO - '_': '/tools/buildbot/bin/python'} 09:04:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:56 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:04:56 INFO - Cleaning up... 09:04:56 INFO - Return code: 0 09:04:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:04:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6011934f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd05240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd940b0>, '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 0xd94fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd95440>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1450284880.663872-775345031', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:04:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:04:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:04:56 INFO - Using env: {'DISPLAY': ':0', 09:04:56 INFO - 'HOME': '/home/cltbld', 09:04:56 INFO - 'LANG': 'en_US.UTF-8', 09:04:56 INFO - 'LANGUAGE': 'en_US:en', 09:04:56 INFO - 'LOGNAME': 'cltbld', 09:04:56 INFO - 'MAIL': '/var/mail/cltbld', 09:04:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:56 INFO - 'MOZ_NO_REMOTE': '1', 09:04:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:56 INFO - 'NO_EM_RESTART': '1', 09:04:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:56 INFO - 'PWD': '/builds/slave/test', 09:04:56 INFO - 'SHELL': '/bin/bash', 09:04:56 INFO - 'SHLVL': '1', 09:04:56 INFO - 'TERM': 'linux', 09:04:56 INFO - 'TMOUT': '86400', 09:04:56 INFO - 'USER': 'cltbld', 09:04:56 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1450284880.663872-775345031', 09:04:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:56 INFO - '_': '/tools/buildbot/bin/python'} 09:04:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:56 INFO - Downloading/unpacking psutil>=0.7.1 09:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:58 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 09:04:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:04:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:04:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:04:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:04:58 INFO - Installing collected packages: psutil 09:04:58 INFO - Running setup.py install for psutil 09:04:58 INFO - building 'psutil._psutil_linux' extension 09:04:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:04:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:04:58 INFO - building 'psutil._psutil_posix' extension 09:04:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:04:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:04:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:04:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:04:59 INFO - Successfully installed psutil 09:04:59 INFO - Cleaning up... 09:04:59 INFO - Return code: 0 09:04:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:04:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6011934f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd05240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd940b0>, '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 0xd94fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd95440>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1450284880.663872-775345031', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:04:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:04:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:04:59 INFO - Using env: {'DISPLAY': ':0', 09:04:59 INFO - 'HOME': '/home/cltbld', 09:04:59 INFO - 'LANG': 'en_US.UTF-8', 09:04:59 INFO - 'LANGUAGE': 'en_US:en', 09:04:59 INFO - 'LOGNAME': 'cltbld', 09:04:59 INFO - 'MAIL': '/var/mail/cltbld', 09:04:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:59 INFO - 'MOZ_NO_REMOTE': '1', 09:04:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:59 INFO - 'NO_EM_RESTART': '1', 09:04:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:59 INFO - 'PWD': '/builds/slave/test', 09:04:59 INFO - 'SHELL': '/bin/bash', 09:04:59 INFO - 'SHLVL': '1', 09:04:59 INFO - 'TERM': 'linux', 09:04:59 INFO - 'TMOUT': '86400', 09:04:59 INFO - 'USER': 'cltbld', 09:04:59 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1450284880.663872-775345031', 09:04:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:59 INFO - '_': '/tools/buildbot/bin/python'} 09:04:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:05:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:05:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:05:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:05:01 INFO - Installing collected packages: mozsystemmonitor 09:05:01 INFO - Running setup.py install for mozsystemmonitor 09:05:01 INFO - Successfully installed mozsystemmonitor 09:05:01 INFO - Cleaning up... 09:05:01 INFO - Return code: 0 09:05:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:05:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6011934f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd05240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd940b0>, '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 0xd94fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd95440>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1450284880.663872-775345031', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:05:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:05:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:05:01 INFO - Using env: {'DISPLAY': ':0', 09:05:01 INFO - 'HOME': '/home/cltbld', 09:05:01 INFO - 'LANG': 'en_US.UTF-8', 09:05:01 INFO - 'LANGUAGE': 'en_US:en', 09:05:01 INFO - 'LOGNAME': 'cltbld', 09:05:01 INFO - 'MAIL': '/var/mail/cltbld', 09:05:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:01 INFO - 'MOZ_NO_REMOTE': '1', 09:05:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:01 INFO - 'NO_EM_RESTART': '1', 09:05:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:01 INFO - 'PWD': '/builds/slave/test', 09:05:01 INFO - 'SHELL': '/bin/bash', 09:05:01 INFO - 'SHLVL': '1', 09:05:01 INFO - 'TERM': 'linux', 09:05:01 INFO - 'TMOUT': '86400', 09:05:01 INFO - 'USER': 'cltbld', 09:05:01 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1450284880.663872-775345031', 09:05:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:01 INFO - '_': '/tools/buildbot/bin/python'} 09:05:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:01 INFO - Downloading/unpacking blobuploader==1.2.4 09:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:03 INFO - Downloading blobuploader-1.2.4.tar.gz 09:05:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:05:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:05:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:05:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:05:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:03 INFO - Downloading docopt-0.6.1.tar.gz 09:05:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:05:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:05:03 INFO - Installing collected packages: blobuploader, requests, docopt 09:05:03 INFO - Running setup.py install for blobuploader 09:05:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:05:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:05:04 INFO - Running setup.py install for requests 09:05:04 INFO - Running setup.py install for docopt 09:05:04 INFO - Successfully installed blobuploader requests docopt 09:05:04 INFO - Cleaning up... 09:05:04 INFO - Return code: 0 09:05:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:05:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6011934f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd05240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd940b0>, '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 0xd94fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd95440>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1450284880.663872-775345031', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:05:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:05:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:05:04 INFO - Using env: {'DISPLAY': ':0', 09:05:04 INFO - 'HOME': '/home/cltbld', 09:05:04 INFO - 'LANG': 'en_US.UTF-8', 09:05:04 INFO - 'LANGUAGE': 'en_US:en', 09:05:04 INFO - 'LOGNAME': 'cltbld', 09:05:04 INFO - 'MAIL': '/var/mail/cltbld', 09:05:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:04 INFO - 'MOZ_NO_REMOTE': '1', 09:05:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:04 INFO - 'NO_EM_RESTART': '1', 09:05:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:04 INFO - 'PWD': '/builds/slave/test', 09:05:04 INFO - 'SHELL': '/bin/bash', 09:05:04 INFO - 'SHLVL': '1', 09:05:04 INFO - 'TERM': 'linux', 09:05:04 INFO - 'TMOUT': '86400', 09:05:04 INFO - 'USER': 'cltbld', 09:05:04 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1450284880.663872-775345031', 09:05:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:04 INFO - '_': '/tools/buildbot/bin/python'} 09:05:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:05:04 INFO - Running setup.py (path:/tmp/pip-oDv_Ro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:05:04 INFO - Running setup.py (path:/tmp/pip-OoJYIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:05:04 INFO - Running setup.py (path:/tmp/pip-QQM5QK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:05:05 INFO - Running setup.py (path:/tmp/pip-9YlLwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:05:05 INFO - Running setup.py (path:/tmp/pip-ll2Toh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:05:05 INFO - Running setup.py (path:/tmp/pip-gWEesc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:05:05 INFO - Running setup.py (path:/tmp/pip-YjV7n7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:05:05 INFO - Running setup.py (path:/tmp/pip-BeLddM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:05:05 INFO - Running setup.py (path:/tmp/pip-ifbp2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:05:05 INFO - Running setup.py (path:/tmp/pip-kJmlvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:05:05 INFO - Running setup.py (path:/tmp/pip-lKO0jZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:05:05 INFO - Running setup.py (path:/tmp/pip-wCSoDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:05:05 INFO - Running setup.py (path:/tmp/pip-EUkYfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:05:05 INFO - Running setup.py (path:/tmp/pip-6SmkuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:05 INFO - Running setup.py (path:/tmp/pip-KhrdZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:05:05 INFO - Running setup.py (path:/tmp/pip-27LjAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:05:05 INFO - Running setup.py (path:/tmp/pip-Syct8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:05:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:05:06 INFO - Running setup.py install for manifestparser 09:05:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:05:06 INFO - Running setup.py install for mozcrash 09:05:06 INFO - Running setup.py install for mozdebug 09:05:06 INFO - Running setup.py install for mozdevice 09:05:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:05:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:05:06 INFO - Running setup.py install for mozfile 09:05:06 INFO - Running setup.py install for mozhttpd 09:05:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:05:06 INFO - Running setup.py install for mozinfo 09:05:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:05:06 INFO - Running setup.py install for mozInstall 09:05:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:05:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:05:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:05:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:05:06 INFO - Running setup.py install for mozleak 09:05:06 INFO - Running setup.py install for mozlog 09:05:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:05:07 INFO - Running setup.py install for moznetwork 09:05:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:05:07 INFO - Running setup.py install for mozprocess 09:05:07 INFO - Running setup.py install for mozprofile 09:05:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:05:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:05:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:05:07 INFO - Running setup.py install for mozrunner 09:05:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:05:07 INFO - Running setup.py install for mozscreenshot 09:05:07 INFO - Running setup.py install for moztest 09:05:07 INFO - Running setup.py install for mozversion 09:05:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:05:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:05:07 INFO - Cleaning up... 09:05:07 INFO - Return code: 0 09:05:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:05:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:07 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 0x7f6011934f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd05240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd940b0>, '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 0xd94fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd95440>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1450284880.663872-775345031', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:05:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:05:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:05:07 INFO - Using env: {'DISPLAY': ':0', 09:05:07 INFO - 'HOME': '/home/cltbld', 09:05:07 INFO - 'LANG': 'en_US.UTF-8', 09:05:07 INFO - 'LANGUAGE': 'en_US:en', 09:05:07 INFO - 'LOGNAME': 'cltbld', 09:05:07 INFO - 'MAIL': '/var/mail/cltbld', 09:05:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:07 INFO - 'MOZ_NO_REMOTE': '1', 09:05:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:07 INFO - 'NO_EM_RESTART': '1', 09:05:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:07 INFO - 'PWD': '/builds/slave/test', 09:05:07 INFO - 'SHELL': '/bin/bash', 09:05:07 INFO - 'SHLVL': '1', 09:05:07 INFO - 'TERM': 'linux', 09:05:07 INFO - 'TMOUT': '86400', 09:05:07 INFO - 'USER': 'cltbld', 09:05:07 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1450284880.663872-775345031', 09:05:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:07 INFO - '_': '/tools/buildbot/bin/python'} 09:05:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:05:08 INFO - Running setup.py (path:/tmp/pip-sSGPcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:05:08 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:05:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:05:08 INFO - Running setup.py (path:/tmp/pip-9Oh2cF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:05:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:05:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:05:08 INFO - Running setup.py (path:/tmp/pip-4pekt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:05:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:05:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:05:08 INFO - Running setup.py (path:/tmp/pip-NGjw4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:05:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:05:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:05:08 INFO - Running setup.py (path:/tmp/pip-QhuZ87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:05:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:05:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:05:08 INFO - Running setup.py (path:/tmp/pip-u8Nkuh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:05:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:05:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:05:08 INFO - Running setup.py (path:/tmp/pip-QO7p_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:05:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:05:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:05:08 INFO - Running setup.py (path:/tmp/pip-UkA17l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:05:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:05:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:05:08 INFO - Running setup.py (path:/tmp/pip-nGAy4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:05:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:05:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:05:08 INFO - Running setup.py (path:/tmp/pip-_KshCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:05:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:05:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:05:08 INFO - Running setup.py (path:/tmp/pip-nuKTh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:05:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:05:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:05:08 INFO - Running setup.py (path:/tmp/pip-xymyp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:05:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:05:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:05:08 INFO - Running setup.py (path:/tmp/pip-3_1rlS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:05:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:05:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:05:08 INFO - Running setup.py (path:/tmp/pip-WxNzFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:09 INFO - Running setup.py (path:/tmp/pip-6XJDyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:05:09 INFO - Running setup.py (path:/tmp/pip-TxQqil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:05:09 INFO - Running setup.py (path:/tmp/pip-2TMiQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:05:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:10 INFO - Downloading blessings-1.5.1.tar.gz 09:05:10 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 09:05:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:05:11 INFO - Installing collected packages: blessings 09:05:11 INFO - Running setup.py install for blessings 09:05:11 INFO - Successfully installed blessings 09:05:11 INFO - Cleaning up... 09:05:11 INFO - Return code: 0 09:05:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:05:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:05:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:05:11 INFO - Reading from file tmpfile_stdout 09:05:11 INFO - Current package versions: 09:05:11 INFO - argparse == 1.2.1 09:05:11 INFO - blessings == 1.5.1 09:05:11 INFO - blobuploader == 1.2.4 09:05:11 INFO - docopt == 0.6.1 09:05:11 INFO - manifestparser == 1.1 09:05:11 INFO - mozInstall == 1.12 09:05:11 INFO - mozcrash == 0.16 09:05:11 INFO - mozdebug == 0.1 09:05:11 INFO - mozdevice == 0.47 09:05:11 INFO - mozfile == 1.2 09:05:11 INFO - mozhttpd == 0.7 09:05:11 INFO - mozinfo == 0.9 09:05:11 INFO - mozleak == 0.1 09:05:11 INFO - mozlog == 3.1 09:05:11 INFO - moznetwork == 0.27 09:05:11 INFO - mozprocess == 0.22 09:05:11 INFO - mozprofile == 0.27 09:05:11 INFO - mozrunner == 6.11 09:05:11 INFO - mozscreenshot == 0.1 09:05:11 INFO - mozsystemmonitor == 0.0 09:05:11 INFO - moztest == 0.7 09:05:11 INFO - mozversion == 1.4 09:05:11 INFO - psutil == 3.1.1 09:05:11 INFO - requests == 1.2.3 09:05:11 INFO - wsgiref == 0.1.2 09:05:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:05:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6011934f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd05240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd940b0>, '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 0xd94fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd95440>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1450284880.663872-775345031', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:05:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:05:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:05:11 INFO - Using env: {'DISPLAY': ':0', 09:05:11 INFO - 'HOME': '/home/cltbld', 09:05:11 INFO - 'LANG': 'en_US.UTF-8', 09:05:11 INFO - 'LANGUAGE': 'en_US:en', 09:05:11 INFO - 'LOGNAME': 'cltbld', 09:05:11 INFO - 'MAIL': '/var/mail/cltbld', 09:05:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:11 INFO - 'MOZ_NO_REMOTE': '1', 09:05:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:11 INFO - 'NO_EM_RESTART': '1', 09:05:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:11 INFO - 'PWD': '/builds/slave/test', 09:05:11 INFO - 'SHELL': '/bin/bash', 09:05:11 INFO - 'SHLVL': '1', 09:05:11 INFO - 'TERM': 'linux', 09:05:11 INFO - 'TMOUT': '86400', 09:05:11 INFO - 'USER': 'cltbld', 09:05:11 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1450284880.663872-775345031', 09:05:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:11 INFO - '_': '/tools/buildbot/bin/python'} 09:05:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:05:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:05:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:05:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:05:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:05:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:05:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:05:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:05:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:05:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:05:11 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:05:11 INFO - Cleaning up... 09:05:11 INFO - Return code: 0 09:05:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:05:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6011934f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd05240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd940b0>, '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 0xd94fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd95440>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1450284880.663872-775345031', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:05:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:05:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:05:11 INFO - Using env: {'DISPLAY': ':0', 09:05:11 INFO - 'HOME': '/home/cltbld', 09:05:11 INFO - 'LANG': 'en_US.UTF-8', 09:05:11 INFO - 'LANGUAGE': 'en_US:en', 09:05:11 INFO - 'LOGNAME': 'cltbld', 09:05:11 INFO - 'MAIL': '/var/mail/cltbld', 09:05:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:11 INFO - 'MOZ_NO_REMOTE': '1', 09:05:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:11 INFO - 'NO_EM_RESTART': '1', 09:05:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:11 INFO - 'PWD': '/builds/slave/test', 09:05:11 INFO - 'SHELL': '/bin/bash', 09:05:11 INFO - 'SHLVL': '1', 09:05:11 INFO - 'TERM': 'linux', 09:05:11 INFO - 'TMOUT': '86400', 09:05:11 INFO - 'USER': 'cltbld', 09:05:11 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1450284880.663872-775345031', 09:05:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:11 INFO - '_': '/tools/buildbot/bin/python'} 09:05:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:11 INFO - Downloading/unpacking jsonschema 09:05:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:05:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 09:05:13 INFO - Downloading/unpacking functools32 (from jsonschema) 09:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:13 INFO - Downloading functools32-3.2.3-2.tar.gz 09:05:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 09:05:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:05:13 INFO - warning: no files found matching '*.txt' 09:05:13 INFO - no previously-included directories found matching 'build' 09:05:13 INFO - no previously-included directories found matching 'dist' 09:05:13 INFO - no previously-included directories found matching '.git*' 09:05:13 INFO - Installing collected packages: jsonschema, functools32 09:05:13 INFO - Running setup.py install for functools32 09:05:13 INFO - warning: no files found matching '*.txt' 09:05:13 INFO - no previously-included directories found matching 'build' 09:05:13 INFO - no previously-included directories found matching 'dist' 09:05:13 INFO - no previously-included directories found matching '.git*' 09:05:13 INFO - Successfully installed jsonschema functools32 09:05:13 INFO - Cleaning up... 09:05:13 INFO - Return code: 0 09:05:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:05:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6011934f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd05240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd940b0>, '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 0xd94fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd95440>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1450284880.663872-775345031', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:05:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:05:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:05:13 INFO - Using env: {'DISPLAY': ':0', 09:05:13 INFO - 'HOME': '/home/cltbld', 09:05:13 INFO - 'LANG': 'en_US.UTF-8', 09:05:13 INFO - 'LANGUAGE': 'en_US:en', 09:05:13 INFO - 'LOGNAME': 'cltbld', 09:05:13 INFO - 'MAIL': '/var/mail/cltbld', 09:05:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:13 INFO - 'MOZ_NO_REMOTE': '1', 09:05:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:13 INFO - 'NO_EM_RESTART': '1', 09:05:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:13 INFO - 'PWD': '/builds/slave/test', 09:05:13 INFO - 'SHELL': '/bin/bash', 09:05:13 INFO - 'SHLVL': '1', 09:05:13 INFO - 'TERM': 'linux', 09:05:13 INFO - 'TMOUT': '86400', 09:05:13 INFO - 'USER': 'cltbld', 09:05:13 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1450284880.663872-775345031', 09:05:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:13 INFO - '_': '/tools/buildbot/bin/python'} 09:05:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:14 INFO - Downloading/unpacking flake8 09:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:05:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 09:05:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:05:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:05:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 09:05:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:05:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 09:05:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:05:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 09:05:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:05:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:05:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:05:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:05:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:05:16 INFO - no previously-included directories found matching 'docs/_build' 09:05:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:05:16 INFO - Running setup.py install for pep8 09:05:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:05:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:05:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:05:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:05:16 INFO - no previously-included directories found matching 'docs/_build' 09:05:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:05:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:05:16 INFO - Cleaning up... 09:05:16 INFO - Return code: 0 09:05:16 INFO - Running post-action listener: _resource_record_post_action 09:05:16 INFO - Running post-action listener: _start_resource_monitoring 09:05:16 INFO - Starting resource monitoring. 09:05:16 INFO - ##### 09:05:16 INFO - ##### Running install step. 09:05:16 INFO - ##### 09:05:16 INFO - Running pre-action listener: _resource_record_pre_action 09:05:16 INFO - Running main action method: install 09:05:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:05:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:05:16 INFO - Reading from file tmpfile_stdout 09:05:16 INFO - Detecting whether we're running mozinstall >=1.0... 09:05:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:05:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:05:17 INFO - Reading from file tmpfile_stdout 09:05:17 INFO - Output received: 09:05:17 INFO - Usage: mozinstall [options] installer 09:05:17 INFO - Options: 09:05:17 INFO - -h, --help show this help message and exit 09:05:17 INFO - -d DEST, --destination=DEST 09:05:17 INFO - Directory to install application into. [default: 09:05:17 INFO - "/builds/slave/test"] 09:05:17 INFO - --app=APP Application being installed. [default: firefox] 09:05:17 INFO - mkdir: /builds/slave/test/build/application 09:05:17 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'] 09:05:17 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 09:05:31 INFO - Reading from file tmpfile_stdout 09:05:31 INFO - Output received: 09:05:31 INFO - /builds/slave/test/build/application/firefox/firefox 09:05:31 INFO - Running post-action listener: _resource_record_post_action 09:05:31 INFO - ##### 09:05:31 INFO - ##### Running run-tests step. 09:05:31 INFO - ##### 09:05:31 INFO - Running pre-action listener: _resource_record_pre_action 09:05:31 INFO - Running main action method: run_tests 09:05:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:05:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:05:31 INFO - Python 2.7.3 09:05:31 INFO - Return code: 0 09:05:31 INFO - grabbing minidump binary from tooltool 09:05:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:31 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd940b0>, '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 0xd94fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd95440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:05:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:05:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:05:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:05:31 INFO - Return code: 0 09:05:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:05:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:05:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:05:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:05:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:05:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:05:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:05:32 INFO - Return code: 0 09:05:32 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f6SkOJErTwqV-kuaojpO4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost'] in /builds/slave/test/build 09:05:32 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/f6SkOJErTwqV-kuaojpO4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --webServer localhost 09:05:32 INFO - Using env: {'DISPLAY': ':0', 09:05:32 INFO - 'HOME': '/home/cltbld', 09:05:32 INFO - 'LANG': 'en_US.UTF-8', 09:05:32 INFO - 'LANGUAGE': 'en_US:en', 09:05:32 INFO - 'LOGNAME': 'cltbld', 09:05:32 INFO - 'MAIL': '/var/mail/cltbld', 09:05:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:05:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:05:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:32 INFO - 'MOZ_NO_REMOTE': '1', 09:05:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:05:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:32 INFO - 'NO_EM_RESTART': '1', 09:05:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:32 INFO - 'PWD': '/builds/slave/test', 09:05:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:05:32 INFO - 'SHELL': '/bin/bash', 09:05:32 INFO - 'SHLVL': '1', 09:05:32 INFO - 'TERM': 'linux', 09:05:32 INFO - 'TMOUT': '86400', 09:05:32 INFO - 'USER': 'cltbld', 09:05:32 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1450284880.663872-775345031', 09:05:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:32 INFO - '_': '/tools/buildbot/bin/python'} 09:05:32 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f6SkOJErTwqV-kuaojpO4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost'] with output_timeout 3600 09:05:32 INFO - mozversion INFO | application_buildid: 20151216083053 09:05:32 INFO - mozversion INFO | application_changeset: b13cc636c9c8573f8c5d39ac2fbdefbff70f51df 09:05:32 INFO - mozversion INFO | application_display_name: Nightly 09:05:32 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:05:32 INFO - mozversion INFO | application_name: Firefox 09:05:32 INFO - mozversion INFO | application_remotingname: firefox 09:05:32 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 09:05:32 INFO - mozversion INFO | application_vendor: Mozilla 09:05:32 INFO - mozversion INFO | application_version: 46.0a1 09:05:32 INFO - mozversion INFO | platform_buildid: 20151216083053 09:05:32 INFO - mozversion INFO | platform_changeset: b13cc636c9c8573f8c5d39ac2fbdefbff70f51df 09:05:32 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 09:05:32 INFO - mozversion INFO | platform_version: 46.0a1 09:05:32 INFO - 2015-12-16 09:05:32,765 DEBUG : using testdate: 1450285532 09:05:32 INFO - 2015-12-16 09:05:32,765 DEBUG : actual date: 1450285532 09:05:32 INFO - 2015-12-16 09:05:32,817 INFO : starting webserver on 'localhost:40281' 09:05:32 INFO - 2015-12-16 09:05:32,818 INFO : Starting test suite talos-linux64-ix-034 09:05:32 INFO - 2015-12-16 09:05:32,818 INFO : Starting test dromaeo_css 09:05:32 INFO - 2015-12-16 09:05:32,818 DEBUG : operating with platform_type : linux_ 09:05:32 INFO - 2015-12-16 09:05:32,819 INFO : Initialising browser for dromaeo_css test... 09:05:32 INFO - 2015-12-16 09:05:32,834 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpinP3Hs/profile http://localhost:40281/getInfo.html 09:05:37 INFO - 2015-12-16 09:05:37,944 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:05:37 INFO - 2015-12-16 09:05:37,944 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:05:37 INFO - 2015-12-16 09:05:37,944 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:05:37 INFO - 2015-12-16 09:05:37,944 DEBUG : BROWSER_OUTPUT: __metrics 09:05:38 INFO - 2015-12-16 09:05:38,101 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 09:05:38 INFO - 2015-12-16 09:05:38,165 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:05:39 INFO - 2015-12-16 09:05:39,103 INFO : Browser initialized. 09:05:39 INFO - 2015-12-16 09:05:39,104 INFO : Running cycle 1/1 for dromaeo_css test... 09:05:39 INFO - 2015-12-16 09:05:39,104 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpinP3Hs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:05:51 INFO - 2015-12-16 09:05:51,125 DEBUG : BROWSER_OUTPUT: RSS: Main: 142807040 09:05:51 INFO - 2015-12-16 09:05:51,125 DEBUG : BROWSER_OUTPUT: 09:06:42 INFO - 2015-12-16 09:06:42,442 DEBUG : BROWSER_OUTPUT: 1450285602437 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:08:54 INFO - 2015-12-16 09:08:54,177 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40281/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40281/tests/dromaeo/cssquery-ext.html) 09:08:55 INFO - 2015-12-16 09:08:55,791 DEBUG : BROWSER_OUTPUT: RSS: Main: 290041856 09:08:55 INFO - 2015-12-16 09:08:55,791 DEBUG : BROWSER_OUTPUT: 09:11:58 INFO - 2015-12-16 09:11:58,571 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40281/tests/dromaeo/cssquery-ext.html (next: http://localhost:40281/tests/dromaeo/cssquery-jquery.html) 09:11:59 INFO - 2015-12-16 09:11:59,144 DEBUG : BROWSER_OUTPUT: RSS: Main: 224301056 09:11:59 INFO - 2015-12-16 09:11:59,144 DEBUG : BROWSER_OUTPUT: 09:15:01 INFO - 2015-12-16 09:15:01,172 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40281/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40281/tests/dromaeo/cssquery-mootools.html) 09:15:01 INFO - 2015-12-16 09:15:01,758 DEBUG : BROWSER_OUTPUT: RSS: Main: 224731136 09:15:01 INFO - 2015-12-16 09:15:01,759 DEBUG : BROWSER_OUTPUT: 09:18:03 INFO - 2015-12-16 09:18:03,663 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40281/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40281/tests/dromaeo/cssquery-prototype.html) 09:18:04 INFO - 2015-12-16 09:18:04,249 DEBUG : BROWSER_OUTPUT: RSS: Main: 205500416 09:18:04 INFO - 2015-12-16 09:18:04,250 DEBUG : BROWSER_OUTPUT: 09:21:07 INFO - 2015-12-16 09:21:07,011 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40281/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40281/tests/dromaeo/cssquery-yui.html) 09:21:07 INFO - 2015-12-16 09:21:07,593 DEBUG : BROWSER_OUTPUT: RSS: Main: 208699392 09:21:07 INFO - 2015-12-16 09:21:07,594 DEBUG : BROWSER_OUTPUT: 09:24:10 INFO - 2015-12-16 09:24:10,365 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40281/tests/dromaeo/cssquery-yui.html (next: http://localhost:40281/tests/dromaeo/cssquery-dojo.html) 09:24:10 INFO - 2015-12-16 09:24:10,623 DEBUG : BROWSER_OUTPUT: RSS: Main: 279830528 09:24:10 INFO - 2015-12-16 09:24:10,623 DEBUG : BROWSER_OUTPUT: 09:24:10 INFO - 2015-12-16 09:24:10,623 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:24:10 INFO - 2015-12-16 09:24:10,624 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:24:10 INFO - 2015-12-16 09:24:10,624 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:24:10 INFO - 2015-12-16 09:24:10,624 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:24:10 INFO - 2015-12-16 09:24:10,624 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2627.6978147513037;2717.429339838634;2717.9456410871785;2731.412746259554;2734.4531093781243;4504.594586487216;4669.322948172513;4751.358566593509;4764.976175119128;4767.070421267854;4638.350630911675;4690.953090469095;4709.128811169936;4717.127331443686;4837.298591704201;4325.178216138924;4342.305231163023;4418.270985287424;4487.483939346968;4510.526394728556;4405.229084910144;4459.732416055047;4477.888052798674;4483.4171557697455;4517.774111294439;4194.328907374821;4271.850485233002;4303.65570754342;4352.17308711347;4378.255696531565;4339.500957389878;4372.322290045048;4384.7369157850635;4391.758453285068;4432.822687092513;4118.320477121271;4337.934930976038;4350.695451318409;4358.978205108954;4403.801828917706;4598.425196850394;4607.10161518504;4627.791749371253;4711.104890070876;4755.976220118911;5115.232715092766;5153.433122356538;5154.819581314636;5158.664686795384;5192.870178245536;4839.322494850724;5141.048905952373;5168.483151684839;5172.172452407597;5172.456892026358;4668.486466488684;4678.859634210945;4685.88285292867;4724.787384567703;4785.258284965836;5136.486351364908;5153.17549192135;5169.302144210484;5169.327987361619;5211.218317252443;4749.833755818529;4999.400071991385;5045.949540504622;5047.596192304681;5099.490050994945;4985;5003.199488081962;5017.623678224075;5093.796248150033;5114.590832733373;4990.700557966534;5029;5039.21892106724;5049.469805670426;5079.5428411443145;4747.548982846624;4988.451270360258;5007.599392048627;5010.398752149766;5012.523810238022;4150.584941505826;4175.248455278079;4188.643965262926;4235.385869048971;4251.404803327537;3693.8891833245048;3700.3709369407266;3704.277665855186;3705.962940370616;3721.832517536717;4331.675124365685;4376.7811609419405;4377.518472967971;4413.029133590605;4415.4259946206785;4865.051314993542;4964.751762411865;4988.700677959261;4991.001799640087;5086.9745651271505;4347.760873151944;4350.1734670412525;4385.627221686129;4392.407025051641;4408.845690400884;4519.728816271035;4521.253993091169;4524.7511386873375;4542.523035081335;4554.225781617133;4681.789319480564;4800.4479484859685;4870.732109733999;4871.683340582922;4886.413630364379;4996.50034996512;4998.775055122455;5080.110980578458;5088.338515992898;5123.948760512496;4849.442314133919;4852.1508735971765;4855.028994201244;4859.2954021665955;4895.583875370633;4818.301346304836;4946.109700253989;5016.322796422436;5024.698518088926;5062.240663900445;4913.778879950482;4946.925796113133;4947.356843610308;4970.403551573834;4972.950270497248;4834.347363105936;4836.153673107263;4850.345203397637;4857.392825896763;4858.854234372974;4934.703917764946;4945.530174633404;4945.629077819106;4945.950540494549;4957.058158949788;4834.6374021947795;4850.563449289581;4855.878603034952;4861.805527778849;4896.706197628154;4748.192807222849;4810.494898035656;4814.15752243349;4868.075065737498;5013.623978201576;4842.757862106951;4878.0975519529;4881.048195601966;4883.60931125502;4924.285978533021 09:24:10 INFO - 2015-12-16 09:24:10,624 DEBUG : BROWSER_OUTPUT: |1;ext.html;556.8607848037993;558.1766893831599;565.064817726662;568.8009196781127;580.3731969472967;26798.4640307194;32968.835155824214;33750.8312458438;33805.323893522174;33825;39875.20249595006;40412.19175616493;40423.59576404235;40434.59565404345;40514.79742601283;7078.716851325941;7196.532225405332;7674.040744906901;7821.726239581616;7825.491343062683;10130.949345253264;10353.896461035369;10365.378077315347;10369.896301036968;10373.429461379621;9843.360181588174;9918.752031199241;9919.404835709844;9923;9927.106560409562;7311.634418279064;7502.212267711866;7510;7511.286427789351;10014.3490673106;7123.501354905159;10091.899081009244;10393.272470927039;10403.53184106717;10410.219233557438;37698.43452348217;38102.61897381018;38230.23539529221;38304.233915321536;38353.616463835286;2810.1990932584117;2855.0863723608454;3068.186930463429;3428.194374322032;3636.8545258189642;28314.150575482563;28498.715012849814;28846.134615961553;28866;29301.56047659287;3307.834608269577;3312.850921708529;3323.7008669219886;3361.5629968104236;3426.9143271418166;213187;213352;215187;215204;215897;52408.21387679188;53443.73278133662;56147.71926140343;56493.717531412905;57734;49771;49813;50155.74922125439;50159.74920125449;50179;13944.651383715489;13982.091164074303;14124.646883827781;14147.787783183261;14152.22162781057;10556.313839600401;10601.204909631655;10613.363198208132;10615.575376984834;10726.249162558703;19040.395026474034;19489.170188455162;19528.51178720515;19536.12087456068;19553.608927821362;7252.891206631904;7391.926080739231;7480.513766605153;7525.285097915689;7533.773986780406;861.8104017116225;869.891263592051;887.671561522241;932.1936524905908;1008.9344192627456;27650.723492764813;27785.583216251773;27878.303042423697;28023.159305220877;28147.15558533247;957.5978089202551;980.3382716666222;988.3921388346115;992.5087081894509;1073.9636251017648;14808.922738865287;14826.670366479515;14932.708603329591;14965.401383944738;14982.550523484313;315812;321868;321890;322184;322250;48552;49181.262281065814;49182.50817491779;49188.11366408705;49190.50809491931;1043.5512729526376;1131.1064259235277;1198.532572296805;1250.612310183846;1310.7640624687458;26287.342816429744;27530.587041194798;27694.44611107807;27813;27884.860575697803;38253.61746382501;38575.807120964215;38603.99999999888;38625.6137438622;44551.77724111359;193182;195490;513038;529183;530265;38459.61540384672;38936.610633893295;38961.220775584894;38973;39707.80146099251;42048;42215.788921055195;42620.78689606532;42744.35883461813;43050.569494304655;34846.303073938885;35173;35573.644263557035;35641.82179089088;36002.8199858999;35848;35958.64041359553;35980.20098995092;36035.63964360323;36510.8174459126;36061.27877442489;36407.45388819117;36533.63466365302;36997.44503832391;37267.25465490621;28847.42305153927;30242.79028838822;30792.692073078983;30816.691833081382;31046.91335803236;23557.411064723517;23934.76065239325;24186.153484628656;24332.635010474503;24424.87787561051 09:24:10 INFO - 2015-12-16 09:24:10,624 DEBUG : BROWSER_OUTPUT: |2;jquery.html;333.90984434202784;340.94374428219345;342.47088248655825;343.12160868177466;349.0558040500446;12098.395080245975;12524.123311368185;14963.401463941444;15125.168115753642;16884.83115168848;11880.405979701023;12138.196044857475;13313.600591982231;14682.28377750117;14706.632334191623;4918.213085906255;5134.2812006319145;5147.665401748893;5148.639595228336;5153.793848246084;3720.4977328060772;5033.471485494026;5049.873753156164;5061.9240711389175;5123.513266239701;3806.5812760596314;5676.943230567683;5802.448767367094;5815.709214539277;5824.359320474766;5692.943070569324;5770.538356931435;5780.566457515703;5780.682062486561;5886.440788125121;5162.92255616166;5163.40620828602;5165.354330708661;5168.767405466763;5171.146760784503;18200.63598728031;18229.908850455795;18433.170507327202;18578.814211857843;19150.80849191518;1870.261246807517;1886.481217665153;1926.4509614759727;1935.2549268531575;1957.4421289932443;8111.391645626542;8301.211384918422;8462.36532260083;12388.938055309756;12986.415611297514;1735.3232239426634;1750.3786155914722;1761.7093179625347;1762.0396883698288;1772.8482166880904;53870.730646346514;57417.71291143559;57747.711261443845;58110.418895811345;58579.41420585782;9688.41869487833;9751.073648003428;9775.853362199572;9788.461634610023;9846.803063938682;12546.498140074478;12553.874461255453;12567.120301578801;12569.183003104768;12571.93714031424;7168.92831071693;7251.637418129178;7266.055412796302;7304.561726296439;7305.488615796843;6994.965025174944;7036.824079398056;7074.575525468488;7081.256468070881;7106.431485481149;4076.3477843544892;4162;4169.45797046382;4187.099773548702;4213.726107802983;1524.9695006099817;1588.0829144354368;1696.8642508599282;1716.416418417744;1772.9024903630425;407.5964794853074;716.4411758828122;836.1011912194415;906.2659246010752;931.4550987672152;8693.478391296416;9620.95189524048;9880.209583233323;9976.501174941224;10332.586696532055;394.1152113505142;402.3883696780935;404.82390160280374;404.97772622506045;406.90641152535085;8941.642334306685;9039.819203616022;9216.447013179097;9273.238084763872;9867.605295788231;465787;471333;472652;485522;489297;61589.692051540354;72859;73124.63437682777;74286;75329;1050.579768092769;1055.7096798380508;1057.2704833664748;1072.099436473366;1074.1836204484491;13754.381052852847;14258.786118208027;14810.925945370203;14893.702125957638;15075.54773356801;33157;33371.49942750812;34047.65952340445;34452.655473444946;34557;37621.81189094037;38393.80803095967;38609.227815444094;38996;39214;8547.316214702685;8718.258947989492;8792.164744349277;9069.410488318239;9181.724548263563;16214.918925405298;16360.18199090017;16404.425845095364;16685.749713754547;16869.91565042167;13460.25968571738;13993.720125597227;14021.579352619437;14156.787648185491;14264.144151350953;13065.869341306465;13373.465061397825;13744.03791734569;13806.723865522834;13973.441062357391;13277.800832987707;13630.386632601754;13820.930895345458;13952.302384880919;14248;8470.83058338842;8545.188207120314;8963.865542016745;8970.37207395502;8985.685501007694;9112.681056163003;9260.814783704423;13004.609861704164;13938.651533711738;14230.501932432315 09:24:10 INFO - 2015-12-16 09:24:10,628 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1258.6790368456043;1654.1150484490795;1715.5025042737607;1717.4590004148693;1740.7127823909063;6063.727132279047;7054.85890282194;7250.854982900339;7254.6009969451725;7255.238199988991;7140.5001649884525;7289.380402665766;7344.155422126457;7354.521956072852;7358.852822943538;2052.2611859730487;2065.184252220372;2078.449210959097;2081.6669332906736;2082.094288984289;2092.7279453671076;2105.26315789474;2115.4922818523596;2149.881756503392;2157.773433789453;2054.0551346380685;2056.259746491262;2077.8233850122756;2081.2923605973965;2082.79172082792;2082.3856962196187;2104.8000439958255;2104.8737075775502;2105;2105.0211651581935;2014.8891810950392;2046.478148072247;2047.4471892588917;2049.6515592349338;2102.7056212130315;7109.751158709472;7190.676419561132;7197.092770415844;7199.712011519533;7203.243659415738;4126.504819421689;4195.328747400401;4218.093109981369;4237.025484138665;4253.106847562016;2661.1484325016004;2686.6641669791275;2698.7840972722333;2725.550284203104;2733.671959364869;837.9874301885477;848.465466755946;853.3471894001032;865.6018231613465;871.808202195516;9777.853332200022;9811.803763924752;9844.556994935245;9866.901330986742;9867.358621689567;3867.5552311483975;3885.825137868803;3926.587708290588;3984.063745019918;3994.520657521116;8414.453060551166;8454.788630284293;8467.95766021166;8473.745787626382;8477.830443391098;4308.612224899774;4323.6757243206885;4326.15639950213;4333.133373325348;4333.566643335705;3270.2314955985325;3353.614334351581;3805.219929914361;3928.2929072767174;3928.7249892507252;3480.460528618068;3495.94756078659;3497.860085596548;3522.454019626962;3555.822208889545;1052.2055847834836;1068.503146037081;1086.4296244471716;1099.384344766933;1108.013867657785;1193.5882120668355;1193.970150746221;1198.5445530698278;1200.9699757506132;1230.7353918907477;6674.16572928384;6703.363180497845;6867.862642747117;6928.376446119873;6933;412.0214490584861;412.29909154437576;412.8637549608622;414.7242084014157;414.85480081971673;5383.623146379716;5426.891462170814;5433.619646624698;5434.673919564839;5442.782288708408;8431.662733490592;8516.935383077116;8720.433171843937;8761.649534018568;8804.559772011375;8622.396432249683;8653.30773538128;8719.912800872036;8721.694740684046;8727.389082764146;6749.3250674932115;6827.146606674166;6843.315668433117;6880.139982502287;6901.757683616896;6373.044043393528;6432.517561182836;6452.12896258999;6455.4190122887285;6461.289258181502;7573.394128469819;7604.125525564631;7670.42471814605;7785.065792104983;7793.37652987771;7843.84312313762;7892.0529536456;8030.317423019109;8095.433319667567;8105.067917189599;5359.356877174608;5634.85912852182;5649.293838270216;6368.363163683594;6412.487001039813;5941.405859414024;6383.712732926937;6392.840178995562;6433.388828061326;6435.324290949383;6135.785247516315;6178.196834411498;6331.620102793847;6503.512236582181;6622.403983641495;6335.841603959938;6366.076918846648;6372.5220608455475;6453.806385808433;6476.6114033158165;6606.8017959461295;6645.60126392418;6647.634380108947;6650.83372915681;6651.26836048044;5845.532357411482;5997.280326360865;6004.039353703386;6030.095485677183;6035.879282414415;6110.7861224856915;6151.323354431099;6163.38366163398;6168;6173.56785025044 09:24:10 INFO - 2015-12-16 09:24:10,629 DEBUG : BROWSER_OUTPUT: |4;prototype.html;296.3864799864282;300.5521772558887;307.9476488996872;308.4155525279595;310.48614542931426;5369.5435887949525;5383.192521121834;5405.324334458198;5408.702521361323;5427.511523962842;5309.920351194735;5322.148456247001;5322.201669749539;5324.1747529133045;5332.946670533293;3939.7439166454233;4167.145735124307;4172.18642364739;4179.289520781467;4181.979090104545;4053.1893621275717;4070.9185816283657;4140.047789008515;4170.291050521419;4183.435236243099;4127.504699436072;4140.358244472111;4141.213169497801;4144.9585504145025;4145.751254924699;3898.142408670088;3998.540167880702;3999.920001599952;4138.586141385852;4138.772367519785;3634.036980200249;3656.122530592665;3659.8536058557625;3661.2494438640283;3661.6338366163436;5141.280220769096;5163;5163.0190263849745;5167.199084141964;5175.715335656538;4720.763961801897;4752.691075080109;4759;4763.428388593356;4774.3077253798;5457.154141108134;5594.720263986825;5603.551715862721;5603.859903502404;5627.8593035174445;3967.1272320089533;3967.3057214987552;3975.1453437510786;3975.1652153047894;3977.9259599907864;5880.117982302646;5887.0286402743495;5893.233879595668;5896.115582662592;5898.970505147447;4079.592040795956;4085.652719518874;4087.6321131098343;4087.8364865405647;4088.2845502037026;3911.726179167431;4088.5707000765087;4152.045029643199;4155.563665815046;4161.04296011919;4664.416947881515;4670.159371313128;4679.064187162581;4681.695689780154;4684;5604.963081829875;5606.747696353674;5613.971930140323;5614.1859430382365;5621.269234999424;1413.9787903181461;1436.6049336432357;1437.6118448019186;1437.7915202295608;1438.1946110178333;939.4175611121149;948.5731420860641;959.8128364968903;986.9981968302179;988.3921388346259;4960.751962401865;4962.627802914796;4965.230389289666;4965.602751779849;4968.627352948543;5836.591438599257;5845.766169353178;5846.327672317653;5847.912281315784;5849.298084229919;4944.802207911715;4954.256861470808;4956.90086198274;4957.677750946177;4960.231164169487;2901.4922388581913;3011.728944395015;3086.4907290297297;3111.7510599152465;3128.2961333699736;5533.08704063833;5589.329280486287;5608.074667679869;5608.635438696553;5613.550915926798;6054.727537260834;6059.818205453844;6062.939370606326;6069.241344831896;6073.4837538808815;5590.301212348457;5598.384177740527;5602.719864006865;5604.131359639263;5604.887902242014;5762.7694892203845;5875.764969401176;5888.087346461305;5894.941050589439;5910.202122713378;5739.483446489836;5745.683987380734;5749.453801888814;5754.741036653444;5755.424457554211;5585;5585.860353491195;5590.077637189818;5590.5527557796095;5591.776328946797;3882.3400021995762;4036.434899114185;4036.656884164879;4037.8990525237105;4039.1719697461363;5820.505257053029;5834.795782147605;5835.299764028344;5835.912461313169;5839;5580.469855363734;5587.804426845041;5591.30108736408;5592.524635406036;5595.244641973281;5562.610617256915;5595.804146855004;5598.244237028112;5600.243967064394;5622.072358060874;5352.839414817562;5463.153211252262;5474.671519708831;5475.753591088331;5479;5623.718814059199;5624.578156638187;5628.85927851807;5632.521235694848;5633.436656334334;5281.366236051698;5466.606015466031;5470.53500452466;5470.9179362308805;5473.562115030868 09:24:10 INFO - 2015-12-16 09:24:10,630 DEBUG : BROWSER_OUTPUT: |5;yui.html;659.2188256915556;682.4028974647186;719.9424046076315;752.713968691897;796.406677025616;11458.197926145163;11781.587644432446;11811.350375729331;11826.822597661041;11834.7633047339;11430.08559315255;11877.7624447511;11888;11895.52417903283;11898.167128301022;650.8828410886039;657.6185812228896;801.707376807464;816.7876352148425;832.4505826154739;825.8637324841394;828.3249151941179;834.3450391442718;834.5910503853129;834.8497270491309;864.1962974433774;874.1695389380083;875.8992715837696;875.9386842920998;876.1370050500252;670.0351493848866;679.8572299817044;841.1840514700791;853.9957300213521;857.5669287010082;638.8722255548909;639.3606393606393;639.3766078073841;641.2081079866362;642.3063091860779;10958.561657533768;11244.943775281154;11251.09991200702;11257;11273.943630281878;11219.834284040566;11267.943660281728;11278.436078196057;11601;11714.355710435922;9234.307426943005;9244.815103697956;9271.3973591717;9306.115918987685;9372.90627093734;3249.707526322619;3267.3628642414737;3287.0467564406295;3302;3315.535824984504;36779.264414711826;39411.40882886759;39502.802485987384;39518;39594.010149746486;9005.189532941935;9015.594298256463;9056.958449778229;9219.354645174773;9405.811883762286;15332.540023799304;15410.768838467431;15414.537563873102;15415.383384664488;15428.15145167004;6020.247469066367;6108.297545782292;6115.755369785159;6336.904946425807;6420.06908998202;3516.7538272321203;3564.8752293669595;3610.151614370621;3634.9636503634624;3652.634736526379;2587.456634106821;2598;2607.29603007187;2610.073423934514;2614.4640348728467;462.8889066623986;466.30753331302986;477.1840153337831;478.8802799300175;479.51808432525087;548.2051026012298;589.2751915144396;603.9396060393925;629.1003864473755;638.0716058135401;7730.188330225358;7775.455718099679;8036.236557527026;8104.230098140667;8143.51138931666;445.4943638969793;460.0614745918356;467.3597171874554;575.3153747041008;616.035903810535;3487.720982321408;3641.708663306929;3710.5547334320054;3763.41667041609;3766.4162054881535;50614.98770024579;53869.461305386445;53961.73019134879;54629.45370546323;54750.45249547533;41592.792036039624;41904;42411;43283.350749738776;43416.78291608522;39092.21815563673;39256.80371598124;39749;39805.40291895566;39817.40273895894;7506.849863002819;7991.440599158235;8224.424290299621;8291.626876790438;8312.21034001769;29667.703322966496;29804;30734.23164420818;30851.537226941164;30915.381692366478;38606.42090368703;38723.612763872;38974.610253897095;39068.804655976535;39337.40993885151;10267.640632577824;10325.864154943101;10501.632442864464;10547.630832921119;10752.193585481276;11264.098872090377;11283.774324513628;11389.202755807013;11529.769404611692;12092.576759813364;10785.730356741144;11118.054965328038;11231.38227397501;11274.661760147208;11417.657470275904;10184.18526517862;10218.795624087328;10557.419341936267;10655.520501577292;10756.623518176826;11025.724356891142;11041.183944988543;11081.612143574936;11453.19827612059;11477.598284060017;9340.439573625332;9621.27840411986;9681.177099946583;9767.56045977947;9949.353292035994;9061.13919177677;9141.3601047926;9224.907750922674;9337.272604568177;9599.136077753035 09:24:10 INFO - 2015-12-16 09:24:10,630 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:24:10 INFO - 2015-12-16 09:24:10,630 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:24:10 INFO - 2015-12-16 09:24:10,630 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1423 09:24:10 INFO - 2015-12-16 09:24:10,630 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:24:10 INFO - 2015-12-16 09:24:10,630 DEBUG : BROWSER_OUTPUT: __startTimestamp1450286650618__endTimestamp 09:24:10 INFO - 2015-12-16 09:24:10,631 DEBUG : BROWSER_OUTPUT: 09:24:10 INFO - 2015-12-16 09:24:10,631 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:24:10 INFO - 2015-12-16 09:24:10,631 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:24:10 INFO - 2015-12-16 09:24:10,631 DEBUG : BROWSER_OUTPUT: 09:24:10 INFO - 2015-12-16 09:24:10,631 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4667.91 Median:4834.35 stddev:481.26 (10.0%) stddev-sans-first:455.35 09:24:10 INFO - 2015-12-16 09:24:10,631 DEBUG : BROWSER_OUTPUT: Values: 2627.7 2717.4 2717.9 2731.4 2734.5 4504.6 4669.3 4751.4 4765.0 4767.1 4638.4 4691.0 4709.1 4717.1 4837.3 4325.2 4342.3 4418.3 4487.5 4510.5 4405.2 4459.7 4477.9 4483.4 4517.8 4194.3 4271.9 4303.7 4352.2 4378.3 4339.5 4372.3 4384.7 4391.8 4432.8 4118.3 4337.9 4350.7 4359.0 4403.8 4598.4 4607.1 4627.8 4711.1 4756.0 5115.2 5153.4 5154.8 5158.7 5192.9 4839.3 5141.0 5168.5 5172.2 5172.5 4668.5 4678.9 4685.9 4724.8 4785.3 5136.5 5153.2 5169.3 5169.3 5211.2 4749.8 4999.4 5045.9 5047.6 5099.5 4985.0 5003.2 5017.6 5093.8 5114.6 4990.7 5029.0 5039.2 5049.5 5079.5 4747.5 4988.5 5007.6 5010.4 5012.5 4150.6 4175.2 4188.6 4235.4 4251.4 3693.9 3700.4 3704.3 3706.0 3721.8 4331.7 4376.8 4377.5 4413.0 4415.4 4865.1 4964.8 4988.7 4991.0 5087.0 4347.8 4350.2 4385.6 4392.4 4408.8 4519.7 4521.3 4524.8 4542.5 4554.2 4681.8 4800.4 4870.7 4871.7 4886.4 4996.5 4998.8 5080.1 5088.3 5123.9 4849.4 4852.2 4855.0 4859.3 4895.6 4818.3 4946.1 5016.3 5024.7 5062.2 4913.8 4946.9 4947.4 4970.4 4973.0 4834.3 4836.2 4850.3 4857.4 4858.9 4934.7 4945.5 4945.6 4946.0 4957.1 4834.6 4850.6 4855.9 4861.8 4896.7 4748.2 4810.5 4814.2 4868.1 5013.6 4842.8 4878.1 4881.0 4883.6 4924.3 09:24:10 INFO - 2015-12-16 09:24:10,631 DEBUG : BROWSER_OUTPUT: 09:24:10 INFO - 2015-12-16 09:24:10,631 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46739.51 Median:35607.73 stddev:87881.18 (246.8%) stddev-sans-first:88059.30 09:24:10 INFO - 2015-12-16 09:24:10,631 DEBUG : BROWSER_OUTPUT: Values: 556.9 558.2 565.1 568.8 580.4 26798.5 32968.8 33750.8 33805.3 33825.0 39875.2 40412.2 40423.6 40434.6 40514.8 7078.7 7196.5 7674.0 7821.7 7825.5 10130.9 10353.9 10365.4 10369.9 10373.4 9843.4 9918.8 9919.4 9923.0 9927.1 7311.6 7502.2 7510.0 7511.3 10014.3 7123.5 10091.9 10393.3 10403.5 10410.2 37698.4 38102.6 38230.2 38304.2 38353.6 2810.2 2855.1 3068.2 3428.2 3636.9 28314.2 28498.7 28846.1 28866.0 29301.6 3307.8 3312.9 3323.7 3361.6 3426.9 213187.0 213352.0 215187.0 215204.0 215897.0 52408.2 53443.7 56147.7 56493.7 57734.0 49771.0 49813.0 50155.7 50159.7 50179.0 13944.7 13982.1 14124.6 14147.8 14152.2 10556.3 10601.2 10613.4 10615.6 10726.2 19040.4 19489.2 19528.5 19536.1 19553.6 7252.9 7391.9 7480.5 7525.3 7533.8 861.8 869.9 887.7 932.2 1008.9 27650.7 27785.6 27878.3 28023.2 28147.2 957.6 980.3 988.4 992.5 1074.0 14808.9 14826.7 14932.7 14965.4 14982.6 315812.0 321868.0 321890.0 322184.0 322250.0 48552.0 49181.3 49182.5 49188.1 49190.5 1043.6 1131.1 1198.5 1250.6 1310.8 26287.3 27530.6 27694.4 27813.0 27884.9 38253.6 38575.8 38604.0 38625.6 44551.8 193182.0 195490.0 513038.0 529183.0 530265.0 38459.6 38936.6 38961.2 38973.0 39707.8 42048.0 42215.8 42620.8 42744.4 43050.6 34846.3 35173.0 35573.6 35641.8 36002.8 35848.0 35958.6 35980.2 36035.6 36510.8 36061.3 36407.5 36533.6 36997.4 37267.3 28847.4 30242.8 30792.7 30816.7 31046.9 23557.4 23934.8 24186.2 24332.6 24424.9 09:24:10 INFO - 2015-12-16 09:24:10,631 DEBUG : BROWSER_OUTPUT: 09:24:10 INFO - 2015-12-16 09:24:10,631 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25836.37 Median:404.90 stddev:77933.19 (19247.5%) stddev-sans-first:78128.29 09:24:10 INFO - 2015-12-16 09:24:10,633 DEBUG : BROWSER_OUTPUT: Values: 333.9 340.9 342.5 343.1 349.1 12098.4 12524.1 14963.4 15125.2 16884.8 11880.4 12138.2 13313.6 14682.3 14706.6 4918.2 5134.3 5147.7 5148.6 5153.8 3720.5 5033.5 5049.9 5061.9 5123.5 3806.6 5676.9 5802.4 5815.7 5824.4 5692.9 5770.5 5780.6 5780.7 5886.4 5162.9 5163.4 5165.4 5168.8 5171.1 18200.6 18229.9 18433.2 18578.8 19150.8 1870.3 1886.5 1926.5 1935.3 1957.4 8111.4 8301.2 8462.4 12388.9 12986.4 1735.3 1750.4 1761.7 1762.0 1772.8 53870.7 57417.7 57747.7 58110.4 58579.4 9688.4 9751.1 9775.9 9788.5 9846.8 12546.5 12553.9 12567.1 12569.2 12571.9 7168.9 7251.6 7266.1 7304.6 7305.5 6995.0 7036.8 7074.6 7081.3 7106.4 4076.3 4162.0 4169.5 4187.1 4213.7 1525.0 1588.1 1696.9 1716.4 1772.9 407.6 716.4 836.1 906.3 931.5 8693.5 9621.0 9880.2 9976.5 10332.6 394.1 402.4 404.8 405.0 406.9 8941.6 9039.8 9216.4 9273.2 9867.6 465787.0 471333.0 472652.0 485522.0 489297.0 61589.7 72859.0 73124.6 74286.0 75329.0 1050.6 1055.7 1057.3 1072.1 1074.2 13754.4 14258.8 14810.9 14893.7 15075.5 33157.0 33371.5 34047.7 34452.7 34557.0 37621.8 38393.8 38609.2 38996.0 39214.0 8547.3 8718.3 8792.2 9069.4 9181.7 16214.9 16360.2 16404.4 16685.7 16869.9 13460.3 13993.7 14021.6 14156.8 14264.1 13065.9 13373.5 13744.0 13806.7 13973.4 13277.8 13630.4 13820.9 13952.3 14248.0 8470.8 8545.2 8963.9 8970.4 8985.7 9112.7 9260.8 13004.6 13938.7 14230.5 09:24:10 INFO - 2015-12-16 09:24:10,633 DEBUG : BROWSER_OUTPUT: 09:24:10 INFO - 2015-12-16 09:24:10,633 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4998.27 Median:6123.29 stddev:2625.18 (42.9%) stddev-sans-first:2617.50 09:24:10 INFO - 2015-12-16 09:24:10,633 DEBUG : BROWSER_OUTPUT: Values: 1258.7 1654.1 1715.5 1717.5 1740.7 6063.7 7054.9 7250.9 7254.6 7255.2 7140.5 7289.4 7344.2 7354.5 7358.9 2052.3 2065.2 2078.4 2081.7 2082.1 2092.7 2105.3 2115.5 2149.9 2157.8 2054.1 2056.3 2077.8 2081.3 2082.8 2082.4 2104.8 2104.9 2105.0 2105.0 2014.9 2046.5 2047.4 2049.7 2102.7 7109.8 7190.7 7197.1 7199.7 7203.2 4126.5 4195.3 4218.1 4237.0 4253.1 2661.1 2686.7 2698.8 2725.6 2733.7 838.0 848.5 853.3 865.6 871.8 9777.9 9811.8 9844.6 9866.9 9867.4 3867.6 3885.8 3926.6 3984.1 3994.5 8414.5 8454.8 8468.0 8473.7 8477.8 4308.6 4323.7 4326.2 4333.1 4333.6 3270.2 3353.6 3805.2 3928.3 3928.7 3480.5 3495.9 3497.9 3522.5 3555.8 1052.2 1068.5 1086.4 1099.4 1108.0 1193.6 1194.0 1198.5 1201.0 1230.7 6674.2 6703.4 6867.9 6928.4 6933.0 412.0 412.3 412.9 414.7 414.9 5383.6 5426.9 5433.6 5434.7 5442.8 8431.7 8516.9 8720.4 8761.6 8804.6 8622.4 8653.3 8719.9 8721.7 8727.4 6749.3 6827.1 6843.3 6880.1 6901.8 6373.0 6432.5 6452.1 6455.4 6461.3 7573.4 7604.1 7670.4 7785.1 7793.4 7843.8 7892.1 8030.3 8095.4 8105.1 5359.4 5634.9 5649.3 6368.4 6412.5 5941.4 6383.7 6392.8 6433.4 6435.3 6135.8 6178.2 6331.6 6503.5 6622.4 6335.8 6366.1 6372.5 6453.8 6476.6 6606.8 6645.6 6647.6 6650.8 6651.3 5845.5 5997.3 6004.0 6030.1 6035.9 6110.8 6151.3 6163.4 6168.0 6173.6 09:24:10 INFO - 2015-12-16 09:24:10,633 DEBUG : BROWSER_OUTPUT: 09:24:10 INFO - 2015-12-16 09:24:10,633 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4670.43 Median:5342.89 stddev:1378.97 (25.8%) stddev-sans-first:1343.19 09:24:10 INFO - 2015-12-16 09:24:10,633 DEBUG : BROWSER_OUTPUT: Values: 296.4 300.6 307.9 308.4 310.5 5369.5 5383.2 5405.3 5408.7 5427.5 5309.9 5322.1 5322.2 5324.2 5332.9 3939.7 4167.1 4172.2 4179.3 4182.0 4053.2 4070.9 4140.0 4170.3 4183.4 4127.5 4140.4 4141.2 4145.0 4145.8 3898.1 3998.5 3999.9 4138.6 4138.8 3634.0 3656.1 3659.9 3661.2 3661.6 5141.3 5163.0 5163.0 5167.2 5175.7 4720.8 4752.7 4759.0 4763.4 4774.3 5457.2 5594.7 5603.6 5603.9 5627.9 3967.1 3967.3 3975.1 3975.2 3977.9 5880.1 5887.0 5893.2 5896.1 5899.0 4079.6 4085.7 4087.6 4087.8 4088.3 3911.7 4088.6 4152.0 4155.6 4161.0 4664.4 4670.2 4679.1 4681.7 4684.0 5605.0 5606.7 5614.0 5614.2 5621.3 1414.0 1436.6 1437.6 1437.8 1438.2 939.4 948.6 959.8 987.0 988.4 4960.8 4962.6 4965.2 4965.6 4968.6 5836.6 5845.8 5846.3 5847.9 5849.3 4944.8 4954.3 4956.9 4957.7 4960.2 2901.5 3011.7 3086.5 3111.8 3128.3 5533.1 5589.3 5608.1 5608.6 5613.6 6054.7 6059.8 6062.9 6069.2 6073.5 5590.3 5598.4 5602.7 5604.1 5604.9 5762.8 5875.8 5888.1 5894.9 5910.2 5739.5 5745.7 5749.5 5754.7 5755.4 5585.0 5585.9 5590.1 5590.6 5591.8 3882.3 4036.4 4036.7 4037.9 4039.2 5820.5 5834.8 5835.3 5835.9 5839.0 5580.5 5587.8 5591.3 5592.5 5595.2 5562.6 5595.8 5598.2 5600.2 5622.1 5352.8 5463.2 5474.7 5475.8 5479.0 5623.7 5624.6 5628.9 5632.5 5633.4 5281.4 5466.6 5470.5 5470.9 5473.6 09:24:10 INFO - 2015-12-16 09:24:10,633 DEBUG : BROWSER_OUTPUT: 09:24:10 INFO - 2015-12-16 09:24:10,633 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12201.92 Median:41748.40 stddev:13763.31 (33.0%) stddev-sans-first:13774.62 09:24:10 INFO - 2015-12-16 09:24:10,634 DEBUG : BROWSER_OUTPUT: Values: 659.2 682.4 719.9 752.7 796.4 11458.2 11781.6 11811.4 11826.8 11834.8 11430.1 11877.8 11888.0 11895.5 11898.2 650.9 657.6 801.7 816.8 832.5 825.9 828.3 834.3 834.6 834.8 864.2 874.2 875.9 875.9 876.1 670.0 679.9 841.2 854.0 857.6 638.9 639.4 639.4 641.2 642.3 10958.6 11244.9 11251.1 11257.0 11273.9 11219.8 11267.9 11278.4 11601.0 11714.4 9234.3 9244.8 9271.4 9306.1 9372.9 3249.7 3267.4 3287.0 3302.0 3315.5 36779.3 39411.4 39502.8 39518.0 39594.0 9005.2 9015.6 9057.0 9219.4 9405.8 15332.5 15410.8 15414.5 15415.4 15428.2 6020.2 6108.3 6115.8 6336.9 6420.1 3516.8 3564.9 3610.2 3635.0 3652.6 2587.5 2598.0 2607.3 2610.1 2614.5 462.9 466.3 477.2 478.9 479.5 548.2 589.3 603.9 629.1 638.1 7730.2 7775.5 8036.2 8104.2 8143.5 445.5 460.1 467.4 575.3 616.0 3487.7 3641.7 3710.6 3763.4 3766.4 50615.0 53869.5 53961.7 54629.5 54750.5 41592.8 41904.0 42411.0 43283.4 43416.8 39092.2 39256.8 39749.0 39805.4 39817.4 7506.8 7991.4 8224.4 8291.6 8312.2 29667.7 29804.0 30734.2 30851.5 30915.4 38606.4 38723.6 38974.6 39068.8 39337.4 10267.6 10325.9 10501.6 10547.6 10752.2 11264.1 11283.8 11389.2 11529.8 12092.6 10785.7 11118.1 11231.4 11274.7 11417.7 10184.2 10218.8 10557.4 10655.5 10756.6 11025.7 11041.2 11081.6 11453.2 11477.6 9340.4 9621.3 9681.2 9767.6 9949.4 9061.1 9141.4 9224.9 9337.3 9599.1 09:24:10 INFO - 2015-12-16 09:24:10,635 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:24:10 INFO - 2015-12-16 09:24:10,635 DEBUG : BROWSER_OUTPUT: 09:24:11 INFO - 2015-12-16 09:24:11,361 INFO : Browser exited with error code: 0 09:24:11 INFO - 2015-12-16 09:24:11,380 INFO : Completed test dromaeo_css (00:18:38) 09:24:11 INFO - 2015-12-16 09:24:11,380 INFO : Starting test kraken 09:24:11 INFO - 2015-12-16 09:24:11,380 DEBUG : operating with platform_type : linux_ 09:24:11 INFO - 2015-12-16 09:24:11,380 INFO : Initialising browser for kraken test... 09:24:11 INFO - 2015-12-16 09:24:11,386 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUw7BdR/profile http://localhost:40281/getInfo.html 09:24:16 INFO - 2015-12-16 09:24:16,058 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:24:16 INFO - 2015-12-16 09:24:16,058 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:24:16 INFO - 2015-12-16 09:24:16,058 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:24:16 INFO - 2015-12-16 09:24:16,058 DEBUG : BROWSER_OUTPUT: __metrics 09:24:16 INFO - 2015-12-16 09:24:16,179 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 09:24:16 INFO - 2015-12-16 09:24:16,389 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:24:17 INFO - 2015-12-16 09:24:17,407 INFO : Browser initialized. 09:24:17 INFO - 2015-12-16 09:24:17,407 INFO : Running cycle 1/1 for kraken test... 09:24:17 INFO - 2015-12-16 09:24:17,407 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUw7BdR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:24:29 INFO - 2015-12-16 09:24:29,455 DEBUG : BROWSER_OUTPUT: RSS: Main: 142569472 09:24:29 INFO - 2015-12-16 09:24:29,455 DEBUG : BROWSER_OUTPUT: 09:24:32 INFO - 2015-12-16 09:24:32,116 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40281/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40281/tests/kraken/driver.html?testName=audio-beat-detection) 09:24:32 INFO - 2015-12-16 09:24:32,698 DEBUG : BROWSER_OUTPUT: RSS: Main: 179523584 09:24:32 INFO - 2015-12-16 09:24:32,698 DEBUG : BROWSER_OUTPUT: 09:24:35 INFO - 2015-12-16 09:24:35,456 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40281/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40281/tests/kraken/driver.html?testName=audio-dft) 09:24:36 INFO - 2015-12-16 09:24:36,038 DEBUG : BROWSER_OUTPUT: RSS: Main: 168300544 09:24:36 INFO - 2015-12-16 09:24:36,038 DEBUG : BROWSER_OUTPUT: 09:24:39 INFO - 2015-12-16 09:24:39,030 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40281/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40281/tests/kraken/driver.html?testName=audio-fft) 09:24:39 INFO - 2015-12-16 09:24:39,598 DEBUG : BROWSER_OUTPUT: RSS: Main: 156368896 09:24:39 INFO - 2015-12-16 09:24:39,599 DEBUG : BROWSER_OUTPUT: 09:24:41 INFO - 2015-12-16 09:24:41,635 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40281/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40281/tests/kraken/driver.html?testName=audio-oscillator) 09:24:42 INFO - 2015-12-16 09:24:42,201 DEBUG : BROWSER_OUTPUT: RSS: Main: 155193344 09:24:42 INFO - 2015-12-16 09:24:42,201 DEBUG : BROWSER_OUTPUT: 09:24:44 INFO - 2015-12-16 09:24:44,434 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40281/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40281/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:24:45 INFO - 2015-12-16 09:24:45,003 DEBUG : BROWSER_OUTPUT: RSS: Main: 158617600 09:24:45 INFO - 2015-12-16 09:24:45,003 DEBUG : BROWSER_OUTPUT: 09:24:47 INFO - 2015-12-16 09:24:47,967 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40281/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40281/tests/kraken/driver.html?testName=imaging-darkroom) 09:24:48 INFO - 2015-12-16 09:24:48,548 DEBUG : BROWSER_OUTPUT: RSS: Main: 157081600 09:24:48 INFO - 2015-12-16 09:24:48,548 DEBUG : BROWSER_OUTPUT: 09:24:52 INFO - 2015-12-16 09:24:52,024 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40281/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40281/tests/kraken/driver.html?testName=imaging-desaturate) 09:24:52 INFO - 2015-12-16 09:24:52,607 DEBUG : BROWSER_OUTPUT: RSS: Main: 159440896 09:24:52 INFO - 2015-12-16 09:24:52,607 DEBUG : BROWSER_OUTPUT: 09:24:55 INFO - 2015-12-16 09:24:55,404 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40281/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40281/tests/kraken/driver.html?testName=json-parse-financial) 09:24:55 INFO - 2015-12-16 09:24:55,985 DEBUG : BROWSER_OUTPUT: RSS: Main: 157609984 09:24:55 INFO - 2015-12-16 09:24:55,986 DEBUG : BROWSER_OUTPUT: 09:24:57 INFO - 2015-12-16 09:24:57,776 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40281/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40281/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:24:58 INFO - 2015-12-16 09:24:58,341 DEBUG : BROWSER_OUTPUT: RSS: Main: 170262528 09:24:58 INFO - 2015-12-16 09:24:58,341 DEBUG : BROWSER_OUTPUT: 09:25:00 INFO - 2015-12-16 09:25:00,232 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40281/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40281/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:25:00 INFO - 2015-12-16 09:25:00,826 DEBUG : BROWSER_OUTPUT: RSS: Main: 170205184 09:25:00 INFO - 2015-12-16 09:25:00,826 DEBUG : BROWSER_OUTPUT: 09:25:03 INFO - 2015-12-16 09:25:03,019 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40281/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40281/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:25:03 INFO - 2015-12-16 09:25:03,602 DEBUG : BROWSER_OUTPUT: RSS: Main: 177987584 09:25:03 INFO - 2015-12-16 09:25:03,602 DEBUG : BROWSER_OUTPUT: 09:25:06 INFO - 2015-12-16 09:25:06,142 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40281/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:25:06 INFO - 2015-12-16 09:25:06,727 DEBUG : BROWSER_OUTPUT: RSS: Main: 183767040 09:25:06 INFO - 2015-12-16 09:25:06,727 DEBUG : BROWSER_OUTPUT: 09:25:09 INFO - 2015-12-16 09:25:09,327 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:25:09 INFO - 2015-12-16 09:25:09,909 DEBUG : BROWSER_OUTPUT: RSS: Main: 179585024 09:25:09 INFO - 2015-12-16 09:25:09,909 DEBUG : BROWSER_OUTPUT: 09:25:11 INFO - 2015-12-16 09:25:11,650 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40281/tests/kraken/driver.html?testName=ai-astar) 09:25:11 INFO - 2015-12-16 09:25:11,900 DEBUG : BROWSER_OUTPUT: RSS: Main: 238268416 09:25:11 INFO - 2015-12-16 09:25:11,900 DEBUG : BROWSER_OUTPUT: 09:25:11 INFO - 2015-12-16 09:25:11,902 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:25:11 INFO - 2015-12-16 09:25:11,902 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:25:11 INFO - 2015-12-16 09:25:11,902 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:25:11 INFO - 2015-12-16 09:25:11,902 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:25:11 INFO - 2015-12-16 09:25:11,902 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;114;109;115;116;113;103;115;114;123 09:25:11 INFO - 2015-12-16 09:25:11,903 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;160;128;152;170;140;155;155;131;182;131 09:25:11 INFO - 2015-12-16 09:25:11,903 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;160;163;162;164;162;161;162;161 09:25:11 INFO - 2015-12-16 09:25:11,904 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;78;96;71;73;72;103;89;72 09:25:11 INFO - 2015-12-16 09:25:11,904 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;138;95;95;96;130;94;95;132 09:25:11 INFO - 2015-12-16 09:25:11,905 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;110;110;110;110;110;109;110;110 09:25:11 INFO - 2015-12-16 09:25:11,905 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;148;147;147;148;146;147;146;146;145 09:25:11 INFO - 2015-12-16 09:25:11,905 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;95;96;95;95;95;95;95 09:25:11 INFO - 2015-12-16 09:25:11,905 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;75;75;75;74;74;74;74;87;71;73 09:25:11 INFO - 2015-12-16 09:25:11,905 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;69;68;68;68;70;69;69;69 09:25:11 INFO - 2015-12-16 09:25:11,905 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;87;86;86;91;86;86;86;88;87;87 09:25:11 INFO - 2015-12-16 09:25:11,905 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;120;132;120;120;133;124;133;130;123 09:25:11 INFO - 2015-12-16 09:25:11,905 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;147;147;144;151;153;138;152;150;148;135 09:25:11 INFO - 2015-12-16 09:25:11,906 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;70;69;69;70;69;68;70;71;70 09:25:11 INFO - 2015-12-16 09:25:11,906 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:25:11 INFO - 2015-12-16 09:25:11,906 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:25:11 INFO - 2015-12-16 09:25:11,906 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,983 09:25:11 INFO - 2015-12-16 09:25:11,906 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:25:11 INFO - 2015-12-16 09:25:11,906 DEBUG : BROWSER_OUTPUT: __startTimestamp1450286711901__endTimestamp 09:25:11 INFO - 2015-12-16 09:25:11,906 DEBUG : BROWSER_OUTPUT: 09:25:11 INFO - 2015-12-16 09:25:11,914 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:25:11 INFO - 2015-12-16 09:25:11,914 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:25:11 INFO - 2015-12-16 09:25:11,914 DEBUG : BROWSER_OUTPUT: 09:25:11 INFO - 2015-12-16 09:25:11,914 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.50 Median:114.50 stddev:5.08 (4.4%) stddev-sans-first:5.39 09:25:11 INFO - 2015-12-16 09:25:11,914 DEBUG : BROWSER_OUTPUT: Values: 113.0 114.0 109.0 115.0 116.0 113.0 103.0 115.0 114.0 123.0 09:25:11 INFO - 2015-12-16 09:25:11,914 DEBUG : BROWSER_OUTPUT: 09:25:11 INFO - 2015-12-16 09:25:11,914 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.40 Median:155.00 stddev:17.90 (11.5%) stddev-sans-first:18.64 09:25:11 INFO - 2015-12-16 09:25:11,914 DEBUG : BROWSER_OUTPUT: Values: 160.0 128.0 152.0 170.0 140.0 155.0 155.0 131.0 182.0 131.0 09:25:11 INFO - 2015-12-16 09:25:11,914 DEBUG : BROWSER_OUTPUT: 09:25:11 INFO - 2015-12-16 09:25:11,915 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.14 (0.7%) stddev-sans-first:1.17 09:25:11 INFO - 2015-12-16 09:25:11,915 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 160.0 163.0 162.0 164.0 162.0 161.0 162.0 161.0 09:25:11 INFO - 2015-12-16 09:25:11,915 DEBUG : BROWSER_OUTPUT: 09:25:11 INFO - 2015-12-16 09:25:11,915 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.00 Median:73.00 stddev:11.67 (16.0%) stddev-sans-first:12.10 09:25:11 INFO - 2015-12-16 09:25:11,915 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 78.0 96.0 71.0 73.0 72.0 103.0 89.0 72.0 09:25:11 INFO - 2015-12-16 09:25:11,915 DEBUG : BROWSER_OUTPUT: 09:25:11 INFO - 2015-12-16 09:25:11,915 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.50 Median:95.00 stddev:18.63 (19.6%) stddev-sans-first:19.29 09:25:11 INFO - 2015-12-16 09:25:11,915 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 138.0 95.0 95.0 96.0 130.0 94.0 95.0 132.0 09:25:11 INFO - 2015-12-16 09:25:11,916 DEBUG : BROWSER_OUTPUT: 09:25:11 INFO - 2015-12-16 09:25:11,916 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:25:11 INFO - 2015-12-16 09:25:11,916 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 110.0 110.0 110.0 110.0 110.0 109.0 110.0 110.0 09:25:11 INFO - 2015-12-16 09:25:11,916 DEBUG : BROWSER_OUTPUT: 09:25:11 INFO - 2015-12-16 09:25:11,916 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 09:25:11 INFO - 2015-12-16 09:25:11,916 DEBUG : BROWSER_OUTPUT: Values: 147.0 148.0 147.0 147.0 148.0 146.0 147.0 146.0 146.0 145.0 09:25:11 INFO - 2015-12-16 09:25:11,916 DEBUG : BROWSER_OUTPUT: 09:25:11 INFO - 2015-12-16 09:25:11,916 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:25:11 INFO - 2015-12-16 09:25:11,916 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 09:25:11 INFO - 2015-12-16 09:25:11,916 DEBUG : BROWSER_OUTPUT: 09:25:11 INFO - 2015-12-16 09:25:11,916 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:75.20 Median:74.50 stddev:4.32 (5.8%) stddev-sans-first:4.58 09:25:11 INFO - 2015-12-16 09:25:11,917 DEBUG : BROWSER_OUTPUT: Values: 75.0 75.0 75.0 74.0 74.0 74.0 74.0 87.0 71.0 73.0 09:25:11 INFO - 2015-12-16 09:25:11,917 DEBUG : BROWSER_OUTPUT: 09:25:11 INFO - 2015-12-16 09:25:11,917 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 09:25:11 INFO - 2015-12-16 09:25:11,917 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 69.0 68.0 68.0 68.0 70.0 69.0 69.0 69.0 09:25:11 INFO - 2015-12-16 09:25:11,917 DEBUG : BROWSER_OUTPUT: 09:25:11 INFO - 2015-12-16 09:25:11,917 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:87.00 stddev:1.56 (1.8%) stddev-sans-first:1.66 09:25:11 INFO - 2015-12-16 09:25:11,917 DEBUG : BROWSER_OUTPUT: Values: 87.0 86.0 86.0 91.0 86.0 86.0 86.0 88.0 87.0 87.0 09:25:11 INFO - 2015-12-16 09:25:11,917 DEBUG : BROWSER_OUTPUT: 09:25:11 INFO - 2015-12-16 09:25:11,917 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.60 Median:127.00 stddev:5.72 (4.5%) stddev-sans-first:5.82 09:25:11 INFO - 2015-12-16 09:25:11,917 DEBUG : BROWSER_OUTPUT: Values: 121.0 120.0 132.0 120.0 120.0 133.0 124.0 133.0 130.0 123.0 09:25:11 INFO - 2015-12-16 09:25:11,917 DEBUG : BROWSER_OUTPUT: 09:25:11 INFO - 2015-12-16 09:25:11,917 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.50 Median:149.00 stddev:5.95 (4.0%) stddev-sans-first:6.31 09:25:11 INFO - 2015-12-16 09:25:11,917 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 144.0 151.0 153.0 138.0 152.0 150.0 148.0 135.0 09:25:11 INFO - 2015-12-16 09:25:11,917 DEBUG : BROWSER_OUTPUT: 09:25:11 INFO - 2015-12-16 09:25:11,917 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:70.00 stddev:0.84 (1.2%) stddev-sans-first:0.88 09:25:11 INFO - 2015-12-16 09:25:11,918 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 69.0 69.0 70.0 69.0 68.0 70.0 71.0 70.0 09:25:11 INFO - 2015-12-16 09:25:11,918 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:25:11 INFO - 2015-12-16 09:25:11,918 DEBUG : BROWSER_OUTPUT: 09:25:12 INFO - 2015-12-16 09:25:12,873 INFO : Browser exited with error code: 0 09:25:12 INFO - 2015-12-16 09:25:12,925 INFO : Completed test kraken (00:01:01) 09:25:12 INFO - 2015-12-16 09:25:12,925 INFO : Starting test v8_7 09:25:12 INFO - 2015-12-16 09:25:12,925 DEBUG : operating with platform_type : linux_ 09:25:12 INFO - 2015-12-16 09:25:12,925 INFO : Initialising browser for v8_7 test... 09:25:12 INFO - 2015-12-16 09:25:12,931 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmJ9PCF/profile http://localhost:40281/getInfo.html 09:25:17 INFO - 2015-12-16 09:25:17,896 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:25:17 INFO - 2015-12-16 09:25:17,896 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:25:17 INFO - 2015-12-16 09:25:17,896 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:25:17 INFO - 2015-12-16 09:25:17,896 DEBUG : BROWSER_OUTPUT: __metrics 09:25:18 INFO - 2015-12-16 09:25:18,081 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 09:25:18 INFO - 2015-12-16 09:25:18,157 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:25:19 INFO - 2015-12-16 09:25:19,150 INFO : Browser initialized. 09:25:19 INFO - 2015-12-16 09:25:19,151 INFO : Running cycle 1/1 for v8_7 test... 09:25:19 INFO - 2015-12-16 09:25:19,151 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmJ9PCF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:25:31 INFO - 2015-12-16 09:25:31,122 DEBUG : BROWSER_OUTPUT: RSS: Main: 141742080 09:25:31 INFO - 2015-12-16 09:25:31,122 DEBUG : BROWSER_OUTPUT: 09:25:52 INFO - 2015-12-16 09:25:52,485 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40281/tests/v8_7/run.html (next: http://localhost:40281/tests/v8_7/run.html) 09:25:52 INFO - 2015-12-16 09:25:52,743 DEBUG : BROWSER_OUTPUT: RSS: Main: 444780544 09:25:52 INFO - 2015-12-16 09:25:52,743 DEBUG : BROWSER_OUTPUT: 09:25:52 INFO - 2015-12-16 09:25:52,743 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:25:52 INFO - 2015-12-16 09:25:52,743 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:25:52 INFO - 2015-12-16 09:25:52,743 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:25:52 INFO - 2015-12-16 09:25:52,744 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:25:52 INFO - 2015-12-16 09:25:52,744 DEBUG : BROWSER_OUTPUT: |0;Richards;165.80998176090202 09:25:52 INFO - 2015-12-16 09:25:52,744 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.6368047779022 09:25:52 INFO - 2015-12-16 09:25:52,744 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.9400278940028 09:25:52 INFO - 2015-12-16 09:25:52,744 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5154.639175257732 09:25:52 INFO - 2015-12-16 09:25:52,744 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1996.007984031936 09:25:52 INFO - 2015-12-16 09:25:52,744 DEBUG : BROWSER_OUTPUT: |5;Earley;788.0220646178093 09:25:52 INFO - 2015-12-16 09:25:52,744 DEBUG : BROWSER_OUTPUT: |6;Boyer;11988.095238095239 09:25:52 INFO - 2015-12-16 09:25:52,745 DEBUG : BROWSER_OUTPUT: |7;RegExp;27459.45945945946 09:25:52 INFO - 2015-12-16 09:25:52,745 DEBUG : BROWSER_OUTPUT: |8;Splay;607.1645415907711 09:25:52 INFO - 2015-12-16 09:25:52,745 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 09:25:52 INFO - 2015-12-16 09:25:52,745 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:25:52 INFO - 2015-12-16 09:25:52,745 DEBUG : BROWSER_OUTPUT: __startTimestamp1450286752736__endTimestamp 09:25:52 INFO - 2015-12-16 09:25:52,745 DEBUG : BROWSER_OUTPUT: 09:25:52 INFO - 2015-12-16 09:25:52,745 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:25:52 INFO - 2015-12-16 09:25:52,746 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:25:52 INFO - 2015-12-16 09:25:52,746 DEBUG : BROWSER_OUTPUT: 09:25:52 INFO - 2015-12-16 09:25:52,746 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.81 Median:165.81 stddev:0.00 (0.0%) 09:25:52 INFO - 2015-12-16 09:25:52,746 DEBUG : BROWSER_OUTPUT: Values: 165.8 09:25:52 INFO - 2015-12-16 09:25:52,746 DEBUG : BROWSER_OUTPUT: 09:25:52 INFO - 2015-12-16 09:25:52,746 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.64 Median:186.64 stddev:0.00 (0.0%) 09:25:52 INFO - 2015-12-16 09:25:52,746 DEBUG : BROWSER_OUTPUT: Values: 186.6 09:25:52 INFO - 2015-12-16 09:25:52,746 DEBUG : BROWSER_OUTPUT: 09:25:52 INFO - 2015-12-16 09:25:52,747 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.94 Median:278.94 stddev:0.00 (0.0%) 09:25:52 INFO - 2015-12-16 09:25:52,747 DEBUG : BROWSER_OUTPUT: Values: 278.9 09:25:52 INFO - 2015-12-16 09:25:52,747 DEBUG : BROWSER_OUTPUT: 09:25:52 INFO - 2015-12-16 09:25:52,747 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5154.64 Median:5154.64 stddev:0.00 (0.0%) 09:25:52 INFO - 2015-12-16 09:25:52,747 DEBUG : BROWSER_OUTPUT: Values: 5154.6 09:25:52 INFO - 2015-12-16 09:25:52,747 DEBUG : BROWSER_OUTPUT: 09:25:52 INFO - 2015-12-16 09:25:52,747 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1996.01 Median:1996.01 stddev:0.00 (0.0%) 09:25:52 INFO - 2015-12-16 09:25:52,747 DEBUG : BROWSER_OUTPUT: Values: 1996.0 09:25:52 INFO - 2015-12-16 09:25:52,747 DEBUG : BROWSER_OUTPUT: 09:25:52 INFO - 2015-12-16 09:25:52,747 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:788.02 Median:788.02 stddev:0.00 (0.0%) 09:25:52 INFO - 2015-12-16 09:25:52,747 DEBUG : BROWSER_OUTPUT: Values: 788.0 09:25:52 INFO - 2015-12-16 09:25:52,747 DEBUG : BROWSER_OUTPUT: 09:25:52 INFO - 2015-12-16 09:25:52,747 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11988.10 Median:11988.10 stddev:0.00 (0.0%) 09:25:52 INFO - 2015-12-16 09:25:52,747 DEBUG : BROWSER_OUTPUT: Values: 11988.1 09:25:52 INFO - 2015-12-16 09:25:52,747 DEBUG : BROWSER_OUTPUT: 09:25:52 INFO - 2015-12-16 09:25:52,747 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27459.46 Median:27459.46 stddev:0.00 (0.0%) 09:25:52 INFO - 2015-12-16 09:25:52,748 DEBUG : BROWSER_OUTPUT: Values: 27459.5 09:25:52 INFO - 2015-12-16 09:25:52,748 DEBUG : BROWSER_OUTPUT: 09:25:52 INFO - 2015-12-16 09:25:52,748 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:607.16 Median:607.16 stddev:0.00 (0.0%) 09:25:52 INFO - 2015-12-16 09:25:52,748 DEBUG : BROWSER_OUTPUT: Values: 607.2 09:25:52 INFO - 2015-12-16 09:25:52,748 DEBUG : BROWSER_OUTPUT: 09:25:52 INFO - 2015-12-16 09:25:52,748 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 09:25:52 INFO - 2015-12-16 09:25:52,748 DEBUG : BROWSER_OUTPUT: Values: 4845.4 09:25:52 INFO - 2015-12-16 09:25:52,748 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:25:52 INFO - 2015-12-16 09:25:52,748 DEBUG : BROWSER_OUTPUT: 09:25:53 INFO - 2015-12-16 09:25:53,665 INFO : Browser exited with error code: 0 09:25:53 INFO - 2015-12-16 09:25:53,677 INFO : Completed test v8_7 (00:00:40) 09:25:53 INFO - 2015-12-16 09:25:53,805 INFO : Completed test suite (00:20:20) 09:25:53 INFO - 2015-12-16 09:25:53,806 DEBUG : Working with test: dromaeo_css 09:25:53 INFO - 2015-12-16 09:25:53,806 DEBUG : Generating results file: dromaeo_css 09:25:53 INFO - 2015-12-16 09:25:53,807 DEBUG : Working with test: kraken 09:25:53 INFO - 2015-12-16 09:25:53,807 DEBUG : Generating results file: kraken 09:25:53 INFO - 2015-12-16 09:25:53,807 INFO : javascript benchmark 09:25:53 INFO - 2015-12-16 09:25:53,807 DEBUG : Working with test: v8_7 09:25:53 INFO - 2015-12-16 09:25:53,808 DEBUG : Generating results file: v8_7 09:25:53 INFO - 2015-12-16 09:25:53,808 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:25:53 INFO - 2015-12-16 09:25:53,862 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 09:25:53 INFO - 2015-12-16 09:25:53,862 DEBUG : process_Request line: dromaeo_css 6329.50 graph.html#tests=[[72,132,35]] 09:25:53 INFO - 2015-12-16 09:25:53,862 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:25:53 INFO - 2015-12-16 09:25:53,894 DEBUG : process_Request line: kraken 1536.40 graph.html#tests=[[232,132,35]] 09:25:53 INFO - 2015-12-16 09:25:53,894 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:25:53 INFO - 2015-12-16 09:25:53,927 DEBUG : process_Request line: v8_7 19784.81 graph.html#tests=[[230,132,35]] 09:25:53 INFO - 2015-12-16 09:25:53,928 INFO : javascript benchmark 09:25:53 INFO - 2015-12-16 09:25:53,932 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2627.6978147513037, 2717.429339838634, 2717.9456410871785, 2731.412746259554, 2734.4531093781243, 4504.594586487216, 4669.322948172513, 4751.358566593509, 4764.976175119128, 4767.070421267854, 4638.350630911675, 4690.953090469095, 4709.128811169936, 4717.127331443686, 4837.298591704201, 4325.178216138924, 4342.305231163023, 4418.270985287424, 4487.483939346968, 4510.526394728556, 4405.229084910144, 4459.732416055047, 4477.888052798674, 4483.4171557697455, 4517.774111294439, 4194.328907374821, 4271.850485233002, 4303.65570754342, 4352.17308711347, 4378.255696531565, 4339.500957389878, 4372.322290045048, 4384.7369157850635, 4391.758453285068, 4432.822687092513, 4118.320477121271, 4337.934930976038, 4350.695451318409, 4358.978205108954, 4403.801828917706, 4598.425196850394, 4607.10161518504, 4627.791749371253, 4711.104890070876, 4755.976220118911, 5115.232715092766, 5153.433122356538, 5154.819581314636, 5158.664686795384, 5192.870178245536, 4839.322494850724, 5141.048905952373, 5168.483151684839, 5172.172452407597, 5172.456892026358, 4668.486466488684, 4678.859634210945, 4685.88285292867, 4724.787384567703, 4785.258284965836, 5136.486351364908, 5153.17549192135, 5169.302144210484, 5169.327987361619, 5211.218317252443, 4749.833755818529, 4999.400071991385, 5045.949540504622, 5047.596192304681, 5099.490050994945, 4985.0, 5003.199488081962, 5017.623678224075, 5093.796248150033, 5114.590832733373, 4990.700557966534, 5029.0, 5039.21892106724, 5049.469805670426, 5079.5428411443145, 4747.548982846624, 4988.451270360258, 5007.599392048627, 5010.398752149766, 5012.523810238022, 4150.584941505826, 4175.248455278079, 4188.643965262926, 4235.385869048971, 4251.404803327537, 3693.8891833245048, 3700.3709369407266, 3704.277665855186, 3705.962940370616, 3721.832517536717, 4331.675124365685, 4376.7811609419405, 4377.518472967971, 4413.029133590605, 4415.4259946206785, 4865.051314993542, 4964.751762411865, 4988.700677959261, 4991.001799640087, 5086.9745651271505, 4347.760873151944, 4350.1734670412525, 4385.627221686129, 4392.407025051641, 4408.845690400884, 4519.728816271035, 4521.253993091169, 4524.7511386873375, 4542.523035081335, 4554.225781617133, 4681.789319480564, 4800.4479484859685, 4870.732109733999, 4871.683340582922, 4886.413630364379, 4996.50034996512, 4998.775055122455, 5080.110980578458, 5088.338515992898, 5123.948760512496, 4849.442314133919, 4852.1508735971765, 4855.028994201244, 4859.2954021665955, 4895.583875370633, 4818.301346304836, 4946.109700253989, 5016.322796422436, 5024.698518088926, 5062.240663900445, 4913.778879950482, 4946.925796113133, 4947.356843610308, 4970.403551573834, 4972.950270497248, 4834.347363105936, 4836.153673107263, 4850.345203397637, 4857.392825896763, 4858.854234372974, 4934.703917764946, 4945.530174633404, 4945.629077819106, 4945.950540494549, 4957.058158949788, 4834.6374021947795, 4850.563449289581, 4855.878603034952, 4861.805527778849, 4896.706197628154, 4748.192807222849, 4810.494898035656, 4814.15752243349, 4868.075065737498, 5013.623978201576, 4842.757862106951, 4878.0975519529, 4881.048195601966, 4883.60931125502, 4924.285978533021], "unit": "score", "name": "dojo.html", "value": 4638.245280550119}, {"lowerIsBetter": false, "replicates": [556.8607848037993, 558.1766893831599, 565.064817726662, 568.8009196781127, 580.3731969472967, 26798.4640307194, 32968.835155824214, 33750.8312458438, 33805.323893522174, 33825.0, 39875.20249595006, 40412.19175616493, 40423.59576404235, 40434.59565404345, 40514.79742601283, 7078.716851325941, 7196.532225405332, 7674.040744906901, 7821.726239581616, 7825.491343062683, 10130.949345253264, 10353.896461035369, 10365.378077315347, 10369.896301036968, 10373.429461379621, 9843.360181588174, 9918.752031199241, 9919.404835709844, 9923.0, 9927.106560409562, 7311.634418279064, 7502.212267711866, 7510.0, 7511.286427789351, 10014.3490673106, 7123.501354905159, 10091.899081009244, 10393.272470927039, 10403.53184106717, 10410.219233557438, 37698.43452348217, 38102.61897381018, 38230.23539529221, 38304.233915321536, 38353.616463835286, 2810.1990932584117, 2855.0863723608454, 3068.186930463429, 3428.194374322032, 3636.8545258189642, 28314.150575482563, 28498.715012849814, 28846.134615961553, 28866.0, 29301.56047659287, 3307.834608269577, 3312.850921708529, 3323.7008669219886, 3361.5629968104236, 3426.9143271418166, 213187.0, 213352.0, 215187.0, 215204.0, 215897.0, 52408.21387679188, 53443.73278133662, 56147.71926140343, 56493.717531412905, 57734.0, 49771.0, 49813.0, 50155.74922125439, 50159.74920125449, 50179.0, 13944.651383715489, 13982.091164074303, 14124.646883827781, 14147.787783183261, 14152.22162781057, 10556.313839600401, 10601.204909631655, 10613.363198208132, 10615.575376984834, 10726.249162558703, 19040.395026474034, 19489.170188455162, 19528.51178720515, 19536.12087456068, 19553.608927821362, 7252.891206631904, 7391.926080739231, 7480.513766605153, 7525.285097915689, 7533.773986780406, 861.8104017116225, 869.891263592051, 887.671561522241, 932.1936524905908, 1008.9344192627456, 27650.723492764813, 27785.583216251773, 27878.303042423697, 28023.159305220877, 28147.15558533247, 957.5978089202551, 980.3382716666222, 988.3921388346115, 992.5087081894509, 1073.9636251017648, 14808.922738865287, 14826.670366479515, 14932.708603329591, 14965.401383944738, 14982.550523484313, 315812.0, 321868.0, 321890.0, 322184.0, 322250.0, 48552.0, 49181.262281065814, 49182.50817491779, 49188.11366408705, 49190.50809491931, 1043.5512729526376, 1131.1064259235277, 1198.532572296805, 1250.612310183846, 1310.7640624687458, 26287.342816429744, 27530.587041194798, 27694.44611107807, 27813.0, 27884.860575697803, 38253.61746382501, 38575.807120964215, 38603.99999999888, 38625.6137438622, 44551.77724111359, 193182.0, 195490.0, 513038.0, 529183.0, 530265.0, 38459.61540384672, 38936.610633893295, 38961.220775584894, 38973.0, 39707.80146099251, 42048.0, 42215.788921055195, 42620.78689606532, 42744.35883461813, 43050.569494304655, 34846.303073938885, 35173.0, 35573.644263557035, 35641.82179089088, 36002.8199858999, 35848.0, 35958.64041359553, 35980.20098995092, 36035.63964360323, 36510.8174459126, 36061.27877442489, 36407.45388819117, 36533.63466365302, 36997.44503832391, 37267.25465490621, 28847.42305153927, 30242.79028838822, 30792.692073078983, 30816.691833081382, 31046.91335803236, 23557.411064723517, 23934.76065239325, 24186.153484628656, 24332.635010474503, 24424.87787561051], "unit": "score", "name": "ext.html", "value": 17838.62845279104}, {"lowerIsBetter": false, "replicates": [333.90984434202784, 340.94374428219345, 342.47088248655825, 343.12160868177466, 349.0558040500446, 12098.395080245975, 12524.123311368185, 14963.401463941444, 15125.168115753642, 16884.83115168848, 11880.405979701023, 12138.196044857475, 13313.600591982231, 14682.28377750117, 14706.632334191623, 4918.213085906255, 5134.2812006319145, 5147.665401748893, 5148.639595228336, 5153.793848246084, 3720.4977328060772, 5033.471485494026, 5049.873753156164, 5061.9240711389175, 5123.513266239701, 3806.5812760596314, 5676.943230567683, 5802.448767367094, 5815.709214539277, 5824.359320474766, 5692.943070569324, 5770.538356931435, 5780.566457515703, 5780.682062486561, 5886.440788125121, 5162.92255616166, 5163.40620828602, 5165.354330708661, 5168.767405466763, 5171.146760784503, 18200.63598728031, 18229.908850455795, 18433.170507327202, 18578.814211857843, 19150.80849191518, 1870.261246807517, 1886.481217665153, 1926.4509614759727, 1935.2549268531575, 1957.4421289932443, 8111.391645626542, 8301.211384918422, 8462.36532260083, 12388.938055309756, 12986.415611297514, 1735.3232239426634, 1750.3786155914722, 1761.7093179625347, 1762.0396883698288, 1772.8482166880904, 53870.730646346514, 57417.71291143559, 57747.711261443845, 58110.418895811345, 58579.41420585782, 9688.41869487833, 9751.073648003428, 9775.853362199572, 9788.461634610023, 9846.803063938682, 12546.498140074478, 12553.874461255453, 12567.120301578801, 12569.183003104768, 12571.93714031424, 7168.92831071693, 7251.637418129178, 7266.055412796302, 7304.561726296439, 7305.488615796843, 6994.965025174944, 7036.824079398056, 7074.575525468488, 7081.256468070881, 7106.431485481149, 4076.3477843544892, 4162.0, 4169.45797046382, 4187.099773548702, 4213.726107802983, 1524.9695006099817, 1588.0829144354368, 1696.8642508599282, 1716.416418417744, 1772.9024903630425, 407.5964794853074, 716.4411758828122, 836.1011912194415, 906.2659246010752, 931.4550987672152, 8693.478391296416, 9620.95189524048, 9880.209583233323, 9976.501174941224, 10332.586696532055, 394.1152113505142, 402.3883696780935, 404.82390160280374, 404.97772622506045, 406.90641152535085, 8941.642334306685, 9039.819203616022, 9216.447013179097, 9273.238084763872, 9867.605295788231, 465787.0, 471333.0, 472652.0, 485522.0, 489297.0, 61589.692051540354, 72859.0, 73124.63437682777, 74286.0, 75329.0, 1050.579768092769, 1055.7096798380508, 1057.2704833664748, 1072.099436473366, 1074.1836204484491, 13754.381052852847, 14258.786118208027, 14810.925945370203, 14893.702125957638, 15075.54773356801, 33157.0, 33371.49942750812, 34047.65952340445, 34452.655473444946, 34557.0, 37621.81189094037, 38393.80803095967, 38609.227815444094, 38996.0, 39214.0, 8547.316214702685, 8718.258947989492, 8792.164744349277, 9069.410488318239, 9181.724548263563, 16214.918925405298, 16360.18199090017, 16404.425845095364, 16685.749713754547, 16869.91565042167, 13460.25968571738, 13993.720125597227, 14021.579352619437, 14156.787648185491, 14264.144151350953, 13065.869341306465, 13373.465061397825, 13744.03791734569, 13806.723865522834, 13973.441062357391, 13277.800832987707, 13630.386632601754, 13820.930895345458, 13952.302384880919, 14248.0, 8470.83058338842, 8545.188207120314, 8963.865542016745, 8970.37207395502, 8985.685501007694, 9112.681056163003, 9260.814783704423, 13004.609861704164, 13938.651533711738, 14230.501932432315], "unit": "score", "name": "jquery.html", "value": 7986.999278008557}, {"lowerIsBetter": false, "replicates": [1258.6790368456043, 1654.1150484490795, 1715.5025042737607, 1717.4590004148693, 1740.7127823909063, 6063.727132279047, 7054.85890282194, 7250.854982900339, 7254.6009969451725, 7255.238199988991, 7140.5001649884525, 7289.380402665766, 7344.155422126457, 7354.521956072852, 7358.852822943538, 2052.2611859730487, 2065.184252220372, 2078.449210959097, 2081.6669332906736, 2082.094288984289, 2092.7279453671076, 2105.26315789474, 2115.4922818523596, 2149.881756503392, 2157.773433789453, 2054.0551346380685, 2056.259746491262, 2077.8233850122756, 2081.2923605973965, 2082.79172082792, 2082.3856962196187, 2104.8000439958255, 2104.8737075775502, 2105.0, 2105.0211651581935, 2014.8891810950392, 2046.478148072247, 2047.4471892588917, 2049.6515592349338, 2102.7056212130315, 7109.751158709472, 7190.676419561132, 7197.092770415844, 7199.712011519533, 7203.243659415738, 4126.504819421689, 4195.328747400401, 4218.093109981369, 4237.025484138665, 4253.106847562016, 2661.1484325016004, 2686.6641669791275, 2698.7840972722333, 2725.550284203104, 2733.671959364869, 837.9874301885477, 848.465466755946, 853.3471894001032, 865.6018231613465, 871.808202195516, 9777.853332200022, 9811.803763924752, 9844.556994935245, 9866.901330986742, 9867.358621689567, 3867.5552311483975, 3885.825137868803, 3926.587708290588, 3984.063745019918, 3994.520657521116, 8414.453060551166, 8454.788630284293, 8467.95766021166, 8473.745787626382, 8477.830443391098, 4308.612224899774, 4323.6757243206885, 4326.15639950213, 4333.133373325348, 4333.566643335705, 3270.2314955985325, 3353.614334351581, 3805.219929914361, 3928.2929072767174, 3928.7249892507252, 3480.460528618068, 3495.94756078659, 3497.860085596548, 3522.454019626962, 3555.822208889545, 1052.2055847834836, 1068.503146037081, 1086.4296244471716, 1099.384344766933, 1108.013867657785, 1193.5882120668355, 1193.970150746221, 1198.5445530698278, 1200.9699757506132, 1230.7353918907477, 6674.16572928384, 6703.363180497845, 6867.862642747117, 6928.376446119873, 6933.0, 412.0214490584861, 412.29909154437576, 412.8637549608622, 414.7242084014157, 414.85480081971673, 5383.623146379716, 5426.891462170814, 5433.619646624698, 5434.673919564839, 5442.782288708408, 8431.662733490592, 8516.935383077116, 8720.433171843937, 8761.649534018568, 8804.559772011375, 8622.396432249683, 8653.30773538128, 8719.912800872036, 8721.694740684046, 8727.389082764146, 6749.3250674932115, 6827.146606674166, 6843.315668433117, 6880.139982502287, 6901.757683616896, 6373.044043393528, 6432.517561182836, 6452.12896258999, 6455.4190122887285, 6461.289258181502, 7573.394128469819, 7604.125525564631, 7670.42471814605, 7785.065792104983, 7793.37652987771, 7843.84312313762, 7892.0529536456, 8030.317423019109, 8095.433319667567, 8105.067917189599, 5359.356877174608, 5634.85912852182, 5649.293838270216, 6368.363163683594, 6412.487001039813, 5941.405859414024, 6383.712732926937, 6392.840178995562, 6433.388828061326, 6435.324290949383, 6135.785247516315, 6178.196834411498, 6331.620102793847, 6503.512236582181, 6622.403983641495, 6335.841603959938, 6366.076918846648, 6372.5220608455475, 6453.806385808433, 6476.6114033158165, 6606.8017959461295, 6645.60126392418, 6647.634380108947, 6650.83372915681, 6651.26836048044, 5845.532357411482, 5997.280326360865, 6004.039353703386, 6030.095485677183, 6035.879282414415, 6110.7861224856915, 6151.323354431099, 6163.38366163398, 6168.0, 6173.56785025044], "unit": "score", "name": "mootools.html", "value": 4029.6117456482716}, {"lowerIsBetter": false, "replicates": [296.3864799864282, 300.5521772558887, 307.9476488996872, 308.4155525279595, 310.48614542931426, 5369.5435887949525, 5383.192521121834, 5405.324334458198, 5408.702521361323, 5427.511523962842, 5309.920351194735, 5322.148456247001, 5322.201669749539, 5324.1747529133045, 5332.946670533293, 3939.7439166454233, 4167.145735124307, 4172.18642364739, 4179.289520781467, 4181.979090104545, 4053.1893621275717, 4070.9185816283657, 4140.047789008515, 4170.291050521419, 4183.435236243099, 4127.504699436072, 4140.358244472111, 4141.213169497801, 4144.9585504145025, 4145.751254924699, 3898.142408670088, 3998.540167880702, 3999.920001599952, 4138.586141385852, 4138.772367519785, 3634.036980200249, 3656.122530592665, 3659.8536058557625, 3661.2494438640283, 3661.6338366163436, 5141.280220769096, 5163.0, 5163.0190263849745, 5167.199084141964, 5175.715335656538, 4720.763961801897, 4752.691075080109, 4759.0, 4763.428388593356, 4774.3077253798, 5457.154141108134, 5594.720263986825, 5603.551715862721, 5603.859903502404, 5627.8593035174445, 3967.1272320089533, 3967.3057214987552, 3975.1453437510786, 3975.1652153047894, 3977.9259599907864, 5880.117982302646, 5887.0286402743495, 5893.233879595668, 5896.115582662592, 5898.970505147447, 4079.592040795956, 4085.652719518874, 4087.6321131098343, 4087.8364865405647, 4088.2845502037026, 3911.726179167431, 4088.5707000765087, 4152.045029643199, 4155.563665815046, 4161.04296011919, 4664.416947881515, 4670.159371313128, 4679.064187162581, 4681.695689780154, 4684.0, 5604.963081829875, 5606.747696353674, 5613.971930140323, 5614.1859430382365, 5621.269234999424, 1413.9787903181461, 1436.6049336432357, 1437.6118448019186, 1437.7915202295608, 1438.1946110178333, 939.4175611121149, 948.5731420860641, 959.8128364968903, 986.9981968302179, 988.3921388346259, 4960.751962401865, 4962.627802914796, 4965.230389289666, 4965.602751779849, 4968.627352948543, 5836.591438599257, 5845.766169353178, 5846.327672317653, 5847.912281315784, 5849.298084229919, 4944.802207911715, 4954.256861470808, 4956.90086198274, 4957.677750946177, 4960.231164169487, 2901.4922388581913, 3011.728944395015, 3086.4907290297297, 3111.7510599152465, 3128.2961333699736, 5533.08704063833, 5589.329280486287, 5608.074667679869, 5608.635438696553, 5613.550915926798, 6054.727537260834, 6059.818205453844, 6062.939370606326, 6069.241344831896, 6073.4837538808815, 5590.301212348457, 5598.384177740527, 5602.719864006865, 5604.131359639263, 5604.887902242014, 5762.7694892203845, 5875.764969401176, 5888.087346461305, 5894.941050589439, 5910.202122713378, 5739.483446489836, 5745.683987380734, 5749.453801888814, 5754.741036653444, 5755.424457554211, 5585.0, 5585.860353491195, 5590.077637189818, 5590.5527557796095, 5591.776328946797, 3882.3400021995762, 4036.434899114185, 4036.656884164879, 4037.8990525237105, 4039.1719697461363, 5820.505257053029, 5834.795782147605, 5835.299764028344, 5835.912461313169, 5839.0, 5580.469855363734, 5587.804426845041, 5591.30108736408, 5592.524635406036, 5595.244641973281, 5562.610617256915, 5595.804146855004, 5598.244237028112, 5600.243967064394, 5622.072358060874, 5352.839414817562, 5463.153211252262, 5474.671519708831, 5475.753591088331, 5479.0, 5623.718814059199, 5624.578156638187, 5628.85927851807, 5632.521235694848, 5633.436656334334, 5281.366236051698, 5466.606015466031, 5470.53500452466, 5470.9179362308805, 5473.562115030868], "unit": "score", "name": "prototype.html", "value": 4225.066551720656}, {"lowerIsBetter": false, "replicates": [659.2188256915556, 682.4028974647186, 719.9424046076315, 752.713968691897, 796.406677025616, 11458.197926145163, 11781.587644432446, 11811.350375729331, 11826.822597661041, 11834.7633047339, 11430.08559315255, 11877.7624447511, 11888.0, 11895.52417903283, 11898.167128301022, 650.8828410886039, 657.6185812228896, 801.707376807464, 816.7876352148425, 832.4505826154739, 825.8637324841394, 828.3249151941179, 834.3450391442718, 834.5910503853129, 834.8497270491309, 864.1962974433774, 874.1695389380083, 875.8992715837696, 875.9386842920998, 876.1370050500252, 670.0351493848866, 679.8572299817044, 841.1840514700791, 853.9957300213521, 857.5669287010082, 638.8722255548909, 639.3606393606393, 639.3766078073841, 641.2081079866362, 642.3063091860779, 10958.561657533768, 11244.943775281154, 11251.09991200702, 11257.0, 11273.943630281878, 11219.834284040566, 11267.943660281728, 11278.436078196057, 11601.0, 11714.355710435922, 9234.307426943005, 9244.815103697956, 9271.3973591717, 9306.115918987685, 9372.90627093734, 3249.707526322619, 3267.3628642414737, 3287.0467564406295, 3302.0, 3315.535824984504, 36779.264414711826, 39411.40882886759, 39502.802485987384, 39518.0, 39594.010149746486, 9005.189532941935, 9015.594298256463, 9056.958449778229, 9219.354645174773, 9405.811883762286, 15332.540023799304, 15410.768838467431, 15414.537563873102, 15415.383384664488, 15428.15145167004, 6020.247469066367, 6108.297545782292, 6115.755369785159, 6336.904946425807, 6420.06908998202, 3516.7538272321203, 3564.8752293669595, 3610.151614370621, 3634.9636503634624, 3652.634736526379, 2587.456634106821, 2598.0, 2607.29603007187, 2610.073423934514, 2614.4640348728467, 462.8889066623986, 466.30753331302986, 477.1840153337831, 478.8802799300175, 479.51808432525087, 548.2051026012298, 589.2751915144396, 603.9396060393925, 629.1003864473755, 638.0716058135401, 7730.188330225358, 7775.455718099679, 8036.236557527026, 8104.230098140667, 8143.51138931666, 445.4943638969793, 460.0614745918356, 467.3597171874554, 575.3153747041008, 616.035903810535, 3487.720982321408, 3641.708663306929, 3710.5547334320054, 3763.41667041609, 3766.4162054881535, 50614.98770024579, 53869.461305386445, 53961.73019134879, 54629.45370546323, 54750.45249547533, 41592.792036039624, 41904.0, 42411.0, 43283.350749738776, 43416.78291608522, 39092.21815563673, 39256.80371598124, 39749.0, 39805.40291895566, 39817.40273895894, 7506.849863002819, 7991.440599158235, 8224.424290299621, 8291.626876790438, 8312.21034001769, 29667.703322966496, 29804.0, 30734.23164420818, 30851.537226941164, 30915.381692366478, 38606.42090368703, 38723.612763872, 38974.610253897095, 39068.804655976535, 39337.40993885151, 10267.640632577824, 10325.864154943101, 10501.632442864464, 10547.630832921119, 10752.193585481276, 11264.098872090377, 11283.774324513628, 11389.202755807013, 11529.769404611692, 12092.576759813364, 10785.730356741144, 11118.054965328038, 11231.38227397501, 11274.661760147208, 11417.657470275904, 10184.18526517862, 10218.795624087328, 10557.419341936267, 10655.520501577292, 10756.623518176826, 11025.724356891142, 11041.183944988543, 11081.612143574936, 11453.19827612059, 11477.598284060017, 9340.439573625332, 9621.27840411986, 9681.177099946583, 9767.56045977947, 9949.353292035994, 9061.13919177677, 9141.3601047926, 9224.907750922674, 9337.272604568177, 9599.136077753035], "unit": "score", "name": "yui.html", "value": 5714.433782741924}], "name": "dromaeo_css", "value": 6329.498963914312}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 114.0, 109.0, 115.0, 116.0, 113.0, 103.0, 115.0, 114.0, 123.0], "unit": "score", "name": "ai-astar", "value": 113.5}, {"lowerIsBetter": true, "replicates": [160.0, 128.0, 152.0, 170.0, 140.0, 155.0, 155.0, 131.0, 182.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 150.4}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 160.0, 163.0, 162.0, 164.0, 162.0, 161.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.8}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 78.0, 96.0, 71.0, 73.0, 72.0, 103.0, 89.0, 72.0], "unit": "score", "name": "audio-fft", "value": 80.0}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 138.0, 95.0, 95.0, 96.0, 130.0, 94.0, 95.0, 132.0], "unit": "score", "name": "audio-oscillator", "value": 106.5}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 147.0, 147.0, 148.0, 146.0, 147.0, 146.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [75.0, 75.0, 75.0, 74.0, 74.0, 74.0, 74.0, 87.0, 71.0, 73.0], "unit": "score", "name": "json-parse-financial", "value": 75.2}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 68.0, 68.0, 68.0, 70.0, 69.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [87.0, 86.0, 86.0, 91.0, 86.0, 86.0, 86.0, 88.0, 87.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.0}, {"lowerIsBetter": true, "replicates": [121.0, 120.0, 132.0, 120.0, 120.0, 133.0, 124.0, 133.0, 130.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.6}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 144.0, 151.0, 153.0, 138.0, 152.0, 150.0, 148.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.5}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 69.0, 69.0, 70.0, 69.0, 68.0, 70.0, 71.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.6}], "name": "kraken", "value": 1536.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.80998176090202], "unit": "score", "name": "Richards", "value": 212.90636200000006}, {"lowerIsBetter": false, "replicates": [186.6368047779022], "unit": "score", "name": "DeltaBlue", "value": 354.26024399999994}, {"lowerIsBetter": false, "replicates": [278.9400278940028], "unit": "score", "name": "Encrypt", "value": 954.2588850000001}, {"lowerIsBetter": false, "replicates": [5154.639175257732], "unit": "score", "name": "Decrypt", "value": 51.63911399999997}, {"lowerIsBetter": false, "replicates": [1996.007984031936], "unit": "score", "name": "RayTrace", "value": 370.73448899999994}, {"lowerIsBetter": false, "replicates": [788.0220646178093], "unit": "score", "name": "Earley", "value": 845.7415470000001}, {"lowerIsBetter": false, "replicates": [11988.095238095239], "unit": "score", "name": "Boyer", "value": 55.59373584905661}, {"lowerIsBetter": false, "replicates": [27459.45945945946], "unit": "score", "name": "RegExp", "value": 33.17563484251969}, {"lowerIsBetter": false, "replicates": [607.1645415907711], "unit": "score", "name": "Splay", "value": 134.21567700000003}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 19784.811178928932}]} 09:25:53 INFO - RETURN: dromaeo_css: 6329.50 09:25:53 INFO - RETURN: kraken: 1536.40 09:25:53 INFO - RETURN: v8_7: 19784.81 09:25:53 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19784.81"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1536.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6329.50"}}} 09:25:54 INFO - Return code: 0 09:25:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:25:54 INFO - # TBPL SUCCESS # 09:25:54 INFO - Running post-action listener: _resource_record_post_action 09:25:54 INFO - Running post-run listener: _resource_record_post_run 09:25:55 INFO - Total resource usage - Wall time: 1237s; CPU: 13.0%; Read bytes: 0; Write bytes: 504614912; Read time: 0; Write time: 512176 09:25:55 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 231456768; Read time: 0; Write time: 306412 09:25:55 INFO - run-tests - Wall time: 1223s; CPU: 13.0%; Read bytes: 0; Write bytes: 272138240; Read time: 0; Write time: 205716 09:25:55 INFO - Running post-run listener: _upload_blobber_files 09:25:55 INFO - Blob upload gear active. 09:25:55 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:25:55 INFO - Copying logs to upload dir... 09:25:55 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1289.473436 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2015-12-16 09:25:54.701466) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 09:25:54.704978) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1450284880.663872-775345031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/f6SkOJErTwqV-kuaojpO4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009980 build_url: 'https://queue.taskcluster.net/v1/task/f6SkOJErTwqV-kuaojpO4Q/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-16 09:25:54.755794) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 09:25:54.756125) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1450284880.663872-775345031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004636 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 09:25:54.805494) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 09:25:54.805803) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 09:25:54.806110) ========= ========= Total master_lag: 0.26 =========