builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-014 starttime: 1448000135.25 results: success (0) buildid: 20151119211036 builduid: dcd87b7a8c9b4a67a2ac813c610d7193 revision: 1b2e15608f34fef0f23369731c80138f55f00cf2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 22:15:35.251173) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 22:15:35.251557) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 22:15:35.251854) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=01deea79d00cc2c334834894000001d2-1447999933.960079-964426978 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006504 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 22:15:35.277959) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 22:15:35.278293) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 22:15:35.305535) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:15:35.305878) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=01deea79d00cc2c334834894000001d2-1447999933.960079-964426978 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004614 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:15:35.354772) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 22:15:35.355099) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 22:15:35.355443) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:15:35.355723) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=01deea79d00cc2c334834894000001d2-1447999933.960079-964426978 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-19 22:15:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2015-11-19 22:15:36 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.175359 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:15:35.544094) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:15:35.544376) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=01deea79d00cc2c334834894000001d2-1447999933.960079-964426978 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018092 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:15:35.593551) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:15:35.593860) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1b2e15608f34fef0f23369731c80138f55f00cf2 --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 1b2e15608f34fef0f23369731c80138f55f00cf2 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=01deea79d00cc2c334834894000001d2-1447999933.960079-964426978 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-19 22:15:36,129 truncating revision to first 12 chars 2015-11-19 22:15:36,129 Setting DEBUG logging. 2015-11-19 22:15:36,129 attempt 1/10 2015-11-19 22:15:36,129 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1b2e15608f34?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-19 22:15:36,745 unpacking tar archive at: fx-team-1b2e15608f34/testing/mozharness/ program finished with exit code 0 elapsedTime=0.915287 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:15:36.521940) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 22:15:36.522314) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 22:15:36.530494) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 22:15:36.530753) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 22:15:36.531216) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-11-19 22:15:36.531508) ========= /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=01deea79d00cc2c334834894000001d2-1447999933.960079-964426978 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:15:37 INFO - MultiFileLogger online at 20151119 22:15:37 in /builds/slave/test 22:15:37 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 22:15:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:15:37 INFO - {'append_to_log': False, 22:15:37 INFO - 'base_work_dir': '/builds/slave/test', 22:15:37 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:15:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:15:37 INFO - 'branch': 'Fx-Team-Non-PGO', 22:15:37 INFO - 'buildbot_json_path': 'buildprops.json', 22:15:37 INFO - 'config_files': ('talos/linux_config.py',), 22:15:37 INFO - 'default_actions': ('clobber', 22:15:37 INFO - 'read-buildbot-config', 22:15:37 INFO - 'download-and-extract', 22:15:37 INFO - 'populate-webroot', 22:15:37 INFO - 'create-virtualenv', 22:15:37 INFO - 'install', 22:15:37 INFO - 'run-tests'), 22:15:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:15:37 INFO - 'download_minidump_stackwalk': True, 22:15:37 INFO - 'download_symbols': 'ondemand', 22:15:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:15:37 INFO - 'tooltool.py': '/tools/tooltool.py', 22:15:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:15:37 INFO - '/tools/misc-python/virtualenv.py')}, 22:15:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:15:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:15:37 INFO - 'installer_path': 'installer.exe', 22:15:37 INFO - 'log_level': 'info', 22:15:37 INFO - 'log_name': 'talos', 22:15:37 INFO - 'log_to_console': True, 22:15:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:15:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:15:37 INFO - 'opt_config_files': (), 22:15:37 INFO - 'pip_index': False, 22:15:37 INFO - 'sps_profile': False, 22:15:37 INFO - 'sps_profile_interval': 0, 22:15:37 INFO - 'suite': 'dromaeojs', 22:15:37 INFO - 'system_bits': '64', 22:15:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:15:37 INFO - 'title': 'talos-linux64-ix-014', 22:15:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:15:37 INFO - 'use_talos_json': True, 22:15:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:15:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:15:37 INFO - 'work_dir': 'build'} 22:15:37 INFO - ##### 22:15:37 INFO - ##### Running clobber step. 22:15:37 INFO - ##### 22:15:37 INFO - Running pre-action listener: _resource_record_pre_action 22:15:37 INFO - Running main action method: clobber 22:15:37 INFO - rmtree: /builds/slave/test/build 22:15:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:15:37 INFO - Running post-action listener: _resource_record_post_action 22:15:37 INFO - ##### 22:15:37 INFO - ##### Running read-buildbot-config step. 22:15:37 INFO - ##### 22:15:37 INFO - Running pre-action listener: _resource_record_pre_action 22:15:37 INFO - Running main action method: read_buildbot_config 22:15:37 INFO - Using buildbot properties: 22:15:37 INFO - { 22:15:37 INFO - "properties": { 22:15:37 INFO - "buildnumber": 2093, 22:15:37 INFO - "product": "firefox", 22:15:37 INFO - "script_repo_revision": "production", 22:15:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 22:15:37 INFO - "repository": "", 22:15:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 22:15:37 INFO - "buildid": "20151119211036", 22:15:37 INFO - "slavename": "talos-linux64-ix-014", 22:15:37 INFO - "pgo_build": "False", 22:15:37 INFO - "basedir": "/builds/slave/test", 22:15:37 INFO - "project": "", 22:15:37 INFO - "platform": "ubuntu64_hw", 22:15:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:15:37 INFO - "slavebuilddir": "test", 22:15:37 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:15:37 INFO - "branch": "fx-team", 22:15:37 INFO - "repo_path": "integration/fx-team", 22:15:37 INFO - "stage_platform": "linux64", 22:15:37 INFO - "builduid": "dcd87b7a8c9b4a67a2ac813c610d7193", 22:15:37 INFO - "revision": "1b2e15608f34fef0f23369731c80138f55f00cf2" 22:15:37 INFO - }, 22:15:37 INFO - "sourcestamp": { 22:15:37 INFO - "repository": "", 22:15:37 INFO - "hasPatch": false, 22:15:37 INFO - "project": "", 22:15:37 INFO - "branch": "fx-team-linux64-talos", 22:15:37 INFO - "changes": [ 22:15:37 INFO - { 22:15:37 INFO - "category": null, 22:15:37 INFO - "files": [ 22:15:37 INFO - { 22:15:37 INFO - "url": null, 22:15:37 INFO - "name": "https://queue.taskcluster.net/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 22:15:37 INFO - } 22:15:37 INFO - ], 22:15:37 INFO - "repository": "", 22:15:37 INFO - "rev": "1b2e15608f34fef0f23369731c80138f55f00cf2", 22:15:37 INFO - "who": "philringnalda@gmail.com", 22:15:37 INFO - "when": 1448000103, 22:15:37 INFO - "number": 6686988, 22:15:37 INFO - "comments": "Merge m-c to f-t", 22:15:37 INFO - "project": "", 22:15:37 INFO - "at": "Thu 19 Nov 2015 22:15:03", 22:15:37 INFO - "branch": "fx-team-linux64-talos", 22:15:37 INFO - "revlink": "", 22:15:37 INFO - "properties": [ 22:15:37 INFO - [ 22:15:37 INFO - "buildid", 22:15:37 INFO - "20151119211036", 22:15:37 INFO - "Change" 22:15:37 INFO - ], 22:15:37 INFO - [ 22:15:37 INFO - "builduid", 22:15:37 INFO - "dcd87b7a8c9b4a67a2ac813c610d7193", 22:15:37 INFO - "Change" 22:15:37 INFO - ], 22:15:37 INFO - [ 22:15:37 INFO - "pgo_build", 22:15:37 INFO - "False", 22:15:37 INFO - "Change" 22:15:37 INFO - ] 22:15:37 INFO - ], 22:15:37 INFO - "revision": "1b2e15608f34fef0f23369731c80138f55f00cf2" 22:15:37 INFO - } 22:15:37 INFO - ], 22:15:37 INFO - "revision": "1b2e15608f34fef0f23369731c80138f55f00cf2" 22:15:37 INFO - } 22:15:37 INFO - } 22:15:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 22:15:37 INFO - Running post-action listener: _resource_record_post_action 22:15:37 INFO - ##### 22:15:37 INFO - ##### Running download-and-extract step. 22:15:37 INFO - ##### 22:15:37 INFO - Running pre-action listener: _resource_record_pre_action 22:15:37 INFO - Running main action method: download_and_extract 22:15:37 INFO - mkdir: /builds/slave/test/build/tests 22:15: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')]} 22:15:37 INFO - https://queue.taskcluster.net/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:15:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/test_packages.json 22:15:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/test_packages.json 22:15:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 22:15:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 22:15:38 INFO - Downloaded 1302 bytes. 22:15:38 INFO - Reading from file /builds/slave/test/build/test_packages.json 22:15:38 INFO - Using the following test package requirements: 22:15:38 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:15:38 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:15:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:15:38 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:15:38 INFO - u'jsshell-linux-x86_64.zip'], 22:15:38 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:15:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:15:38 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:15:38 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:15:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:15:38 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:15:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:15:38 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:15:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:15:38 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:15:38 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:15:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:15:38 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:15:38 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')]} 22:15:38 INFO - https://queue.taskcluster.net/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:15:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:15:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:15:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:15:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:15:39 INFO - Downloaded 21339275 bytes. 22:15:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 22:15:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:15:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 22:15:40 INFO - Return code: 0 22:15:40 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:15:40 INFO - https://queue.taskcluster.net/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:15:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:15:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:15:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:15:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:15:43 INFO - Downloaded 21339275 bytes. 22:15:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 22:15:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:15:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 22:15:44 INFO - Return code: 0 22:15:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:15:44 INFO - https://queue.taskcluster.net/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:15:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:15:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:15:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:15:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:15:45 INFO - Downloaded 11130997 bytes. 22:15:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 22:15:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:15:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 22:15:46 INFO - Return code: 0 22:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:15:46 INFO - https://queue.taskcluster.net/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:15:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:15:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:15:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:15:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:15:47 INFO - Downloaded 55783644 bytes. 22:15:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:15:47 INFO - mkdir: /builds/slave/test/properties 22:15:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:15:47 INFO - Writing to file /builds/slave/test/properties/build_url 22:15:47 INFO - Contents: 22:15:47 INFO - build_url:https://queue.taskcluster.net/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:15:47 INFO - Running post-action listener: _resource_record_post_action 22:15:47 INFO - Running post-action listener: set_extra_try_arguments 22:15:47 INFO - ##### 22:15:47 INFO - ##### Running populate-webroot step. 22:15:47 INFO - ##### 22:15:47 INFO - Running pre-action listener: _resource_record_pre_action 22:15:47 INFO - Running main action method: populate_webroot 22:15:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:15:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:15:47 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 22:15:47 INFO - '../fennec_ids.txt'], 22:15:47 INFO - 'tests': ['tcheck2']}, 22:15:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:15:47 INFO - '--tppagecycles', 22:15:47 INFO - '7'], 22:15:47 INFO - 'tests': ['tsvgm']}}, 22:15:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:15:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:15:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:15:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:15:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:15:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:15:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:15:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:15:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:15:47 INFO - 'talos_options': ['--e10s'], 22:15:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:15:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:15:47 INFO - 'tests': ['damp', 'tps']}, 22:15:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:15:47 INFO - 'talos_options': ['--e10s'], 22:15:47 INFO - 'tests': ['damp', 'tps']}, 22:15:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:15:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:15:47 INFO - 'other': {'tests': ['a11yr', 22:15:47 INFO - 'ts_paint', 22:15:47 INFO - 'tpaint', 22:15:47 INFO - 'sessionrestore', 22:15:47 INFO - 'sessionrestore_no_auto_restore']}, 22:15:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:15:47 INFO - 'tests': ['a11yr', 22:15:47 INFO - 'ts_paint', 22:15:47 INFO - 'tpaint', 22:15:47 INFO - 'sessionrestore', 22:15:47 INFO - 'sessionrestore_no_auto_restore']}, 22:15:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:15:47 INFO - 'tests': ['a11yr', 22:15:47 INFO - 'ts_paint', 22:15:47 INFO - 'tpaint', 22:15:47 INFO - 'sessionrestore', 22:15:47 INFO - 'sessionrestore_no_auto_restore']}, 22:15:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:15:47 INFO - 'tests': ['a11yr', 22:15:47 INFO - 'ts_paint', 22:15:47 INFO - 'tpaint', 22:15:47 INFO - 'sessionrestore', 22:15:47 INFO - 'sessionrestore_no_auto_restore']}, 22:15:47 INFO - 'other_l64': {'tests': ['a11yr', 22:15:47 INFO - 'ts_paint', 22:15:47 INFO - 'tpaint', 22:15:47 INFO - 'sessionrestore', 22:15:47 INFO - 'sessionrestore_no_auto_restore']}, 22:15:47 INFO - 'other_nol64': {'tests': ['a11yr', 22:15:47 INFO - 'ts_paint', 22:15:47 INFO - 'tpaint', 22:15:47 INFO - 'sessionrestore', 22:15:47 INFO - 'sessionrestore_no_auto_restore']}, 22:15:47 INFO - 'svgr': {'tests': ['tsvgx', 22:15:47 INFO - 'tsvgr_opacity', 22:15:47 INFO - 'tart', 22:15:47 INFO - 'tscrollx', 22:15:47 INFO - 'cart']}, 22:15:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:15:47 INFO - 'tests': ['tsvgx', 22:15:47 INFO - 'tsvgr_opacity', 22:15:47 INFO - 'tart', 22:15:47 INFO - 'tscrollx', 22:15:47 INFO - 'cart']}, 22:15:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:15:47 INFO - 'tests': ['tp5o']}, 22:15:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:15:47 INFO - 'talos_options': ['--e10s'], 22:15:47 INFO - 'tests': ['tp5o']}, 22:15:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:15:47 INFO - 'talos_options': ['--xperf_path', 22:15:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:15:47 INFO - 'tests': ['tp5n']}, 22:15:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:15:47 INFO - 'talos_options': ['--e10s', 22:15:47 INFO - '--xperf_path', 22:15:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:15:47 INFO - 'tests': ['tp5n']}}, 22:15:47 INFO - 'talos.zip': {'path': '', 22:15:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:15:47 INFO - Running post-action listener: _resource_record_post_action 22:15:47 INFO - ##### 22:15:47 INFO - ##### Running create-virtualenv step. 22:15:47 INFO - ##### 22:15:47 INFO - Running pre-action listener: _resource_record_pre_action 22:15:47 INFO - Running main action method: create_virtualenv 22:15:47 INFO - Creating virtualenv /builds/slave/test/build/venv 22:15:47 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 22:15:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:15:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:15:47 INFO - Using real prefix '/usr' 22:15:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:15:48 INFO - Installing distribute.............................................................................................................................................................................................done. 22:15:50 INFO - Installing pip.................done. 22:15:50 INFO - Return code: 0 22:15:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:15:50 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')]} 22:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:15:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:50 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')]} 22:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:50 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 0x7f3165570c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22bf900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2305b70>, '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 0x2356dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2357250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1447999933.960079-964426978', '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 22:15:50 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 22:15:50 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 22:15:50 INFO - Using env: {'DISPLAY': ':0', 22:15:50 INFO - 'HOME': '/home/cltbld', 22:15:50 INFO - 'LANG': 'en_US.UTF-8', 22:15:50 INFO - 'LANGUAGE': 'en_US:en', 22:15:50 INFO - 'LOGNAME': 'cltbld', 22:15:50 INFO - 'MAIL': '/var/mail/cltbld', 22:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:15:50 INFO - 'MOZ_NO_REMOTE': '1', 22:15:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:15:50 INFO - 'NO_EM_RESTART': '1', 22:15:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:15:50 INFO - 'PWD': '/builds/slave/test', 22:15:50 INFO - 'SHELL': '/bin/bash', 22:15:50 INFO - 'SHLVL': '1', 22:15:50 INFO - 'TERM': 'linux', 22:15:50 INFO - 'TMOUT': '86400', 22:15:50 INFO - 'USER': 'cltbld', 22:15:50 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1447999933.960079-964426978', 22:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:15:50 INFO - '_': '/tools/buildbot/bin/python'} 22:15:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:15:50 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 22:15:50 INFO - Cleaning up... 22:15:50 INFO - Return code: 0 22:15:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:15:50 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')]} 22:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:15:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:50 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')]} 22:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:50 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 0x7f3165570c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22bf900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2305b70>, '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 0x2356dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2357250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1447999933.960079-964426978', '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 22:15:50 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 22:15:50 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 22:15:50 INFO - Using env: {'DISPLAY': ':0', 22:15:50 INFO - 'HOME': '/home/cltbld', 22:15:50 INFO - 'LANG': 'en_US.UTF-8', 22:15:50 INFO - 'LANGUAGE': 'en_US:en', 22:15:50 INFO - 'LOGNAME': 'cltbld', 22:15:50 INFO - 'MAIL': '/var/mail/cltbld', 22:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:15:50 INFO - 'MOZ_NO_REMOTE': '1', 22:15:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:15:50 INFO - 'NO_EM_RESTART': '1', 22:15:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:15:50 INFO - 'PWD': '/builds/slave/test', 22:15:50 INFO - 'SHELL': '/bin/bash', 22:15:50 INFO - 'SHLVL': '1', 22:15:50 INFO - 'TERM': 'linux', 22:15:50 INFO - 'TMOUT': '86400', 22:15:50 INFO - 'USER': 'cltbld', 22:15:50 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1447999933.960079-964426978', 22:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:15:50 INFO - '_': '/tools/buildbot/bin/python'} 22:15:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:15:50 INFO - Downloading/unpacking psutil>=0.7.1 22:15:50 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 22:15:50 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 22:15:50 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 22:15:50 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 22:15:50 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 22:15:50 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 22:15:52 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 22:15:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:15:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:15:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:15:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:15:52 INFO - Installing collected packages: psutil 22:15:52 INFO - Running setup.py install for psutil 22:15:52 INFO - building 'psutil._psutil_linux' extension 22:15:52 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 22:15:52 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 22:15:52 INFO - building 'psutil._psutil_posix' extension 22:15:52 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 22:15:52 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 22:15:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:15:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:15:52 INFO - Successfully installed psutil 22:15:52 INFO - Cleaning up... 22:15:52 INFO - Return code: 0 22:15:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:15: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')]} 22:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:15:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15: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')]} 22:15:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:15:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:52 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 0x7f3165570c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22bf900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2305b70>, '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 0x2356dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2357250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1447999933.960079-964426978', '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 22:15:52 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 22:15:52 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 22:15:52 INFO - Using env: {'DISPLAY': ':0', 22:15:52 INFO - 'HOME': '/home/cltbld', 22:15:52 INFO - 'LANG': 'en_US.UTF-8', 22:15:52 INFO - 'LANGUAGE': 'en_US:en', 22:15:52 INFO - 'LOGNAME': 'cltbld', 22:15:52 INFO - 'MAIL': '/var/mail/cltbld', 22:15:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:15:52 INFO - 'MOZ_NO_REMOTE': '1', 22:15:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:15:52 INFO - 'NO_EM_RESTART': '1', 22:15:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:15:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:15:52 INFO - 'PWD': '/builds/slave/test', 22:15:52 INFO - 'SHELL': '/bin/bash', 22:15:52 INFO - 'SHLVL': '1', 22:15:52 INFO - 'TERM': 'linux', 22:15:52 INFO - 'TMOUT': '86400', 22:15:52 INFO - 'USER': 'cltbld', 22:15:52 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1447999933.960079-964426978', 22:15:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:15:52 INFO - '_': '/tools/buildbot/bin/python'} 22:15:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:15:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:15:53 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 22:15:53 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 22:15:53 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 22:15:53 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 22:15:53 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 22:15:53 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 22:15:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:15:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:15:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:15:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:15:54 INFO - Installing collected packages: mozsystemmonitor 22:15:54 INFO - Running setup.py install for mozsystemmonitor 22:15:54 INFO - Successfully installed mozsystemmonitor 22:15:54 INFO - Cleaning up... 22:15:54 INFO - Return code: 0 22:15:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:15:54 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')]} 22:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:15:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:54 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')]} 22:15:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:15:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:54 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 0x7f3165570c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22bf900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2305b70>, '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 0x2356dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2357250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1447999933.960079-964426978', '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 22:15:54 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 22:15:54 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 22:15:54 INFO - Using env: {'DISPLAY': ':0', 22:15:54 INFO - 'HOME': '/home/cltbld', 22:15:54 INFO - 'LANG': 'en_US.UTF-8', 22:15:54 INFO - 'LANGUAGE': 'en_US:en', 22:15:54 INFO - 'LOGNAME': 'cltbld', 22:15:54 INFO - 'MAIL': '/var/mail/cltbld', 22:15:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:15:54 INFO - 'MOZ_NO_REMOTE': '1', 22:15:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:15:54 INFO - 'NO_EM_RESTART': '1', 22:15:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:15:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:15:54 INFO - 'PWD': '/builds/slave/test', 22:15:54 INFO - 'SHELL': '/bin/bash', 22:15:54 INFO - 'SHLVL': '1', 22:15:54 INFO - 'TERM': 'linux', 22:15:54 INFO - 'TMOUT': '86400', 22:15:54 INFO - 'USER': 'cltbld', 22:15:54 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1447999933.960079-964426978', 22:15:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:15:54 INFO - '_': '/tools/buildbot/bin/python'} 22:15:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:15:55 INFO - Downloading/unpacking blobuploader==1.2.4 22:15:55 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 22:15:55 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 22:15:55 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 22:15:55 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 22:15:55 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 22:15:55 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 22:15:56 INFO - Downloading blobuploader-1.2.4.tar.gz 22:15:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:15:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:15:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:15: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 22:15: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 22:15: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 22:15: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 22:15: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 22:15: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 22:15:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:15:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:15:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:15:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:15:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:15:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:15:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:15:57 INFO - Downloading docopt-0.6.1.tar.gz 22:15:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:15:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:15:57 INFO - Installing collected packages: blobuploader, requests, docopt 22:15:57 INFO - Running setup.py install for blobuploader 22:15:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:15:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:15:57 INFO - Running setup.py install for requests 22:15:58 INFO - Running setup.py install for docopt 22:15:58 INFO - Successfully installed blobuploader requests docopt 22:15:58 INFO - Cleaning up... 22:15:58 INFO - Return code: 0 22:15:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:15:58 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')]} 22:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:15:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:58 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')]} 22:15:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:15:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:58 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 0x7f3165570c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22bf900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2305b70>, '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 0x2356dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2357250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1447999933.960079-964426978', '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 22:15:58 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 22:15:58 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 22:15:58 INFO - Using env: {'DISPLAY': ':0', 22:15:58 INFO - 'HOME': '/home/cltbld', 22:15:58 INFO - 'LANG': 'en_US.UTF-8', 22:15:58 INFO - 'LANGUAGE': 'en_US:en', 22:15:58 INFO - 'LOGNAME': 'cltbld', 22:15:58 INFO - 'MAIL': '/var/mail/cltbld', 22:15:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:15:58 INFO - 'MOZ_NO_REMOTE': '1', 22:15:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:15:58 INFO - 'NO_EM_RESTART': '1', 22:15:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:15:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:15:58 INFO - 'PWD': '/builds/slave/test', 22:15:58 INFO - 'SHELL': '/bin/bash', 22:15:58 INFO - 'SHLVL': '1', 22:15:58 INFO - 'TERM': 'linux', 22:15:58 INFO - 'TMOUT': '86400', 22:15:58 INFO - 'USER': 'cltbld', 22:15:58 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1447999933.960079-964426978', 22:15:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:15:58 INFO - '_': '/tools/buildbot/bin/python'} 22:15:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:15:58 INFO - Running setup.py (path:/tmp/pip-zsYhzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:15:58 INFO - Running setup.py (path:/tmp/pip-k266y7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:15:58 INFO - Running setup.py (path:/tmp/pip-6boTkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:15:58 INFO - Running setup.py (path:/tmp/pip-p3RbcZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:15:58 INFO - Running setup.py (path:/tmp/pip-ZYh0B9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:15:58 INFO - Running setup.py (path:/tmp/pip-Z62aFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:15:58 INFO - Running setup.py (path:/tmp/pip-B91vbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:15:58 INFO - Running setup.py (path:/tmp/pip-HPxuWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:15:58 INFO - Running setup.py (path:/tmp/pip-Vi7OzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:15:58 INFO - Running setup.py (path:/tmp/pip-IrfhtL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:15:59 INFO - Running setup.py (path:/tmp/pip-HQ1kA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:15:59 INFO - Running setup.py (path:/tmp/pip-wc1UnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:15:59 INFO - Running setup.py (path:/tmp/pip-xIlS5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:15:59 INFO - Running setup.py (path:/tmp/pip-_jP2S0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:15:59 INFO - Running setup.py (path:/tmp/pip-rVMtCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:15:59 INFO - Running setup.py (path:/tmp/pip-dVTsOt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:15:59 INFO - Running setup.py (path:/tmp/pip-cSOL9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:15:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:15:59 INFO - Running setup.py install for manifestparser 22:15:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:15:59 INFO - Running setup.py install for mozcrash 22:15:59 INFO - Running setup.py install for mozdebug 22:15:59 INFO - Running setup.py install for mozdevice 22:15:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:15:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:16:00 INFO - Running setup.py install for mozfile 22:16:00 INFO - Running setup.py install for mozhttpd 22:16:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:16:00 INFO - Running setup.py install for mozinfo 22:16:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:16:00 INFO - Running setup.py install for mozInstall 22:16:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:16:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:16:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:16:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:16:00 INFO - Running setup.py install for mozleak 22:16:00 INFO - Running setup.py install for mozlog 22:16:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:16:00 INFO - Running setup.py install for moznetwork 22:16:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:16:00 INFO - Running setup.py install for mozprocess 22:16:00 INFO - Running setup.py install for mozprofile 22:16:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:16:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:16:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:16:00 INFO - Running setup.py install for mozrunner 22:16:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:16:01 INFO - Running setup.py install for mozscreenshot 22:16:01 INFO - Running setup.py install for moztest 22:16:01 INFO - Running setup.py install for mozversion 22:16:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:16:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:16:01 INFO - Cleaning up... 22:16:01 INFO - Return code: 0 22:16:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:16: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')]} 22:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:16:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16: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')]} 22:16:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:16:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16: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', '-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 0x7f3165570c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22bf900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2305b70>, '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 0x2356dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2357250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1447999933.960079-964426978', '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 22:16:01 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 22:16:01 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 22:16:01 INFO - Using env: {'DISPLAY': ':0', 22:16:01 INFO - 'HOME': '/home/cltbld', 22:16:01 INFO - 'LANG': 'en_US.UTF-8', 22:16:01 INFO - 'LANGUAGE': 'en_US:en', 22:16:01 INFO - 'LOGNAME': 'cltbld', 22:16:01 INFO - 'MAIL': '/var/mail/cltbld', 22:16:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:16:01 INFO - 'MOZ_NO_REMOTE': '1', 22:16:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:16:01 INFO - 'NO_EM_RESTART': '1', 22:16:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:16:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:16:01 INFO - 'PWD': '/builds/slave/test', 22:16:01 INFO - 'SHELL': '/bin/bash', 22:16:01 INFO - 'SHLVL': '1', 22:16:01 INFO - 'TERM': 'linux', 22:16:01 INFO - 'TMOUT': '86400', 22:16:01 INFO - 'USER': 'cltbld', 22:16:01 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1447999933.960079-964426978', 22:16:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:16:01 INFO - '_': '/tools/buildbot/bin/python'} 22:16:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:16:01 INFO - Running setup.py (path:/tmp/pip-Bg3fzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:16:01 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)) 22:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:16:01 INFO - Running setup.py (path:/tmp/pip-ww6nQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:16:01 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)) 22:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:16:01 INFO - Running setup.py (path:/tmp/pip-W29eQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:16:01 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)) 22:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:16:01 INFO - Running setup.py (path:/tmp/pip-bi5HhP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:16:01 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)) 22:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:16:01 INFO - Running setup.py (path:/tmp/pip-gj9yFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:16:01 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)) 22:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:16:01 INFO - Running setup.py (path:/tmp/pip-wEUck4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:16:02 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)) 22:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:16:02 INFO - Running setup.py (path:/tmp/pip-pUCpBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:16:02 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)) 22:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:16:02 INFO - Running setup.py (path:/tmp/pip-jQtcAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:16:02 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)) 22:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:16:02 INFO - Running setup.py (path:/tmp/pip-qHCUEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:16:02 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)) 22:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:16:02 INFO - Running setup.py (path:/tmp/pip-jA5Bh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:16:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 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)) 22:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:16:02 INFO - Running setup.py (path:/tmp/pip-mqiN7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:16:02 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)) 22:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:16:02 INFO - Running setup.py (path:/tmp/pip-WI9jPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:16:02 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)) 22:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:16:02 INFO - Running setup.py (path:/tmp/pip-ShQtdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:16:02 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)) 22:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:16:02 INFO - Running setup.py (path:/tmp/pip-gF7qgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:16:02 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)) 22:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:16:02 INFO - Running setup.py (path:/tmp/pip-zxX0od-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:16:02 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)) 22:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:16:02 INFO - Running setup.py (path:/tmp/pip-0j65WF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:16:02 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)) 22:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:16:02 INFO - Running setup.py (path:/tmp/pip-0cibKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:16:02 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)) 22:16:02 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)) 22:16:02 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)) 22:16:02 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)) 22:16:02 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)) 22:16:02 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)) 22:16:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:16:02 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 22:16:02 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 22:16:02 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 22:16:02 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 22:16:02 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 22:16:02 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 22:16:04 INFO - Downloading blessings-1.5.1.tar.gz 22:16:04 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 22:16:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:16:04 INFO - Installing collected packages: blessings 22:16:04 INFO - Running setup.py install for blessings 22:16:04 INFO - Successfully installed blessings 22:16:04 INFO - Cleaning up... 22:16:04 INFO - Return code: 0 22:16:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:16:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:16:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:16:04 INFO - Reading from file tmpfile_stdout 22:16:04 INFO - Current package versions: 22:16:04 INFO - argparse == 1.2.1 22:16:04 INFO - blessings == 1.5.1 22:16:04 INFO - blobuploader == 1.2.4 22:16:04 INFO - docopt == 0.6.1 22:16:04 INFO - manifestparser == 1.1 22:16:04 INFO - mozInstall == 1.12 22:16:04 INFO - mozcrash == 0.16 22:16:04 INFO - mozdebug == 0.1 22:16:04 INFO - mozdevice == 0.47 22:16:04 INFO - mozfile == 1.2 22:16:04 INFO - mozhttpd == 0.7 22:16:04 INFO - mozinfo == 0.9 22:16:04 INFO - mozleak == 0.1 22:16:04 INFO - mozlog == 3.0 22:16:04 INFO - moznetwork == 0.27 22:16:04 INFO - mozprocess == 0.22 22:16:04 INFO - mozprofile == 0.27 22:16:04 INFO - mozrunner == 6.11 22:16:04 INFO - mozscreenshot == 0.1 22:16:04 INFO - mozsystemmonitor == 0.0 22:16:04 INFO - moztest == 0.7 22:16:04 INFO - mozversion == 1.4 22:16:04 INFO - psutil == 3.1.1 22:16:04 INFO - requests == 1.2.3 22:16:04 INFO - wsgiref == 0.1.2 22:16:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:16: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')]} 22:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:16:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16: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')]} 22:16:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:16:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16:04 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 0x7f3165570c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22bf900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2305b70>, '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 0x2356dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2357250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1447999933.960079-964426978', '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 22:16:04 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 22:16:04 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 22:16:04 INFO - Using env: {'DISPLAY': ':0', 22:16:04 INFO - 'HOME': '/home/cltbld', 22:16:04 INFO - 'LANG': 'en_US.UTF-8', 22:16:04 INFO - 'LANGUAGE': 'en_US:en', 22:16:04 INFO - 'LOGNAME': 'cltbld', 22:16:04 INFO - 'MAIL': '/var/mail/cltbld', 22:16:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:16:04 INFO - 'MOZ_NO_REMOTE': '1', 22:16:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:16:04 INFO - 'NO_EM_RESTART': '1', 22:16:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:16:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:16:04 INFO - 'PWD': '/builds/slave/test', 22:16:04 INFO - 'SHELL': '/bin/bash', 22:16:04 INFO - 'SHLVL': '1', 22:16:04 INFO - 'TERM': 'linux', 22:16:04 INFO - 'TMOUT': '86400', 22:16:04 INFO - 'USER': 'cltbld', 22:16:04 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1447999933.960079-964426978', 22:16:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:16:04 INFO - '_': '/tools/buildbot/bin/python'} 22:16:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:16:05 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)) 22:16:05 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)) 22:16:05 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)) 22:16:05 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)) 22:16:05 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)) 22:16:05 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)) 22:16:05 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)) 22:16:05 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)) 22:16:05 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)) 22:16:05 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)) 22:16:05 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)) 22:16:05 INFO - Cleaning up... 22:16:05 INFO - Return code: 0 22:16:05 INFO - Running post-action listener: _resource_record_post_action 22:16:05 INFO - Running post-action listener: _start_resource_monitoring 22:16:05 INFO - Starting resource monitoring. 22:16:05 INFO - ##### 22:16:05 INFO - ##### Running install step. 22:16:05 INFO - ##### 22:16:05 INFO - Running pre-action listener: _resource_record_pre_action 22:16:05 INFO - Running main action method: install 22:16:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:16:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:16:05 INFO - Reading from file tmpfile_stdout 22:16:05 INFO - Detecting whether we're running mozinstall >=1.0... 22:16:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:16:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:16:05 INFO - Reading from file tmpfile_stdout 22:16:05 INFO - Output received: 22:16:05 INFO - Usage: mozinstall [options] installer 22:16:05 INFO - Options: 22:16:05 INFO - -h, --help show this help message and exit 22:16:05 INFO - -d DEST, --destination=DEST 22:16:05 INFO - Directory to install application into. [default: 22:16:05 INFO - "/builds/slave/test"] 22:16:05 INFO - --app=APP Application being installed. [default: firefox] 22:16:05 INFO - mkdir: /builds/slave/test/build/application 22:16:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:16:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:16:19 INFO - Reading from file tmpfile_stdout 22:16:19 INFO - Output received: 22:16:19 INFO - /builds/slave/test/build/application/firefox/firefox 22:16:19 INFO - Running post-action listener: _resource_record_post_action 22:16:19 INFO - ##### 22:16:19 INFO - ##### Running run-tests step. 22:16:19 INFO - ##### 22:16:19 INFO - Running pre-action listener: _resource_record_pre_action 22:16:19 INFO - Running main action method: run_tests 22:16:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:16:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:16:19 INFO - Python 2.7.3 22:16:19 INFO - Return code: 0 22:16:19 INFO - grabbing minidump binary from tooltool 22:16:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:16:19 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 0x2305b70>, '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 0x2356dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2357250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:16:19 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 22:16:19 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 22:16:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:16:19 INFO - Return code: 0 22:16:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:16:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:16:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:16:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:16:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:16:19 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/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost'] in /builds/slave/test/build 22:16:19 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/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost 22:16:19 INFO - Using env: {'DISPLAY': ':0', 22:16:19 INFO - 'HOME': '/home/cltbld', 22:16:19 INFO - 'LANG': 'en_US.UTF-8', 22:16:19 INFO - 'LANGUAGE': 'en_US:en', 22:16:19 INFO - 'LOGNAME': 'cltbld', 22:16:19 INFO - 'MAIL': '/var/mail/cltbld', 22:16:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:16:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:16:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:16:19 INFO - 'MOZ_NO_REMOTE': '1', 22:16:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:16:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:16:19 INFO - 'NO_EM_RESTART': '1', 22:16:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:16:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:16:19 INFO - 'PWD': '/builds/slave/test', 22:16:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:16:19 INFO - 'SHELL': '/bin/bash', 22:16:19 INFO - 'SHLVL': '1', 22:16:19 INFO - 'TERM': 'linux', 22:16:19 INFO - 'TMOUT': '86400', 22:16:19 INFO - 'USER': 'cltbld', 22:16:19 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1447999933.960079-964426978', 22:16:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:16:19 INFO - '_': '/tools/buildbot/bin/python'} 22:16:19 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/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost'] with output_timeout 3600 22:16:19 INFO - mozversion INFO | application_buildid: 20151119211036 22:16:19 INFO - mozversion INFO | application_changeset: 1b2e15608f34fef0f23369731c80138f55f00cf2 22:16:19 INFO - mozversion INFO | application_display_name: Nightly 22:16:19 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:16:19 INFO - mozversion INFO | application_name: Firefox 22:16:19 INFO - mozversion INFO | application_remotingname: firefox 22:16:19 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 22:16:19 INFO - mozversion INFO | application_vendor: Mozilla 22:16:19 INFO - mozversion INFO | application_version: 45.0a1 22:16:19 INFO - mozversion INFO | platform_buildid: 20151119211036 22:16:19 INFO - mozversion INFO | platform_changeset: 1b2e15608f34fef0f23369731c80138f55f00cf2 22:16:19 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 22:16:19 INFO - mozversion INFO | platform_version: 45.0a1 22:16:19 INFO - 2015-11-19 22:16:19,870 DEBUG : using testdate: 1448000179 22:16:19 INFO - 2015-11-19 22:16:19,870 DEBUG : actual date: 1448000179 22:16:19 INFO - 2015-11-19 22:16:19,951 INFO : starting webserver on 'localhost:37395' 22:16:19 INFO - 2015-11-19 22:16:19,952 INFO : Starting test suite talos-linux64-ix-014 22:16:19 INFO - 2015-11-19 22:16:19,952 INFO : Starting test dromaeo_css 22:16:19 INFO - 2015-11-19 22:16:19,953 DEBUG : operating with platform_type : linux_ 22:16:19 INFO - 2015-11-19 22:16:19,953 INFO : Initialising browser for dromaeo_css test... 22:16:19 INFO - 2015-11-19 22:16:19,967 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp05X0VL/profile http://localhost:37395/getInfo.html 22:16:24 INFO - 2015-11-19 22:16:24,379 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:16:24 INFO - 2015-11-19 22:16:24,380 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:16:24 INFO - 2015-11-19 22:16:24,380 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:16:24 INFO - 2015-11-19 22:16:24,380 DEBUG : BROWSER_OUTPUT: __metrics 22:16:24 INFO - 2015-11-19 22:16:24,524 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:16:25 INFO - 2015-11-19 22:16:25,738 INFO : Browser initialized. 22:16:25 INFO - 2015-11-19 22:16:25,739 INFO : Running cycle 1/1 for dromaeo_css test... 22:16:25 INFO - 2015-11-19 22:16:25,739 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp05X0VL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:16:37 INFO - 2015-11-19 22:16:37,663 DEBUG : BROWSER_OUTPUT: RSS: Main: 141824000 22:16:37 INFO - 2015-11-19 22:16:37,663 DEBUG : BROWSER_OUTPUT: 22:17:29 INFO - 2015-11-19 22:17:29,112 DEBUG : BROWSER_OUTPUT: 1448000249111 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] 22:19:41 INFO - 2015-11-19 22:19:41,396 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37395/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37395/tests/dromaeo/cssquery-ext.html) 22:19:42 INFO - 2015-11-19 22:19:42,525 DEBUG : BROWSER_OUTPUT: RSS: Main: 243712000 22:19:42 INFO - 2015-11-19 22:19:42,525 DEBUG : BROWSER_OUTPUT: 22:22:44 INFO - 2015-11-19 22:22:44,960 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37395/tests/dromaeo/cssquery-ext.html (next: http://localhost:37395/tests/dromaeo/cssquery-jquery.html) 22:22:45 INFO - 2015-11-19 22:22:45,541 DEBUG : BROWSER_OUTPUT: RSS: Main: 211652608 22:22:45 INFO - 2015-11-19 22:22:45,541 DEBUG : BROWSER_OUTPUT: 22:25:47 INFO - 2015-11-19 22:25:47,591 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37395/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37395/tests/dromaeo/cssquery-mootools.html) 22:25:48 INFO - 2015-11-19 22:25:48,164 DEBUG : BROWSER_OUTPUT: RSS: Main: 218259456 22:25:48 INFO - 2015-11-19 22:25:48,164 DEBUG : BROWSER_OUTPUT: 22:28:50 INFO - 2015-11-19 22:28:50,097 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37395/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37395/tests/dromaeo/cssquery-prototype.html) 22:28:50 INFO - 2015-11-19 22:28:50,663 DEBUG : BROWSER_OUTPUT: RSS: Main: 206467072 22:28:50 INFO - 2015-11-19 22:28:50,663 DEBUG : BROWSER_OUTPUT: 22:31:53 INFO - 2015-11-19 22:31:53,517 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37395/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37395/tests/dromaeo/cssquery-yui.html) 22:31:54 INFO - 2015-11-19 22:31:54,110 DEBUG : BROWSER_OUTPUT: RSS: Main: 208728064 22:31:54 INFO - 2015-11-19 22:31:54,110 DEBUG : BROWSER_OUTPUT: 22:34:56 INFO - 2015-11-19 22:34:56,684 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37395/tests/dromaeo/cssquery-yui.html (next: http://localhost:37395/tests/dromaeo/cssquery-dojo.html) 22:34:56 INFO - 2015-11-19 22:34:56,934 DEBUG : BROWSER_OUTPUT: RSS: Main: 258121728 22:34:56 INFO - 2015-11-19 22:34:56,934 DEBUG : BROWSER_OUTPUT: 22:34:56 INFO - 2015-11-19 22:34:56,936 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:34:56 INFO - 2015-11-19 22:34:56,936 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:34:56 INFO - 2015-11-19 22:34:56,936 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:34:56 INFO - 2015-11-19 22:34:56,936 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:34:56 INFO - 2015-11-19 22:34:56,940 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2681.8390896546207;2757.4209416022636;2765.7925655575837;2778.7638050765686;2779.749822515974;4611.861644150673;4730.6925049871825;4749.501302363254;4780.426348838136;4790.8802279942975;4706.717596944177;4719.9292010619865;4781.235002399617;4786.664933454659;4851.708897466146;4424.823007079721;4424.845130420436;4434.17967675981;4439.889002774924;4507.09858028394;4357.934630980538;4446.066326071529;4449.154660614473;4470.910581788362;4521.502634710179;4280.828766849322;4368.060866913597;4372.584604462602;4373.518912919576;4376.89057773555;4465.1739428205565;4467.642588592905;4470.642348612103;4472.776361181928;4513.1650644630845;4460.754658493782;4464.2187617166865;4470.75410852403;4490.59584637381;4509;4554.180247555439;4675.322078298662;4708.693934894221;4713.434387873443;4816.879578010543;5196.740162991873;5211.895762084775;5217.373915130209;5225.08561001827;5228.032813929397;5225.242339860699;5229.607779416559;5233.241180028913;5258.710770907599;5282.577393808486;4567.840125595621;4626.606738427204;4691.319758634979;4695.319178719066;4698.671093023456;5306.442823503554;5361.51746342831;5364.061289274361;5370.946290537123;5373.462653734595;5128.3845938486875;5169.560587350042;5172.560332371715;5179.741012949337;5227.503387178212;4883;4970.931249781314;4995.775190116454;4996.400431948116;5088.949110508922;5119.667221630582;5122.436531981479;5123.180291153398;5130.204818253177;5134.666246693953;5109.131447653907;5115.283860259567;5117.2068329409;5121.359830021247;5166.199239117943;4102.938455923164;4110.794460276974;4168.874933751932;4209.536950935395;4213.641840443596;3735.215604722984;3739.962600374016;3759.323321802102;3772.490713753663;3799.297130030953;4380.299152135643;4385.7149285296355;4385.912281754347;4422.800973956179;4427.512973572904;4913.140200464904;5052.8484145475695;5147.3051138096625;5188.247704082887;5190.40310364313;4357.085012147421;4391.121775644884;4418.315161150027;4421.314696222091;4463.285874260103;4594.839180628662;4604.608608268268;4606.170889239902;4609.746463944448;4643.953560464352;4677.555632214934;4782.043591281688;4787.832425865078;4942.159832828428;4960.553550180501;5100.770465329143;5214.9478505214465;5219.530242278213;5224;5259.289995850511;4955.40535135786;4957;4968.577670898014;5017.874553136201;5021.221710634857;4876.756162191805;4990.201567749143;5175.663581867167;5177.870553236048;5179.430262671179;4972.378452693413;5026.170681837456;5048.671836330626;5060.645754797129;5078.771455284447;5003.074431230234;5026.874328141826;5031.446540880427;5039.722815245197;5088.618353623419;4806.182948898626;4929.383827021622;4971.701697898137;5032.119379108714;5032.220005899091;4747.881302967454;4869.0261947609915;4901.436334821398;4918.2868484068895;4926.162552366035;5076.213186956028;5082.949170508247;5083.974580127076;5087.821926232564;5093.821716239914;4941.703497790144;4951.3810773653295;4961.70229786214;4963.677360971526;5005.599552035901 22:34:56 INFO - 2015-11-19 22:34:56,941 DEBUG : BROWSER_OUTPUT: |1;ext.html;565.9614607195793;569.7009070238125;571.3600767140803;577.80354679409;585.408737175453;27997.300067498323;28527.42945141096;35882.64117358826;36327;36343.4548481773;39258.41112383317;39811.60188398115;39947.80026099872;40163.397549036716;40202.59797402025;6870.862582748342;7810.101838288584;7961.641726122339;7967.322777563914;7975.960120199391;6996.370326670599;7105.786826395217;7111.07556017717;7113.502054856162;9924.702258932244;10140.340877842953;10215.846762298572;10253.43606101664;10256.589736410535;10260.33307834992;10076.89923100767;10122.595096196143;10171.033751793568;10176.982301769764;10189.490525473697;7149.9642501787675;7342.118945726494;7352.63236838156;7353.154387245429;10217.080462758313;37067.81466092679;37676.62323376758;37706.24587508262;37711.62288377109;37743.62256377456;2894.9276268093254;2934.4277865816175;2950.5279155335043;2967.139529536432;3022.1689035515187;28274;28405.289867753472;28614.856925715445;28696.85651571729;28790;3184.1561986073707;3202.871885124592;3277.6886195811358;3332.6000879894327;3481.8433170507387;218978;219542;221172;221553;221816;48446.75776621094;48716;48741.26888096681;48777.756111219926;48845.511544884095;59575.70212148998;60048;60082;60084.39915600788;60134.69932650309;14334.21161836109;14890.255487225812;14987.700245995236;14997.17515536656;14998.700025999418;11556.191066625424;11653;11659.242149260272;11665.183437159487;11669.59156429521;18802.431850930676;19289.614207715767;19475.415737527896;19479.805201948082;19518.40680742275;7626.54240745557;7753.457257991887;7829.95304226201;7840.647170877324;7918.841623167505;747.1034758290074;839.1063517353998;887.1882227761655;911.2209061252667;1042.2652030318607;25922.481550369263;25938.092166774073;25961;26232.86883565608;26262.34344141412;850.4004676702909;945.5036106044245;963.8361478548663;972.9027097290356;1032.0866033560203;13404.463821447032;13885.86114138866;13886.546129623084;13888.791668124986;14060.22668753208;312060;314590;315132;316496;316715;48005.75997119992;48136.75931620319;48406.27390589144;48597.757011214715;48676;1139.4473680265064;1151.8272259161026;1154.3939431798374;1157.1148071725138;1179.4102948525738;25726.742732572435;26288.60567091457;26445.80582485778;26693.866530667998;26749.33126671771;36137.0965725859;36685.449718253716;37444;37863.43204851874;37897.62102378941;234441;237989;238836;238976;240891;28916.566251506665;29332;29577.26056848596;29874.701252987194;29919.102426927227;39290.410643839794;39565.91744056774;39804.40293395543;40006.999825004605;40582.188356232116;33031.50452743259;33405.16487087842;33524.329513410084;33816.15681762982;33928.83035584806;33254.004759714495;33817.83091084529;33837.66162338443;33928.15179620529;33944.830275848464;35359.292814144086;35380.292394152486;35725.10687232736;35846.820765896;36228;27131;27327.86336068307;28750.7124928748;29047.12858614245;29054.854725726236;23764.524709505367;24225.757742423055;24391;24426.75573244245;24580.452616266048 22:34:56 INFO - 2015-11-19 22:34:56,942 DEBUG : BROWSER_OUTPUT: |2;jquery.html;321.699211237493;337.3270325700228;339.5806179368478;344.8672261179446;347.87824261508473;12153.574624888131;12525.68685782856;15090.396384144635;15120.697586048273;15878.206089695526;14719.484818031371;15139.832201358386;16304.592385190375;16515.917420412912;16529.338826446958;4979.278004689327;6225.128482012499;6504.252011018722;6508.7396504140015;6509.153810004716;3842.1163132479546;3939.113699417637;6338.809835704913;6558.409743123118;6573.572717773353;6376.202974628171;6519.413252807246;6527.640979746112;6538.7384504619995;6549.148610680605;6468.773592924249;6499.252585952581;6503.934960650404;6505.056766768816;6505.121808555832;5754.827355179351;5948.910766338508;5957.285125784891;6217.533684973645;6235.438810507076;19506.609867802705;19718;20040.298589549442;20066.598668026705;20658.896705516378;1991.7709463411747;2002.6795712686046;2050.302897015007;2053.3121404329568;2083.656196727538;13799.172049677052;13934.372953217027;14040.578782636538;14040.859591404058;14138.939579531576;1894.7536820213284;1908.5991941692123;1936.6417212815534;1939.9515012124668;1946.8247857692875;57942.420575794546;62596;62881.685591571746;63936;64310.3568964309;14892.776608350883;15476.303566339542;15482.380704771684;15491.5352539424;15511.767323490156;23218.767812322;23274.53450930972;23424.297271081894;23490.295291141294;23518.58888466663;8564.357673174536;8570.95714521436;8586.184312490303;8597.785055373666;8659.6103175356;7168.426525877917;7331.853362932711;7357.963210183915;7378.594177320191;7402.481826272109;6596.307387724316;7564.962175189199;7633.084029916335;7639.083310002835;7651.1583725790115;1739.1825841854309;1750.851177649914;1768.1336145288717;1770.0795586295312;2172.5654869026257;728.4682182007165;809.1948511231362;862.1593945902695;872.2716531696104;884.6151923913119;14947.327370268364;15694.372225110868;15775.211239437982;15785.68428631421;16268.837311626969;831.2061980808313;832.2592892325835;844.462390516494;845.9577021148918;863.6070587882498;9156.130167634064;9438.48088355147;9444.811103777885;9450.952745236367;9481.956984731674;418930;453880;459223;473133;473877;60008.39991600028;60138.39861601416;61352;62117.68941155265;66768;1011.9291649584459;1035.963741269052;1039.9740006499899;1041.557338131291;1058.6771034834449;14417;14473.85526144725;14561.635959101108;14809.555713328617;14983;32530.674693252764;32810;33132.33735325232;33626.159346016546;33693.66306336905;38740.6125938737;38842.223155536165;39838.60161398349;40384.3942340871;41494.96262593339;7974.880376794236;8190.221928916743;8279.37904657141;8380.874286885824;8389.11914248995;9876.950615246878;10016.799664006825;15490;15915.363385464452;16023.599410014844;13127.540536081191;13226.933865330611;13419.463221471031;13465.730685386434;13586.592402227949;13480;13649.522266720616;13740.793888091886;14172.362243699265;14229;14377.856221437652;14419;14688.41246350134;14801.111933284037;14803.0378025428;8440.620172092147;8553.61508732121;8647.56762161902;8734.213920747163;8753;9294.117058879396;9409.341346105706;13176.341182940623;14070.648233793827;14193.787093193818 22:34:56 INFO - 2015-11-19 22:34:56,946 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1462.6270301073225;1643.7205675035243;1700.056468659894;1724.051771525661;1728.9567760805985;6537;6895.965520172398;7026.473014523918;7032.50772445929;7039.6480175991255;7170.7490237841685;7233.24050974648;7266.273372662731;7269.491135620508;7277.9636101819415;1792.982070179301;1826.3607737291975;2072.585482903418;2142.635751922173;2168.360333701562;2142.507223338633;2152.268228802207;2152.849300548962;2153.3755210988793;2155.2133471282946;2074.0770357191054;2133.359992002393;2145.0776166248506;2146.334636262756;2146.731658542682;1780.964380712385;1819.5269230000229;2066.7209926659857;2100.85294029418;2103.6634138537916;2125.6173888700027;2132.7120838686733;2154.827613790893;2158.5143342747915;2158.892055397224;7327.194008659043;7383.40932725386;7389.298016688406;7390.852182956311;7398;4404.0531285773395;4464.866054018352;4506.233940230136;4509.706869053533;4516.938519447927;2848.1028476029983;2900.318425170083;2930.0477344862793;2951.719586639287;2969.2280007198283;881.3433991676242;884.5621417398429;895.9641614335419;920.700772249015;950.4819873169139;10026.147777438926;10037.849432258448;10066.597336106546;10071.798564028679;10085.89914100857;3994.0813612868624;4067.450894129314;4112.691548133902;4121.402396652468;4133.91732165355;8562.700305489278;8589.055203927563;8598.828023439497;8611.526366049802;8612.8708069379;4422.491413487426;4432.180046691373;4441.222786012435;4441.333799930037;4443.888902777457;3987.5414327352146;4019.2765302245875;4023.7183397161916;4025.9597404025585;4028.1742242840146;3503.3518799022263;3513.209527856263;3531.258435728526;3534.4698295255403;3546.4148415511154;1147.7819214349247;1150.2925700694013;1153.9423028848523;1169.9707507312385;1172.8709841917382;744.3115118515352;815.5962798414822;836.3434703757642;836.4688422851533;840.8528507511161;6740.528163028639;6821.658917054127;6863.210730765926;6881.380675739208;6886.51794374389;1007.6271779441654;1034.3018462537757;1037.3257382701304;1037.7198156497855;1043.658381134477;5310.9734451327495;5395.244665746799;5395.81114660985;5405.972970135124;5409.26974858397;8481.745547633582;8654.134586541422;8770.956145219361;8837.425567338103;8864.20222179994;8794.912050879537;8806.823863522694;8808.471491710518;8813.338999575057;8824.735257942271;6722.428593569503;6817.318268173143;6904.4131248843405;6914;6928.861422771617;6635.2037755469655;6656.567323123982;6657.3342665733035;6666.866662666816;6670.66646667655;7717.421193410404;7782;7823.335016523659;7850.685972561034;7942.285194332538;7987.520748755093;8172.387070969582;8205.671773129008;8286.917130828855;8304.294134998592;6398.328175541687;6403.775867844603;6454.677266136769;6455.580387274812;6462.741490340334;6931.480138989697;7000.124984376953;7001.299870012958;7005.614691192033;7016.19313778922;6573.967130164318;6646.468282537482;6720.630365329954;6753.763618273337;6861.279565645735;6511.34886511345;6517.348265173445;6549.115869357766;6657.500687448558;6679.165104361955;5873.4126587340925;6087.330393656605;6091.725872335667;6639.867202655823;6713.496487763339;5667.716614169358;6059.272887253558;6076.33160352352;6077.118817771487;6086.72609732572;6170.074488826712;6244.812655620339;6251.562390632612;6315.115883776367;6353.8729225416155 22:34:56 INFO - 2015-11-19 22:34:56,947 DEBUG : BROWSER_OUTPUT: |4;prototype.html;310.5559050557702;316.435163233628;320.0813664782076;327.81150838267985;329.2394568546656;5274.235235890794;5398.190271459283;5415.864603384917;5452.91820622691;5462.453754624536;5267.420583735786;5322.8137015204475;5355.223492593572;5390.5418039466595;5413.729313534327;4161.542230354658;4176.519700234481;4237.597428244312;4246.57534246576;4250.128723611652;4006.3589825627905;4088.7546747195115;4240.321548552232;4242.363645453176;4253.106847562016;4067.0849058961794;4159.958400415987;4167.979160104195;4168.541460439349;4171.395147703581;4146.751194928283;4161.854335098287;4162.375643653446;4164.00063984643;4168.791560421997;3642.0348607619003;3642.7996460194677;3645.052286405527;3648;3652.251288485854;5247.763850626731;5248.265242866002;5256.9474305256845;5268.209768534713;5272.92090618641;4711.528847115295;4884.340614017134;4885.169521181408;4887.120318342697;4891.706497610155;5700;5705.1727499512335;5709.343425506078;5710.114932185518;5715.342735585419;3859.7105217108547;3908.5895980922164;3984.900377490557;4077.3272410052305;4081.1225586499045;5893.027650437715;5968.492678122365;5988.520918326567;5990.580659353847;5995.850103747442;4218.346156345771;4219.0507135894795;4221.810018549173;4222.9577704223175;4226.556211597799;4268.701190916606;4279.786010699515;4280.507741609693;4283.0363168286885;4290.549492303326;4695.765211739399;4852.272159176081;4853.854384368475;4867.269909513601;4871.34236878017;5695.829125126253;5697.059985102412;5697.0599851024945;5698.430156984268;5699.344575373802;1475.542581799624;1514.48507507448;1514.9848501515064;1515.9696806064037;1517.036681707124;1019.2814066083394;1028.7942411517727;1029.629333439961;1044.6657069737762;1048.2190767877828;4932.161532539477;4946.233333833262;4947.233178857283;4953.390148201849;4958.082754690394;5881.852953676193;5883.941160588425;5888.411158884077;5893.911591326134;5896.086106653475;4939.234418665113;4946.258061290835;4947.455779864212;4949.925751113737;4950.925736113961;3116.8597413116463;3142.9528557071662;3184.41088398647;3192.473241915058;3200.823954682515;5552.972235138798;5564.805231816867;5569.220309156722;5570.637908535932;5578.107502799614;6033.577649564576;6042.063480160582;6043.486303664238;6044.969775151184;6055.697215139226;5551.084071128299;5554.638948468337;5556.166575013699;5559.249501317351;5561.805336813273;5762.481376676119;5948.464638182411;5956.731947062479;5965.403459654;5970.0746384310505;5599.776008959596;5728.4271572844045;5730.742116604846;5821.155932389695;5833.649981001154;5509.889802204014;5534.05920993424;5534.640248383842;5540.307461567304;5631.070873305859;4058.939115913323;4091.6931230158452;4105.055837157411;4107.876763697094;4114.91770164601;5928.822135335947;5929.0513517836935;5932.13983972313;5939.703014849327;5943.940560594338;5503.091989821794;5622.156676498558;5626.803061892814;5691.373948865538;5725.427457254241;5656.236408084856;5709.7145142741865;5710.971445142914;5714.428557144252;5715.914261286167;5559.082751345983;5588.804391846428;5588.888222235614;5588.888222235614;5592.944070559242;5591.860203494783;5731.770729170953;5733.541316694738;5742.856428589152;5752.9712351437975;5570.888582228414;5607.186957891001;5614.045612245846;5617.74720137603;5619.690916999604 22:34:56 INFO - 2015-11-19 22:34:56,949 DEBUG : BROWSER_OUTPUT: |5;yui.html;608.3612207182458;650.4211251985732;751.222484728306;760.3688938181314;763.1338430880949;11678.357690327028;12134.150609457352;12153.574624888131;12153.635390938263;12187.756244875098;11753.471093800777;11813.054955603553;11836.28982261065;11836.408179591008;11840.052795776339;608.5557542993618;619.8574327904585;620.3734228429274;777.1063277231201;795.5346122518333;795.49883573349;796.366888323781;802.2098233240254;802.3541049455187;802.458340620082;828.3373301358919;834.253343257784;834.9540775257359;835.1189495082685;835.2315869400167;638.4700698420323;645.6319897658336;818.8812622169812;831.8419500294924;832.7252006837729;617.4566381584222;618.0821480102045;618.8050764009367;619.1888625900041;619.2074145094286;12173.391330433444;12357.814632780515;12375.381230938507;12379.690507737288;12381.195222310522;10849.891501084967;11942.104342174285;12078.577249796303;12329.383530823423;12669;9401.294902882242;9413.76465588359;9435.858462123073;9518.476483793389;9528.618855245782;3214.180384002088;3306.272620023591;3313.2710803623163;3320.734341252694;3389.0849470643034;41288.38067428991;41514.58485415138;41613.1677366454;41662.79168604168;41674.791626041675;8790.86813697795;9614.95192524033;9683.515824208762;9751.853722194173;9819.509024548744;15318.923405383124;15337.769933451007;15348.462803801813;15386.076835389913;15491.690166196613;6173.382661733881;6303.968480157661;6419.101325814389;6501.31736167705;6505.186851643544;3518.82405879705;3549.2457852706525;3565.3047655706887;3645.434957581579;3674.0814796300924;2774.3618967637153;2837.120492647286;2842.1757690270006;2843.2039029071893;2866.899658511942;494.87133345329755;495.0198606758638;495.5391485918131;496.6796416311459;501.07301492239066;556.8329501149639;557.743438018516;567.7133047810829;569.5785119011902;617.0805499805258;6798.796036118924;7242.998817123276;7514.47398682087;7827.217278272127;7973.72091976778;486.5183468366363;533.3200169783557;554.7836343825911;579.2932622200908;598.0729868703493;3567.2865426914723;3619.022863826752;3656.670899619047;3696.242270334575;3962.583928687504;52441.2133817993;52492;53372.73313633485;53853;53865;47357.76321118372;47366.76316618395;47605;47637;47708.7614561925;42123.57876421258;42793.78603106965;43546.346804797955;44166.33750493745;44215.778921105186;7975.2423519765525;7977.641006154853;8049.14593946654;8184.713535026245;8338.332933365195;33003.66996330006;33215.335693286484;33621.83189084039;33944.98165055052;34086;38457.615423845404;38468;48342.75828620834;48455.51544484651;48745.26882096842;10744.946275268574;10757.515911784145;10968.506417211085;11411.657650270505;11605.30368177912;11596.884031159918;11701.824472633087;11748.882511175121;11847.466863991314;12720.427580758704;10784.568617255221;10877.945610271898;10922.836157457803;11155;11588.94205528967;11008.834867477155;11035.448227588427;11044.392558409365;11264.267822591506;11287.153463490107;10295.691129266133;10380.896191038295;10396;10546.525406356579;10932.234743567873;9468;9522.816115076655;9754.902450975684;9896.257780666334;9964.352317099656;8400.789980250544;8419.678144421392;8438.789030274293;8558.031652719785;8639.352048596505 22:34:56 INFO - 2015-11-19 22:34:56,949 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:34:56 INFO - 2015-11-19 22:34:56,949 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:34:56 INFO - 2015-11-19 22:34:56,949 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,932 22:34:56 INFO - 2015-11-19 22:34:56,949 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:34:56 INFO - 2015-11-19 22:34:56,950 DEBUG : BROWSER_OUTPUT: __startTimestamp1448001296935__endTimestamp 22:34:56 INFO - 2015-11-19 22:34:56,950 DEBUG : BROWSER_OUTPUT: 22:34:56 INFO - 2015-11-19 22:34:56,950 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:34:56 INFO - 2015-11-19 22:34:56,950 DEBUG : BROWSER_OUTPUT: Number of tests: 6 22:34:56 INFO - 2015-11-19 22:34:56,950 DEBUG : BROWSER_OUTPUT: 22:34:56 INFO - 2015-11-19 22:34:56,950 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4743.49 Median:4883.00 stddev:505.65 (10.4%) stddev-sans-first:480.64 22:34:56 INFO - 2015-11-19 22:34:56,951 DEBUG : BROWSER_OUTPUT: Values: 2681.8 2757.4 2765.8 2778.8 2779.7 4611.9 4730.7 4749.5 4780.4 4790.9 4706.7 4719.9 4781.2 4786.7 4851.7 4424.8 4424.8 4434.2 4439.9 4507.1 4357.9 4446.1 4449.2 4470.9 4521.5 4280.8 4368.1 4372.6 4373.5 4376.9 4465.2 4467.6 4470.6 4472.8 4513.2 4460.8 4464.2 4470.8 4490.6 4509.0 4554.2 4675.3 4708.7 4713.4 4816.9 5196.7 5211.9 5217.4 5225.1 5228.0 5225.2 5229.6 5233.2 5258.7 5282.6 4567.8 4626.6 4691.3 4695.3 4698.7 5306.4 5361.5 5364.1 5370.9 5373.5 5128.4 5169.6 5172.6 5179.7 5227.5 4883.0 4970.9 4995.8 4996.4 5088.9 5119.7 5122.4 5123.2 5130.2 5134.7 5109.1 5115.3 5117.2 5121.4 5166.2 4102.9 4110.8 4168.9 4209.5 4213.6 3735.2 3740.0 3759.3 3772.5 3799.3 4380.3 4385.7 4385.9 4422.8 4427.5 4913.1 5052.8 5147.3 5188.2 5190.4 4357.1 4391.1 4418.3 4421.3 4463.3 4594.8 4604.6 4606.2 4609.7 4644.0 4677.6 4782.0 4787.8 4942.2 4960.6 5100.8 5214.9 5219.5 5224.0 5259.3 4955.4 4957.0 4968.6 5017.9 5021.2 4876.8 4990.2 5175.7 5177.9 5179.4 4972.4 5026.2 5048.7 5060.6 5078.8 5003.1 5026.9 5031.4 5039.7 5088.6 4806.2 4929.4 4971.7 5032.1 5032.2 4747.9 4869.0 4901.4 4918.3 4926.2 5076.2 5082.9 5084.0 5087.8 5093.8 4941.7 4951.4 4961.7 4963.7 5005.6 22:34:56 INFO - 2015-11-19 22:34:56,951 DEBUG : BROWSER_OUTPUT: 22:34:56 INFO - 2015-11-19 22:34:56,952 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41815.21 Median:3193.51 stddev:68193.84 (2135.4%) stddev-sans-first:68314.81 22:34:56 INFO - 2015-11-19 22:34:56,952 DEBUG : BROWSER_OUTPUT: Values: 566.0 569.7 571.4 577.8 585.4 27997.3 28527.4 35882.6 36327.0 36343.5 39258.4 39811.6 39947.8 40163.4 40202.6 6870.9 7810.1 7961.6 7967.3 7976.0 6996.4 7105.8 7111.1 7113.5 9924.7 10140.3 10215.8 10253.4 10256.6 10260.3 10076.9 10122.6 10171.0 10177.0 10189.5 7150.0 7342.1 7352.6 7353.2 10217.1 37067.8 37676.6 37706.2 37711.6 37743.6 2894.9 2934.4 2950.5 2967.1 3022.2 28274.0 28405.3 28614.9 28696.9 28790.0 3184.2 3202.9 3277.7 3332.6 3481.8 218978.0 219542.0 221172.0 221553.0 221816.0 48446.8 48716.0 48741.3 48777.8 48845.5 59575.7 60048.0 60082.0 60084.4 60134.7 14334.2 14890.3 14987.7 14997.2 14998.7 11556.2 11653.0 11659.2 11665.2 11669.6 18802.4 19289.6 19475.4 19479.8 19518.4 7626.5 7753.5 7830.0 7840.6 7918.8 747.1 839.1 887.2 911.2 1042.3 25922.5 25938.1 25961.0 26232.9 26262.3 850.4 945.5 963.8 972.9 1032.1 13404.5 13885.9 13886.5 13888.8 14060.2 312060.0 314590.0 315132.0 316496.0 316715.0 48005.8 48136.8 48406.3 48597.8 48676.0 1139.4 1151.8 1154.4 1157.1 1179.4 25726.7 26288.6 26445.8 26693.9 26749.3 36137.1 36685.4 37444.0 37863.4 37897.6 234441.0 237989.0 238836.0 238976.0 240891.0 28916.6 29332.0 29577.3 29874.7 29919.1 39290.4 39565.9 39804.4 40007.0 40582.2 33031.5 33405.2 33524.3 33816.2 33928.8 33254.0 33817.8 33837.7 33928.2 33944.8 35359.3 35380.3 35725.1 35846.8 36228.0 27131.0 27327.9 28750.7 29047.1 29054.9 23764.5 24225.8 24391.0 24426.8 24580.5 22:34:56 INFO - 2015-11-19 22:34:56,952 DEBUG : BROWSER_OUTPUT: 22:34:56 INFO - 2015-11-19 22:34:56,952 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26186.83 Median:346.37 stddev:74321.93 (21457.2%) stddev-sans-first:74505.05 22:34:56 INFO - 2015-11-19 22:34:56,953 DEBUG : BROWSER_OUTPUT: Values: 321.7 337.3 339.6 344.9 347.9 12153.6 12525.7 15090.4 15120.7 15878.2 14719.5 15139.8 16304.6 16515.9 16529.3 4979.3 6225.1 6504.3 6508.7 6509.2 3842.1 3939.1 6338.8 6558.4 6573.6 6376.2 6519.4 6527.6 6538.7 6549.1 6468.8 6499.3 6503.9 6505.1 6505.1 5754.8 5948.9 5957.3 6217.5 6235.4 19506.6 19718.0 20040.3 20066.6 20658.9 1991.8 2002.7 2050.3 2053.3 2083.7 13799.2 13934.4 14040.6 14040.9 14138.9 1894.8 1908.6 1936.6 1940.0 1946.8 57942.4 62596.0 62881.7 63936.0 64310.4 14892.8 15476.3 15482.4 15491.5 15511.8 23218.8 23274.5 23424.3 23490.3 23518.6 8564.4 8571.0 8586.2 8597.8 8659.6 7168.4 7331.9 7358.0 7378.6 7402.5 6596.3 7565.0 7633.1 7639.1 7651.2 1739.2 1750.9 1768.1 1770.1 2172.6 728.5 809.2 862.2 872.3 884.6 14947.3 15694.4 15775.2 15785.7 16268.8 831.2 832.3 844.5 846.0 863.6 9156.1 9438.5 9444.8 9451.0 9482.0 418930.0 453880.0 459223.0 473133.0 473877.0 60008.4 60138.4 61352.0 62117.7 66768.0 1011.9 1036.0 1040.0 1041.6 1058.7 14417.0 14473.9 14561.6 14809.6 14983.0 32530.7 32810.0 33132.3 33626.2 33693.7 38740.6 38842.2 39838.6 40384.4 41495.0 7974.9 8190.2 8279.4 8380.9 8389.1 9877.0 10016.8 15490.0 15915.4 16023.6 13127.5 13226.9 13419.5 13465.7 13586.6 13480.0 13649.5 13740.8 14172.4 14229.0 14377.9 14419.0 14688.4 14801.1 14803.0 8440.6 8553.6 8647.6 8734.2 8753.0 9294.1 9409.3 13176.3 14070.6 14193.8 22:34:56 INFO - 2015-11-19 22:34:56,953 DEBUG : BROWSER_OUTPUT: 22:34:56 INFO - 2015-11-19 22:34:56,953 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5115.43 Median:6283.34 stddev:2653.74 (42.2%) stddev-sans-first:2646.98 22:34:56 INFO - 2015-11-19 22:34:56,954 DEBUG : BROWSER_OUTPUT: Values: 1462.6 1643.7 1700.1 1724.1 1729.0 6537.0 6896.0 7026.5 7032.5 7039.6 7170.7 7233.2 7266.3 7269.5 7278.0 1793.0 1826.4 2072.6 2142.6 2168.4 2142.5 2152.3 2152.8 2153.4 2155.2 2074.1 2133.4 2145.1 2146.3 2146.7 1781.0 1819.5 2066.7 2100.9 2103.7 2125.6 2132.7 2154.8 2158.5 2158.9 7327.2 7383.4 7389.3 7390.9 7398.0 4404.1 4464.9 4506.2 4509.7 4516.9 2848.1 2900.3 2930.0 2951.7 2969.2 881.3 884.6 896.0 920.7 950.5 10026.1 10037.8 10066.6 10071.8 10085.9 3994.1 4067.5 4112.7 4121.4 4133.9 8562.7 8589.1 8598.8 8611.5 8612.9 4422.5 4432.2 4441.2 4441.3 4443.9 3987.5 4019.3 4023.7 4026.0 4028.2 3503.4 3513.2 3531.3 3534.5 3546.4 1147.8 1150.3 1153.9 1170.0 1172.9 744.3 815.6 836.3 836.5 840.9 6740.5 6821.7 6863.2 6881.4 6886.5 1007.6 1034.3 1037.3 1037.7 1043.7 5311.0 5395.2 5395.8 5406.0 5409.3 8481.7 8654.1 8771.0 8837.4 8864.2 8794.9 8806.8 8808.5 8813.3 8824.7 6722.4 6817.3 6904.4 6914.0 6928.9 6635.2 6656.6 6657.3 6666.9 6670.7 7717.4 7782.0 7823.3 7850.7 7942.3 7987.5 8172.4 8205.7 8286.9 8304.3 6398.3 6403.8 6454.7 6455.6 6462.7 6931.5 7000.1 7001.3 7005.6 7016.2 6574.0 6646.5 6720.6 6753.8 6861.3 6511.3 6517.3 6549.1 6657.5 6679.2 5873.4 6087.3 6091.7 6639.9 6713.5 5667.7 6059.3 6076.3 6077.1 6086.7 6170.1 6244.8 6251.6 6315.1 6353.9 22:34:56 INFO - 2015-11-19 22:34:56,954 DEBUG : BROWSER_OUTPUT: 22:34:56 INFO - 2015-11-19 22:34:56,954 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4731.71 Median:5273.58 stddev:1375.48 (26.1%) stddev-sans-first:1338.71 22:34:56 INFO - 2015-11-19 22:34:56,954 DEBUG : BROWSER_OUTPUT: Values: 310.6 316.4 320.1 327.8 329.2 5274.2 5398.2 5415.9 5452.9 5462.5 5267.4 5322.8 5355.2 5390.5 5413.7 4161.5 4176.5 4237.6 4246.6 4250.1 4006.4 4088.8 4240.3 4242.4 4253.1 4067.1 4160.0 4168.0 4168.5 4171.4 4146.8 4161.9 4162.4 4164.0 4168.8 3642.0 3642.8 3645.1 3648.0 3652.3 5247.8 5248.3 5256.9 5268.2 5272.9 4711.5 4884.3 4885.2 4887.1 4891.7 5700.0 5705.2 5709.3 5710.1 5715.3 3859.7 3908.6 3984.9 4077.3 4081.1 5893.0 5968.5 5988.5 5990.6 5995.9 4218.3 4219.1 4221.8 4223.0 4226.6 4268.7 4279.8 4280.5 4283.0 4290.5 4695.8 4852.3 4853.9 4867.3 4871.3 5695.8 5697.1 5697.1 5698.4 5699.3 1475.5 1514.5 1515.0 1516.0 1517.0 1019.3 1028.8 1029.6 1044.7 1048.2 4932.2 4946.2 4947.2 4953.4 4958.1 5881.9 5883.9 5888.4 5893.9 5896.1 4939.2 4946.3 4947.5 4949.9 4950.9 3116.9 3143.0 3184.4 3192.5 3200.8 5553.0 5564.8 5569.2 5570.6 5578.1 6033.6 6042.1 6043.5 6045.0 6055.7 5551.1 5554.6 5556.2 5559.2 5561.8 5762.5 5948.5 5956.7 5965.4 5970.1 5599.8 5728.4 5730.7 5821.2 5833.6 5509.9 5534.1 5534.6 5540.3 5631.1 4058.9 4091.7 4105.1 4107.9 4114.9 5928.8 5929.1 5932.1 5939.7 5943.9 5503.1 5622.2 5626.8 5691.4 5725.4 5656.2 5709.7 5711.0 5714.4 5715.9 5559.1 5588.8 5588.9 5588.9 5592.9 5591.9 5731.8 5733.5 5742.9 5753.0 5570.9 5607.2 5614.0 5617.7 5619.7 22:34:56 INFO - 2015-11-19 22:34:56,954 DEBUG : BROWSER_OUTPUT: 22:34:56 INFO - 2015-11-19 22:34:56,955 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12822.92 Median:47672.88 stddev:14864.41 (31.2%) stddev-sans-first:14877.81 22:34:56 INFO - 2015-11-19 22:34:56,955 DEBUG : BROWSER_OUTPUT: Values: 608.4 650.4 751.2 760.4 763.1 11678.4 12134.2 12153.6 12153.6 12187.8 11753.5 11813.1 11836.3 11836.4 11840.1 608.6 619.9 620.4 777.1 795.5 795.5 796.4 802.2 802.4 802.5 828.3 834.3 835.0 835.1 835.2 638.5 645.6 818.9 831.8 832.7 617.5 618.1 618.8 619.2 619.2 12173.4 12357.8 12375.4 12379.7 12381.2 10849.9 11942.1 12078.6 12329.4 12669.0 9401.3 9413.8 9435.9 9518.5 9528.6 3214.2 3306.3 3313.3 3320.7 3389.1 41288.4 41514.6 41613.2 41662.8 41674.8 8790.9 9615.0 9683.5 9751.9 9819.5 15318.9 15337.8 15348.5 15386.1 15491.7 6173.4 6304.0 6419.1 6501.3 6505.2 3518.8 3549.2 3565.3 3645.4 3674.1 2774.4 2837.1 2842.2 2843.2 2866.9 494.9 495.0 495.5 496.7 501.1 556.8 557.7 567.7 569.6 617.1 6798.8 7243.0 7514.5 7827.2 7973.7 486.5 533.3 554.8 579.3 598.1 3567.3 3619.0 3656.7 3696.2 3962.6 52441.2 52492.0 53372.7 53853.0 53865.0 47357.8 47366.8 47605.0 47637.0 47708.8 42123.6 42793.8 43546.3 44166.3 44215.8 7975.2 7977.6 8049.1 8184.7 8338.3 33003.7 33215.3 33621.8 33945.0 34086.0 38457.6 38468.0 48342.8 48455.5 48745.3 10744.9 10757.5 10968.5 11411.7 11605.3 11596.9 11701.8 11748.9 11847.5 12720.4 10784.6 10877.9 10922.8 11155.0 11588.9 11008.8 11035.4 11044.4 11264.3 11287.2 10295.7 10380.9 10396.0 10546.5 10932.2 9468.0 9522.8 9754.9 9896.3 9964.4 8400.8 8419.7 8438.8 8558.0 8639.4 22:34:56 INFO - 2015-11-19 22:34:56,956 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:34:56 INFO - 2015-11-19 22:34:56,956 DEBUG : BROWSER_OUTPUT: 22:34:57 INFO - 2015-11-19 22:34:57,673 INFO : Browser exited with error code: 0 22:34:57 INFO - 2015-11-19 22:34:57,692 INFO : Completed test dromaeo_css (00:18:37) 22:34:57 INFO - 2015-11-19 22:34:57,692 INFO : Starting test kraken 22:34:57 INFO - 2015-11-19 22:34:57,692 DEBUG : operating with platform_type : linux_ 22:34:57 INFO - 2015-11-19 22:34:57,692 INFO : Initialising browser for kraken test... 22:34:57 INFO - 2015-11-19 22:34:57,698 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzGwLvS/profile http://localhost:37395/getInfo.html 22:35:01 INFO - 2015-11-19 22:35:01,715 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:35:01 INFO - 2015-11-19 22:35:01,716 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:35:01 INFO - 2015-11-19 22:35:01,716 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:35:01 INFO - 2015-11-19 22:35:01,716 DEBUG : BROWSER_OUTPUT: __metrics 22:35:01 INFO - 2015-11-19 22:35:01,804 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:35:03 INFO - 2015-11-19 22:35:03,268 INFO : Browser initialized. 22:35:03 INFO - 2015-11-19 22:35:03,269 INFO : Running cycle 1/1 for kraken test... 22:35:03 INFO - 2015-11-19 22:35:03,269 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzGwLvS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:35:15 INFO - 2015-11-19 22:35:15,184 DEBUG : BROWSER_OUTPUT: RSS: Main: 142213120 22:35:15 INFO - 2015-11-19 22:35:15,184 DEBUG : BROWSER_OUTPUT: 22:35:17 INFO - 2015-11-19 22:35:17,845 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37395/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37395/tests/kraken/driver.html?testName=audio-beat-detection) 22:35:18 INFO - 2015-11-19 22:35:18,431 DEBUG : BROWSER_OUTPUT: RSS: Main: 175169536 22:35:18 INFO - 2015-11-19 22:35:18,431 DEBUG : BROWSER_OUTPUT: 22:35:21 INFO - 2015-11-19 22:35:21,153 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37395/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37395/tests/kraken/driver.html?testName=audio-dft) 22:35:21 INFO - 2015-11-19 22:35:21,739 DEBUG : BROWSER_OUTPUT: RSS: Main: 166092800 22:35:21 INFO - 2015-11-19 22:35:21,739 DEBUG : BROWSER_OUTPUT: 22:35:24 INFO - 2015-11-19 22:35:24,748 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37395/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37395/tests/kraken/driver.html?testName=audio-fft) 22:35:25 INFO - 2015-11-19 22:35:25,314 DEBUG : BROWSER_OUTPUT: RSS: Main: 151900160 22:35:25 INFO - 2015-11-19 22:35:25,314 DEBUG : BROWSER_OUTPUT: 22:35:27 INFO - 2015-11-19 22:35:27,350 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37395/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37395/tests/kraken/driver.html?testName=audio-oscillator) 22:35:27 INFO - 2015-11-19 22:35:27,923 DEBUG : BROWSER_OUTPUT: RSS: Main: 154759168 22:35:27 INFO - 2015-11-19 22:35:27,923 DEBUG : BROWSER_OUTPUT: 22:35:30 INFO - 2015-11-19 22:35:30,104 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37395/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37395/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:35:30 INFO - 2015-11-19 22:35:30,674 DEBUG : BROWSER_OUTPUT: RSS: Main: 156168192 22:35:30 INFO - 2015-11-19 22:35:30,674 DEBUG : BROWSER_OUTPUT: 22:35:33 INFO - 2015-11-19 22:35:33,696 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37395/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37395/tests/kraken/driver.html?testName=imaging-darkroom) 22:35:34 INFO - 2015-11-19 22:35:34,265 DEBUG : BROWSER_OUTPUT: RSS: Main: 156676096 22:35:34 INFO - 2015-11-19 22:35:34,265 DEBUG : BROWSER_OUTPUT: 22:35:37 INFO - 2015-11-19 22:35:37,655 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37395/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37395/tests/kraken/driver.html?testName=imaging-desaturate) 22:35:38 INFO - 2015-11-19 22:35:38,237 DEBUG : BROWSER_OUTPUT: RSS: Main: 156311552 22:35:38 INFO - 2015-11-19 22:35:38,238 DEBUG : BROWSER_OUTPUT: 22:35:41 INFO - 2015-11-19 22:35:41,090 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37395/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37395/tests/kraken/driver.html?testName=json-parse-financial) 22:35:41 INFO - 2015-11-19 22:35:41,675 DEBUG : BROWSER_OUTPUT: RSS: Main: 157724672 22:35:41 INFO - 2015-11-19 22:35:41,675 DEBUG : BROWSER_OUTPUT: 22:35:43 INFO - 2015-11-19 22:35:43,425 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37395/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37395/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:35:43 INFO - 2015-11-19 22:35:43,999 DEBUG : BROWSER_OUTPUT: RSS: Main: 165044224 22:35:44 INFO - 2015-11-19 22:35:43,999 DEBUG : BROWSER_OUTPUT: 22:35:45 INFO - 2015-11-19 22:35:45,897 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37395/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37395/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:35:46 INFO - 2015-11-19 22:35:46,501 DEBUG : BROWSER_OUTPUT: RSS: Main: 164212736 22:35:46 INFO - 2015-11-19 22:35:46,501 DEBUG : BROWSER_OUTPUT: 22:35:48 INFO - 2015-11-19 22:35:48,605 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37395/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37395/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:35:49 INFO - 2015-11-19 22:35:49,186 DEBUG : BROWSER_OUTPUT: RSS: Main: 172863488 22:35:49 INFO - 2015-11-19 22:35:49,186 DEBUG : BROWSER_OUTPUT: 22:35:51 INFO - 2015-11-19 22:35:51,726 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37395/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37395/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:35:52 INFO - 2015-11-19 22:35:52,311 DEBUG : BROWSER_OUTPUT: RSS: Main: 179490816 22:35:52 INFO - 2015-11-19 22:35:52,312 DEBUG : BROWSER_OUTPUT: 22:35:54 INFO - 2015-11-19 22:35:54,894 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37395/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37395/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:35:55 INFO - 2015-11-19 22:35:55,476 DEBUG : BROWSER_OUTPUT: RSS: Main: 175325184 22:35:55 INFO - 2015-11-19 22:35:55,476 DEBUG : BROWSER_OUTPUT: 22:35:57 INFO - 2015-11-19 22:35:57,249 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37395/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37395/tests/kraken/driver.html?testName=ai-astar) 22:35:57 INFO - 2015-11-19 22:35:57,499 DEBUG : BROWSER_OUTPUT: RSS: Main: 234958848 22:35:57 INFO - 2015-11-19 22:35:57,499 DEBUG : BROWSER_OUTPUT: 22:35:57 INFO - 2015-11-19 22:35:57,501 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:35:57 INFO - 2015-11-19 22:35:57,501 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:35:57 INFO - 2015-11-19 22:35:57,501 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:35:57 INFO - 2015-11-19 22:35:57,501 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:35:57 INFO - 2015-11-19 22:35:57,501 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;111;107;114;119;114;101;110;103;110 22:35:57 INFO - 2015-11-19 22:35:57,501 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;128;157;173;131;163;153;133;169;132 22:35:57 INFO - 2015-11-19 22:35:57,501 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;162;163;163;162;162;164;163;161;161 22:35:57 INFO - 2015-11-19 22:35:57,501 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;82;93;72;75;73;100;107;72 22:35:57 INFO - 2015-11-19 22:35:57,501 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;91;126;90;91;91;132;92;92;131 22:35:57 INFO - 2015-11-19 22:35:57,502 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;110;110;109;109;109;109;109;109 22:35:57 INFO - 2015-11-19 22:35:57,502 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;147;147;146;146;146;146;147;146 22:35:57 INFO - 2015-11-19 22:35:57,502 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;95;95;95;95;95;95;95 22:35:57 INFO - 2015-11-19 22:35:57,502 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;68;69;70;70;69;68;70;78;67;67 22:35:57 INFO - 2015-11-19 22:35:57,502 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;70;69;70;69;69;70;69;70;69 22:35:57 INFO - 2015-11-19 22:35:57,502 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;85;84;85;83;85;84;84;86;84 22:35:57 INFO - 2015-11-19 22:35:57,502 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;129;126;121;126;127;130;131;121;120 22:35:57 INFO - 2015-11-19 22:35:57,502 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;139;146;154;155;141;152;148;144;139 22:35:57 INFO - 2015-11-19 22:35:57,502 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;67;67;68;71;68;69;69;69;67 22:35:57 INFO - 2015-11-19 22:35:57,502 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:35:57 INFO - 2015-11-19 22:35:57,502 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:35:57 INFO - 2015-11-19 22:35:57,502 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1005 22:35:57 INFO - 2015-11-19 22:35:57,502 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:35:57 INFO - 2015-11-19 22:35:57,502 DEBUG : BROWSER_OUTPUT: __startTimestamp1448001357499__endTimestamp 22:35:57 INFO - 2015-11-19 22:35:57,503 DEBUG : BROWSER_OUTPUT: 22:35:57 INFO - 2015-11-19 22:35:57,506 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:35:57 INFO - 2015-11-19 22:35:57,506 DEBUG : BROWSER_OUTPUT: Number of tests: 14 22:35:57 INFO - 2015-11-19 22:35:57,506 DEBUG : BROWSER_OUTPUT: 22:35:57 INFO - 2015-11-19 22:35:57,506 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.90 Median:110.50 stddev:5.30 (4.8%) stddev-sans-first:5.62 22:35:57 INFO - 2015-11-19 22:35:57,506 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 107.0 114.0 119.0 114.0 101.0 110.0 103.0 110.0 22:35:57 INFO - 2015-11-19 22:35:57,506 DEBUG : BROWSER_OUTPUT: 22:35:57 INFO - 2015-11-19 22:35:57,506 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.40 Median:156.00 stddev:16.98 (10.9%) stddev-sans-first:17.89 22:35:57 INFO - 2015-11-19 22:35:57,506 DEBUG : BROWSER_OUTPUT: Values: 155.0 128.0 157.0 173.0 131.0 163.0 153.0 133.0 169.0 132.0 22:35:57 INFO - 2015-11-19 22:35:57,506 DEBUG : BROWSER_OUTPUT: 22:35:57 INFO - 2015-11-19 22:35:57,506 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 22:35:57 INFO - 2015-11-19 22:35:57,506 DEBUG : BROWSER_OUTPUT: Values: 163.0 162.0 163.0 163.0 162.0 162.0 164.0 163.0 161.0 161.0 22:35:57 INFO - 2015-11-19 22:35:57,507 DEBUG : BROWSER_OUTPUT: 22:35:57 INFO - 2015-11-19 22:35:57,507 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.00 Median:73.00 stddev:13.17 (18.0%) stddev-sans-first:13.56 22:35:57 INFO - 2015-11-19 22:35:57,507 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 82.0 93.0 72.0 75.0 73.0 100.0 107.0 72.0 22:35:57 INFO - 2015-11-19 22:35:57,507 DEBUG : BROWSER_OUTPUT: 22:35:57 INFO - 2015-11-19 22:35:57,507 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.70 Median:91.00 stddev:18.68 (20.5%) stddev-sans-first:19.33 22:35:57 INFO - 2015-11-19 22:35:57,507 DEBUG : BROWSER_OUTPUT: Values: 91.0 91.0 126.0 90.0 91.0 91.0 132.0 92.0 92.0 131.0 22:35:57 INFO - 2015-11-19 22:35:57,507 DEBUG : BROWSER_OUTPUT: 22:35:57 INFO - 2015-11-19 22:35:57,507 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 22:35:57 INFO - 2015-11-19 22:35:57,507 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 110.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 22:35:57 INFO - 2015-11-19 22:35:57,507 DEBUG : BROWSER_OUTPUT: 22:35:57 INFO - 2015-11-19 22:35:57,507 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 22:35:57 INFO - 2015-11-19 22:35:57,507 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 147.0 147.0 146.0 146.0 146.0 146.0 147.0 146.0 22:35:57 INFO - 2015-11-19 22:35:57,507 DEBUG : BROWSER_OUTPUT: 22:35:57 INFO - 2015-11-19 22:35:57,507 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 22:35:57 INFO - 2015-11-19 22:35:57,507 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 22:35:57 INFO - 2015-11-19 22:35:57,508 DEBUG : BROWSER_OUTPUT: 22:35:57 INFO - 2015-11-19 22:35:57,508 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:69.60 Median:69.50 stddev:3.17 (4.6%) stddev-sans-first:3.31 22:35:57 INFO - 2015-11-19 22:35:57,508 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 70.0 70.0 69.0 68.0 70.0 78.0 67.0 67.0 22:35:57 INFO - 2015-11-19 22:35:57,508 DEBUG : BROWSER_OUTPUT: 22:35:57 INFO - 2015-11-19 22:35:57,508 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:69.50 stddev:0.67 (1.0%) stddev-sans-first:0.53 22:35:57 INFO - 2015-11-19 22:35:57,508 DEBUG : BROWSER_OUTPUT: Values: 68.0 70.0 69.0 70.0 69.0 69.0 70.0 69.0 70.0 69.0 22:35:57 INFO - 2015-11-19 22:35:57,508 DEBUG : BROWSER_OUTPUT: 22:35:57 INFO - 2015-11-19 22:35:57,508 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:84.50 stddev:0.84 (1.0%) stddev-sans-first:0.88 22:35:57 INFO - 2015-11-19 22:35:57,508 DEBUG : BROWSER_OUTPUT: Values: 84.0 85.0 84.0 85.0 83.0 85.0 84.0 84.0 86.0 84.0 22:35:57 INFO - 2015-11-19 22:35:57,508 DEBUG : BROWSER_OUTPUT: 22:35:57 INFO - 2015-11-19 22:35:57,508 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:127.00 stddev:3.91 (3.1%) stddev-sans-first:4.12 22:35:57 INFO - 2015-11-19 22:35:57,508 DEBUG : BROWSER_OUTPUT: Values: 127.0 129.0 126.0 121.0 126.0 127.0 130.0 131.0 121.0 120.0 22:35:57 INFO - 2015-11-19 22:35:57,508 DEBUG : BROWSER_OUTPUT: 22:35:57 INFO - 2015-11-19 22:35:57,509 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.70 Median:147.00 stddev:6.33 (4.3%) stddev-sans-first:6.23 22:35:57 INFO - 2015-11-19 22:35:57,509 DEBUG : BROWSER_OUTPUT: Values: 139.0 139.0 146.0 154.0 155.0 141.0 152.0 148.0 144.0 139.0 22:35:57 INFO - 2015-11-19 22:35:57,509 DEBUG : BROWSER_OUTPUT: 22:35:57 INFO - 2015-11-19 22:35:57,509 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:69.00 stddev:1.26 (1.8%) stddev-sans-first:1.32 22:35:57 INFO - 2015-11-19 22:35:57,509 DEBUG : BROWSER_OUTPUT: Values: 69.0 67.0 67.0 68.0 71.0 68.0 69.0 69.0 69.0 67.0 22:35:57 INFO - 2015-11-19 22:35:57,509 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:35:57 INFO - 2015-11-19 22:35:57,509 DEBUG : BROWSER_OUTPUT: 22:35:58 INFO - 2015-11-19 22:35:58,397 INFO : Browser exited with error code: 0 22:35:58 INFO - 2015-11-19 22:35:58,452 INFO : Completed test kraken (00:01:00) 22:35:58 INFO - 2015-11-19 22:35:58,452 INFO : Starting test v8_7 22:35:58 INFO - 2015-11-19 22:35:58,452 DEBUG : operating with platform_type : linux_ 22:35:58 INFO - 2015-11-19 22:35:58,452 INFO : Initialising browser for v8_7 test... 22:35:58 INFO - 2015-11-19 22:35:58,458 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEHrcwd/profile http://localhost:37395/getInfo.html 22:36:02 INFO - 2015-11-19 22:36:02,821 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:36:02 INFO - 2015-11-19 22:36:02,821 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:36:02 INFO - 2015-11-19 22:36:02,821 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:36:02 INFO - 2015-11-19 22:36:02,821 DEBUG : BROWSER_OUTPUT: __metrics 22:36:02 INFO - 2015-11-19 22:36:02,958 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:36:04 INFO - 2015-11-19 22:36:04,230 INFO : Browser initialized. 22:36:04 INFO - 2015-11-19 22:36:04,230 INFO : Running cycle 1/1 for v8_7 test... 22:36:04 INFO - 2015-11-19 22:36:04,231 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEHrcwd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:36:16 INFO - 2015-11-19 22:36:16,097 DEBUG : BROWSER_OUTPUT: RSS: Main: 141811712 22:36:16 INFO - 2015-11-19 22:36:16,097 DEBUG : BROWSER_OUTPUT: 22:36:37 INFO - 2015-11-19 22:36:37,521 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37395/tests/v8_7/run.html (next: http://localhost:37395/tests/v8_7/run.html) 22:36:37 INFO - 2015-11-19 22:36:37,767 DEBUG : BROWSER_OUTPUT: RSS: Main: 435929088 22:36:37 INFO - 2015-11-19 22:36:37,767 DEBUG : BROWSER_OUTPUT: 22:36:37 INFO - 2015-11-19 22:36:37,767 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:36:37 INFO - 2015-11-19 22:36:37,767 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:36:37 INFO - 2015-11-19 22:36:37,767 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:36:37 INFO - 2015-11-19 22:36:37,767 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:36:37 INFO - 2015-11-19 22:36:37,767 DEBUG : BROWSER_OUTPUT: |0;Richards;163.50555918901242 22:36:37 INFO - 2015-11-19 22:36:37,767 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;192.30769230769232 22:36:37 INFO - 2015-11-19 22:36:37,768 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.50490883590464 22:36:37 INFO - 2015-11-19 22:36:37,768 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5035.175879396985 22:36:37 INFO - 2015-11-19 22:36:37,768 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1978.2608695652175 22:36:37 INFO - 2015-11-19 22:36:37,768 DEBUG : BROWSER_OUTPUT: |5;Earley;793.6507936507936 22:36:37 INFO - 2015-11-19 22:36:37,768 DEBUG : BROWSER_OUTPUT: |6;Boyer;12469.135802469136 22:36:37 INFO - 2015-11-19 22:36:37,768 DEBUG : BROWSER_OUTPUT: |7;RegExp;26500 22:36:37 INFO - 2015-11-19 22:36:37,768 DEBUG : BROWSER_OUTPUT: |8;Splay;600.4756242568371 22:36:37 INFO - 2015-11-19 22:36:37,768 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4854.368932038835 22:36:37 INFO - 2015-11-19 22:36:37,768 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:36:37 INFO - 2015-11-19 22:36:37,768 DEBUG : BROWSER_OUTPUT: __startTimestamp1448001397766__endTimestamp 22:36:37 INFO - 2015-11-19 22:36:37,768 DEBUG : BROWSER_OUTPUT: 22:36:37 INFO - 2015-11-19 22:36:37,770 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:36:37 INFO - 2015-11-19 22:36:37,770 DEBUG : BROWSER_OUTPUT: Number of tests: 10 22:36:37 INFO - 2015-11-19 22:36:37,770 DEBUG : BROWSER_OUTPUT: 22:36:37 INFO - 2015-11-19 22:36:37,770 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.51 Median:163.51 stddev:0.00 (0.0%) 22:36:37 INFO - 2015-11-19 22:36:37,770 DEBUG : BROWSER_OUTPUT: Values: 163.5 22:36:37 INFO - 2015-11-19 22:36:37,770 DEBUG : BROWSER_OUTPUT: 22:36:37 INFO - 2015-11-19 22:36:37,770 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:192.31 Median:192.31 stddev:0.00 (0.0%) 22:36:37 INFO - 2015-11-19 22:36:37,771 DEBUG : BROWSER_OUTPUT: Values: 192.3 22:36:37 INFO - 2015-11-19 22:36:37,771 DEBUG : BROWSER_OUTPUT: 22:36:37 INFO - 2015-11-19 22:36:37,771 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.50 Median:280.50 stddev:0.00 (0.0%) 22:36:37 INFO - 2015-11-19 22:36:37,771 DEBUG : BROWSER_OUTPUT: Values: 280.5 22:36:37 INFO - 2015-11-19 22:36:37,771 DEBUG : BROWSER_OUTPUT: 22:36:37 INFO - 2015-11-19 22:36:37,771 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5035.18 Median:5035.18 stddev:0.00 (0.0%) 22:36:37 INFO - 2015-11-19 22:36:37,771 DEBUG : BROWSER_OUTPUT: Values: 5035.2 22:36:37 INFO - 2015-11-19 22:36:37,771 DEBUG : BROWSER_OUTPUT: 22:36:37 INFO - 2015-11-19 22:36:37,772 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1978.26 Median:1978.26 stddev:0.00 (0.0%) 22:36:37 INFO - 2015-11-19 22:36:37,772 DEBUG : BROWSER_OUTPUT: Values: 1978.3 22:36:37 INFO - 2015-11-19 22:36:37,772 DEBUG : BROWSER_OUTPUT: 22:36:37 INFO - 2015-11-19 22:36:37,772 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:793.65 Median:793.65 stddev:0.00 (0.0%) 22:36:37 INFO - 2015-11-19 22:36:37,772 DEBUG : BROWSER_OUTPUT: Values: 793.7 22:36:37 INFO - 2015-11-19 22:36:37,772 DEBUG : BROWSER_OUTPUT: 22:36:37 INFO - 2015-11-19 22:36:37,772 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12469.14 Median:12469.14 stddev:0.00 (0.0%) 22:36:37 INFO - 2015-11-19 22:36:37,773 DEBUG : BROWSER_OUTPUT: Values: 12469.1 22:36:37 INFO - 2015-11-19 22:36:37,773 DEBUG : BROWSER_OUTPUT: 22:36:37 INFO - 2015-11-19 22:36:37,773 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26500.00 Median:26500.00 stddev:0.00 (0.0%) 22:36:37 INFO - 2015-11-19 22:36:37,773 DEBUG : BROWSER_OUTPUT: Values: 26500.0 22:36:37 INFO - 2015-11-19 22:36:37,773 DEBUG : BROWSER_OUTPUT: 22:36:37 INFO - 2015-11-19 22:36:37,773 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:600.48 Median:600.48 stddev:0.00 (0.0%) 22:36:37 INFO - 2015-11-19 22:36:37,773 DEBUG : BROWSER_OUTPUT: Values: 600.5 22:36:37 INFO - 2015-11-19 22:36:37,773 DEBUG : BROWSER_OUTPUT: 22:36:37 INFO - 2015-11-19 22:36:37,773 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 22:36:37 INFO - 2015-11-19 22:36:37,773 DEBUG : BROWSER_OUTPUT: Values: 4854.4 22:36:37 INFO - 2015-11-19 22:36:37,773 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:36:37 INFO - 2015-11-19 22:36:37,773 DEBUG : BROWSER_OUTPUT: 22:36:38 INFO - 2015-11-19 22:36:38,673 INFO : Browser exited with error code: 0 22:36:38 INFO - 2015-11-19 22:36:38,688 INFO : Completed test v8_7 (00:00:40) 22:36:38 INFO - 2015-11-19 22:36:38,779 INFO : Completed test suite (00:20:18) 22:36:38 INFO - 2015-11-19 22:36:38,780 DEBUG : Working with test: dromaeo_css 22:36:38 INFO - 2015-11-19 22:36:38,780 DEBUG : Generating results file: dromaeo_css 22:36:38 INFO - 2015-11-19 22:36:38,781 DEBUG : Working with test: kraken 22:36:38 INFO - 2015-11-19 22:36:38,781 DEBUG : Generating results file: kraken 22:36:38 INFO - 2015-11-19 22:36:38,781 INFO : javascript benchmark 22:36:38 INFO - 2015-11-19 22:36:38,782 DEBUG : Working with test: v8_7 22:36:38 INFO - 2015-11-19 22:36:38,782 DEBUG : Generating results file: v8_7 22:36:38 INFO - 2015-11-19 22:36:38,782 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:36:38 INFO - 2015-11-19 22:36:38,832 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 22:36:38 INFO - 2015-11-19 22:36:38,833 DEBUG : process_Request line: dromaeo_css 6509.68 graph.html#tests=[[72,132,35]] 22:36:38 INFO - 2015-11-19 22:36:38,833 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:36:38 INFO - 2015-11-19 22:36:38,862 DEBUG : process_Request line: kraken 1520.40 graph.html#tests=[[232,132,35]] 22:36:38 INFO - 2015-11-19 22:36:38,862 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:36:38 INFO - 2015-11-19 22:36:38,897 DEBUG : process_Request line: v8_7 19801.45 graph.html#tests=[[230,132,35]] 22:36:38 INFO - 2015-11-19 22:36:38,898 INFO : javascript benchmark 22:36:38 INFO - 2015-11-19 22:36:38,901 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2681.8390896546207, 2757.4209416022636, 2765.7925655575837, 2778.7638050765686, 2779.749822515974, 4611.861644150673, 4730.6925049871825, 4749.501302363254, 4780.426348838136, 4790.8802279942975, 4706.717596944177, 4719.9292010619865, 4781.235002399617, 4786.664933454659, 4851.708897466146, 4424.823007079721, 4424.845130420436, 4434.17967675981, 4439.889002774924, 4507.09858028394, 4357.934630980538, 4446.066326071529, 4449.154660614473, 4470.910581788362, 4521.502634710179, 4280.828766849322, 4368.060866913597, 4372.584604462602, 4373.518912919576, 4376.89057773555, 4465.1739428205565, 4467.642588592905, 4470.642348612103, 4472.776361181928, 4513.1650644630845, 4460.754658493782, 4464.2187617166865, 4470.75410852403, 4490.59584637381, 4509.0, 4554.180247555439, 4675.322078298662, 4708.693934894221, 4713.434387873443, 4816.879578010543, 5196.740162991873, 5211.895762084775, 5217.373915130209, 5225.08561001827, 5228.032813929397, 5225.242339860699, 5229.607779416559, 5233.241180028913, 5258.710770907599, 5282.577393808486, 4567.840125595621, 4626.606738427204, 4691.319758634979, 4695.319178719066, 4698.671093023456, 5306.442823503554, 5361.51746342831, 5364.061289274361, 5370.946290537123, 5373.462653734595, 5128.3845938486875, 5169.560587350042, 5172.560332371715, 5179.741012949337, 5227.503387178212, 4883.0, 4970.931249781314, 4995.775190116454, 4996.400431948116, 5088.949110508922, 5119.667221630582, 5122.436531981479, 5123.180291153398, 5130.204818253177, 5134.666246693953, 5109.131447653907, 5115.283860259567, 5117.2068329409, 5121.359830021247, 5166.199239117943, 4102.938455923164, 4110.794460276974, 4168.874933751932, 4209.536950935395, 4213.641840443596, 3735.215604722984, 3739.962600374016, 3759.323321802102, 3772.490713753663, 3799.297130030953, 4380.299152135643, 4385.7149285296355, 4385.912281754347, 4422.800973956179, 4427.512973572904, 4913.140200464904, 5052.8484145475695, 5147.3051138096625, 5188.247704082887, 5190.40310364313, 4357.085012147421, 4391.121775644884, 4418.315161150027, 4421.314696222091, 4463.285874260103, 4594.839180628662, 4604.608608268268, 4606.170889239902, 4609.746463944448, 4643.953560464352, 4677.555632214934, 4782.043591281688, 4787.832425865078, 4942.159832828428, 4960.553550180501, 5100.770465329143, 5214.9478505214465, 5219.530242278213, 5224.0, 5259.289995850511, 4955.40535135786, 4957.0, 4968.577670898014, 5017.874553136201, 5021.221710634857, 4876.756162191805, 4990.201567749143, 5175.663581867167, 5177.870553236048, 5179.430262671179, 4972.378452693413, 5026.170681837456, 5048.671836330626, 5060.645754797129, 5078.771455284447, 5003.074431230234, 5026.874328141826, 5031.446540880427, 5039.722815245197, 5088.618353623419, 4806.182948898626, 4929.383827021622, 4971.701697898137, 5032.119379108714, 5032.220005899091, 4747.881302967454, 4869.0261947609915, 4901.436334821398, 4918.2868484068895, 4926.162552366035, 5076.213186956028, 5082.949170508247, 5083.974580127076, 5087.821926232564, 5093.821716239914, 4941.703497790144, 4951.3810773653295, 4961.70229786214, 4963.677360971526, 5005.599552035901], "unit": "ms", "name": "dojo.html", "value": 4711.575358271519}, {"lowerIsBetter": false, "replicates": [565.9614607195793, 569.7009070238125, 571.3600767140803, 577.80354679409, 585.408737175453, 27997.300067498323, 28527.42945141096, 35882.64117358826, 36327.0, 36343.4548481773, 39258.41112383317, 39811.60188398115, 39947.80026099872, 40163.397549036716, 40202.59797402025, 6870.862582748342, 7810.101838288584, 7961.641726122339, 7967.322777563914, 7975.960120199391, 6996.370326670599, 7105.786826395217, 7111.07556017717, 7113.502054856162, 9924.702258932244, 10140.340877842953, 10215.846762298572, 10253.43606101664, 10256.589736410535, 10260.33307834992, 10076.89923100767, 10122.595096196143, 10171.033751793568, 10176.982301769764, 10189.490525473697, 7149.9642501787675, 7342.118945726494, 7352.63236838156, 7353.154387245429, 10217.080462758313, 37067.81466092679, 37676.62323376758, 37706.24587508262, 37711.62288377109, 37743.62256377456, 2894.9276268093254, 2934.4277865816175, 2950.5279155335043, 2967.139529536432, 3022.1689035515187, 28274.0, 28405.289867753472, 28614.856925715445, 28696.85651571729, 28790.0, 3184.1561986073707, 3202.871885124592, 3277.6886195811358, 3332.6000879894327, 3481.8433170507387, 218978.0, 219542.0, 221172.0, 221553.0, 221816.0, 48446.75776621094, 48716.0, 48741.26888096681, 48777.756111219926, 48845.511544884095, 59575.70212148998, 60048.0, 60082.0, 60084.39915600788, 60134.69932650309, 14334.21161836109, 14890.255487225812, 14987.700245995236, 14997.17515536656, 14998.700025999418, 11556.191066625424, 11653.0, 11659.242149260272, 11665.183437159487, 11669.59156429521, 18802.431850930676, 19289.614207715767, 19475.415737527896, 19479.805201948082, 19518.40680742275, 7626.54240745557, 7753.457257991887, 7829.95304226201, 7840.647170877324, 7918.841623167505, 747.1034758290074, 839.1063517353998, 887.1882227761655, 911.2209061252667, 1042.2652030318607, 25922.481550369263, 25938.092166774073, 25961.0, 26232.86883565608, 26262.34344141412, 850.4004676702909, 945.5036106044245, 963.8361478548663, 972.9027097290356, 1032.0866033560203, 13404.463821447032, 13885.86114138866, 13886.546129623084, 13888.791668124986, 14060.22668753208, 312060.0, 314590.0, 315132.0, 316496.0, 316715.0, 48005.75997119992, 48136.75931620319, 48406.27390589144, 48597.757011214715, 48676.0, 1139.4473680265064, 1151.8272259161026, 1154.3939431798374, 1157.1148071725138, 1179.4102948525738, 25726.742732572435, 26288.60567091457, 26445.80582485778, 26693.866530667998, 26749.33126671771, 36137.0965725859, 36685.449718253716, 37444.0, 37863.43204851874, 37897.62102378941, 234441.0, 237989.0, 238836.0, 238976.0, 240891.0, 28916.566251506665, 29332.0, 29577.26056848596, 29874.701252987194, 29919.102426927227, 39290.410643839794, 39565.91744056774, 39804.40293395543, 40006.999825004605, 40582.188356232116, 33031.50452743259, 33405.16487087842, 33524.329513410084, 33816.15681762982, 33928.83035584806, 33254.004759714495, 33817.83091084529, 33837.66162338443, 33928.15179620529, 33944.830275848464, 35359.292814144086, 35380.292394152486, 35725.10687232736, 35846.820765896, 36228.0, 27131.0, 27327.86336068307, 28750.7124928748, 29047.12858614245, 29054.854725726236, 23764.524709505367, 24225.757742423055, 24391.0, 24426.75573244245, 24580.452616266048], "unit": "ms", "name": "ext.html", "value": 17134.243042961694}, {"lowerIsBetter": false, "replicates": [321.699211237493, 337.3270325700228, 339.5806179368478, 344.8672261179446, 347.87824261508473, 12153.574624888131, 12525.68685782856, 15090.396384144635, 15120.697586048273, 15878.206089695526, 14719.484818031371, 15139.832201358386, 16304.592385190375, 16515.917420412912, 16529.338826446958, 4979.278004689327, 6225.128482012499, 6504.252011018722, 6508.7396504140015, 6509.153810004716, 3842.1163132479546, 3939.113699417637, 6338.809835704913, 6558.409743123118, 6573.572717773353, 6376.202974628171, 6519.413252807246, 6527.640979746112, 6538.7384504619995, 6549.148610680605, 6468.773592924249, 6499.252585952581, 6503.934960650404, 6505.056766768816, 6505.121808555832, 5754.827355179351, 5948.910766338508, 5957.285125784891, 6217.533684973645, 6235.438810507076, 19506.609867802705, 19718.0, 20040.298589549442, 20066.598668026705, 20658.896705516378, 1991.7709463411747, 2002.6795712686046, 2050.302897015007, 2053.3121404329568, 2083.656196727538, 13799.172049677052, 13934.372953217027, 14040.578782636538, 14040.859591404058, 14138.939579531576, 1894.7536820213284, 1908.5991941692123, 1936.6417212815534, 1939.9515012124668, 1946.8247857692875, 57942.420575794546, 62596.0, 62881.685591571746, 63936.0, 64310.3568964309, 14892.776608350883, 15476.303566339542, 15482.380704771684, 15491.5352539424, 15511.767323490156, 23218.767812322, 23274.53450930972, 23424.297271081894, 23490.295291141294, 23518.58888466663, 8564.357673174536, 8570.95714521436, 8586.184312490303, 8597.785055373666, 8659.6103175356, 7168.426525877917, 7331.853362932711, 7357.963210183915, 7378.594177320191, 7402.481826272109, 6596.307387724316, 7564.962175189199, 7633.084029916335, 7639.083310002835, 7651.1583725790115, 1739.1825841854309, 1750.851177649914, 1768.1336145288717, 1770.0795586295312, 2172.5654869026257, 728.4682182007165, 809.1948511231362, 862.1593945902695, 872.2716531696104, 884.6151923913119, 14947.327370268364, 15694.372225110868, 15775.211239437982, 15785.68428631421, 16268.837311626969, 831.2061980808313, 832.2592892325835, 844.462390516494, 845.9577021148918, 863.6070587882498, 9156.130167634064, 9438.48088355147, 9444.811103777885, 9450.952745236367, 9481.956984731674, 418930.0, 453880.0, 459223.0, 473133.0, 473877.0, 60008.39991600028, 60138.39861601416, 61352.0, 62117.68941155265, 66768.0, 1011.9291649584459, 1035.963741269052, 1039.9740006499899, 1041.557338131291, 1058.6771034834449, 14417.0, 14473.85526144725, 14561.635959101108, 14809.555713328617, 14983.0, 32530.674693252764, 32810.0, 33132.33735325232, 33626.159346016546, 33693.66306336905, 38740.6125938737, 38842.223155536165, 39838.60161398349, 40384.3942340871, 41494.96262593339, 7974.880376794236, 8190.221928916743, 8279.37904657141, 8380.874286885824, 8389.11914248995, 9876.950615246878, 10016.799664006825, 15490.0, 15915.363385464452, 16023.599410014844, 13127.540536081191, 13226.933865330611, 13419.463221471031, 13465.730685386434, 13586.592402227949, 13480.0, 13649.522266720616, 13740.793888091886, 14172.362243699265, 14229.0, 14377.856221437652, 14419.0, 14688.41246350134, 14801.111933284037, 14803.0378025428, 8440.620172092147, 8553.61508732121, 8647.56762161902, 8734.213920747163, 8753.0, 9294.117058879396, 9409.341346105706, 13176.341182940623, 14070.648233793827, 14193.787093193818], "unit": "ms", "name": "jquery.html", "value": 9027.84614275526}, {"lowerIsBetter": false, "replicates": [1462.6270301073225, 1643.7205675035243, 1700.056468659894, 1724.051771525661, 1728.9567760805985, 6537.0, 6895.965520172398, 7026.473014523918, 7032.50772445929, 7039.6480175991255, 7170.7490237841685, 7233.24050974648, 7266.273372662731, 7269.491135620508, 7277.9636101819415, 1792.982070179301, 1826.3607737291975, 2072.585482903418, 2142.635751922173, 2168.360333701562, 2142.507223338633, 2152.268228802207, 2152.849300548962, 2153.3755210988793, 2155.2133471282946, 2074.0770357191054, 2133.359992002393, 2145.0776166248506, 2146.334636262756, 2146.731658542682, 1780.964380712385, 1819.5269230000229, 2066.7209926659857, 2100.85294029418, 2103.6634138537916, 2125.6173888700027, 2132.7120838686733, 2154.827613790893, 2158.5143342747915, 2158.892055397224, 7327.194008659043, 7383.40932725386, 7389.298016688406, 7390.852182956311, 7398.0, 4404.0531285773395, 4464.866054018352, 4506.233940230136, 4509.706869053533, 4516.938519447927, 2848.1028476029983, 2900.318425170083, 2930.0477344862793, 2951.719586639287, 2969.2280007198283, 881.3433991676242, 884.5621417398429, 895.9641614335419, 920.700772249015, 950.4819873169139, 10026.147777438926, 10037.849432258448, 10066.597336106546, 10071.798564028679, 10085.89914100857, 3994.0813612868624, 4067.450894129314, 4112.691548133902, 4121.402396652468, 4133.91732165355, 8562.700305489278, 8589.055203927563, 8598.828023439497, 8611.526366049802, 8612.8708069379, 4422.491413487426, 4432.180046691373, 4441.222786012435, 4441.333799930037, 4443.888902777457, 3987.5414327352146, 4019.2765302245875, 4023.7183397161916, 4025.9597404025585, 4028.1742242840146, 3503.3518799022263, 3513.209527856263, 3531.258435728526, 3534.4698295255403, 3546.4148415511154, 1147.7819214349247, 1150.2925700694013, 1153.9423028848523, 1169.9707507312385, 1172.8709841917382, 744.3115118515352, 815.5962798414822, 836.3434703757642, 836.4688422851533, 840.8528507511161, 6740.528163028639, 6821.658917054127, 6863.210730765926, 6881.380675739208, 6886.51794374389, 1007.6271779441654, 1034.3018462537757, 1037.3257382701304, 1037.7198156497855, 1043.658381134477, 5310.9734451327495, 5395.244665746799, 5395.81114660985, 5405.972970135124, 5409.26974858397, 8481.745547633582, 8654.134586541422, 8770.956145219361, 8837.425567338103, 8864.20222179994, 8794.912050879537, 8806.823863522694, 8808.471491710518, 8813.338999575057, 8824.735257942271, 6722.428593569503, 6817.318268173143, 6904.4131248843405, 6914.0, 6928.861422771617, 6635.2037755469655, 6656.567323123982, 6657.3342665733035, 6666.866662666816, 6670.66646667655, 7717.421193410404, 7782.0, 7823.335016523659, 7850.685972561034, 7942.285194332538, 7987.520748755093, 8172.387070969582, 8205.671773129008, 8286.917130828855, 8304.294134998592, 6398.328175541687, 6403.775867844603, 6454.677266136769, 6455.580387274812, 6462.741490340334, 6931.480138989697, 7000.124984376953, 7001.299870012958, 7005.614691192033, 7016.19313778922, 6573.967130164318, 6646.468282537482, 6720.630365329954, 6753.763618273337, 6861.279565645735, 6511.34886511345, 6517.348265173445, 6549.115869357766, 6657.500687448558, 6679.165104361955, 5873.4126587340925, 6087.330393656605, 6091.725872335667, 6639.867202655823, 6713.496487763339, 5667.716614169358, 6059.272887253558, 6076.33160352352, 6077.118817771487, 6086.72609732572, 6170.074488826712, 6244.812655620339, 6251.562390632612, 6315.115883776367, 6353.8729225416155], "unit": "ms", "name": "mootools.html", "value": 4182.978417040369}, {"lowerIsBetter": false, "replicates": [310.5559050557702, 316.435163233628, 320.0813664782076, 327.81150838267985, 329.2394568546656, 5274.235235890794, 5398.190271459283, 5415.864603384917, 5452.91820622691, 5462.453754624536, 5267.420583735786, 5322.8137015204475, 5355.223492593572, 5390.5418039466595, 5413.729313534327, 4161.542230354658, 4176.519700234481, 4237.597428244312, 4246.57534246576, 4250.128723611652, 4006.3589825627905, 4088.7546747195115, 4240.321548552232, 4242.363645453176, 4253.106847562016, 4067.0849058961794, 4159.958400415987, 4167.979160104195, 4168.541460439349, 4171.395147703581, 4146.751194928283, 4161.854335098287, 4162.375643653446, 4164.00063984643, 4168.791560421997, 3642.0348607619003, 3642.7996460194677, 3645.052286405527, 3648.0, 3652.251288485854, 5247.763850626731, 5248.265242866002, 5256.9474305256845, 5268.209768534713, 5272.92090618641, 4711.528847115295, 4884.340614017134, 4885.169521181408, 4887.120318342697, 4891.706497610155, 5700.0, 5705.1727499512335, 5709.343425506078, 5710.114932185518, 5715.342735585419, 3859.7105217108547, 3908.5895980922164, 3984.900377490557, 4077.3272410052305, 4081.1225586499045, 5893.027650437715, 5968.492678122365, 5988.520918326567, 5990.580659353847, 5995.850103747442, 4218.346156345771, 4219.0507135894795, 4221.810018549173, 4222.9577704223175, 4226.556211597799, 4268.701190916606, 4279.786010699515, 4280.507741609693, 4283.0363168286885, 4290.549492303326, 4695.765211739399, 4852.272159176081, 4853.854384368475, 4867.269909513601, 4871.34236878017, 5695.829125126253, 5697.059985102412, 5697.0599851024945, 5698.430156984268, 5699.344575373802, 1475.542581799624, 1514.48507507448, 1514.9848501515064, 1515.9696806064037, 1517.036681707124, 1019.2814066083394, 1028.7942411517727, 1029.629333439961, 1044.6657069737762, 1048.2190767877828, 4932.161532539477, 4946.233333833262, 4947.233178857283, 4953.390148201849, 4958.082754690394, 5881.852953676193, 5883.941160588425, 5888.411158884077, 5893.911591326134, 5896.086106653475, 4939.234418665113, 4946.258061290835, 4947.455779864212, 4949.925751113737, 4950.925736113961, 3116.8597413116463, 3142.9528557071662, 3184.41088398647, 3192.473241915058, 3200.823954682515, 5552.972235138798, 5564.805231816867, 5569.220309156722, 5570.637908535932, 5578.107502799614, 6033.577649564576, 6042.063480160582, 6043.486303664238, 6044.969775151184, 6055.697215139226, 5551.084071128299, 5554.638948468337, 5556.166575013699, 5559.249501317351, 5561.805336813273, 5762.481376676119, 5948.464638182411, 5956.731947062479, 5965.403459654, 5970.0746384310505, 5599.776008959596, 5728.4271572844045, 5730.742116604846, 5821.155932389695, 5833.649981001154, 5509.889802204014, 5534.05920993424, 5534.640248383842, 5540.307461567304, 5631.070873305859, 4058.939115913323, 4091.6931230158452, 4105.055837157411, 4107.876763697094, 4114.91770164601, 5928.822135335947, 5929.0513517836935, 5932.13983972313, 5939.703014849327, 5943.940560594338, 5503.091989821794, 5622.156676498558, 5626.803061892814, 5691.373948865538, 5725.427457254241, 5656.236408084856, 5709.7145142741865, 5710.971445142914, 5714.428557144252, 5715.914261286167, 5559.082751345983, 5588.804391846428, 5588.888222235614, 5588.888222235614, 5592.944070559242, 5591.860203494783, 5731.770729170953, 5733.541316694738, 5742.856428589152, 5752.9712351437975, 5570.888582228414, 5607.186957891001, 5614.045612245846, 5617.74720137603, 5619.690916999604], "unit": "ms", "name": "prototype.html", "value": 4296.427463897021}, {"lowerIsBetter": false, "replicates": [608.3612207182458, 650.4211251985732, 751.222484728306, 760.3688938181314, 763.1338430880949, 11678.357690327028, 12134.150609457352, 12153.574624888131, 12153.635390938263, 12187.756244875098, 11753.471093800777, 11813.054955603553, 11836.28982261065, 11836.408179591008, 11840.052795776339, 608.5557542993618, 619.8574327904585, 620.3734228429274, 777.1063277231201, 795.5346122518333, 795.49883573349, 796.366888323781, 802.2098233240254, 802.3541049455187, 802.458340620082, 828.3373301358919, 834.253343257784, 834.9540775257359, 835.1189495082685, 835.2315869400167, 638.4700698420323, 645.6319897658336, 818.8812622169812, 831.8419500294924, 832.7252006837729, 617.4566381584222, 618.0821480102045, 618.8050764009367, 619.1888625900041, 619.2074145094286, 12173.391330433444, 12357.814632780515, 12375.381230938507, 12379.690507737288, 12381.195222310522, 10849.891501084967, 11942.104342174285, 12078.577249796303, 12329.383530823423, 12669.0, 9401.294902882242, 9413.76465588359, 9435.858462123073, 9518.476483793389, 9528.618855245782, 3214.180384002088, 3306.272620023591, 3313.2710803623163, 3320.734341252694, 3389.0849470643034, 41288.38067428991, 41514.58485415138, 41613.1677366454, 41662.79168604168, 41674.791626041675, 8790.86813697795, 9614.95192524033, 9683.515824208762, 9751.853722194173, 9819.509024548744, 15318.923405383124, 15337.769933451007, 15348.462803801813, 15386.076835389913, 15491.690166196613, 6173.382661733881, 6303.968480157661, 6419.101325814389, 6501.31736167705, 6505.186851643544, 3518.82405879705, 3549.2457852706525, 3565.3047655706887, 3645.434957581579, 3674.0814796300924, 2774.3618967637153, 2837.120492647286, 2842.1757690270006, 2843.2039029071893, 2866.899658511942, 494.87133345329755, 495.0198606758638, 495.5391485918131, 496.6796416311459, 501.07301492239066, 556.8329501149639, 557.743438018516, 567.7133047810829, 569.5785119011902, 617.0805499805258, 6798.796036118924, 7242.998817123276, 7514.47398682087, 7827.217278272127, 7973.72091976778, 486.5183468366363, 533.3200169783557, 554.7836343825911, 579.2932622200908, 598.0729868703493, 3567.2865426914723, 3619.022863826752, 3656.670899619047, 3696.242270334575, 3962.583928687504, 52441.2133817993, 52492.0, 53372.73313633485, 53853.0, 53865.0, 47357.76321118372, 47366.76316618395, 47605.0, 47637.0, 47708.7614561925, 42123.57876421258, 42793.78603106965, 43546.346804797955, 44166.33750493745, 44215.778921105186, 7975.2423519765525, 7977.641006154853, 8049.14593946654, 8184.713535026245, 8338.332933365195, 33003.66996330006, 33215.335693286484, 33621.83189084039, 33944.98165055052, 34086.0, 38457.615423845404, 38468.0, 48342.75828620834, 48455.51544484651, 48745.26882096842, 10744.946275268574, 10757.515911784145, 10968.506417211085, 11411.657650270505, 11605.30368177912, 11596.884031159918, 11701.824472633087, 11748.882511175121, 11847.466863991314, 12720.427580758704, 10784.568617255221, 10877.945610271898, 10922.836157457803, 11155.0, 11588.94205528967, 11008.834867477155, 11035.448227588427, 11044.392558409365, 11264.267822591506, 11287.153463490107, 10295.691129266133, 10380.896191038295, 10396.0, 10546.525406356579, 10932.234743567873, 9468.0, 9522.816115076655, 9754.902450975684, 9896.257780666334, 9964.352317099656, 8400.789980250544, 8419.678144421392, 8438.789030274293, 8558.031652719785, 8639.352048596505], "unit": "ms", "name": "yui.html", "value": 5809.026660412478}], "name": "dromaeo_css", "value": 6509.677109780023}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 107.0, 114.0, 119.0, 114.0, 101.0, 110.0, 103.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 109.9}, {"lowerIsBetter": true, "replicates": [155.0, 128.0, 157.0, 173.0, 131.0, 163.0, 153.0, 133.0, 169.0, 132.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.4}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 163.0, 163.0, 162.0, 162.0, 164.0, 163.0, 161.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 162.4}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 82.0, 93.0, 72.0, 75.0, 73.0, 100.0, 107.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 82.0}, {"lowerIsBetter": true, "replicates": [91.0, 91.0, 126.0, 90.0, 91.0, 91.0, 132.0, 92.0, 92.0, 131.0], "unit": "ms", "name": "audio-oscillator", "value": 102.7}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 70.0, 70.0, 69.0, 68.0, 70.0, 78.0, 67.0, 67.0], "unit": "ms", "name": "json-parse-financial", "value": 69.6}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 69.0, 70.0, 69.0, 69.0, 70.0, 69.0, 70.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.3}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 84.0, 85.0, 83.0, 85.0, 84.0, 84.0, 86.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.4}, {"lowerIsBetter": true, "replicates": [127.0, 129.0, 126.0, 121.0, 126.0, 127.0, 130.0, 131.0, 121.0, 120.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.8}, {"lowerIsBetter": true, "replicates": [139.0, 139.0, 146.0, 154.0, 155.0, 141.0, 152.0, 148.0, 144.0, 139.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.7}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 67.0, 68.0, 71.0, 68.0, 69.0, 69.0, 69.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.4}], "name": "kraken", "value": 1520.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.50555918901242], "unit": "score", "name": "Richards", "value": 215.90703200000004}, {"lowerIsBetter": false, "replicates": [192.30769230769232], "unit": "score", "name": "DeltaBlue", "value": 343.8135999999999}, {"lowerIsBetter": false, "replicates": [280.50490883590464], "unit": "score", "name": "Encrypt", "value": 948.9352650000003}, {"lowerIsBetter": false, "replicates": [5035.175879396985], "unit": "score", "name": "Decrypt", "value": 52.864290419161705}, {"lowerIsBetter": false, "replicates": [1978.2608695652175], "unit": "score", "name": "RayTrace", "value": 374.06037362637363}, {"lowerIsBetter": false, "replicates": [793.6507936507936], "unit": "score", "name": "Earley", "value": 839.7433799999998}, {"lowerIsBetter": false, "replicates": [12469.135802469136], "unit": "score", "name": "Boyer", "value": 53.449012871287174}, {"lowerIsBetter": false, "replicates": [26500.0], "unit": "score", "name": "RegExp", "value": 34.37679245283018}, {"lowerIsBetter": false, "replicates": [600.4756242568371], "unit": "score", "name": "Splay", "value": 135.7107544554456}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 19801.454566758603}]} 22:36:38 INFO - RETURN: dromaeo_css: 6509.68 22:36:38 INFO - RETURN: kraken: 1520.40 22:36:38 INFO - RETURN: v8_7: 19801.45 22:36:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19801.45"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1520.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6509.68"}}} 22:36:38 INFO - Return code: 0 22:36:38 INFO - # TBPL SUCCESS # 22:36:38 INFO - Running post-action listener: _resource_record_post_action 22:36:38 INFO - Running post-run listener: _resource_record_post_run 22:36:40 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 4096; Write bytes: 510464000; Read time: 8; Write time: 567808 22:36:40 INFO - install - Wall time: 14s; CPU: 15.0%; Read bytes: 0; Write bytes: 230543360; Read time: 0; Write time: 422148 22:36:40 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 4096; Write bytes: 279908352; Read time: 8; Write time: 145660 22:36:40 INFO - Running post-run listener: _upload_blobber_files 22:36:40 INFO - Blob upload gear active. 22:36:40 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 22:36:40 INFO - Copying logs to upload dir... 22:36:40 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1263.061495 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-11-19 22:36:39.609185) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 22:36:39.612473) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=01deea79d00cc2c334834894000001d2-1447999933.960079-964426978 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010242 build_url: 'https://queue.taskcluster.net/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 22:36:39.664099) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:36:39.664418) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=01deea79d00cc2c334834894000001d2-1447999933.960079-964426978 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004546 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:36:39.714326) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 22:36:39.714670) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 22:36:39.715024) ========= ========= Total master_lag: 0.22 =========