builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-007 starttime: 1448291599.37 results: success (0) buildid: 20151123062128 builduid: 563983de6ca948699f612fe25d78c50b revision: bfd81e42d1ddc7071c7fab2598f3099aab30ca92 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 07:13:19.372887) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 07:13:19.373366) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 07:13:19.373705) ========= 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=6ef107882637bc5fc02d78b7000001c2-1448291597.125367-777282226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.003053 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 07:13:19.390494) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 07:13:19.390812) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 07:13:19.404019) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 07:13:19.404506) ========= 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=6ef107882637bc5fc02d78b7000001c2-1448291597.125367-777282226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004638 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 07:13:19.456898) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 07:13:19.457232) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 07:13:19.457623) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 07:13:19.457934) ========= 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=6ef107882637bc5fc02d78b7000001c2-1448291597.125367-777282226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-23 07:13:20-- 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% 84.7M=0s 2015-11-23 07:13:20 (84.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107497 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 07:13:19.580084) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 07:13:19.581137) ========= 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=6ef107882637bc5fc02d78b7000001c2-1448291597.125367-777282226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017478 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 07:13:19.632026) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 07:13:19.632508) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev bfd81e42d1ddc7071c7fab2598f3099aab30ca92 --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 bfd81e42d1ddc7071c7fab2598f3099aab30ca92 --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=6ef107882637bc5fc02d78b7000001c2-1448291597.125367-777282226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-23 07:13:20,678 truncating revision to first 12 chars 2015-11-23 07:13:20,678 Setting DEBUG logging. 2015-11-23 07:13:20,678 attempt 1/10 2015-11-23 07:13:20,678 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/bfd81e42d1dd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 07:13:21,387 unpacking tar archive at: fx-team-bfd81e42d1dd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.976784 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 07:13:20.622688) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 07:13:20.623062) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 07:13:20.630660) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 07:13:20.630964) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 07:13:20.631393) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-11-23 07:13:20.631871) ========= /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=6ef107882637bc5fc02d78b7000001c2-1448291597.125367-777282226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:13:21 INFO - MultiFileLogger online at 20151123 07:13:21 in /builds/slave/test 07:13:21 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 07:13:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:13:21 INFO - {'append_to_log': False, 07:13:21 INFO - 'base_work_dir': '/builds/slave/test', 07:13:21 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:13:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:13:21 INFO - 'branch': 'Fx-Team-Non-PGO', 07:13:21 INFO - 'buildbot_json_path': 'buildprops.json', 07:13:21 INFO - 'config_files': ('talos/linux_config.py',), 07:13:21 INFO - 'default_actions': ('clobber', 07:13:21 INFO - 'read-buildbot-config', 07:13:21 INFO - 'download-and-extract', 07:13:21 INFO - 'populate-webroot', 07:13:21 INFO - 'create-virtualenv', 07:13:21 INFO - 'install', 07:13:21 INFO - 'run-tests'), 07:13:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:13:21 INFO - 'download_minidump_stackwalk': True, 07:13:21 INFO - 'download_symbols': 'ondemand', 07:13:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:13:21 INFO - 'tooltool.py': '/tools/tooltool.py', 07:13:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:13:21 INFO - '/tools/misc-python/virtualenv.py')}, 07:13:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:13:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:13:21 INFO - 'installer_path': 'installer.exe', 07:13:21 INFO - 'log_level': 'info', 07:13:21 INFO - 'log_name': 'talos', 07:13:21 INFO - 'log_to_console': True, 07:13:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:13:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:13:21 INFO - 'opt_config_files': (), 07:13:21 INFO - 'pip_index': False, 07:13:21 INFO - 'sps_profile': False, 07:13:21 INFO - 'sps_profile_interval': 0, 07:13:21 INFO - 'suite': 'dromaeojs', 07:13:21 INFO - 'system_bits': '64', 07:13:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:13:21 INFO - 'title': 'talos-linux64-ix-007', 07:13:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:13:21 INFO - 'use_talos_json': True, 07:13:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:13:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:13:21 INFO - 'work_dir': 'build'} 07:13:21 INFO - ##### 07:13:21 INFO - ##### Running clobber step. 07:13:21 INFO - ##### 07:13:21 INFO - Running pre-action listener: _resource_record_pre_action 07:13:21 INFO - Running main action method: clobber 07:13:21 INFO - rmtree: /builds/slave/test/build 07:13:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:13:22 INFO - Running post-action listener: _resource_record_post_action 07:13:22 INFO - ##### 07:13:22 INFO - ##### Running read-buildbot-config step. 07:13:22 INFO - ##### 07:13:22 INFO - Running pre-action listener: _resource_record_pre_action 07:13:22 INFO - Running main action method: read_buildbot_config 07:13:22 INFO - Using buildbot properties: 07:13:22 INFO - { 07:13:22 INFO - "properties": { 07:13:22 INFO - "buildnumber": 905, 07:13:22 INFO - "product": "firefox", 07:13:22 INFO - "script_repo_revision": "production", 07:13:22 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:13:22 INFO - "repository": "", 07:13:22 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 07:13:22 INFO - "buildid": "20151123062128", 07:13:22 INFO - "slavename": "talos-linux64-ix-007", 07:13:22 INFO - "pgo_build": "False", 07:13:22 INFO - "basedir": "/builds/slave/test", 07:13:22 INFO - "project": "", 07:13:22 INFO - "platform": "ubuntu64_hw", 07:13:22 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:13:22 INFO - "slavebuilddir": "test", 07:13:22 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:13:22 INFO - "branch": "fx-team", 07:13:22 INFO - "repo_path": "integration/fx-team", 07:13:22 INFO - "stage_platform": "linux64", 07:13:22 INFO - "builduid": "563983de6ca948699f612fe25d78c50b", 07:13:22 INFO - "revision": "bfd81e42d1ddc7071c7fab2598f3099aab30ca92" 07:13:22 INFO - }, 07:13:22 INFO - "sourcestamp": { 07:13:22 INFO - "repository": "", 07:13:22 INFO - "hasPatch": false, 07:13:22 INFO - "project": "", 07:13:22 INFO - "branch": "fx-team-linux64-talos", 07:13:22 INFO - "changes": [ 07:13:22 INFO - { 07:13:22 INFO - "category": null, 07:13:22 INFO - "files": [ 07:13:22 INFO - { 07:13:22 INFO - "url": null, 07:13:22 INFO - "name": "https://queue.taskcluster.net/v1/task/TgApCiCTQOmZQbOPyB7oGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 07:13:22 INFO - } 07:13:22 INFO - ], 07:13:22 INFO - "repository": "", 07:13:22 INFO - "rev": "bfd81e42d1ddc7071c7fab2598f3099aab30ca92", 07:13:22 INFO - "who": "felipc@gmail.com", 07:13:22 INFO - "when": 1448291186, 07:13:22 INFO - "number": 6695132, 07:13:22 INFO - "comments": "Bug 1210617 - [e10s] Implement PrivateBrowsingChannel for ExternalHelperAppParent. r=jduell", 07:13:22 INFO - "project": "", 07:13:22 INFO - "at": "Mon 23 Nov 2015 07:06:26", 07:13:22 INFO - "branch": "fx-team-linux64-talos", 07:13:22 INFO - "revlink": "", 07:13:22 INFO - "properties": [ 07:13:22 INFO - [ 07:13:22 INFO - "buildid", 07:13:22 INFO - "20151123062128", 07:13:22 INFO - "Change" 07:13:22 INFO - ], 07:13:22 INFO - [ 07:13:22 INFO - "builduid", 07:13:22 INFO - "563983de6ca948699f612fe25d78c50b", 07:13:22 INFO - "Change" 07:13:22 INFO - ], 07:13:22 INFO - [ 07:13:22 INFO - "pgo_build", 07:13:22 INFO - "False", 07:13:22 INFO - "Change" 07:13:22 INFO - ] 07:13:22 INFO - ], 07:13:22 INFO - "revision": "bfd81e42d1ddc7071c7fab2598f3099aab30ca92" 07:13:22 INFO - } 07:13:22 INFO - ], 07:13:22 INFO - "revision": "bfd81e42d1ddc7071c7fab2598f3099aab30ca92" 07:13:22 INFO - } 07:13:22 INFO - } 07:13:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/TgApCiCTQOmZQbOPyB7oGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 07:13:22 INFO - Running post-action listener: _resource_record_post_action 07:13:22 INFO - ##### 07:13:22 INFO - ##### Running download-and-extract step. 07:13:22 INFO - ##### 07:13:22 INFO - Running pre-action listener: _resource_record_pre_action 07:13:22 INFO - Running main action method: download_and_extract 07:13:22 INFO - mkdir: /builds/slave/test/build/tests 07:13:22 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')]} 07:13:22 INFO - https://queue.taskcluster.net/v1/task/TgApCiCTQOmZQbOPyB7oGw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:13:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TgApCiCTQOmZQbOPyB7oGw/artifacts/public/build/test_packages.json 07:13:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TgApCiCTQOmZQbOPyB7oGw/artifacts/public/build/test_packages.json 07:13:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TgApCiCTQOmZQbOPyB7oGw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 07:13:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TgApCiCTQOmZQbOPyB7oGw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 07:13:22 INFO - Downloaded 1302 bytes. 07:13:22 INFO - Reading from file /builds/slave/test/build/test_packages.json 07:13:22 INFO - Using the following test package requirements: 07:13:22 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:13:22 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:13:22 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:13:22 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:13:22 INFO - u'jsshell-linux-x86_64.zip'], 07:13:22 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:13:22 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:13:22 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:13:22 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:13:22 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:13:22 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:13:22 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:13:22 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:13:22 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:13:22 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:13:22 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:13:22 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:13:22 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:13:22 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')]} 07:13:22 INFO - https://queue.taskcluster.net/v1/task/TgApCiCTQOmZQbOPyB7oGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:13:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TgApCiCTQOmZQbOPyB7oGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:13:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TgApCiCTQOmZQbOPyB7oGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:13:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TgApCiCTQOmZQbOPyB7oGw/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 07:13:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TgApCiCTQOmZQbOPyB7oGw/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 07:13:24 INFO - Downloaded 21341544 bytes. 07:13:24 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 07:13:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:13:24 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 07:13:25 INFO - Return code: 0 07:13:25 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 07:13:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:25 INFO - https://queue.taskcluster.net/v1/task/TgApCiCTQOmZQbOPyB7oGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:13:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TgApCiCTQOmZQbOPyB7oGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:13:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TgApCiCTQOmZQbOPyB7oGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:13:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TgApCiCTQOmZQbOPyB7oGw/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 07:13:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TgApCiCTQOmZQbOPyB7oGw/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 07:13:26 INFO - Downloaded 21341544 bytes. 07:13:26 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 07:13:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:13:26 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 07:13:27 INFO - Return code: 0 07:13:27 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')]} 07:13:27 INFO - https://queue.taskcluster.net/v1/task/TgApCiCTQOmZQbOPyB7oGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:13:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TgApCiCTQOmZQbOPyB7oGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:13:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TgApCiCTQOmZQbOPyB7oGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:13:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TgApCiCTQOmZQbOPyB7oGw/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 07:13:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TgApCiCTQOmZQbOPyB7oGw/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 07:13:31 INFO - Downloaded 11130997 bytes. 07:13:31 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 07:13:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:13:31 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 07:13:31 INFO - Return code: 0 07:13:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:31 INFO - https://queue.taskcluster.net/v1/task/TgApCiCTQOmZQbOPyB7oGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:13:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TgApCiCTQOmZQbOPyB7oGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:13:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TgApCiCTQOmZQbOPyB7oGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:13:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TgApCiCTQOmZQbOPyB7oGw/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 07:13:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TgApCiCTQOmZQbOPyB7oGw/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 07:13:32 INFO - Downloaded 56024515 bytes. 07:13:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TgApCiCTQOmZQbOPyB7oGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:13:32 INFO - mkdir: /builds/slave/test/properties 07:13:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:13:32 INFO - Writing to file /builds/slave/test/properties/build_url 07:13:32 INFO - Contents: 07:13:32 INFO - build_url:https://queue.taskcluster.net/v1/task/TgApCiCTQOmZQbOPyB7oGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:13:32 INFO - Running post-action listener: _resource_record_post_action 07:13:32 INFO - Running post-action listener: set_extra_try_arguments 07:13:32 INFO - ##### 07:13:32 INFO - ##### Running populate-webroot step. 07:13:32 INFO - ##### 07:13:32 INFO - Running pre-action listener: _resource_record_pre_action 07:13:32 INFO - Running main action method: populate_webroot 07:13:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:13:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:13:32 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 07:13:32 INFO - '../fennec_ids.txt'], 07:13:32 INFO - 'tests': ['tcheck2']}, 07:13:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:13:32 INFO - '--tppagecycles', 07:13:32 INFO - '7'], 07:13:32 INFO - 'tests': ['tsvgm']}}, 07:13:32 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:13:32 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:13:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:13:32 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:13:32 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:13:32 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:13:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:13:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:13:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:13:32 INFO - 'talos_options': ['--e10s'], 07:13:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:13:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:13:32 INFO - 'tests': ['damp', 'tps']}, 07:13:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:13:32 INFO - 'talos_options': ['--e10s'], 07:13:32 INFO - 'tests': ['damp', 'tps']}, 07:13:32 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:13:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:13:32 INFO - 'other': {'tests': ['a11yr', 07:13:32 INFO - 'ts_paint', 07:13:32 INFO - 'tpaint', 07:13:32 INFO - 'sessionrestore', 07:13:32 INFO - 'sessionrestore_no_auto_restore']}, 07:13:32 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:13:32 INFO - 'tests': ['a11yr', 07:13:32 INFO - 'ts_paint', 07:13:32 INFO - 'tpaint', 07:13:32 INFO - 'sessionrestore', 07:13:32 INFO - 'sessionrestore_no_auto_restore']}, 07:13:32 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:13:32 INFO - 'tests': ['a11yr', 07:13:32 INFO - 'ts_paint', 07:13:32 INFO - 'tpaint', 07:13:32 INFO - 'sessionrestore', 07:13:32 INFO - 'sessionrestore_no_auto_restore']}, 07:13:32 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:13:32 INFO - 'tests': ['a11yr', 07:13:32 INFO - 'ts_paint', 07:13:32 INFO - 'tpaint', 07:13:32 INFO - 'sessionrestore', 07:13:32 INFO - 'sessionrestore_no_auto_restore']}, 07:13:32 INFO - 'other_l64': {'tests': ['a11yr', 07:13:32 INFO - 'ts_paint', 07:13:32 INFO - 'tpaint', 07:13:32 INFO - 'sessionrestore', 07:13:32 INFO - 'sessionrestore_no_auto_restore']}, 07:13:32 INFO - 'other_nol64': {'tests': ['a11yr', 07:13:32 INFO - 'ts_paint', 07:13:32 INFO - 'tpaint', 07:13:32 INFO - 'sessionrestore', 07:13:32 INFO - 'sessionrestore_no_auto_restore']}, 07:13:32 INFO - 'svgr': {'tests': ['tsvgx', 07:13:32 INFO - 'tsvgr_opacity', 07:13:32 INFO - 'tart', 07:13:32 INFO - 'tscrollx', 07:13:32 INFO - 'cart']}, 07:13:32 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:13:32 INFO - 'tests': ['tsvgx', 07:13:32 INFO - 'tsvgr_opacity', 07:13:32 INFO - 'tart', 07:13:32 INFO - 'tscrollx', 07:13:32 INFO - 'cart']}, 07:13:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:13:32 INFO - 'tests': ['tp5o']}, 07:13:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:13:32 INFO - 'talos_options': ['--e10s'], 07:13:32 INFO - 'tests': ['tp5o']}, 07:13:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:13:32 INFO - 'talos_options': ['--xperf_path', 07:13:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:13:32 INFO - 'tests': ['tp5n']}, 07:13:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:13:32 INFO - 'talos_options': ['--e10s', 07:13:32 INFO - '--xperf_path', 07:13:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:13:32 INFO - 'tests': ['tp5n']}}, 07:13:32 INFO - 'talos.zip': {'path': '', 07:13:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:13:32 INFO - Running post-action listener: _resource_record_post_action 07:13:32 INFO - ##### 07:13:32 INFO - ##### Running create-virtualenv step. 07:13:32 INFO - ##### 07:13:32 INFO - Running pre-action listener: _resource_record_pre_action 07:13:32 INFO - Running main action method: create_virtualenv 07:13:32 INFO - Creating virtualenv /builds/slave/test/build/venv 07:13:32 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 07:13:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:13:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:13:32 INFO - Using real prefix '/usr' 07:13:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:13:33 INFO - Installing distribute.............................................................................................................................................................................................done. 07:13:35 INFO - Installing pip.................done. 07:13:35 INFO - Return code: 0 07:13:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:13:35 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')]} 07:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:35 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')]} 07:13:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:35 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 0x7f8160187c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1510900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1556b70>, '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 0x15a7dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a8250>, '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': '6ef107882637bc5fc02d78b7000001c2-1448291597.125367-777282226', '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 07:13:35 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 07:13:35 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 07:13:35 INFO - Using env: {'DISPLAY': ':0', 07:13:35 INFO - 'HOME': '/home/cltbld', 07:13:35 INFO - 'LANG': 'en_US.UTF-8', 07:13:35 INFO - 'LANGUAGE': 'en_US:en', 07:13:35 INFO - 'LOGNAME': 'cltbld', 07:13:35 INFO - 'MAIL': '/var/mail/cltbld', 07:13:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:35 INFO - 'MOZ_NO_REMOTE': '1', 07:13:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:35 INFO - 'NO_EM_RESTART': '1', 07:13:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:35 INFO - 'PWD': '/builds/slave/test', 07:13:35 INFO - 'SHELL': '/bin/bash', 07:13:35 INFO - 'SHLVL': '1', 07:13:35 INFO - 'TERM': 'linux', 07:13:35 INFO - 'TMOUT': '86400', 07:13:35 INFO - 'USER': 'cltbld', 07:13:35 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1448291597.125367-777282226', 07:13:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:35 INFO - '_': '/tools/buildbot/bin/python'} 07:13:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:35 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 07:13:35 INFO - Cleaning up... 07:13:35 INFO - Return code: 0 07:13:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:13:35 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')]} 07:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:35 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')]} 07:13:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:35 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 0x7f8160187c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1510900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1556b70>, '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 0x15a7dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a8250>, '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': '6ef107882637bc5fc02d78b7000001c2-1448291597.125367-777282226', '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 07:13:35 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 07:13:35 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 07:13:35 INFO - Using env: {'DISPLAY': ':0', 07:13:35 INFO - 'HOME': '/home/cltbld', 07:13:35 INFO - 'LANG': 'en_US.UTF-8', 07:13:35 INFO - 'LANGUAGE': 'en_US:en', 07:13:35 INFO - 'LOGNAME': 'cltbld', 07:13:35 INFO - 'MAIL': '/var/mail/cltbld', 07:13:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:35 INFO - 'MOZ_NO_REMOTE': '1', 07:13:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:35 INFO - 'NO_EM_RESTART': '1', 07:13:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:35 INFO - 'PWD': '/builds/slave/test', 07:13:35 INFO - 'SHELL': '/bin/bash', 07:13:35 INFO - 'SHLVL': '1', 07:13:35 INFO - 'TERM': 'linux', 07:13:35 INFO - 'TMOUT': '86400', 07:13:35 INFO - 'USER': 'cltbld', 07:13:35 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1448291597.125367-777282226', 07:13:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:35 INFO - '_': '/tools/buildbot/bin/python'} 07:13:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:35 INFO - Downloading/unpacking psutil>=0.7.1 07:13:35 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 07:13:35 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 07:13:35 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 07:13:35 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 07:13:35 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 07:13:35 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 07:13:37 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 07:13:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:13:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:13:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:13:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:13:37 INFO - Installing collected packages: psutil 07:13:37 INFO - Running setup.py install for psutil 07:13:37 INFO - building 'psutil._psutil_linux' extension 07:13:37 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 07:13:37 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 07:13:37 INFO - building 'psutil._psutil_posix' extension 07:13:37 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 07:13:37 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 07:13:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:13:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:13:37 INFO - Successfully installed psutil 07:13:37 INFO - Cleaning up... 07:13:37 INFO - Return code: 0 07:13:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:13: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')]} 07:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13: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')]} 07:13:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:37 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 0x7f8160187c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1510900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1556b70>, '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 0x15a7dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a8250>, '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': '6ef107882637bc5fc02d78b7000001c2-1448291597.125367-777282226', '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 07:13:37 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 07:13:37 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 07:13:37 INFO - Using env: {'DISPLAY': ':0', 07:13:37 INFO - 'HOME': '/home/cltbld', 07:13:37 INFO - 'LANG': 'en_US.UTF-8', 07:13:37 INFO - 'LANGUAGE': 'en_US:en', 07:13:37 INFO - 'LOGNAME': 'cltbld', 07:13:37 INFO - 'MAIL': '/var/mail/cltbld', 07:13:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:37 INFO - 'MOZ_NO_REMOTE': '1', 07:13:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:37 INFO - 'NO_EM_RESTART': '1', 07:13:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:37 INFO - 'PWD': '/builds/slave/test', 07:13:37 INFO - 'SHELL': '/bin/bash', 07:13:37 INFO - 'SHLVL': '1', 07:13:37 INFO - 'TERM': 'linux', 07:13:37 INFO - 'TMOUT': '86400', 07:13:37 INFO - 'USER': 'cltbld', 07:13:37 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1448291597.125367-777282226', 07:13:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:37 INFO - '_': '/tools/buildbot/bin/python'} 07:13:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:13:38 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 07:13:38 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 07:13:38 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 07:13:38 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 07:13:38 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 07:13:38 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 07:13:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:13:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:13:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:13:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:13:39 INFO - Installing collected packages: mozsystemmonitor 07:13:39 INFO - Running setup.py install for mozsystemmonitor 07:13:39 INFO - Successfully installed mozsystemmonitor 07:13:39 INFO - Cleaning up... 07:13:39 INFO - Return code: 0 07:13:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:13:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:39 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 0x7f8160187c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1510900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1556b70>, '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 0x15a7dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a8250>, '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': '6ef107882637bc5fc02d78b7000001c2-1448291597.125367-777282226', '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 07:13:39 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 07:13:39 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 07:13:39 INFO - Using env: {'DISPLAY': ':0', 07:13:39 INFO - 'HOME': '/home/cltbld', 07:13:39 INFO - 'LANG': 'en_US.UTF-8', 07:13:39 INFO - 'LANGUAGE': 'en_US:en', 07:13:39 INFO - 'LOGNAME': 'cltbld', 07:13:39 INFO - 'MAIL': '/var/mail/cltbld', 07:13:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:39 INFO - 'MOZ_NO_REMOTE': '1', 07:13:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:39 INFO - 'NO_EM_RESTART': '1', 07:13:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:39 INFO - 'PWD': '/builds/slave/test', 07:13:39 INFO - 'SHELL': '/bin/bash', 07:13:39 INFO - 'SHLVL': '1', 07:13:39 INFO - 'TERM': 'linux', 07:13:39 INFO - 'TMOUT': '86400', 07:13:39 INFO - 'USER': 'cltbld', 07:13:39 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1448291597.125367-777282226', 07:13:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:39 INFO - '_': '/tools/buildbot/bin/python'} 07:13:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:40 INFO - Downloading/unpacking blobuploader==1.2.4 07:13:40 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 07:13:40 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 07:13:40 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 07:13:40 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 07:13:40 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 07:13:40 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 07:13:41 INFO - Downloading blobuploader-1.2.4.tar.gz 07:13:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:13:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:13:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:13:41 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 07:13:41 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 07:13:41 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 07:13:41 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 07:13:41 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 07:13:41 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 07:13:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:13:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:13:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:13:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:42 INFO - Downloading docopt-0.6.1.tar.gz 07:13:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:13:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:13:42 INFO - Installing collected packages: blobuploader, requests, docopt 07:13:42 INFO - Running setup.py install for blobuploader 07:13:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:13:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:13:42 INFO - Running setup.py install for requests 07:13:42 INFO - Running setup.py install for docopt 07:13:43 INFO - Successfully installed blobuploader requests docopt 07:13:43 INFO - Cleaning up... 07:13:43 INFO - Return code: 0 07:13:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:13:43 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')]} 07:13:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:43 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')]} 07:13:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:43 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 0x7f8160187c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1510900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1556b70>, '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 0x15a7dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a8250>, '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': '6ef107882637bc5fc02d78b7000001c2-1448291597.125367-777282226', '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 07:13:43 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 07:13:43 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 07:13:43 INFO - Using env: {'DISPLAY': ':0', 07:13:43 INFO - 'HOME': '/home/cltbld', 07:13:43 INFO - 'LANG': 'en_US.UTF-8', 07:13:43 INFO - 'LANGUAGE': 'en_US:en', 07:13:43 INFO - 'LOGNAME': 'cltbld', 07:13:43 INFO - 'MAIL': '/var/mail/cltbld', 07:13:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:43 INFO - 'MOZ_NO_REMOTE': '1', 07:13:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:43 INFO - 'NO_EM_RESTART': '1', 07:13:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:43 INFO - 'PWD': '/builds/slave/test', 07:13:43 INFO - 'SHELL': '/bin/bash', 07:13:43 INFO - 'SHLVL': '1', 07:13:43 INFO - 'TERM': 'linux', 07:13:43 INFO - 'TMOUT': '86400', 07:13:43 INFO - 'USER': 'cltbld', 07:13:43 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1448291597.125367-777282226', 07:13:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:43 INFO - '_': '/tools/buildbot/bin/python'} 07:13:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:13:43 INFO - Running setup.py (path:/tmp/pip-NyeDoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:13:43 INFO - Running setup.py (path:/tmp/pip-Z_Verl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:13:43 INFO - Running setup.py (path:/tmp/pip-z_9jtN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:13:43 INFO - Running setup.py (path:/tmp/pip-LUBtCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:13:43 INFO - Running setup.py (path:/tmp/pip-_p13h2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:13:43 INFO - Running setup.py (path:/tmp/pip-A5_I28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:13:43 INFO - Running setup.py (path:/tmp/pip-slLaTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:13:43 INFO - Running setup.py (path:/tmp/pip-Mnebcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:13:43 INFO - Running setup.py (path:/tmp/pip-QS51yD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:13:44 INFO - Running setup.py (path:/tmp/pip-BbkWqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:13:44 INFO - Running setup.py (path:/tmp/pip-sedb8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:13:44 INFO - Running setup.py (path:/tmp/pip-_CO9Ly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:13:44 INFO - Running setup.py (path:/tmp/pip-MvKtd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:13:44 INFO - Running setup.py (path:/tmp/pip-vI20G2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:13:44 INFO - Running setup.py (path:/tmp/pip-oNyCyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:13:44 INFO - Running setup.py (path:/tmp/pip-zRM_cP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:13:44 INFO - Running setup.py (path:/tmp/pip-mcWb91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:13:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:13:44 INFO - Running setup.py install for manifestparser 07:13:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:13:44 INFO - Running setup.py install for mozcrash 07:13:44 INFO - Running setup.py install for mozdebug 07:13:44 INFO - Running setup.py install for mozdevice 07:13:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:13:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:13:45 INFO - Running setup.py install for mozfile 07:13:45 INFO - Running setup.py install for mozhttpd 07:13:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:13:45 INFO - Running setup.py install for mozinfo 07:13:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:13:45 INFO - Running setup.py install for mozInstall 07:13:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:13:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:13:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:13:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:13:45 INFO - Running setup.py install for mozleak 07:13:45 INFO - Running setup.py install for mozlog 07:13:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:13:45 INFO - Running setup.py install for moznetwork 07:13:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:13:45 INFO - Running setup.py install for mozprocess 07:13:45 INFO - Running setup.py install for mozprofile 07:13:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:13:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:13:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:13:45 INFO - Running setup.py install for mozrunner 07:13:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:13:46 INFO - Running setup.py install for mozscreenshot 07:13:46 INFO - Running setup.py install for moztest 07:13:46 INFO - Running setup.py install for mozversion 07:13:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:13:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:13:46 INFO - Cleaning up... 07:13:46 INFO - Return code: 0 07:13:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:13: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')]} 07:13:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13: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')]} 07:13:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f8160187c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1510900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1556b70>, '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 0x15a7dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a8250>, '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': '6ef107882637bc5fc02d78b7000001c2-1448291597.125367-777282226', '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 07:13:46 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 07:13:46 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 07:13:46 INFO - Using env: {'DISPLAY': ':0', 07:13:46 INFO - 'HOME': '/home/cltbld', 07:13:46 INFO - 'LANG': 'en_US.UTF-8', 07:13:46 INFO - 'LANGUAGE': 'en_US:en', 07:13:46 INFO - 'LOGNAME': 'cltbld', 07:13:46 INFO - 'MAIL': '/var/mail/cltbld', 07:13:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:46 INFO - 'MOZ_NO_REMOTE': '1', 07:13:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:46 INFO - 'NO_EM_RESTART': '1', 07:13:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:46 INFO - 'PWD': '/builds/slave/test', 07:13:46 INFO - 'SHELL': '/bin/bash', 07:13:46 INFO - 'SHLVL': '1', 07:13:46 INFO - 'TERM': 'linux', 07:13:46 INFO - 'TMOUT': '86400', 07:13:46 INFO - 'USER': 'cltbld', 07:13:46 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1448291597.125367-777282226', 07:13:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:46 INFO - '_': '/tools/buildbot/bin/python'} 07:13:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:13:46 INFO - Running setup.py (path:/tmp/pip-5PAWrb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:13:46 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)) 07:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:13:46 INFO - Running setup.py (path:/tmp/pip-25U4uf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:13:46 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)) 07:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:13:46 INFO - Running setup.py (path:/tmp/pip-E0JUpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:13:46 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)) 07:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:13:46 INFO - Running setup.py (path:/tmp/pip-R7sEVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:13:46 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)) 07:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:13:46 INFO - Running setup.py (path:/tmp/pip-_ya5iM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:13:46 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)) 07:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:13:46 INFO - Running setup.py (path:/tmp/pip-kSojsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:13:47 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)) 07:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:13:47 INFO - Running setup.py (path:/tmp/pip-Fa8pEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:13:47 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)) 07:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:13:47 INFO - Running setup.py (path:/tmp/pip-l1lFn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:13:47 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)) 07:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:13:47 INFO - Running setup.py (path:/tmp/pip-aoeHhK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:13:47 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)) 07:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:13:47 INFO - Running setup.py (path:/tmp/pip-GyrRDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:13:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:13:47 INFO - Running setup.py (path:/tmp/pip-FRg6yq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:13:47 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)) 07:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:13:47 INFO - Running setup.py (path:/tmp/pip-7UNoOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:13:47 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)) 07:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:13:47 INFO - Running setup.py (path:/tmp/pip-7Y8DPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:13:47 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)) 07:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:13:47 INFO - Running setup.py (path:/tmp/pip-6WOUWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:13:47 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)) 07:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:13:47 INFO - Running setup.py (path:/tmp/pip-JMrrgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:13:47 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)) 07:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:13:47 INFO - Running setup.py (path:/tmp/pip-GKLdBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:13:47 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)) 07:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:13:47 INFO - Running setup.py (path:/tmp/pip-CrBic5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:13:47 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)) 07:13:47 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)) 07:13:47 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)) 07:13:47 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)) 07:13:47 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)) 07:13:47 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)) 07:13:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:13:47 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 07:13:47 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 07:13:47 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 07:13:47 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 07:13:47 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 07:13:47 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 07:13:49 INFO - Downloading blessings-1.5.1.tar.gz 07:13:49 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 07:13:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:13:49 INFO - Installing collected packages: blessings 07:13:49 INFO - Running setup.py install for blessings 07:13:49 INFO - Successfully installed blessings 07:13:49 INFO - Cleaning up... 07:13:49 INFO - Return code: 0 07:13:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:13:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:13:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:13:49 INFO - Reading from file tmpfile_stdout 07:13:49 INFO - Current package versions: 07:13:49 INFO - argparse == 1.2.1 07:13:49 INFO - blessings == 1.5.1 07:13:49 INFO - blobuploader == 1.2.4 07:13:49 INFO - docopt == 0.6.1 07:13:49 INFO - manifestparser == 1.1 07:13:49 INFO - mozInstall == 1.12 07:13:49 INFO - mozcrash == 0.16 07:13:49 INFO - mozdebug == 0.1 07:13:49 INFO - mozdevice == 0.47 07:13:49 INFO - mozfile == 1.2 07:13:49 INFO - mozhttpd == 0.7 07:13:49 INFO - mozinfo == 0.9 07:13:49 INFO - mozleak == 0.1 07:13:49 INFO - mozlog == 3.1 07:13:49 INFO - moznetwork == 0.27 07:13:49 INFO - mozprocess == 0.22 07:13:49 INFO - mozprofile == 0.27 07:13:49 INFO - mozrunner == 6.11 07:13:49 INFO - mozscreenshot == 0.1 07:13:49 INFO - mozsystemmonitor == 0.0 07:13:49 INFO - moztest == 0.7 07:13:49 INFO - mozversion == 1.4 07:13:49 INFO - psutil == 3.1.1 07:13:49 INFO - requests == 1.2.3 07:13:49 INFO - wsgiref == 0.1.2 07:13:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:13:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:49 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 0x7f8160187c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1510900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1556b70>, '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 0x15a7dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a8250>, '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': '6ef107882637bc5fc02d78b7000001c2-1448291597.125367-777282226', '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 07:13:49 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 07:13:49 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 07:13:49 INFO - Using env: {'DISPLAY': ':0', 07:13:49 INFO - 'HOME': '/home/cltbld', 07:13:49 INFO - 'LANG': 'en_US.UTF-8', 07:13:49 INFO - 'LANGUAGE': 'en_US:en', 07:13:49 INFO - 'LOGNAME': 'cltbld', 07:13:49 INFO - 'MAIL': '/var/mail/cltbld', 07:13:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:49 INFO - 'MOZ_NO_REMOTE': '1', 07:13:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:49 INFO - 'NO_EM_RESTART': '1', 07:13:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:49 INFO - 'PWD': '/builds/slave/test', 07:13:49 INFO - 'SHELL': '/bin/bash', 07:13:49 INFO - 'SHLVL': '1', 07:13:49 INFO - 'TERM': 'linux', 07:13:49 INFO - 'TMOUT': '86400', 07:13:49 INFO - 'USER': 'cltbld', 07:13:49 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1448291597.125367-777282226', 07:13:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:49 INFO - '_': '/tools/buildbot/bin/python'} 07:13:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:50 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)) 07:13:50 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)) 07:13:50 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)) 07:13:50 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)) 07:13:50 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)) 07:13:50 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)) 07:13:50 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)) 07:13:50 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)) 07:13:50 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)) 07:13:50 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)) 07:13:50 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)) 07:13:50 INFO - Cleaning up... 07:13:50 INFO - Return code: 0 07:13:50 INFO - Running post-action listener: _resource_record_post_action 07:13:50 INFO - Running post-action listener: _start_resource_monitoring 07:13:50 INFO - Starting resource monitoring. 07:13:50 INFO - ##### 07:13:50 INFO - ##### Running install step. 07:13:50 INFO - ##### 07:13:50 INFO - Running pre-action listener: _resource_record_pre_action 07:13:50 INFO - Running main action method: install 07:13:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:13:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:13:50 INFO - Reading from file tmpfile_stdout 07:13:50 INFO - Detecting whether we're running mozinstall >=1.0... 07:13:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:13:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:13:50 INFO - Reading from file tmpfile_stdout 07:13:50 INFO - Output received: 07:13:50 INFO - Usage: mozinstall [options] installer 07:13:50 INFO - Options: 07:13:50 INFO - -h, --help show this help message and exit 07:13:50 INFO - -d DEST, --destination=DEST 07:13:50 INFO - Directory to install application into. [default: 07:13:50 INFO - "/builds/slave/test"] 07:13:50 INFO - --app=APP Application being installed. [default: firefox] 07:13:50 INFO - mkdir: /builds/slave/test/build/application 07:13:50 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'] 07:13:50 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 07:14:04 INFO - Reading from file tmpfile_stdout 07:14:04 INFO - Output received: 07:14:04 INFO - /builds/slave/test/build/application/firefox/firefox 07:14:04 INFO - Running post-action listener: _resource_record_post_action 07:14:04 INFO - ##### 07:14:04 INFO - ##### Running run-tests step. 07:14:04 INFO - ##### 07:14:04 INFO - Running pre-action listener: _resource_record_pre_action 07:14:04 INFO - Running main action method: run_tests 07:14:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:14:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:14:04 INFO - Python 2.7.3 07:14:04 INFO - Return code: 0 07:14:04 INFO - grabbing minidump binary from tooltool 07:14: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')]} 07:14:04 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 0x1556b70>, '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 0x15a7dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a8250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:14:04 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 07:14:04 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 07:14:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:14:04 INFO - Return code: 0 07:14:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:14:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:14:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:14:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:14:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:14:04 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/TgApCiCTQOmZQbOPyB7oGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost'] in /builds/slave/test/build 07:14:04 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/TgApCiCTQOmZQbOPyB7oGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --webServer localhost 07:14:04 INFO - Using env: {'DISPLAY': ':0', 07:14:04 INFO - 'HOME': '/home/cltbld', 07:14:04 INFO - 'LANG': 'en_US.UTF-8', 07:14:04 INFO - 'LANGUAGE': 'en_US:en', 07:14:04 INFO - 'LOGNAME': 'cltbld', 07:14:04 INFO - 'MAIL': '/var/mail/cltbld', 07:14:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:14:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:14:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:04 INFO - 'MOZ_NO_REMOTE': '1', 07:14:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:14:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:04 INFO - 'NO_EM_RESTART': '1', 07:14:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:04 INFO - 'PWD': '/builds/slave/test', 07:14:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:14:04 INFO - 'SHELL': '/bin/bash', 07:14:04 INFO - 'SHLVL': '1', 07:14:04 INFO - 'TERM': 'linux', 07:14:04 INFO - 'TMOUT': '86400', 07:14:04 INFO - 'USER': 'cltbld', 07:14:04 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1448291597.125367-777282226', 07:14:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:04 INFO - '_': '/tools/buildbot/bin/python'} 07:14:04 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/TgApCiCTQOmZQbOPyB7oGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost'] with output_timeout 3600 07:14:04 INFO - mozversion INFO | application_buildid: 20151123062128 07:14:04 INFO - mozversion INFO | application_changeset: bfd81e42d1ddc7071c7fab2598f3099aab30ca92 07:14:04 INFO - mozversion INFO | application_display_name: Nightly 07:14:04 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:14:04 INFO - mozversion INFO | application_name: Firefox 07:14:04 INFO - mozversion INFO | application_remotingname: firefox 07:14:04 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 07:14:04 INFO - mozversion INFO | application_vendor: Mozilla 07:14:04 INFO - mozversion INFO | application_version: 45.0a1 07:14:04 INFO - mozversion INFO | platform_buildid: 20151123062128 07:14:04 INFO - mozversion INFO | platform_changeset: bfd81e42d1ddc7071c7fab2598f3099aab30ca92 07:14:04 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 07:14:04 INFO - mozversion INFO | platform_version: 45.0a1 07:14:04 INFO - 2015-11-23 07:14:04,895 DEBUG : using testdate: 1448291644 07:14:04 INFO - 2015-11-23 07:14:04,895 DEBUG : actual date: 1448291644 07:14:04 INFO - 2015-11-23 07:14:04,904 INFO : starting webserver on 'localhost:50354' 07:14:04 INFO - 2015-11-23 07:14:04,905 INFO : Starting test suite talos-linux64-ix-007 07:14:04 INFO - 2015-11-23 07:14:04,905 INFO : Starting test dromaeo_css 07:14:04 INFO - 2015-11-23 07:14:04,905 DEBUG : operating with platform_type : linux_ 07:14:04 INFO - 2015-11-23 07:14:04,906 INFO : Initialising browser for dromaeo_css test... 07:14:04 INFO - 2015-11-23 07:14:04,922 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzt1ss3/profile http://localhost:50354/getInfo.html 07:14:10 INFO - 2015-11-23 07:14:10,236 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:14:10 INFO - 2015-11-23 07:14:10,236 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:14:10 INFO - 2015-11-23 07:14:10,236 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:14:10 INFO - 2015-11-23 07:14:10,236 DEBUG : BROWSER_OUTPUT: __metrics 07:14:10 INFO - 2015-11-23 07:14:10,373 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:14:11 INFO - 2015-11-23 07:14:11,642 INFO : Browser initialized. 07:14:11 INFO - 2015-11-23 07:14:11,643 INFO : Running cycle 1/1 for dromaeo_css test... 07:14:11 INFO - 2015-11-23 07:14:11,643 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzt1ss3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:14:23 INFO - 2015-11-23 07:14:23,618 DEBUG : BROWSER_OUTPUT: RSS: Main: 139915264 07:14:23 INFO - 2015-11-23 07:14:23,618 DEBUG : BROWSER_OUTPUT: 07:15:14 INFO - 2015-11-23 07:15:14,717 DEBUG : BROWSER_OUTPUT: 1448291714711 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] 07:17:26 INFO - 2015-11-23 07:17:26,595 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50354/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50354/tests/dromaeo/cssquery-ext.html) 07:17:27 INFO - 2015-11-23 07:17:27,800 DEBUG : BROWSER_OUTPUT: RSS: Main: 244133888 07:17:27 INFO - 2015-11-23 07:17:27,801 DEBUG : BROWSER_OUTPUT: 07:20:30 INFO - 2015-11-23 07:20:30,303 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50354/tests/dromaeo/cssquery-ext.html (next: http://localhost:50354/tests/dromaeo/cssquery-jquery.html) 07:20:30 INFO - 2015-11-23 07:20:30,889 DEBUG : BROWSER_OUTPUT: RSS: Main: 219164672 07:20:30 INFO - 2015-11-23 07:20:30,889 DEBUG : BROWSER_OUTPUT: 07:23:32 INFO - 2015-11-23 07:23:32,913 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50354/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50354/tests/dromaeo/cssquery-mootools.html) 07:23:33 INFO - 2015-11-23 07:23:33,499 DEBUG : BROWSER_OUTPUT: RSS: Main: 222121984 07:23:33 INFO - 2015-11-23 07:23:33,499 DEBUG : BROWSER_OUTPUT: 07:26:35 INFO - 2015-11-23 07:26:35,420 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50354/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50354/tests/dromaeo/cssquery-prototype.html) 07:26:35 INFO - 2015-11-23 07:26:35,985 DEBUG : BROWSER_OUTPUT: RSS: Main: 201547776 07:26:35 INFO - 2015-11-23 07:26:35,985 DEBUG : BROWSER_OUTPUT: 07:29:38 INFO - 2015-11-23 07:29:38,722 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50354/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50354/tests/dromaeo/cssquery-yui.html) 07:29:39 INFO - 2015-11-23 07:29:39,302 DEBUG : BROWSER_OUTPUT: RSS: Main: 202588160 07:29:39 INFO - 2015-11-23 07:29:39,303 DEBUG : BROWSER_OUTPUT: 07:32:41 INFO - 2015-11-23 07:32:41,832 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50354/tests/dromaeo/cssquery-yui.html (next: http://localhost:50354/tests/dromaeo/cssquery-dojo.html) 07:32:42 INFO - 2015-11-23 07:32:42,083 DEBUG : BROWSER_OUTPUT: RSS: Main: 247910400 07:32:42 INFO - 2015-11-23 07:32:42,084 DEBUG : BROWSER_OUTPUT: 07:32:42 INFO - 2015-11-23 07:32:42,085 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:32:42 INFO - 2015-11-23 07:32:42,085 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:32:42 INFO - 2015-11-23 07:32:42,085 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:32:42 INFO - 2015-11-23 07:32:42,086 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:32:42 INFO - 2015-11-23 07:32:42,087 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2573.163721790418;2661.4144888124606;2668.933276668083;2669.7196794336605;2688.045743760965;4430.09183117461;4560.70355426897;4597.632189424842;4637.605803506702;4647.581717645411;4525.298578720295;4542.841000564981;4610.308453731942;4612.469565999911;4635.976820115895;4247.214265360918;4255.851045213418;4282.122164956192;4282.614564689169;4350.1734670412525;4145.689073319513;4333;4349;4371.038371558252;4384.342348647697;4198.118395137025;4258.276093064171;4260.998665313648;4290.69965102443;4297.914041719179;4301;4305.698601097924;4320.503142138663;4332.458442694663;4344.109457561192;4125.628693417577;4214.4099826024385;4288.892777680552;4297.290946993742;4345.913081738379;4469.888252793674;4494.438195225597;4558.475775285819;4571.58855702985;4613.077384523109;4967.82612608557;4980.427250866161;4982.725950072744;4984.352034235562;5005.974970125162;4774.80900763969;4886.804527818883;4984;4994.600431965434;5001.09848409193;4565.5206203348835;4603.953960460386;4648.558386953234;4655.464621568495;4711.81152753886;5102.5662818660085;5121.206213036985;5163.14808056674;5163.380394352702;5165.096108181053;4689.062187562433;4783.067301876101;4938.629602779806;4940.580050695659;4943.530364615356;4866.099771542205;4885.340479035356;4945.010997800454;4952.4057113146655;4999.625028122832;4878.170710979142;4908.533689299511;4913.778879950411;4919.803207871645;4964.578010869117;4696.694714843524;4796.472388037313;4868.95131048692;4872.853814385574;4924.03981223658;4029.315016447211;4055.148418832019;4092.345224764083;4111.424400583921;4111.671066314688;3573.285342931424;3605.2248766515327;3608.80151591665;3638.399664055454;3640.10817349751;4142.958570414257;4301.333293339538;4306.720063195882;4315.632754342431;4342.869713908588;4834.613230941516;4900.117978763857;4909.754512274372;4930.11257973561;4930.161872481687;4262.722923010057;4324.481062272547;4325.502567204811;4328.5455027222315;4365.628921541705;4216.852410165629;4422.977885110618;4450.532694067141;4451.799669014902;4478.216312145361;4603.953960460352;4622.121796858586;4640.164770341304;4717.929231061606;4741.786619602195;4923.606111510999;4943.466992981212;4950.8267210647455;4953.826616068421;4999.65002449825;4692.765361731831;4693.296005599187;4693.389859318267;4697.577218050255;4740.834070807505;4730.952690473051;4751.691140075884;4812;4812.663113582015;4817.710937343771;4942.901141977212;4959.479254678206;4984.775685094252;4988.201887697951;4991.401031876198;4828.468868424541;4831.758412079312;4836.637252206169;4840.2255639097575;4879.853604391874;4662.7202367858035;4743.905121897612;4811.446683631427;4828.517148285284;4871.926921096116;4638.768061596839;4676.6492513060975;4764.618830493621;4792.664513484023;4803.615710743202;4763.952360476351;4786;4800.207965685623;4812.35033270504;4846.297286893451;4563.269876819693;4699.765011749467;4701;4706.223473126895;4739.786709598007 07:32:42 INFO - 2015-11-23 07:32:42,090 DEBUG : BROWSER_OUTPUT: |1;ext.html;545.4425350810143;573.1116769008037;573.5067841656172;581.453433772254;587.3245767367528;28221.717782822165;28737.85631071847;28780.568291475643;28783.424331513357;28793.856030719817;29114.854425727895;29537;36952.81523592378;37483.25033499328;37768.43347349785;7943.205679432069;7978.481398709066;7991.24083212094;7994.000749906262;8006.159353267911;7107.964460177718;7796.727114550992;7926.484778489408;7928.80177995549;7975.641096150658;7037.718491260343;9877.407355558653;10155.543000564992;10155.644552440666;10160.491975401237;9825.508724563742;9879.555420006118;9918.454485003322;9923.057309555652;9927;7140.571565706075;7329.853402931964;9555.856662150003;9657.661981830603;10070.194384449227;36042.45936310958;36414.817925910465;36431.27137457236;36442.81778591117;36443;2603.597535114645;2638.9868050659816;2700.6894207166033;2704.3644743485265;3386.915327116817;27668.723312766815;28324.858375708194;28354;28520.857395713098;28669;3406.744494162948;3496.283261931298;3513.771604845677;3559.323728491578;3623.8188090595363;220732;221066;222824;223123;223345;55389.723051384484;55557.44442555604;55720.44279557152;55725.721371393694;55860.44139558553;52655.21017184745;53720;58308;58825.41174588285;62999;14364.497242596459;14460.276986150651;14535.709285814224;14585.489507867385;14588.41646334156;11006.669799906016;11086.944565277283;11126;11137.498812553455;11145.554177832959;18451.538711532052;18561.90719046396;18710.966774918812;18806.529836753918;18808.52978675544;7048.436125109979;7369.6315184240575;7438.5536867788105;7489.063867016623;7517.323440890346;853.5518852602434;877.7498412952406;880.6389380354024;881.7619242804407;944.0276515189366;26129;26640.866795665897;26655.33361665935;26726.732732672423;26761.197164085108;920.4983284110176;930.251147825993;942.2509105261333;990.4156547636928;1006.8288390973552;12687.682807929876;12790.744185116431;12843.03677224212;14107.294635268196;15322.923385383225;258466;261615;262270;262937;263330;45666.77166614212;45751.08497830025;45812;45874.77062614666;46092.53907460949;1186.1578279421708;1198.532572296805;1212.5331747277362;1213.9635810925686;1223.8409006829056;26226.475470490102;27070.593941091294;27213.87248613581;27297.181084567495;27619.171424857286;35247;36035.81982090178;42056.78971605122;43170.56829431791;43202.13595728131;221978;222388;223753;223835;224580;23717.762822372246;24048.39879003039;24143.637845432684;27822.66128064645;28104.156875293775;27281.454370912074;28846.855765721037;34990.30019399547;35569.46645800367;35799.46300805438;30243.848780755954;30306.242343941576;30702.078937631908;30840.074797756104;31168;33151.83424082864;34001.82999084989;35969.46045809367;36253.818730906176;36396.45405318975;32936.176595584344;33023.174420639676;33351.16622084467;33376;33461.83269083639;27067.72932270652;27923.44153116967;29731.256718582208;29805.552916705834;29954;23122.421939450975;23231.767682323636;23291.88354058219;23391.298261052194;23512.529749404574 07:32:42 INFO - 2015-11-23 07:32:42,091 DEBUG : BROWSER_OUTPUT: |2;jquery.html;330.5867665418227;334.2396048988551;334.69542716128313;334.8822462870674;338.3030956230166;12395.008399328055;12823.615291541246;15022.57285557873;15283.018867924531;16650.750238746412;14916.552503424915;15254.068976474908;15941.362345506166;16118.194090295498;16138.515844524654;3962.603739626043;4762.142814293417;4852.830150944717;4858.149823780842;4865.343178670887;4895.167821470341;4902.534259245366;4927.630427717918;4930.4083509978855;4934.28452874333;4813.927791083119;4891.5353041461;4898.41219053714;4946.530079642428;4962.181240095398;4869.172240719051;4888.437829649582;4904.141775189363;4922.729249891255;4926.605871530287;4278.058827058042;4391.9780401098105;4405.29515277554;4407.889802754957;4411.139827733593;19158.904205479022;19159.137838797287;19271.036448177674;19277.012063130238;19400.80599194004;1754.1317048061164;1757.2707326459504;1768.777745776677;1780.0832571225828;1833.7432759413693;12542.874571254262;12585.496580136783;12695.492180312776;13001.089923705344;13001.86998130016;1727.7494763259383;1730.1695186310515;1740.1647209339462;1749.422690512128;1813.1931290575699;51202;53326;54328.72835635836;54452.183217251775;55158.44841551573;9359.391639543408;9424.387414818015;9689.176420004378;9714;9721.270904682176;10747.516361763739;11051.613193538187;11408.429578521207;12249.938750306192;12301.938490307492;6906.965465172642;7014.19336776267;7018.894716579255;7111.2533184015965;7148.499605027702;6733.158355205599;6748.257691653914;6854.588724676535;6871.415929645936;6908.447324214051;5724.742386592613;5800.8259752207505;5804.79683211094;5828.184054232411;5834.212381328466;1677.2368572299574;1697.125980120239;1700.9404670836461;1704.7783788107467;1711.5085226138785;802.2458888644655;805.8831469436899;856.4475913036057;877.5217506458995;993.9453330066916;16299;16306.347746090261;16377.754333685005;16577.50267491953;16755.413560525565;779.3492433817712;795.6220795122271;822.198356602308;854.606880834823;926.4672813132341;5734.598578099493;7337.19290878003;8585.828283434297;8864.113588641214;9270.119338662817;335148;336327;340123;463468;466084;55272.17091743627;60499.69750151221;60896.69551652214;63096.79741633558;63553.36446635567;414.7242084014157;457.01969275903;464.64454692160524;466.8739440351086;466.9673122881434;9504.239660827256;9720.562574684298;9795;9923.603055877684;10039.648612298535;31048.223794404417;32028.5195722069;33447.83276083604;33485.83257083699;34200.486992694634;43683.78158109189;43947.34078988754;45995.77002114968;46737.2989405166;47060.7646961763;8918.509481978554;9022.684206052756;9207.907920920972;9221.769455763659;9228.676996305365;13637.386317615532;15997.440089596808;16153.596160095622;16402;16535.25591348368;13451.394687238902;13525;13655.04414690962;13979.650508737363;14137.939654525746;13258.403371848482;13267.867321326663;13297;13580.728385432434;13610.115342502706;13965.231912244924;14140.292985350485;14237.71524569482;14341.56975290743;14599.489017884323;8808.64765409402;8906.73279801607;8911.643534258557;9098.363114581916;9115.407498512575;13293.468261269441;13447.865521344662;13468.730625387241;14034.859651403356;14145.858541414455 07:32:42 INFO - 2015-11-23 07:32:42,094 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1398.6153807702888;1567.612662793428;1621.4730212680875;1634.901905885647;1659.2201665217344;5560.52735517481;6237.563370564057;6302.464290535304;6302.716377763;6305.432511074003;6388.520860935425;6482.384173503521;6484.4488218501365;6487.026945958109;6489.61062336259;2014.979850201494;2017.0923084611948;2039.2658642888548;2040.5102775333962;2041.4181958141933;2014.385612388221;2033;2040.3980825656467;2040.9897950510301;2041.4284000479815;1869.560653246486;1894.6873765828623;1903.8667293289475;1907.418237437581;1908.1699460734555;1972.4279958811928;1984.732061171745;1985.4936991067257;1995.9401217963484;2003.8196562309463;2009.1661960286463;2012.939611811648;2018.8485863560293;2039.0722221389233;2040.5714799892041;5502.339719233678;5673.773049078032;6443.420092191725;6455.903161452582;6475.7085931133215;3798.240351929625;3953;3955.3275943089457;3962;3963.663088637469;2639.0499420208707;2658.70754217036;2667.279834444689;2687.8924843006257;2696.7572918437436;882.6248844241172;891.4250308551013;894.5080205886736;900.8468560344758;905.3255324783079;8615.310775137974;8642.092580279043;8660.437071590326;8671.609777560025;8685.348598855047;3691.5201023866725;3693;3715.0898029982827;3727.2918145552258;3730.2725968435893;7690;7699.076110866732;7714.9228507715325;7720.343770779435;7724.575148366781;3923.7841918694744;3941.0935484838647;3942.8817135485983;3943.2507823513442;3946.348852439373;3572.8570857165423;3608.530890984208;3611.1513794258326;3613.223157021253;3615.4034584293295;3091.721745042912;3100.364425292855;3105.0995211388445;3114.205877501268;3127.702868227515;968.5496244246459;972.4457059476031;975.3075316525346;986.4673076538733;999.14073896449;1059.327327147267;1079.6707004363745;1138.8690300615535;1152.6945359479744;1158.1545471805462;6231.158793562901;6234.0337247726675;6268.561200715997;6273.749050038039;6276.403741644536;1070.464767616192;1097.067492631257;1101.2676570080966;1114;1123.3316176874746;4752.643551733634;4807.110684523374;4818.469968303484;4830.130576496194;4833.32333473314;7231.566106033655;7649.31156195945;7747.922520774833;7754.844903101906;7766.844663106706;7613.162552119263;7631.771046868603;7656.502327348704;7665.693372265158;7720.845583088307;6146.938530614726;6391.265004524446;6406.67966601668;6424.293327733945;6435.517336199804;6229.595076320206;6248.625082495065;6251;6259.998400255937;6260.217472815898;7042.859142817012;7188;7279.8544029120185;7282.890756638761;7296.635168241461;7287.234840341688;7410.11078670563;7426.183119856703;7437.628118593941;7503.66233519482;5674.546036317167;5754;5779.959607270732;5781.768729250951;5782.190493330853;5917.319508256605;6269.874602508015;6299.30707622152;6303.842403939938;6308.337624549356;6066.575339726177;6077.969610151921;6129.2032035835055;6140.109684095871;6196.225471816023;6015.72929218195;6104.938950610437;6152.384761523991;6153.230846144232;6205.906911396242;6018.849528761816;6038.6678732670125;6044.274687037584;6085.056816193497;6145.385461453819;5632.183333416713;5668.603197776281;5676.460736230051;5676.971615141898;5677.489025987681;5796.507296879812;5847.678377689268;5856.502197313276;5858.531317494675;5863.530917526502 07:32:42 INFO - 2015-11-23 07:32:42,096 DEBUG : BROWSER_OUTPUT: |4;prototype.html;302.9500132478141;306.6458240731955;309.19454820193397;312.23813894098396;315.26857690158835;5456.781728730851;5473.67157970521;5491.835244942648;5510.201020851979;5523;5148.099082660528;5282;5312.07038768216;5434.673919564829;5461.2354270402175;4249.426327445802;4267.615914567688;4272.081502476967;4274.380214868857;4299.011227417695;4043.7978101094973;4258.339957306623;4267.167902259061;4278.165757677254;4282.7858607069675;4084.1831633673237;4114.958850411487;4199.7480151190875;4241.151769646068;4248.915021699564;4235.449391579105;4236.703430759848;4242.575742425764;4250.341197114452;4251.978740106295;3757.6618104370737;3758.1356288053626;3762.191128907298;3772.264408440355;3774.622537746231;5253.605979551511;5265.236540701577;5272.657277276965;5274.103402421598;5279;4783.258594917794;4898.681585696918;4901.975490122562;4910.508949105061;4914.754262286871;5702.372738998707;5707.400722924075;5708.486236238717;5715.714214289269;5718.828435146911;4043.555208927016;4077.6533994610195;4084.326086195804;4086.4074709167303;4091.3862920562156;5854.5023672987845;6001.729922153513;6007.969960150215;6009.429104235091;6011.158437818709;4202.978985105055;4210.7473551587;4211.894702632459;4217.704760666786;4229.323308270662;4264.765437900884;4274.786260686953;4274.829006839754;4276.2089013532595;4281.957180428218;4831.782569784368;4839.249916262985;4843.370361853007;4844.249141383091;4852.805887764521;5563.36021357541;5705.857353566111;5711.371749107595;5712.143178523254;5718.656880587095;1483.8293596236572;1509.3811537269667;1509.9396024158912;1510.5996910818642;1514.48507507448;1034.1468288661883;1039.262123892045;1050.3645294596658;1057.0169742139883;1072.6406653771073;5030.647854650139;5035.96762663653;5042.974785126051;5048.974755126201;5055.418626857959;5917.082852157922;5928.347881733006;5944.405559444108;5948.583599148018;5955.047192449274;4881.536254055859;4950.579200767903;5012.147934851084;5038.773255203525;5086.669366491166;3191.2500562367827;3197.4564324064963;3216.9195770105935;3220.710136087763;3232.095013396206;5644.322681278273;5654.236678048411;5658.009848276535;5659.745311460994;5670.716464176857;5992.730327135289;6142;6142.140100385949;6143.539234557426;6146.108814222002;5666.433356664383;5671.1493276008105;5671.404502527175;5672.092465205547;5672.631278966854;5973.074173503114;5978.103284507359;5979.133025711334;5986.850328741816;5987.461128498456;5823.097419899922;5824.184614154106;5835.328937172279;5838.970805146117;5840.065589505659;5511.614187006871;5654.208410822571;5667.3482549507335;5669.149627555899;5669.177969194526;4257.254980378483;4259.063006138645;4262.275413179829;4263.083437061046;4266.0827921996915;5965.045592705146;5965.522758179422;5966.731497082555;5970.313413957277;5978.641281523122;5622.100463925753;5725.456081672234;5738.540916726568;5743.195952566561;5748.137779332967;5723.8855222896145;5725;5737.540996720336;5742.08126699726;5747.453991870766;5610.7194640268635;5614.29821272341;5615.719214039364;5616.494515493625;5618.5110945598635;5611.523020543136;5764;5775.595708300379;5787.826365209051;5790.420957904176;5662.8301150965535;5663.830085097454;5669.177969194361;5671.0359238930305;5675.120356344773 07:32:42 INFO - 2015-11-23 07:32:42,097 DEBUG : BROWSER_OUTPUT: |5;yui.html;617.4566381584206;628.5757113948084;713.7010640634046;756.5196100476196;768.488954845028;11372.658820235396;11669.12481563884;11678;11688.298702077871;11689.12331575131;11570.190086693934;11695;12908.483660653586;13246.536371227008;13289.401976911038;601.7532811547267;609.1958614628692;763.4541302968377;776.1384862802284;778.1051790440981;612.3417326374143;761.889526018727;772.5441989226356;773.6325245508367;777.9416543759212;793.6864938349348;807.4105902691039;807.725373373053;807.9313258373045;808.3573559020564;634.0932466572822;642.3095172689331;787.1695361393728;797.4417907464768;798.3652995868299;589.8377946064824;593.1577160432197;593.9346671866091;594.1118028547306;594.7829042399536;11708.765824683544;12003.399830008551;12013.219140755911;12039.976601988841;12045.939770301093;11070.944645276722;11592.536298548048;11718.941405293004;12028.69928251792;12373.69065773354;9317.161455468973;9519.143277105024;9783.41299522031;9918.156956658693;9957.601695932153;3244.30247496787;3275.3449310138067;3289.654586268455;3299.0927494939083;3314.2045908981913;42614;42900;43144.13711725779;43282.78358608218;43407.56592434035;9781.119699226962;9863.309568330147;10010.199184065257;10051.59793608262;10087.798244035079;17202.827971720122;17220.741688874677;17237.39669111575;17280.13599320029;17304.480865574053;6063.757449701962;6294.339094395114;6384.776532821329;6471.708773105222;6501.44737697301;3524.8590056397456;3532.894013179609;3603.279344131184;3629.7822130672243;3702.9259414811554;2578.1749840051;2622.239550530363;2623.317937336268;2625.0287393664466;2629.763321301092;469.3569809361129;477.2483338741496;477.93308936748883;480.37071436418404;483.1496566043718;369.5159341262954;384.9210911763082;388.03186050803424;403.9757614543078;448.7666413465045;6684.665766711645;6950;7059.964700176569;7062.540934839219;7140.321669441499;434.9325854492559;485.53631282125485;547.2693953572026;553.8283132228942;602.4367216652444;3087.737542308884;3274.6397896231397;3352.7150192233444;3352.8491217894766;3359.8488068036995;53549.464505354445;54614;54762.72618636881;54773.726131369884;55021;46836.531634683895;47149.528504714515;47516.52483475121;47944.520554794006;48050;42926.57073429288;43098.569014309454;43464.348034779505;43536.78231608885;43786.34320485195;6374.808755737336;6460.515461340325;6461.644609546332;6536.509761767791;6552.148220731275;31633.683663163993;32264.83867580647;32367.496767609642;32448.188795280308;32632.34735305328;40052.799736001136;41884;42361.36457953072;42770.78614606907;43014.35478467763;8686.826263474568;8796.428232164888;8812.383133180616;8834.911650883667;9129.680461183827;9702.143786808077;9768.706938791847;9832.164266037467;9904.851427228741;9935.751606209902;8393;8620.52587107715;8623.482591044558;8644.740657780276;8671.739847804576;8231.876521852057;8262.297704694927;8402.453840500593;8426.4944103354;8433.072362040048;8624.137586241326;8634.913650863662;8638.222559969632;8803.075677053817;8976.326775491734;7433.702651893864;7485.850282994418;7596.164421913474;7781.144074151952;7888.132305446511;7747.845043098993;8049.678012879419;8065.677372905253;8114.675412983414;8455.704050358208 07:32:42 INFO - 2015-11-23 07:32:42,097 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:32:42 INFO - 2015-11-23 07:32:42,097 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:32:42 INFO - 2015-11-23 07:32:42,097 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,980 07:32:42 INFO - 2015-11-23 07:32:42,097 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:32:42 INFO - 2015-11-23 07:32:42,097 DEBUG : BROWSER_OUTPUT: __startTimestamp1448292762084__endTimestamp 07:32:42 INFO - 2015-11-23 07:32:42,097 DEBUG : BROWSER_OUTPUT: 07:32:42 INFO - 2015-11-23 07:32:42,098 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:32:42 INFO - 2015-11-23 07:32:42,098 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:32:42 INFO - 2015-11-23 07:32:42,098 DEBUG : BROWSER_OUTPUT: 07:32:42 INFO - 2015-11-23 07:32:42,098 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4562.11 Median:4692.77 stddev:470.08 (10.0%) stddev-sans-first:444.87 07:32:42 INFO - 2015-11-23 07:32:42,099 DEBUG : BROWSER_OUTPUT: Values: 2573.2 2661.4 2668.9 2669.7 2688.0 4430.1 4560.7 4597.6 4637.6 4647.6 4525.3 4542.8 4610.3 4612.5 4636.0 4247.2 4255.9 4282.1 4282.6 4350.2 4145.7 4333.0 4349.0 4371.0 4384.3 4198.1 4258.3 4261.0 4290.7 4297.9 4301.0 4305.7 4320.5 4332.5 4344.1 4125.6 4214.4 4288.9 4297.3 4345.9 4469.9 4494.4 4558.5 4571.6 4613.1 4967.8 4980.4 4982.7 4984.4 5006.0 4774.8 4886.8 4984.0 4994.6 5001.1 4565.5 4604.0 4648.6 4655.5 4711.8 5102.6 5121.2 5163.1 5163.4 5165.1 4689.1 4783.1 4938.6 4940.6 4943.5 4866.1 4885.3 4945.0 4952.4 4999.6 4878.2 4908.5 4913.8 4919.8 4964.6 4696.7 4796.5 4869.0 4872.9 4924.0 4029.3 4055.1 4092.3 4111.4 4111.7 3573.3 3605.2 3608.8 3638.4 3640.1 4143.0 4301.3 4306.7 4315.6 4342.9 4834.6 4900.1 4909.8 4930.1 4930.2 4262.7 4324.5 4325.5 4328.5 4365.6 4216.9 4423.0 4450.5 4451.8 4478.2 4604.0 4622.1 4640.2 4717.9 4741.8 4923.6 4943.5 4950.8 4953.8 4999.7 4692.8 4693.3 4693.4 4697.6 4740.8 4731.0 4751.7 4812.0 4812.7 4817.7 4942.9 4959.5 4984.8 4988.2 4991.4 4828.5 4831.8 4836.6 4840.2 4879.9 4662.7 4743.9 4811.4 4828.5 4871.9 4638.8 4676.6 4764.6 4792.7 4803.6 4764.0 4786.0 4800.2 4812.4 4846.3 4563.3 4699.8 4701.0 4706.2 4739.8 07:32:42 INFO - 2015-11-23 07:32:42,099 DEBUG : BROWSER_OUTPUT: 07:32:42 INFO - 2015-11-23 07:32:42,099 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39318.28 Median:30771.08 stddev:61520.52 (199.9%) stddev-sans-first:61624.22 07:32:42 INFO - 2015-11-23 07:32:42,099 DEBUG : BROWSER_OUTPUT: Values: 545.4 573.1 573.5 581.5 587.3 28221.7 28737.9 28780.6 28783.4 28793.9 29114.9 29537.0 36952.8 37483.3 37768.4 7943.2 7978.5 7991.2 7994.0 8006.2 7108.0 7796.7 7926.5 7928.8 7975.6 7037.7 9877.4 10155.5 10155.6 10160.5 9825.5 9879.6 9918.5 9923.1 9927.0 7140.6 7329.9 9555.9 9657.7 10070.2 36042.5 36414.8 36431.3 36442.8 36443.0 2603.6 2639.0 2700.7 2704.4 3386.9 27668.7 28324.9 28354.0 28520.9 28669.0 3406.7 3496.3 3513.8 3559.3 3623.8 220732.0 221066.0 222824.0 223123.0 223345.0 55389.7 55557.4 55720.4 55725.7 55860.4 52655.2 53720.0 58308.0 58825.4 62999.0 14364.5 14460.3 14535.7 14585.5 14588.4 11006.7 11086.9 11126.0 11137.5 11145.6 18451.5 18561.9 18711.0 18806.5 18808.5 7048.4 7369.6 7438.6 7489.1 7517.3 853.6 877.7 880.6 881.8 944.0 26129.0 26640.9 26655.3 26726.7 26761.2 920.5 930.3 942.3 990.4 1006.8 12687.7 12790.7 12843.0 14107.3 15322.9 258466.0 261615.0 262270.0 262937.0 263330.0 45666.8 45751.1 45812.0 45874.8 46092.5 1186.2 1198.5 1212.5 1214.0 1223.8 26226.5 27070.6 27213.9 27297.2 27619.2 35247.0 36035.8 42056.8 43170.6 43202.1 221978.0 222388.0 223753.0 223835.0 224580.0 23717.8 24048.4 24143.6 27822.7 28104.2 27281.5 28846.9 34990.3 35569.5 35799.5 30243.8 30306.2 30702.1 30840.1 31168.0 33151.8 34001.8 35969.5 36253.8 36396.5 32936.2 33023.2 33351.2 33376.0 33461.8 27067.7 27923.4 29731.3 29805.6 29954.0 23122.4 23231.8 23291.9 23391.3 23512.5 07:32:42 INFO - 2015-11-23 07:32:42,099 DEBUG : BROWSER_OUTPUT: 07:32:42 INFO - 2015-11-23 07:32:42,099 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23290.52 Median:4406.59 stddev:64275.63 (1458.6%) stddev-sans-first:64432.82 07:32:42 INFO - 2015-11-23 07:32:42,099 DEBUG : BROWSER_OUTPUT: Values: 330.6 334.2 334.7 334.9 338.3 12395.0 12823.6 15022.6 15283.0 16650.8 14916.6 15254.1 15941.4 16118.2 16138.5 3962.6 4762.1 4852.8 4858.1 4865.3 4895.2 4902.5 4927.6 4930.4 4934.3 4813.9 4891.5 4898.4 4946.5 4962.2 4869.2 4888.4 4904.1 4922.7 4926.6 4278.1 4392.0 4405.3 4407.9 4411.1 19158.9 19159.1 19271.0 19277.0 19400.8 1754.1 1757.3 1768.8 1780.1 1833.7 12542.9 12585.5 12695.5 13001.1 13001.9 1727.7 1730.2 1740.2 1749.4 1813.2 51202.0 53326.0 54328.7 54452.2 55158.4 9359.4 9424.4 9689.2 9714.0 9721.3 10747.5 11051.6 11408.4 12249.9 12301.9 6907.0 7014.2 7018.9 7111.3 7148.5 6733.2 6748.3 6854.6 6871.4 6908.4 5724.7 5800.8 5804.8 5828.2 5834.2 1677.2 1697.1 1700.9 1704.8 1711.5 802.2 805.9 856.4 877.5 993.9 16299.0 16306.3 16377.8 16577.5 16755.4 779.3 795.6 822.2 854.6 926.5 5734.6 7337.2 8585.8 8864.1 9270.1 335148.0 336327.0 340123.0 463468.0 466084.0 55272.2 60499.7 60896.7 63096.8 63553.4 414.7 457.0 464.6 466.9 467.0 9504.2 9720.6 9795.0 9923.6 10039.6 31048.2 32028.5 33447.8 33485.8 34200.5 43683.8 43947.3 45995.8 46737.3 47060.8 8918.5 9022.7 9207.9 9221.8 9228.7 13637.4 15997.4 16153.6 16402.0 16535.3 13451.4 13525.0 13655.0 13979.7 14137.9 13258.4 13267.9 13297.0 13580.7 13610.1 13965.2 14140.3 14237.7 14341.6 14599.5 8808.6 8906.7 8911.6 9098.4 9115.4 13293.5 13447.9 13468.7 14034.9 14145.9 07:32:42 INFO - 2015-11-23 07:32:42,100 DEBUG : BROWSER_OUTPUT: 07:32:42 INFO - 2015-11-23 07:32:42,100 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4641.16 Median:5857.52 stddev:2320.93 (39.6%) stddev-sans-first:2314.65 07:32:42 INFO - 2015-11-23 07:32:42,101 DEBUG : BROWSER_OUTPUT: Values: 1398.6 1567.6 1621.5 1634.9 1659.2 5560.5 6237.6 6302.5 6302.7 6305.4 6388.5 6482.4 6484.4 6487.0 6489.6 2015.0 2017.1 2039.3 2040.5 2041.4 2014.4 2033.0 2040.4 2041.0 2041.4 1869.6 1894.7 1903.9 1907.4 1908.2 1972.4 1984.7 1985.5 1995.9 2003.8 2009.2 2012.9 2018.8 2039.1 2040.6 5502.3 5673.8 6443.4 6455.9 6475.7 3798.2 3953.0 3955.3 3962.0 3963.7 2639.0 2658.7 2667.3 2687.9 2696.8 882.6 891.4 894.5 900.8 905.3 8615.3 8642.1 8660.4 8671.6 8685.3 3691.5 3693.0 3715.1 3727.3 3730.3 7690.0 7699.1 7714.9 7720.3 7724.6 3923.8 3941.1 3942.9 3943.3 3946.3 3572.9 3608.5 3611.2 3613.2 3615.4 3091.7 3100.4 3105.1 3114.2 3127.7 968.5 972.4 975.3 986.5 999.1 1059.3 1079.7 1138.9 1152.7 1158.2 6231.2 6234.0 6268.6 6273.7 6276.4 1070.5 1097.1 1101.3 1114.0 1123.3 4752.6 4807.1 4818.5 4830.1 4833.3 7231.6 7649.3 7747.9 7754.8 7766.8 7613.2 7631.8 7656.5 7665.7 7720.8 6146.9 6391.3 6406.7 6424.3 6435.5 6229.6 6248.6 6251.0 6260.0 6260.2 7042.9 7188.0 7279.9 7282.9 7296.6 7287.2 7410.1 7426.2 7437.6 7503.7 5674.5 5754.0 5780.0 5781.8 5782.2 5917.3 6269.9 6299.3 6303.8 6308.3 6066.6 6078.0 6129.2 6140.1 6196.2 6015.7 6104.9 6152.4 6153.2 6205.9 6018.8 6038.7 6044.3 6085.1 6145.4 5632.2 5668.6 5676.5 5677.0 5677.5 5796.5 5847.7 5856.5 5858.5 5863.5 07:32:42 INFO - 2015-11-23 07:32:42,101 DEBUG : BROWSER_OUTPUT: 07:32:42 INFO - 2015-11-23 07:32:42,101 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4780.13 Median:5280.50 stddev:1384.15 (26.2%) stddev-sans-first:1346.63 07:32:42 INFO - 2015-11-23 07:32:42,101 DEBUG : BROWSER_OUTPUT: Values: 303.0 306.6 309.2 312.2 315.3 5456.8 5473.7 5491.8 5510.2 5523.0 5148.1 5282.0 5312.1 5434.7 5461.2 4249.4 4267.6 4272.1 4274.4 4299.0 4043.8 4258.3 4267.2 4278.2 4282.8 4084.2 4115.0 4199.7 4241.2 4248.9 4235.4 4236.7 4242.6 4250.3 4252.0 3757.7 3758.1 3762.2 3772.3 3774.6 5253.6 5265.2 5272.7 5274.1 5279.0 4783.3 4898.7 4902.0 4910.5 4914.8 5702.4 5707.4 5708.5 5715.7 5718.8 4043.6 4077.7 4084.3 4086.4 4091.4 5854.5 6001.7 6008.0 6009.4 6011.2 4203.0 4210.7 4211.9 4217.7 4229.3 4264.8 4274.8 4274.8 4276.2 4282.0 4831.8 4839.2 4843.4 4844.2 4852.8 5563.4 5705.9 5711.4 5712.1 5718.7 1483.8 1509.4 1509.9 1510.6 1514.5 1034.1 1039.3 1050.4 1057.0 1072.6 5030.6 5036.0 5043.0 5049.0 5055.4 5917.1 5928.3 5944.4 5948.6 5955.0 4881.5 4950.6 5012.1 5038.8 5086.7 3191.3 3197.5 3216.9 3220.7 3232.1 5644.3 5654.2 5658.0 5659.7 5670.7 5992.7 6142.0 6142.1 6143.5 6146.1 5666.4 5671.1 5671.4 5672.1 5672.6 5973.1 5978.1 5979.1 5986.9 5987.5 5823.1 5824.2 5835.3 5839.0 5840.1 5511.6 5654.2 5667.3 5669.1 5669.2 4257.3 4259.1 4262.3 4263.1 4266.1 5965.0 5965.5 5966.7 5970.3 5978.6 5622.1 5725.5 5738.5 5743.2 5748.1 5723.9 5725.0 5737.5 5742.1 5747.5 5610.7 5614.3 5615.7 5616.5 5618.5 5611.5 5764.0 5775.6 5787.8 5790.4 5662.8 5663.8 5669.2 5671.0 5675.1 07:32:42 INFO - 2015-11-23 07:32:42,101 DEBUG : BROWSER_OUTPUT: 07:32:42 INFO - 2015-11-23 07:32:42,102 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12385.82 Median:27787.41 stddev:14960.39 (53.8%) stddev-sans-first:14976.26 07:32:42 INFO - 2015-11-23 07:32:42,103 DEBUG : BROWSER_OUTPUT: Values: 617.5 628.6 713.7 756.5 768.5 11372.7 11669.1 11678.0 11688.3 11689.1 11570.2 11695.0 12908.5 13246.5 13289.4 601.8 609.2 763.5 776.1 778.1 612.3 761.9 772.5 773.6 777.9 793.7 807.4 807.7 807.9 808.4 634.1 642.3 787.2 797.4 798.4 589.8 593.2 593.9 594.1 594.8 11708.8 12003.4 12013.2 12040.0 12045.9 11070.9 11592.5 11718.9 12028.7 12373.7 9317.2 9519.1 9783.4 9918.2 9957.6 3244.3 3275.3 3289.7 3299.1 3314.2 42614.0 42900.0 43144.1 43282.8 43407.6 9781.1 9863.3 10010.2 10051.6 10087.8 17202.8 17220.7 17237.4 17280.1 17304.5 6063.8 6294.3 6384.8 6471.7 6501.4 3524.9 3532.9 3603.3 3629.8 3702.9 2578.2 2622.2 2623.3 2625.0 2629.8 469.4 477.2 477.9 480.4 483.1 369.5 384.9 388.0 404.0 448.8 6684.7 6950.0 7060.0 7062.5 7140.3 434.9 485.5 547.3 553.8 602.4 3087.7 3274.6 3352.7 3352.8 3359.8 53549.5 54614.0 54762.7 54773.7 55021.0 46836.5 47149.5 47516.5 47944.5 48050.0 42926.6 43098.6 43464.3 43536.8 43786.3 6374.8 6460.5 6461.6 6536.5 6552.1 31633.7 32264.8 32367.5 32448.2 32632.3 40052.8 41884.0 42361.4 42770.8 43014.4 8686.8 8796.4 8812.4 8834.9 9129.7 9702.1 9768.7 9832.2 9904.9 9935.8 8393.0 8620.5 8623.5 8644.7 8671.7 8231.9 8262.3 8402.5 8426.5 8433.1 8624.1 8634.9 8638.2 8803.1 8976.3 7433.7 7485.9 7596.2 7781.1 7888.1 7747.8 8049.7 8065.7 8114.7 8455.7 07:32:42 INFO - 2015-11-23 07:32:42,103 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:32:42 INFO - 2015-11-23 07:32:42,103 DEBUG : BROWSER_OUTPUT: 07:32:42 INFO - 2015-11-23 07:32:42,877 INFO : Browser exited with error code: 0 07:32:42 INFO - 2015-11-23 07:32:42,896 INFO : Completed test dromaeo_css (00:18:37) 07:32:42 INFO - 2015-11-23 07:32:42,896 INFO : Starting test kraken 07:32:42 INFO - 2015-11-23 07:32:42,896 DEBUG : operating with platform_type : linux_ 07:32:42 INFO - 2015-11-23 07:32:42,896 INFO : Initialising browser for kraken test... 07:32:42 INFO - 2015-11-23 07:32:42,902 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfbvStw/profile http://localhost:50354/getInfo.html 07:32:47 INFO - 2015-11-23 07:32:47,140 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:32:47 INFO - 2015-11-23 07:32:47,140 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:32:47 INFO - 2015-11-23 07:32:47,140 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:32:47 INFO - 2015-11-23 07:32:47,140 DEBUG : BROWSER_OUTPUT: __metrics 07:32:47 INFO - 2015-11-23 07:32:47,281 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:32:48 INFO - 2015-11-23 07:32:48,572 INFO : Browser initialized. 07:32:48 INFO - 2015-11-23 07:32:48,573 INFO : Running cycle 1/1 for kraken test... 07:32:48 INFO - 2015-11-23 07:32:48,573 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfbvStw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:33:00 INFO - 2015-11-23 07:33:00,592 DEBUG : BROWSER_OUTPUT: RSS: Main: 143106048 07:33:00 INFO - 2015-11-23 07:33:00,592 DEBUG : BROWSER_OUTPUT: 07:33:03 INFO - 2015-11-23 07:33:03,212 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50354/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50354/tests/kraken/driver.html?testName=audio-beat-detection) 07:33:03 INFO - 2015-11-23 07:33:03,793 DEBUG : BROWSER_OUTPUT: RSS: Main: 180383744 07:33:03 INFO - 2015-11-23 07:33:03,794 DEBUG : BROWSER_OUTPUT: 07:33:06 INFO - 2015-11-23 07:33:06,551 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50354/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50354/tests/kraken/driver.html?testName=audio-dft) 07:33:07 INFO - 2015-11-23 07:33:07,120 DEBUG : BROWSER_OUTPUT: RSS: Main: 169185280 07:33:07 INFO - 2015-11-23 07:33:07,120 DEBUG : BROWSER_OUTPUT: 07:33:10 INFO - 2015-11-23 07:33:10,143 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50354/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50354/tests/kraken/driver.html?testName=audio-fft) 07:33:10 INFO - 2015-11-23 07:33:10,708 DEBUG : BROWSER_OUTPUT: RSS: Main: 152870912 07:33:10 INFO - 2015-11-23 07:33:10,709 DEBUG : BROWSER_OUTPUT: 07:33:12 INFO - 2015-11-23 07:33:12,746 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50354/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50354/tests/kraken/driver.html?testName=audio-oscillator) 07:33:13 INFO - 2015-11-23 07:33:13,319 DEBUG : BROWSER_OUTPUT: RSS: Main: 154861568 07:33:13 INFO - 2015-11-23 07:33:13,319 DEBUG : BROWSER_OUTPUT: 07:33:15 INFO - 2015-11-23 07:33:15,555 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50354/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50354/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:33:16 INFO - 2015-11-23 07:33:16,120 DEBUG : BROWSER_OUTPUT: RSS: Main: 158330880 07:33:16 INFO - 2015-11-23 07:33:16,120 DEBUG : BROWSER_OUTPUT: 07:33:19 INFO - 2015-11-23 07:33:19,105 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50354/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50354/tests/kraken/driver.html?testName=imaging-darkroom) 07:33:19 INFO - 2015-11-23 07:33:19,685 DEBUG : BROWSER_OUTPUT: RSS: Main: 156549120 07:33:19 INFO - 2015-11-23 07:33:19,686 DEBUG : BROWSER_OUTPUT: 07:33:23 INFO - 2015-11-23 07:33:23,059 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50354/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50354/tests/kraken/driver.html?testName=imaging-desaturate) 07:33:23 INFO - 2015-11-23 07:33:23,631 DEBUG : BROWSER_OUTPUT: RSS: Main: 157818880 07:33:23 INFO - 2015-11-23 07:33:23,632 DEBUG : BROWSER_OUTPUT: 07:33:26 INFO - 2015-11-23 07:33:26,504 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50354/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50354/tests/kraken/driver.html?testName=json-parse-financial) 07:33:27 INFO - 2015-11-23 07:33:27,085 DEBUG : BROWSER_OUTPUT: RSS: Main: 158212096 07:33:27 INFO - 2015-11-23 07:33:27,085 DEBUG : BROWSER_OUTPUT: 07:33:28 INFO - 2015-11-23 07:33:28,835 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50354/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50354/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:33:29 INFO - 2015-11-23 07:33:29,408 DEBUG : BROWSER_OUTPUT: RSS: Main: 165654528 07:33:29 INFO - 2015-11-23 07:33:29,408 DEBUG : BROWSER_OUTPUT: 07:33:31 INFO - 2015-11-23 07:33:31,303 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50354/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50354/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:33:31 INFO - 2015-11-23 07:33:31,904 DEBUG : BROWSER_OUTPUT: RSS: Main: 164888576 07:33:31 INFO - 2015-11-23 07:33:31,904 DEBUG : BROWSER_OUTPUT: 07:33:34 INFO - 2015-11-23 07:33:34,023 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50354/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50354/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:33:34 INFO - 2015-11-23 07:33:34,609 DEBUG : BROWSER_OUTPUT: RSS: Main: 174718976 07:33:34 INFO - 2015-11-23 07:33:34,609 DEBUG : BROWSER_OUTPUT: 07:33:37 INFO - 2015-11-23 07:33:37,190 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50354/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50354/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:33:37 INFO - 2015-11-23 07:33:37,773 DEBUG : BROWSER_OUTPUT: RSS: Main: 181403648 07:33:37 INFO - 2015-11-23 07:33:37,773 DEBUG : BROWSER_OUTPUT: 07:33:40 INFO - 2015-11-23 07:33:40,370 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50354/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50354/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:33:40 INFO - 2015-11-23 07:33:40,951 DEBUG : BROWSER_OUTPUT: RSS: Main: 179224576 07:33:40 INFO - 2015-11-23 07:33:40,952 DEBUG : BROWSER_OUTPUT: 07:33:42 INFO - 2015-11-23 07:33:42,720 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50354/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50354/tests/kraken/driver.html?testName=ai-astar) 07:33:42 INFO - 2015-11-23 07:33:42,966 DEBUG : BROWSER_OUTPUT: RSS: Main: 238452736 07:33:42 INFO - 2015-11-23 07:33:42,967 DEBUG : BROWSER_OUTPUT: 07:33:42 INFO - 2015-11-23 07:33:42,970 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:33:42 INFO - 2015-11-23 07:33:42,970 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:33:42 INFO - 2015-11-23 07:33:42,970 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:33:42 INFO - 2015-11-23 07:33:42,970 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:33:42 INFO - 2015-11-23 07:33:42,971 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;114;108;113;115;115;104;112;114;109 07:33:42 INFO - 2015-11-23 07:33:42,971 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;129;154;176;140;157;153;134;185;137 07:33:42 INFO - 2015-11-23 07:33:42,971 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;160;160;158;161;164;161;162;161 07:33:42 INFO - 2015-11-23 07:33:42,971 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;81;93;72;71;72;111;89;72 07:33:42 INFO - 2015-11-23 07:33:42,971 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;94;130;95;95;95;137;98;94;127 07:33:42 INFO - 2015-11-23 07:33:42,971 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;111;109;109;110;110;110;110;110 07:33:42 INFO - 2015-11-23 07:33:42,971 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;146;150;148;149;147;148;146;147;147 07:33:42 INFO - 2015-11-23 07:33:42,972 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;96;95;95;96;96;96;96 07:33:42 INFO - 2015-11-23 07:33:42,972 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;70;70;71;71;71;71;72;79;69;68 07:33:42 INFO - 2015-11-23 07:33:42,972 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;68;69;68;68;68;69;70;69;68 07:33:42 INFO - 2015-11-23 07:33:42,972 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;83;85;84;82;84;84;92;84;86 07:33:42 INFO - 2015-11-23 07:33:42,972 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;126;138;120;119;131;135;129;125;125 07:33:42 INFO - 2015-11-23 07:33:42,972 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;150;137;149;149;141;137;147;151;148;143 07:33:42 INFO - 2015-11-23 07:33:42,972 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;69;69;68;71;70;68;68;69;68 07:33:42 INFO - 2015-11-23 07:33:42,972 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:33:42 INFO - 2015-11-23 07:33:42,973 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:33:42 INFO - 2015-11-23 07:33:42,973 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,975 07:33:42 INFO - 2015-11-23 07:33:42,973 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:33:42 INFO - 2015-11-23 07:33:42,973 DEBUG : BROWSER_OUTPUT: __startTimestamp1448292822968__endTimestamp 07:33:42 INFO - 2015-11-23 07:33:42,973 DEBUG : BROWSER_OUTPUT: 07:33:42 INFO - 2015-11-23 07:33:42,976 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:33:42 INFO - 2015-11-23 07:33:42,976 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:33:42 INFO - 2015-11-23 07:33:42,976 DEBUG : BROWSER_OUTPUT: 07:33:42 INFO - 2015-11-23 07:33:42,976 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.60 Median:113.50 stddev:3.57 (3.1%) stddev-sans-first:3.78 07:33:42 INFO - 2015-11-23 07:33:42,976 DEBUG : BROWSER_OUTPUT: Values: 112.0 114.0 108.0 113.0 115.0 115.0 104.0 112.0 114.0 109.0 07:33:42 INFO - 2015-11-23 07:33:42,977 DEBUG : BROWSER_OUTPUT: 07:33:42 INFO - 2015-11-23 07:33:42,977 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:152.10 Median:155.00 stddev:18.05 (11.6%) stddev-sans-first:19.09 07:33:42 INFO - 2015-11-23 07:33:42,977 DEBUG : BROWSER_OUTPUT: Values: 156.0 129.0 154.0 176.0 140.0 157.0 153.0 134.0 185.0 137.0 07:33:42 INFO - 2015-11-23 07:33:42,977 DEBUG : BROWSER_OUTPUT: 07:33:42 INFO - 2015-11-23 07:33:42,977 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.55 (1.0%) stddev-sans-first:1.64 07:33:42 INFO - 2015-11-23 07:33:42,977 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 160.0 160.0 158.0 161.0 164.0 161.0 162.0 161.0 07:33:42 INFO - 2015-11-23 07:33:42,977 DEBUG : BROWSER_OUTPUT: 07:33:42 INFO - 2015-11-23 07:33:42,977 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.60 Median:72.50 stddev:13.31 (18.4%) stddev-sans-first:13.75 07:33:42 INFO - 2015-11-23 07:33:42,977 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 81.0 93.0 72.0 71.0 72.0 111.0 89.0 72.0 07:33:42 INFO - 2015-11-23 07:33:42,977 DEBUG : BROWSER_OUTPUT: 07:33:42 INFO - 2015-11-23 07:33:42,977 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.00 Median:95.00 stddev:17.68 (18.6%) stddev-sans-first:18.30 07:33:42 INFO - 2015-11-23 07:33:42,977 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 130.0 95.0 95.0 95.0 137.0 98.0 94.0 127.0 07:33:42 INFO - 2015-11-23 07:33:42,977 DEBUG : BROWSER_OUTPUT: 07:33:42 INFO - 2015-11-23 07:33:42,977 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 07:33:42 INFO - 2015-11-23 07:33:42,977 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 111.0 109.0 109.0 110.0 110.0 110.0 110.0 110.0 07:33:42 INFO - 2015-11-23 07:33:42,977 DEBUG : BROWSER_OUTPUT: 07:33:42 INFO - 2015-11-23 07:33:42,978 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:1.26 (0.9%) stddev-sans-first:1.33 07:33:42 INFO - 2015-11-23 07:33:42,978 DEBUG : BROWSER_OUTPUT: Values: 148.0 146.0 150.0 148.0 149.0 147.0 148.0 146.0 147.0 147.0 07:33:42 INFO - 2015-11-23 07:33:42,978 DEBUG : BROWSER_OUTPUT: 07:33:42 INFO - 2015-11-23 07:33:42,978 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 07:33:42 INFO - 2015-11-23 07:33:42,978 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 96.0 95.0 95.0 96.0 96.0 96.0 96.0 07:33:42 INFO - 2015-11-23 07:33:42,978 DEBUG : BROWSER_OUTPUT: 07:33:42 INFO - 2015-11-23 07:33:42,978 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.20 Median:71.00 stddev:2.97 (4.2%) stddev-sans-first:3.12 07:33:42 INFO - 2015-11-23 07:33:42,978 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 71.0 71.0 71.0 71.0 72.0 79.0 69.0 68.0 07:33:42 INFO - 2015-11-23 07:33:42,978 DEBUG : BROWSER_OUTPUT: 07:33:42 INFO - 2015-11-23 07:33:42,978 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 07:33:42 INFO - 2015-11-23 07:33:42,978 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 69.0 68.0 68.0 68.0 69.0 70.0 69.0 68.0 07:33:42 INFO - 2015-11-23 07:33:42,978 DEBUG : BROWSER_OUTPUT: 07:33:42 INFO - 2015-11-23 07:33:42,978 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:84.00 stddev:2.99 (3.6%) stddev-sans-first:2.89 07:33:42 INFO - 2015-11-23 07:33:42,978 DEBUG : BROWSER_OUTPUT: Values: 81.0 83.0 85.0 84.0 82.0 84.0 84.0 92.0 84.0 86.0 07:33:42 INFO - 2015-11-23 07:33:42,979 DEBUG : BROWSER_OUTPUT: 07:33:42 INFO - 2015-11-23 07:33:42,979 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.00 Median:127.50 stddev:6.25 (4.9%) stddev-sans-first:6.37 07:33:42 INFO - 2015-11-23 07:33:42,979 DEBUG : BROWSER_OUTPUT: Values: 122.0 126.0 138.0 120.0 119.0 131.0 135.0 129.0 125.0 125.0 07:33:42 INFO - 2015-11-23 07:33:42,979 DEBUG : BROWSER_OUTPUT: 07:33:42 INFO - 2015-11-23 07:33:42,979 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.20 Median:148.50 stddev:5.31 (3.6%) stddev-sans-first:5.34 07:33:42 INFO - 2015-11-23 07:33:42,979 DEBUG : BROWSER_OUTPUT: Values: 150.0 137.0 149.0 149.0 141.0 137.0 147.0 151.0 148.0 143.0 07:33:42 INFO - 2015-11-23 07:33:42,980 DEBUG : BROWSER_OUTPUT: 07:33:42 INFO - 2015-11-23 07:33:42,980 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:1.03 (1.5%) stddev-sans-first:1.05 07:33:42 INFO - 2015-11-23 07:33:42,980 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 68.0 71.0 70.0 68.0 68.0 69.0 68.0 07:33:42 INFO - 2015-11-23 07:33:42,980 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:33:42 INFO - 2015-11-23 07:33:42,980 DEBUG : BROWSER_OUTPUT: 07:33:43 INFO - 2015-11-23 07:33:43,925 INFO : Browser exited with error code: 0 07:33:43 INFO - 2015-11-23 07:33:43,976 INFO : Completed test kraken (00:01:01) 07:33:43 INFO - 2015-11-23 07:33:43,976 INFO : Starting test v8_7 07:33:43 INFO - 2015-11-23 07:33:43,976 DEBUG : operating with platform_type : linux_ 07:33:43 INFO - 2015-11-23 07:33:43,976 INFO : Initialising browser for v8_7 test... 07:33:43 INFO - 2015-11-23 07:33:43,983 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjfXrgr/profile http://localhost:50354/getInfo.html 07:33:48 INFO - 2015-11-23 07:33:48,035 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:33:48 INFO - 2015-11-23 07:33:48,035 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:33:48 INFO - 2015-11-23 07:33:48,035 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:33:48 INFO - 2015-11-23 07:33:48,035 DEBUG : BROWSER_OUTPUT: __metrics 07:33:48 INFO - 2015-11-23 07:33:48,192 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:33:49 INFO - 2015-11-23 07:33:49,452 INFO : Browser initialized. 07:33:49 INFO - 2015-11-23 07:33:49,453 INFO : Running cycle 1/1 for v8_7 test... 07:33:49 INFO - 2015-11-23 07:33:49,453 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjfXrgr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:34:01 INFO - 2015-11-23 07:34:01,433 DEBUG : BROWSER_OUTPUT: RSS: Main: 140595200 07:34:01 INFO - 2015-11-23 07:34:01,433 DEBUG : BROWSER_OUTPUT: 07:34:22 INFO - 2015-11-23 07:34:22,910 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50354/tests/v8_7/run.html (next: http://localhost:50354/tests/v8_7/run.html) 07:34:23 INFO - 2015-11-23 07:34:23,169 DEBUG : BROWSER_OUTPUT: RSS: Main: 453394432 07:34:23 INFO - 2015-11-23 07:34:23,169 DEBUG : BROWSER_OUTPUT: 07:34:23 INFO - 2015-11-23 07:34:23,169 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:34:23 INFO - 2015-11-23 07:34:23,169 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:34:23 INFO - 2015-11-23 07:34:23,169 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:34:23 INFO - 2015-11-23 07:34:23,169 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:34:23 INFO - 2015-11-23 07:34:23,169 DEBUG : BROWSER_OUTPUT: |0;Richards;190.2587519025875 07:34:23 INFO - 2015-11-23 07:34:23,169 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.7608990505716 07:34:23 INFO - 2015-11-23 07:34:23,169 DEBUG : BROWSER_OUTPUT: |2;Encrypt;282.4060999717594 07:34:23 INFO - 2015-11-23 07:34:23,169 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4975.124378109453 07:34:23 INFO - 2015-11-23 07:34:23,170 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1951.2670565302144 07:34:23 INFO - 2015-11-23 07:34:23,170 DEBUG : BROWSER_OUTPUT: |5;Earley;800 07:34:23 INFO - 2015-11-23 07:34:23,170 DEBUG : BROWSER_OUTPUT: |6;Boyer;12407.407407407407 07:34:23 INFO - 2015-11-23 07:34:23,170 DEBUG : BROWSER_OUTPUT: |7;RegExp;26153.846153846152 07:34:23 INFO - 2015-11-23 07:34:23,170 DEBUG : BROWSER_OUTPUT: |8;Splay;594.3060498220641 07:34:23 INFO - 2015-11-23 07:34:23,170 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 07:34:23 INFO - 2015-11-23 07:34:23,170 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:34:23 INFO - 2015-11-23 07:34:23,170 DEBUG : BROWSER_OUTPUT: __startTimestamp1448292863163__endTimestamp 07:34:23 INFO - 2015-11-23 07:34:23,170 DEBUG : BROWSER_OUTPUT: 07:34:23 INFO - 2015-11-23 07:34:23,170 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:34:23 INFO - 2015-11-23 07:34:23,170 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:34:23 INFO - 2015-11-23 07:34:23,170 DEBUG : BROWSER_OUTPUT: 07:34:23 INFO - 2015-11-23 07:34:23,170 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:190.26 Median:190.26 stddev:0.00 (0.0%) 07:34:23 INFO - 2015-11-23 07:34:23,170 DEBUG : BROWSER_OUTPUT: Values: 190.3 07:34:23 INFO - 2015-11-23 07:34:23,170 DEBUG : BROWSER_OUTPUT: 07:34:23 INFO - 2015-11-23 07:34:23,171 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.76 Median:193.76 stddev:0.00 (0.0%) 07:34:23 INFO - 2015-11-23 07:34:23,171 DEBUG : BROWSER_OUTPUT: Values: 193.8 07:34:23 INFO - 2015-11-23 07:34:23,171 DEBUG : BROWSER_OUTPUT: 07:34:23 INFO - 2015-11-23 07:34:23,171 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:282.41 Median:282.41 stddev:0.00 (0.0%) 07:34:23 INFO - 2015-11-23 07:34:23,171 DEBUG : BROWSER_OUTPUT: Values: 282.4 07:34:23 INFO - 2015-11-23 07:34:23,171 DEBUG : BROWSER_OUTPUT: 07:34:23 INFO - 2015-11-23 07:34:23,171 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4975.12 Median:4975.12 stddev:0.00 (0.0%) 07:34:23 INFO - 2015-11-23 07:34:23,171 DEBUG : BROWSER_OUTPUT: Values: 4975.1 07:34:23 INFO - 2015-11-23 07:34:23,171 DEBUG : BROWSER_OUTPUT: 07:34:23 INFO - 2015-11-23 07:34:23,171 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1951.27 Median:1951.27 stddev:0.00 (0.0%) 07:34:23 INFO - 2015-11-23 07:34:23,171 DEBUG : BROWSER_OUTPUT: Values: 1951.3 07:34:23 INFO - 2015-11-23 07:34:23,171 DEBUG : BROWSER_OUTPUT: 07:34:23 INFO - 2015-11-23 07:34:23,171 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:800.00 Median:800.00 stddev:0.00 (0.0%) 07:34:23 INFO - 2015-11-23 07:34:23,171 DEBUG : BROWSER_OUTPUT: Values: 800.0 07:34:23 INFO - 2015-11-23 07:34:23,171 DEBUG : BROWSER_OUTPUT: 07:34:23 INFO - 2015-11-23 07:34:23,171 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12407.41 Median:12407.41 stddev:0.00 (0.0%) 07:34:23 INFO - 2015-11-23 07:34:23,172 DEBUG : BROWSER_OUTPUT: Values: 12407.4 07:34:23 INFO - 2015-11-23 07:34:23,172 DEBUG : BROWSER_OUTPUT: 07:34:23 INFO - 2015-11-23 07:34:23,172 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26153.85 Median:26153.85 stddev:0.00 (0.0%) 07:34:23 INFO - 2015-11-23 07:34:23,172 DEBUG : BROWSER_OUTPUT: Values: 26153.8 07:34:23 INFO - 2015-11-23 07:34:23,172 DEBUG : BROWSER_OUTPUT: 07:34:23 INFO - 2015-11-23 07:34:23,172 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:594.31 Median:594.31 stddev:0.00 (0.0%) 07:34:23 INFO - 2015-11-23 07:34:23,172 DEBUG : BROWSER_OUTPUT: Values: 594.3 07:34:23 INFO - 2015-11-23 07:34:23,172 DEBUG : BROWSER_OUTPUT: 07:34:23 INFO - 2015-11-23 07:34:23,172 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 07:34:23 INFO - 2015-11-23 07:34:23,172 DEBUG : BROWSER_OUTPUT: Values: 4830.9 07:34:23 INFO - 2015-11-23 07:34:23,172 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:34:23 INFO - 2015-11-23 07:34:23,172 DEBUG : BROWSER_OUTPUT: 07:34:24 INFO - 2015-11-23 07:34:24,065 INFO : Browser exited with error code: 0 07:34:24 INFO - 2015-11-23 07:34:24,084 INFO : Completed test v8_7 (00:00:40) 07:34:24 INFO - 2015-11-23 07:34:24,114 INFO : Completed test suite (00:20:19) 07:34:24 INFO - 2015-11-23 07:34:24,114 DEBUG : Working with test: dromaeo_css 07:34:24 INFO - 2015-11-23 07:34:24,115 DEBUG : Generating results file: dromaeo_css 07:34:24 INFO - 2015-11-23 07:34:24,116 DEBUG : Working with test: kraken 07:34:24 INFO - 2015-11-23 07:34:24,116 DEBUG : Generating results file: kraken 07:34:24 INFO - 2015-11-23 07:34:24,116 INFO : javascript benchmark 07:34:24 INFO - 2015-11-23 07:34:24,116 DEBUG : Working with test: v8_7 07:34:24 INFO - 2015-11-23 07:34:24,116 DEBUG : Generating results file: v8_7 07:34:24 INFO - 2015-11-23 07:34:24,117 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:34:24 INFO - 2015-11-23 07:34:24,180 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 07:34:24 INFO - 2015-11-23 07:34:24,181 DEBUG : process_Request line: dromaeo_css 6165.06 graph.html#tests=[[72,132,35]] 07:34:24 INFO - 2015-11-23 07:34:24,181 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:34:24 INFO - 2015-11-23 07:34:24,216 DEBUG : process_Request line: kraken 1529.50 graph.html#tests=[[232,132,35]] 07:34:24 INFO - 2015-11-23 07:34:24,217 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:34:24 INFO - 2015-11-23 07:34:24,254 DEBUG : process_Request line: v8_7 19574.32 graph.html#tests=[[230,132,35]] 07:34:24 INFO - 2015-11-23 07:34:24,255 INFO : javascript benchmark 07:34:24 INFO - 2015-11-23 07:34:24,259 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2573.163721790418, 2661.4144888124606, 2668.933276668083, 2669.7196794336605, 2688.045743760965, 4430.09183117461, 4560.70355426897, 4597.632189424842, 4637.605803506702, 4647.581717645411, 4525.298578720295, 4542.841000564981, 4610.308453731942, 4612.469565999911, 4635.976820115895, 4247.214265360918, 4255.851045213418, 4282.122164956192, 4282.614564689169, 4350.1734670412525, 4145.689073319513, 4333.0, 4349.0, 4371.038371558252, 4384.342348647697, 4198.118395137025, 4258.276093064171, 4260.998665313648, 4290.69965102443, 4297.914041719179, 4301.0, 4305.698601097924, 4320.503142138663, 4332.458442694663, 4344.109457561192, 4125.628693417577, 4214.4099826024385, 4288.892777680552, 4297.290946993742, 4345.913081738379, 4469.888252793674, 4494.438195225597, 4558.475775285819, 4571.58855702985, 4613.077384523109, 4967.82612608557, 4980.427250866161, 4982.725950072744, 4984.352034235562, 5005.974970125162, 4774.80900763969, 4886.804527818883, 4984.0, 4994.600431965434, 5001.09848409193, 4565.5206203348835, 4603.953960460386, 4648.558386953234, 4655.464621568495, 4711.81152753886, 5102.5662818660085, 5121.206213036985, 5163.14808056674, 5163.380394352702, 5165.096108181053, 4689.062187562433, 4783.067301876101, 4938.629602779806, 4940.580050695659, 4943.530364615356, 4866.099771542205, 4885.340479035356, 4945.010997800454, 4952.4057113146655, 4999.625028122832, 4878.170710979142, 4908.533689299511, 4913.778879950411, 4919.803207871645, 4964.578010869117, 4696.694714843524, 4796.472388037313, 4868.95131048692, 4872.853814385574, 4924.03981223658, 4029.315016447211, 4055.148418832019, 4092.345224764083, 4111.424400583921, 4111.671066314688, 3573.285342931424, 3605.2248766515327, 3608.80151591665, 3638.399664055454, 3640.10817349751, 4142.958570414257, 4301.333293339538, 4306.720063195882, 4315.632754342431, 4342.869713908588, 4834.613230941516, 4900.117978763857, 4909.754512274372, 4930.11257973561, 4930.161872481687, 4262.722923010057, 4324.481062272547, 4325.502567204811, 4328.5455027222315, 4365.628921541705, 4216.852410165629, 4422.977885110618, 4450.532694067141, 4451.799669014902, 4478.216312145361, 4603.953960460352, 4622.121796858586, 4640.164770341304, 4717.929231061606, 4741.786619602195, 4923.606111510999, 4943.466992981212, 4950.8267210647455, 4953.826616068421, 4999.65002449825, 4692.765361731831, 4693.296005599187, 4693.389859318267, 4697.577218050255, 4740.834070807505, 4730.952690473051, 4751.691140075884, 4812.0, 4812.663113582015, 4817.710937343771, 4942.901141977212, 4959.479254678206, 4984.775685094252, 4988.201887697951, 4991.401031876198, 4828.468868424541, 4831.758412079312, 4836.637252206169, 4840.2255639097575, 4879.853604391874, 4662.7202367858035, 4743.905121897612, 4811.446683631427, 4828.517148285284, 4871.926921096116, 4638.768061596839, 4676.6492513060975, 4764.618830493621, 4792.664513484023, 4803.615710743202, 4763.952360476351, 4786.0, 4800.207965685623, 4812.35033270504, 4846.297286893451, 4563.269876819693, 4699.765011749467, 4701.0, 4706.223473126895, 4739.786709598007], "unit": "ms", "name": "dojo.html", "value": 4533.1602999276065}, {"lowerIsBetter": false, "replicates": [545.4425350810143, 573.1116769008037, 573.5067841656172, 581.453433772254, 587.3245767367528, 28221.717782822165, 28737.85631071847, 28780.568291475643, 28783.424331513357, 28793.856030719817, 29114.854425727895, 29537.0, 36952.81523592378, 37483.25033499328, 37768.43347349785, 7943.205679432069, 7978.481398709066, 7991.24083212094, 7994.000749906262, 8006.159353267911, 7107.964460177718, 7796.727114550992, 7926.484778489408, 7928.80177995549, 7975.641096150658, 7037.718491260343, 9877.407355558653, 10155.543000564992, 10155.644552440666, 10160.491975401237, 9825.508724563742, 9879.555420006118, 9918.454485003322, 9923.057309555652, 9927.0, 7140.571565706075, 7329.853402931964, 9555.856662150003, 9657.661981830603, 10070.194384449227, 36042.45936310958, 36414.817925910465, 36431.27137457236, 36442.81778591117, 36443.0, 2603.597535114645, 2638.9868050659816, 2700.6894207166033, 2704.3644743485265, 3386.915327116817, 27668.723312766815, 28324.858375708194, 28354.0, 28520.857395713098, 28669.0, 3406.744494162948, 3496.283261931298, 3513.771604845677, 3559.323728491578, 3623.8188090595363, 220732.0, 221066.0, 222824.0, 223123.0, 223345.0, 55389.723051384484, 55557.44442555604, 55720.44279557152, 55725.721371393694, 55860.44139558553, 52655.21017184745, 53720.0, 58308.0, 58825.41174588285, 62999.0, 14364.497242596459, 14460.276986150651, 14535.709285814224, 14585.489507867385, 14588.41646334156, 11006.669799906016, 11086.944565277283, 11126.0, 11137.498812553455, 11145.554177832959, 18451.538711532052, 18561.90719046396, 18710.966774918812, 18806.529836753918, 18808.52978675544, 7048.436125109979, 7369.6315184240575, 7438.5536867788105, 7489.063867016623, 7517.323440890346, 853.5518852602434, 877.7498412952406, 880.6389380354024, 881.7619242804407, 944.0276515189366, 26129.0, 26640.866795665897, 26655.33361665935, 26726.732732672423, 26761.197164085108, 920.4983284110176, 930.251147825993, 942.2509105261333, 990.4156547636928, 1006.8288390973552, 12687.682807929876, 12790.744185116431, 12843.03677224212, 14107.294635268196, 15322.923385383225, 258466.0, 261615.0, 262270.0, 262937.0, 263330.0, 45666.77166614212, 45751.08497830025, 45812.0, 45874.77062614666, 46092.53907460949, 1186.1578279421708, 1198.532572296805, 1212.5331747277362, 1213.9635810925686, 1223.8409006829056, 26226.475470490102, 27070.593941091294, 27213.87248613581, 27297.181084567495, 27619.171424857286, 35247.0, 36035.81982090178, 42056.78971605122, 43170.56829431791, 43202.13595728131, 221978.0, 222388.0, 223753.0, 223835.0, 224580.0, 23717.762822372246, 24048.39879003039, 24143.637845432684, 27822.66128064645, 28104.156875293775, 27281.454370912074, 28846.855765721037, 34990.30019399547, 35569.46645800367, 35799.46300805438, 30243.848780755954, 30306.242343941576, 30702.078937631908, 30840.074797756104, 31168.0, 33151.83424082864, 34001.82999084989, 35969.46045809367, 36253.818730906176, 36396.45405318975, 32936.176595584344, 33023.174420639676, 33351.16622084467, 33376.0, 33461.83269083639, 27067.72932270652, 27923.44153116967, 29731.256718582208, 29805.552916705834, 29954.0, 23122.421939450975, 23231.767682323636, 23291.88354058219, 23391.298261052194, 23512.529749404574], "unit": "ms", "name": "ext.html", "value": 16671.586897077766}, {"lowerIsBetter": false, "replicates": [330.5867665418227, 334.2396048988551, 334.69542716128313, 334.8822462870674, 338.3030956230166, 12395.008399328055, 12823.615291541246, 15022.57285557873, 15283.018867924531, 16650.750238746412, 14916.552503424915, 15254.068976474908, 15941.362345506166, 16118.194090295498, 16138.515844524654, 3962.603739626043, 4762.142814293417, 4852.830150944717, 4858.149823780842, 4865.343178670887, 4895.167821470341, 4902.534259245366, 4927.630427717918, 4930.4083509978855, 4934.28452874333, 4813.927791083119, 4891.5353041461, 4898.41219053714, 4946.530079642428, 4962.181240095398, 4869.172240719051, 4888.437829649582, 4904.141775189363, 4922.729249891255, 4926.605871530287, 4278.058827058042, 4391.9780401098105, 4405.29515277554, 4407.889802754957, 4411.139827733593, 19158.904205479022, 19159.137838797287, 19271.036448177674, 19277.012063130238, 19400.80599194004, 1754.1317048061164, 1757.2707326459504, 1768.777745776677, 1780.0832571225828, 1833.7432759413693, 12542.874571254262, 12585.496580136783, 12695.492180312776, 13001.089923705344, 13001.86998130016, 1727.7494763259383, 1730.1695186310515, 1740.1647209339462, 1749.422690512128, 1813.1931290575699, 51202.0, 53326.0, 54328.72835635836, 54452.183217251775, 55158.44841551573, 9359.391639543408, 9424.387414818015, 9689.176420004378, 9714.0, 9721.270904682176, 10747.516361763739, 11051.613193538187, 11408.429578521207, 12249.938750306192, 12301.938490307492, 6906.965465172642, 7014.19336776267, 7018.894716579255, 7111.2533184015965, 7148.499605027702, 6733.158355205599, 6748.257691653914, 6854.588724676535, 6871.415929645936, 6908.447324214051, 5724.742386592613, 5800.8259752207505, 5804.79683211094, 5828.184054232411, 5834.212381328466, 1677.2368572299574, 1697.125980120239, 1700.9404670836461, 1704.7783788107467, 1711.5085226138785, 802.2458888644655, 805.8831469436899, 856.4475913036057, 877.5217506458995, 993.9453330066916, 16299.0, 16306.347746090261, 16377.754333685005, 16577.50267491953, 16755.413560525565, 779.3492433817712, 795.6220795122271, 822.198356602308, 854.606880834823, 926.4672813132341, 5734.598578099493, 7337.19290878003, 8585.828283434297, 8864.113588641214, 9270.119338662817, 335148.0, 336327.0, 340123.0, 463468.0, 466084.0, 55272.17091743627, 60499.69750151221, 60896.69551652214, 63096.79741633558, 63553.36446635567, 414.7242084014157, 457.01969275903, 464.64454692160524, 466.8739440351086, 466.9673122881434, 9504.239660827256, 9720.562574684298, 9795.0, 9923.603055877684, 10039.648612298535, 31048.223794404417, 32028.5195722069, 33447.83276083604, 33485.83257083699, 34200.486992694634, 43683.78158109189, 43947.34078988754, 45995.77002114968, 46737.2989405166, 47060.7646961763, 8918.509481978554, 9022.684206052756, 9207.907920920972, 9221.769455763659, 9228.676996305365, 13637.386317615532, 15997.440089596808, 16153.596160095622, 16402.0, 16535.25591348368, 13451.394687238902, 13525.0, 13655.04414690962, 13979.650508737363, 14137.939654525746, 13258.403371848482, 13267.867321326663, 13297.0, 13580.728385432434, 13610.115342502706, 13965.231912244924, 14140.292985350485, 14237.71524569482, 14341.56975290743, 14599.489017884323, 8808.64765409402, 8906.73279801607, 8911.643534258557, 9098.363114581916, 9115.407498512575, 13293.468261269441, 13447.865521344662, 13468.730625387241, 14034.859651403356, 14145.858541414455], "unit": "ms", "name": "jquery.html", "value": 7961.208324631714}, {"lowerIsBetter": false, "replicates": [1398.6153807702888, 1567.612662793428, 1621.4730212680875, 1634.901905885647, 1659.2201665217344, 5560.52735517481, 6237.563370564057, 6302.464290535304, 6302.716377763, 6305.432511074003, 6388.520860935425, 6482.384173503521, 6484.4488218501365, 6487.026945958109, 6489.61062336259, 2014.979850201494, 2017.0923084611948, 2039.2658642888548, 2040.5102775333962, 2041.4181958141933, 2014.385612388221, 2033.0, 2040.3980825656467, 2040.9897950510301, 2041.4284000479815, 1869.560653246486, 1894.6873765828623, 1903.8667293289475, 1907.418237437581, 1908.1699460734555, 1972.4279958811928, 1984.732061171745, 1985.4936991067257, 1995.9401217963484, 2003.8196562309463, 2009.1661960286463, 2012.939611811648, 2018.8485863560293, 2039.0722221389233, 2040.5714799892041, 5502.339719233678, 5673.773049078032, 6443.420092191725, 6455.903161452582, 6475.7085931133215, 3798.240351929625, 3953.0, 3955.3275943089457, 3962.0, 3963.663088637469, 2639.0499420208707, 2658.70754217036, 2667.279834444689, 2687.8924843006257, 2696.7572918437436, 882.6248844241172, 891.4250308551013, 894.5080205886736, 900.8468560344758, 905.3255324783079, 8615.310775137974, 8642.092580279043, 8660.437071590326, 8671.609777560025, 8685.348598855047, 3691.5201023866725, 3693.0, 3715.0898029982827, 3727.2918145552258, 3730.2725968435893, 7690.0, 7699.076110866732, 7714.9228507715325, 7720.343770779435, 7724.575148366781, 3923.7841918694744, 3941.0935484838647, 3942.8817135485983, 3943.2507823513442, 3946.348852439373, 3572.8570857165423, 3608.530890984208, 3611.1513794258326, 3613.223157021253, 3615.4034584293295, 3091.721745042912, 3100.364425292855, 3105.0995211388445, 3114.205877501268, 3127.702868227515, 968.5496244246459, 972.4457059476031, 975.3075316525346, 986.4673076538733, 999.14073896449, 1059.327327147267, 1079.6707004363745, 1138.8690300615535, 1152.6945359479744, 1158.1545471805462, 6231.158793562901, 6234.0337247726675, 6268.561200715997, 6273.749050038039, 6276.403741644536, 1070.464767616192, 1097.067492631257, 1101.2676570080966, 1114.0, 1123.3316176874746, 4752.643551733634, 4807.110684523374, 4818.469968303484, 4830.130576496194, 4833.32333473314, 7231.566106033655, 7649.31156195945, 7747.922520774833, 7754.844903101906, 7766.844663106706, 7613.162552119263, 7631.771046868603, 7656.502327348704, 7665.693372265158, 7720.845583088307, 6146.938530614726, 6391.265004524446, 6406.67966601668, 6424.293327733945, 6435.517336199804, 6229.595076320206, 6248.625082495065, 6251.0, 6259.998400255937, 6260.217472815898, 7042.859142817012, 7188.0, 7279.8544029120185, 7282.890756638761, 7296.635168241461, 7287.234840341688, 7410.11078670563, 7426.183119856703, 7437.628118593941, 7503.66233519482, 5674.546036317167, 5754.0, 5779.959607270732, 5781.768729250951, 5782.190493330853, 5917.319508256605, 6269.874602508015, 6299.30707622152, 6303.842403939938, 6308.337624549356, 6066.575339726177, 6077.969610151921, 6129.2032035835055, 6140.109684095871, 6196.225471816023, 6015.72929218195, 6104.938950610437, 6152.384761523991, 6153.230846144232, 6205.906911396242, 6018.849528761816, 6038.6678732670125, 6044.274687037584, 6085.056816193497, 6145.385461453819, 5632.183333416713, 5668.603197776281, 5676.460736230051, 5676.971615141898, 5677.489025987681, 5796.507296879812, 5847.678377689268, 5856.502197313276, 5858.531317494675, 5863.530917526502], "unit": "ms", "name": "mootools.html", "value": 3875.2267130557}, {"lowerIsBetter": false, "replicates": [302.9500132478141, 306.6458240731955, 309.19454820193397, 312.23813894098396, 315.26857690158835, 5456.781728730851, 5473.67157970521, 5491.835244942648, 5510.201020851979, 5523.0, 5148.099082660528, 5282.0, 5312.07038768216, 5434.673919564829, 5461.2354270402175, 4249.426327445802, 4267.615914567688, 4272.081502476967, 4274.380214868857, 4299.011227417695, 4043.7978101094973, 4258.339957306623, 4267.167902259061, 4278.165757677254, 4282.7858607069675, 4084.1831633673237, 4114.958850411487, 4199.7480151190875, 4241.151769646068, 4248.915021699564, 4235.449391579105, 4236.703430759848, 4242.575742425764, 4250.341197114452, 4251.978740106295, 3757.6618104370737, 3758.1356288053626, 3762.191128907298, 3772.264408440355, 3774.622537746231, 5253.605979551511, 5265.236540701577, 5272.657277276965, 5274.103402421598, 5279.0, 4783.258594917794, 4898.681585696918, 4901.975490122562, 4910.508949105061, 4914.754262286871, 5702.372738998707, 5707.400722924075, 5708.486236238717, 5715.714214289269, 5718.828435146911, 4043.555208927016, 4077.6533994610195, 4084.326086195804, 4086.4074709167303, 4091.3862920562156, 5854.5023672987845, 6001.729922153513, 6007.969960150215, 6009.429104235091, 6011.158437818709, 4202.978985105055, 4210.7473551587, 4211.894702632459, 4217.704760666786, 4229.323308270662, 4264.765437900884, 4274.786260686953, 4274.829006839754, 4276.2089013532595, 4281.957180428218, 4831.782569784368, 4839.249916262985, 4843.370361853007, 4844.249141383091, 4852.805887764521, 5563.36021357541, 5705.857353566111, 5711.371749107595, 5712.143178523254, 5718.656880587095, 1483.8293596236572, 1509.3811537269667, 1509.9396024158912, 1510.5996910818642, 1514.48507507448, 1034.1468288661883, 1039.262123892045, 1050.3645294596658, 1057.0169742139883, 1072.6406653771073, 5030.647854650139, 5035.96762663653, 5042.974785126051, 5048.974755126201, 5055.418626857959, 5917.082852157922, 5928.347881733006, 5944.405559444108, 5948.583599148018, 5955.047192449274, 4881.536254055859, 4950.579200767903, 5012.147934851084, 5038.773255203525, 5086.669366491166, 3191.2500562367827, 3197.4564324064963, 3216.9195770105935, 3220.710136087763, 3232.095013396206, 5644.322681278273, 5654.236678048411, 5658.009848276535, 5659.745311460994, 5670.716464176857, 5992.730327135289, 6142.0, 6142.140100385949, 6143.539234557426, 6146.108814222002, 5666.433356664383, 5671.1493276008105, 5671.404502527175, 5672.092465205547, 5672.631278966854, 5973.074173503114, 5978.103284507359, 5979.133025711334, 5986.850328741816, 5987.461128498456, 5823.097419899922, 5824.184614154106, 5835.328937172279, 5838.970805146117, 5840.065589505659, 5511.614187006871, 5654.208410822571, 5667.3482549507335, 5669.149627555899, 5669.177969194526, 4257.254980378483, 4259.063006138645, 4262.275413179829, 4263.083437061046, 4266.0827921996915, 5965.045592705146, 5965.522758179422, 5966.731497082555, 5970.313413957277, 5978.641281523122, 5622.100463925753, 5725.456081672234, 5738.540916726568, 5743.195952566561, 5748.137779332967, 5723.8855222896145, 5725.0, 5737.540996720336, 5742.08126699726, 5747.453991870766, 5610.7194640268635, 5614.29821272341, 5615.719214039364, 5616.494515493625, 5618.5110945598635, 5611.523020543136, 5764.0, 5775.595708300379, 5787.826365209051, 5790.420957904176, 5662.8301150965535, 5663.830085097454, 5669.177969194361, 5671.0359238930305, 5675.120356344773], "unit": "ms", "name": "prototype.html", "value": 4336.741492940943}, {"lowerIsBetter": false, "replicates": [617.4566381584206, 628.5757113948084, 713.7010640634046, 756.5196100476196, 768.488954845028, 11372.658820235396, 11669.12481563884, 11678.0, 11688.298702077871, 11689.12331575131, 11570.190086693934, 11695.0, 12908.483660653586, 13246.536371227008, 13289.401976911038, 601.7532811547267, 609.1958614628692, 763.4541302968377, 776.1384862802284, 778.1051790440981, 612.3417326374143, 761.889526018727, 772.5441989226356, 773.6325245508367, 777.9416543759212, 793.6864938349348, 807.4105902691039, 807.725373373053, 807.9313258373045, 808.3573559020564, 634.0932466572822, 642.3095172689331, 787.1695361393728, 797.4417907464768, 798.3652995868299, 589.8377946064824, 593.1577160432197, 593.9346671866091, 594.1118028547306, 594.7829042399536, 11708.765824683544, 12003.399830008551, 12013.219140755911, 12039.976601988841, 12045.939770301093, 11070.944645276722, 11592.536298548048, 11718.941405293004, 12028.69928251792, 12373.69065773354, 9317.161455468973, 9519.143277105024, 9783.41299522031, 9918.156956658693, 9957.601695932153, 3244.30247496787, 3275.3449310138067, 3289.654586268455, 3299.0927494939083, 3314.2045908981913, 42614.0, 42900.0, 43144.13711725779, 43282.78358608218, 43407.56592434035, 9781.119699226962, 9863.309568330147, 10010.199184065257, 10051.59793608262, 10087.798244035079, 17202.827971720122, 17220.741688874677, 17237.39669111575, 17280.13599320029, 17304.480865574053, 6063.757449701962, 6294.339094395114, 6384.776532821329, 6471.708773105222, 6501.44737697301, 3524.8590056397456, 3532.894013179609, 3603.279344131184, 3629.7822130672243, 3702.9259414811554, 2578.1749840051, 2622.239550530363, 2623.317937336268, 2625.0287393664466, 2629.763321301092, 469.3569809361129, 477.2483338741496, 477.93308936748883, 480.37071436418404, 483.1496566043718, 369.5159341262954, 384.9210911763082, 388.03186050803424, 403.9757614543078, 448.7666413465045, 6684.665766711645, 6950.0, 7059.964700176569, 7062.540934839219, 7140.321669441499, 434.9325854492559, 485.53631282125485, 547.2693953572026, 553.8283132228942, 602.4367216652444, 3087.737542308884, 3274.6397896231397, 3352.7150192233444, 3352.8491217894766, 3359.8488068036995, 53549.464505354445, 54614.0, 54762.72618636881, 54773.726131369884, 55021.0, 46836.531634683895, 47149.528504714515, 47516.52483475121, 47944.520554794006, 48050.0, 42926.57073429288, 43098.569014309454, 43464.348034779505, 43536.78231608885, 43786.34320485195, 6374.808755737336, 6460.515461340325, 6461.644609546332, 6536.509761767791, 6552.148220731275, 31633.683663163993, 32264.83867580647, 32367.496767609642, 32448.188795280308, 32632.34735305328, 40052.799736001136, 41884.0, 42361.36457953072, 42770.78614606907, 43014.35478467763, 8686.826263474568, 8796.428232164888, 8812.383133180616, 8834.911650883667, 9129.680461183827, 9702.143786808077, 9768.706938791847, 9832.164266037467, 9904.851427228741, 9935.751606209902, 8393.0, 8620.52587107715, 8623.482591044558, 8644.740657780276, 8671.739847804576, 8231.876521852057, 8262.297704694927, 8402.453840500593, 8426.4944103354, 8433.072362040048, 8624.137586241326, 8634.913650863662, 8638.222559969632, 8803.075677053817, 8976.326775491734, 7433.702651893864, 7485.850282994418, 7596.164421913474, 7781.144074151952, 7888.132305446511, 7747.845043098993, 8049.678012879419, 8065.677372905253, 8114.675412983414, 8455.704050358208], "unit": "ms", "name": "yui.html", "value": 5429.505484870566}], "name": "dromaeo_css", "value": 6165.06002657105}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 114.0, 108.0, 113.0, 115.0, 115.0, 104.0, 112.0, 114.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 111.6}, {"lowerIsBetter": true, "replicates": [156.0, 129.0, 154.0, 176.0, 140.0, 157.0, 153.0, 134.0, 185.0, 137.0], "unit": "ms", "name": "audio-beat-detection", "value": 152.1}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 160.0, 160.0, 158.0, 161.0, 164.0, 161.0, 162.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 81.0, 93.0, 72.0, 71.0, 72.0, 111.0, 89.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 80.6}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 130.0, 95.0, 95.0, 95.0, 137.0, 98.0, 94.0, 127.0], "unit": "ms", "name": "audio-oscillator", "value": 106.0}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 111.0, 109.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 150.0, 148.0, 149.0, 147.0, 148.0, 146.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.6}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 71.0, 71.0, 71.0, 71.0, 72.0, 79.0, 69.0, 68.0], "unit": "ms", "name": "json-parse-financial", "value": 71.2}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 69.0, 68.0, 68.0, 68.0, 69.0, 70.0, 69.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [81.0, 83.0, 85.0, 84.0, 82.0, 84.0, 84.0, 92.0, 84.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.5}, {"lowerIsBetter": true, "replicates": [122.0, 126.0, 138.0, 120.0, 119.0, 131.0, 135.0, 129.0, 125.0, 125.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 127.0}, {"lowerIsBetter": true, "replicates": [150.0, 137.0, 149.0, 149.0, 141.0, 137.0, 147.0, 151.0, 148.0, 143.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.2}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 68.0, 71.0, 70.0, 68.0, 68.0, 69.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.8}], "name": "kraken", "value": 1529.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [190.2587519025875], "unit": "score", "name": "Richards", "value": 185.54731199999992}, {"lowerIsBetter": false, "replicates": [193.7608990505716], "unit": "score", "name": "DeltaBlue", "value": 341.234998}, {"lowerIsBetter": false, "replicates": [282.4060999717594], "unit": "score", "name": "Encrypt", "value": 942.5469209999999}, {"lowerIsBetter": false, "replicates": [4975.124378109453], "unit": "score", "name": "Decrypt", "value": 53.502381}, {"lowerIsBetter": false, "replicates": [1951.2670565302144], "unit": "score", "name": "RayTrace", "value": 379.23512187812196}, {"lowerIsBetter": false, "replicates": [800.0], "unit": "score", "name": "Earley", "value": 833.0787499999997}, {"lowerIsBetter": false, "replicates": [12407.407407407407], "unit": "score", "name": "Boyer", "value": 53.71492835820899}, {"lowerIsBetter": false, "replicates": [26153.846153846152], "unit": "score", "name": "RegExp", "value": 34.8317794117647}, {"lowerIsBetter": false, "replicates": [594.3060498220641], "unit": "score", "name": "Splay", "value": 137.11958682634727}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19574.318079665285}]} 07:34:24 INFO - RETURN: dromaeo_css: 6165.06 07:34:24 INFO - RETURN: kraken: 1529.50 07:34:24 INFO - RETURN: v8_7: 19574.32 07:34:24 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19574.32"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1529.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6165.06"}}} 07:34:24 INFO - Return code: 0 07:34:24 INFO - # TBPL SUCCESS # 07:34:24 INFO - Running post-action listener: _resource_record_post_action 07:34:24 INFO - Running post-run listener: _resource_record_post_run 07:34:25 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 4096; Write bytes: 500449280; Read time: 12; Write time: 363932 07:34:25 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 132517888; Read time: 0; Write time: 131668 07:34:25 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 0; Write bytes: 363085824; Read time: 0; Write time: 231968 07:34:25 INFO - Running post-run listener: _upload_blobber_files 07:34:25 INFO - Blob upload gear active. 07:34:25 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:34:25 INFO - Copying logs to upload dir... 07:34:25 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1263.842305 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-11-23 07:34:24.491644) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 07:34:24.495119) ========= 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=6ef107882637bc5fc02d78b7000001c2-1448291597.125367-777282226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/TgApCiCTQOmZQbOPyB7oGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010182 build_url: 'https://queue.taskcluster.net/v1/task/TgApCiCTQOmZQbOPyB7oGw/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-23 07:34:24.546951) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 07:34:24.547284) ========= 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=6ef107882637bc5fc02d78b7000001c2-1448291597.125367-777282226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004733 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 07:34:24.597768) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 07:34:24.598075) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 07:34:24.598419) ========= ========= Total master_lag: 0.23 =========